2019-04-11 16:28:39.854 T:3011529184  NOTICE: -----------------------------------------------------------------------
2019-04-11 16:28:39.854 T:3011529184  NOTICE: Starting Kodi (18.9 (18.9.0) Git:leia_pi4_18.9-Leia). Platform: Linux ARM 32-bit
2019-04-11 16:28:39.854 T:3011529184  NOTICE: Using Release Kodi x32 build
2019-04-11 16:28:39.854 T:3011529184  NOTICE: Kodi compiled 2020-10-24 by GCC 8.3.0 for Linux ARM 32-bit version 4.19.127 (267135)
2019-04-11 16:28:39.854 T:3011529184  NOTICE: Running on LibreELEC (official): 9.2.6, kernel: Linux ARM 32-bit version 4.19.127
2019-04-11 16:28:39.854 T:3011529184  NOTICE: FFmpeg version/source: 4.0.4-Kodi
2019-04-11 16:28:39.854 T:3011529184  NOTICE: Host CPU: ARMv7 Processor rev 3 (v7l), 4 cores available
2019-04-11 16:28:39.854 T:3011529184  NOTICE: ARM Features: Neon enabled
2019-04-11 16:28:39.854 T:3011529184  NOTICE: special://xbmc/ is mapped to: /usr/share/kodi/
2019-04-11 16:28:39.854 T:3011529184  NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi
2019-04-11 16:28:39.854 T:3011529184  NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons
2019-04-11 16:28:39.854 T:3011529184  NOTICE: special://masterprofile/ is mapped to: /storage/.kodi/userdata
2019-04-11 16:28:39.854 T:3011529184  NOTICE: special://envhome/ is mapped to: /storage
2019-04-11 16:28:39.854 T:3011529184  NOTICE: special://home/ is mapped to: /storage/.kodi
2019-04-11 16:28:39.854 T:3011529184  NOTICE: special://temp/ is mapped to: /storage/.kodi/temp
2019-04-11 16:28:39.854 T:3011529184  NOTICE: special://logpath/ is mapped to: /storage/.kodi/temp
2019-04-11 16:28:39.854 T:3011529184  NOTICE: The executable running is: /usr/lib/kodi/kodi.bin
2019-04-11 16:28:39.854 T:3011529184  NOTICE: Local hostname: LibreELEC
2019-04-11 16:28:39.854 T:3011529184  NOTICE: Log File is located: /storage/.kodi/temp/kodi.log
2019-04-11 16:28:39.854 T:3011529184  NOTICE: -----------------------------------------------------------------------
2019-04-11 16:28:39.865 T:3011529184    INFO: loading settings
2019-04-11 16:28:39.867 T:3011529184  NOTICE: special://profile/ is mapped to: special://masterprofile/
2019-04-11 16:28:39.892 T:3011529184   DEBUG: CSkinSettings: no <skinsettings> tag found
2019-04-11 16:28:39.892 T:3011529184  NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml
2019-04-11 16:28:39.892 T:3011529184  NOTICE: Contents of special://xbmc/system/advancedsettings.xml are...
                                            <?xml version="1.0" encoding="utf-8" ?>
                                            <advancedsettings>
                                              <cputempcommand>/usr/bin/cputemp</cputempcommand>
                                              <gputempcommand>/usr/bin/gputemp</gputempcommand>
                                              <showexitbutton>false</showexitbutton>
                                              <remotedelay>1</remotedelay>
                                              <samba>
                                                <clienttimeout>30</clienttimeout>
                                              </samba>
                                              <fanartres>720</fanartres>
                                              <imageres>540</imageres>
                                            </advancedsettings>
