· 6 years ago · Dec 28, 2019, 01:12 PM
12019-04-11 18:28:39.349 T:3011825680 NOTICE: -----------------------------------------------------------------------
22019-04-11 18:28:39.349 T:3011825680 NOTICE: Starting Kodi (18.5 Git:leia_pi4_18.5-Leia). Platform: Linux ARM 32-bit
32019-04-11 18:28:39.349 T:3011825680 NOTICE: Using Release Kodi x32 build
42019-04-11 18:28:39.349 T:3011825680 NOTICE: Kodi compiled 2019-11-23 by GCC 8.3.0 for Linux ARM 32-bit version 4.19.83 (267091)
52019-04-11 18:28:39.349 T:3011825680 NOTICE: Running on LibreELEC (official): 9.2.0, kernel: Linux ARM 32-bit version 4.19.83
62019-04-11 18:28:39.349 T:3011825680 NOTICE: FFmpeg version/source: 4.0.4-Kodi
72019-04-11 18:28:39.349 T:3011825680 NOTICE: Host CPU: ARMv7 Processor rev 3 (v7l), 4 cores available
82019-04-11 18:28:39.350 T:3011825680 NOTICE: ARM Features: Neon enabled
92019-04-11 18:28:39.350 T:3011825680 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi/
102019-04-11 18:28:39.350 T:3011825680 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi
112019-04-11 18:28:39.350 T:3011825680 NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons
122019-04-11 18:28:39.350 T:3011825680 NOTICE: special://masterprofile/ is mapped to: /storage/.kodi/userdata
132019-04-11 18:28:39.350 T:3011825680 NOTICE: special://envhome/ is mapped to: /storage
142019-04-11 18:28:39.350 T:3011825680 NOTICE: special://home/ is mapped to: /storage/.kodi
152019-04-11 18:28:39.350 T:3011825680 NOTICE: special://temp/ is mapped to: /storage/.kodi/temp
162019-04-11 18:28:39.350 T:3011825680 NOTICE: special://logpath/ is mapped to: /storage/.kodi/temp
172019-04-11 18:28:39.350 T:3011825680 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin
182019-04-11 18:28:39.350 T:3011825680 NOTICE: Local hostname: Kodi
192019-04-11 18:28:39.350 T:3011825680 NOTICE: Log File is located: /storage/.kodi/temp/kodi.log
202019-04-11 18:28:39.350 T:3011825680 NOTICE: -----------------------------------------------------------------------
212019-04-11 18:28:39.361 T:3011825680 INFO: loading settings
222019-04-11 18:28:39.363 T:3011825680 NOTICE: special://profile/ is mapped to: special://masterprofile/
232019-04-11 18:28:39.385 T:3011825680 DEBUG: CSkinSettings: no <skinsettings> tag found
242019-04-11 18:28:39.385 T:3011825680 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml
252019-04-11 18:28:39.385 T:3011825680 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are...
26 <?xml version="1.0" encoding="utf-8" ?>
27 <advancedsettings>
28 <cputempcommand>/usr/bin/cputemp</cputempcommand>
29 <gputempcommand>/usr/bin/gputemp</gputempcommand>
30 <showexitbutton>false</showexitbutton>
31 <remotedelay>1</remotedelay>
32 <samba>
33 <clienttimeout>30</clienttimeout>
34 </samba>
35 <fanartres>720</fanartres>
36 <imageres>540</imageres>
37 </advancedsettings>
382019-04-11 18:28:39.385 T:3011825680 WARNING: CSettingsManager: missing version attribute
392019-04-11 18:28:39.386 T:3011825680 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml)
402019-04-11 18:28:39.386 T:3011825680 NOTICE: Default Video Player: VideoPlayer
412019-04-11 18:28:39.386 T:3011825680 NOTICE: Default Audio Player: paplayer
422019-04-11 18:28:39.386 T:3011825680 NOTICE: Enabled debug logging due to GUI setting (2)
432019-04-11 18:28:39.386 T:3011825680 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM"
442019-04-11 18:28:39.387 T:3011825680 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml
452019-04-11 18:28:39.398 T:3011825680 INFO: creating subdirectories
462019-04-11 18:28:39.398 T:3011825680 INFO: userdata folder: special://masterprofile/
472019-04-11 18:28:39.398 T:3011825680 INFO: recording folder:
482019-04-11 18:28:39.398 T:3011825680 INFO: screenshots folder: /storage/screenshots/
492019-04-11 18:28:39.506 T:3011825680 NOTICE: PulseAudio: Server found running - will try to use Pulse
502019-04-11 18:28:39.507 T:2934961008 DEBUG: Thread Lirc start, auto delete: false
512019-04-11 18:28:39.508 T:2934961008 INFO: Loading special://xbmc/system/Lircmap.xml
522019-04-11 18:28:39.508 T:3002069872 DEBUG: Thread libinput start, auto delete: false
532019-04-11 18:28:39.513 T:2934961008 INFO: * Adding remote mapping for device 'mceusb'
542019-04-11 18:28:39.513 T:2934961008 INFO: * Adding remote mapping for device 'XboxDVDDongle'
552019-04-11 18:28:39.513 T:2934961008 INFO: * Adding remote mapping for device 'Microsoft_Xbox'
562019-04-11 18:28:39.513 T:2934961008 INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote'
572019-04-11 18:28:39.513 T:2934961008 INFO: * Adding remote mapping for device 'anysee'
582019-04-11 18:28:39.513 T:2934961008 INFO: * Adding remote mapping for device 'iMON-PAD'
592019-04-11 18:28:39.513 T:2934961008 INFO: * Adding remote mapping for device 'Antec_Veris_RM200'
602019-04-11 18:28:39.514 T:2934961008 INFO: * Adding remote mapping for device 'MCE_via_iMON'
612019-04-11 18:28:39.514 T:2934961008 INFO: * Adding remote mapping for device 'TwinHanRemote'
622019-04-11 18:28:39.514 T:2934961008 INFO: * Adding remote mapping for device 'linux-input-layer'
632019-04-11 18:28:39.514 T:2934961008 INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote'
642019-04-11 18:28:39.514 T:2934961008 INFO: * Adding remote mapping for device 'mediacenter'
652019-04-11 18:28:39.514 T:2934961008 INFO: * Adding remote mapping for device 'devinput'
662019-04-11 18:28:39.514 T:2934961008 INFO: * Adding remote mapping for device 'devinput-32'
672019-04-11 18:28:39.514 T:2934961008 INFO: * Adding remote mapping for device 'devinput-64'
682019-04-11 18:28:39.515 T:2934961008 DEBUG: CIRTranslator::Load - no userdata Lircmap.xml found, skipping
692019-04-11 18:28:39.560 T:3011825680 NOTICE: Running database version Addons27
702019-04-11 18:28:39.709 T:3002069872 DEBUG: CLibInputHandler::DeviceAdded - pointer type device added: Logitech Craft (event0)
712019-04-11 18:28:39.709 T:3002069872 DEBUG: CLibInputHandler::DeviceAdded - keyboard type device added: Logitech Craft (event0)
722019-04-11 18:28:39.709 T:3002069872 DEBUG: CLibInputKeyboard::GetRepeat - delay: 500ms repeat: 33ms for Logitech Craft (event0)
732019-04-11 18:28:39.731 T:3002069872 DEBUG: CLibInputHandler::DeviceAdded - pointer type device added: Logitech MX Master 2S (event1)
742019-04-11 18:28:39.731 T:3002069872 DEBUG: CLibInputHandler::DeviceAdded - keyboard type device added: Logitech MX Master 2S (event1)
752019-04-11 18:28:39.731 T:3002069872 DEBUG: CLibInputKeyboard::GetRepeat - delay: 500ms repeat: 33ms for Logitech MX Master 2S (event1)
762019-04-11 18:28:39.756 T:3011825680 INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/kodi/addons: No such file or directory'
772019-04-11 18:28:39.757 T:3011825680 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.'
782019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: audioencoder.kodi.builtin.aac v1.0.0 installed
792019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: audioencoder.kodi.builtin.wma v1.0.0 installed
802019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: driver.dvb.crazycat v9.2.0.0 installed
812019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: driver.dvb.dvb-latest v9.2.0.0 installed
822019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: game.controller.default v1.0.8 installed
832019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: game.controller.snes v1.0.8 installed
842019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: inputstream.adaptive v2.4.0 installed
852019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: kodi.binary.global.audioengine v1.0.1 installed
862019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: kodi.binary.global.filesystem v1.0.2 installed
872019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: kodi.binary.global.general v1.0.3 installed
882019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: kodi.binary.global.gui v5.12.0 installed
892019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: kodi.binary.global.main v1.0.14 installed
902019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: kodi.binary.global.network v1.0.0 installed
912019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: kodi.binary.instance.audiodecoder v2.0.0 installed
922019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: kodi.binary.instance.audioencoder v2.0.0 installed
932019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: kodi.binary.instance.game v1.1.0 installed
942019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: kodi.binary.instance.imagedecoder v2.0.0 installed
952019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: kodi.binary.instance.inputstream v2.0.8 installed
962019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: kodi.binary.instance.peripheral v1.3.7 installed
972019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: kodi.binary.instance.pvr v5.10.3 installed
982019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: kodi.binary.instance.screensaver v2.0.0 installed
992019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: kodi.binary.instance.vfs v2.0.0 installed
1002019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: kodi.binary.instance.videocodec v1.0.1 installed
1012019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: kodi.binary.instance.visualization v2.0.1 installed
1022019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: kodi.resource v1.0.0 installed
1032019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: metadata.album.universal v3.1.2 installed
1042019-04-11 18:28:39.757 T:3011825680 NOTICE: ADDON: metadata.artists.universal v4.3.2 installed
1052019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: metadata.common.allmusic.com v3.2.1 installed
1062019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: metadata.common.fanart.tv v3.6.2 installed
1072019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: metadata.common.imdb.com v3.1.4 installed
1082019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: metadata.common.musicbrainz.org v2.2.1 installed
1092019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: metadata.common.theaudiodb.com v2.0.3 installed
1102019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: metadata.common.themoviedb.org v3.1.10 installed
1112019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: metadata.local v1.0.0 installed
1122019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: metadata.themoviedb.org v5.1.10 installed
1132019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: metadata.tvshows.themoviedb.org v3.4.0 installed
1142019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: os.libreelec.tv v9.2 installed
1152019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: os.openelec.tv v9.2 installed
1162019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: peripheral.joystick v1.4.8 installed
1172019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: plugin.video.retrospect v5.1.3 installed
1182019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: plugin.video.vrt.nu v2.2.2 installed
1192019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: plugin.video.vtm.go v0.9.2 installed
1202019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: plugin.video.yelo v0.0.9 installed
1212019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: plugin.video.youtube v6.5.2 installed
1222019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: repository.kodi.game v1.0.0 installed
1232019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: repository.libreelec.tv v9.2.0 installed
1242019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: repository.xbmc.org v3.1.6 installed
1252019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: resource.images.retrospect v1.0.2 installed
1262019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: resource.images.studios.white v0.0.24 installed
1272019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: resource.images.weathericons.default v1.1.8 installed
1282019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: resource.language.en_gb v2.0.1 installed
1292019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: resource.uisounds.kodi v1.0.0 installed
1302019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: screensaver.xbmc.builtin.black v1.0.33 installed
1312019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: screensaver.xbmc.builtin.dim v1.0.58 installed
1322019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: script.module.beautifulsoup4 v4.6.2 installed
1332019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: script.module.buggalo v1.1.8 installed
1342019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: script.module.certifi v2019.9.11 installed
1352019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: script.module.chardet v3.0.4 installed
1362019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: script.module.dateutil v2.8.1 installed
1372019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: script.module.future v0.17.1 installed
1382019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: script.module.idna v2.8 installed
1392019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: script.module.inputstreamhelper v0.4.3 installed
1402019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: script.module.kodi-six v0.1.2 installed
1412019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: script.module.pil v1.1.7 installed
1422019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: script.module.pyaes v1.6.1 installed
1432019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: script.module.pycryptodome v3.4.3 installed
1442019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: script.module.pyscrypt v1.6.2 installed
1452019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: script.module.pytz v2014.2 installed
1462019-04-11 18:28:39.758 T:3011825680 NOTICE: ADDON: script.module.requests v2.22.0 installed
1472019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: script.module.routing v0.2.3 installed
1482019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: script.module.simplejson v3.16.1 installed
1492019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: script.module.six v1.13.0 installed
1502019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: script.module.urllib3 v1.25.6 installed
1512019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: script.program.driverselect v0.1.6 installed
1522019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: script.tvguide v2.1.1 installed
1532019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: script.tvguide.fullscreen v0.17.445 installed
1542019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: service.libreelec.settings v9.0.0 installed
1552019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: service.subtitles.opensubtitles v5.0.16 installed
1562019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: service.thoradia v9.2.0.23 installed
1572019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: service.webgrabplus v9.2.0.111 installed
1582019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: skin.estuary v2.0.26 installed
1592019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: tools.mono v9.2.0.115 installed
1602019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: webinterface.default v18.x-2.4.6 installed
1612019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: xbmc.addon v18.5.0 installed
1622019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: xbmc.core v0.1.0 installed
1632019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: xbmc.gui v5.14.0 installed
1642019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: xbmc.json v10.3.0 installed
1652019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: xbmc.metadata v2.1.0 installed
1662019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: xbmc.python v2.26.0 installed
1672019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: xbmc.repo.ivueguide v0.0.1 installed
1682019-04-11 18:28:39.759 T:3011825680 NOTICE: ADDON: xbmc.webinterface v1.0.0 installed
1692019-04-11 18:28:39.787 T:3011825680 DEBUG: CFavourites::Load - no system favourites found, skipping
1702019-04-11 18:28:39.791 T:3011825680 DEBUG: DBus method call to org.freedesktop.ConsoleKit.Manager.CanStop at /org/freedesktop/ConsoleKit/Manager of org.freedesktop.ConsoleKit failed: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.ConsoleKit was not provided by any .service files
1712019-04-11 18:28:39.792 T:3011825680 INFO: Selected Logind/UPower as PowerSyscall
1722019-04-11 18:28:39.792 T:3011825680 ERROR: DBus error: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files
1732019-04-11 18:28:39.792 T:3011825680 INFO: LogindUPowerSyscall - UPower not found, battery information will not be available
1742019-04-11 18:28:39.799 T:3011825680 DEBUG: LogindUPowerSyscall - inhibit lock taken, fd 20
1752019-04-11 18:28:39.801 T:3011825680 DEBUG: DBus method call to org.freedesktop.UPower.EnumerateDevices at /org/freedesktop/UPower of org.freedesktop.UPower failed: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files
1762019-04-11 18:28:39.802 T:2989871984 DEBUG: Thread ActiveAE start, auto delete: false
1772019-04-11 18:28:39.802 T:2980049776 DEBUG: Thread AESink start, auto delete: false
1782019-04-11 18:28:39.802 T:2969564016 DEBUG: Thread FDEventMonitor start, auto delete: false
1792019-04-11 18:28:39.811 T:2989871984 INFO: CAESinkALSA - Unable to open device "default" for playback
1802019-04-11 18:28:39.820 T:2989871984 DEBUG: PulseAudio: Context authorizing
1812019-04-11 18:28:39.820 T:2989871984 DEBUG: PulseAudio: Context setting name
1822019-04-11 18:28:39.820 T:2989871984 DEBUG: PulseAudio: Context ready
1832019-04-11 18:28:39.821 T:2989871984 WARNING: Pulseaudio module module-allow-passthrough not loaded - opening PT devices might fail
1842019-04-11 18:28:39.821 T:2989871984 NOTICE: Found 2 Lists of Devices
1852019-04-11 18:28:39.822 T:2989871984 NOTICE: Enumerated PI devices:
1862019-04-11 18:28:39.822 T:2989871984 NOTICE: Device 1
1872019-04-11 18:28:39.822 T:2989871984 NOTICE: m_deviceName : HDMI
1882019-04-11 18:28:39.822 T:2989871984 NOTICE: m_displayName : HDMI
1892019-04-11 18:28:39.822 T:2989871984 NOTICE: m_displayNameExtra:
1902019-04-11 18:28:39.822 T:2989871984 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
1912019-04-11 18:28:39.822 T:2989871984 NOTICE: m_channels : FL, FR
1922019-04-11 18:28:39.822 T:2989871984 NOTICE: m_sampleRates : 8000,11025,16000,22050,24000,32000,44100,48000,88200,96000,176400,192000
1932019-04-11 18:28:39.822 T:2989871984 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP,AE_FMT_RAW
1942019-04-11 18:28:39.822 T:2989871984 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_EAC3,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_512
1952019-04-11 18:28:39.822 T:2989871984 NOTICE: Device 2
1962019-04-11 18:28:39.822 T:2989871984 NOTICE: m_deviceName : Analogue
1972019-04-11 18:28:39.822 T:2989871984 NOTICE: m_displayName : Analogue
1982019-04-11 18:28:39.822 T:2989871984 NOTICE: m_displayNameExtra:
1992019-04-11 18:28:39.822 T:2989871984 NOTICE: m_deviceType : AE_DEVTYPE_PCM
2002019-04-11 18:28:39.822 T:2989871984 NOTICE: m_channels : FL, FR
2012019-04-11 18:28:39.822 T:2989871984 NOTICE: m_sampleRates : 48000
2022019-04-11 18:28:39.822 T:2989871984 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP
2032019-04-11 18:28:39.822 T:2989871984 NOTICE: m_streamTypes : No passthrough capabilities
2042019-04-11 18:28:39.822 T:2989871984 NOTICE: Device 3
2052019-04-11 18:28:39.822 T:2989871984 NOTICE: m_deviceName : Both
2062019-04-11 18:28:39.822 T:2989871984 NOTICE: m_displayName : HDMI and Analogue
2072019-04-11 18:28:39.822 T:2989871984 NOTICE: m_displayNameExtra:
2082019-04-11 18:28:39.822 T:2989871984 NOTICE: m_deviceType : AE_DEVTYPE_PCM
2092019-04-11 18:28:39.822 T:2989871984 NOTICE: m_channels : FL, FR
2102019-04-11 18:28:39.822 T:2989871984 NOTICE: m_sampleRates : 48000
2112019-04-11 18:28:39.822 T:2989871984 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP
2122019-04-11 18:28:39.822 T:2989871984 NOTICE: m_streamTypes : No passthrough capabilities
2132019-04-11 18:28:39.822 T:2989871984 NOTICE: Enumerated PULSE devices:
2142019-04-11 18:28:39.822 T:2989871984 NOTICE: Device 1
2152019-04-11 18:28:39.822 T:2989871984 NOTICE: m_deviceName : Default
2162019-04-11 18:28:39.822 T:2989871984 NOTICE: m_displayName : Default
2172019-04-11 18:28:39.822 T:2989871984 NOTICE: m_displayNameExtra: Bluetooth Audio (PULSEAUDIO)
2182019-04-11 18:28:39.823 T:2989871984 NOTICE: m_deviceType : AE_DEVTYPE_PCM
2192019-04-11 18:28:39.823 T:2989871984 NOTICE: m_channels : FL, FR
2202019-04-11 18:28:39.823 T:2989871984 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000
2212019-04-11 18:28:39.823 T:2989871984 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT
2222019-04-11 18:28:39.823 T:2989871984 NOTICE: m_streamTypes : No passthrough capabilities
2232019-04-11 18:28:39.823 T:2980049776 INFO: CActiveAESink::OpenSink - initialize sink
2242019-04-11 18:28:39.823 T:2980049776 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI
2252019-04-11 18:28:39.823 T:2980049776 DEBUG: DllBcm: Using omx system library
2262019-04-11 18:28:39.824 T:2980049776 DEBUG: SECTION:LoadDLL(libopenmaxil.so)
2272019-04-11 18:28:39.825 T:2980049776 DEBUG: Loading: libopenmaxil.so
2282019-04-11 18:28:39.834 T:2980049776 DEBUG: CSettingsManager: requested setting (videoscreen.limitgui) was not found.
2292019-04-11 18:28:39.835 T:2980049776 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI
2302019-04-11 18:28:39.835 T:2980049776 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008
2312019-04-11 18:28:39.836 T:2980049776 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0xb100d308
2322019-04-11 18:28:39.837 T:2980049776 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignment(16)
2332019-04-11 18:28:39.838 T:2980049776 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized:
2342019-04-11 18:28:39.838 T:2980049776 DEBUG: Output Device : HDMI
2352019-04-11 18:28:39.838 T:2980049776 DEBUG: Sample Rate : 44100
2362019-04-11 18:28:39.838 T:2980049776 DEBUG: Sample Format : AE_FMT_FLOAT
2372019-04-11 18:28:39.838 T:2980049776 DEBUG: Channel Count : 2
2382019-04-11 18:28:39.838 T:2980049776 DEBUG: Channel Layout: FL, FR
2392019-04-11 18:28:39.838 T:2980049776 DEBUG: Frames : 2205
2402019-04-11 18:28:39.838 T:2980049776 DEBUG: Frame Size : 8
2412019-04-11 18:28:39.845 T:3011825680 INFO: CKeyboardLayoutManager: loading keyboard layouts from special://xbmc/system/keyboardlayouts...
2422019-04-11 18:28:39.850 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Arabic QWERTY" successfully loaded
2432019-04-11 18:28:39.850 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian ЯВЕРТЪ" successfully loaded
2442019-04-11 18:28:39.851 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian АБВ" successfully loaded
2452019-04-11 18:28:39.851 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BasePY" successfully loaded
2462019-04-11 18:28:39.852 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BaiduPY" successfully loaded
2472019-04-11 18:28:39.852 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Croatian QWERTY" successfully loaded
2482019-04-11 18:28:39.853 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Czech QWERTZ" successfully loaded
2492019-04-11 18:28:39.853 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Danish QWERTY" successfully loaded
2502019-04-11 18:28:39.854 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "English QWERTY" successfully loaded
2512019-04-11 18:28:39.854 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "English AZERTY" successfully loaded
2522019-04-11 18:28:39.854 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "English ABC" successfully loaded
2532019-04-11 18:28:39.855 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "French AZERTY" successfully loaded
2542019-04-11 18:28:39.855 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "German QWERTZ" successfully loaded
2552019-04-11 18:28:39.856 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "German ABC" successfully loaded
2562019-04-11 18:28:39.856 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Greek QWERTY" successfully loaded
2572019-04-11 18:28:39.857 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew QWERTY" successfully loaded
2582019-04-11 18:28:39.857 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew ABC" successfully loaded
2592019-04-11 18:28:39.858 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Hungarian QWERTZ" successfully loaded
2602019-04-11 18:28:39.858 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Icelandic QWERTY" successfully loaded
2612019-04-11 18:28:39.859 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Italian QWERTY" successfully loaded
2622019-04-11 18:28:39.859 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Korean ㄱㄴㄷ" successfully loaded
2632019-04-11 18:28:39.860 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian AZERTY" successfully loaded
2642019-04-11 18:28:39.860 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian QWERTY" successfully loaded
2652019-04-11 18:28:39.860 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Norwegian QWERTY" successfully loaded
2662019-04-11 18:28:39.861 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Polish QWERTY" successfully loaded
2672019-04-11 18:28:39.861 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Portuguese (Portugal) QWERTY" successfully loaded
2682019-04-11 18:28:39.862 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Romanian QWERTY" successfully loaded
2692019-04-11 18:28:39.862 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian ЙЦУКЕН" successfully loaded
2702019-04-11 18:28:39.863 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian АБВ" successfully loaded
2712019-04-11 18:28:39.863 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Silesian QWERTY" successfully loaded
2722019-04-11 18:28:39.864 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTZ" successfully loaded
2732019-04-11 18:28:39.864 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTY" successfully loaded
2742019-04-11 18:28:39.864 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak ABC" successfully loaded
2752019-04-11 18:28:39.865 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovenian QWERTZ" successfully loaded
2762019-04-11 18:28:39.865 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Spanish QWERTY" successfully loaded
2772019-04-11 18:28:39.866 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Swedish QWERTY" successfully loaded
2782019-04-11 18:28:39.866 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Thai Kedmanee" successfully loaded
2792019-04-11 18:28:39.867 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Turkish QWERTY" successfully loaded
2802019-04-11 18:28:39.868 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian ЙЦУКЕН" successfully loaded
2812019-04-11 18:28:39.868 T:3011825680 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian АБВ" successfully loaded
2822019-04-11 18:28:39.869 T:3011825680 DEBUG: DBus method call to org.freedesktop.DBus.Peer.Ping at /org/freedesktop/UDisks2 of org.freedesktop.UDisks2 failed: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UDisks2 was not provided by any .service files
2832019-04-11 18:28:39.869 T:3011825680 DEBUG: DBus method call to org.freedesktop.UDisks.EnumerateDevices at /org/freedesktop/UDisks of org.freedesktop.UDisks failed: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UDisks was not provided by any .service files
2842019-04-11 18:28:39.871 T:3011825680 DEBUG: Selected UDev as storage provider
2852019-04-11 18:28:39.871 T:3011825680 NOTICE: Raspberry PI firmware version: Nov 5 2019 20:38:23
286 Copyright (c) 2012 Broadcom
287 version 9b5b17690196152a1df1beb1429dd906556d5829 (clean) (release) (start_x)
2882019-04-11 18:28:39.871 T:3011825680 NOTICE: ARM mem: 704MB GPU mem: 320MB MPG2:0 WVC1:0
2892019-04-11 18:28:39.872 T:3011825680 NOTICE: Config:
290 arm_freq=1500
291 audio_pwm_mode=514
292 config_hdmi_boost=5
293 core_freq=500
294 core_freq_min=200
295 disable_commandline_tags=2
296 disable_l2cache=1
297 disable_overscan=1
298 display_hdmi_rotate=-1
299 display_lcd_rotate=-1
300 enable_gic=1
301 force_eeprom_read=1
302 force_pwm_open=1
303 framebuffer_ignore_alpha=1
304 framebuffer_swap=1
305 gpu_freq=500
306 gpu_freq_min=500
307 hdmi_channel_map=8
308 init_uart_clock=0x2dc6c00
309 lcd_framerate=60
310 mask_gpu_interrupt0=1024
311 mask_gpu_interrupt1=0x10000
312 pause_burst_frames=1
313 program_serial_random=1
314 total_mem=4096
315 hdmi_edid_file:0=1
316 hdmi_force_cec_address:0=65535
317 hdmi_force_cec_address:1=65535
318 hdmi_force_hotplug:0=1
319 hdmi_ignore_cec_init:0=1
320 hdmi_pixel_freq_limit:0=0x11e1a300
321 hdmi_pixel_freq_limit:1=0x11e1a300
3222019-04-11 18:28:39.872 T:3011825680 NOTICE: Config:
323 device_tree=-
324 overlay_prefix=overlays/
325 hdmi_cvt:0=
326 hdmi_cvt:1=
327 hdmi_edid_filename:0=
328 hdmi_edid_filename:1=
329 hdmi_timings:0=
330 hdmi_timings:1=
3312019-04-11 18:28:39.872 T:3011825680 INFO: RetroPlayer[PROCESS]: Registering process control for GBM
3322019-04-11 18:28:39.872 T:3011825680 INFO: RetroPlayer[RENDER]: Registering renderer factory for OpenGLES
3332019-04-11 18:28:40.003 T:3011825680 DEBUG: CDRMUtils::FindConnector - found connector: 51
3342019-04-11 18:28:40.004 T:3011825680 DEBUG: CDRMUtils::OpenDrm - opened device: /dev/dri/card0 using module: vc4
3352019-04-11 18:28:40.009 T:3011825680 DEBUG: CDRMUtils::FindConnector - found connector: 51
3362019-04-11 18:28:40.010 T:3011825680 DEBUG: CDRMUtils::FindEncoder - found encoder: 50
3372019-04-11 18:28:40.010 T:3011825680 DEBUG: CDRMUtils::FindCrtc - found crtc: 49
3382019-04-11 18:28:40.010 T:3011825680 DEBUG: CDRMUtils::FindPlane - found video plane 28
3392019-04-11 18:28:40.011 T:3011825680 WARNING: CDRMUtils::FindPlane - could not find plane
3402019-04-11 18:28:40.012 T:3011825680 DEBUG: CDRMUtils::FindPlane - found gui plane 35
3412019-04-11 18:28:40.013 T:3011825680 DEBUG: CDRMUtils::FindPreferredMode - found preferred mode: 1920x1080 @ 60 Hz
3422019-04-11 18:28:40.014 T:3011825680 DEBUG: CDRMAtomic::InitDrm - initialized atomic DRM
3432019-04-11 18:28:40.187 T:3011825680 DEBUG: CWinSystemGbm::InitWindowSystem - initialized DRM
3442019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 60.000000 Hz
3452019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 59.940063 Hz
3462019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 50.000000 Hz
3472019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 30.000000 Hz
3482019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 29.970032 Hz
3492019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 25.000000 Hz
3502019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 24.000000 Hz
3512019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 23.976025 Hz
3522019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 1280x1024 with 1280x1024 @ 60.000000 Hz
3532019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 1360x768 with 1360x768 @ 60.000000 Hz
3542019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 1152x864 with 1152x864 @ 59.940063 Hz
3552019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 1280x720 with 1280x720 @ 60.000000 Hz
3562019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 1280x720 with 1280x720 @ 59.940063 Hz
3572019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 1280x720 with 1280x720 @ 50.000000 Hz
3582019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 1024x768 with 1024x768 @ 60.000000 Hz
3592019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 800x600 with 800x600 @ 60.000000 Hz
3602019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 720x576 with 720x576 @ 50.000000 Hz
3612019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 720x480 with 720x480 @ 59.940063 Hz
3622019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 720x480 with 720x480 @ 60.000000 Hz
3632019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 640x480 with 640x480 @ 60.000000 Hz
3642019-04-11 18:28:40.188 T:3011825680 NOTICE: Previous line repeats 1 times.
3652019-04-11 18:28:40.188 T:3011825680 NOTICE: Found resolution 720x400 with 720x400 @ 70.000000 Hz
3662019-04-11 18:28:40.190 T:3011825680 NOTICE: EGL_VERSION = 1.4
3672019-04-11 18:28:40.190 T:3011825680 NOTICE: EGL_VENDOR = Mesa Project
3682019-04-11 18:28:40.190 T:3011825680 NOTICE: EGL_EXTENSIONS = EGL_EXT_buffer_age EGL_EXT_image_dma_buf_import EGL_EXT_image_dma_buf_import_modifiers EGL_KHR_cl_event2 EGL_KHR_config_attribs EGL_KHR_create_context EGL_KHR_create_context_no_error EGL_KHR_fence_sync EGL_KHR_get_all_proc_addresses EGL_KHR_gl_colorspace EGL_KHR_gl_renderbuffer_image EGL_KHR_gl_texture_2D_image EGL_KHR_gl_texture_3D_image EGL_KHR_gl_texture_cubemap_image EGL_KHR_image EGL_KHR_image_base EGL_KHR_image_pixmap EGL_KHR_no_config_context EGL_KHR_reusable_sync EGL_KHR_surfaceless_context EGL_EXT_pixel_format_float EGL_KHR_wait_sync EGL_MESA_configless_context EGL_MESA_drm_image EGL_MESA_image_dma_buf_export
3692019-04-11 18:28:40.190 T:3011825680 NOTICE: EGL_CLIENT_EXTENSIONS = EGL_EXT_client_extensions EGL_EXT_device_base EGL_EXT_device_enumeration EGL_EXT_device_query EGL_EXT_platform_base EGL_KHR_client_get_all_proc_addresses EGL_KHR_debug EGL_MESA_platform_gbm
3702019-04-11 18:28:40.190 T:3011825680 DEBUG: EGL Config Attributes:
3712019-04-11 18:28:40.190 T:3011825680 DEBUG: EGL_BUFFER_SIZE: 32
3722019-04-11 18:28:40.190 T:3011825680 DEBUG: EGL_ALPHA_SIZE: 8
3732019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_BLUE_SIZE: 8
3742019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_GREEN_SIZE: 8
3752019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_RED_SIZE: 8
3762019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_DEPTH_SIZE: 16
3772019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_STENCIL_SIZE: 0
3782019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_CONFIG_CAVEAT: 0x3038
3792019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_CONFIG_ID: 10
3802019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_LEVEL: 0
3812019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_MAX_PBUFFER_HEIGHT: 4096
3822019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_MAX_PBUFFER_PIXELS: 0
3832019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_MAX_PBUFFER_WIDTH: 4096
3842019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_NATIVE_RENDERABLE: 1
3852019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_NATIVE_VISUAL_ID: 875713089
3862019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_NATIVE_VISUAL_TYPE: 0x3038
3872019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_SAMPLES: 0
3882019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_SAMPLE_BUFFERS: 0
3892019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_SURFACE_TYPE: 4
3902019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_TRANSPARENT_TYPE: 0x3038
3912019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_TRANSPARENT_BLUE_VALUE: 0
3922019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_TRANSPARENT_GREEN_VALUE: 0
3932019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_TRANSPARENT_RED_VALUE: 0
3942019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_BIND_TO_TEXTURE_RGB: 0
3952019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_BIND_TO_TEXTURE_RGBA: 0
3962019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_MIN_SWAP_INTERVAL: 1
3972019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_MAX_SWAP_INTERVAL: 1
3982019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_LUMINANCE_SIZE: 0
3992019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_ALPHA_MASK_SIZE: 0
4002019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_COLOR_BUFFER_TYPE: 0x308e
4012019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_RENDERABLE_TYPE: 77
4022019-04-11 18:28:40.191 T:3011825680 DEBUG: EGL_CONFORMANT: 77
4032019-04-11 18:28:40.195 T:3011825680 NOTICE: Checking resolution 16
4042019-04-11 18:28:40.195 T:3011825680 DEBUG: OnLostDevice - notify display change event
4052019-04-11 18:28:40.341 T:2980049776 DEBUG: CAESinkPi:Drain delay:100ms now:0ms
4062019-04-11 18:28:40.341 T:2980049776 DEBUG: CAESinkPi:Deinitialize
4072019-04-11 18:28:40.341 T:2980049776 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000
4082019-04-11 18:28:40.352 T:2980049776 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0xb100d308
4092019-04-11 18:28:40.352 T:3011825680 WARNING: CGBMUtils::DestroySurface - surface already destroyed
4102019-04-11 18:28:40.352 T:3011825680 DEBUG: CWinSystemGbmEGLContext::DestroyWindow - deinitialized GBM
4112019-04-11 18:28:40.353 T:3011825680 DEBUG: CDRMUtils::SetMode - found crtc mode: 1920x1080 @ 60 Hz
4122019-04-11 18:28:40.353 T:3011825680 DEBUG: CGBMUtils::CreateSurface - created surface with size 1920x1080
4132019-04-11 18:28:40.369 T:3011825680 DEBUG: CWinSystemGbmEGLContext::CreateNewWindow - initialized GBM
4142019-04-11 18:28:40.369 T:3011825680 NOTICE: GL_VENDOR = Broadcom
4152019-04-11 18:28:40.369 T:3011825680 NOTICE: GL_RENDERER = V3D 4.2
4162019-04-11 18:28:40.369 T:3011825680 NOTICE: GL_VERSION = OpenGL ES 3.0 Mesa 19.1.7
4172019-04-11 18:28:40.369 T:3011825680 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 3.00
4182019-04-11 18:28:40.369 T:3011825680 NOTICE: GL_EXTENSIONS = GL_EXT_blend_minmax GL_EXT_multi_draw_arrays GL_EXT_texture_format_BGRA8888 GL_OES_compressed_ETC1_RGB8_texture GL_OES_depth24 GL_OES_element_index_uint GL_OES_fbo_render_mipmap GL_OES_mapbuffer GL_OES_rgb8_rgba8 GL_OES_standard_derivatives GL_OES_stencil8 GL_OES_texture_3D GL_OES_texture_float GL_OES_texture_half_float GL_OES_texture_half_float_linear GL_OES_texture_npot GL_OES_vertex_half_float GL_EXT_texture_sRGB_decode GL_OES_EGL_image GL_OES_depth_texture GL_OES_packed_depth_stencil GL_EXT_texture_type_2_10_10_10_REV GL_OES_get_program_binary GL_APPLE_texture_max_level GL_EXT_discard_framebuffer GL_EXT_read_format_bgra GL_EXT_frag_depth GL_NV_fbo_color_attachments GL_OES_EGL_image_external GL_OES_EGL_sync GL_OES_vertex_array_object GL_EXT_occlusion_query_boolean GL_EXT_texture_rg GL_EXT_unpack_subimage GL_NV_draw_buffers GL_NV_read_buffer GL_NV_read_depth GL_NV_read_depth_stencil GL_NV_read_stencil GL_EXT_draw_buffers GL_EXT_map_buffer_range GL_KHR_debug GL_KHR_texture_compression_astc_ldr GL_OES_depth_texture_cube_map GL_OES_required_internalformat GL_OES_surfaceless_context GL_EXT_color_buffer_float GL_EXT_sRGB_write_control GL_EXT_separate_shader_objects GL_EXT_shader_integer_mix GL_EXT_base_instance GL_EXT_compressed_ETC1_RGB8_sub_texture GL_EXT_draw_elements_base_vertex GL_EXT_texture_border_clamp GL_KHR_context_flush_control GL_OES_draw_elements_base_vertex GL_OES_texture_border_clamp GL_OES_texture_stencil8 GL_EXT_float_blend GL_KHR_no_error GL_KHR_texture_compression_astc_sliced_3d GL_OES_EGL_image_external_essl3 GL_MESA_shader_integer_functions GL_KHR_parallel_shader_compile GL_EXT_texture_query_lod
4192019-04-11 18:28:41.013 T:3011825680 DEBUG: OnLostDevice - notify display change event
4202019-04-11 18:28:41.015 T:3011825680 DEBUG: CDRMUtils::SetMode - found crtc mode: 1920x1080 @ 60 Hz
4212019-04-11 18:28:41.015 T:3011825680 INFO: GLES: Maximum texture width: 4096
4222019-04-11 18:28:41.015 T:2989871984 DEBUG: CActiveAE - display reset event
4232019-04-11 18:28:41.015 T:2980049776 INFO: CActiveAESink::OpenSink - initialize sink
4242019-04-11 18:28:41.015 T:3011825680 DEBUG: guilib: Fill viewport on change for solving rendering passes
4252019-04-11 18:28:41.015 T:2980049776 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI
4262019-04-11 18:28:41.015 T:2980049776 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI
4272019-04-11 18:28:41.015 T:2980049776 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008
4282019-04-11 18:28:41.017 T:2980049776 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0xb100d308
4292019-04-11 18:28:41.024 T:2980049776 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignment(16)
4302019-04-11 18:28:41.025 T:2980049776 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized:
4312019-04-11 18:28:41.025 T:2980049776 DEBUG: Output Device : HDMI
4322019-04-11 18:28:41.025 T:2980049776 DEBUG: Sample Rate : 44100
4332019-04-11 18:28:41.025 T:2980049776 DEBUG: Sample Format : AE_FMT_FLOAT
4342019-04-11 18:28:41.025 T:2980049776 DEBUG: Channel Count : 2
4352019-04-11 18:28:41.025 T:2980049776 DEBUG: Channel Layout: FL, FR
4362019-04-11 18:28:41.025 T:2980049776 DEBUG: Frames : 2205
4372019-04-11 18:28:41.025 T:2980049776 DEBUG: Frame Size : 8
4382019-04-11 18:28:41.027 T:2989871984 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
4392019-04-11 18:28:41.608 T:3011825680 DEBUG: EGL Debugging:
440 Error: EGL_BAD_SURFACE
441 Command: eglSwapBuffers
442 Type: EGL_DEBUG_MSG_ERROR_KHR
443 Message: dri2_swap_buffers
4442019-04-11 18:28:41.614 T:3011825680 DEBUG: CRBP::OpenDisplay device:0 m_display:10000020 (0)
4452019-04-11 18:28:41.614 T:3011825680 INFO: load keymapping
4462019-04-11 18:28:41.617 T:3011825680 INFO: Loading special://xbmc/system/keymaps/appcommand.xml
4472019-04-11 18:28:41.617 T:3011825680 INFO: Loading special://xbmc/system/keymaps/customcontroller.AppleRemote.xml
4482019-04-11 18:28:41.619 T:3011825680 INFO: Loading special://xbmc/system/keymaps/customcontroller.Harmony.xml
4492019-04-11 18:28:41.621 T:3011825680 INFO: Loading special://xbmc/system/keymaps/gamepad.xml
4502019-04-11 18:28:41.623 T:3011825680 INFO: Loading special://xbmc/system/keymaps/joystick.xml
4512019-04-11 18:28:41.626 T:3011825680 INFO: Loading special://xbmc/system/keymaps/keyboard.xml
4522019-04-11 18:28:41.633 T:3011825680 INFO: Loading special://xbmc/system/keymaps/mouse.xml
4532019-04-11 18:28:41.634 T:3011825680 INFO: Loading special://xbmc/system/keymaps/remote.xml
4542019-04-11 18:28:41.638 T:3011825680 INFO: Loading special://xbmc/system/keymaps/touchscreen.xml
4552019-04-11 18:28:41.642 T:3011825680 INFO: GUI format 1920x1080, Display 1920x1080 @ 60.000000 Hz
4562019-04-11 18:28:41.642 T:3011825680 INFO: CLangInfo: loading resource.language.en_gb language information...
4572019-04-11 18:28:41.646 T:3011825680 DEBUG: trying to set locale to en_DE.UTF-8
4582019-04-11 18:28:41.655 T:3011825680 INFO: global locale set to C
4592019-04-11 18:28:41.656 T:3011825680 INFO: CLangInfo: loading resource.language.en_gb language strings...
4602019-04-11 18:28:41.685 T:3011825680 DEBUG: LocalizeStrings: loaded 4022 strings from file resource://resource.language.en_gb/strings.po
4612019-04-11 18:28:41.698 T:3011825680 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.kodi.builtin.aac/resources/language/English/strings.po
4622019-04-11 18:28:41.699 T:3011825680 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.kodi.builtin.wma/resources/language/English/strings.po
4632019-04-11 18:28:41.700 T:3011825680 DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/game.controller.default/resources/language/resource.language.en_gb/strings.po
4642019-04-11 18:28:41.703 T:3011825680 DEBUG: LocalizeStrings: loaded 13 strings from file /usr/share/kodi/addons/game.controller.snes/resources/language/resource.language.en_gb/strings.po
4652019-04-11 18:28:41.706 T:3011825680 DEBUG: LocalizeStrings: loaded 17 strings from file /storage/.kodi/addons/metadata.album.universal/resources/language/resource.language.en_gb/strings.po
4662019-04-11 18:28:41.708 T:3011825680 DEBUG: LocalizeStrings: loaded 32 strings from file /storage/.kodi/addons/metadata.artists.universal/resources/language/resource.language.en_gb/strings.po
4672019-04-11 18:28:41.713 T:3011825680 DEBUG: LocalizeStrings: loaded 8 strings from file /storage/.kodi/addons/metadata.themoviedb.org/resources/language/resource.language.en_gb/strings.po
4682019-04-11 18:28:41.716 T:3011825680 DEBUG: LocalizeStrings: loaded 10 strings from file /storage/.kodi/addons/metadata.tvshows.themoviedb.org/resources/language/resource.language.en_gb/strings.po
4692019-04-11 18:28:41.718 T:3011825680 DEBUG: LocalizeStrings: loaded 9 strings from file /usr/share/kodi/addons/peripheral.joystick/resources/language/resource.language.en_gb/strings.po
4702019-04-11 18:28:41.724 T:3011825680 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.en_gb/strings.po
4712019-04-11 18:28:41.725 T:3011825680 DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/script.program.driverselect/resources/language/resource.language.en_gb/strings.po
4722019-04-11 18:28:41.727 T:3011825680 DEBUG: LocalizeStrings: loaded 256 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/resource.language.en_gb/strings.po
4732019-04-11 18:28:41.733 T:3011825680 DEBUG: LocalizeStrings: loaded 73 strings from file /storage/.kodi/addons/script.module.inputstreamhelper/resources/language/resource.language.en_gb/strings.po
4742019-04-11 18:28:41.737 T:3011825680 DEBUG: LocalizeStrings: loaded 177 strings from file /storage/.kodi/addons/plugin.video.vrt.nu/resources/language/resource.language.en_gb/strings.po
4752019-04-11 18:28:41.743 T:3011825680 DEBUG: LocalizeStrings: loaded 22 strings from file /storage/.kodi/addons/inputstream.adaptive/resources/language/resource.language.en_gb/strings.po
4762019-04-11 18:28:41.750 T:3011825680 DEBUG: LocalizeStrings: loaded 237 strings from file /storage/.kodi/addons/plugin.video.retrospect/resources/language/resource.language.en_gb/strings.po
4772019-04-11 18:28:41.753 T:3011825680 DEBUG: LocalizeStrings: loaded 17 strings from file /storage/.kodi/addons/plugin.video.yelo/resources/language/resource.language.en_gb/strings.po
4782019-04-11 18:28:41.757 T:3011825680 DEBUG: LocalizeStrings: loaded 290 strings from file /storage/.kodi/addons/plugin.video.youtube/resources/language/resource.language.en_gb/strings.po
4792019-04-11 18:28:41.759 T:3011825680 DEBUG: LocalizeStrings: loaded 5 strings from file /storage/.kodi/addons/service.subtitles.opensubtitles/resources/language/English/strings.po
4802019-04-11 18:28:41.761 T:3011825680 DEBUG: LocalizeStrings: loaded 95 strings from file /storage/.kodi/addons/plugin.video.vtm.go/resources/language/resource.language.en_gb/strings.po
4812019-04-11 18:28:41.764 T:3011825680 DEBUG: LocalizeStrings: loaded 22 strings from file /storage/.kodi/addons/script.module.buggalo/resources/language/English/strings.xml
4822019-04-11 18:28:41.768 T:3011825680 DEBUG: LocalizeStrings: loaded 77 strings from file /storage/.kodi/addons/script.tvguide/resources/language/English/strings.po
4832019-04-11 18:28:41.771 T:3011825680 DEBUG: POParser: PO file has Win Style Line Endings. Converted in memory to Linux LF for file: /storage/.kodi/addons/script.tvguide.fullscreen/resources/language/English/strings.po
4842019-04-11 18:28:41.772 T:3011825680 DEBUG: LocalizeStrings: loaded 116 strings from file /storage/.kodi/addons/script.tvguide.fullscreen/resources/language/English/strings.po
4852019-04-11 18:28:41.774 T:3011825680 DEBUG: LocalizeStrings: loaded 8 strings from file /storage/.kodi/addons/service.thoradia/resources/language/English/strings.po
4862019-04-11 18:28:41.776 T:3011825680 DEBUG: LocalizeStrings: loaded 4 strings from file /storage/.kodi/addons/service.webgrabplus/resources/language/English/strings.po
4872019-04-11 18:28:41.777 T:2876646256 DEBUG: Thread JobWorker start, auto delete: true
4882019-04-11 18:28:41.777 T:2876646256 DEBUG: Initialize, updating databases...
4892019-04-11 18:28:41.780 T:2876646256 NOTICE: Running database version Addons27
4902019-04-11 18:28:41.784 T:2876646256 NOTICE: Running database version ViewModes6
4912019-04-11 18:28:41.813 T:2876646256 NOTICE: Running database version Textures13
4922019-04-11 18:28:41.825 T:2876646256 NOTICE: Running database version MyMusic72
4932019-04-11 18:28:41.864 T:2876646256 NOTICE: Running database version MyVideos116
4942019-04-11 18:28:41.869 T:2876646256 NOTICE: Running database version TV32
4952019-04-11 18:28:41.874 T:2876646256 NOTICE: Running database version Epg12
4962019-04-11 18:28:41.874 T:2876646256 DEBUG: Initialize, updating databases... DONE
4972019-04-11 18:28:41.897 T:3011825680 NOTICE: start dvd mediatype detection
4982019-04-11 18:28:41.898 T:2993140592 DEBUG: Thread DetectDVDMedia start, auto delete: false
4992019-04-11 18:28:41.898 T:3011825680 DEBUG: DPMS: supported power-saving modes: OFF
5002019-04-11 18:28:41.898 T:2993140592 DEBUG: Compiled with libcdio Version 0.94
5012019-04-11 18:28:41.899 T:2993140592 DEBUG: Thread DetectDVDMedia 2993140592 terminating
5022019-04-11 18:28:41.965 T:3011825680 INFO: Unloading old skin ...
5032019-04-11 18:28:41.967 T:3011825680 NOTICE: load skin from: /usr/share/kodi/addons/skin.estuary (version: 2.0.26)
5042019-04-11 18:28:41.967 T:3011825680 INFO: load fonts for skin...
5052019-04-11 18:28:41.973 T:3011825680 INFO: Loading skin includes from /usr/share/kodi/addons/skin.estuary/xml/Includes.xml
5062019-04-11 18:28:42.064 T:3011825680 INFO: Loading fonts from /usr/share/kodi/addons/skin.estuary/xml/Font.xml
5072019-04-11 18:28:42.176 T:3011825680 DEBUG: LocalizeStrings: loaded 140 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.en_gb/strings.po
5082019-04-11 18:28:42.176 T:3011825680 INFO: load new skin...
5092019-04-11 18:28:42.176 T:3011825680 INFO: Loading custom window XMLs from skin path /usr/share/kodi/addons/skin.estuary/xml
5102019-04-11 18:28:42.190 T:3011825680 DEBUG: Load Skin XML: 13.63ms
5112019-04-11 18:28:42.190 T:3011825680 INFO: initialize new skin...
5122019-04-11 18:28:42.190 T:3011825680 DEBUG: guilib: Fill viewport on change for solving rendering passes
5132019-04-11 18:28:42.190 T:3011825680 INFO: Loading skin file: Custom_1109_TopBarOverlay.xml, load type: LOAD_ON_GUI_INIT
5142019-04-11 18:28:42.194 T:3011825680 INFO: Loading skin file: DialogNotification.xml, load type: LOAD_ON_GUI_INIT
5152019-04-11 18:28:42.195 T:3011825680 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT
5162019-04-11 18:28:42.234 T:3011825680 DEBUG: OpenBundle - Opened bundle /usr/share/kodi/addons/skin.estuary/media/Textures.xbt
5172019-04-11 18:28:42.246 T:3011825680 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT
5182019-04-11 18:28:42.249 T:3011825680 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
5192019-04-11 18:28:42.250 T:3011825680 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT
5202019-04-11 18:28:42.252 T:3011825680 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT
5212019-04-11 18:28:42.254 T:3011825680 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
5222019-04-11 18:28:42.257 T:3011825680 INFO: Loading resource://resource.uisounds.kodi/sounds.xml
5232019-04-11 18:28:42.305 T:3011825680 INFO: skin loaded...
5242019-04-11 18:28:42.305 T:3011825680 DEBUG: Activating window ID: 12997
5252019-04-11 18:28:42.305 T:3011825680 DEBUG: ------ Window Init () ------
5262019-04-11 18:28:42.306 T:3011825680 DEBUG: Activating window ID: 12999
5272019-04-11 18:28:42.306 T:3011825680 DEBUG: ------ Window Init (Startup.xml) ------
5282019-04-11 18:28:42.306 T:3011825680 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME
5292019-04-11 18:28:42.306 T:3011825680 DEBUG: Activating window ID: 10000
5302019-04-11 18:28:42.306 T:3011825680 DEBUG: ------ Window Deinit (Startup.xml) ------
5312019-04-11 18:28:42.306 T:3011825680 DEBUG: ------ Window Init (Home.xml) ------
5322019-04-11 18:28:42.306 T:3011825680 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY
5332019-04-11 18:28:42.466 T:3011825680 DEBUG: CDirectoryProvider[library://video/movies/]: refreshing..
5342019-04-11 18:28:42.467 T:3011825680 DEBUG: CDirectoryProvider[special://skin/playlists/inprogress_movies.xsp]: refreshing..
5352019-04-11 18:28:42.469 T:3011825680 DEBUG: CDirectoryProvider[special://skin/playlists/recent_unwatched_movies.xsp]: refreshing..
5362019-04-11 18:28:42.469 T:2868253552 DEBUG: Thread JobWorker start, auto delete: true
5372019-04-11 18:28:42.469 T:3011825680 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_movies.xsp]: refreshing..
5382019-04-11 18:28:42.469 T:3011825680 DEBUG: CDirectoryProvider[special://skin/playlists/random_movies.xsp]: refreshing..
5392019-04-11 18:28:42.469 T:2859860848 DEBUG: Thread JobWorker start, auto delete: true
5402019-04-11 18:28:42.469 T:3011825680 DEBUG: CDirectoryProvider[videodb://movies/genres/]: refreshing..
5412019-04-11 18:28:42.469 T:3011825680 DEBUG: CDirectoryProvider[videodb://movies/sets/]: refreshing..
5422019-04-11 18:28:42.469 T:3011825680 DEBUG: CDirectoryProvider[library://video/tvshows/]: refreshing..
5432019-04-11 18:28:42.469 T:3011825680 DEBUG: CDirectoryProvider[videodb://inprogresstvshows]: refreshing..
5442019-04-11 18:28:42.469 T:3011825680 DEBUG: CDirectoryProvider[special://skin/playlists/recent_unwatched_episodes.xsp]: refreshing..
5452019-04-11 18:28:42.469 T:3011825680 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_tvshows.xsp]: refreshing..
5462019-04-11 18:28:42.469 T:3011825680 DEBUG: CDirectoryProvider[videodb://tvshows/genres/]: refreshing..
5472019-04-11 18:28:42.469 T:3011825680 DEBUG: CDirectoryProvider[videodb://tvshows/studios/]: refreshing..
5482019-04-11 18:28:42.476 T:3011825680 DEBUG: CDirectoryProvider[addons://]: refreshing..
5492019-04-11 18:28:42.476 T:3011825680 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing..
5502019-04-11 18:28:42.476 T:3011825680 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing..
5512019-04-11 18:28:42.476 T:3011825680 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing..
5522019-04-11 18:28:42.476 T:3011825680 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing..
5532019-04-11 18:28:42.476 T:3011825680 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing..
5542019-04-11 18:28:42.476 T:3011825680 DEBUG: CDirectoryProvider[library://video/]: refreshing..
5552019-04-11 18:28:42.476 T:3011825680 DEBUG: CDirectoryProvider[sources://video/]: refreshing..
5562019-04-11 18:28:42.476 T:3011825680 DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing..
5572019-04-11 18:28:42.476 T:3011825680 DEBUG: CDirectoryProvider[favourites://]: refreshing..
5582019-04-11 18:28:42.476 T:3011825680 DEBUG: CDirectoryProvider[sources://pictures/]: refreshing..
5592019-04-11 18:28:42.476 T:3011825680 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing..
5602019-04-11 18:28:42.499 T:3011825680 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting
5612019-04-11 18:28:42.499 T:3011825680 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList"
5622019-04-11 18:28:42.499 T:3011825680 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting")
5632019-04-11 18:28:42.499 T:3011825680 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting
5642019-04-11 18:28:42.528 T:3011825680 INFO: JSONRPC v10.3.0: Successfully initialized
5652019-04-11 18:28:42.529 T:3011825680 DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid"
5662019-04-11 18:28:42.530 T:3011825680 DEBUG: LoadMappings - loaded node "CEC Adapter"
5672019-04-11 18:28:42.530 T:3011825680 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter"
5682019-04-11 18:28:42.530 T:3011825680 DEBUG: LoadMappings - loaded node "iMON HID device"
5692019-04-11 18:28:42.530 T:3011825680 DEBUG: LoadMappings - loaded node "WETEK Play remote"
5702019-04-11 18:28:42.530 T:3011825680 DEBUG: LoadMappings - loaded node ""
5712019-04-11 18:28:42.530 T:3011825680 DEBUG: CPeripheralBusUSB - initialised udev monitor
5722019-04-11 18:28:42.531 T:3011825680 DEBUG: Add-on bus: Registering add-on peripheral.joystick
5732019-04-11 18:28:42.531 T:3011825680 DEBUG: PERIPHERAL - CreateAddon - creating peripheral add-on instance 'Joystick Support'
5742019-04-11 18:28:42.531 T:3011825680 DEBUG: ADDON: Dll Initializing - Joystick Support
5752019-04-11 18:28:42.531 T:3011825680 DEBUG: SECTION:LoadDLL(/usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.4.8)
5762019-04-11 18:28:42.531 T:3011825680 DEBUG: Loading: /usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.4.8
5772019-04-11 18:28:42.544 T:3011825680 DEBUG: AddOnLog: Joystick Support: Loaded 14 joystick families with 97 total joysticks
5782019-04-11 18:28:42.544 T:3011825680 DEBUG: Calling TransferSettings for: Joystick Support
5792019-04-11 18:28:42.545 T:3011825680 DEBUG: CAddonSettings[peripheral.joystick]: loading setting definitions
5802019-04-11 18:28:42.545 T:3011825680 INFO: AddOnLog: Joystick Support: Enabling joystick interface "linux"
5812019-04-11 18:28:42.547 T:2840765296 DEBUG: Thread PeripBusUSBUdev start, auto delete: false
5822019-04-11 18:28:42.556 T:2832372592 DEBUG: Thread PeripBusCEC start, auto delete: false
5832019-04-11 18:28:42.560 T:2823979888 DEBUG: Thread PeripBusAddon start, auto delete: false
5842019-04-11 18:28:42.563 T:3011825680 DEBUG: Initialise - initialised peripheral on 'keyboard' with 1 features and 0 sub devices
5852019-04-11 18:28:42.563 T:3011825680 NOTICE: Register - new keyboard device registered on application->keyboard: Keyboard (0000:0000)
5862019-04-11 18:28:42.563 T:3011825680 DEBUG: Initialise - initialised peripheral on 'mouse' with 1 features and 0 sub devices
5872019-04-11 18:28:42.564 T:3011825680 NOTICE: Register - new mouse device registered on application->mouse: Mouse (0000:0000)
5882019-04-11 18:28:42.567 T:2815587184 DEBUG: Thread PeripEventScanner start, auto delete: false
5892019-04-11 18:28:42.568 T:3011825680 DEBUG: ContextMenuManager: addon menus reloaded.
5902019-04-11 18:28:42.568 T:3011825680 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
5912019-04-11 18:28:42.570 T:3011825680 DEBUG: CPlayerCoreConfig::<ctor>: created player VideoPlayer
5922019-04-11 18:28:42.570 T:3011825680 DEBUG: CPlayerCoreConfig::<ctor>: created player PAPlayer
5932019-04-11 18:28:42.570 T:3011825680 DEBUG: CPlayerCoreConfig::<ctor>: created player RetroPlayer
5942019-04-11 18:28:42.571 T:3011825680 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules
5952019-04-11 18:28:42.571 T:3011825680 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mms/udp
5962019-04-11 18:28:42.571 T:3011825680 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout
5972019-04-11 18:28:42.571 T:3011825680 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp
5982019-04-11 18:28:42.571 T:3011825680 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp
5992019-04-11 18:28:42.571 T:3011825680 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams
6002019-04-11 18:28:42.571 T:3011825680 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp
6012019-04-11 18:28:42.571 T:3011825680 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2
6022019-04-11 18:28:42.571 T:3011825680 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd
6032019-04-11 18:28:42.571 T:3011825680 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage
6042019-04-11 18:28:42.571 T:3011825680 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf
6052019-04-11 18:28:42.571 T:3011825680 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv
6062019-04-11 18:28:42.571 T:3011825680 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio
6072019-04-11 18:28:42.571 T:3011825680 NOTICE: Loaded playercorefactory configuration
6082019-04-11 18:28:42.571 T:3011825680 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
6092019-04-11 18:28:42.571 T:3011825680 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
6102019-04-11 18:28:42.571 T:3011825680 INFO: removing tempfiles
6112019-04-11 18:28:42.572 T:3011825680 NOTICE: UpdateLibraries: Starting video library startup scan
6122019-04-11 18:28:42.589 T:3011825680 DEBUG: CRepositoryUpdater: previous update at 28-12-2019 10:33:02, next at 29-12-2019 10:33:02
6132019-04-11 18:28:42.590 T:2806039408 DEBUG: Thread Timer start, auto delete: false
6142019-04-11 18:28:42.595 T:3011825680 DEBUG: CServiceAddonManager: starting service.libreelec.settings
6152019-04-11 18:28:42.595 T:3011825680 DEBUG: CServiceAddonManager: starting plugin.video.vrt.nu
6162019-04-11 18:28:42.595 T:2797646704 DEBUG: Thread LanguageInvoker start, auto delete: false
6172019-04-11 18:28:42.596 T:2797646704 INFO: initializing python engine.
6182019-04-11 18:28:42.598 T:3011825680 DEBUG: CServiceAddonManager: starting plugin.video.retrospect
6192019-04-11 18:28:42.598 T:2789254000 DEBUG: Thread LanguageInvoker start, auto delete: false
6202019-04-11 18:28:42.598 T:3011825680 DEBUG: CServiceAddonManager: starting plugin.video.youtube
6212019-04-11 18:28:42.599 T:2789254000 INFO: initializing python engine.
6222019-04-11 18:28:42.599 T:2780861296 DEBUG: Thread LanguageInvoker start, auto delete: false
6232019-04-11 18:28:42.599 T:2780861296 INFO: initializing python engine.
6242019-04-11 18:28:42.600 T:3011825680 DEBUG: CServiceAddonManager: starting plugin.video.vtm.go
6252019-04-11 18:28:42.600 T:2772468592 DEBUG: Thread LanguageInvoker start, auto delete: false
6262019-04-11 18:28:42.600 T:2772468592 INFO: initializing python engine.
6272019-04-11 18:28:42.600 T:3011825680 DEBUG: CServiceAddonManager: starting script.tvguide.fullscreen
6282019-04-11 18:28:42.600 T:2764075888 DEBUG: Thread LanguageInvoker start, auto delete: false
6292019-04-11 18:28:42.601 T:2764075888 INFO: initializing python engine.
6302019-04-11 18:28:42.601 T:3011825680 DEBUG: CServiceAddonManager: starting service.thoradia
6312019-04-11 18:28:42.601 T:2755683184 DEBUG: Thread LanguageInvoker start, auto delete: false
6322019-04-11 18:28:42.602 T:3011825680 DEBUG: CServiceAddonManager: starting tools.mono
6332019-04-11 18:28:42.602 T:2755683184 INFO: initializing python engine.
6342019-04-11 18:28:42.602 T:2747290480 DEBUG: Thread LanguageInvoker start, auto delete: false
6352019-04-11 18:28:42.602 T:3011825680 DEBUG: CServiceAddonManager: starting service.webgrabplus
6362019-04-11 18:28:42.603 T:2747290480 INFO: initializing python engine.
6372019-04-11 18:28:42.603 T:2738897776 DEBUG: Thread LanguageInvoker start, auto delete: false
6382019-04-11 18:28:42.603 T:3011825680 NOTICE: initialize done
6392019-04-11 18:28:42.603 T:2730505072 DEBUG: Thread LanguageInvoker start, auto delete: false
6402019-04-11 18:28:42.603 T:3011825680 NOTICE: Running the application...
6412019-04-11 18:28:42.604 T:2738897776 INFO: initializing python engine.
6422019-04-11 18:28:42.604 T:3011825680 INFO: Previous line repeats 1 times.
6432019-04-11 18:28:42.604 T:3011825680 DEBUG: no profile autoexec.py (/storage/.kodi/userdata/autoexec.py) found, skipping
6442019-04-11 18:28:42.605 T:3011825680 DEBUG: NetworkMessage - Starting network services
6452019-04-11 18:28:42.610 T:3011825680 DEBUG: CZeroconfAvahi::clientCallback: client is up and running
6462019-04-11 18:28:42.611 T:3011825680 NOTICE: starting zeroconf publishing
6472019-04-11 18:28:42.612 T:3011825680 NOTICE: CWebServer[8080]: Started
6482019-04-11 18:28:42.613 T:2696934256 DEBUG: Thread EventServer start, auto delete: false
6492019-04-11 18:28:42.613 T:2696934256 NOTICE: ES: Starting UDP Event server on port 9777
6502019-04-11 18:28:42.613 T:2696934256 NOTICE: UDP: Listening on port 9777 (ipv6 : false)
6512019-04-11 18:28:42.617 T:3011825680 DEBUG: GetFirstConnectedInterface no connected interface found - requery list
6522019-04-11 18:28:42.617 T:3011825680 DEBUG: SECTION:LoadDLL(libshairplay.so.0)
6532019-04-11 18:28:42.618 T:3011825680 DEBUG: Loading: libshairplay.so.0
6542019-04-11 18:28:42.624 T:3011825680 DEBUG: GetFirstConnectedInterface no connected interface found - requery list
6552019-04-11 18:28:42.694 T:2797646704 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): start processing
6562019-04-11 18:28:42.694 T:2780861296 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.retrospect/retroservice.py): start processing
6572019-04-11 18:28:42.695 T:2789254000 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.vrt.nu/resources/lib/addon_service.py): start processing
6582019-04-11 18:28:42.695 T:2772468592 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.youtube/resources/lib/startup.py): start processing
6592019-04-11 18:28:42.695 T:2764075888 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.vtm.go/service.py): start processing
6602019-04-11 18:28:42.695 T:2755683184 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/script.tvguide.fullscreen/service.py): start processing
6612019-04-11 18:28:42.695 T:2747290480 DEBUG: CPythonInvoker(6, /storage/.kodi/addons/service.thoradia/default.py): start processing
6622019-04-11 18:28:42.695 T:2730505072 DEBUG: CPythonInvoker(8, /storage/.kodi/addons/service.webgrabplus/default.py): start processing
6632019-04-11 18:28:42.695 T:2738897776 DEBUG: CPythonInvoker(7, /storage/.kodi/addons/tools.mono/default.py): start processing
6642019-04-11 18:28:42.709 T:2876646256 DEBUG: CAddonMgr::GetAvailableUpdates took 38 ms
6652019-04-11 18:28:42.798 T:2859860848 DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3a%2f%2fprofile%2fplaylists%2fvideo/special%3a%2f%2fprofile%2fplaylists%2fmixed/)
6662019-04-11 18:28:42.798 T:2859860848 DEBUG: Getting Directory (special://profile/playlists/video)
6672019-04-11 18:28:42.802 T:2859860848 DEBUG: Getting Directory (special://profile/playlists/mixed)
6682019-04-11 18:28:42.803 T:2859860848 DEBUG: CMultiPathDirectory::MergeItems, items = 0
6692019-04-11 18:28:42.856 T:2797646704 DEBUG: -->Python Interpreter Initialized<--
6702019-04-11 18:28:42.856 T:2797646704 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): the source file to load is "/usr/share/kodi/addons/service.libreelec.settings/service.py"
6712019-04-11 18:28:42.942 T:2859860848 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:Kodi (Kodi) port:8080
6722019-04-11 18:28:42.943 T:2859860848 DEBUG: CZeroconfAvahi::addService() named: Kodi (Kodi) type: _http._tcp port:8080
6732019-04-11 18:28:42.947 T:2859860848 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:Kodi (Kodi) port:8080
6742019-04-11 18:28:42.948 T:2859860848 DEBUG: CZeroconfAvahi::addService() named: Kodi (Kodi) type: _xbmc-jsonrpc-h._tcp port:8080
6752019-04-11 18:28:42.953 T:2859860848 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:Kodi (Kodi) port:9777
6762019-04-11 18:28:42.953 T:2722112368 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
6772019-04-11 18:28:42.953 T:2859860848 DEBUG: Previous line repeats 1 times.
6782019-04-11 18:28:42.953 T:2859860848 DEBUG: CZeroconfAvahi::addService() named: Kodi (Kodi) type: _xbmc-events._udp port:9777
6792019-04-11 18:28:42.955 T:2738897776 DEBUG: -->Python Interpreter Initialized<--
6802019-04-11 18:28:42.955 T:2738897776 DEBUG: CPythonInvoker(7, /storage/.kodi/addons/tools.mono/default.py): the source file to load is "/storage/.kodi/addons/tools.mono/default.py"
6812019-04-11 18:28:42.956 T:2859860848 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airtunes type: _raop._tcp name:000102030405@Kodi (Kodi) port:36666
6822019-04-11 18:28:42.956 T:2722112368 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
6832019-04-11 18:28:42.956 T:2859860848 DEBUG: CZeroconfAvahi::addService() named: 000102030405@Kodi (Kodi) type: _raop._tcp port:36666
6842019-04-11 18:28:42.959 T:2797646704 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): setting the Python path to /usr/share/kodi/addons/service.libreelec.settings:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/gtk-2.0
6852019-04-11 18:28:42.959 T:2797646704 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): entering source directory /usr/share/kodi/addons/service.libreelec.settings
6862019-04-11 18:28:42.961 T:2722112368 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
6872019-04-11 18:28:42.975 T:2797646704 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): instantiating addon using automatically obtained id of "service.libreelec.settings" dependent on version 2.1.0 of the xbmc.python api
6882019-04-11 18:28:43.124 T:2663220080 DEBUG: Thread JobWorker start, auto delete: true
6892019-04-11 18:28:43.154 T:2859860848 DEBUG: ffmpeg[AA760370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
6902019-04-11 18:28:43.164 T:3011825680 DEBUG: ------ Window Init () ------
6912019-04-11 18:28:43.169 T:2663220080 DEBUG: ffmpeg[9EBD8370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
6922019-04-11 18:28:43.170 T:3011825680 DEBUG: ------ Window Init (Pointer.xml) ------
6932019-04-11 18:28:43.171 T:2876646256 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update
6942019-04-11 18:28:43.193 T:2859860848 DEBUG: ffmpeg[AA760370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
6952019-04-11 18:28:43.194 T:2876646256 DEBUG: GetRecentlyAddedAlbumSongs() query: SELECT songview.*, songartistview.* FROM (SELECT idAlbum FROM album ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN songview ON songview.idAlbum = recentalbums.idAlbum JOIN songartistview ON songview.idSong = songartistview.idSong ORDER BY songview.idAlbum DESC, songview.idSong, songartistview.idRole, songartistview.iOrder
6962019-04-11 18:28:43.199 T:2876646256 DEBUG: GetRecentlyAddedAlbums query: SELECT albumview.*, albumartistview.* FROM (SELECT idAlbum FROM album WHERE strAlbum != '' ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN albumview ON albumview.idAlbum = recentalbums.idAlbum JOIN albumartistview ON albumview.idAlbum = albumartistview.idAlbum ORDER BY albumview.idAlbum desc, albumartistview.iOrder
6972019-04-11 18:28:43.208 T:2876646256 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
6982019-04-11 18:28:43.229 T:2663220080 DEBUG: ffmpeg[9EBD8370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
6992019-04-11 18:28:43.247 T:2859860848 DEBUG: ffmpeg[AA760370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
7002019-04-11 18:28:43.293 T:2876646256 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
7012019-04-11 18:28:43.298 T:2876646256 DEBUG: GetArtistsByWhere query: SELECT COUNT(DISTINCT artistview.idArtist) FROM artistview WHERE (EXISTS (SELECT 1 FROM song_artist WHERE song_artist.idArtist = artistview.idArtist AND song_artist.idRole = 1) OR EXISTS (SELECT 1 FROM album_artist WHERE album_artist.idArtist = artistview.idArtist)) AND (artistview.strArtist != '')
7022019-04-11 18:28:43.312 T:2832372592 DEBUG: GetMappingForDevice - device (2708:1001) mapped to CEC Adapter (type = cec)
7032019-04-11 18:28:43.317 T:2876646256 WARNING: CreateLoader - unsupported protocol(thumb) in thumb://None/
7042019-04-11 18:28:43.317 T:2876646256 DEBUG: GetImageHash - unable to stat url thumb://None/
7052019-04-11 18:28:43.318 T:2832372592 DEBUG: InitialiseFeature - using libCEC v4.0.4
7062019-04-11 18:28:43.318 T:2832372592 DEBUG: Initialise - initialised peripheral on 'RPI' with 2 features and 0 sub devices
7072019-04-11 18:28:43.318 T:2832372592 NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001)
7082019-04-11 18:28:43.318 T:2832372592 DEBUG: Thread PeripBusCEC 2832372592 terminating
7092019-04-11 18:28:43.325 T:2631435120 DEBUG: Thread CECAdapter start, auto delete: false
7102019-04-11 18:28:43.325 T:2631435120 DEBUG: OpenConnection - opening a connection to the CEC adapter: RPI
7112019-12-28 14:00:38.676 T:2797646704 DEBUG: ## LibreELEC Addon ## 9.0.0
7122019-12-28 14:00:38.728 T:3011825680 DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------
7132019-12-28 14:00:38.728 T:3011825680 DEBUG: LogindUPowerSyscall - Received unknown signal NameAcquired
7142019-12-28 14:00:38.731 T:3011825680 DEBUG: ------ Window Init (DialogNotification.xml) ------
7152019-12-28 14:00:38.754 T:2747290480 DEBUG: -->Python Interpreter Initialized<--
7162019-12-28 14:00:38.754 T:2747290480 DEBUG: CPythonInvoker(6, /storage/.kodi/addons/service.thoradia/default.py): the source file to load is "/storage/.kodi/addons/service.thoradia/default.py"
7172019-12-28 14:00:38.754 T:2755683184 DEBUG: -->Python Interpreter Initialized<--
7182019-12-28 14:00:38.754 T:2755683184 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/script.tvguide.fullscreen/service.py): the source file to load is "/storage/.kodi/addons/script.tvguide.fullscreen/service.py"
7192019-12-28 14:00:38.757 T:2738897776 DEBUG: CPythonInvoker(7, /storage/.kodi/addons/tools.mono/default.py): setting the Python path to /storage/.kodi/addons/tools.mono:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/gtk-2.0
7202019-12-28 14:00:38.757 T:2738897776 DEBUG: CPythonInvoker(7, /storage/.kodi/addons/tools.mono/default.py): entering source directory /storage/.kodi/addons/tools.mono
7212019-12-28 14:00:38.757 T:2868253552 NOTICE: VideoInfoScanner: Finished scan. Scanning for video info took 00:00
7222019-12-28 14:00:38.778 T:2738897776 DEBUG: CPythonInvoker(7, /storage/.kodi/addons/tools.mono/default.py): instantiating addon using automatically obtained id of "tools.mono" dependent on version 2.1.0 of the xbmc.python api
7232019-12-28 14:00:38.790 T:2764075888 DEBUG: -->Python Interpreter Initialized<--
7242019-12-28 14:00:38.790 T:2764075888 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.vtm.go/service.py): the source file to load is "/storage/.kodi/addons/plugin.video.vtm.go/service.py"
7252019-12-28 14:00:38.792 T:2730505072 DEBUG: -->Python Interpreter Initialized<--
7262019-12-28 14:00:38.792 T:2730505072 DEBUG: CPythonInvoker(8, /storage/.kodi/addons/service.webgrabplus/default.py): the source file to load is "/storage/.kodi/addons/service.webgrabplus/default.py"
7272019-12-28 14:00:38.792 T:2747290480 DEBUG: CPythonInvoker(6, /storage/.kodi/addons/service.thoradia/default.py): setting the Python path to /storage/.kodi/addons/service.thoradia:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/gtk-2.0
7282019-12-28 14:00:38.793 T:2747290480 DEBUG: CPythonInvoker(6, /storage/.kodi/addons/service.thoradia/default.py): entering source directory /storage/.kodi/addons/service.thoradia
7292019-12-28 14:00:38.793 T:2755683184 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/script.tvguide.fullscreen/service.py): setting the Python path to /storage/.kodi/addons/script.tvguide.fullscreen:/storage/.kodi/addons/script.module.beautifulsoup4/lib:/storage/.kodi/addons/script.module.certifi/lib:/storage/.kodi/addons/script.module.chardet/lib:/storage/.kodi/addons/script.module.dateutil/lib:/storage/.kodi/addons/script.module.idna/lib:/storage/.kodi/addons/script.module.requests/lib:/storage/.kodi/addons/script.module.simplejson/lib:/storage/.kodi/addons/script.module.six/lib:/storage/.kodi/addons/script.module.urllib3/lib:/usr/share/kodi/addons/script.module.pil/lib:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/gtk-2.0
7302019-12-28 14:00:38.793 T:2755683184 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/script.tvguide.fullscreen/service.py): entering source directory /storage/.kodi/addons/script.tvguide.fullscreen
7312019-12-28 14:00:38.793 T:2747290480 DEBUG: CPythonInvoker(6, /storage/.kodi/addons/service.thoradia/default.py): instantiating addon using automatically obtained id of "service.thoradia" dependent on version 2.1.0 of the xbmc.python api
7322019-12-28 14:00:38.799 T:2755683184 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/script.tvguide.fullscreen/service.py): instantiating addon using automatically obtained id of "script.tvguide.fullscreen" dependent on version 2.25.0 of the xbmc.python api
7332019-12-28 14:00:38.811 T:2876646256 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
7342019-12-28 14:00:38.821 T:2730505072 DEBUG: CPythonInvoker(8, /storage/.kodi/addons/service.webgrabplus/default.py): setting the Python path to /storage/.kodi/addons/service.webgrabplus:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/gtk-2.0
7352019-12-28 14:00:38.821 T:2730505072 DEBUG: CPythonInvoker(8, /storage/.kodi/addons/service.webgrabplus/default.py): entering source directory /storage/.kodi/addons/service.webgrabplus
7362019-12-28 14:00:38.822 T:2730505072 DEBUG: CPythonInvoker(8, /storage/.kodi/addons/service.webgrabplus/default.py): instantiating addon using automatically obtained id of "service.webgrabplus" dependent on version 2.1.0 of the xbmc.python api
7372019-12-28 14:00:38.823 T:2780861296 DEBUG: -->Python Interpreter Initialized<--
7382019-12-28 14:00:38.823 T:2780861296 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.retrospect/retroservice.py): the source file to load is "/storage/.kodi/addons/plugin.video.retrospect/retroservice.py"
7392019-12-28 14:00:38.825 T:2789254000 DEBUG: -->Python Interpreter Initialized<--
7402019-12-28 14:00:38.825 T:2789254000 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.vrt.nu/resources/lib/addon_service.py): the source file to load is "/storage/.kodi/addons/plugin.video.vrt.nu/resources/lib/addon_service.py"
7412019-12-28 14:00:38.870 T:3011825680 DEBUG: CDirectoryProvider[special://skin/playlists/recent_unwatched_movies.xsp]: refreshing..
7422019-12-28 14:00:38.871 T:3011825680 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_movies.xsp]: refreshing..
7432019-12-28 14:00:38.871 T:3011825680 DEBUG: CDirectoryProvider[special://skin/playlists/random_movies.xsp]: refreshing..
7442019-12-28 14:00:38.871 T:3011825680 DEBUG: CDirectoryProvider[videodb://movies/genres/]: refreshing..
7452019-12-28 14:00:38.871 T:3011825680 DEBUG: CDirectoryProvider[videodb://movies/sets/]: refreshing..
7462019-12-28 14:00:38.873 T:2876646256 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
7472019-12-28 14:00:38.882 T:2876646256 DEBUG: GetArtistsByWhere query: SELECT COUNT(DISTINCT artistview.idArtist) FROM artistview WHERE (EXISTS (SELECT 1 FROM song_artist WHERE song_artist.idArtist = artistview.idArtist AND song_artist.idRole = 1) OR EXISTS (SELECT 1 FROM album_artist WHERE album_artist.idArtist = artistview.idArtist)) AND (artistview.strArtist != '')
7482019-12-28 14:00:39.034 T:3011825680 DEBUG: ------ Window Deinit (DialogExtendedProgressBar.xml) ------
7492019-12-28 14:00:39.448 T:3011825680 DEBUG: ------ Window Deinit (Pointer.xml) ------
7502019-12-28 14:00:39.828 T:2755683184 DEBUG: CAddonSettings[script.tvguide.fullscreen]: loading setting definitions
7512019-12-28 14:00:39.828 T:2755683184 DEBUG: CAddonSettings[script.tvguide.fullscreen]: trying to load setting definitions from old format...
7522019-12-28 14:00:39.840 T:2755683184 DEBUG: CAddonSettings[script.tvguide.fullscreen]: loading setting values
7532019-12-28 14:00:39.845 T:2755683184 DEBUG: CSettingsManager: requested setting (category) was not found.
7542019-12-28 14:00:39.845 T:2755683184 DEBUG: CAddonSettings[script.tvguide.fullscreen]: failed to find definition for setting category. Creating a setting on-the-fly...
7552019-12-28 14:00:39.845 T:2755683184 DEBUG: CSettingsManager: requested setting (channel.arg) was not found.
7562019-12-28 14:00:39.845 T:2755683184 DEBUG: CAddonSettings[script.tvguide.fullscreen]: failed to find definition for setting channel.arg. Creating a setting on-the-fly...
7572019-12-28 14:00:39.845 T:2755683184 DEBUG: CSettingsManager: requested setting (channelIdx) was not found.
7582019-12-28 14:00:39.845 T:2755683184 DEBUG: CAddonSettings[script.tvguide.fullscreen]: failed to find definition for setting channelIdx. Creating a setting on-the-fly...
7592019-12-28 14:00:39.845 T:2755683184 DEBUG: CSettingsManager: requested setting (last.channel) was not found.
7602019-12-28 14:00:39.846 T:2755683184 DEBUG: CAddonSettings[script.tvguide.fullscreen]: failed to find definition for setting last.channel. Creating a setting on-the-fly...
7612019-12-28 14:00:39.846 T:2755683184 DEBUG: CSettingsManager: requested setting (version) was not found.
7622019-12-28 14:00:39.846 T:2755683184 DEBUG: CAddonSettings[script.tvguide.fullscreen]: failed to find definition for setting version. Creating a setting on-the-fly...
7632019-12-28 14:00:39.858 T:2780861296 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.retrospect/retroservice.py): setting the Python path to /storage/.kodi/addons/plugin.video.retrospect:/storage/.kodi/addons/plugin.video.youtube/resources/lib/:/storage/.kodi/addons/script.module.certifi/lib:/storage/.kodi/addons/script.module.chardet/lib:/storage/.kodi/addons/script.module.idna/lib:/storage/.kodi/addons/script.module.inputstreamhelper/lib:/storage/.kodi/addons/script.module.pyaes/lib:/storage/.kodi/addons/script.module.pyscrypt/lib:/storage/.kodi/addons/script.module.pytz/lib:/storage/.kodi/addons/script.module.requests/lib:/storage/.kodi/addons/script.module.six/lib:/storage/.kodi/addons/script.module.urllib3/lib:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/gtk-2.0
7642019-12-28 14:00:39.858 T:2780861296 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.retrospect/retroservice.py): entering source directory /storage/.kodi/addons/plugin.video.retrospect
7652019-12-28 14:00:39.873 T:2780861296 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.retrospect/retroservice.py): instantiating addon using automatically obtained id of "plugin.video.retrospect" dependent on version 2.26.0 of the xbmc.python api
7662019-12-28 14:00:39.876 T:2764075888 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.vtm.go/service.py): setting the Python path to /storage/.kodi/addons/plugin.video.vtm.go:/storage/.kodi/addons/script.module.certifi/lib:/storage/.kodi/addons/script.module.chardet/lib:/storage/.kodi/addons/script.module.dateutil/lib:/storage/.kodi/addons/script.module.idna/lib:/storage/.kodi/addons/script.module.inputstreamhelper/lib:/storage/.kodi/addons/script.module.requests/lib:/storage/.kodi/addons/script.module.routing/lib:/storage/.kodi/addons/script.module.six/lib:/storage/.kodi/addons/script.module.urllib3/lib:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/gtk-2.0
7672019-12-28 14:00:39.876 T:2764075888 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.vtm.go/service.py): entering source directory /storage/.kodi/addons/plugin.video.vtm.go
7682019-12-28 14:00:39.876 T:2772468592 DEBUG: -->Python Interpreter Initialized<--
7692019-12-28 14:00:39.876 T:2772468592 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.youtube/resources/lib/startup.py): the source file to load is "/storage/.kodi/addons/plugin.video.youtube/resources/lib/startup.py"
7702019-12-28 14:00:39.877 T:2764075888 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.vtm.go/service.py): instantiating addon using automatically obtained id of "plugin.video.vtm.go" dependent on version 2.26.0 of the xbmc.python api
7712019-12-28 14:00:40.018 T:2631435120 DEBUG: OpenConnection - connection to the CEC adapter opened
7722019-12-28 14:00:40.019 T:2631435120 DEBUG: SetConfigurationFromLibCEC - settings updated by libCEC
7732019-12-28 14:00:40.023 T:2612487024 DEBUG: Thread CECAdapterUpdate start, auto delete: false
7742019-12-28 14:00:40.237 T:2612487024 DEBUG: UpdateMenuLanguage - using TV menu language is disabled
7752019-12-28 14:00:40.476 T:2789254000 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.vrt.nu/resources/lib/addon_service.py): setting the Python path to /storage/.kodi/addons/plugin.video.vrt.nu/resources/lib:/storage/.kodi/addons/plugin.video.youtube/resources/lib/:/storage/.kodi/addons/script.module.beautifulsoup4/lib:/storage/.kodi/addons/script.module.certifi/lib:/storage/.kodi/addons/script.module.chardet/lib:/storage/.kodi/addons/script.module.dateutil/lib:/storage/.kodi/addons/script.module.idna/lib:/storage/.kodi/addons/script.module.inputstreamhelper/lib:/storage/.kodi/addons/script.module.requests/lib:/storage/.kodi/addons/script.module.routing/lib:/storage/.kodi/addons/script.module.six/lib:/storage/.kodi/addons/script.module.urllib3/lib:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/gtk-2.0
7762019-12-28 14:00:40.476 T:2789254000 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.vrt.nu/resources/lib/addon_service.py): entering source directory /storage/.kodi/addons/plugin.video.vrt.nu/resources/lib
7772019-12-28 14:00:40.476 T:2772468592 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.youtube/resources/lib/startup.py): setting the Python path to /storage/.kodi/addons/plugin.video.youtube/resources/lib:/storage/.kodi/addons/script.module.certifi/lib:/storage/.kodi/addons/script.module.chardet/lib:/storage/.kodi/addons/script.module.idna/lib:/storage/.kodi/addons/script.module.inputstreamhelper/lib:/storage/.kodi/addons/script.module.requests/lib:/storage/.kodi/addons/script.module.six/lib:/storage/.kodi/addons/script.module.urllib3/lib:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/gtk-2.0
7782019-12-28 14:00:40.476 T:2772468592 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.youtube/resources/lib/startup.py): entering source directory /storage/.kodi/addons/plugin.video.youtube/resources/lib
7792019-12-28 14:00:40.476 T:2789254000 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.vrt.nu/resources/lib/addon_service.py): instantiating addon using automatically obtained id of "plugin.video.vrt.nu" dependent on version 2.25.0 of the xbmc.python api
7802019-12-28 14:00:40.477 T:2772468592 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.youtube/resources/lib/startup.py): instantiating addon using automatically obtained id of "plugin.video.youtube" dependent on version 2.20.0 of the xbmc.python api
7812019-12-28 14:00:40.855 T:3011825680 NOTICE: UDev: Added /var/media/Elements
7822019-12-28 14:00:41.356 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting definitions
7832019-12-28 14:00:41.356 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: trying to load setting definitions from old format...
7842019-12-28 14:00:41.361 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting values
7852019-12-28 14:00:41.364 T:2772468592 DEBUG: [plugin.video.youtube] send_notification: |check_settings| -> |{"httpd_address": "0.0.0.0", "use_httpd": false, "whitelist": "", "httpd_port": 50152}|
7862019-12-28 14:00:41.366 T:2772468592 DEBUG: [plugin.video.youtube] JSONStore Load |/storage/.kodi/userdata/addon_data/plugin.video.youtube/api_keys.json|
7872019-12-28 14:00:41.367 T:2772468592 DEBUG: [plugin.video.youtube] JSONStore Load |/storage/.kodi/userdata/addon_data/plugin.video.youtube/access_manager.json|
7882019-12-28 14:00:41.373 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting definitions
7892019-12-28 14:00:41.373 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: trying to load setting definitions from old format...
7902019-12-28 14:00:41.377 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting values
7912019-12-28 14:00:41.384 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting definitions
7922019-12-28 14:00:41.384 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: trying to load setting definitions from old format...
7932019-12-28 14:00:41.387 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting values
7942019-12-28 14:00:41.394 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting definitions
7952019-12-28 14:00:41.394 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: trying to load setting definitions from old format...
7962019-12-28 14:00:41.398 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting values
7972019-12-28 14:00:41.405 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting definitions
7982019-12-28 14:00:41.405 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: trying to load setting definitions from old format...
7992019-12-28 14:00:41.409 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting values
8002019-12-28 14:00:41.412 T:2772468592 DEBUG: CSettingsManager: requested setting (kodion.access_token) was not found.
8012019-12-28 14:00:41.412 T:2772468592 DEBUG: CSettingsManager: requested setting (kodion.refresh_token) was not found.
8022019-12-28 14:00:41.413 T:2772468592 DEBUG: CSettingsManager: requested setting (kodion.access_token.expires) was not found.
8032019-12-28 14:00:41.413 T:2772468592 DEBUG: CSettingsManager: requested setting (youtube.api.last.hash) was not found.
8042019-12-28 14:00:41.413 T:2772468592 DEBUG: [plugin.video.youtube] User: |0| Using API key set: |1|
8052019-12-28 14:00:41.459 T:2772468592 DEBUG: [plugin.video.youtube] YouTube service initialization...
8062019-12-28 14:00:41.461 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting definitions
8072019-12-28 14:00:41.461 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: trying to load setting definitions from old format...
8082019-12-28 14:00:41.465 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting values
8092019-12-28 14:00:41.474 T:2764075888 DEBUG: CAddonSettings[plugin.video.vtm.go]: loading setting definitions
8102019-12-28 14:00:41.474 T:2764075888 DEBUG: CAddonSettings[plugin.video.vtm.go]: trying to load setting definitions from old format...
8112019-12-28 14:00:41.478 T:2764075888 DEBUG: CAddonSettings[plugin.video.vtm.go]: loading setting values
8122019-12-28 14:00:41.482 T:2780861296 DEBUG: CAddonSettings[plugin.video.retrospect]: loading setting definitions
8132019-12-28 14:00:41.482 T:2780861296 DEBUG: CAddonSettings[plugin.video.retrospect]: trying to load setting definitions from old format...
8142019-12-28 14:00:41.486 T:2780861296 DEBUG: CAddonSettings[plugin.video.retrospect]: loading setting values
8152019-12-28 14:00:41.488 T:2780861296 INFO: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.retrospect/retroservice.py): script successfully run
8162019-12-28 14:00:41.488 T:2780861296 DEBUG: onExecutionDone(2, /storage/.kodi/addons/plugin.video.retrospect/retroservice.py)
8172019-12-28 14:00:41.491 T:2780861296 INFO: Python interpreter stopped
8182019-12-28 14:00:41.491 T:2780861296 DEBUG: Thread LanguageInvoker 2780861296 terminating
8192019-12-28 14:00:41.497 T:2755683184 DEBUG: CAddonSettings[script.tvguide.fullscreen]: loading setting definitions
8202019-12-28 14:00:41.498 T:2755683184 DEBUG: CAddonSettings[script.tvguide.fullscreen]: trying to load setting definitions from old format...
8212019-12-28 14:00:41.510 T:2755683184 DEBUG: CAddonSettings[script.tvguide.fullscreen]: loading setting values
8222019-12-28 14:00:41.515 T:2755683184 DEBUG: CSettingsManager: requested setting (category) was not found.
8232019-12-28 14:00:41.515 T:2755683184 DEBUG: CAddonSettings[script.tvguide.fullscreen]: failed to find definition for setting category. Creating a setting on-the-fly...
8242019-12-28 14:00:41.515 T:2755683184 DEBUG: CSettingsManager: requested setting (channel.arg) was not found.
8252019-12-28 14:00:41.515 T:2755683184 DEBUG: CAddonSettings[script.tvguide.fullscreen]: failed to find definition for setting channel.arg. Creating a setting on-the-fly...
8262019-12-28 14:00:41.515 T:2755683184 DEBUG: CSettingsManager: requested setting (channelIdx) was not found.
8272019-12-28 14:00:41.515 T:2755683184 DEBUG: CAddonSettings[script.tvguide.fullscreen]: failed to find definition for setting channelIdx. Creating a setting on-the-fly...
8282019-12-28 14:00:41.515 T:2755683184 DEBUG: CSettingsManager: requested setting (last.channel) was not found.
8292019-12-28 14:00:41.515 T:2755683184 DEBUG: CAddonSettings[script.tvguide.fullscreen]: failed to find definition for setting last.channel. Creating a setting on-the-fly...
8302019-12-28 14:00:41.516 T:2755683184 DEBUG: CSettingsManager: requested setting (version) was not found.
8312019-12-28 14:00:41.516 T:2755683184 DEBUG: CAddonSettings[script.tvguide.fullscreen]: failed to find definition for setting version. Creating a setting on-the-fly...
8322019-12-28 14:00:41.525 T:2755683184 INFO: CPythonInvoker(5, /storage/.kodi/addons/script.tvguide.fullscreen/service.py): script successfully run
8332019-12-28 14:00:41.525 T:2755683184 DEBUG: onExecutionDone(5, /storage/.kodi/addons/script.tvguide.fullscreen/service.py)
8342019-12-28 14:00:41.578 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting definitions
8352019-12-28 14:00:41.578 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: trying to load setting definitions from old format...
8362019-12-28 14:00:41.582 T:2772468592 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting values
8372019-12-28 14:00:41.931 T:2755683184 INFO: Python interpreter stopped
8382019-12-28 14:00:41.932 T:2755683184 DEBUG: Thread LanguageInvoker 2755683184 terminating
8392019-12-28 14:00:41.939 T:2747290480 NOTICE: Thoradia Add-ons: found release 9.2.0/RPi4/arm
8402019-12-28 14:00:41.939 T:2747290480 NOTICE: Thoradia Add-ons: using release 9.2.0/RPi4/arm
8412019-12-28 14:00:41.944 T:2747290480 DEBUG: CAddonSettings[service.thoradia]: loading setting definitions
8422019-12-28 14:00:41.944 T:2747290480 DEBUG: CAddonSettings[service.thoradia]: trying to load setting definitions from old format...
8432019-12-28 14:00:41.944 T:2747290480 DEBUG: CSettingsManager: requested setting (updated) was not found.
8442019-12-28 14:00:41.944 T:2747290480 NOTICE: Thoradia Add-ons: repository is up to date
8452019-12-28 14:00:41.945 T:2747290480 INFO: CPythonInvoker(6, /storage/.kodi/addons/service.thoradia/default.py): script successfully run
8462019-12-28 14:00:41.945 T:2747290480 DEBUG: onExecutionDone(6, /storage/.kodi/addons/service.thoradia/default.py)
8472019-12-28 14:00:42.017 T:2747290480 INFO: Python interpreter stopped
8482019-12-28 14:00:42.017 T:2747290480 DEBUG: Thread LanguageInvoker 2747290480 terminating
8492019-12-28 14:00:42.050 T:2797646704 INFO: ## LibreELEC Addon ## system::set_hostname ## Kodi
8502019-12-28 14:00:42.051 T:2797646704 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## azerty
8512019-12-28 14:00:42.051 T:2797646704 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## loadkmap < `ls -1 /usr/lib/keymaps/*/azerty.bmap`
8522019-12-28 14:00:42.750 T:2612487024 DEBUG: UpdateAudioSystemStatus - no CEC capable amplifier found
8532019-12-28 14:00:43.232 T:2797646704 INFO: ## LibreELEC Addon ## updates::updateThread ## Started
8542019-12-28 14:00:43.233 T:2797646704 INFO: ## LibreELEC Addon ## updates::set_auto_update ## auto
8552019-12-28 14:00:43.304 T:2780861296 INFO: ## LibreELEC Addon ## _service_::run ## WAITING:
8562019-12-28 14:00:43.313 T:2755683184 INFO: ## LibreELEC Addon ## xdbus Monitor started. ##
8572019-12-28 14:00:48.116 T:3011825680 DEBUG: ------ Window Deinit (DialogNotification.xml) ------
8582019-12-28 14:01:08.981 T:2876646256 DEBUG: Thread JobWorker 2876646256 terminating (autodelete)
8592019-12-28 14:01:08.981 T:2859860848 DEBUG: Thread JobWorker 2859860848 terminating (autodelete)
8602019-12-28 14:01:08.982 T:2663220080 DEBUG: Thread JobWorker 2663220080 terminating (autodelete)
8612019-12-28 14:01:08.983 T:2868253552 DEBUG: Thread JobWorker 2868253552 terminating (autodelete)
8622019-12-28 14:01:13.016 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 0
8632019-12-28 14:01:13.030 T:3011825680 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down
8642019-12-28 14:01:13.033 T:3011825680 DEBUG: CDirectoryProvider[videodb://inprogresstvshows]: refreshing..
8652019-12-28 14:01:13.034 T:2868253552 DEBUG: Thread JobWorker start, auto delete: true
8662019-12-28 14:01:13.034 T:3011825680 DEBUG: CDirectoryProvider[special://skin/playlists/recent_unwatched_episodes.xsp]: refreshing..
8672019-12-28 14:01:13.034 T:2663220080 DEBUG: Thread JobWorker start, auto delete: true
8682019-12-28 14:01:13.034 T:3011825680 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_tvshows.xsp]: refreshing..
8692019-12-28 14:01:13.035 T:3011825680 DEBUG: CDirectoryProvider[videodb://tvshows/genres/]: refreshing..
8702019-12-28 14:01:13.035 T:3011825680 DEBUG: CDirectoryProvider[videodb://tvshows/studios/]: refreshing..
8712019-12-28 14:01:13.036 T:2859860848 DEBUG: Thread JobWorker start, auto delete: true
8722019-12-28 14:01:13.087 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 72
8732019-12-28 14:01:13.121 T:2876646256 DEBUG: Thread JobWorker start, auto delete: true
8742019-12-28 14:01:13.140 T:2868253552 DEBUG: ffmpeg[AAF61370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
8752019-12-28 14:01:13.141 T:2876646256 DEBUG: ffmpeg[AB762370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
8762019-12-28 14:01:13.170 T:2663220080 DEBUG: ffmpeg[9EBD8370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
8772019-12-28 14:01:13.190 T:2876646256 DEBUG: ffmpeg[AB762370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
8782019-12-28 14:01:13.203 T:2859860848 DEBUG: ffmpeg[AA760370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
8792019-12-28 14:01:13.216 T:2868253552 DEBUG: ffmpeg[AAF61370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
8802019-12-28 14:01:13.239 T:2663220080 DEBUG: ffmpeg[9EBD8370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
8812019-12-28 14:01:13.295 T:2876646256 DEBUG: ffmpeg[AB762370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
8822019-12-28 14:01:13.775 T:2639827824 DEBUG: PushCecKeypress - received key a6 duration 0
8832019-12-28 14:01:13.778 T:3011825680 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up
8842019-12-28 14:01:13.847 T:2639827824 DEBUG: PushCecKeypress - received key a6 duration 72
8852019-12-28 14:01:15.143 T:2639827824 DEBUG: PushCecKeypress - received key a8 duration 0
8862019-12-28 14:01:15.144 T:3011825680 DEBUG: HandleKey: 168 (0xa8, obc87) pressed, action is Right
8872019-12-28 14:01:15.215 T:2639827824 DEBUG: PushCecKeypress - received key a8 duration 72
8882019-12-28 14:01:16.015 T:2639827824 DEBUG: PushCecKeypress - received key a9 duration 0
8892019-12-28 14:01:16.028 T:3011825680 DEBUG: HandleKey: 169 (0xa9, obc86) pressed, action is Left
8902019-12-28 14:01:16.087 T:2639827824 DEBUG: PushCecKeypress - received key a9 duration 72
8912019-12-28 14:01:16.556 T:2639827824 DEBUG: PushCecKeypress - received key b duration 0
8922019-12-28 14:01:16.561 T:3011825680 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
8932019-12-28 14:01:16.567 T:3011825680 DEBUG: Activating window ID: 10025
8942019-12-28 14:01:16.628 T:2639827824 DEBUG: PushCecKeypress - received key b duration 72
8952019-12-28 14:01:16.866 T:3011825680 DEBUG: ------ Window Deinit (Home.xml) ------
8962019-12-28 14:01:16.866 T:3011825680 DEBUG: FreeVisualisation() done
8972019-12-28 14:01:16.901 T:3011825680 DEBUG: ------ Window Init (MyVideoNav.xml) ------
8982019-12-28 14:01:16.901 T:3011825680 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY
8992019-12-28 14:01:17.008 T:3011825680 DEBUG: CGUIMediaWindow::GetDirectory (videodb://movies/titles/)
9002019-12-28 14:01:17.008 T:3011825680 DEBUG: ParentPath = [videodb://movies/titles/]
9012019-12-28 14:01:17.019 T:2564035440 DEBUG: Thread BackgroundLoader start, auto delete: false
9022019-12-28 14:01:17.032 T:2564035440 DEBUG: Thread BackgroundLoader 2564035440 terminating
9032019-12-28 14:01:18.710 T:2639827824 DEBUG: PushCecKeypress - received key b duration 0
9042019-12-28 14:01:18.711 T:3011825680 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
9052019-12-28 14:01:18.711 T:3011825680 DEBUG: CGUIMediaWindow::GetDirectory (videodb://movies/)
9062019-12-28 14:01:18.711 T:3011825680 DEBUG: ParentPath = []
9072019-12-28 14:01:18.712 T:2564035440 DEBUG: Thread waiting start, auto delete: false
9082019-12-28 14:01:18.722 T:2564035440 DEBUG: Thread waiting 2564035440 terminating
9092019-12-28 14:01:18.725 T:2564035440 DEBUG: Thread BackgroundLoader start, auto delete: false
9102019-12-28 14:01:18.782 T:2639827824 DEBUG: PushCecKeypress - received key b duration 72
9112019-12-28 14:01:18.846 T:2564035440 DEBUG: Thread BackgroundLoader 2564035440 terminating
9122019-12-28 14:01:19.663 T:2639827824 DEBUG: PushCecKeypress - received key a6 duration 0
9132019-12-28 14:01:19.694 T:3011825680 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up
9142019-12-28 14:01:19.735 T:2639827824 DEBUG: PushCecKeypress - received key a6 duration 72
9152019-12-28 14:01:20.120 T:2639827824 DEBUG: PushCecKeypress - received key a6 duration 0
9162019-12-28 14:01:20.122 T:3011825680 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up
9172019-12-28 14:01:20.192 T:2639827824 DEBUG: PushCecKeypress - received key a6 duration 71
9182019-12-28 14:01:20.660 T:2639827824 DEBUG: PushCecKeypress - received key b duration 0
9192019-12-28 14:01:20.666 T:3011825680 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
9202019-12-28 14:01:20.666 T:3011825680 DEBUG: CGUIMediaWindow::GetDirectory ()
9212019-12-28 14:01:20.666 T:3011825680 DEBUG: ParentPath = []
9222019-12-28 14:01:20.672 T:2564035440 DEBUG: Thread waiting start, auto delete: false
9232019-12-28 14:01:20.674 T:2564035440 DEBUG: Thread waiting 2564035440 terminating
9242019-12-28 14:01:20.699 T:2564035440 DEBUG: Thread BackgroundLoader start, auto delete: false
9252019-12-28 14:01:20.708 T:2564035440 DEBUG: Thread BackgroundLoader 2564035440 terminating
9262019-12-28 14:01:20.732 T:2639827824 DEBUG: PushCecKeypress - received key b duration 72
9272019-12-28 14:01:21.408 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 0
9282019-12-28 14:01:21.428 T:3011825680 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down
9292019-12-28 14:01:21.479 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 72
9302019-12-28 14:01:21.905 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 0
9312019-12-28 14:01:21.911 T:3011825680 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down
9322019-12-28 14:01:21.977 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 72
9332019-12-28 14:01:22.573 T:2639827824 DEBUG: PushCecKeypress - received key b duration 0
9342019-12-28 14:01:22.578 T:3011825680 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
9352019-12-28 14:01:22.579 T:3011825680 DEBUG: CGUIMediaWindow::GetDirectory (library://video/files.xml/)
9362019-12-28 14:01:22.579 T:3011825680 DEBUG: ParentPath = []
9372019-12-28 14:01:22.579 T:2564035440 DEBUG: Thread waiting start, auto delete: false
9382019-12-28 14:01:22.645 T:2639827824 DEBUG: PushCecKeypress - received key b duration 72
9392019-12-28 14:01:22.679 T:3011825680 DEBUG: ------ Window Init (DialogBusy.xml) ------
9402019-12-28 14:01:22.965 T:2564035440 DEBUG: Thread waiting 2564035440 terminating
9412019-12-28 14:01:22.978 T:3011825680 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
9422019-12-28 14:01:23.004 T:2564035440 DEBUG: Thread BackgroundLoader start, auto delete: false
9432019-12-28 14:01:23.014 T:2564035440 DEBUG: Thread BackgroundLoader 2564035440 terminating
9442019-12-28 14:01:23.857 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 0
9452019-12-28 14:01:23.867 T:3011825680 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down
9462019-12-28 14:01:23.929 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 73
9472019-12-28 14:01:24.231 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 0
9482019-12-28 14:01:24.244 T:3011825680 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down
9492019-12-28 14:01:24.303 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 71
9502019-12-28 14:01:24.813 T:2639827824 DEBUG: PushCecKeypress - received key b duration 0
9512019-12-28 14:01:24.828 T:3011825680 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
9522019-12-28 14:01:24.830 T:3011825680 DEBUG: CGUIMediaWindow::GetDirectory (/media/Elements/Movies/)
9532019-12-28 14:01:24.830 T:3011825680 DEBUG: ParentPath = [sources://video/]
9542019-12-28 14:01:24.830 T:2564035440 DEBUG: Thread waiting start, auto delete: false
9552019-12-28 14:01:24.886 T:2639827824 DEBUG: PushCecKeypress - received key b duration 72
9562019-12-28 14:01:24.930 T:2564035440 DEBUG: Thread waiting 2564035440 terminating
9572019-12-28 14:01:24.935 T:3011825680 DEBUG: CAddonSettings[metadata.themoviedb.org]: loading setting definitions
9582019-12-28 14:01:24.935 T:3011825680 DEBUG: CAddonSettings[metadata.themoviedb.org]: trying to load setting definitions from old format...
9592019-12-28 14:01:24.935 T:3011825680 DEBUG: CAddonSettings[metadata.themoviedb.org]: loading setting values
9602019-12-28 14:01:24.936 T:3011825680 DEBUG: CAddonSettings[metadata.themoviedb.org]: loading setting definitions
9612019-12-28 14:01:24.936 T:3011825680 DEBUG: CAddonSettings[metadata.themoviedb.org]: trying to load setting definitions from old format...
9622019-12-28 14:01:24.937 T:3011825680 DEBUG: CAddonSettings[metadata.themoviedb.org]: loading setting values
9632019-12-28 14:01:24.940 T:2564035440 DEBUG: Thread BackgroundLoader start, auto delete: false
9642019-12-28 14:01:24.953 T:2564035440 DEBUG: Thread BackgroundLoader 2564035440 terminating
9652019-12-28 14:01:25.518 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 0
9662019-12-28 14:01:25.528 T:3011825680 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down
9672019-12-28 14:01:25.572 T:2859860848 DEBUG: ffmpeg[AA760370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
9682019-12-28 14:01:25.591 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 73
9692019-12-28 14:01:25.850 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 0
9702019-12-28 14:01:25.878 T:3011825680 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down
9712019-12-28 14:01:25.922 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 72
9722019-12-28 14:01:25.929 T:2868253552 DEBUG: ffmpeg[AAF61370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
9732019-12-28 14:01:26.142 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 0
9742019-12-28 14:01:26.161 T:3011825680 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down
9752019-12-28 14:01:26.200 T:2876646256 DEBUG: ffmpeg[AB762370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
9762019-12-28 14:01:26.213 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 72
9772019-12-28 14:01:26.642 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 0
9782019-12-28 14:01:26.661 T:3011825680 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down
9792019-12-28 14:01:26.693 T:2868253552 DEBUG: ffmpeg[AAF61370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
9802019-12-28 14:01:26.714 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 72
9812019-12-28 14:01:27.097 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 0
9822019-12-28 14:01:27.111 T:3011825680 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down
9832019-12-28 14:01:27.169 T:2639827824 DEBUG: PushCecKeypress - received key a7 duration 72
9842019-12-28 14:01:28.216 T:2639827824 DEBUG: PushCecKeypress - received key b duration 0
9852019-12-28 14:01:28.222 T:3011825680 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
9862019-12-28 14:01:28.229 T:3011825680 DEBUG: OnPlayMedia /media/Elements/Movies/jellyfish-400-mbps-4k-uhd-hevc-10bit.mkv
9872019-12-28 14:01:28.241 T:3011825680 DEBUG: CPlayerCoreFactory::GetPlayers(/media/Elements/Movies/jellyfish-400-mbps-4k-uhd-hevc-10bit.mkv)
9882019-12-28 14:01:28.241 T:3011825680 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
9892019-12-28 14:01:28.241 T:3011825680 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
9902019-12-28 14:01:28.241 T:3011825680 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp
9912019-12-28 14:01:28.241 T:3011825680 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
9922019-12-28 14:01:28.241 T:3011825680 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
9932019-12-28 14:01:28.241 T:3011825680 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
9942019-12-28 14:01:28.241 T:3011825680 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
9952019-12-28 14:01:28.241 T:3011825680 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
9962019-12-28 14:01:28.241 T:3011825680 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
9972019-12-28 14:01:28.241 T:3011825680 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
9982019-12-28 14:01:28.241 T:3011825680 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
9992019-12-28 14:01:28.241 T:3011825680 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
10002019-12-28 14:01:28.241 T:3011825680 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
10012019-12-28 14:01:28.241 T:3011825680 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer)
10022019-12-28 14:01:28.241 T:3011825680 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
10032019-12-28 14:01:28.241 T:3011825680 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
10042019-12-28 14:01:28.242 T:3011825680 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
10052019-12-28 14:01:28.244 T:3011825680 DEBUG: CMMALPool::CMMALPool Created pool 0x2d9e980 of size 26 x 0 for port vc.ril.video_decode:out:0(I420)
10062019-12-28 14:01:28.249 T:3011825680 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData
10072019-12-28 14:01:28.250 T:3011825680 NOTICE: VideoPlayer::OpenFile: /media/Elements/Movies/jellyfish-400-mbps-4k-uhd-hevc-10bit.mkv
10082019-12-28 14:01:28.250 T:3011825680 DEBUG: CMMALRenderer::CMMALRenderer
10092019-12-28 14:01:28.250 T:3011825680 DEBUG: OnPlayBackStarted: CApplication::OnPlayBackStarted
10102019-12-28 14:01:28.250 T:2531095408 DEBUG: Thread VideoPlayer start, auto delete: false
10112019-12-28 14:01:28.250 T:2522702704 DEBUG: Thread BackgroundLoader start, auto delete: false
10122019-12-28 14:01:28.250 T:2531095408 NOTICE: Creating InputStream
10132019-12-28 14:01:28.252 T:2539488112 DEBUG: Thread MMALProcess start, auto delete: false
10142019-12-28 14:01:28.252 T:2539488112 DEBUG: CMMALRenderer::Run - starting
10152019-12-28 14:01:28.254 T:2531095408 DEBUG: ScanForExternalSubtitles: Searching for subtitles...
10162019-12-28 14:01:28.255 T:2531095408 DEBUG: ScanForExternalSubtitles: END (total time: 1 ms)
10172019-12-28 14:01:28.255 T:2531095408 NOTICE: Creating Demuxer
10182019-12-28 14:01:28.259 T:2859860848 DEBUG: Loading settings for /media/Elements/Movies/jellyfish-400-mbps-4k-uhd-hevc-10bit.mkv
10192019-12-28 14:01:28.264 T:2522702704 DEBUG: Thread BackgroundLoader 2522702704 terminating
10202019-12-28 14:01:28.278 T:3011825680 DEBUG: CVideoGUIInfo::InitCurrentItem(/media/Elements/Movies/jellyfish-400-mbps-4k-uhd-hevc-10bit.mkv)
10212019-12-28 14:01:28.278 T:3011825680 DEBUG: CPlayerGUIInfo::InitCurrentItem(/media/Elements/Movies/jellyfish-400-mbps-4k-uhd-hevc-10bit.mkv)
10222019-12-28 14:01:28.288 T:2639827824 DEBUG: PushCecKeypress - received key b duration 72
10232019-12-28 14:01:28.337 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: loading setting definitions
10242019-12-28 14:01:28.337 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: trying to load setting definitions from old format...
10252019-12-28 14:01:28.341 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: loading setting values
10262019-12-28 14:01:28.346 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: loading setting definitions
10272019-12-28 14:01:28.346 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: trying to load setting definitions from old format...
10282019-12-28 14:01:28.347 T:2531095408 DEBUG: Open - probing detected format [matroska,webm]
10292019-12-28 14:01:28.348 T:2531095408 DEBUG: Open - avformat_find_stream_info starting
10302019-12-28 14:01:28.350 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: loading setting values
10312019-12-28 14:01:28.355 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: loading setting definitions
10322019-12-28 14:01:28.355 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: trying to load setting definitions from old format...
10332019-12-28 14:01:28.358 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: loading setting values
10342019-12-28 14:01:28.378 T:3011825680 DEBUG: ------ Window Init (DialogBusy.xml) ------
10352019-12-28 14:01:28.473 T:2531095408 DEBUG: Open - av_find_stream_info finished
10362019-12-28 14:01:28.474 T:2531095408 INFO: ffmpeg[96DD7370]: Input #0, matroska,webm, from '/media/Elements/Movies/jellyfish-400-mbps-4k-uhd-hevc-10bit.mkv':
10372019-12-28 14:01:28.474 T:2531095408 INFO: ffmpeg[96DD7370]: Metadata:
10382019-12-28 14:01:28.474 T:2531095408 INFO: ffmpeg[96DD7370]: COMPATIBLE_BRANDS: iso4hvc1iso6
10392019-12-28 14:01:28.474 T:2531095408 INFO: ffmpeg[96DD7370]: MAJOR_BRAND : iso4
10402019-12-28 14:01:28.474 T:2531095408 INFO: ffmpeg[96DD7370]: MINOR_VERSION : 1
10412019-12-28 14:01:28.474 T:2531095408 INFO: ffmpeg[96DD7370]: ENCODER : Lavf56.3.100
10422019-12-28 14:01:28.474 T:2531095408 INFO: ffmpeg[96DD7370]: Duration: 00:00:30.10, start: 0.067000, bitrate: 400027 kb/s
10432019-12-28 14:01:28.474 T:2531095408 INFO: ffmpeg[96DD7370]: Stream #0:0(und): Video: hevc (Main 10), yuv420p10le(tv), 3840x2160 [SAR 1:1 DAR 16:9], 29.97 fps, 29.97 tbr, 1k tbn, 29.97 tbc (default)
10442019-12-28 14:01:28.474 T:2531095408 INFO: ffmpeg[96DD7370]: Metadata:
10452019-12-28 14:01:28.474 T:2531095408 INFO: ffmpeg[96DD7370]: CREATION_TIME : 2016-02-05 16:11:30
10462019-12-28 14:01:28.474 T:2531095408 INFO: ffmpeg[96DD7370]: LANGUAGE : und
10472019-12-28 14:01:28.474 T:2531095408 INFO: ffmpeg[96DD7370]: HANDLER_NAME : hevc@GPAC0.5.2-DEV-rev565-g71748d7-ab-suite
10482019-12-28 14:01:28.474 T:2531095408 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0
10492019-12-28 14:01:28.475 T:2531095408 NOTICE: Opening stream: 0 source: 256
10502019-12-28 14:01:28.475 T:2531095408 NOTICE: Creating video codec with codec id: 173
10512019-12-28 14:01:28.475 T:2531095408 ERROR: CMMALVideo::Open : Video codec unknown: ad
10522019-12-28 14:01:28.475 T:2531095408 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: HEVC (High Efficiency Video Coding)
10532019-12-28 14:01:28.475 T:2531095408 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-hevc
10542019-12-28 14:01:28.475 T:2531095408 DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 173
10552019-12-28 14:01:28.477 T:2531095408 DEBUG: CMMALPool::CMMALPool Created pool 0xafcab780 of size 26 x 0 for port vc.ril.video_decode:out:0(I420)
10562019-12-28 14:01:28.477 T:2531095408 DEBUG: CMMALPool::~CMMALPool Destroying pool 0x2d9e980 for port vc.ril.video_decode:out:0(I420)
10572019-12-28 14:01:28.477 T:2531095408 NOTICE: Creating video thread
10582019-12-28 14:01:28.477 T:2564035440 DEBUG: Thread VideoPlayerVideo start, auto delete: false
10592019-12-28 14:01:28.478 T:2564035440 NOTICE: running thread: video_thread
10602019-12-28 14:01:28.478 T:2531095408 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: /media/Elements/Movies/jellyfish-400-mbps-4k-uhd-hevc-10bit.mkv
10612019-12-28 14:01:28.478 T:2564035440 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: 0
10622019-12-28 14:01:28.478 T:2531095408 DEBUG: CVideoPlayer::SetCaching - caching state 2
10632019-12-28 14:01:28.478 T:2531095408 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
10642019-12-28 14:01:28.478 T:2531095408 DEBUG: CVideoPlayer::HandleMessages - player 2 reported state: 0
10652019-12-28 14:01:28.487 T:2531095408 DEBUG: CVideoPlayer::SetCaching - caching state 1
10662019-12-28 14:01:28.487 T:2564035440 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback
10672019-12-28 14:01:28.487 T:2531095408 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
10682019-12-28 14:01:28.506 T:2531095408 DEBUG: CVideoPlayer::CheckContinuity - wrapback :2, prev:133000.000000, curr:0.000000, diff:-133000.000000
10692019-12-28 14:01:28.523 T:2564035440 NOTICE: CDecoder::Open - fmt:188
10702019-12-28 14:01:28.523 T:2564035440 DEBUG: CDecoder::Open MMAL - source requires 1 references
10712019-12-28 14:01:28.525 T:2564035440 DEBUG: CMMALPool::CMMALPool Created pool 0xb1a571e0 of size 26 x 0 for port vc.ril.video_decode:out:0(I420)
10722019-12-28 14:01:28.525 T:2564035440 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-hevc-mmal
10732019-12-28 14:01:28.562 T:2564035440 DEBUG: CMMALPool::Configure pool:0xb1a571e0 3840x2160 (3840x2160) pix:188 size:0 fmt:Y10C
10742019-12-28 14:01:28.760 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
10752019-12-28 14:01:29.122 T:2564035440 DEBUG: Previous line repeats 5 times.
10762019-12-28 14:01:29.122 T:2564035440 DEBUG: CRenderManager::Configure - change configuration. 3840x2160. display: 3840x2160. framerate: 29.97.
10772019-12-28 14:01:29.147 T:3011825680 DEBUG: DeleteRenderer - deleting renderer
10782019-12-28 14:01:29.147 T:2531095408 DEBUG: CVideoPlayer::SetCaching - caching state 2
10792019-12-28 14:01:29.147 T:3011825680 DEBUG: CMMALRenderer::~CMMALRenderer
10802019-12-28 14:01:29.147 T:2531095408 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
10812019-12-28 14:01:29.147 T:3011825680 DEBUG: CMMALRenderer::UnInitMMAL
10822019-12-28 14:01:29.147 T:2539488112 DEBUG: CMMALRenderer::Run - stopping
10832019-12-28 14:01:29.147 T:2539488112 DEBUG: Thread MMALProcess 2539488112 terminating
10842019-12-28 14:01:29.147 T:3011825680 DEBUG: CMMALRenderer::CMMALRenderer
10852019-12-28 14:01:29.147 T:2299343728 DEBUG: Thread MMALProcess start, auto delete: false
10862019-12-28 14:01:29.147 T:3011825680 DEBUG: CMMALRenderer::Configure - 3840x2160->3840x2160@29.97 flags:1 format:-1 orient:0
10872019-12-28 14:01:29.147 T:2299343728 DEBUG: CMMALRenderer::Run - starting
10882019-12-28 14:01:29.148 T:3011825680 DEBUG: CRenderManager::Configure - 6
10892019-12-28 14:01:29.151 T:2299343728 DEBUG: CMMALRenderer::CheckConfigurationVout Changing Vout dimensions from 0x0 (0x0) to 3840x2160 (0x0) Y10C
10902019-12-28 14:01:29.156 T:2299343728 DEBUG: CMMALRenderer::SetVideoRect 0,0,3840,2160 -> 0,0,1920,1080 (o:0 v:0 d:0 i:0)
10912019-12-28 14:01:29.156 T:2290951024 DEBUG: Thread MMALRenderer start, auto delete: false
10922019-12-28 14:01:29.156 T:2290951024 DEBUG: CMMALRenderer::Process - starting
10932019-12-28 14:01:29.156 T:2299343728 DEBUG: CMMALRenderer::SetVideoRect 0,0,3840,2160 -> 0,0,1920,1080 t:100000
10942019-12-28 14:01:29.157 T:2859860848 DEBUG: OnAVChange: CApplication::OnAVChange
10952019-12-28 14:01:29.157 T:2531095408 DEBUG: CVideoPlayer::HandleMessages - player started 2
10962019-12-28 14:01:29.157 T:2531095408 DEBUG: CVideoPlayer::SetCaching - caching state 3
10972019-12-28 14:01:29.157 T:2531095408 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
10982019-12-28 14:01:29.157 T:2531095408 DEBUG: CVideoPlayer::SetCaching - caching state 0
10992019-12-28 14:01:29.157 T:2531095408 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
11002019-12-28 14:01:29.157 T:2531095408 DEBUG: VideoPlayer::Sync - Video - pts: 0.000000, cache: 50000.000000, totalcache: 100000.000000
11012019-12-28 14:01:29.157 T:2531095408 WARNING: CDVDMessageQueue(audio)::Put MSGQ_NOT_INITIALIZED
11022019-12-28 14:01:29.157 T:2876646256 DEBUG: OnAVStarted: CApplication::OnAVStarted
11032019-12-28 14:01:29.158 T:2564035440 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(-100000.000000)
11042019-12-28 14:01:29.161 T:3011825680 DEBUG: CMMALRenderer::RenderUpdate - vsync -1 (+3144)
11052019-12-28 14:01:29.161 T:3011825680 DEBUG: CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 60
11062019-12-28 14:01:29.179 T:3011825680 DEBUG: Activating window ID: 12005
11072019-12-28 14:01:29.179 T:3011825680 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
11082019-12-28 14:01:29.180 T:3011825680 DEBUG: FreeVisualisation() done
11092019-12-28 14:01:29.180 T:3011825680 DEBUG: ------ Window Init (VideoFullScreen.xml) ------
11102019-12-28 14:01:29.181 T:3011825680 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY
11112019-12-28 14:01:29.185 T:3011825680 DEBUG: CMMALRenderer::SetVideoRect 0,0,3840,2160 -> 0,0,1920,1080 (o:0 v:0 d:0 i:0)
11122019-12-28 14:01:29.185 T:3011825680 DEBUG: CMMALRenderer::SetVideoRect 0,0,3840,2160 -> 0,0,1920,1080 t:100000
11132019-12-28 14:01:29.185 T:3011825680 DEBUG: CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 68
11142019-12-28 14:01:29.191 T:2663220080 DEBUG: OnAVChange: CApplication::OnAVChange
11152019-12-28 14:01:29.194 T:3011825680 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
11162019-12-28 14:01:29.263 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: loading setting definitions
11172019-12-28 14:01:29.263 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: trying to load setting definitions from old format...
11182019-12-28 14:01:29.264 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: loading setting values
11192019-12-28 14:01:29.266 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: loading setting definitions
11202019-12-28 14:01:29.266 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: trying to load setting definitions from old format...
11212019-12-28 14:01:29.268 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: loading setting values
11222019-12-28 14:01:29.270 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: loading setting definitions
11232019-12-28 14:01:29.270 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: trying to load setting definitions from old format...
11242019-12-28 14:01:29.271 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: loading setting values
11252019-12-28 14:01:29.284 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
11262019-12-28 14:01:29.462 T:3011825680 DEBUG: Previous line repeats 7 times.
11272019-12-28 14:01:29.463 T:3011825680 DEBUG: CMMALRenderer::RenderUpdate - vsync 3160 (+1)
11282019-12-28 14:01:29.579 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
11292019-12-28 14:01:29.731 T:3011825680 DEBUG: Previous line repeats 8 times.
11302019-12-28 14:01:29.732 T:3011825680 DEBUG: CMMALRenderer::RenderUpdate - vsync 3176 (+1)
11312019-12-28 14:01:29.854 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
11322019-12-28 14:01:29.913 T:2290951024 DEBUG: Previous line repeats 5 times.
11332019-12-28 14:01:29.913 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3185/3186 display:10000020 delay:0
11342019-12-28 14:01:30.007 T:2564035440 DEBUG: Previous line repeats 1 times.
11352019-12-28 14:01:30.007 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
11362019-12-28 14:01:30.014 T:2290951024 DEBUG: Previous line repeats 4 times.
11372019-12-28 14:01:30.014 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3185/3186 display:10000020 delay:0
11382019-12-28 14:01:30.138 T:2564035440 DEBUG: Previous line repeats 2 times.
11392019-12-28 14:01:30.138 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
11402019-12-28 14:01:30.166 T:2290951024 DEBUG: Previous line repeats 3 times.
11412019-12-28 14:01:30.166 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3185/3186 display:10000020 delay:0
11422019-12-28 14:01:30.259 T:2564035440 DEBUG: Previous line repeats 1 times.
11432019-12-28 14:01:30.260 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
11442019-12-28 14:01:30.266 T:2290951024 DEBUG: Previous line repeats 4 times.
11452019-12-28 14:01:30.266 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3185/3186 display:10000020 delay:0
11462019-12-28 14:01:30.353 T:2564035440 DEBUG: Previous line repeats 1 times.
11472019-12-28 14:01:30.353 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
11482019-12-28 14:01:30.367 T:2290951024 DEBUG: Previous line repeats 5 times.
11492019-12-28 14:01:30.368 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3185/3186 display:10000020 delay:0
11502019-12-28 14:01:30.455 T:2564035440 DEBUG: Previous line repeats 1 times.
11512019-12-28 14:01:30.455 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
11522019-12-28 14:01:30.468 T:2290951024 DEBUG: Previous line repeats 4 times.
11532019-12-28 14:01:30.468 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3185/3186 display:10000020 delay:0
11542019-12-28 14:01:30.523 T:2564035440 DEBUG: Previous line repeats 1 times.
11552019-12-28 14:01:30.523 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
11562019-12-28 14:01:30.569 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3185/3186 display:10000020 delay:0
11572019-12-28 14:01:30.574 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
11582019-12-28 14:01:30.619 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3185/3186 display:10000020 delay:0
11592019-12-28 14:01:30.625 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
11602019-12-28 14:01:30.669 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3185/3186 display:10000020 delay:0
11612019-12-28 14:01:30.677 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
11622019-12-28 14:01:30.719 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3185/3186 display:10000020 delay:0
11632019-12-28 14:01:30.728 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
11642019-12-28 14:01:30.770 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3185/3186 display:10000020 delay:0
11652019-12-28 14:01:30.779 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
11662019-12-28 14:01:30.820 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3185/3186 display:10000020 delay:0
11672019-12-28 14:01:30.831 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
11682019-12-28 14:01:30.870 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3185/3186 display:10000020 delay:0
11692019-12-28 14:01:30.882 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
11702019-12-28 14:01:30.921 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3185/3186 display:10000020 delay:0
11712019-12-28 14:01:30.933 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
11722019-12-28 14:01:30.971 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3185/3186 display:10000020 delay:0
11732019-12-28 14:01:30.985 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
11742019-12-28 14:01:31.021 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3185/3186 display:10000020 delay:0
11752019-12-28 14:01:31.036 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
11762019-12-28 14:01:31.071 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3185/3186 display:10000020 delay:0
11772019-12-28 14:01:31.087 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
11782019-12-28 14:01:31.135 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
11792019-12-28 14:01:31.189 T:2564035440 DEBUG: Previous line repeats 1 times.
11802019-12-28 14:01:31.189 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
11812019-12-28 14:01:31.208 T:2564035440 DEBUG: Previous line repeats 3 times.
11822019-12-28 14:01:31.208 T:2564035440 NOTICE: CDVDVideoCodecFFmpeg::CDropControl: calculated diff time: 33363
11832019-12-28 14:01:31.236 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
11842019-12-28 14:01:31.313 T:2564035440 DEBUG: Previous line repeats 1 times.
11852019-12-28 14:01:31.313 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
11862019-12-28 14:01:31.336 T:2290951024 DEBUG: Previous line repeats 4 times.
11872019-12-28 14:01:31.336 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
11882019-12-28 14:01:31.408 T:2564035440 DEBUG: Previous line repeats 1 times.
11892019-12-28 14:01:31.408 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
11902019-12-28 14:01:31.437 T:2290951024 DEBUG: Previous line repeats 5 times.
11912019-12-28 14:01:31.437 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
11922019-12-28 14:01:31.516 T:2564035440 DEBUG: Previous line repeats 1 times.
11932019-12-28 14:01:31.516 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
11942019-12-28 14:01:31.537 T:2290951024 DEBUG: Previous line repeats 4 times.
11952019-12-28 14:01:31.537 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
11962019-12-28 14:01:31.585 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
11972019-12-28 14:01:31.587 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
11982019-12-28 14:01:31.636 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
11992019-12-28 14:01:31.637 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
12002019-12-28 14:01:31.688 T:2564035440 DEBUG: Previous line repeats 1 times.
12012019-12-28 14:01:31.688 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12022019-12-28 14:01:31.738 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
12032019-12-28 14:01:31.739 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12042019-12-28 14:01:31.788 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
12052019-12-28 14:01:31.790 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12062019-12-28 14:01:31.839 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
12072019-12-28 14:01:31.842 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12082019-12-28 14:01:31.889 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
12092019-12-28 14:01:31.893 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12102019-12-28 14:01:31.939 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
12112019-12-28 14:01:31.944 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12122019-12-28 14:01:31.989 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
12132019-12-28 14:01:31.996 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12142019-12-28 14:01:32.040 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
12152019-12-28 14:01:32.047 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12162019-12-28 14:01:32.090 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
12172019-12-28 14:01:32.098 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12182019-12-28 14:01:32.140 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
12192019-12-28 14:01:32.149 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12202019-12-28 14:01:32.190 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
12212019-12-28 14:01:32.200 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12222019-12-28 14:01:32.240 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
12232019-12-28 14:01:32.252 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12242019-12-28 14:01:32.291 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3186/3187 display:10000020 delay:0
12252019-12-28 14:01:32.303 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12262019-12-28 14:01:32.388 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3187/3188 display:10000020 delay:0
12272019-12-28 14:01:32.460 T:2564035440 DEBUG: Previous line repeats 1 times.
12282019-12-28 14:01:32.460 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
12292019-12-28 14:01:32.488 T:2290951024 DEBUG: Previous line repeats 3 times.
12302019-12-28 14:01:32.489 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3187/3188 display:10000020 delay:0
12312019-12-28 14:01:32.585 T:2564035440 DEBUG: Previous line repeats 1 times.
12322019-12-28 14:01:32.585 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
12332019-12-28 14:01:32.589 T:2290951024 DEBUG: Previous line repeats 4 times.
12342019-12-28 14:01:32.589 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3187/3188 display:10000020 delay:0
12352019-12-28 14:01:32.687 T:2564035440 DEBUG: Previous line repeats 1 times.
12362019-12-28 14:01:32.687 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
12372019-12-28 14:01:32.690 T:2290951024 DEBUG: Previous line repeats 5 times.
12382019-12-28 14:01:32.690 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3187/3188 display:10000020 delay:0
12392019-12-28 14:01:32.827 T:2564035440 DEBUG: Previous line repeats 2 times.
12402019-12-28 14:01:32.827 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
12412019-12-28 14:01:32.841 T:2290951024 DEBUG: Previous line repeats 4 times.
12422019-12-28 14:01:32.841 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3187/3188 display:10000020 delay:0
12432019-12-28 14:01:32.900 T:2564035440 DEBUG: Previous line repeats 1 times.
12442019-12-28 14:01:32.900 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12452019-12-28 14:01:32.942 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3187/3188 display:10000020 delay:0
12462019-12-28 14:01:32.951 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12472019-12-28 14:01:32.992 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3187/3188 display:10000020 delay:0
12482019-12-28 14:01:33.002 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12492019-12-28 14:01:33.042 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3187/3188 display:10000020 delay:0
12502019-12-28 14:01:33.053 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12512019-12-28 14:01:33.093 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3187/3188 display:10000020 delay:0
12522019-12-28 14:01:33.104 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12532019-12-28 14:01:33.143 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3187/3188 display:10000020 delay:0
12542019-12-28 14:01:33.156 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12552019-12-28 14:01:33.193 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3187/3188 display:10000020 delay:0
12562019-12-28 14:01:33.207 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12572019-12-28 14:01:33.243 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3187/3188 display:10000020 delay:0
12582019-12-28 14:01:33.258 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12592019-12-28 14:01:33.293 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3187/3188 display:10000020 delay:0
12602019-12-28 14:01:33.309 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12612019-12-28 14:01:33.344 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3187/3188 display:10000020 delay:0
12622019-12-28 14:01:33.361 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12632019-12-28 14:01:33.394 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3187/3188 display:10000020 delay:0
12642019-12-28 14:01:33.412 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12652019-12-28 14:01:33.444 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3187/3188 display:10000020 delay:0
12662019-12-28 14:01:33.463 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12672019-12-28 14:01:33.494 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3187/3188 display:10000020 delay:0
12682019-12-28 14:01:33.514 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12692019-12-28 14:01:33.587 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3188/3189 display:10000020 delay:0
12702019-12-28 14:01:33.639 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3189/3190 display:10000020 delay:0
12712019-12-28 14:01:33.653 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
12722019-12-28 14:01:33.689 T:2290951024 DEBUG: Previous line repeats 3 times.
12732019-12-28 14:01:33.689 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3189/3190 display:10000020 delay:0
12742019-12-28 14:01:33.777 T:2564035440 DEBUG: Previous line repeats 1 times.
12752019-12-28 14:01:33.777 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
12762019-12-28 14:01:33.791 T:2290951024 DEBUG: Previous line repeats 4 times.
12772019-12-28 14:01:33.792 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3189/3190 display:10000020 delay:0
12782019-12-28 14:01:33.881 T:2564035440 DEBUG: Previous line repeats 1 times.
12792019-12-28 14:01:33.881 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
12802019-12-28 14:01:33.892 T:2290951024 DEBUG: Previous line repeats 5 times.
12812019-12-28 14:01:33.893 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3189/3190 display:10000020 delay:0
12822019-12-28 14:01:33.982 T:2564035440 DEBUG: Previous line repeats 1 times.
12832019-12-28 14:01:33.982 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
12842019-12-28 14:01:33.994 T:2290951024 DEBUG: Previous line repeats 4 times.
12852019-12-28 14:01:33.994 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3189/3190 display:10000020 delay:0
12862019-12-28 14:01:34.112 T:2564035440 DEBUG: Previous line repeats 2 times.
12872019-12-28 14:01:34.112 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
12882019-12-28 14:01:34.145 T:2290951024 DEBUG: Previous line repeats 3 times.
12892019-12-28 14:01:34.145 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3189/3190 display:10000020 delay:0
12902019-12-28 14:01:34.241 T:2564035440 DEBUG: Previous line repeats 1 times.
12912019-12-28 14:01:34.241 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
12922019-12-28 14:01:34.246 T:2290951024 DEBUG: Previous line repeats 4 times.
12932019-12-28 14:01:34.246 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3189/3190 display:10000020 delay:0
12942019-12-28 14:01:34.312 T:2564035440 DEBUG: Previous line repeats 1 times.
12952019-12-28 14:01:34.312 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12962019-12-28 14:01:34.346 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3189/3190 display:10000020 delay:0
12972019-12-28 14:01:34.363 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
12982019-12-28 14:01:34.397 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3189/3190 display:10000020 delay:0
12992019-12-28 14:01:34.414 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13002019-12-28 14:01:34.447 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3189/3190 display:10000020 delay:0
13012019-12-28 14:01:34.466 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13022019-12-28 14:01:34.497 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3189/3190 display:10000020 delay:0
13032019-12-28 14:01:34.517 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13042019-12-28 14:01:34.547 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3189/3190 display:10000020 delay:0
13052019-12-28 14:01:34.568 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13062019-12-28 14:01:34.598 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3189/3190 display:10000020 delay:0
13072019-12-28 14:01:34.619 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13082019-12-28 14:01:34.648 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3189/3190 display:10000020 delay:0
13092019-12-28 14:01:34.671 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13102019-12-28 14:01:34.698 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3189/3190 display:10000020 delay:0
13112019-12-28 14:01:34.722 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13122019-12-28 14:01:34.788 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3190/3191 display:10000020 delay:0
13132019-12-28 14:01:34.822 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
13142019-12-28 14:01:34.839 T:2290951024 DEBUG: Previous line repeats 5 times.
13152019-12-28 14:01:34.839 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3191/3192 display:10000020 delay:0
13162019-12-28 14:01:34.925 T:2564035440 DEBUG: Previous line repeats 1 times.
13172019-12-28 14:01:34.925 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
13182019-12-28 14:01:34.940 T:2290951024 DEBUG: Previous line repeats 4 times.
13192019-12-28 14:01:34.940 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3191/3192 display:10000020 delay:0
13202019-12-28 14:01:35.052 T:2564035440 DEBUG: Previous line repeats 2 times.
13212019-12-28 14:01:35.052 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
13222019-12-28 14:01:35.090 T:2290951024 DEBUG: Previous line repeats 3 times.
13232019-12-28 14:01:35.090 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3191/3192 display:10000020 delay:0
13242019-12-28 14:01:35.174 T:2564035440 DEBUG: Previous line repeats 1 times.
13252019-12-28 14:01:35.174 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
13262019-12-28 14:01:35.191 T:2290951024 DEBUG: Previous line repeats 4 times.
13272019-12-28 14:01:35.191 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3191/3192 display:10000020 delay:0
13282019-12-28 14:01:35.306 T:2564035440 DEBUG: Previous line repeats 2 times.
13292019-12-28 14:01:35.306 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
13302019-12-28 14:01:35.342 T:2290951024 DEBUG: Previous line repeats 5 times.
13312019-12-28 14:01:35.342 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3191/3192 display:10000020 delay:0
13322019-12-28 14:01:35.405 T:2564035440 DEBUG: Previous line repeats 1 times.
13332019-12-28 14:01:35.405 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
13342019-12-28 14:01:35.442 T:2290951024 DEBUG: Previous line repeats 4 times.
13352019-12-28 14:01:35.442 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3191/3192 display:10000020 delay:0
13362019-12-28 14:01:35.474 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13372019-12-28 14:01:35.492 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3191/3192 display:10000020 delay:0
13382019-12-28 14:01:35.525 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13392019-12-28 14:01:35.543 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3191/3192 display:10000020 delay:0
13402019-12-28 14:01:35.576 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13412019-12-28 14:01:35.593 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3191/3192 display:10000020 delay:0
13422019-12-28 14:01:35.627 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13432019-12-28 14:01:35.643 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3191/3192 display:10000020 delay:0
13442019-12-28 14:01:35.678 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13452019-12-28 14:01:35.693 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3191/3192 display:10000020 delay:0
13462019-12-28 14:01:35.730 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13472019-12-28 14:01:35.743 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3191/3192 display:10000020 delay:0
13482019-12-28 14:01:35.781 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13492019-12-28 14:01:35.793 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3191/3192 display:10000020 delay:0
13502019-12-28 14:01:35.832 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13512019-12-28 14:01:35.844 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3191/3192 display:10000020 delay:0
13522019-12-28 14:01:35.883 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13532019-12-28 14:01:35.894 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3191/3192 display:10000020 delay:0
13542019-12-28 14:01:35.935 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13552019-12-28 14:01:35.944 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3191/3192 display:10000020 delay:0
13562019-12-28 14:01:35.986 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13572019-12-28 14:01:35.991 T:3011825680 DEBUG: CMMALRenderer::RenderUpdate - vsync 3192 (+1)
13582019-12-28 14:01:36.040 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3193/3194 display:10000020 delay:0
13592019-12-28 14:01:36.114 T:2564035440 DEBUG: Previous line repeats 1 times.
13602019-12-28 14:01:36.114 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
13612019-12-28 14:01:36.141 T:2290951024 DEBUG: Previous line repeats 3 times.
13622019-12-28 14:01:36.141 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3193/3194 display:10000020 delay:0
13632019-12-28 14:01:36.240 T:2564035440 DEBUG: Previous line repeats 1 times.
13642019-12-28 14:01:36.240 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
13652019-12-28 14:01:36.241 T:2290951024 DEBUG: Previous line repeats 4 times.
13662019-12-28 14:01:36.241 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3193/3194 display:10000020 delay:0
13672019-12-28 14:01:36.346 T:2564035440 DEBUG: Previous line repeats 2 times.
13682019-12-28 14:01:36.346 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
13692019-12-28 14:01:36.392 T:2290951024 DEBUG: Previous line repeats 5 times.
13702019-12-28 14:01:36.392 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3193/3194 display:10000020 delay:0
13712019-12-28 14:01:36.448 T:2564035440 DEBUG: Previous line repeats 1 times.
13722019-12-28 14:01:36.448 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
13732019-12-28 14:01:36.492 T:2290951024 DEBUG: Previous line repeats 4 times.
13742019-12-28 14:01:36.492 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3193/3194 display:10000020 delay:0
13752019-12-28 14:01:36.516 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13762019-12-28 14:01:36.542 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3193/3194 display:10000020 delay:0
13772019-12-28 14:01:36.567 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13782019-12-28 14:01:36.592 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3193/3194 display:10000020 delay:0
13792019-12-28 14:01:36.619 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13802019-12-28 14:01:36.643 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3193/3194 display:10000020 delay:0
13812019-12-28 14:01:36.670 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13822019-12-28 14:01:36.693 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3193/3194 display:10000020 delay:0
13832019-12-28 14:01:36.721 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13842019-12-28 14:01:36.743 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3193/3194 display:10000020 delay:0
13852019-12-28 14:01:36.772 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13862019-12-28 14:01:36.793 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3193/3194 display:10000020 delay:0
13872019-12-28 14:01:36.824 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13882019-12-28 14:01:36.843 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3193/3194 display:10000020 delay:0
13892019-12-28 14:01:36.875 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13902019-12-28 14:01:36.894 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3193/3194 display:10000020 delay:0
13912019-12-28 14:01:36.926 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13922019-12-28 14:01:36.944 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3193/3194 display:10000020 delay:0
13932019-12-28 14:01:36.978 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13942019-12-28 14:01:36.994 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3193/3194 display:10000020 delay:0
13952019-12-28 14:01:37.029 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13962019-12-28 14:01:37.045 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3193/3194 display:10000020 delay:0
13972019-12-28 14:01:37.080 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
13982019-12-28 14:01:37.095 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3193/3194 display:10000020 delay:0
13992019-12-28 14:01:37.131 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14002019-12-28 14:01:37.145 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3193/3194 display:10000020 delay:0
14012019-12-28 14:01:37.183 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14022019-12-28 14:01:37.241 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3194/3195 display:10000020 delay:0
14032019-12-28 14:01:37.291 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3195/3196 display:10000020 delay:0
14042019-12-28 14:01:37.295 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
14052019-12-28 14:01:37.342 T:2290951024 DEBUG: Previous line repeats 3 times.
14062019-12-28 14:01:37.342 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3195/3196 display:10000020 delay:0
14072019-12-28 14:01:37.420 T:2564035440 DEBUG: Previous line repeats 1 times.
14082019-12-28 14:01:37.420 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
14092019-12-28 14:01:37.442 T:2290951024 DEBUG: Previous line repeats 4 times.
14102019-12-28 14:01:37.442 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3195/3196 display:10000020 delay:0
14112019-12-28 14:01:37.526 T:2564035440 DEBUG: Previous line repeats 1 times.
14122019-12-28 14:01:37.526 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
14132019-12-28 14:01:37.543 T:2290951024 DEBUG: Previous line repeats 5 times.
14142019-12-28 14:01:37.543 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3195/3196 display:10000020 delay:0
14152019-12-28 14:01:37.628 T:2564035440 DEBUG: Previous line repeats 1 times.
14162019-12-28 14:01:37.628 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
14172019-12-28 14:01:37.643 T:2290951024 DEBUG: Previous line repeats 4 times.
14182019-12-28 14:01:37.643 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3195/3196 display:10000020 delay:0
14192019-12-28 14:01:37.751 T:2564035440 DEBUG: Previous line repeats 2 times.
14202019-12-28 14:01:37.751 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
14212019-12-28 14:01:37.794 T:2290951024 DEBUG: Previous line repeats 3 times.
14222019-12-28 14:01:37.794 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3195/3196 display:10000020 delay:0
14232019-12-28 14:01:37.888 T:2564035440 DEBUG: Previous line repeats 1 times.
14242019-12-28 14:01:37.888 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
14252019-12-28 14:01:37.895 T:2290951024 DEBUG: Previous line repeats 4 times.
14262019-12-28 14:01:37.895 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3195/3196 display:10000020 delay:0
14272019-12-28 14:01:37.959 T:2564035440 DEBUG: Previous line repeats 1 times.
14282019-12-28 14:01:37.959 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14292019-12-28 14:01:37.995 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3195/3196 display:10000020 delay:0
14302019-12-28 14:01:38.010 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14312019-12-28 14:01:38.046 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3195/3196 display:10000020 delay:0
14322019-12-28 14:01:38.061 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14332019-12-28 14:01:38.096 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3195/3196 display:10000020 delay:0
14342019-12-28 14:01:38.112 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14352019-12-28 14:01:38.146 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3195/3196 display:10000020 delay:0
14362019-12-28 14:01:38.163 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14372019-12-28 14:01:38.196 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3195/3196 display:10000020 delay:0
14382019-12-28 14:01:38.215 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14392019-12-28 14:01:38.246 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3195/3196 display:10000020 delay:0
14402019-12-28 14:01:38.266 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14412019-12-28 14:01:38.296 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3195/3196 display:10000020 delay:0
14422019-12-28 14:01:38.317 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14432019-12-28 14:01:38.347 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3195/3196 display:10000020 delay:0
14442019-12-28 14:01:38.368 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14452019-12-28 14:01:38.482 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
14462019-12-28 14:01:38.491 T:2290951024 DEBUG: Previous line repeats 5 times.
14472019-12-28 14:01:38.492 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3197/3198 display:10000020 delay:0
14482019-12-28 14:01:38.602 T:2564035440 DEBUG: Previous line repeats 2 times.
14492019-12-28 14:01:38.602 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
14502019-12-28 14:01:38.644 T:2290951024 DEBUG: Previous line repeats 4 times.
14512019-12-28 14:01:38.644 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3197/3198 display:10000020 delay:0
14522019-12-28 14:01:38.724 T:2564035440 DEBUG: Previous line repeats 1 times.
14532019-12-28 14:01:38.725 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
14542019-12-28 14:01:38.744 T:2290951024 DEBUG: Previous line repeats 3 times.
14552019-12-28 14:01:38.744 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3197/3198 display:10000020 delay:0
14562019-12-28 14:01:38.853 T:2564035440 DEBUG: Previous line repeats 2 times.
14572019-12-28 14:01:38.853 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
14582019-12-28 14:01:38.895 T:2290951024 DEBUG: Previous line repeats 4 times.
14592019-12-28 14:01:38.895 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3197/3198 display:10000020 delay:0
14602019-12-28 14:01:38.960 T:2564035440 DEBUG: Previous line repeats 1 times.
14612019-12-28 14:01:38.960 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
14622019-12-28 14:01:38.995 T:2290951024 DEBUG: Previous line repeats 5 times.
14632019-12-28 14:01:38.995 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3197/3198 display:10000020 delay:0
14642019-12-28 14:01:39.066 T:2564035440 DEBUG: Previous line repeats 1 times.
14652019-12-28 14:01:39.066 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
14662019-12-28 14:01:39.096 T:2290951024 DEBUG: Previous line repeats 4 times.
14672019-12-28 14:01:39.096 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3197/3198 display:10000020 delay:0
14682019-12-28 14:01:39.134 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14692019-12-28 14:01:39.146 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3197/3198 display:10000020 delay:0
14702019-12-28 14:01:39.186 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14712019-12-28 14:01:39.196 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3197/3198 display:10000020 delay:0
14722019-12-28 14:01:39.237 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14732019-12-28 14:01:39.246 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3197/3198 display:10000020 delay:0
14742019-12-28 14:01:39.288 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14752019-12-28 14:01:39.297 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3197/3198 display:10000020 delay:0
14762019-12-28 14:01:39.339 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14772019-12-28 14:01:39.347 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3197/3198 display:10000020 delay:0
14782019-12-28 14:01:39.391 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14792019-12-28 14:01:39.397 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3197/3198 display:10000020 delay:0
14802019-12-28 14:01:39.442 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14812019-12-28 14:01:39.448 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3197/3198 display:10000020 delay:0
14822019-12-28 14:01:39.494 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14832019-12-28 14:01:39.498 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3197/3198 display:10000020 delay:0
14842019-12-28 14:01:39.545 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14852019-12-28 14:01:39.548 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3197/3198 display:10000020 delay:0
14862019-12-28 14:01:39.596 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
14872019-12-28 14:01:39.598 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3197/3198 display:10000020 delay:0
14882019-12-28 14:01:39.642 T:3011825680 DEBUG: CMMALRenderer::RenderUpdate - vsync 3198 (+1)
14892019-12-28 14:01:39.691 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3199/3200 display:10000020 delay:0
14902019-12-28 14:01:39.744 T:2564035440 DEBUG: Previous line repeats 1 times.
14912019-12-28 14:01:39.744 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
14922019-12-28 14:01:39.792 T:2290951024 DEBUG: Previous line repeats 3 times.
14932019-12-28 14:01:39.792 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3199/3200 display:10000020 delay:0
14942019-12-28 14:01:39.872 T:2564035440 DEBUG: Previous line repeats 1 times.
14952019-12-28 14:01:39.872 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
14962019-12-28 14:01:39.892 T:2290951024 DEBUG: Previous line repeats 4 times.
14972019-12-28 14:01:39.892 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3199/3200 display:10000020 delay:0
14982019-12-28 14:01:39.977 T:2564035440 DEBUG: Previous line repeats 1 times.
14992019-12-28 14:01:39.978 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
15002019-12-28 14:01:39.993 T:2290951024 DEBUG: Previous line repeats 5 times.
15012019-12-28 14:01:39.993 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3199/3200 display:10000020 delay:0
15022019-12-28 14:01:40.080 T:2564035440 DEBUG: Previous line repeats 1 times.
15032019-12-28 14:01:40.081 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
15042019-12-28 14:01:40.093 T:2290951024 DEBUG: Previous line repeats 4 times.
15052019-12-28 14:01:40.093 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3199/3200 display:10000020 delay:0
15062019-12-28 14:01:40.149 T:2564035440 DEBUG: Previous line repeats 1 times.
15072019-12-28 14:01:40.149 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15082019-12-28 14:01:40.194 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3199/3200 display:10000020 delay:0
15092019-12-28 14:01:40.201 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15102019-12-28 14:01:40.244 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3199/3200 display:10000020 delay:0
15112019-12-28 14:01:40.252 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15122019-12-28 14:01:40.294 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3199/3200 display:10000020 delay:0
15132019-12-28 14:01:40.303 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15142019-12-28 14:01:40.345 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3199/3200 display:10000020 delay:0
15152019-12-28 14:01:40.355 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15162019-12-28 14:01:40.395 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3199/3200 display:10000020 delay:0
15172019-12-28 14:01:40.406 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15182019-12-28 14:01:40.445 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3199/3200 display:10000020 delay:0
15192019-12-28 14:01:40.457 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15202019-12-28 14:01:40.495 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3199/3200 display:10000020 delay:0
15212019-12-28 14:01:40.508 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15222019-12-28 14:01:40.546 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3199/3200 display:10000020 delay:0
15232019-12-28 14:01:40.560 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15242019-12-28 14:01:40.596 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3199/3200 display:10000020 delay:0
15252019-12-28 14:01:40.611 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15262019-12-28 14:01:40.646 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3199/3200 display:10000020 delay:0
15272019-12-28 14:01:40.662 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15282019-12-28 14:01:40.696 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3199/3200 display:10000020 delay:0
15292019-12-28 14:01:40.713 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15302019-12-28 14:01:40.746 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3199/3200 display:10000020 delay:0
15312019-12-28 14:01:40.765 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15322019-12-28 14:01:40.796 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3199/3200 display:10000020 delay:0
15332019-12-28 14:01:40.816 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15342019-12-28 14:01:40.942 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3201/3202 display:10000020 delay:0
15352019-12-28 14:01:40.946 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
15362019-12-28 14:01:40.992 T:2290951024 DEBUG: Previous line repeats 3 times.
15372019-12-28 14:01:40.992 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3201/3202 display:10000020 delay:0
15382019-12-28 14:01:41.070 T:2564035440 DEBUG: Previous line repeats 1 times.
15392019-12-28 14:01:41.070 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
15402019-12-28 14:01:41.092 T:2290951024 DEBUG: Previous line repeats 4 times.
15412019-12-28 14:01:41.093 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3201/3202 display:10000020 delay:0
15422019-12-28 14:01:41.174 T:2564035440 DEBUG: Previous line repeats 1 times.
15432019-12-28 14:01:41.174 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
15442019-12-28 14:01:41.194 T:2290951024 DEBUG: Previous line repeats 5 times.
15452019-12-28 14:01:41.195 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3201/3202 display:10000020 delay:0
15462019-12-28 14:01:41.287 T:2564035440 DEBUG: Previous line repeats 1 times.
15472019-12-28 14:01:41.287 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
15482019-12-28 14:01:41.296 T:2290951024 DEBUG: Previous line repeats 4 times.
15492019-12-28 14:01:41.296 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3201/3202 display:10000020 delay:0
15502019-12-28 14:01:41.398 T:2564035440 DEBUG: Previous line repeats 2 times.
15512019-12-28 14:01:41.398 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
15522019-12-28 14:01:41.447 T:2290951024 DEBUG: Previous line repeats 3 times.
15532019-12-28 14:01:41.447 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3201/3202 display:10000020 delay:0
15542019-12-28 14:01:41.525 T:2564035440 DEBUG: Previous line repeats 1 times.
15552019-12-28 14:01:41.525 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
15562019-12-28 14:01:41.547 T:2290951024 DEBUG: Previous line repeats 4 times.
15572019-12-28 14:01:41.547 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3201/3202 display:10000020 delay:0
15582019-12-28 14:01:41.595 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15592019-12-28 14:01:41.597 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3201/3202 display:10000020 delay:0
15602019-12-28 14:01:41.646 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15612019-12-28 14:01:41.647 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3201/3202 display:10000020 delay:0
15622019-12-28 14:01:41.698 T:2564035440 DEBUG: Previous line repeats 1 times.
15632019-12-28 14:01:41.698 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15642019-12-28 14:01:41.748 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3201/3202 display:10000020 delay:0
15652019-12-28 14:01:41.749 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15662019-12-28 14:01:41.798 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3201/3202 display:10000020 delay:0
15672019-12-28 14:01:41.800 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15682019-12-28 14:01:41.848 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3201/3202 display:10000020 delay:0
15692019-12-28 14:01:41.851 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15702019-12-28 14:01:41.898 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3201/3202 display:10000020 delay:0
15712019-12-28 14:01:41.903 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15722019-12-28 14:01:41.948 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3201/3202 display:10000020 delay:0
15732019-12-28 14:01:41.954 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15742019-12-28 14:01:41.999 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3201/3202 display:10000020 delay:0
15752019-12-28 14:01:42.005 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
15762019-12-28 14:01:42.142 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3203/3204 display:10000020 delay:0
15772019-12-28 14:01:42.148 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
15782019-12-28 14:01:42.192 T:2290951024 DEBUG: Previous line repeats 5 times.
15792019-12-28 14:01:42.192 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3203/3204 display:10000020 delay:0
15802019-12-28 14:01:42.248 T:2564035440 DEBUG: Previous line repeats 1 times.
15812019-12-28 14:01:42.248 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
15822019-12-28 14:01:42.293 T:2290951024 DEBUG: Previous line repeats 4 times.
15832019-12-28 14:01:42.293 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3203/3204 display:10000020 delay:0
15842019-12-28 14:01:42.368 T:2564035440 DEBUG: Previous line repeats 1 times.
15852019-12-28 14:01:42.368 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
15862019-12-28 14:01:42.393 T:2290951024 DEBUG: Previous line repeats 3 times.
15872019-12-28 14:01:42.393 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3203/3204 display:10000020 delay:0
15882019-12-28 14:01:42.489 T:2564035440 DEBUG: Previous line repeats 1 times.
15892019-12-28 14:01:42.489 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
15902019-12-28 14:01:42.494 T:2290951024 DEBUG: Previous line repeats 4 times.
15912019-12-28 14:01:42.494 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3203/3204 display:10000020 delay:0
15922019-12-28 14:01:42.595 T:2564035440 DEBUG: Previous line repeats 2 times.
15932019-12-28 14:01:42.595 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
15942019-12-28 14:01:42.644 T:2290951024 DEBUG: Previous line repeats 5 times.
15952019-12-28 14:01:42.644 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3203/3204 display:10000020 delay:0
15962019-12-28 14:01:42.696 T:2564035440 DEBUG: Previous line repeats 1 times.
15972019-12-28 14:01:42.696 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
15982019-12-28 14:01:42.745 T:2290951024 DEBUG: Previous line repeats 4 times.
15992019-12-28 14:01:42.745 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3203/3204 display:10000020 delay:0
16002019-12-28 14:01:42.765 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16012019-12-28 14:01:42.795 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3203/3204 display:10000020 delay:0
16022019-12-28 14:01:42.816 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16032019-12-28 14:01:42.845 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3203/3204 display:10000020 delay:0
16042019-12-28 14:01:42.868 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16052019-12-28 14:01:42.895 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3203/3204 display:10000020 delay:0
16062019-12-28 14:01:42.919 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16072019-12-28 14:01:42.946 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3203/3204 display:10000020 delay:0
16082019-12-28 14:01:42.970 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16092019-12-28 14:01:42.996 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3203/3204 display:10000020 delay:0
16102019-12-28 14:01:43.022 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16112019-12-28 14:01:43.046 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3203/3204 display:10000020 delay:0
16122019-12-28 14:01:43.073 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16132019-12-28 14:01:43.096 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3203/3204 display:10000020 delay:0
16142019-12-28 14:01:43.124 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16152019-12-28 14:01:43.146 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3203/3204 display:10000020 delay:0
16162019-12-28 14:01:43.175 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16172019-12-28 14:01:43.196 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3203/3204 display:10000020 delay:0
16182019-12-28 14:01:43.226 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16192019-12-28 14:01:43.247 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3203/3204 display:10000020 delay:0
16202019-12-28 14:01:43.278 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16212019-12-28 14:01:43.294 T:3011825680 DEBUG: CMMALRenderer::RenderUpdate - vsync 3204 (+1)
16222019-12-28 14:01:43.343 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3205/3206 display:10000020 delay:0
16232019-12-28 14:01:43.390 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
16242019-12-28 14:01:43.393 T:2290951024 DEBUG: Previous line repeats 3 times.
16252019-12-28 14:01:43.393 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3205/3206 display:10000020 delay:0
16262019-12-28 14:01:43.514 T:2564035440 DEBUG: Previous line repeats 2 times.
16272019-12-28 14:01:43.514 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
16282019-12-28 14:01:43.543 T:2290951024 DEBUG: Previous line repeats 4 times.
16292019-12-28 14:01:43.543 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3205/3206 display:10000020 delay:0
16302019-12-28 14:01:43.617 T:2564035440 DEBUG: Previous line repeats 1 times.
16312019-12-28 14:01:43.617 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
16322019-12-28 14:01:43.644 T:2290951024 DEBUG: Previous line repeats 5 times.
16332019-12-28 14:01:43.644 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3205/3206 display:10000020 delay:0
16342019-12-28 14:01:43.741 T:2564035440 DEBUG: Previous line repeats 1 times.
16352019-12-28 14:01:43.741 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
16362019-12-28 14:01:43.745 T:2290951024 DEBUG: Previous line repeats 4 times.
16372019-12-28 14:01:43.745 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3205/3206 display:10000020 delay:0
16382019-12-28 14:01:43.810 T:2564035440 DEBUG: Previous line repeats 1 times.
16392019-12-28 14:01:43.810 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16402019-12-28 14:01:43.845 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3205/3206 display:10000020 delay:0
16412019-12-28 14:01:43.862 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16422019-12-28 14:01:43.895 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3205/3206 display:10000020 delay:0
16432019-12-28 14:01:43.913 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16442019-12-28 14:01:43.946 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3205/3206 display:10000020 delay:0
16452019-12-28 14:01:43.964 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16462019-12-28 14:01:43.996 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3205/3206 display:10000020 delay:0
16472019-12-28 14:01:44.015 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16482019-12-28 14:01:44.046 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3205/3206 display:10000020 delay:0
16492019-12-28 14:01:44.067 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16502019-12-28 14:01:44.096 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3205/3206 display:10000020 delay:0
16512019-12-28 14:01:44.118 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16522019-12-28 14:01:44.146 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3205/3206 display:10000020 delay:0
16532019-12-28 14:01:44.169 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16542019-12-28 14:01:44.196 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3205/3206 display:10000020 delay:0
16552019-12-28 14:01:44.220 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16562019-12-28 14:01:44.247 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3205/3206 display:10000020 delay:0
16572019-12-28 14:01:44.271 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16582019-12-28 14:01:44.297 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3205/3206 display:10000020 delay:0
16592019-12-28 14:01:44.323 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16602019-12-28 14:01:44.347 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3205/3206 display:10000020 delay:0
16612019-12-28 14:01:44.374 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16622019-12-28 14:01:44.397 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3205/3206 display:10000020 delay:0
16632019-12-28 14:01:44.425 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16642019-12-28 14:01:44.447 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3205/3206 display:10000020 delay:0
16652019-12-28 14:01:44.476 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16662019-12-28 14:01:44.543 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3206/3207 display:10000020 delay:0
16672019-12-28 14:01:44.593 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3207/3208 display:10000020 delay:0
16682019-12-28 14:01:44.608 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
16692019-12-28 14:01:44.643 T:2290951024 DEBUG: Previous line repeats 3 times.
16702019-12-28 14:01:44.643 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3207/3208 display:10000020 delay:0
16712019-12-28 14:01:44.725 T:2564035440 DEBUG: Previous line repeats 1 times.
16722019-12-28 14:01:44.725 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
16732019-12-28 14:01:44.744 T:2290951024 DEBUG: Previous line repeats 4 times.
16742019-12-28 14:01:44.744 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3207/3208 display:10000020 delay:0
16752019-12-28 14:01:44.830 T:2564035440 DEBUG: Previous line repeats 1 times.
16762019-12-28 14:01:44.830 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
16772019-12-28 14:01:44.844 T:2290951024 DEBUG: Previous line repeats 5 times.
16782019-12-28 14:01:44.844 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3207/3208 display:10000020 delay:0
16792019-12-28 14:01:44.933 T:2564035440 DEBUG: Previous line repeats 1 times.
16802019-12-28 14:01:44.933 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
16812019-12-28 14:01:44.945 T:2290951024 DEBUG: Previous line repeats 5 times.
16822019-12-28 14:01:44.945 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3207/3208 display:10000020 delay:0
16832019-12-28 14:01:45.036 T:2564035440 DEBUG: Previous line repeats 1 times.
16842019-12-28 14:01:45.036 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
16852019-12-28 14:01:45.045 T:2290951024 DEBUG: Previous line repeats 4 times.
16862019-12-28 14:01:45.045 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3207/3208 display:10000020 delay:0
16872019-12-28 14:01:45.160 T:2564035440 DEBUG: Previous line repeats 2 times.
16882019-12-28 14:01:45.160 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
16892019-12-28 14:01:45.196 T:2290951024 DEBUG: Previous line repeats 3 times.
16902019-12-28 14:01:45.196 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3207/3208 display:10000020 delay:0
16912019-12-28 14:01:45.215 T:1973457776 DEBUG: CWebServer[8080]: request received for /jsonrpc?JSONRPC.Ping
16922019-12-28 14:01:45.227 T:1973457776 DEBUG: Previous line repeats 2 times.
16932019-12-28 14:01:45.227 T:1973457776 DEBUG: CWebServer[8080]: request received for /jsonrpc?Application.GetProperties
16942019-12-28 14:01:45.230 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
16952019-12-28 14:01:45.231 T:1965065072 DEBUG: CWebServer[8080]: request received for /jsonrpc?Application.GetProperties
16962019-12-28 14:01:45.246 T:2290951024 DEBUG: Previous line repeats 2 times.
16972019-12-28 14:01:45.246 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3207/3208 display:10000020 delay:0
16982019-12-28 14:01:45.250 T:1948279664 DEBUG: CWebServer[8080]: request received for /jsonrpc?Player.GetActivePlayers
16992019-12-28 14:01:45.281 T:2564035440 DEBUG: Previous line repeats 3 times.
17002019-12-28 14:01:45.281 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17012019-12-28 14:01:45.296 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3207/3208 display:10000020 delay:0
17022019-12-28 14:01:45.332 T:1973457776 DEBUG: CWebServer[8080]: request received for /jsonrpc?Base
17032019-12-28 14:01:45.333 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17042019-12-28 14:01:45.336 T:1965065072 DEBUG: CWebServer[8080]: request received for /jsonrpc?Base
17052019-12-28 14:01:45.347 T:2290951024 DEBUG: Previous line repeats 2 times.
17062019-12-28 14:01:45.347 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3207/3208 display:10000020 delay:0
17072019-12-28 14:01:45.384 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17082019-12-28 14:01:45.397 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3207/3208 display:10000020 delay:0
17092019-12-28 14:01:45.435 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17102019-12-28 14:01:45.447 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3207/3208 display:10000020 delay:0
17112019-12-28 14:01:45.487 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17122019-12-28 14:01:45.498 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3207/3208 display:10000020 delay:0
17132019-12-28 14:01:45.538 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17142019-12-28 14:01:45.548 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3207/3208 display:10000020 delay:0
17152019-12-28 14:01:45.589 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17162019-12-28 14:01:45.598 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3207/3208 display:10000020 delay:0
17172019-12-28 14:01:45.640 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17182019-12-28 14:01:45.648 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3207/3208 display:10000020 delay:0
17192019-12-28 14:01:45.692 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17202019-12-28 14:01:45.698 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3207/3208 display:10000020 delay:0
17212019-12-28 14:01:45.743 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17222019-12-28 14:01:45.745 T:3011825680 DEBUG: CMMALRenderer::RenderUpdate - vsync 3208 (+1)
17232019-12-28 14:01:45.796 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3209/3210 display:10000020 delay:0
17242019-12-28 14:01:45.852 T:2564035440 DEBUG: Previous line repeats 1 times.
17252019-12-28 14:01:45.852 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
17262019-12-28 14:01:45.896 T:2290951024 DEBUG: Previous line repeats 4 times.
17272019-12-28 14:01:45.896 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3209/3210 display:10000020 delay:0
17282019-12-28 14:01:45.957 T:2564035440 DEBUG: Previous line repeats 1 times.
17292019-12-28 14:01:45.957 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
17302019-12-28 14:01:45.996 T:2290951024 DEBUG: Previous line repeats 5 times.
17312019-12-28 14:01:45.996 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3209/3210 display:10000020 delay:0
17322019-12-28 14:01:46.063 T:2564035440 DEBUG: Previous line repeats 1 times.
17332019-12-28 14:01:46.063 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
17342019-12-28 14:01:46.097 T:2290951024 DEBUG: Previous line repeats 4 times.
17352019-12-28 14:01:46.097 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3209/3210 display:10000020 delay:0
17362019-12-28 14:01:46.193 T:2564035440 DEBUG: Previous line repeats 1 times.
17372019-12-28 14:01:46.193 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
17382019-12-28 14:01:46.197 T:2290951024 DEBUG: Previous line repeats 3 times.
17392019-12-28 14:01:46.197 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3209/3210 display:10000020 delay:0
17402019-12-28 14:01:46.265 T:2564035440 DEBUG: Previous line repeats 1 times.
17412019-12-28 14:01:46.266 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17422019-12-28 14:01:46.293 T:1973457776 DEBUG: CWebServer[8080]: request received for /jsonrpc?System.GetProperties
17432019-12-28 14:01:46.298 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3209/3210 display:10000020 delay:0
17442019-12-28 14:01:46.317 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17452019-12-28 14:01:46.348 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3209/3210 display:10000020 delay:0
17462019-12-28 14:01:46.368 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17472019-12-28 14:01:46.398 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3209/3210 display:10000020 delay:0
17482019-12-28 14:01:46.419 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17492019-12-28 14:01:46.448 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3209/3210 display:10000020 delay:0
17502019-12-28 14:01:46.471 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17512019-12-28 14:01:46.499 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3209/3210 display:10000020 delay:0
17522019-12-28 14:01:46.522 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17532019-12-28 14:01:46.549 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3209/3210 display:10000020 delay:0
17542019-12-28 14:01:46.573 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17552019-12-28 14:01:46.599 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3209/3210 display:10000020 delay:0
17562019-12-28 14:01:46.624 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17572019-12-28 14:01:46.649 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3209/3210 display:10000020 delay:0
17582019-12-28 14:01:46.676 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17592019-12-28 14:01:46.699 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3209/3210 display:10000020 delay:0
17602019-12-28 14:01:46.727 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17612019-12-28 14:01:46.750 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3209/3210 display:10000020 delay:0
17622019-12-28 14:01:46.778 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17632019-12-28 14:01:46.800 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3209/3210 display:10000020 delay:0
17642019-12-28 14:01:46.829 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17652019-12-28 14:01:46.850 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3209/3210 display:10000020 delay:0
17662019-12-28 14:01:46.881 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17672019-12-28 14:01:46.900 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3209/3210 display:10000020 delay:0
17682019-12-28 14:01:46.932 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17692019-12-28 14:01:46.996 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3211/3212 display:10000020 delay:0
17702019-12-28 14:01:47.048 T:2564035440 DEBUG: Previous line repeats 1 times.
17712019-12-28 14:01:47.048 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
17722019-12-28 14:01:47.097 T:2290951024 DEBUG: Previous line repeats 4 times.
17732019-12-28 14:01:47.097 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3211/3212 display:10000020 delay:0
17742019-12-28 14:01:47.177 T:2564035440 DEBUG: Previous line repeats 1 times.
17752019-12-28 14:01:47.177 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
17762019-12-28 14:01:47.198 T:2290951024 DEBUG: Previous line repeats 5 times.
17772019-12-28 14:01:47.198 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3211/3212 display:10000020 delay:0
17782019-12-28 14:01:47.281 T:2564035440 DEBUG: Previous line repeats 1 times.
17792019-12-28 14:01:47.281 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
17802019-12-28 14:01:47.298 T:2290951024 DEBUG: Previous line repeats 4 times.
17812019-12-28 14:01:47.298 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3211/3212 display:10000020 delay:0
17822019-12-28 14:01:47.408 T:2564035440 DEBUG: Previous line repeats 2 times.
17832019-12-28 14:01:47.408 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
17842019-12-28 14:01:47.449 T:2290951024 DEBUG: Previous line repeats 3 times.
17852019-12-28 14:01:47.449 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3211/3212 display:10000020 delay:0
17862019-12-28 14:01:47.477 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17872019-12-28 14:01:47.499 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3211/3212 display:10000020 delay:0
17882019-12-28 14:01:47.528 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17892019-12-28 14:01:47.549 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3211/3212 display:10000020 delay:0
17902019-12-28 14:01:47.580 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17912019-12-28 14:01:47.599 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3211/3212 display:10000020 delay:0
17922019-12-28 14:01:47.631 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17932019-12-28 14:01:47.650 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3211/3212 display:10000020 delay:0
17942019-12-28 14:01:47.682 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17952019-12-28 14:01:47.700 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3211/3212 display:10000020 delay:0
17962019-12-28 14:01:47.733 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17972019-12-28 14:01:47.750 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3211/3212 display:10000020 delay:0
17982019-12-28 14:01:47.784 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
17992019-12-28 14:01:47.800 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3211/3212 display:10000020 delay:0
18002019-12-28 14:01:47.836 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18012019-12-28 14:01:47.850 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3211/3212 display:10000020 delay:0
18022019-12-28 14:01:47.887 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18032019-12-28 14:01:47.901 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3211/3212 display:10000020 delay:0
18042019-12-28 14:01:47.938 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18052019-12-28 14:01:47.951 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3211/3212 display:10000020 delay:0
18062019-12-28 14:01:47.990 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18072019-12-28 14:01:48.001 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3211/3212 display:10000020 delay:0
18082019-12-28 14:01:48.041 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18092019-12-28 14:01:48.052 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3211/3212 display:10000020 delay:0
18102019-12-28 14:01:48.092 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18112019-12-28 14:01:48.102 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3211/3212 display:10000020 delay:0
18122019-12-28 14:01:48.144 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18132019-12-28 14:01:48.149 T:3011825680 DEBUG: CMMALRenderer::RenderUpdate - vsync 3211 (+1)
18142019-12-28 14:01:48.196 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3212/3213 display:10000020 delay:0
18152019-12-28 14:01:48.247 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3213/3214 display:10000020 delay:0
18162019-12-28 14:01:48.281 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
18172019-12-28 14:01:48.298 T:2290951024 DEBUG: Previous line repeats 4 times.
18182019-12-28 14:01:48.299 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3213/3214 display:10000020 delay:0
18192019-12-28 14:01:48.309 T:1973457776 DEBUG: CWebServer[8080]: request received for /jsonrpc?System.Shutdown
18202019-12-28 14:01:48.349 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3213/3214 display:10000020 delay:0
18212019-12-28 14:01:48.389 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
18222019-12-28 14:01:48.400 T:2290951024 DEBUG: Previous line repeats 5 times.
18232019-12-28 14:01:48.400 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3213/3214 display:10000020 delay:0
18242019-12-28 14:01:48.494 T:2564035440 DEBUG: Previous line repeats 1 times.
18252019-12-28 14:01:48.494 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
18262019-12-28 14:01:48.501 T:2290951024 DEBUG: Previous line repeats 4 times.
18272019-12-28 14:01:48.501 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3213/3214 display:10000020 delay:0
18282019-12-28 14:01:48.615 T:2564035440 DEBUG: Previous line repeats 2 times.
18292019-12-28 14:01:48.615 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
18302019-12-28 14:01:48.652 T:2290951024 DEBUG: Previous line repeats 3 times.
18312019-12-28 14:01:48.652 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3213/3214 display:10000020 delay:0
18322019-12-28 14:01:48.752 T:2564035440 DEBUG: Previous line repeats 1 times.
18332019-12-28 14:01:48.752 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
18342019-12-28 14:01:48.752 T:2290951024 DEBUG: Previous line repeats 4 times.
18352019-12-28 14:01:48.752 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3213/3214 display:10000020 delay:0
18362019-12-28 14:01:48.862 T:2564035440 DEBUG: Previous line repeats 2 times.
18372019-12-28 14:01:48.862 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
18382019-12-28 14:01:48.903 T:2290951024 DEBUG: Previous line repeats 5 times.
18392019-12-28 14:01:48.903 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3213/3214 display:10000020 delay:0
18402019-12-28 14:01:48.932 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18412019-12-28 14:01:48.953 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3213/3214 display:10000020 delay:0
18422019-12-28 14:01:48.983 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18432019-12-28 14:01:49.003 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3213/3214 display:10000020 delay:0
18442019-12-28 14:01:49.034 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18452019-12-28 14:01:49.054 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3213/3214 display:10000020 delay:0
18462019-12-28 14:01:49.086 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18472019-12-28 14:01:49.104 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3213/3214 display:10000020 delay:0
18482019-12-28 14:01:49.137 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18492019-12-28 14:01:49.154 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3213/3214 display:10000020 delay:0
18502019-12-28 14:01:49.188 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18512019-12-28 14:01:49.204 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3213/3214 display:10000020 delay:0
18522019-12-28 14:01:49.240 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18532019-12-28 14:01:49.255 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3213/3214 display:10000020 delay:0
18542019-12-28 14:01:49.291 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18552019-12-28 14:01:49.305 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3213/3214 display:10000020 delay:0
18562019-12-28 14:01:49.342 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18572019-12-28 14:01:49.355 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3213/3214 display:10000020 delay:0
18582019-12-28 14:01:49.394 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18592019-12-28 14:01:49.396 T:3011825680 INFO: Saving exitCode 64
18602019-12-28 14:01:49.443 T:3011825680 DEBUG: ------ Window Init (DialogBusy.xml) ------
18612019-12-28 14:01:49.445 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18622019-12-28 14:01:49.447 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
18632019-12-28 14:01:49.450 T:3011825680 DEBUG: CMMALRenderer::RenderUpdate - vsync 3214 (+1)
18642019-12-28 14:01:49.498 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
18652019-12-28 14:01:49.539 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
18662019-12-28 14:01:49.548 T:2290951024 DEBUG: Previous line repeats 4 times.
18672019-12-28 14:01:49.548 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
18682019-12-28 14:01:49.564 T:2531095408 ERROR: ffmpeg[96DD7370]: [matroska,webm] Read error
18692019-12-28 14:01:49.599 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
18702019-12-28 14:01:49.674 T:2564035440 DEBUG: Previous line repeats 1 times.
18712019-12-28 14:01:49.674 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
18722019-12-28 14:01:49.699 T:2290951024 DEBUG: Previous line repeats 3 times.
18732019-12-28 14:01:49.699 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
18742019-12-28 14:01:49.799 T:2564035440 DEBUG: Previous line repeats 1 times.
18752019-12-28 14:01:49.799 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
18762019-12-28 14:01:49.799 T:2290951024 DEBUG: Previous line repeats 4 times.
18772019-12-28 14:01:49.800 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
18782019-12-28 14:01:49.911 T:2564035440 DEBUG: Previous line repeats 2 times.
18792019-12-28 14:01:49.911 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
18802019-12-28 14:01:49.950 T:2290951024 DEBUG: Previous line repeats 5 times.
18812019-12-28 14:01:49.950 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
18822019-12-28 14:01:49.980 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18832019-12-28 14:01:50.000 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
18842019-12-28 14:01:50.032 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18852019-12-28 14:01:50.051 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
18862019-12-28 14:01:50.083 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18872019-12-28 14:01:50.101 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
18882019-12-28 14:01:50.134 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18892019-12-28 14:01:50.151 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
18902019-12-28 14:01:50.185 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18912019-12-28 14:01:50.201 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
18922019-12-28 14:01:50.236 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18932019-12-28 14:01:50.251 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
18942019-12-28 14:01:50.288 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18952019-12-28 14:01:50.301 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
18962019-12-28 14:01:50.340 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18972019-12-28 14:01:50.352 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
18982019-12-28 14:01:50.391 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
18992019-12-28 14:01:50.402 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
19002019-12-28 14:01:50.442 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
19012019-12-28 14:01:50.452 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
19022019-12-28 14:01:50.493 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
19032019-12-28 14:01:50.502 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
19042019-12-28 14:01:50.544 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
19052019-12-28 14:01:50.552 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3215/3216 display:10000020 delay:0
19062019-12-28 14:01:50.596 T:2564035440 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
19072019-12-28 14:01:50.597 T:3011825680 NOTICE: Quitting due to POSIX signal
19082019-12-28 14:01:50.647 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3216/3217 display:10000020 delay:0
19092019-12-28 14:01:50.680 T:2564035440 DEBUG: ffmpeg[98D41370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
19102019-12-28 14:01:50.697 T:2290951024 DEBUG: Previous line repeats 4 times.
19112019-12-28 14:01:50.697 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3216/3217 display:10000020 delay:0
19122019-12-28 14:01:50.698 T:3011825680 NOTICE: Stopping player
19132019-12-28 14:01:50.699 T:3011825680 NOTICE: CVideoPlayer::CloseFile()
19142019-12-28 14:01:50.699 T:3011825680 DEBUG: DeleteRenderer - deleting renderer
19152019-12-28 14:01:50.699 T:3011825680 DEBUG: CMMALRenderer::~CMMALRenderer
19162019-12-28 14:01:50.699 T:3011825680 DEBUG: CMMALRenderer::UnInitMMAL
19172019-12-28 14:01:50.749 T:2290951024 DEBUG: CRBP::WaitVsync no vsync 3217/3218 display:10000020 delay:0
19182019-12-28 14:01:50.749 T:2290951024 DEBUG: CMMALRenderer::Process - stopping
19192019-12-28 14:01:50.749 T:2290951024 DEBUG: Thread MMALRenderer 2290951024 terminating
19202019-12-28 14:01:50.777 T:2531095408 NOTICE: CVideoPlayer::OnExit()
19212019-12-28 14:01:50.777 T:2531095408 NOTICE: Closing stream player 2
19222019-12-28 14:01:50.778 T:2531095408 NOTICE: waiting for video thread to exit
19232019-12-28 14:01:51.214 T:1973457776 DEBUG: CWebServer[8080]: request received for /jsonrpc?JSONRPC.Ping
19242019-12-28 14:01:51.229 T:1973457776 DEBUG: CWebServer[8080]: request received for /jsonrpc?Application.GetProperties
19252019-12-28 14:01:51.238 T:1973457776 DEBUG: CWebServer[8080]: request received for /jsonrpc?Player.GetActivePlayers
19262019-12-28 14:01:51.248 T:1973457776 DEBUG: CWebServer[8080]: request received for /jsonrpc?Base
19272019-12-28 14:01:51.903 T:2299343728 DEBUG: CMMALRenderer::Run - stopping
19282019-12-28 14:01:51.903 T:2299343728 DEBUG: Thread MMALProcess 2299343728 terminating
19292019-12-28 14:01:51.903 T:3011825680 NOTICE: VideoPlayer: waiting for threads to exit
19302019-12-28 14:01:51.903 T:2564035440 NOTICE: thread end: video_thread
19312019-12-28 14:01:51.904 T:2564035440 DEBUG: Thread VideoPlayerVideo 2564035440 terminating
19322019-12-28 14:01:51.914 T:2531095408 NOTICE: deleting video codec
19332019-12-28 14:01:51.935 T:2531095408 DEBUG: CMMALPool::~CMMALPool Destroying pool 0xb1a571e0 for port vc.ril.video_decode:out:0(I420)
19342019-12-28 14:01:51.987 T:2876646256 INFO: Deleting settings information for files /media/Elements/Movies/jellyfish-400-mbps-4k-uhd-hevc-10bit.mkv
19352019-12-28 14:01:51.988 T:2859860848 DEBUG: DoWork - Saving file state for video item /media/Elements/Movies/jellyfish-400-mbps-4k-uhd-hevc-10bit.mkv
19362019-12-28 14:01:52.051 T:2663220080 DEBUG: OnPlayBackStopped: CApplication::OnPlayBackStopped
19372019-12-28 14:01:52.051 T:2531095408 DEBUG: Thread VideoPlayer 2531095408 terminating
19382019-12-28 14:01:52.051 T:3011825680 NOTICE: VideoPlayer: finished waiting
19392019-12-28 14:01:52.051 T:3011825680 NOTICE: CVideoPlayer::CloseFile()
19402019-12-28 14:01:52.051 T:3011825680 NOTICE: VideoPlayer: waiting for threads to exit
19412019-12-28 14:01:52.051 T:3011825680 NOTICE: VideoPlayer: finished waiting
19422019-12-28 14:01:52.087 T:3011825680 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData
19432019-12-28 14:01:52.087 T:3011825680 DEBUG: CMMALPool::~CMMALPool Destroying pool 0xafcab780 for port vc.ril.video_decode:out:0(I420)
19442019-12-28 14:01:52.088 T:3011825680 NOTICE: Storing total System Uptime
19452019-12-28 14:01:52.088 T:3011825680 NOTICE: Saving settings
19462019-12-28 14:01:52.095 T:3011825680 NOTICE: Saving skin settings
19472019-12-28 14:01:52.097 T:3011825680 NOTICE: Stopping all
19482019-12-28 14:01:52.097 T:2868253552 DEBUG: Thread JobWorker 2868253552 terminating (autodelete)
19492019-12-28 14:01:52.097 T:3011825680 DEBUG: NetworkMessage - Signaling network services to stop
19502019-12-28 14:01:52.097 T:3011825680 NOTICE: ES: Stopping event server
19512019-12-28 14:01:52.097 T:2876646256 DEBUG: Thread JobWorker 2876646256 terminating (autodelete)
19522019-12-28 14:01:52.097 T:2663220080 DEBUG: Thread JobWorker 2663220080 terminating (autodelete)
19532019-12-28 14:01:52.098 T:2859860848 DEBUG: Thread JobWorker 2859860848 terminating (autodelete)
19542019-12-28 14:01:52.126 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: loading setting definitions
19552019-12-28 14:01:52.126 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: trying to load setting definitions from old format...
19562019-12-28 14:01:52.127 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: loading setting values
19572019-12-28 14:01:52.129 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: loading setting definitions
19582019-12-28 14:01:52.129 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: trying to load setting definitions from old format...
19592019-12-28 14:01:52.131 T:2789254000 DEBUG: CAddonSettings[plugin.video.vrt.nu]: loading setting values
19602019-12-28 14:01:52.226 T:3011825680 DEBUG: CZeroconfAvahi::doRemoveService named: servers.airtunes
19612019-12-28 14:01:52.227 T:3011825680 DEBUG: NetworkMessage - Waiting for network services to stop
19622019-12-28 14:01:52.227 T:3011825680 NOTICE: stopping zeroconf publishing
19632019-12-28 14:01:52.230 T:3011825680 NOTICE: CWebServer[8080]: Stopped
19642019-12-28 14:01:52.262 T:2612487024 DEBUG: Thread CECAdapterUpdate 2612487024 terminating
19652019-12-28 14:01:52.262 T:2631435120 DEBUG: Process - sending standby commands
19662019-12-28 14:01:52.508 T:2631435120 DEBUG: Process - CEC adapter processor thread ended
19672019-12-28 14:01:52.508 T:2631435120 DEBUG: Thread CECAdapter 2631435120 terminating
19682019-12-28 14:01:52.846 T:2696934256 NOTICE: ES: UDP Event server stopped
19692019-12-28 14:01:52.847 T:2696934256 DEBUG: Thread EventServer 2696934256 terminating
19702019-12-28 14:01:52.847 T:3011825680 NOTICE: stop dvd detect media
19712019-12-28 14:01:52.847 T:3011825680 DEBUG: CServiceAddonManager: stopping plugin.video.retrospect.
19722019-12-28 14:01:52.847 T:3011825680 INFO: CServiceAddonManager: failed to stop plugin.video.retrospect (may have ended)
19732019-12-28 14:01:52.847 T:3011825680 DEBUG: CServiceAddonManager: stopping plugin.video.vrt.nu.
19742019-12-28 14:01:52.847 T:3011825680 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.vrt.nu/resources/lib/addon_service.py): trigger Monitor abort request
19752019-12-28 14:01:52.848 T:2789254000 INFO: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.vrt.nu/resources/lib/addon_service.py): script successfully run
19762019-12-28 14:01:52.848 T:2789254000 DEBUG: onExecutionDone(1, /storage/.kodi/addons/plugin.video.vrt.nu/resources/lib/addon_service.py)
19772019-12-28 14:01:52.866 T:2789254000 INFO: Python interpreter interrupted by user
19782019-12-28 14:01:52.867 T:3011825680 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.vrt.nu/resources/lib/addon_service.py): script termination took 19ms
19792019-12-28 14:01:52.867 T:3011825680 DEBUG: CServiceAddonManager: stopping plugin.video.vtm.go.
19802019-12-28 14:01:52.867 T:3011825680 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.vtm.go/service.py): trigger Monitor abort request
19812019-12-28 14:01:52.868 T:2764075888 INFO: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.vtm.go/service.py): script successfully run
19822019-12-28 14:01:52.868 T:2764075888 DEBUG: onExecutionDone(4, /storage/.kodi/addons/plugin.video.vtm.go/service.py)
19832019-12-28 14:01:52.896 T:2764075888 INFO: Python interpreter interrupted by user
19842019-12-28 14:01:52.896 T:3011825680 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.vtm.go/service.py): script termination took 30ms
19852019-12-28 14:01:52.896 T:3011825680 DEBUG: CServiceAddonManager: stopping plugin.video.youtube.
19862019-12-28 14:01:52.897 T:2789254000 DEBUG: Thread LanguageInvoker 2789254000 terminating
19872019-12-28 14:01:52.897 T:2764075888 DEBUG: Thread LanguageInvoker 2764075888 terminating
19882019-12-28 14:01:52.897 T:3011825680 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.youtube/resources/lib/startup.py): trigger Monitor abort request
19892019-12-28 14:01:52.898 T:2772468592 DEBUG: [plugin.video.youtube] PlaybackMonitor active threads: ||
19902019-12-28 14:01:52.899 T:2772468592 INFO: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.youtube/resources/lib/startup.py): script successfully run
19912019-12-28 14:01:52.900 T:2772468592 DEBUG: onExecutionDone(3, /storage/.kodi/addons/plugin.video.youtube/resources/lib/startup.py)
19922019-12-28 14:01:52.936 T:2772468592 INFO: Python interpreter interrupted by user
19932019-12-28 14:01:52.936 T:3011825680 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.youtube/resources/lib/startup.py): script termination took 39ms
19942019-12-28 14:01:52.936 T:3011825680 DEBUG: CServiceAddonManager: stopping script.tvguide.fullscreen.
19952019-12-28 14:01:52.936 T:2772468592 DEBUG: Thread LanguageInvoker 2772468592 terminating
19962019-12-28 14:01:52.936 T:3011825680 INFO: CServiceAddonManager: failed to stop script.tvguide.fullscreen (may have ended)
19972019-12-28 14:01:52.937 T:3011825680 DEBUG: CServiceAddonManager: stopping service.libreelec.settings.
19982019-12-28 14:01:52.937 T:3011825680 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): trigger Monitor abort request
19992019-12-28 14:01:52.938 T:2755683184 INFO: ## LibreELEC Addon ## xdbus Monitor stopped. ##
20002019-12-28 14:01:52.953 T:2797646704 DEBUG: ## LibreELEC Addon ## STOP SERVICE DONE !
20012019-12-28 14:01:52.954 T:2797646704 INFO: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): script successfully run
20022019-12-28 14:01:52.954 T:2797646704 INFO: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): waiting on thread 18446744072195445616
20032019-12-28 14:01:52.955 T:2780861296 INFO: ## LibreELEC Addon ## _service_::run ## MESSAGE:'exit'
20042019-12-28 14:01:52.999 T:2747290480 INFO: ## LibreELEC Addon ## updates::updateThread ## Stopped
20052019-12-28 14:01:53.054 T:2797646704 DEBUG: onExecutionDone(0, /usr/share/kodi/addons/service.libreelec.settings/service.py)
20062019-12-28 14:01:53.076 T:2797646704 INFO: Python interpreter interrupted by user
20072019-12-28 14:01:53.077 T:3011825680 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): script termination took 140ms
20082019-12-28 14:01:53.077 T:3011825680 DEBUG: CServiceAddonManager: stopping service.thoradia.
20092019-12-28 14:01:53.077 T:2797646704 DEBUG: Thread LanguageInvoker 2797646704 terminating
20102019-12-28 14:01:53.077 T:3011825680 INFO: CServiceAddonManager: failed to stop service.thoradia (may have ended)
20112019-12-28 14:01:53.077 T:3011825680 DEBUG: CServiceAddonManager: stopping service.webgrabplus.
20122019-12-28 14:01:53.077 T:3011825680 DEBUG: CPythonInvoker(8, /storage/.kodi/addons/service.webgrabplus/default.py): trigger Monitor abort request
20132019-12-28 14:01:53.077 T:2730505072 INFO: CPythonInvoker(8, /storage/.kodi/addons/service.webgrabplus/default.py): script successfully run
20142019-12-28 14:01:53.077 T:2730505072 DEBUG: onExecutionDone(8, /storage/.kodi/addons/service.webgrabplus/default.py)
20152019-12-28 14:01:53.083 T:2730505072 INFO: Python interpreter interrupted by user
20162019-12-28 14:01:53.083 T:3011825680 DEBUG: CPythonInvoker(8, /storage/.kodi/addons/service.webgrabplus/default.py): script termination took 5ms
20172019-12-28 14:01:53.083 T:3011825680 DEBUG: CServiceAddonManager: stopping tools.mono.
20182019-12-28 14:01:53.083 T:2730505072 DEBUG: Thread LanguageInvoker 2730505072 terminating
20192019-12-28 14:01:53.083 T:3011825680 DEBUG: CPythonInvoker(7, /storage/.kodi/addons/tools.mono/default.py): trigger Monitor abort request
20202019-12-28 14:01:53.084 T:2738897776 INFO: CPythonInvoker(7, /storage/.kodi/addons/tools.mono/default.py): script successfully run
20212019-12-28 14:01:53.084 T:2738897776 DEBUG: onExecutionDone(7, /storage/.kodi/addons/tools.mono/default.py)
20222019-12-28 14:01:53.089 T:2738897776 INFO: Python interpreter interrupted by user
20232019-12-28 14:01:53.089 T:3011825680 DEBUG: CPythonInvoker(7, /storage/.kodi/addons/tools.mono/default.py): script termination took 6ms
20242019-12-28 14:01:53.090 T:2738897776 DEBUG: Thread LanguageInvoker 2738897776 terminating
20252019-12-28 14:01:53.090 T:2989871984 DEBUG: Thread ActiveAE 2989871984 terminating
20262019-12-28 14:01:53.101 T:2980049776 DEBUG: Thread AESink 2980049776 terminating
20272019-12-28 14:01:53.200 T:3011825680 DEBUG: CAESinkPi:Drain delay:99ms now:0ms
20282019-12-28 14:01:53.201 T:3011825680 DEBUG: CAESinkPi:Deinitialize
20292019-12-28 14:01:53.201 T:3011825680 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000
20302019-12-28 14:01:53.211 T:3011825680 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0xb100d308
20312019-12-28 14:01:53.212 T:3011825680 NOTICE: Application stopped
20322019-12-28 14:01:53.412 T:3011825680 NOTICE: XBApplicationEx: destroying...
20332019-12-28 14:01:53.413 T:2815587184 DEBUG: Thread PeripEventScanner 2815587184 terminating
20342019-12-28 14:01:53.499 T:2840765296 DEBUG: Thread PeripBusUSBUdev 2840765296 terminating
20352019-12-28 14:01:53.510 T:2823979888 DEBUG: Thread PeripBusAddon 2823979888 terminating
20362019-12-28 14:01:53.711 T:3011825680 INFO: AddOnLog: Joystick Support: Disabling joystick interface "linux"
20372019-12-28 14:01:53.711 T:3011825680 DEBUG: SECTION:UnloadDll(/usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.4.8)
20382019-12-28 14:01:53.712 T:3011825680 INFO: ADDON: Dll Destroyed - Joystick Support
20392019-12-28 14:01:53.712 T:3011825680 NOTICE: unload skin
20402019-12-28 14:01:53.712 T:3011825680 INFO: Unloading old skin ...
20412019-12-28 14:01:53.716 T:3011825680 DEBUG: ------ Window Deinit () ------
20422019-12-28 14:01:53.719 T:3011825680 DEBUG: FreeVisualisation() done
20432019-12-28 14:01:53.740 T:3011825680 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
20442019-12-28 14:01:53.740 T:3011825680 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------
20452019-12-28 14:01:53.740 T:3011825680 DEBUG: FreeVisualisation() done
20462019-12-28 14:01:53.754 T:3011825680 DEBUG: CloseBundle - Closed bundle
20472019-12-28 14:01:53.792 T:3011825680 DEBUG: CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 60
20482019-12-28 14:01:53.792 T:3011825680 DEBUG: CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 68
20492019-12-28 14:01:54.993 T:3011825680 DEBUG: CWinSystemGbmEGLContext::DestroyWindow - deinitialized GBM
20502019-12-28 14:01:54.997 T:3011825680 NOTICE: unload sections
20512019-12-28 14:01:55.003 T:3011825680 DEBUG: LogindUPowerSyscall - delay lock sleep released
20522019-12-28 14:01:55.005 T:2806039408 DEBUG: Thread Timer 2806039408 terminating
20532019-12-28 14:01:55.009 T:3011825680 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x1e32a40 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
20542019-12-28 14:01:55.009 T:3011825680 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x1d24a98 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
20552019-12-28 14:01:55.009 T:3011825680 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x1e39c60 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
20562019-12-28 14:01:55.009 T:3011825680 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x1d71020 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
20572019-12-28 14:01:55.009 T:3011825680 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x1e4c128 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
20582019-12-28 14:01:55.009 T:3011825680 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x1e418a8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
20592019-12-28 14:01:55.009 T:3011825680 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x1e4e0f0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
20602019-12-28 14:01:55.009 T:3011825680 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x1e4af30 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
20612019-12-28 14:01:55.014 T:3011825680 DEBUG: object 0 --> 0 instances
20622019-12-28 14:01:55.014 T:3011825680 DEBUG: object 1 --> 0 instances
20632019-12-28 14:01:55.014 T:3011825680 DEBUG: object 2 --> 0 instances
20642019-12-28 14:01:55.014 T:3011825680 DEBUG: object 3 --> 0 instances
20652019-12-28 14:01:55.014 T:3011825680 DEBUG: object 4 --> 0 instances
20662019-12-28 14:01:55.014 T:3011825680 DEBUG: object 5 --> 0 instances
20672019-12-28 14:01:55.014 T:3011825680 DEBUG: object 6 --> 0 instances
20682019-12-28 14:01:55.015 T:3011825680 DEBUG: object 7 --> 0 instances
20692019-12-28 14:01:55.015 T:3011825680 DEBUG: object 8 --> 0 instances
20702019-12-28 14:01:55.015 T:3011825680 DEBUG: object 9 --> 0 instances
20712019-12-28 14:01:55.112 T:3011825680 DEBUG: CWinSystemGbm::DestroyWindowSystem - deinitialized DRM
20722019-12-28 14:01:55.274 T:3002069872 DEBUG: Thread libinput 3002069872 terminating
20732019-12-28 14:01:55.401 T:2934961008 DEBUG: Thread Lirc 2934961008 terminating