2019-04-11 16:28:39.892 T:3011529184 WARNING: CSettingsManager: missing version attribute
2019-04-11 16:28:39.893 T:3011529184  NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml)
2019-04-11 16:28:39.893 T:3011529184  NOTICE: Default Video Player: VideoPlayer
2019-04-11 16:28:39.893 T:3011529184  NOTICE: Default Audio Player: paplayer
2019-04-11 16:28:39.894 T:3011529184  NOTICE: Enabled debug logging due to GUI setting (2)
2019-04-11 16:28:39.894 T:3011529184  NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM"
2019-04-11 16:28:39.894 T:3011529184  NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml
2019-04-11 16:28:39.895 T:3011529184   DEBUG: CMediaSourceSettings: <programs> tag is missing or sources.xml is malformed
2019-04-11 16:28:39.895 T:3011529184   DEBUG: CMediaSourceSettings: <files> tag is missing or sources.xml is malformed
2019-04-11 16:28:39.895 T:3011529184   DEBUG: CMediaSourceSettings: <games> tag is missing or sources.xml is malformed
2019-04-11 16:28:39.903 T:3011529184    INFO: creating subdirectories
2019-04-11 16:28:39.903 T:3011529184    INFO: userdata folder: special://masterprofile/
2019-04-11 16:28:39.903 T:3011529184    INFO: recording folder:
2019-04-11 16:28:39.903 T:3011529184    INFO: screenshots folder: /storage/screenshots/
2019-04-11 16:28:40.038 T:3011529184  NOTICE: PulseAudio: Server found running - will try to use Pulse
2019-04-11 16:28:40.039 T:2934961008   DEBUG: Thread Lirc start, auto delete: false
2019-04-11 16:28:40.039 T:2934961008    INFO: Loading special://xbmc/system/Lircmap.xml
2019-04-11 16:28:40.039 T:3002069872   DEBUG: Thread libinput start, auto delete: false
2019-04-11 16:28:40.044 T:2934961008    INFO: * Adding remote mapping for device 'mceusb'
2019-04-11 16:28:40.045 T:2934961008    INFO: * Adding remote mapping for device 'XboxDVDDongle'
2019-04-11 16:28:40.045 T:2934961008    INFO: * Adding remote mapping for device 'Microsoft_Xbox'
2019-04-11 16:28:40.045 T:2934961008    INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote'
2019-04-11 16:28:40.045 T:2934961008    INFO: * Adding remote mapping for device 'anysee'
2019-04-11 16:28:40.045 T:2934961008    INFO: * Adding remote mapping for device 'iMON-PAD'
2019-04-11 16:28:40.045 T:2934961008    INFO: * Adding remote mapping for device 'Antec_Veris_RM200'
2019-04-11 16:28:40.045 T:2934961008    INFO: * Adding remote mapping for device 'MCE_via_iMON'
2019-04-11 16:28:40.045 T:2934961008    INFO: * Adding remote mapping for device 'TwinHanRemote'
2019-04-11 16:28:40.045 T:2934961008    INFO: * Adding remote mapping for device 'linux-input-layer'
2019-04-11 16:28:40.045 T:2934961008    INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote'
2019-04-11 16:28:40.045 T:2934961008    INFO: * Adding remote mapping for device 'mediacenter'
2019-04-11 16:28:40.045 T:2934961008    INFO: * Adding remote mapping for device 'devinput'
2019-04-11 16:28:40.045 T:2934961008    INFO: * Adding remote mapping for device 'devinput-32'
2019-04-11 16:28:40.046 T:2934961008    INFO: * Adding remote mapping for device 'devinput-64'
2019-04-11 16:28:40.046 T:2934961008   DEBUG: CIRTranslator::Load - no userdata Lircmap.xml found, skipping
2019-04-11 16:28:40.099 T:3011529184  NOTICE: Running database version Addons27
2019-04-11 16:28:40.240 T:3002069872   DEBUG: CLibInputHandler::DeviceAdded - keyboard type device added: Microsoft Microsoft® 2.4GHz Transceiver v7.0 (event0)
2019-04-11 16:28:40.240 T:3002069872   DEBUG: CLibInputKeyboard::GetRepeat - delay: 500ms repeat: 33ms for Microsoft Microsoft® 2.4GHz Transceiver v7.0 (event0)
2019-04-11 16:28:40.263 T:3002069872   DEBUG: CLibInputHandler::DeviceAdded - pointer type device added: Microsoft Microsoft® 2.4GHz Transceiver v7.0 Mouse (event1)
2019-04-11 16:28:40.263 T:3002069872   DEBUG: CLibInputHandler::DeviceAdded - pointer type device added: Microsoft Microsoft® 2.4GHz Transceiver v7.0 Consumer Control (event2)
2019-04-11 16:28:40.263 T:3002069872   DEBUG: CLibInputHandler::DeviceAdded - keyboard type device added: Microsoft Microsoft® 2.4GHz Transceiver v7.0 Consumer Control (event2)
2019-04-11 16:28:40.263 T:3002069872   DEBUG: CLibInputKeyboard::GetRepeat - could not get key repeat for event2 (Function not implemented)
2019-04-11 16:28:40.263 T:3002069872   DEBUG: CLibInputKeyboard::GetRepeat - delay: 400ms repeat: 80ms for Microsoft Microsoft® 2.4GHz Transceiver v7.0 Consumer Control (event2)
2019-04-11 16:28:40.279 T:3011529184    INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/kodi/addons: No such file or directory'
2019-04-11 16:28:40.279 T:3011529184   DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.'
2019-04-11 16:28:40.279 T:3011529184  NOTICE: ADDON: audioencoder.kodi.builtin.aac v1.0.0 installed
2019-04-11 16:28:40.279 T:3011529184  NOTICE: ADDON: audioencoder.kodi.builtin.wma v1.0.0 installed
2019-04-11 16:28:40.279 T:3011529184  NOTICE: ADDON: driver.dvb.crazycat v9.2.0.0 installed
2019-04-11 16:28:40.279 T:3011529184  NOTICE: ADDON: driver.dvb.dvb-latest v9.2.0.0 installed
2019-04-11 16:28:40.279 T:3011529184  NOTICE: ADDON: game.controller.default v1.0.8 installed
2019-04-11 16:28:40.279 T:3011529184  NOTICE: ADDON: game.controller.snes v1.0.8 installed
2019-04-11 16:28:40.279 T:3011529184  NOTICE: ADDON: kodi.binary.global.audioengine v1.0.1 installed
2019-04-11 16:28:40.279 T:3011529184  NOTICE: ADDON: kodi.binary.global.filesystem v1.0.2 installed
2019-04-11 16:28:40.279 T:3011529184  NOTICE: ADDON: kodi.binary.global.general v1.0.3 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: kodi.binary.global.gui v5.12.0 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: kodi.binary.global.main v1.0.14 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: kodi.binary.global.network v1.0.0 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: kodi.binary.instance.audiodecoder v2.0.0 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: kodi.binary.instance.audioencoder v2.0.0 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: kodi.binary.instance.game v1.1.0 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: kodi.binary.instance.imagedecoder v2.0.0 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: kodi.binary.instance.inputstream v2.0.8 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: kodi.binary.instance.peripheral v1.3.7 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: kodi.binary.instance.pvr v5.10.3 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: kodi.binary.instance.screensaver v2.0.0 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: kodi.binary.instance.vfs v2.0.0 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: kodi.binary.instance.videocodec v1.0.1 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: kodi.binary.instance.visualization v2.0.1 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: kodi.resource v1.0.0 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: metadata.album.universal v3.1.4 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: metadata.artists.universal v4.3.3 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: metadata.common.allmusic.com v3.2.2 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: metadata.common.fanart.tv v3.6.3 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: metadata.common.imdb.com v3.1.6 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: metadata.common.musicbrainz.org v2.2.4 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: metadata.common.theaudiodb.com v2.0.3 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: metadata.common.themoviedb.org v3.2.14 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: metadata.local v1.0.0 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: metadata.themoviedb.org v5.2.6 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: metadata.tvshows.themoviedb.org v3.5.13 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: os.libreelec.tv v9.2 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: os.openelec.tv v9.2 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: peripheral.joystick v1.4.9 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: plugin.video.ipcams v0.0.4 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: repository.kodi.game v1.0.0 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: repository.kodinerds v7.0.1.1 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: repository.libreelec.tv v9.2.0 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: repository.xbmc.org v3.1.6 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: resource.images.weathericons.default v1.1.8 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: resource.language.de_de v9.0.21 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: resource.language.en_gb v2.0.1 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: resource.uisounds.kodi v1.0.0 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: screensaver.xbmc.builtin.black v1.0.33 installed
2019-04-11 16:28:40.280 T:3011529184  NOTICE: ADDON: screensaver.xbmc.builtin.dim v1.0.59 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: script.kodi.loguploader v0.6.0 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: script.logviewer v2.1.3+gotham.1 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: script.module.certifi v2019.9.11 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: script.module.chardet v3.0.4 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: script.module.idna v2.8 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: script.module.pil v1.1.7 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: script.module.pycryptodome v3.4.3 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: script.module.pyqrcode v0.0.2 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: script.module.requests v2.22.0 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: script.module.urllib3 v1.25.6 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: script.program.driverselect v0.1.6 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: service.libreelec.settings v9.0.0 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: skin.estuary v2.0.27 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: webinterface.default v18.x-2.4.6 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: xbmc.addon v18.9 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: xbmc.core v0.1.0 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: xbmc.gui v5.14.0 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: xbmc.json v10.3.0 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: xbmc.metadata v2.1.0 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: xbmc.python v2.26.0 installed
2019-04-11 16:28:40.281 T:3011529184  NOTICE: ADDON: xbmc.webinterface v1.0.0 installed
2019-04-11 16:28:40.283 T:3002069872   DEBUG: CLibInputHandler::DeviceAdded - pointer type device added: Microsoft Microsoft® 2.4GHz Transceiver v7.0 Consumer Control (event3)
2019-04-11 16:28:40.283 T:3002069872   DEBUG: CLibInputHandler::DeviceAdded - keyboard type device added: Microsoft Microsoft® 2.4GHz Transceiver v7.0 Consumer Control (event3)
2019-04-11 16:28:40.283 T:3002069872   DEBUG: CLibInputKeyboard::GetRepeat - delay: 500ms repeat: 33ms for Microsoft Microsoft® 2.4GHz Transceiver v7.0 Consumer Control (event3)
2019-04-11 16:28:40.303 T:3002069872   DEBUG: CLibInputHandler::DeviceAdded - keyboard type device added: Microsoft Microsoft® 2.4GHz Transceiver v7.0 System Control (event4)
2019-04-11 16:28:40.303 T:3002069872   DEBUG: CLibInputKeyboard::GetRepeat - could not get key repeat for event4 (Function not implemented)
2019-04-11 16:28:40.303 T:3002069872   DEBUG: CLibInputKeyboard::GetRepeat - delay: 400ms repeat: 80ms for Microsoft Microsoft® 2.4GHz Transceiver v7.0 System Control (event4)
2019-04-11 16:28:40.312 T:3011529184   DEBUG: CFavourites::Load - no system favourites found, skipping
2019-04-11 16:28:40.312 T:3011529184   DEBUG: CFavourites::Load - no userdata favourites found, skipping
2019-04-11 16:28:40.314 T:3011529184   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
2019-04-11 16:28:40.314 T:3011529184    INFO: Selected Logind/UPower as PowerSyscall
2019-04-11 16:28:40.314 T:3011529184   ERROR: DBus error: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files
2019-04-11 16:28:40.314 T:3011529184    INFO: LogindUPowerSyscall - UPower not found, battery information will not be available
2019-04-11 16:28:40.322 T:3011529184   DEBUG: LogindUPowerSyscall - inhibit lock taken, fd 26
2019-04-11 16:28:40.323 T:3002069872   DEBUG: CLibInputHandler::DeviceAdded - keyboard type device added: NOVATEK USB Keyboard (event5)
2019-04-11 16:28:40.323 T:3002069872   DEBUG: CLibInputKeyboard::GetRepeat - delay: 500ms repeat: 33ms for NOVATEK USB Keyboard (event5)
2019-04-11 16:28:40.324 T:3011529184   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
2019-04-11 16:28:40.324 T:2989278064   DEBUG: Thread ActiveAE start, auto delete: false
2019-04-11 16:28:40.324 T:2979001200   DEBUG: Thread AESink start, auto delete: false
2019-04-11 16:28:40.325 T:2968515440   DEBUG: Thread FDEventMonitor start, auto delete: false
2019-04-11 16:28:40.336 T:2989278064    INFO: CAESinkALSA - Unable to open device "default" for playback
2019-04-11 16:28:40.343 T:3002069872   DEBUG: CLibInputHandler::DeviceAdded - keyboard type device added: NOVATEK USB Keyboard System Control (event6)
2019-04-11 16:28:40.343 T:3002069872   DEBUG: CLibInputKeyboard::GetRepeat - could not get key repeat for event6 (Function not implemented)
2019-04-11 16:28:40.343 T:3002069872   DEBUG: CLibInputKeyboard::GetRepeat - delay: 400ms repeat: 80ms for NOVATEK USB Keyboard System Control (event6)
2019-04-11 16:28:40.363 T:3002069872   DEBUG: CLibInputHandler::DeviceAdded - keyboard type device added: NOVATEK USB Keyboard Consumer Control (event7)
2019-04-11 16:28:40.363 T:3002069872   DEBUG: CLibInputKeyboard::GetRepeat - could not get key repeat for event7 (Function not implemented)
2019-04-11 16:28:40.363 T:3002069872   DEBUG: CLibInputKeyboard::GetRepeat - delay: 400ms repeat: 80ms for NOVATEK USB Keyboard Consumer Control (event7)
2019-04-11 16:28:40.364 T:2989278064   DEBUG: PulseAudio: Context authorizing
2019-04-11 16:28:40.365 T:2989278064   DEBUG: PulseAudio: Context setting name
2019-04-11 16:28:40.365 T:2989278064   DEBUG: PulseAudio: Context ready
2019-04-11 16:28:40.365 T:2989278064 WARNING: Pulseaudio module module-allow-passthrough not loaded - opening PT devices might fail
2019-04-11 16:28:40.366 T:2989278064  NOTICE: Found 2 Lists of Devices
2019-04-11 16:28:40.366 T:2989278064  NOTICE: Enumerated PI devices:
2019-04-11 16:28:40.366 T:2989278064  NOTICE:     Device 1
2019-04-11 16:28:40.366 T:2989278064  NOTICE:         m_deviceName      : HDMI
2019-04-11 16:28:40.366 T:2989278064  NOTICE:         m_displayName     : HDMI
2019-04-11 16:28:40.366 T:2989278064  NOTICE:         m_displayNameExtra:
2019-04-11 16:28:40.366 T:2989278064  NOTICE:         m_deviceType      : AE_DEVTYPE_HDMI
2019-04-11 16:28:40.366 T:2989278064  NOTICE:         m_channels        : FL, FR
2019-04-11 16:28:40.366 T:2989278064  NOTICE:         m_sampleRates     : 8000,11025,16000,22050,24000,32000,44100,48000,88200,96000,176400,192000
2019-04-11 16:28:40.366 T:2989278064  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
2019-04-11 16:28:40.366 T:2989278064  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
2019-04-11 16:28:40.366 T:2989278064  NOTICE:     Device 2
2019-04-11 16:28:40.366 T:2989278064  NOTICE:         m_deviceName      : Analogue
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_displayName     : Analogue
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_displayNameExtra:
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_channels        : FL, FR
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_sampleRates     : 48000
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_dataFormats     : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_streamTypes     : No passthrough capabilities
2019-04-11 16:28:40.367 T:2989278064  NOTICE:     Device 3
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_deviceName      : Both
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_displayName     : HDMI and Analogue
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_displayNameExtra:
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_channels        : FL, FR
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_sampleRates     : 48000
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_dataFormats     : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_streamTypes     : No passthrough capabilities
2019-04-11 16:28:40.367 T:2989278064  NOTICE: Enumerated PULSE devices:
2019-04-11 16:28:40.367 T:2989278064  NOTICE:     Device 1
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_deviceName      : Default
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_displayName     : Default
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_displayNameExtra: Bluetooth Audio (PULSEAUDIO)
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_channels        : FL, FR
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_sampleRates     : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_dataFormats     : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT
2019-04-11 16:28:40.367 T:2989278064  NOTICE:         m_streamTypes     : No passthrough capabilities
2019-04-11 16:28:40.367 T:2979001200    INFO: CActiveAESink::OpenSink - initialize sink
2019-04-11 16:28:40.367 T:2979001200   DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI
2019-04-11 16:28:40.367 T:2979001200   DEBUG: DllBcm: Using omx system library
2019-04-11 16:28:40.369 T:2979001200   DEBUG: SECTION:LoadDLL(libopenmaxil.so)
2019-04-11 16:28:40.370 T:2979001200   DEBUG: Loading: libopenmaxil.so
2019-04-11 16:28:40.379 T:2979001200   DEBUG: CSettingsManager: requested setting (videoscreen.limitgui) was not found.
2019-04-11 16:28:40.379 T:2979001200   DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI
2019-04-11 16:28:40.379 T:2979001200   DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008
2019-04-11 16:28:40.382 T:2979001200   DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0xb0f0d308
2019-04-11 16:28:40.383 T:2979001200   DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignment(16)
2019-04-11 16:28:40.384 T:2979001200   DEBUG: CActiveAESink::OpenSink - SinkPi Initialized:
2019-04-11 16:28:40.384 T:2979001200   DEBUG:   Output Device : HDMI
2019-04-11 16:28:40.384 T:2979001200   DEBUG:   Sample Rate   : 44100
2019-04-11 16:28:40.384 T:2979001200   DEBUG:   Sample Format : AE_FMT_FLOAT
2019-04-11 16:28:40.384 T:2979001200   DEBUG:   Channel Count : 2
2019-04-11 16:28:40.384 T:2979001200   DEBUG:   Channel Layout: FL, FR
2019-04-11 16:28:40.384 T:2979001200   DEBUG:   Frames        : 2205
2019-04-11 16:28:40.384 T:2979001200   DEBUG:   Frame Size    : 8
2019-04-11 16:28:40.391 T:3011529184    INFO: CKeyboardLayoutManager: loading keyboard layouts from special://xbmc/system/keyboardlayouts...
2019-04-11 16:28:40.396 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Arabic QWERTY" successfully loaded
2019-04-11 16:28:40.397 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian ЯВЕРТЪ" successfully loaded
2019-04-11 16:28:40.397 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian АБВ" successfully loaded
2019-04-11 16:28:40.398 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BasePY" successfully loaded
2019-04-11 16:28:40.398 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BaiduPY" successfully loaded
2019-04-11 16:28:40.398 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Croatian QWERTY" successfully loaded
2019-04-11 16:28:40.399 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Czech QWERTZ" successfully loaded
2019-04-11 16:28:40.399 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Danish QWERTY" successfully loaded
2019-04-11 16:28:40.400 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "English QWERTY" successfully loaded
2019-04-11 16:28:40.400 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "English AZERTY" successfully loaded
2019-04-11 16:28:40.400 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "English ABC" successfully loaded
2019-04-11 16:28:40.401 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "French AZERTY" successfully loaded
2019-04-11 16:28:40.401 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "German QWERTZ" successfully loaded
2019-04-11 16:28:40.402 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "German ABC" successfully loaded
2019-04-11 16:28:40.402 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Greek QWERTY" successfully loaded
2019-04-11 16:28:40.403 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew QWERTY" successfully loaded
2019-04-11 16:28:40.403 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew ABC" successfully loaded
2019-04-11 16:28:40.403 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Hungarian QWERTZ" successfully loaded
2019-04-11 16:28:40.404 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Icelandic QWERTY" successfully loaded
2019-04-11 16:28:40.404 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Italian QWERTY" successfully loaded
2019-04-11 16:28:40.405 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Korean ㄱㄴㄷ" successfully loaded
2019-04-11 16:28:40.405 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian AZERTY" successfully loaded
2019-04-11 16:28:40.406 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian QWERTY" successfully loaded
2019-04-11 16:28:40.406 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Norwegian QWERTY" successfully loaded
2019-04-11 16:28:40.407 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Polish QWERTY" successfully loaded
2019-04-11 16:28:40.407 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Portuguese (Portugal) QWERTY" successfully loaded
2019-04-11 16:28:40.408 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Romanian QWERTY" successfully loaded
2019-04-11 16:28:40.408 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Russian ЙЦУКЕН" successfully loaded
2019-04-11 16:28:40.408 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Russian АБВ" successfully loaded
2019-04-11 16:28:40.409 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Silesian QWERTY" successfully loaded
2019-04-11 16:28:40.410 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTZ" successfully loaded
2019-04-11 16:28:40.410 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTY" successfully loaded
2019-04-11 16:28:40.410 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak ABC" successfully loaded
2019-04-11 16:28:40.411 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Slovenian QWERTZ" successfully loaded
2019-04-11 16:28:40.411 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Spanish QWERTY" successfully loaded
2019-04-11 16:28:40.412 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Swedish QWERTY" successfully loaded
2019-04-11 16:28:40.412 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Thai Kedmanee" successfully loaded
2019-04-11 16:28:40.413 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Turkish QWERTY" successfully loaded
2019-04-11 16:28:40.413 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian ЙЦУКЕН" successfully loaded
2019-04-11 16:28:40.413 T:3011529184   DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian АБВ" successfully loaded
2019-04-11 16:28:40.414 T:3011529184   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
2019-04-11 16:28:40.414 T:3011529184   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
2019-04-11 16:28:40.417 T:3011529184   DEBUG: Selected UDev as storage provider
2019-04-11 16:28:40.417 T:3011529184  NOTICE: Raspberry PI firmware version: Jun 26 2020 14:49:28 
                                            Copyright (c) 2012 Broadcom
                                            version b078012603a6a094178f959805996ad225a0d83b (clean) (release) (start_x)
2019-04-11 16:28:40.417 T:3011529184  NOTICE: ARM mem: 704MB GPU mem: 320MB MPG2:0 WVC1:0
2019-04-11 16:28:40.417 T:3011529184  NOTICE: Config:
                                            arm_freq=1500
                                            audio_pwm_mode=514
                                            config_hdmi_boost=5
                                            core_freq=500
                                            core_freq_min=200
                                            disable_commandline_tags=2
                                            disable_l2cache=1
                                            disable_overscan=1
                                            display_hdmi_rotate=-1
                                            display_lcd_rotate=-1
                                            enable_gic=1
                                            force_eeprom_read=1
                                            force_pwm_open=1
                                            framebuffer_ignore_alpha=1
                                            framebuffer_swap=1
                                            gpu_freq=500
                                            gpu_freq_min=250
                                            hdmi_channel_map=8
                                            init_uart_clock=0x2dc6c00
                                            lcd_framerate=60
                                            mask_gpu_interrupt0=1024
                                            mask_gpu_interrupt1=0x10000
                                            over_voltage_avs=-20000
                                            pause_burst_frames=1
                                            program_serial_random=1
                                            total_mem=8192
                                            hdmi_force_cec_address:0=65535
                                            hdmi_force_cec_address:1=65535
                                            hdmi_ignore_cec_init:0=1
                                            hdmi_pixel_freq_limit:0=0x11e1a300
                                            hdmi_pixel_freq_limit:1=0x11e1a300
2019-04-11 16:28:40.417 T:3011529184  NOTICE: Config:
                                            device_tree=-
                                            overlay_prefix=overlays/
                                            hdmi_cvt:0=
                                            hdmi_cvt:1=
                                            hdmi_edid_filename:0=
                                            hdmi_edid_filename:1=
                                            hdmi_timings:0=
                                            hdmi_timings:1=
2019-04-11 16:28:40.417 T:3011529184    INFO: RetroPlayer[PROCESS]: Registering process control for GBM
2019-04-11 16:28:40.418 T:3011529184    INFO: RetroPlayer[RENDER]: Registering renderer factory for OpenGLES
2019-04-11 16:28:40.573 T:3011529184   DEBUG: CDRMUtils::FindConnector - found connector: 51
2019-04-11 16:28:40.574 T:3011529184   DEBUG: CDRMUtils::OpenDrm - opened device: /dev/dri/card0 using module: vc4
2019-04-11 16:28:40.605 T:3011529184   DEBUG: CDRMUtils::FindConnector - found connector: 51
2019-04-11 16:28:40.605 T:3011529184   DEBUG: CDRMUtils::FindEncoder - found encoder: 50
2019-04-11 16:28:40.605 T:3011529184   DEBUG: CDRMUtils::FindCrtc - found crtc: 49
2019-04-11 16:28:40.606 T:3011529184   DEBUG: CDRMUtils::FindPlane - found video plane 28
2019-04-11 16:28:40.606 T:3011529184 WARNING: CDRMUtils::FindPlane - could not find plane
2019-04-11 16:28:40.606 T:3011529184   DEBUG: CDRMUtils::FindPlane - found gui plane 35
2019-04-11 16:28:40.607 T:3011529184   DEBUG: CDRMUtils::FindPreferredMode - found preferred mode: 1920x1080 @ 60 Hz
2019-04-11 16:28:40.607 T:3011529184   DEBUG: CDRMAtomic::InitDrm - initialized atomic DRM
2019-04-11 16:28:40.720 T:3011529184   DEBUG: CWinSystemGbm::InitWindowSystem - initialized DRM
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 1920x1080 with 1920x1080 @ 60.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 1920x1080 with 1920x1080 @ 75.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 1920x1080 with 1920x1080 @ 59.940063 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 1920x1080 with 1920x1080 @ 50.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 1680x1050 with 1680x1050 @ 60.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 1400x1050 with 1400x1050 @ 60.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 1600x900 with 1600x900 @ 60.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 1280x1024 with 1280x1024 @ 75.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 1280x1024 with 1280x1024 @ 60.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 1440x900 with 1440x900 @ 60.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 1280x800 with 1280x800 @ 60.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 1152x864 with 1152x864 @ 75.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 1280x720 with 1280x720 @ 60.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 1280x720 with 1280x720 @ 59.940063 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 1280x720 with 1280x720 @ 50.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 1024x768 with 1024x768 @ 75.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 1024x768 with 1024x768 @ 60.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 800x600 with 800x600 @ 75.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 800x600 with 800x600 @ 60.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 720x576 with 720x576 @ 50.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 720x480 with 720x480 @ 59.940063 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 720x480 with 720x480 @ 60.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 640x480 with 640x480 @ 75.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 640x480 with 640x480 @ 60.000000 Hz
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Previous line repeats 1 times.
2019-04-11 16:28:40.721 T:3011529184  NOTICE: Found resolution 720x400 with 720x400 @ 70.000000 Hz
2019-04-11 16:28:40.723 T:3011529184  NOTICE: EGL_VERSION = 1.4
2019-04-11 16:28:40.724 T:3011529184  NOTICE: EGL_VENDOR = Mesa Project
2019-04-11 16:28:40.724 T:3011529184  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
2019-04-11 16:28:40.724 T:3011529184  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
2019-04-11 16:28:40.724 T:3011529184   DEBUG: EGL Config Attributes:
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_BUFFER_SIZE: 32
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_ALPHA_SIZE: 8
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_BLUE_SIZE: 8
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_GREEN_SIZE: 8
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_RED_SIZE: 8
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_DEPTH_SIZE: 16
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_STENCIL_SIZE: 0
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_CONFIG_CAVEAT: 0x3038
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_CONFIG_ID: 10
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_LEVEL: 0
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_MAX_PBUFFER_HEIGHT: 4096
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_MAX_PBUFFER_PIXELS: 0
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_MAX_PBUFFER_WIDTH: 4096
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_NATIVE_RENDERABLE: 1
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_NATIVE_VISUAL_ID: 875713089
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_NATIVE_VISUAL_TYPE: 0x3038
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_SAMPLES: 0
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_SAMPLE_BUFFERS: 0
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_SURFACE_TYPE: 4
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_TRANSPARENT_TYPE: 0x3038
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_TRANSPARENT_BLUE_VALUE: 0
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_TRANSPARENT_GREEN_VALUE: 0
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_TRANSPARENT_RED_VALUE: 0
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_BIND_TO_TEXTURE_RGB: 0
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_BIND_TO_TEXTURE_RGBA: 0
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_MIN_SWAP_INTERVAL: 1
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_MAX_SWAP_INTERVAL: 1
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_LUMINANCE_SIZE: 0
2019-04-11 16:28:40.724 T:3011529184   DEBUG:   EGL_ALPHA_MASK_SIZE: 0
2019-04-11 16:28:40.725 T:3011529184   DEBUG:   EGL_COLOR_BUFFER_TYPE: 0x308e
2019-04-11 16:28:40.725 T:3011529184   DEBUG:   EGL_RENDERABLE_TYPE: 77
2019-04-11 16:28:40.725 T:3011529184   DEBUG:   EGL_CONFORMANT: 77
2019-04-11 16:28:40.728 T:3011529184  NOTICE: Checking resolution 16
2019-04-11 16:28:40.728 T:3011529184   DEBUG: OnLostDevice - notify display change event
2019-04-11 16:28:40.847 T:2979001200   DEBUG: CAESinkPi:Drain delay:100ms now:0ms
2019-04-11 16:28:40.847 T:2979001200   DEBUG: CAESinkPi:Deinitialize
2019-04-11 16:28:40.847 T:2979001200   DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000
2019-04-11 16:28:40.850 T:2979001200   DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0xb0f0d308
2019-04-11 16:28:40.851 T:3011529184 WARNING: CGBMUtils::DestroySurface - surface already destroyed
2019-04-11 16:28:40.851 T:3011529184   DEBUG: CWinSystemGbmEGLContext::DestroyWindow - deinitialized GBM
2019-04-11 16:28:40.880 T:3011529184   DEBUG: CDRMUtils::SetMode - found crtc mode: 1920x1080 @ 60 Hz
2019-04-11 16:28:40.880 T:3011529184   DEBUG: CGBMUtils::CreateSurface - created surface with size 1920x1080
2019-04-11 16:28:40.912 T:3011529184   DEBUG: CWinSystemGbmEGLContext::CreateNewWindow - initialized GBM
2019-04-11 16:28:40.913 T:3011529184  NOTICE: GL_VENDOR = Broadcom
2019-04-11 16:28:40.913 T:3011529184  NOTICE: GL_RENDERER = V3D 4.2
2019-04-11 16:28:40.913 T:3011529184  NOTICE: GL_VERSION = OpenGL ES 3.0 Mesa 19.1.7
2019-04-11 16:28:40.913 T:3011529184  NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 3.00
2019-04-11 16:28:40.914 T:3011529184  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
2019-04-11 16:28:41.662 T:3011529184   DEBUG: OnLostDevice - notify display change event
2019-04-11 16:28:41.691 T:3011529184   DEBUG: CDRMUtils::SetMode - found crtc mode: 1920x1080 @ 60 Hz
2019-04-11 16:28:41.692 T:3011529184    INFO: GLES: Maximum texture width: 4096
2019-04-11 16:28:41.692 T:2989278064   DEBUG: CActiveAE - display reset event
2019-04-11 16:28:41.692 T:3011529184   DEBUG: guilib: Fill viewport on change for solving rendering passes
2019-04-11 16:28:41.692 T:2979001200    INFO: CActiveAESink::OpenSink - initialize sink
2019-04-11 16:28:41.692 T:2979001200   DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI
2019-04-11 16:28:41.692 T:2979001200   DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI
2019-04-11 16:28:41.692 T:2979001200   DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008
2019-04-11 16:28:41.693 T:2979001200   DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0xb0f0d308
2019-04-11 16:28:41.695 T:2979001200   DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignment(16)
2019-04-11 16:28:41.695 T:2979001200   DEBUG: CActiveAESink::OpenSink - SinkPi Initialized:
2019-04-11 16:28:41.695 T:2979001200   DEBUG:   Output Device : HDMI
2019-04-11 16:28:41.695 T:2979001200   DEBUG:   Sample Rate   : 44100
2019-04-11 16:28:41.695 T:2979001200   DEBUG:   Sample Format : AE_FMT_FLOAT
2019-04-11 16:28:41.695 T:2979001200   DEBUG:   Channel Count : 2
2019-04-11 16:28:41.695 T:2979001200   DEBUG:   Channel Layout: FL, FR
2019-04-11 16:28:41.695 T:2979001200   DEBUG:   Frames        : 2205
2019-04-11 16:28:41.695 T:2979001200   DEBUG:   Frame Size    : 8
2019-04-11 16:28:41.697 T:2989278064   DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
2019-04-11 16:28:42.267 T:3011529184   DEBUG: EGL Debugging:
                                            Error: EGL_BAD_SURFACE
                                            Command: eglSwapBuffers
                                            Type: EGL_DEBUG_MSG_ERROR_KHR
                                            Message: dri2_swap_buffers
2019-04-11 16:28:42.277 T:3011529184   DEBUG: CRBP::OpenDisplay device:0 m_display:10000020 (0)
2019-04-11 16:28:42.277 T:3011529184    INFO: load keymapping
2019-04-11 16:28:42.279 T:3011529184    INFO: Loading special://xbmc/system/keymaps/appcommand.xml
2019-04-11 16:28:42.279 T:3011529184    INFO: Loading special://xbmc/system/keymaps/customcontroller.AppleRemote.xml
2019-04-11 16:28:42.281 T:3011529184    INFO: Loading special://xbmc/system/keymaps/customcontroller.Harmony.xml
2019-04-11 16:28:42.284 T:3011529184    INFO: Loading special://xbmc/system/keymaps/gamepad.xml
2019-04-11 16:28:42.286 T:3011529184    INFO: Loading special://xbmc/system/keymaps/joystick.xml
2019-04-11 16:28:42.289 T:3011529184    INFO: Loading special://xbmc/system/keymaps/keyboard.xml
2019-04-11 16:28:42.296 T:3011529184    INFO: Loading special://xbmc/system/keymaps/mouse.xml
2019-04-11 16:28:42.296 T:3011529184    INFO: Loading special://xbmc/system/keymaps/remote.xml
2019-04-11 16:28:42.301 T:3011529184    INFO: Loading special://xbmc/system/keymaps/touchscreen.xml
2019-04-11 16:28:42.304 T:3011529184    INFO: GUI format 1920x1080, Display 1920x1080 @ 60.000000 Hz
2019-04-11 16:28:42.304 T:3011529184    INFO: CLangInfo: loading resource.language.de_de language information...
2019-04-11 16:28:42.306 T:3011529184   DEBUG: trying to set locale to de_DE.UTF-8
2019-04-11 16:28:42.316 T:3011529184    INFO: global locale set to C
2019-04-11 16:28:42.316 T:3011529184    INFO: CLangInfo: loading resource.language.de_de language strings...
2019-04-11 16:28:42.365 T:3011529184   DEBUG: LocalizeStrings: loaded 4015 strings from file resource://resource.language.de_de/strings.po
2019-04-11 16:28:42.383 T:3011529184   DEBUG: POParser: id:12343 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead
2019-04-11 16:28:42.394 T:3011529184   DEBUG: LocalizeStrings: loaded 8 strings from file resource://resource.language.en_gb/strings.po
2019-04-11 16:28:42.407 T:3011529184   DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.kodi.builtin.aac/resources/language/English/strings.po
2019-04-11 16:28:42.408 T:3011529184   DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.kodi.builtin.wma/resources/language/English/strings.po
2019-04-11 16:28:42.411 T:3011529184   DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/game.controller.default/resources/language/resource.language.en_gb/strings.po
2019-04-11 16:28:42.414 T:3011529184   DEBUG: LocalizeStrings: loaded 13 strings from file /usr/share/kodi/addons/game.controller.snes/resources/language/resource.language.en_gb/strings.po
2019-04-11 16:28:42.421 T:3011529184   DEBUG: LocalizeStrings: loaded 11 strings from file /storage/.kodi/addons/metadata.album.universal/resources/language/resource.language.de_de/strings.po
2019-04-11 16:28:42.423 T:3011529184   DEBUG: LocalizeStrings: loaded 6 strings from file /storage/.kodi/addons/metadata.album.universal/resources/language/resource.language.en_gb/strings.po
2019-04-11 16:28:42.425 T:3011529184   DEBUG: LocalizeStrings: loaded 23 strings from file /storage/.kodi/addons/metadata.artists.universal/resources/language/resource.language.de_de/strings.po
2019-04-11 16:28:42.427 T:3011529184   DEBUG: LocalizeStrings: loaded 9 strings from file /storage/.kodi/addons/metadata.artists.universal/resources/language/resource.language.en_gb/strings.po
2019-04-11 16:28:42.435 T:3011529184   DEBUG: LocalizeStrings: loaded 7 strings from file /storage/.kodi/addons/metadata.themoviedb.org/resources/language/resource.language.de_de/strings.po
2019-04-11 16:28:42.436 T:3011529184   DEBUG: POParser: id:30003 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead
2019-04-11 16:28:42.436 T:3011529184   DEBUG: LocalizeStrings: loaded 3 strings from file /storage/.kodi/addons/metadata.themoviedb.org/resources/language/resource.language.en_gb/strings.po
2019-04-11 16:28:42.439 T:3011529184   DEBUG: LocalizeStrings: loaded 3 strings from file /storage/.kodi/addons/metadata.tvshows.themoviedb.org/resources/language/resource.language.de_de/strings.po
2019-04-11 16:28:42.440 T:3011529184   DEBUG: LocalizeStrings: loaded 10 strings from file /storage/.kodi/addons/metadata.tvshows.themoviedb.org/resources/language/resource.language.en_gb/strings.po
2019-04-11 16:28:42.444 T:3011529184   DEBUG: LocalizeStrings: loaded 9 strings from file /usr/share/kodi/addons/peripheral.joystick/resources/language/resource.language.en_gb/strings.po
2019-04-11 16:28:42.453 T:3011529184   DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.de_de/strings.po
2019-04-11 16:28:42.453 T:3011529184   DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.en_gb/strings.po
2019-04-11 16:28:42.455 T:3011529184   DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/script.program.driverselect/resources/language/resource.language.de_de/strings.po
2019-04-11 16:28:42.456 T:3011529184   DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/script.program.driverselect/resources/language/resource.language.en_gb/strings.po
2019-04-11 16:28:42.458 T:3011529184   DEBUG: LocalizeStrings: loaded 230 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/resource.language.de_de/strings.po
2019-04-11 16:28:42.459 T:3011529184   DEBUG: POParser: id:722 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead
2019-04-11 16:28:42.460 T:3011529184   DEBUG: LocalizeStrings: loaded 29 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/resource.language.en_gb/strings.po
2019-04-11 16:28:42.474 T:3011529184   DEBUG: LocalizeStrings: loaded 24 strings from file /storage/.kodi/addons/script.kodi.loguploader/resources/language/resource.language.en_gb/strings.po
2019-04-11 16:28:42.478 T:3011529184   DEBUG: LocalizeStrings: loaded 21 strings from file /storage/.kodi/addons/script.logviewer/resources/language/English/strings.po
2019-04-11 16:28:42.481 T:3011529184   DEBUG: LocalizeStrings: loaded 10 strings from file /storage/.kodi/addons/plugin.video.ipcams/resources/language/resource.language.de_de/strings.po
2019-04-11 16:28:42.483 T:3011529184   DEBUG: LocalizeStrings: loaded 0 strings from file /storage/.kodi/addons/plugin.video.ipcams/resources/language/resource.language.en_gb/strings.po
2019-04-11 16:28:42.484 T:2876646256   DEBUG: Thread JobWorker start, auto delete: true
2019-04-11 16:28:42.484 T:2876646256   DEBUG: Initialize, updating databases...
2019-04-11 16:28:42.487 T:2876646256  NOTICE: Running database version Addons27
2019-04-11 16:28:42.491 T:2876646256  NOTICE: Running database version ViewModes6
2019-04-11 16:28:42.501 T:2876646256  NOTICE: Running database version Textures13
2019-04-11 16:28:42.513 T:2876646256  NOTICE: Running database version MyMusic72
2019-04-11 16:28:42.531 T:2876646256  NOTICE: Running database version MyVideos116
2019-04-11 16:28:42.536 T:2876646256  NOTICE: Running database version TV32
2019-04-11 16:28:42.540 T:2876646256  NOTICE: Running database version Epg12
2019-04-11 16:28:42.540 T:2876646256   DEBUG: Initialize, updating databases... DONE
2019-04-11 16:28:42.560 T:3011529184  NOTICE: start dvd mediatype detection
2019-04-11 16:28:42.560 T:2992886640   DEBUG: Thread DetectDVDMedia start, auto delete: false
2019-04-11 16:28:42.560 T:3011529184   DEBUG: DPMS: supported power-saving modes: OFF
2019-04-11 16:28:42.560 T:2992886640   DEBUG: Compiled with libcdio Version 0.94
2019-04-11 16:28:42.562 T:2992886640   DEBUG: Thread DetectDVDMedia 2992886640 terminating
2019-04-11 16:28:42.627 T:3011529184    INFO: Unloading old skin ...
2019-04-11 16:28:42.629 T:3011529184  NOTICE:   load skin from: /usr/share/kodi/addons/skin.estuary (version: 2.0.27)
2019-04-11 16:28:42.629 T:3011529184    INFO:   load fonts for skin...
2019-04-11 16:28:42.635 T:3011529184    INFO: Loading skin includes from /usr/share/kodi/addons/skin.estuary/xml/Includes.xml
2019-04-11 16:28:42.725 T:3011529184    INFO: Loading fonts from /usr/share/kodi/addons/skin.estuary/xml/Font.xml
2019-04-11 16:28:42.827 T:3011529184   DEBUG: LocalizeStrings: loaded 140 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.de_de/strings.po
2019-04-11 16:28:42.828 T:3011529184   DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.en_gb/strings.po
2019-04-11 16:28:42.828 T:3011529184    INFO:   load new skin...
2019-04-11 16:28:42.828 T:3011529184    INFO: Loading custom window XMLs from skin path /usr/share/kodi/addons/skin.estuary/xml
2019-04-11 16:28:42.842 T:3011529184   DEBUG: Load Skin XML: 14.37ms
2019-04-11 16:28:42.842 T:3011529184    INFO:   initialize new skin...
2019-04-11 16:28:42.842 T:3011529184   DEBUG: guilib: Fill viewport on change for solving rendering passes
2019-04-11 16:28:42.842 T:3011529184    INFO: Loading skin file: Custom_1109_TopBarOverlay.xml, load type: LOAD_ON_GUI_INIT
2019-04-11 16:28:42.846 T:3011529184    INFO: Loading skin file: DialogNotification.xml, load type: LOAD_ON_GUI_INIT
2019-04-11 16:28:42.848 T:3011529184    INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT
2019-04-11 16:28:42.881 T:3011529184   DEBUG: OpenBundle - Opened bundle /usr/share/kodi/addons/skin.estuary/media/Textures.xbt
2019-04-11 16:28:42.892 T:3011529184    INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT
2019-04-11 16:28:42.894 T:3011529184    INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
2019-04-11 16:28:42.896 T:3011529184    INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT
2019-04-11 16:28:42.897 T:3011529184    INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT
2019-04-11 16:28:42.900 T:3011529184    INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
2019-04-11 16:28:42.903 T:3011529184    INFO: Loading resource://resource.uisounds.kodi/sounds.xml
2019-04-11 16:28:42.953 T:3011529184    INFO:   skin loaded...
2019-04-11 16:28:42.953 T:3011529184   DEBUG: Activating window ID: 12997
2019-04-11 16:28:42.953 T:3011529184   DEBUG: ------ Window Init () ------
2019-04-11 16:28:42.954 T:3011529184   DEBUG: Activating window ID: 12999
2019-04-11 16:28:42.954 T:3011529184   DEBUG: ------ Window Init (Startup.xml) ------
2019-04-11 16:28:42.954 T:3011529184    INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME
2019-04-11 16:28:42.954 T:3011529184   DEBUG: Activating window ID: 10000
2019-04-11 16:28:42.954 T:3011529184   DEBUG: ------ Window Deinit (Startup.xml) ------
2019-04-11 16:28:42.954 T:3011529184   DEBUG: ------ Window Init (Home.xml) ------
2019-04-11 16:28:42.954 T:3011529184    INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY
2019-04-11 16:28:43.070 T:3011529184   DEBUG: CDirectoryProvider[addons://]: refreshing..
2019-04-11 16:28:43.072 T:3011529184   DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing..
2019-04-11 16:28:43.072 T:3011529184   DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing..
2019-04-11 16:28:43.072 T:3011529184   DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing..
2019-04-11 16:28:43.072 T:3011529184   DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing..
2019-04-11 16:28:43.072 T:3011529184   DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing..
2019-04-11 16:28:43.072 T:3011529184   DEBUG: CDirectoryProvider[library://video/]: refreshing..
2019-04-11 16:28:43.072 T:3011529184   DEBUG: CDirectoryProvider[sources://video/]: refreshing..
2019-04-11 16:28:43.072 T:3011529184   DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing..
2019-04-11 16:28:43.073 T:3011529184   DEBUG: CDirectoryProvider[favourites://]: refreshing..
2019-04-11 16:28:43.073 T:3011529184   DEBUG: CDirectoryProvider[sources://pictures/]: refreshing..
2019-04-11 16:28:43.073 T:3011529184   DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing..
2019-04-11 16:28:43.073 T:2868253552   DEBUG: Thread JobWorker start, auto delete: true
2019-04-11 16:28:43.096 T:2876646256   DEBUG: Previous line repeats 1 times.
2019-04-11 16:28:43.096 T:2876646256   DEBUG: CAddonMgr::GetAvailableUpdates took 25 ms
2019-04-11 16:28:43.130 T:3011529184   DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting
2019-04-11 16:28:43.130 T:3011529184 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList"
2019-04-11 16:28:43.130 T:3011529184    INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting")
2019-04-11 16:28:43.131 T:3011529184    INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting
2019-04-11 16:28:43.176 T:3011529184    INFO: JSONRPC v10.3.0: Successfully initialized
2019-04-11 16:28:43.180 T:3011529184   DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid"
2019-04-11 16:28:43.180 T:3011529184   DEBUG: LoadMappings - loaded node "CEC Adapter"
2019-04-11 16:28:43.180 T:3011529184   DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter"
2019-04-11 16:28:43.181 T:3011529184   DEBUG: LoadMappings - loaded node "iMON HID device"
2019-04-11 16:28:43.181 T:3011529184   DEBUG: LoadMappings - loaded node "WETEK Play remote"
2019-04-11 16:28:43.181 T:3011529184   DEBUG: LoadMappings - loaded node ""
2019-04-11 16:28:43.182 T:3011529184   DEBUG: Add-on bus: Registering add-on peripheral.joystick
2019-04-11 16:28:43.182 T:3011529184   DEBUG: PERIPHERAL - CreateAddon - creating peripheral add-on instance 'Joystick Support'
2019-04-11 16:28:43.182 T:3011529184   DEBUG: ADDON: Dll Initializing - Joystick Support
2019-04-11 16:28:43.182 T:3011529184   DEBUG: SECTION:LoadDLL(/usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.4.9)
2019-04-11 16:28:43.182 T:3011529184   DEBUG: Loading: /usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.4.9
2019-04-11 16:28:43.198 T:3011529184   DEBUG: AddOnLog: Joystick Support: Loaded 14 joystick families with 97 total joysticks
2019-04-11 16:28:43.198 T:3011529184   DEBUG: Calling TransferSettings for: Joystick Support
2019-04-11 16:28:43.199 T:3011529184   DEBUG: CAddonSettings[peripheral.joystick]: loading setting definitions
2019-04-11 16:28:43.199 T:3011529184    INFO: AddOnLog: Joystick Support: Enabling joystick interface "linux"
2019-04-11 16:28:43.200 T:2843075440   DEBUG: Thread PeripBusUSBUdev start, auto delete: false
2019-04-11 16:28:43.200 T:2843075440   DEBUG: Process - initialised udev monitor
2019-04-11 16:28:43.201 T:2834682736   DEBUG: Thread PeripBusCEC start, auto delete: false
2019-04-11 16:28:43.203 T:2868253552   DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3a%2f%2fprofile%2fplaylists%2fvideo/special%3a%2f%2fprofile%2fplaylists%2fmixed/)
2019-04-11 16:28:43.204 T:2868253552   DEBUG: Getting Directory (special://profile/playlists/video)
2019-04-11 16:28:43.204 T:2826290032   DEBUG: Thread PeripBusAddon start, auto delete: false
2019-04-11 16:28:43.205 T:2868253552   DEBUG: Getting Directory (special://profile/playlists/mixed)
2019-04-11 16:28:43.206 T:3011529184   DEBUG: Initialise - initialised peripheral on 'keyboard' with 1 features and 0 sub devices
2019-04-11 16:28:43.206 T:3011529184  NOTICE: Register - new keyboard device registered on application->keyboard: Tastatur (0000:0000)
2019-04-11 16:28:43.207 T:2868253552   DEBUG: CMultiPathDirectory::MergeItems, items = 0
2019-04-11 16:28:43.207 T:3011529184   DEBUG: Initialise - initialised peripheral on 'mouse' with 1 features and 0 sub devices
2019-04-11 16:28:43.208 T:3011529184  NOTICE: Register - new mouse device registered on application->mouse: Maus (0000:0000)
2019-04-11 16:28:43.211 T:2817897328   DEBUG: Thread PeripEventScanner start, auto delete: false
2019-04-11 16:28:43.217 T:3011529184   DEBUG: ContextMenuManager: addon menus reloaded.
2019-04-11 16:28:43.217 T:3011529184  NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
2019-04-11 16:28:43.218 T:3011529184   DEBUG: CPlayerCoreConfig::<ctor>: created player VideoPlayer
2019-04-11 16:28:43.218 T:3011529184   DEBUG: CPlayerCoreConfig::<ctor>: created player PAPlayer
2019-04-11 16:28:43.218 T:3011529184   DEBUG: CPlayerCoreConfig::<ctor>: created player RetroPlayer
2019-04-11 16:28:43.218 T:3011529184   DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules
2019-04-11 16:28:43.218 T:3011529184   DEBUG: CPlayerSelectionRule::Initialize: creating rule: mms/udp
2019-04-11 16:28:43.218 T:3011529184   DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout
2019-04-11 16:28:43.218 T:3011529184   DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp
2019-04-11 16:28:43.218 T:3011529184   DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp
2019-04-11 16:28:43.218 T:3011529184   DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams
2019-04-11 16:28:43.218 T:3011529184   DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp
2019-04-11 16:28:43.218 T:3011529184   DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2
2019-04-11 16:28:43.218 T:3011529184   DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd
2019-04-11 16:28:43.218 T:3011529184   DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage
2019-04-11 16:28:43.218 T:3011529184   DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf
2019-04-11 16:28:43.218 T:3011529184   DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv
2019-04-11 16:28:43.218 T:3011529184   DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio
2019-04-11 16:28:43.218 T:3011529184  NOTICE: Loaded playercorefactory configuration
2019-04-11 16:28:43.218 T:3011529184  NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
2019-04-11 16:28:43.218 T:3011529184  NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
2019-04-11 16:28:43.218 T:3011529184    INFO: removing tempfiles
2019-04-11 16:28:43.229 T:2876646256   DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update
2019-04-11 16:28:43.241 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
2019-04-11 16:28:43.243 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
2019-04-11 16:28:43.247 T:2876646256   DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
2019-04-11 16:28:43.253 T:3011529184   DEBUG: CRepositoryUpdater: previous update at 12.05.2021 08:54:42, next at 13.05.2021 08:54:42
2019-04-11 16:28:43.253 T:2809504624   DEBUG: Thread Timer start, auto delete: false
2019-04-11 16:28:43.259 T:3011529184   DEBUG: CServiceAddonManager: starting service.libreelec.settings
2019-04-11 16:28:43.259 T:3011529184   DEBUG: CServiceAddonManager: starting script.logviewer
2019-04-11 16:28:43.259 T:2801111920   DEBUG: Thread LanguageInvoker start, auto delete: false
2019-04-11 16:28:43.259 T:2801111920    INFO: initializing python engine.
2019-04-11 16:28:43.260 T:3011529184  NOTICE: initialize done
2019-04-11 16:28:43.260 T:3011529184  NOTICE: Running the application...
2019-04-11 16:28:43.261 T:3011529184   DEBUG: no profile autoexec.py (/storage/.kodi/userdata/autoexec.py) found, skipping
2019-04-11 16:28:43.261 T:3011529184   DEBUG: NetworkMessage - Starting network services
2019-04-11 16:28:43.262 T:2792719216   DEBUG: Thread LanguageInvoker start, auto delete: false
2019-04-11 16:28:43.262 T:2792719216    INFO: initializing python engine.
2019-04-11 16:28:43.265 T:3011529184   DEBUG: CZeroconfAvahi::clientCallback: client is up and running
2019-04-11 16:28:43.266 T:3011529184  NOTICE: starting zeroconf publishing
2019-04-11 16:28:43.267 T:3011529184  NOTICE: CWebServer[8080]: Started
2019-04-11 16:28:43.267 T:3011529184  NOTICE: starting upnp client
2019-04-11 16:28:43.267 T:2868253552   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:Kodi (LibreELEC) port:8080
2019-04-11 16:28:43.267 T:2868253552   DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _http._tcp port:8080
2019-04-11 16:28:43.271 T:3011529184  NOTICE: starting upnp server
2019-04-11 16:28:43.273 T:2868253552   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:Kodi (LibreELEC) port:8080
2019-04-11 16:28:43.273 T:2868253552   DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _xbmc-jsonrpc-h._tcp port:8080
2019-04-11 16:28:43.277 T:3011529184  NOTICE: starting upnp renderer
2019-04-11 16:28:43.284 T:2675221360   DEBUG: Thread EventServer start, auto delete: false
2019-04-11 16:28:43.284 T:2675221360  NOTICE: ES: Starting UDP Event server on port 9777
2019-04-11 16:28:43.284 T:3011529184    INFO: JSONRPC Server: Successfully initialized
2019-04-11 16:28:43.284 T:2675221360  NOTICE: UDP: Listening on port 9777 (ipv6 : true)
2019-04-11 16:28:43.285 T:2876646256   DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
2019-04-11 16:28:43.285 T:2868253552   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:Kodi (LibreELEC) port:9777
2019-04-11 16:28:43.285 T:2868253552   DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _xbmc-events._udp port:9777
2019-04-11 16:28:43.285 T:3011529184   DEBUG: SECTION:LoadDLL(libshairplay.so.0)
2019-04-11 16:28:43.286 T:3011529184   DEBUG: Loading: libshairplay.so.0
2019-04-11 16:28:43.286 T:2666828656   DEBUG: Thread TCPServer start, auto delete: false
2019-04-11 16:28:43.290 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 != '')
2019-04-11 16:28:43.293 T:2868253552   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:Kodi (LibreELEC) port:9090
2019-04-11 16:28:43.294 T:2868253552   DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _xbmc-jsonrpc._tcp port:9090
2019-04-11 16:28:43.302 T:2868253552   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airtunes type: _raop._tcp name:DCA632DAEF5B@Kodi (LibreELEC) port:36666
2019-04-11 16:28:43.302 T:2868253552   DEBUG: CZeroconfAvahi::addService() named: DCA632DAEF5B@Kodi (LibreELEC) type: _raop._tcp port:36666
2021-05-12 08:56:23.173 T:2801111920   DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): start processing
2021-05-12 08:56:23.173 T:2792719216   DEBUG: CPythonInvoker(1, /storage/.kodi/addons/script.logviewer/service.py): start processing
2021-05-12 08:56:23.226 T:2801111920   DEBUG: -->Python Interpreter Initialized<--
2021-05-12 08:56:23.226 T:2801111920   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"
2021-05-12 08:56:23.226 T:2792719216   DEBUG: -->Python Interpreter Initialized<--
2021-05-12 08:56:23.226 T:2792719216   DEBUG: CPythonInvoker(1, /storage/.kodi/addons/script.logviewer/service.py): the source file to load is "/storage/.kodi/addons/script.logviewer/service.py"
2021-05-12 08:56:23.226 T:2801111920   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
2021-05-12 08:56:23.226 T:2801111920   DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): entering source directory /usr/share/kodi/addons/service.libreelec.settings
2021-05-12 08:56:23.227 T:2792719216   DEBUG: CPythonInvoker(1, /storage/.kodi/addons/script.logviewer/service.py): setting the Python path to /storage/.kodi/addons/script.logviewer:/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
2021-05-12 08:56:23.227 T:2792719216   DEBUG: CPythonInvoker(1, /storage/.kodi/addons/script.logviewer/service.py): entering source directory /storage/.kodi/addons/script.logviewer
2021-05-12 08:56:23.227 T:2801111920   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
2021-05-12 08:56:23.254 T:2792719216   DEBUG: CPythonInvoker(1, /storage/.kodi/addons/script.logviewer/service.py): instantiating addon using automatically obtained id of "script.logviewer" dependent on version 2.14.0 of the xbmc.python api
2021-05-12 08:56:23.463 T:3011529184   DEBUG: ------ Window Init () ------
2021-05-12 08:56:23.469 T:3011529184   DEBUG: ------ Window Init (Pointer.xml) ------
2021-05-12 08:56:23.505 T:2834682736   DEBUG: GetMappingForDevice - device (2708:1001) mapped to CEC Adapter (type = cec)
2021-05-12 08:56:23.508 T:2834682736   DEBUG: InitialiseFeature - using libCEC v4.0.4
2021-05-12 08:56:23.508 T:2834682736   DEBUG: Initialise - initialised peripheral on 'RPI' with 2 features and 0 sub devices
2021-05-12 08:56:23.508 T:2834682736  NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001)
2021-05-12 08:56:23.508 T:2605409136   DEBUG: Thread CECAdapter start, auto delete: false
2021-05-12 08:56:23.508 T:2834682736   DEBUG: Thread PeripBusCEC 2834682736 terminating
2021-05-12 08:56:23.508 T:2605409136   DEBUG: OpenConnection - opening a connection to the CEC adapter: RPI
2021-05-12 08:56:23.610 T:2801111920   DEBUG: ## LibreELEC Addon ## 9.0.0
2021-05-12 08:56:23.741 T:3011529184   DEBUG: LogindUPowerSyscall - Received unknown signal NameAcquired
2021-05-12 08:56:23.741 T:3011529184   DEBUG: ------ Window Init (DialogNotification.xml) ------
2021-05-12 08:56:23.912 T:2784326512   DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
2021-05-12 08:56:24.016 T:2801111920   DEBUG: Previous line repeats 4 times.
2021-05-12 08:56:24.016 T:2801111920    INFO: ## LibreELEC Addon ## system::set_hostname ## LibreELEC
2021-05-12 08:56:24.017 T:2801111920    INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## us
2021-05-12 08:56:24.017 T:2801111920    INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## loadkmap < `ls -1 /usr/lib/keymaps/*/us.bmap`
2021-05-12 08:56:24.534 T:2801111920    INFO: ## LibreELEC Addon ## updates::updateThread ## Started
2021-05-12 08:56:24.535 T:2801111920    INFO: ## LibreELEC Addon ## updates::set_auto_update ## auto
2021-05-12 08:56:24.589 T:2583651184    INFO: ## LibreELEC Addon ## _service_::run ## WAITING:
2021-05-12 08:56:24.602 T:2533389168    INFO: ## LibreELEC Addon ## xdbus Monitor started. ##
2021-05-12 08:56:24.642 T:3011529184   DEBUG: ------ Window Deinit (Pointer.xml) ------
2021-05-12 08:56:24.750 T:2605409136   DEBUG: OpenConnection - connection to the CEC adapter opened
2021-05-12 08:56:24.750 T:2605409136   DEBUG: SetConfigurationFromLibCEC - settings updated by libCEC
2021-05-12 08:56:24.750 T:2524996464   DEBUG: Thread CECAdapterUpdate start, auto delete: false
2021-05-12 08:56:29.481 T:3011529184   DEBUG: ------ Window Deinit (DialogNotification.xml) ------
2021-05-12 08:56:34.016 T:3002069872   DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms
2021-05-12 08:56:34.016 T:2541781872   DEBUG: Thread Timer start, auto delete: false
2021-05-12 08:56:34.041 T:3011529184   DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:34.041 T:3011529184   DEBUG: HandleKey: down (0xf081) pressed, action is Down
2021-05-12 08:56:34.079 T:2541781872   DEBUG: Thread Timer 2541781872 terminating
2021-05-12 08:56:34.107 T:3011529184   DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:34.167 T:3002069872   DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms
2021-05-12 08:56:34.167 T:2550174576   DEBUG: Thread Timer start, auto delete: false
2021-05-12 08:56:34.174 T:3011529184   DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:34.174 T:3011529184   DEBUG: HandleKey: down (0xf081) pressed, action is Down
2021-05-12 08:56:34.223 T:2550174576   DEBUG: Thread Timer 2550174576 terminating
2021-05-12 08:56:34.241 T:3011529184   DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:34.311 T:3002069872   DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms
2021-05-12 08:56:34.311 T:2575258480   DEBUG: Thread Timer start, auto delete: false
2021-05-12 08:56:34.340 T:3011529184   DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:34.341 T:3011529184   DEBUG: HandleKey: down (0xf081) pressed, action is Down
2021-05-12 08:56:34.359 T:2575258480   DEBUG: Thread Timer 2575258480 terminating
2021-05-12 08:56:34.374 T:3011529184   DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:34.431 T:3002069872   DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms
2021-05-12 08:56:34.431 T:2575258480   DEBUG: Thread Timer start, auto delete: false
2021-05-12 08:56:34.441 T:3011529184   DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:34.441 T:3011529184   DEBUG: HandleKey: down (0xf081) pressed, action is Down
2021-05-12 08:56:34.495 T:2575258480   DEBUG: Thread Timer 2575258480 terminating
2021-05-12 08:56:34.507 T:3011529184   DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:34.567 T:3002069872   DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms
2021-05-12 08:56:34.567 T:2575258480   DEBUG: Thread Timer start, auto delete: false
2021-05-12 08:56:34.574 T:3011529184   DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:34.574 T:3011529184   DEBUG: HandleKey: down (0xf081) pressed, action is Down
2021-05-12 08:56:34.639 T:2575258480   DEBUG: Thread Timer 2575258480 terminating
2021-05-12 08:56:34.641 T:3011529184   DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:34.727 T:3002069872   DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms
2021-05-12 08:56:34.727 T:2575258480   DEBUG: Thread Timer start, auto delete: false
2021-05-12 08:56:34.741 T:3011529184   DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:34.741 T:3011529184   DEBUG: HandleKey: down (0xf081) pressed, action is Down
2021-05-12 08:56:34.799 T:2575258480   DEBUG: Thread Timer 2575258480 terminating
2021-05-12 08:56:34.807 T:3011529184   DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:34.887 T:3002069872   DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms
2021-05-12 08:56:34.887 T:2575258480   DEBUG: Thread Timer start, auto delete: false
2021-05-12 08:56:34.907 T:3011529184   DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:34.907 T:3011529184   DEBUG: HandleKey: down (0xf081) pressed, action is Down
2021-05-12 08:56:34.921 T:2550174576   DEBUG: Thread JobWorker start, auto delete: true
2021-05-12 08:56:34.923 T:2868253552   DEBUG: ffmpeg[AAF61370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
2021-05-12 08:56:34.975 T:2575258480   DEBUG: Thread Timer 2575258480 terminating
2021-05-12 08:56:35.040 T:3011529184   DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:35.239 T:3002069872   DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms
2021-05-12 08:56:35.239 T:2575258480   DEBUG: Thread Timer start, auto delete: false
2021-05-12 08:56:35.240 T:3011529184   DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:35.241 T:3011529184   DEBUG: HandleKey: right (0xf083) pressed, action is Right
2021-05-12 08:56:35.343 T:2575258480   DEBUG: Thread Timer 2575258480 terminating
2021-05-12 08:56:35.374 T:3011529184   DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:35.783 T:3002069872   DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms
2021-05-12 08:56:35.784 T:2575258480   DEBUG: Thread Timer start, auto delete: false
2021-05-12 08:56:35.788 T:3011529184   DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:35.788 T:3011529184   DEBUG: HandleKey: down (0xf081) pressed, action is Down
2021-05-12 08:56:35.823 T:2876646256   DEBUG: ffmpeg[AB762370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
2021-05-12 08:56:35.863 T:2575258480   DEBUG: Thread Timer 2575258480 terminating
2021-05-12 08:56:35.907 T:3011529184   DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:36.080 T:3002069872   DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms
2021-05-12 08:56:36.080 T:2575258480   DEBUG: Thread Timer start, auto delete: false
2021-05-12 08:56:36.107 T:3011529184   DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0
2021-05-12 08:56:36.151 T:2575258480   DEBUG: Thread Timer 2575258480 terminating
2021-05-12 08:56:36.174 T:3011529184   DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0
2021-05-12 08:56:36.174 T:3011529184   DEBUG: HandleKey: return (0xf00d) pressed, action is Select
2021-05-12 08:56:36.174 T:3011529184   DEBUG: Activating window ID: 10025
2021-05-12 08:56:36.513 T:3011529184   DEBUG: ------ Window Deinit (Home.xml) ------
2021-05-12 08:56:36.513 T:3011529184   DEBUG: FreeVisualisation() done
2021-05-12 08:56:36.545 T:3011529184   DEBUG: ------ Window Init (MyVideoNav.xml) ------
2021-05-12 08:56:36.546 T:3011529184    INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY
2021-05-12 08:56:36.757 T:3011529184   DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.ipcams/)
2021-05-12 08:56:36.757 T:3011529184   DEBUG:   ParentPath = [plugin://plugin.video.ipcams/]
2021-05-12 08:56:36.758 T:2575258480   DEBUG: Thread waiting start, auto delete: false
2021-05-12 08:56:36.770 T:2876646256   DEBUG: CAddonDatabase::SetLastUsed[plugin.video.ipcams] took 13 ms
2021-05-12 08:56:36.771 T:2575258480   DEBUG: StartScript - calling plugin Surveillance Cameras('plugin://plugin.video.ipcams/','1','','resume:false')
2021-05-12 08:56:36.771 T:2541781872   DEBUG: Thread LanguageInvoker start, auto delete: false
2021-05-12 08:56:36.771 T:2541781872    INFO: initializing python engine.
2021-05-12 08:56:36.771 T:2541781872   DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.ipcams/default.py): start processing
2021-05-12 08:56:36.789 T:2541781872   DEBUG: -->Python Interpreter Initialized<--
2021-05-12 08:56:36.789 T:2541781872   DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.ipcams/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.ipcams/default.py"
2021-05-12 08:56:36.789 T:2541781872   DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.ipcams/default.py): setting the Python path to /storage/.kodi/addons/plugin.video.ipcams:/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
2021-05-12 08:56:36.789 T:2541781872   DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.ipcams/default.py): entering source directory /storage/.kodi/addons/plugin.video.ipcams
2021-05-12 08:56:36.789 T:2541781872   DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.ipcams/default.py): instantiating addon using automatically obtained id of "plugin.video.ipcams" dependent on version 2.25.0 of the xbmc.python api
2021-05-12 08:56:36.826 T:2541781872   DEBUG: CAddonSettings[plugin.video.ipcams]: loading setting definitions
2021-05-12 08:56:36.826 T:2541781872   DEBUG: CAddonSettings[plugin.video.ipcams]: trying to load setting definitions from old format...
2021-05-12 08:56:36.827 T:2541781872   DEBUG: CAddonSettings[plugin.video.ipcams]: loading setting values
2021-05-12 08:56:36.858 T:3011529184   DEBUG: ------ Window Init (DialogBusy.xml) ------
2021-05-12 08:56:36.860 T:2541781872    INFO: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.ipcams/default.py): script successfully run
2021-05-12 08:56:36.860 T:2541781872   DEBUG: onExecutionDone(2, /storage/.kodi/addons/plugin.video.ipcams/default.py)
2021-05-12 08:56:36.860 T:2575258480   DEBUG: Thread waiting 2575258480 terminating
2021-05-12 08:56:36.882 T:2541781872    INFO: Python interpreter stopped
2021-05-12 08:56:36.882 T:2541781872   DEBUG: Thread LanguageInvoker 2541781872 terminating
2021-05-12 08:56:36.890 T:3011529184   DEBUG: ------ Window Deinit (DialogBusy.xml) ------
2021-05-12 08:56:36.893 T:2541781872   DEBUG: Thread BackgroundLoader start, auto delete: false
2021-05-12 08:56:36.903 T:2541781872   DEBUG: Thread BackgroundLoader 2541781872 terminating
2021-05-12 08:56:37.239 T:3002069872   DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms
2021-05-12 08:56:37.240 T:2541781872   DEBUG: Thread Timer start, auto delete: false
2021-05-12 08:56:37.247 T:3011529184   DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:37.247 T:3011529184   DEBUG: HandleKey: down (0xf081) pressed, action is Down
2021-05-12 08:56:37.312 T:2541781872   DEBUG: Thread Timer 2541781872 terminating
2021-05-12 08:56:37.324 T:3011529184   DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0
2021-05-12 08:56:37.456 T:3002069872   DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms
2021-05-12 08:56:37.456 T:2541781872   DEBUG: Thread Timer start, auto delete: false
2021-05-12 08:56:37.457 T:3011529184   DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0
2021-05-12 08:56:37.528 T:2541781872   DEBUG: Thread Timer 2541781872 terminating
2021-05-12 08:56:37.557 T:3011529184   DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0
2021-05-12 08:56:37.557 T:3011529184   DEBUG: HandleKey: return (0xf00d) pressed, action is Select
2021-05-12 08:56:37.569 T:3011529184   DEBUG: OnPlayMedia rtsp://USERNAME:PASSWORD@10.0.0.250:554/cam/realmonitor?channel=4&subtype=0
2021-05-12 08:56:37.592 T:3011529184   DEBUG: CPlayerCoreFactory::GetPlayers(rtsp://USERNAME:PASSWORD@10.0.0.250:554/cam/realmonitor?channel=4&subtype=0)
2021-05-12 08:56:37.592 T:3011529184   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
2021-05-12 08:56:37.592 T:3011529184   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
2021-05-12 08:56:37.592 T:3011529184   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp
2021-05-12 08:56:37.592 T:3011529184   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
2021-05-12 08:56:37.592 T:3011529184   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
2021-05-12 08:56:37.592 T:3011529184   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
2021-05-12 08:56:37.593 T:3011529184   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
2021-05-12 08:56:37.593 T:3011529184   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams
2021-05-12 08:56:37.593 T:3011529184   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp
2021-05-12 08:56:37.593 T:3011529184   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2
2021-05-12 08:56:37.593 T:3011529184   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
2021-05-12 08:56:37.593 T:3011529184   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
2021-05-12 08:56:37.593 T:3011529184   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
2021-05-12 08:56:37.593 T:3011529184   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
2021-05-12 08:56:37.593 T:3011529184   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
2021-05-12 08:56:37.593 T:3011529184   DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
2021-05-12 08:56:37.594 T:3011529184   DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer)
2021-05-12 08:56:37.594 T:3011529184   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
2021-05-12 08:56:37.594 T:3011529184   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
2021-05-12 08:56:37.594 T:3011529184   DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
2021-05-12 08:56:37.597 T:3011529184   DEBUG: CMMALPool::CMMALPool Created pool 0x2e93940 of size 26 x 0 for port vc.ril.video_decode:out:0(I420)
2021-05-12 08:56:37.608 T:3011529184   DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData
2021-05-12 08:56:37.608 T:3011529184  NOTICE: VideoPlayer::OpenFile: rtsp://USERNAME:PASSWORD@10.0.0.250:554/cam/realmonitor?channel=4&subtype=0
2021-05-12 08:56:37.608 T:3011529184   DEBUG: CMMALRenderer::CMMALRenderer
2021-05-12 08:56:37.609 T:3011529184   DEBUG: OnPlayBackStarted: CApplication::OnPlayBackStarted
2021-05-12 08:56:37.609 T:2616210288   DEBUG: Thread VideoPlayer start, auto delete: false
2021-05-12 08:56:37.609 T:2575258480   DEBUG: Thread MMALProcess start, auto delete: false
2021-05-12 08:56:37.609 T:2575258480   DEBUG: CMMALRenderer::Run - starting
2021-05-12 08:56:37.609 T:2563179376   DEBUG: Thread BackgroundLoader start, auto delete: false
2021-05-12 08:56:37.609 T:2616210288  NOTICE: Creating InputStream
2021-05-12 08:56:37.610 T:2616210288  NOTICE: Creating Demuxer
2021-05-12 08:56:37.627 T:2876646256   DEBUG: Loading settings for rtsp://USERNAME:PASSWORD@10.0.0.250:554/cam/realmonitor?channel=4&subtype=0
2021-05-12 08:56:37.636 T:2563179376   DEBUG: Thread BackgroundLoader 2563179376 terminating
2021-05-12 08:56:37.641 T:3011529184   DEBUG: CVideoGUIInfo::InitCurrentItem(rtsp://USERNAME:PASSWORD@10.0.0.250:554/cam/realmonitor?channel=4&subtype=0)
2021-05-12 08:56:37.668 T:3011529184   DEBUG: CPlayerGUIInfo::InitCurrentItem(rtsp://USERNAME:PASSWORD@10.0.0.250:554/cam/realmonitor?channel=4&subtype=0)
2021-05-12 08:56:37.675 T:3011515248   DEBUG: UPnP: Building didl for object 'rtsp://admin:Bintes2016!@10.0.0.250:554/cam/realmonitor?channel=4&subtype=0'
2021-05-12 08:56:37.768 T:3011529184   DEBUG: ------ Window Init (DialogBusy.xml) ------
2021-05-12 08:56:37.934 T:2616210288   DEBUG: Open - avformat_find_stream_info starting
2021-05-12 08:56:38.340 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] max delay reached. need to consume packet
2021-05-12 08:56:38.340 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] RTP: missed 21 packets
2021-05-12 08:56:38.340 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] max delay reached. need to consume packet
2021-05-12 08:56:38.340 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] RTP: missed 31 packets
2021-05-12 08:56:38.341 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] max delay reached. need to consume packet
2021-05-12 08:56:38.341 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] RTP: missed 28 packets
2021-05-12 08:56:38.341 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] max delay reached. need to consume packet
2021-05-12 08:56:38.341 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] RTP: missed 28 packets
2021-05-12 08:56:38.342 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] max delay reached. need to consume packet
2021-05-12 08:56:38.342 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] RTP: missed 27 packets
2021-05-12 08:56:38.342 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] max delay reached. need to consume packet
2021-05-12 08:56:38.342 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] RTP: missed 32 packets
2021-05-12 08:56:38.344 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] max delay reached. need to consume packet
2021-05-12 08:56:38.344 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] RTP: missed 9 packets
2021-05-12 08:56:38.345 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] max delay reached. need to consume packet
2021-05-12 08:56:38.345 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] RTP: missed 19 packets
2021-05-12 08:56:38.345 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] max delay reached. need to consume packet
2021-05-12 08:56:38.346 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] RTP: missed 32 packets
2021-05-12 08:56:38.346 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] max delay reached. need to consume packet
2021-05-12 08:56:38.346 T:2616210288   DEBUG: ffmpeg[9BF03370]: [rtsp] RTP: missed 31 packets
2021-05-12 08:56:39.140 T:2616210288   DEBUG: Open - av_find_stream_info finished
2021-05-12 08:56:39.140 T:2616210288    INFO: ffmpeg[9BF03370]: Input #0, rtsp, from 'rtsp://USERNAME:PASSWORD@10.0.0.250:554/cam/realmonitor?channel=4&subtype=0':
2021-05-12 08:56:39.140 T:2616210288    INFO: ffmpeg[9BF03370]:   Metadata:
2021-05-12 08:56:39.140 T:2616210288    INFO: ffmpeg[9BF03370]:     title           : Media Server
2021-05-12 08:56:39.140 T:2616210288    INFO: ffmpeg[9BF03370]:   Duration: N/A, start: 0.000000, bitrate: N/A
2021-05-12 08:56:39.141 T:2616210288    INFO: ffmpeg[9BF03370]:     Stream #0:0: Video: hevc (Main), yuvj420p(pc, bt470bg/bt470bg/smpte170m), 2592x1944, 20 fps, 20 tbr, 90k tbn, 20 tbc
2021-05-12 08:56:39.141 T:2616210288    INFO: ffmpeg[9BF03370]:     Stream #0:1: Audio: pcm_alaw, 8000 Hz, 1 channels, s16, 64 kb/s
2021-05-12 08:56:39.141 T:2616210288   DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0
2021-05-12 08:56:39.141 T:2616210288   DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1
2021-05-12 08:56:39.142 T:2616210288  NOTICE: Opening stream: 0 source: 256
2021-05-12 08:56:39.142 T:2616210288  NOTICE: Creating video codec with codec id: 173
2021-05-12 08:56:39.142 T:2616210288   ERROR: CMMALVideo::Open : Video codec unknown: ad
2021-05-12 08:56:39.143 T:2616210288  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: HEVC (High Efficiency Video Coding)
2021-05-12 08:56:39.143 T:2616210288   DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-hevc
2021-05-12 08:56:39.143 T:2616210288   DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 173
2021-05-12 08:56:39.145 T:2616210288   DEBUG: CMMALPool::CMMALPool Created pool 0x31d3480 of size 26 x 0 for port vc.ril.video_decode:out:0(I420)
2021-05-12 08:56:39.146 T:2616210288   DEBUG: CMMALPool::~CMMALPool Destroying pool 0x2e93940 for port vc.ril.video_decode:out:0(I420)
2021-05-12 08:56:39.146 T:2616210288  NOTICE: Creating video thread
2021-05-12 08:56:39.147 T:2541781872   DEBUG: Thread VideoPlayerVideo start, auto delete: false
2021-05-12 08:56:39.147 T:2541781872  NOTICE: running thread: video_thread
2021-05-12 08:56:39.147 T:2541781872   DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: 0
2021-05-12 08:56:39.147 T:2616210288  NOTICE: Opening stream: 1 source: 256
2021-05-12 08:56:39.147 T:2616210288  NOTICE: Finding audio codec for: 65543
2021-05-12 08:56:39.148 T:2616210288  NOTICE: CDVDAudioCodecFFmpeg::Open() Successful opened audio decoder pcm_alaw
2021-05-12 08:56:39.148 T:2616210288  NOTICE: Creating audio thread
2021-05-12 08:56:39.148 T:2515866480   DEBUG: Thread VideoPlayerAudio start, auto delete: false
2021-05-12 08:56:39.148 T:2515866480  NOTICE: running thread: CVideoPlayerAudio::Process()
2021-05-12 08:56:39.148 T:2515866480   DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_PAUSE: 0
2021-05-12 08:56:39.148 T:2616210288   DEBUG: CVideoPlayer::SetCaching - caching state 2
2021-05-12 08:56:39.148 T:2616210288   DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
2021-05-12 08:56:39.149 T:2616210288   DEBUG: CVideoPlayer::HandleMessages - player 2 reported state: 0
2021-05-12 08:56:39.149 T:2616210288   DEBUG: CVideoPlayer::HandleMessages - player 1 reported state: 0
2021-05-12 08:56:39.149 T:2859860848   DEBUG: OnAVChange: CApplication::OnAVChange
2021-05-12 08:56:39.149 T:2616210288   DEBUG: CVideoPlayer::SetCaching - caching state 1
2021-05-12 08:56:39.149 T:2616210288   DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
2021-05-12 08:56:39.152 T:2541781872    INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback
2021-05-12 08:56:39.159 T:2515866480   DEBUG: CDVDAudio::Pause - pausing audio stream
2021-05-12 08:56:39.159 T:2515866480   DEBUG: Previous line repeats 1 times.
2021-05-12 08:56:39.159 T:2515866480    INFO: CDVDAudioCodecFFmpeg::GetChannelMap - FFmpeg reported 1 channels, but the layout contains 0 ignoring
2021-05-12 08:56:39.159 T:2515866480  NOTICE: Creating audio stream (codec id: 65543, channels: 1, sample rate: 8000, no pass-through)
2021-05-12 08:56:39.160 T:2515866480   DEBUG: CVideoPlayerAudio:: synctype set to 0: clock feedback
2021-05-12 08:56:39.167 T:2541781872  NOTICE: CDecoder::Open - fmt:187
2021-05-12 08:56:39.167 T:2541781872   DEBUG: CDecoder::Open MMAL - source requires 1 references
2021-05-12 08:56:39.170 T:2541781872   DEBUG: CMMALPool::CMMALPool Created pool 0xa0b80f10 of size 26 x 0 for port vc.ril.video_decode:out:0(I420)
2021-05-12 08:56:39.170 T:2541781872   DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-hevc-mmal
2021-05-12 08:56:39.197 T:2979001200    INFO: CActiveAESink::OpenSink - initialize sink
2021-05-12 08:56:39.232 T:2541781872   DEBUG: CMMALPool::Configure pool:0xa0b80f10 2592x1944 (2592x1944) pix:187 size:0 fmt:SAND
2021-05-12 08:56:39.274 T:2541781872   DEBUG: ffmpeg[97808370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
2021-05-12 08:56:39.275 T:2541781872   DEBUG: CRenderManager::Configure - change configuration. 2592x1944. display: 2592x1944. framerate: 20.00.
2021-05-12 08:56:39.293 T:3011529184   DEBUG: DeleteRenderer - deleting renderer
2021-05-12 08:56:39.293 T:3011529184   DEBUG: CMMALRenderer::~CMMALRenderer
2021-05-12 08:56:39.293 T:3011529184   DEBUG: CMMALRenderer::UnInitMMAL
2021-05-12 08:56:39.293 T:2575258480   DEBUG: CMMALRenderer::Run - stopping
2021-05-12 08:56:39.293 T:2575258480   DEBUG: Thread MMALProcess 2575258480 terminating
2021-05-12 08:56:39.293 T:3011529184   DEBUG: CMMALRenderer::CMMALRenderer
2021-05-12 08:56:39.293 T:2420319088   DEBUG: Thread MMALProcess start, auto delete: false
2021-05-12 08:56:39.293 T:3011529184   DEBUG: CMMALRenderer::Configure - 2592x1944->2592x1944@20.00 flags:62 format:-1 orient:0
2021-05-12 08:56:39.293 T:2420319088   DEBUG: CMMALRenderer::Run - starting
2021-05-12 08:56:39.293 T:3011529184   DEBUG: CRenderManager::Configure - 6
2021-05-12 08:56:39.297 T:2979001200   DEBUG: CAESinkPi:Drain delay:100ms now:0ms
2021-05-12 08:56:39.297 T:2979001200   DEBUG: CAESinkPi:Deinitialize
2021-05-12 08:56:39.298 T:2420319088   DEBUG: CMMALRenderer::CheckConfigurationVout Changing Vout dimensions from 0x0 (0x0) to 2592x1944 (0x0) SAND
2021-05-12 08:56:39.298 T:2979001200   DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000
2021-05-12 08:56:39.299 T:2979001200   DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0xb0f0d308
2021-05-12 08:56:39.299 T:2979001200   DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI
2021-05-12 08:56:39.299 T:2979001200   DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:8000 framesize:8 bufsize:3200 bytes/s=64000.00 dest=PI:HDMI
2021-05-12 08:56:39.300 T:2979001200   DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008
2021-05-12 08:56:39.301 T:2979001200   DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0xb0fb4600
2021-05-12 08:56:39.302 T:2979001200   DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(3200), nBufferAlignment(16)
2021-05-12 08:56:39.302 T:2420319088   DEBUG: CMMALRenderer::SetVideoRect 0,0,2592,1944 -> 240,0,1680,1080 (o:0 v:0 d:0 i:0)
2021-05-12 08:56:39.302 T:2411926384   DEBUG: Thread MMALRenderer start, auto delete: false
2021-05-12 08:56:39.302 T:2979001200   DEBUG: CActiveAESink::OpenSink - SinkPi Initialized:
2021-05-12 08:56:39.302 T:2411926384   DEBUG: CMMALRenderer::Process - starting
2021-05-12 08:56:39.302 T:2979001200   DEBUG:   Output Device : HDMI
2021-05-12 08:56:39.303 T:2420319088   DEBUG: CMMALRenderer::SetVideoRect 0,0,2592,1944 -> 240,0,1440,1080 t:100000
2021-05-12 08:56:39.303 T:2979001200   DEBUG:   Sample Rate   : 8000
2021-05-12 08:56:39.303 T:2979001200   DEBUG:   Sample Format : AE_FMT_FLOAT
2021-05-12 08:56:39.303 T:2979001200   DEBUG:   Channel Count : 2
2021-05-12 08:56:39.303 T:2979001200   DEBUG:   Channel Layout: FL, FR
2021-05-12 08:56:39.303 T:2979001200   DEBUG:   Frames        : 400
2021-05-12 08:56:39.303 T:2979001200   DEBUG:   Frame Size    : 8
2021-05-12 08:56:39.304 T:2989278064   DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
2021-05-12 08:56:39.308 T:3011529184   DEBUG: Previous line repeats 1 times.
2021-05-12 08:56:39.308 T:3011529184   DEBUG: CMMALRenderer::RenderUpdate - vsync -1 (+1032)
2021-05-12 08:56:39.308 T:3011529184   DEBUG: CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 87
2021-05-12 08:56:39.315 T:2616210288   DEBUG: CVideoPlayer::HandleMessages - player started 2
2021-05-12 08:56:39.315 T:2868253552   DEBUG: OnAVChange: CApplication::OnAVChange
2021-05-12 08:56:39.316 T:2616210288   DEBUG: CVideoPlayer::HandleMessages - player started 1
2021-05-12 08:56:39.316 T:2616210288   DEBUG: VideoPlayer::Sync - Audio - pts: 281000.000000, cache: 320000.052452, totalcache: 699999.988079
2021-05-12 08:56:39.316 T:2868253552   DEBUG: OnAVChange: CApplication::OnAVChange
2021-05-12 08:56:39.316 T:2616210288   DEBUG: VideoPlayer::Sync - Video - pts: 18442240474082181120.000000, cache: 50000.000000, totalcache: 100000.000000
2021-05-12 08:56:39.316 T:2616210288   DEBUG: CVideoPlayer::SetCaching - caching state 0
2021-05-12 08:56:39.316 T:2616210288   DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
2021-05-12 08:56:39.317 T:2541781872   DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(-39000.052452)
2021-05-12 08:56:39.317 T:2515866480   DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(-39000.052452), level: 11, cache: 406823.811452
2021-05-12 08:56:39.317 T:2515866480   DEBUG: CDVDAudio::Resume - resume audio stream
2021-05-12 08:56:39.318 T:2550174576   DEBUG: OnAVStarted: CApplication::OnAVStarted
2021-05-12 08:56:39.321 T:2989278064   DEBUG: ActiveAE - start sync of audio stream
2021-05-12 08:56:39.325 T:3011529184   DEBUG: Activating window ID: 12005
2021-05-12 08:56:39.325 T:3011529184   DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
2021-05-12 08:56:39.325 T:3011529184   DEBUG: FreeVisualisation() done
2021-05-12 08:56:39.326 T:3011529184   DEBUG: ------ Window Init (VideoFullScreen.xml) ------
2021-05-12 08:56:39.326 T:3011529184    INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY
2021-05-12 08:56:39.329 T:3011529184   DEBUG: CMMALRenderer::SetVideoRect 0,0,2592,1944 -> 240,0,1680,1080 (o:0 v:0 d:0 i:0)
2021-05-12 08:56:39.330 T:3011529184   DEBUG: CMMALRenderer::SetVideoRect 0,0,2592,1944 -> 240,0,1440,1080 t:100000
2021-05-12 08:56:39.330 T:3011529184   DEBUG: CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 59
2021-05-12 08:56:39.339 T:2859860848   DEBUG: OnAVChange: CApplication::OnAVChange
2021-05-12 08:56:39.340 T:3011529184   DEBUG: ------ Window Deinit (DialogBusy.xml) ------
2021-05-12 08:56:39.343 T:2541781872   DEBUG: ffmpeg[97808370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
2021-05-12 08:56:39.454 T:2989278064   DEBUG: Previous line repeats 11 times.
2021-05-12 08:56:39.454 T:2989278064   DEBUG: ActiveAE::SyncStream - average error of -68.975358, start adjusting
2021-05-12 08:56:39.454 T:2989278064   DEBUG: ActiveAE::SyncStream - average error -18.975358 below threshold of 30.000000
2021-05-12 08:56:39.457 T:2541781872   DEBUG: ffmpeg[97808370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
2021-05-12 08:56:39.634 T:2541781872   DEBUG: Previous line repeats 11 times.
2021-05-12 08:56:39.634 T:2541781872  NOTICE: CDVDVideoCodecFFmpeg::CDropControl: calculated diff time: 50000
2021-05-12 08:56:39.677 T:2541781872   DEBUG: ffmpeg[97808370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
2021-05-12 08:56:40.505 T:2515866480   DEBUG: Previous line repeats 35 times.
2021-05-12 08:56:40.505 T:2515866480   DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-56505.903164, adjusted:-50000.000000
2021-05-12 08:56:40.611 T:2541781872   DEBUG: ffmpeg[97808370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
2021-05-12 08:56:42.900 T:2616210288   DEBUG: Previous line repeats 91 times.
2021-05-12 08:56:42.900 T:2616210288   DEBUG: CVideoPlayer::CheckContinuity - wrapback :1, prev:4720000.000000, curr:4679000.000000, diff:-41000.000000
2021-05-12 08:56:42.912 T:2541781872   DEBUG: ffmpeg[97808370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
2021-05-12 08:56:42.944 T:2616210288   DEBUG: Previous line repeats 1 times.
2021-05-12 08:56:42.944 T:2616210288   DEBUG: CVideoPlayer::CheckContinuity - wrapback :2, prev:4800000.000000, curr:4679000.000000, diff:-121000.000000
2021-05-12 08:56:42.946 T:2541781872   DEBUG: ffmpeg[97808370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
2021-05-12 08:56:43.748 T:2792719216   DEBUG: Previous line repeats 33 times.
2021-05-12 08:56:43.748 T:2792719216   DEBUG: CAddonSettings[script.logviewer]: loading setting definitions
2021-05-12 08:56:43.748 T:2792719216   DEBUG: CAddonSettings[script.logviewer]: trying to load setting definitions from old format...
2021-05-12 08:56:43.796 T:2541781872   DEBUG: ffmpeg[97808370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
2021-05-12 08:56:44.505 T:2515866480   DEBUG: Previous line repeats 35 times.
2021-05-12 08:56:44.505 T:2515866480   DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-65814.756817, adjusted:-50000.000000
2021-05-12 08:56:44.580 T:2541781872   DEBUG: ffmpeg[97808370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
2021-05-12 08:56:45.505 T:2515866480   DEBUG: Previous line repeats 37 times.
2021-05-12 08:56:45.506 T:2515866480   DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-40394.498312, adjusted:-50000.000000
2021-05-12 08:56:45.594 T:2541781872   DEBUG: ffmpeg[97808370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL
2021-05-12 08:56:47.025 T:3011529184   DEBUG: Previous line repeats 57 times.
2021-05-12 08:56:47.025 T:3011529184   DEBUG: CMMALRenderer::RenderUpdate - vsync 1493 (+1)
2021-05-12 08:56:47.029 T:2541781872   DEBUG: ffmpeg[97808370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL