2019-03-22 18:38:51.193 T:1899347216 NOTICE: ----------------------------------------------------------------------- 2019-03-22 18:38:51.193 T:1899347216 NOTICE: Starting Kodi (18.1 Git:20190220-5494e5ffac). Platform: Linux ARM 32-bit 2019-03-22 18:38:51.193 T:1899347216 NOTICE: Using Release Kodi x32 build (version for Raspberry Pi) 2019-03-22 18:38:51.193 T:1899347216 NOTICE: Kodi compiled 2019-02-22 by GCC 6.3.0 for Linux ARM 32-bit version 4.9.82 (264530) 2019-03-22 18:38:51.193 T:1899347216 NOTICE: Running on Raspbian GNU/Linux 9 (stretch), kernel: Linux ARM 32-bit version 4.14.98-v7+ 2019-03-22 18:38:51.193 T:1899347216 NOTICE: FFmpeg version/source: 4.0.3-Kodi 2019-03-22 18:38:51.193 T:1899347216 NOTICE: Host CPU: ARMv7 Processor rev 4 (v7l), 4 cores available 2019-03-22 18:38:51.193 T:1899347216 NOTICE: ARM Features: Neon enabled 2019-03-22 18:38:51.193 T:1899347216 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi 2019-03-22 18:38:51.193 T:1899347216 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/arm-linux-gnueabihf/kodi 2019-03-22 18:38:51.193 T:1899347216 NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/arm-linux-gnueabihf/kodi/addons 2019-03-22 18:38:51.193 T:1899347216 NOTICE: special://masterprofile/ is mapped to: /home/pi/.kodi/userdata 2019-03-22 18:38:51.194 T:1899347216 NOTICE: special://envhome/ is mapped to: /home/pi 2019-03-22 18:38:51.194 T:1899347216 NOTICE: special://home/ is mapped to: /home/pi/.kodi 2019-03-22 18:38:51.194 T:1899347216 NOTICE: special://temp/ is mapped to: /home/pi/.kodi/temp 2019-03-22 18:38:51.194 T:1899347216 NOTICE: special://logpath/ is mapped to: /home/pi/.kodi/temp 2019-03-22 18:38:51.194 T:1899347216 NOTICE: The executable running is: /usr/lib/arm-linux-gnueabihf/kodi/kodi-rbpi_v7 2019-03-22 18:38:51.194 T:1899347216 NOTICE: Local hostname: kevpi 2019-03-22 18:38:51.194 T:1899347216 NOTICE: Log File is located: /home/pi/.kodi/temp/kodi.log 2019-03-22 18:38:51.194 T:1899347216 NOTICE: ----------------------------------------------------------------------- 2019-03-22 18:38:51.194 T:1899347216 INFO: loading settings 2019-03-22 18:38:51.195 T:1899347216 NOTICE: special://profile/ is mapped to: special://masterprofile/ 2019-03-22 18:38:51.226 T:1899347216 DEBUG: CSkinSettings: no tag found 2019-03-22 18:38:51.227 T:1899347216 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml 2019-03-22 18:38:51.228 T:1899347216 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are... 720 540 30 31457280 2019-03-22 18:38:51.228 T:1899347216 WARNING: CSettingsManager: missing version attribute 2019-03-22 18:38:51.230 T:1899347216 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 2019-03-22 18:38:51.230 T:1899347216 NOTICE: Default Video Player: VideoPlayer 2019-03-22 18:38:51.230 T:1899347216 NOTICE: Default Audio Player: paplayer 2019-03-22 18:38:51.230 T:1899347216 NOTICE: Enabled debug logging due to GUI setting (2) 2019-03-22 18:38:51.230 T:1899347216 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 2019-03-22 18:38:51.239 T:1899347216 INFO: creating subdirectories 2019-03-22 18:38:51.239 T:1899347216 INFO: userdata folder: special://masterprofile/ 2019-03-22 18:38:51.239 T:1899347216 INFO: recording folder: 2019-03-22 18:38:51.239 T:1899347216 INFO: screenshots folder: 2019-03-22 18:38:51.304 T:1899347216 DEBUG: DllBcm: Using omx system library 2019-03-22 18:38:51.304 T:1889530608 DEBUG: Thread Lirc start, auto delete: false 2019-03-22 18:38:51.305 T:1889530608 INFO: Loading special://xbmc/system/Lircmap.xml 2019-03-22 18:38:51.305 T:1879044848 DEBUG: Thread libinput start, auto delete: false 2019-03-22 18:38:51.307 T:1899347216 NOTICE: Running database version Addons27 2019-03-22 18:38:51.309 T:1889530608 INFO: * Adding remote mapping for device 'mceusb' 2019-03-22 18:38:51.309 T:1889530608 INFO: * Adding remote mapping for device 'XboxDVDDongle' 2019-03-22 18:38:51.309 T:1889530608 INFO: * Adding remote mapping for device 'Microsoft_Xbox' 2019-03-22 18:38:51.309 T:1889530608 INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote' 2019-03-22 18:38:51.309 T:1889530608 INFO: * Adding remote mapping for device 'anysee' 2019-03-22 18:38:51.310 T:1889530608 INFO: * Adding remote mapping for device 'iMON-PAD' 2019-03-22 18:38:51.310 T:1889530608 INFO: * Adding remote mapping for device 'Antec_Veris_RM200' 2019-03-22 18:38:51.310 T:1889530608 INFO: * Adding remote mapping for device 'MCE_via_iMON' 2019-03-22 18:38:51.310 T:1889530608 INFO: * Adding remote mapping for device 'TwinHanRemote' 2019-03-22 18:38:51.310 T:1889530608 INFO: * Adding remote mapping for device 'linux-input-layer' 2019-03-22 18:38:51.310 T:1889530608 INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote' 2019-03-22 18:38:51.310 T:1889530608 INFO: * Adding remote mapping for device 'mediacenter' 2019-03-22 18:38:51.310 T:1889530608 INFO: * Adding remote mapping for device 'devinput' 2019-03-22 18:38:51.311 T:1889530608 INFO: * Adding remote mapping for device 'devinput-32' 2019-03-22 18:38:51.311 T:1889530608 INFO: * Adding remote mapping for device 'devinput-64' 2019-03-22 18:38:51.312 T:1889530608 DEBUG: CIRTranslator::Load - no userdata Lircmap.xml found, skipping 2019-03-22 18:38:51.317 T:1899347216 INFO: ADDON: cpluff: 'Could not read plug-in directory /home/pi/.kodi/addons: No such file or directory' 2019-03-22 18:38:51.337 T:1899347216 INFO: ADDON: cpluff: 'Could not open plug-in directory /usr/lib/arm-linux-gnueabihf/kodi/addons: No such file or directory' 2019-03-22 18:38:51.337 T:1899347216 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.' 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: audioencoder.kodi.builtin.aac v1.0.0 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: audioencoder.kodi.builtin.wma v1.0.0 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: game.controller.default v1.0.8 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: game.controller.snes v1.0.8 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: kodi.binary.global.audioengine v1.0.1 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: kodi.binary.global.filesystem v1.0.2 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: kodi.binary.global.general v1.0.3 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: kodi.binary.global.gui v5.12.0 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: kodi.binary.global.main v1.0.14 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: kodi.binary.global.network v1.0.0 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: kodi.binary.instance.audiodecoder v2.0.0 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: kodi.binary.instance.audioencoder v2.0.0 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: kodi.binary.instance.game v1.1.0 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: kodi.binary.instance.imagedecoder v2.0.0 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: kodi.binary.instance.inputstream v2.0.8 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: kodi.binary.instance.peripheral v1.3.7 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: kodi.binary.instance.pvr v5.10.3 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: kodi.binary.instance.screensaver v2.0.0 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: kodi.binary.instance.vfs v2.0.0 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: kodi.binary.instance.videocodec v1.0.1 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: kodi.binary.instance.visualization v2.0.1 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: kodi.resource v1.0.0 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: metadata.album.universal v3.1.1 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: metadata.artists.universal v4.2.1 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: metadata.common.allmusic.com v3.2.0 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: metadata.common.fanart.tv v3.6.0 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: metadata.common.imdb.com v3.1.4 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: metadata.common.musicbrainz.org v2.2.1 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: metadata.common.theaudiodb.com v2.0.1 installed 2019-03-22 18:38:51.338 T:1899347216 NOTICE: ADDON: metadata.common.themoviedb.org v3.1.9 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: metadata.local v1.0.0 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: metadata.themoviedb.org v5.1.5 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: metadata.tvshows.themoviedb.org v3.1.0 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: repository.xbmc.org v3.1.5 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: resource.images.weathericons.default v1.1.8 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: resource.language.de_de v9.0.17 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: resource.language.en_gb v2.0.1 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: resource.uisounds.kodi v1.0.0 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: screensaver.xbmc.builtin.black v1.0.32 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: screensaver.xbmc.builtin.dim v1.0.53 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: script.module.pil v1.1.7 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: script.module.pycryptodome v3.4.3 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: service.xbmc.versioncheck v0.4.6 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: skin.estouchy v2.0.22 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: skin.estuary v2.0.21 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: webinterface.default v18.x-2.4.6 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: xbmc.addon v18.1.0 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: xbmc.core v0.1.0 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: xbmc.gui v5.14.0 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: xbmc.json v10.1.2 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: xbmc.metadata v2.1.0 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: xbmc.python v2.26.0 installed 2019-03-22 18:38:51.339 T:1899347216 NOTICE: ADDON: xbmc.webinterface v1.0.0 installed 2019-03-22 18:38:51.408 T:1899347216 DEBUG: CFavourites::Load - no system favourites found, skipping 2019-03-22 18:38:51.408 T:1899347216 DEBUG: CFavourites::Load - no userdata favourites found, skipping 2019-03-22 18:38:51.411 T:1899347216 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-03-22 18:38:51.411 T:1899347216 INFO: Selected Logind/UPower as PowerSyscall 2019-03-22 18:38:51.412 T:1899347216 ERROR: DBus error: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files 2019-03-22 18:38:51.412 T:1899347216 INFO: LogindUPowerSyscall - UPower not found, battery information will not be available 2019-03-22 18:38:51.460 T:1899347216 DEBUG: LogindUPowerSyscall - inhibit lock taken, fd 17 2019-03-22 18:38:51.463 T:1899347216 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-03-22 18:38:51.463 T:1868559088 DEBUG: Thread ActiveAE start, auto delete: false 2019-03-22 18:38:51.464 T:1858073328 DEBUG: Thread AESink start, auto delete: false 2019-03-22 18:38:51.464 T:1847587568 DEBUG: Thread FDEventMonitor start, auto delete: false 2019-03-22 18:38:51.474 T:1868559088 INFO: CAESinkALSA - Unable to open device "surround71" for playback 2019-03-22 18:38:51.475 T:1868559088 INFO: CAESinkALSA - Unable to open device "surround51" for playback 2019-03-22 18:38:51.475 T:1868559088 INFO: CAESinkALSA - Unable to open device "surround71" for playback 2019-03-22 18:38:51.476 T:1868559088 INFO: CAESinkALSA - Unable to open device "surround40" for playback 2019-03-22 18:38:51.476 T:1868559088 INFO: CAESinkALSA - Unable to open device "surround51" for playback 2019-03-22 18:38:51.476 T:1868559088 INFO: CAESinkALSA - Unable to open device "surround71" for playback 2019-03-22 18:38:51.495 T:1868559088 NOTICE: Found 2 Lists of Devices 2019-03-22 18:38:51.495 T:1868559088 NOTICE: Enumerated ALSA devices: 2019-03-22 18:38:51.495 T:1868559088 NOTICE: Device 1 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_deviceName : @ 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_displayName : Default (bcm2835 ALSA bcm2835 ALSA) 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_displayNameExtra: 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_deviceType : AE_DEVTYPE_PCM 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_channels : FL, FR 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_sampleRates : 8000,11025,16000,22050,32000,44100,48000 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_dataFormats : AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_U8 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_streamTypes : No passthrough capabilities 2019-03-22 18:38:51.496 T:1868559088 NOTICE: Enumerated PI devices: 2019-03-22 18:38:51.496 T:1868559088 NOTICE: Device 1 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_deviceName : HDMI 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_displayName : HDMI 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_displayNameExtra: 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_channels : FL, FR 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_sampleRates : 8000,11025,16000,22050,24000,32000,44100,48000,88200,96000,176400,192000 2019-03-22 18:38:51.496 T:1868559088 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-03-22 18:38:51.496 T:1868559088 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-03-22 18:38:51.496 T:1868559088 NOTICE: Device 2 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_deviceName : Analogue 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_displayName : Analogue 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_displayNameExtra: 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_deviceType : AE_DEVTYPE_PCM 2019-03-22 18:38:51.496 T:1868559088 NOTICE: m_channels : FL, FR 2019-03-22 18:38:51.497 T:1868559088 NOTICE: m_sampleRates : 48000 2019-03-22 18:38:51.497 T:1868559088 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 2019-03-22 18:38:51.497 T:1868559088 NOTICE: m_streamTypes : No passthrough capabilities 2019-03-22 18:38:51.497 T:1868559088 NOTICE: Device 3 2019-03-22 18:38:51.497 T:1868559088 NOTICE: m_deviceName : Both 2019-03-22 18:38:51.497 T:1868559088 NOTICE: m_displayName : HDMI and Analogue 2019-03-22 18:38:51.497 T:1868559088 NOTICE: m_displayNameExtra: 2019-03-22 18:38:51.497 T:1868559088 NOTICE: m_deviceType : AE_DEVTYPE_PCM 2019-03-22 18:38:51.497 T:1868559088 NOTICE: m_channels : FL, FR 2019-03-22 18:38:51.497 T:1868559088 NOTICE: m_sampleRates : 48000 2019-03-22 18:38:51.497 T:1868559088 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 2019-03-22 18:38:51.497 T:1868559088 NOTICE: m_streamTypes : No passthrough capabilities 2019-03-22 18:38:51.497 T:1858073328 INFO: CActiveAESink::OpenSink - initialize sink 2019-03-22 18:38:51.497 T:1858073328 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 2019-03-22 18:38:51.497 T:1858073328 DEBUG: DllBcm: Using omx system library 2019-03-22 18:38:51.499 T:1858073328 DEBUG: SECTION:LoadDLL(libopenmaxil.so) 2019-03-22 18:38:51.500 T:1858073328 DEBUG: Loading: libopenmaxil.so 2019-03-22 18:38:51.504 T:1784652528 DEBUG: Thread CRBPWorker start, auto delete: false 2019-03-22 18:38:51.504 T:1858073328 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:8816 bytes/s=352800.00 dest=PI:HDMI 2019-03-22 18:38:51.504 T:1858073328 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 2019-03-22 18:38:51.505 T:1858073328 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x6e202218 2019-03-22 18:38:51.507 T:1858073328 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(8816), nBufferAlignment(16) 2019-03-22 18:38:51.507 T:1858073328 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 2019-03-22 18:38:51.507 T:1858073328 DEBUG: Output Device : HDMI 2019-03-22 18:38:51.507 T:1858073328 DEBUG: Sample Rate : 44100 2019-03-22 18:38:51.507 T:1858073328 DEBUG: Sample Format : AE_FMT_FLOAT 2019-03-22 18:38:51.507 T:1858073328 DEBUG: Channel Count : 2 2019-03-22 18:38:51.507 T:1858073328 DEBUG: Channel Layout: FL, FR 2019-03-22 18:38:51.507 T:1858073328 DEBUG: Frames : 1102 2019-03-22 18:38:51.507 T:1858073328 DEBUG: Frame Size : 8 2019-03-22 18:38:51.517 T:1899347216 INFO: CKeyboardLayoutManager: loading keyboard layouts from special://xbmc/system/keyboardlayouts... 2019-03-22 18:38:51.519 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian ЯВЕРТЪ" successfully loaded 2019-03-22 18:38:51.520 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian АБВ" successfully loaded 2019-03-22 18:38:51.521 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Danish QWERTY" successfully loaded 2019-03-22 18:38:51.522 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Norwegian QWERTY" successfully loaded 2019-03-22 18:38:51.523 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Spanish QWERTY" successfully loaded 2019-03-22 18:38:51.523 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Czech QWERTZ" successfully loaded 2019-03-22 18:38:51.524 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian AZERTY" successfully loaded 2019-03-22 18:38:51.525 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian QWERTY" successfully loaded 2019-03-22 18:38:51.525 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Korean ㄱㄴㄷ" successfully loaded 2019-03-22 18:38:51.526 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Hungarian QWERTZ" successfully loaded 2019-03-22 18:38:51.527 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Croatian QWERTY" successfully loaded 2019-03-22 18:38:51.528 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "French AZERTY" successfully loaded 2019-03-22 18:38:51.529 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian ЙЦУКЕН" successfully loaded 2019-03-22 18:38:51.529 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian АБВ" successfully loaded 2019-03-22 18:38:51.530 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Romanian QWERTY" successfully loaded 2019-03-22 18:38:51.531 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Thai Kedmanee" successfully loaded 2019-03-22 18:38:51.532 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Arabic QWERTY" successfully loaded 2019-03-22 18:38:51.532 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Italian QWERTY" successfully loaded 2019-03-22 18:38:51.533 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Turkish QWERTY" successfully loaded 2019-03-22 18:38:51.534 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "German QWERTZ" successfully loaded 2019-03-22 18:38:51.534 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "German ABC" successfully loaded 2019-03-22 18:38:51.535 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Polish QWERTY" successfully loaded 2019-03-22 18:38:51.536 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Swedish QWERTY" successfully loaded 2019-03-22 18:38:51.537 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian ЙЦУКЕН" successfully loaded 2019-03-22 18:38:51.537 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian АБВ" successfully loaded 2019-03-22 18:38:51.538 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew QWERTY" successfully loaded 2019-03-22 18:38:51.539 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew ABC" successfully loaded 2019-03-22 18:38:51.539 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Greek QWERTY" successfully loaded 2019-03-22 18:38:51.540 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Silesian QWERTY" successfully loaded 2019-03-22 18:38:51.541 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTZ" successfully loaded 2019-03-22 18:38:51.542 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTY" successfully loaded 2019-03-22 18:38:51.542 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak ABC" successfully loaded 2019-03-22 18:38:51.543 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovenian QWERTZ" successfully loaded 2019-03-22 18:38:51.544 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Portuguese (Portugal) QWERTY" successfully loaded 2019-03-22 18:38:51.545 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "English QWERTY" successfully loaded 2019-03-22 18:38:51.545 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "English AZERTY" successfully loaded 2019-03-22 18:38:51.545 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "English ABC" successfully loaded 2019-03-22 18:38:51.546 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Icelandic QWERTY" successfully loaded 2019-03-22 18:38:51.547 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BasePY" successfully loaded 2019-03-22 18:38:51.548 T:1899347216 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BaiduPY" successfully loaded 2019-03-22 18:38:51.549 T:1899347216 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-03-22 18:38:51.549 T:1899347216 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-03-22 18:38:51.552 T:1899347216 DEBUG: Selected UDev as storage provider 2019-03-22 18:38:51.553 T:1899347216 NOTICE: Raspberry PI firmware version: Feb 12 2019 19:46:13 Copyright (c) 2012 Broadcom version 8eff5e4023657a8b3b59e1f90dc966f62d74908c (clean) (release) (start_x) 2019-03-22 18:38:51.553 T:1899347216 NOTICE: ARM mem: 724MB GPU mem: 300MB MPG2:1 WVC1:1 2019-03-22 18:38:51.553 T:1899347216 NOTICE: cache.memorysize: 30MB libass.cache: 21MB 2019-03-22 18:38:51.553 T:1899347216 NOTICE: Config: aphy_params_current=819 arm_freq=1200 audio_pwm_mode=514 config_hdmi_boost=6 core_freq=400 desired_osc_freq=0x36ee80 disable_commandline_tags=2 disable_l2cache=1 display_hdmi_rotate=-1 display_lcd_rotate=-1 dphy_params_current=547 force_eeprom_read=1 force_pwm_open=1 framebuffer_ignore_alpha=1 framebuffer_swap=1 gpu_freq=300 hdmi_channel_map=8 hdmi_force_cec_address=65535 init_uart_clock=0x2dc6c00 lcd_framerate=60 over_voltage_avs=0x13d62 overscan_bottom=48 overscan_left=48 overscan_right=48 overscan_top=48 pause_burst_frames=1 program_serial_random=1 sdram_freq=450 2019-03-22 18:38:51.553 T:1899347216 NOTICE: Config: decode_MPG2=0x7f191ddf decode_WVC1=0x6a6c0177 device_tree=- 2019-03-22 18:38:51.553 T:1899347216 DEBUG: EGL initial desktop resolution 1920x1080 (1920x1080) @ 60.00 - Full Screen (1.00) 2019-03-22 18:38:51.554 T:1899347216 DEBUG: EGL get supported modes (2) = 19, prefer_group=1, prefer_mode=10 2019-03-22 18:38:51.554 T:1899347216 DEBUG: EGL mode 0: 640x480 (640x480) @ 60.00 - Full Screen (1.00) :4 2019-03-22 18:38:51.554 T:1899347216 DEBUG: EGL mode 1: 640x480 (640x480) @ 72.00 - Full Screen (1.00) :5 2019-03-22 18:38:51.554 T:1899347216 DEBUG: EGL mode 2: 640x480 (640x480) @ 75.00 - Full Screen (1.00) :6 2019-03-22 18:38:51.554 T:1899347216 DEBUG: EGL mode 3: 800x600 (800x600) @ 56.00 - Full Screen (1.00) :8 2019-03-22 18:38:51.554 T:1899347216 DEBUG: EGL mode 4: 800x600 (800x600) @ 60.00 - Full Screen (1.00) :9 2019-03-22 18:38:51.554 T:1899347216 DEBUG: EGL mode 5: 800x600 (800x600) @ 72.00 - Full Screen (1.00) :a 2019-03-22 18:38:51.554 T:1899347216 DEBUG: EGL mode 6: 800x600 (800x600) @ 75.00 - Full Screen (1.00) :b 2019-03-22 18:38:51.554 T:1899347216 DEBUG: EGL mode 7: 1024x768 (1024x768) @ 60.00 - Full Screen (1.00) :10 2019-03-22 18:38:51.554 T:1899347216 DEBUG: EGL mode 8: 1024x768 (1024x768) @ 70.00 - Full Screen (1.00) :11 2019-03-22 18:38:51.554 T:1899347216 DEBUG: EGL mode 9: 1024x768 (1024x768) @ 75.00 - Full Screen (1.00) :12 2019-03-22 18:38:51.554 T:1899347216 DEBUG: EGL mode 10: 1152x864 (1152x864) @ 75.00 - Full Screen (1.00) :15 2019-03-22 18:38:51.554 T:1899347216 DEBUG: EGL mode 11: 1280x960 (1280x960) @ 60.00 - Full Screen (1.00) :20 2019-03-22 18:38:51.555 T:1899347216 DEBUG: EGL mode 12: 1280x1024 (1280x1024) @ 60.00 - Full Screen (1.00) :23 2019-03-22 18:38:51.555 T:1899347216 DEBUG: EGL mode 13: 1280x1024 (1280x1024) @ 75.00 - Full Screen (1.00) :24 2019-03-22 18:38:51.555 T:1899347216 DEBUG: EGL mode 14: 1440x900 (1440x900) @ 60.00 - Full Screen (1.00) :2f 2019-03-22 18:38:51.555 T:1899347216 DEBUG: EGL mode 15: 1600x1200 (1440x1080) @ 60.00 - Full Screen (1.00) :33 2019-03-22 18:38:51.555 T:1899347216 DEBUG: EGL mode 16: 1680x1050 (1680x1050) @ 60.00 - Full Screen (1.00) :3a 2019-03-22 18:38:51.555 T:1899347216 DEBUG: EGL mode 17: 1366x768 (1366x768) @ 60.00 - Full Screen (1.00) :51 2019-03-22 18:38:51.555 T:1899347216 DEBUG: EGL mode 18: 1920x1080 (1920x1080) @ 60.00 - Full Screen (1.00) :52 2019-03-22 18:38:51.555 T:1899347216 DEBUG: EGL get supported modes (1) = 11, prefer_group=1, prefer_mode=10 2019-03-22 18:38:51.555 T:1899347216 DEBUG: EGL mode 0: 640x480 (640x480) @ 60.00 - Full Screen (1.00) :1 2019-03-22 18:38:51.555 T:1899347216 DEBUG: EGL mode 1: 720x480 (720x480) @ 60.00 - Full Screen (0.89) :2 2019-03-22 18:38:51.555 T:1899347216 DEBUG: EGL mode 2: 720x480 (720x480) @ 60.00 - Full Screen (1.19) :3 2019-03-22 18:38:51.555 T:1899347216 DEBUG: EGL mode 3: 1280x720 (1280x720) @ 60.00 - Full Screen (1.00) :4 2019-03-22 18:38:51.556 T:1899347216 DEBUG: EGL mode 4: 1920x1080 (1920x1080) @ 60.00i - Full Screen (1.00) I:5 2019-03-22 18:38:51.556 T:1899347216 DEBUG: EGL mode 5: 1920x1080 (1920x1080) @ 60.00 - Full Screen (1.00) N:10 2019-03-22 18:38:51.556 T:1899347216 DEBUG: EGL mode 6: 720x576 (720x576) @ 50.00 - Full Screen (1.07) :11 2019-03-22 18:38:51.556 T:1899347216 DEBUG: EGL mode 7: 720x576 (720x576) @ 50.00 - Full Screen (1.42) :12 2019-03-22 18:38:51.556 T:1899347216 DEBUG: EGL mode 8: 1280x720 (1280x720) @ 50.00 - Full Screen (1.00) :13 2019-03-22 18:38:51.556 T:1899347216 DEBUG: EGL mode 9: 1920x1080 (1920x1080) @ 50.00i - Full Screen (1.00) I:14 2019-03-22 18:38:51.556 T:1899347216 DEBUG: EGL mode 10: 1920x1080 (1920x1080) @ 50.00 - Full Screen (1.00) :1f 2019-03-22 18:38:51.556 T:1899347216 DEBUG: EGL probe resolution 1920x1080 (1920x1080) @ 60.00 - Full Screen:10010004 2019-03-22 18:38:51.556 T:1899347216 NOTICE: Found resolution 640 x 480 with 640 x 480 @ 60.000000 Hz 2019-03-22 18:38:51.556 T:1899347216 NOTICE: Found resolution 640 x 480 with 640 x 480 @ 59.940063 Hz 2019-03-22 18:38:51.556 T:1899347216 NOTICE: Found resolution 640 x 480 with 640 x 480 @ 72.000000 Hz 2019-03-22 18:38:51.556 T:1899347216 NOTICE: Found resolution 640 x 480 with 640 x 480 @ 71.928070 Hz 2019-03-22 18:38:51.556 T:1899347216 NOTICE: Found resolution 640 x 480 with 640 x 480 @ 75.000000 Hz 2019-03-22 18:38:51.556 T:1899347216 NOTICE: Found resolution 800 x 600 with 800 x 600 @ 56.000000 Hz 2019-03-22 18:38:51.556 T:1899347216 NOTICE: Found resolution 800 x 600 with 800 x 600 @ 60.000000 Hz 2019-03-22 18:38:51.556 T:1899347216 NOTICE: Found resolution 800 x 600 with 800 x 600 @ 59.940063 Hz 2019-03-22 18:38:51.556 T:1899347216 NOTICE: Found resolution 800 x 600 with 800 x 600 @ 72.000000 Hz 2019-03-22 18:38:51.556 T:1899347216 NOTICE: Found resolution 800 x 600 with 800 x 600 @ 71.928070 Hz 2019-03-22 18:38:51.556 T:1899347216 NOTICE: Found resolution 800 x 600 with 800 x 600 @ 75.000000 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1024 x 768 with 1024 x 768 @ 60.000000 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1024 x 768 with 1024 x 768 @ 59.940063 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1024 x 768 with 1024 x 768 @ 70.000000 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1024 x 768 with 1024 x 768 @ 75.000000 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1152 x 864 with 1152 x 864 @ 75.000000 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1280 x 960 with 1280 x 960 @ 60.000000 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1280 x 960 with 1280 x 960 @ 59.940063 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1280 x 1024 with 1280 x 1024 @ 60.000000 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1280 x 1024 with 1280 x 1024 @ 59.940063 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1280 x 1024 with 1280 x 1024 @ 75.000000 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1440 x 900 with 1440 x 900 @ 60.000000 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1440 x 900 with 1440 x 900 @ 59.940063 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1440 x 1080 with 1600 x 1200 @ 60.000000 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1440 x 1080 with 1600 x 1200 @ 59.940063 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1680 x 1050 with 1680 x 1050 @ 60.000000 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1680 x 1050 with 1680 x 1050 @ 59.940063 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1366 x 768 with 1366 x 768 @ 60.000000 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1366 x 768 with 1366 x 768 @ 59.940063 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1920 x 1080 with 1920 x 1080 @ 60.000000 Hz 2019-03-22 18:38:51.557 T:1899347216 NOTICE: Found resolution 1920 x 1080 with 1920 x 1080 @ 59.940063 Hz 2019-03-22 18:38:51.558 T:1899347216 NOTICE: Found resolution 720 x 480 with 720 x 480 @ 60.000000 Hz 2019-03-22 18:38:51.558 T:1899347216 NOTICE: Found resolution 720 x 480 with 720 x 480 @ 59.940063 Hz 2019-03-22 18:38:51.558 T:1899347216 NOTICE: Found resolution 1280 x 720 with 1280 x 720 @ 60.000000 Hz 2019-03-22 18:38:51.558 T:1899347216 NOTICE: Found resolution 1280 x 720 with 1280 x 720 @ 59.940063 Hz 2019-03-22 18:38:51.558 T:1899347216 NOTICE: Found resolution 720 x 576 with 720 x 576 @ 50.000000 Hz 2019-03-22 18:38:51.558 T:1899347216 NOTICE: Found resolution 1280 x 720 with 1280 x 720 @ 50.000000 Hz 2019-03-22 18:38:51.558 T:1899347216 NOTICE: Found resolution 1920 x 1080 with 1920 x 1080 @ 50.000000 Hz 2019-03-22 18:38:51.558 T:1899347216 NOTICE: Found (1920x1080@60.000000) at 45, setting to RES_DESKTOP at 16 2019-03-22 18:38:51.558 T:1899347216 NOTICE: EGL_VERSION = 1.4 2019-03-22 18:38:51.558 T:1899347216 NOTICE: EGL_VENDOR = Broadcom 2019-03-22 18:38:51.559 T:1899347216 NOTICE: EGL_EXTENSIONS = EGL_KHR_image EGL_KHR_image_base EGL_KHR_image_pixmap EGL_KHR_vg_parent_image EGL_KHR_gl_texture_2D_image EGL_KHR_gl_texture_cubemap_image EGL_KHR_lock_surface 2019-03-22 18:38:51.559 T:1899347216 NOTICE: EGL_CLIENT_EXTENSIONS = NULL 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL Config Attributes: 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_BUFFER_SIZE: 32 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_ALPHA_SIZE: 8 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_BLUE_SIZE: 8 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_GREEN_SIZE: 8 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_RED_SIZE: 8 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_DEPTH_SIZE: 24 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_STENCIL_SIZE: 0 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_CONFIG_CAVEAT: 0x3038 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_CONFIG_ID: 3 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_LEVEL: 0 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_MAX_PBUFFER_HEIGHT: 2048 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_MAX_PBUFFER_PIXELS: 4194304 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_MAX_PBUFFER_WIDTH: 2048 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_NATIVE_RENDERABLE: 1 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_NATIVE_VISUAL_ID: 37928 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_NATIVE_VISUAL_TYPE: 0x3038 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_SAMPLES: 0 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_SAMPLE_BUFFERS: 0 2019-03-22 18:38:51.559 T:1899347216 DEBUG: EGL_SURFACE_TYPE: 1639 2019-03-22 18:38:51.560 T:1899347216 DEBUG: EGL_TRANSPARENT_TYPE: 0x3038 2019-03-22 18:38:51.560 T:1899347216 DEBUG: EGL_TRANSPARENT_BLUE_VALUE: 0 2019-03-22 18:38:51.560 T:1899347216 DEBUG: EGL_TRANSPARENT_GREEN_VALUE: 0 2019-03-22 18:38:51.560 T:1899347216 DEBUG: EGL_TRANSPARENT_RED_VALUE: 0 2019-03-22 18:38:51.560 T:1899347216 DEBUG: EGL_BIND_TO_TEXTURE_RGB: 0 2019-03-22 18:38:51.560 T:1899347216 DEBUG: EGL_BIND_TO_TEXTURE_RGBA: 1 2019-03-22 18:38:51.560 T:1899347216 DEBUG: EGL_MIN_SWAP_INTERVAL: 0 2019-03-22 18:38:51.560 T:1899347216 DEBUG: EGL_MAX_SWAP_INTERVAL: 2147483647 2019-03-22 18:38:51.560 T:1899347216 DEBUG: EGL_LUMINANCE_SIZE: 0 2019-03-22 18:38:51.560 T:1899347216 DEBUG: EGL_ALPHA_MASK_SIZE: 0 2019-03-22 18:38:51.560 T:1899347216 DEBUG: EGL_COLOR_BUFFER_TYPE: 0x308e 2019-03-22 18:38:51.560 T:1899347216 DEBUG: EGL_RENDERABLE_TYPE: 7 2019-03-22 18:38:51.560 T:1899347216 DEBUG: EGL_CONFORMANT: 7 2019-03-22 18:38:51.561 T:1899347216 INFO: RetroPlayer[PROCESS]: Registering process control for RPi 2019-03-22 18:38:51.561 T:1899347216 INFO: RetroPlayer[RENDER]: Registering renderer factory for OpenGLES 2019-03-22 18:38:51.561 T:1899347216 NOTICE: Checking resolution 16 2019-03-22 18:38:51.635 T:1858073328 DEBUG: CAESinkPi:Drain delay:50ms now:0ms 2019-03-22 18:38:51.635 T:1858073328 DEBUG: CAESinkPi:Deinitialize 2019-03-22 18:38:51.635 T:1858073328 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 2019-03-22 18:38:51.638 T:1858073328 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x6e202218 2019-03-22 18:38:51.645 T:1899347216 DEBUG: EGL set HDMI mode (1,16)=0 off 2019-03-22 18:38:51.780 T:1818223344 DEBUG: EGL tv_service_callback (8,1,16) 2019-03-22 18:38:51.780 T:1899347216 DEBUG: EGL set resolution 1920x1080 -> 1920x1080 @ 60.00 fps (1,16) flags:10010004 aspect:1.00 2019-03-22 18:38:51.797 T:1868559088 DEBUG: CActiveAE - display reset event 2019-03-22 18:38:51.797 T:1858073328 INFO: CActiveAESink::OpenSink - initialize sink 2019-03-22 18:38:51.797 T:1858073328 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 2019-03-22 18:38:51.797 T:1858073328 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:8816 bytes/s=352800.00 dest=PI:HDMI 2019-03-22 18:38:51.798 T:1858073328 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 2019-03-22 18:38:51.799 T:1858073328 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x6e201ac8 2019-03-22 18:38:51.800 T:1858073328 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(8816), nBufferAlignment(16) 2019-03-22 18:38:51.801 T:1858073328 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 2019-03-22 18:38:51.801 T:1858073328 DEBUG: Output Device : HDMI 2019-03-22 18:38:51.801 T:1858073328 DEBUG: Sample Rate : 44100 2019-03-22 18:38:51.801 T:1858073328 DEBUG: Sample Format : AE_FMT_FLOAT 2019-03-22 18:38:51.801 T:1858073328 DEBUG: Channel Count : 2 2019-03-22 18:38:51.801 T:1858073328 DEBUG: Channel Layout: FL, FR 2019-03-22 18:38:51.801 T:1858073328 DEBUG: Frames : 1102 2019-03-22 18:38:51.801 T:1858073328 DEBUG: Frame Size : 8 2019-03-22 18:38:51.803 T:1868559088 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2019-03-22 18:38:51.809 T:1899347216 NOTICE: GL_VENDOR = Broadcom 2019-03-22 18:38:51.809 T:1899347216 NOTICE: GL_RENDERER = VideoCore IV HW 2019-03-22 18:38:51.809 T:1899347216 NOTICE: GL_VERSION = OpenGL ES 2.0 2019-03-22 18:38:51.809 T:1899347216 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 2019-03-22 18:38:51.809 T:1899347216 NOTICE: GL_EXTENSIONS = GL_OES_compressed_ETC1_RGB8_texture GL_OES_compressed_paletted_texture GL_OES_texture_npot GL_OES_depth24 GL_OES_vertex_half_float GL_OES_EGL_image GL_OES_EGL_image_external GL_EXT_discard_framebuffer GL_OES_rgb8_rgba8 GL_OES_depth32 GL_OES_mapbuffer GL_EXT_texture_format_BGRA8888 GL_APPLE_rgb_422 GL_EXT_debug_marker 2019-03-22 18:38:51.810 T:1899347216 DEBUG: GL: Vertex Shader compilation log: 2019-03-22 18:38:51.810 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.811 T:1899347216 DEBUG: GL: Pixel Shader compilation log: 2019-03-22 18:38:51.811 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.823 T:1899347216 DEBUG: GL: Vertex Shader compilation log: 2019-03-22 18:38:51.823 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.824 T:1899347216 DEBUG: GL: Pixel Shader compilation log: 2019-03-22 18:38:51.824 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.838 T:1899347216 DEBUG: GL: Vertex Shader compilation log: 2019-03-22 18:38:51.838 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.839 T:1899347216 DEBUG: GL: Pixel Shader compilation log: 2019-03-22 18:38:51.839 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.853 T:1899347216 DEBUG: GL: Vertex Shader compilation log: 2019-03-22 18:38:51.853 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.854 T:1899347216 DEBUG: GL: Pixel Shader compilation log: 2019-03-22 18:38:51.854 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.868 T:1899347216 DEBUG: GL: Vertex Shader compilation log: 2019-03-22 18:38:51.868 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.869 T:1899347216 DEBUG: GL: Pixel Shader compilation log: 2019-03-22 18:38:51.869 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.883 T:1899347216 DEBUG: GL: Vertex Shader compilation log: 2019-03-22 18:38:51.883 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.883 T:1899347216 DEBUG: GL: Pixel Shader compilation log: 2019-03-22 18:38:51.883 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.898 T:1899347216 DEBUG: GL: Vertex Shader compilation log: 2019-03-22 18:38:51.898 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.899 T:1899347216 DEBUG: GL: Pixel Shader compilation log: 2019-03-22 18:38:51.899 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.914 T:1899347216 DEBUG: GL: Vertex Shader compilation log: 2019-03-22 18:38:51.914 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.914 T:1899347216 DEBUG: GL: Pixel Shader compilation log: 2019-03-22 18:38:51.914 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.928 T:1899347216 DEBUG: GL: Vertex Shader compilation log: 2019-03-22 18:38:51.928 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.929 T:1899347216 DEBUG: GL: Pixel Shader compilation log: 2019-03-22 18:38:51.929 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.947 T:1899347216 DEBUG: GL: Vertex Shader compilation log: 2019-03-22 18:38:51.947 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.947 T:1899347216 DEBUG: GL: Pixel Shader compilation log: 2019-03-22 18:38:51.947 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.963 T:1899347216 DEBUG: GL: Vertex Shader compilation log: 2019-03-22 18:38:51.963 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:51.964 T:1899347216 DEBUG: GL: Pixel Shader compilation log: 2019-03-22 18:38:51.964 T:1899347216 DEBUG: Compiled 2019-03-22 18:38:52.054 T:1858073328 DEBUG: CAESinkPi:Drain delay:49ms now:0ms 2019-03-22 18:38:52.054 T:1858073328 DEBUG: CAESinkPi:Deinitialize 2019-03-22 18:38:52.056 T:1858073328 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 2019-03-22 18:38:52.061 T:1858073328 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x6e201ac8 2019-03-22 18:38:52.072 T:1899347216 DEBUG: EGL set HDMI mode (1,16)=0 off 2019-03-22 18:38:52.215 T:1818223344 DEBUG: EGL tv_service_callback (8,1,16) 2019-03-22 18:38:52.215 T:1899347216 DEBUG: EGL set resolution 1920x1080 -> 1920x1080 @ 60.00 fps (1,16) flags:10010004 aspect:1.00 2019-03-22 18:38:52.231 T:1868559088 DEBUG: CActiveAE - display reset event 2019-03-22 18:38:52.232 T:1858073328 INFO: CActiveAESink::OpenSink - initialize sink 2019-03-22 18:38:52.232 T:1858073328 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 2019-03-22 18:38:52.232 T:1858073328 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:8816 bytes/s=352800.00 dest=PI:HDMI 2019-03-22 18:38:52.232 T:1858073328 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 2019-03-22 18:38:52.234 T:1858073328 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x6e201ac8 2019-03-22 18:38:52.236 T:1858073328 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(8816), nBufferAlignment(16) 2019-03-22 18:38:52.236 T:1858073328 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 2019-03-22 18:38:52.237 T:1858073328 DEBUG: Output Device : HDMI 2019-03-22 18:38:52.237 T:1858073328 DEBUG: Sample Rate : 44100 2019-03-22 18:38:52.237 T:1858073328 DEBUG: Sample Format : AE_FMT_FLOAT 2019-03-22 18:38:52.237 T:1858073328 DEBUG: Channel Count : 2 2019-03-22 18:38:52.237 T:1858073328 DEBUG: Channel Layout: FL, FR 2019-03-22 18:38:52.237 T:1858073328 DEBUG: Frames : 1102 2019-03-22 18:38:52.237 T:1858073328 DEBUG: Frame Size : 8 2019-03-22 18:38:52.240 T:1868559088 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2019-03-22 18:38:52.244 T:1899347216 INFO: GLES: Maximum texture width: 2048 2019-03-22 18:38:52.245 T:1899347216 DEBUG: guilib: Fill viewport on change for solving rendering passes 2019-03-22 18:38:52.866 T:1899347216 INFO: GLES: Enabling VSYNC 2019-03-22 18:38:52.866 T:1899347216 INFO: load keymapping 2019-03-22 18:38:52.870 T:1899347216 INFO: Loading special://xbmc/system/keymaps/appcommand.xml 2019-03-22 18:38:52.871 T:1899347216 INFO: Loading special://xbmc/system/keymaps/customcontroller.AppleRemote.xml 2019-03-22 18:38:52.873 T:1899347216 INFO: Loading special://xbmc/system/keymaps/customcontroller.Harmony.xml 2019-03-22 18:38:52.877 T:1899347216 INFO: Loading special://xbmc/system/keymaps/gamepad.xml 2019-03-22 18:38:52.880 T:1899347216 INFO: Loading special://xbmc/system/keymaps/joystick.xml 2019-03-22 18:38:52.884 T:1899347216 INFO: Loading special://xbmc/system/keymaps/keyboard.xml 2019-03-22 18:38:52.894 T:1899347216 INFO: Loading special://xbmc/system/keymaps/mouse.xml 2019-03-22 18:38:52.895 T:1899347216 INFO: Loading special://xbmc/system/keymaps/remote.xml 2019-03-22 18:38:52.902 T:1899347216 INFO: Loading special://xbmc/system/keymaps/touchscreen.xml 2019-03-22 18:38:52.905 T:1899347216 INFO: GUI format 1920x1080, Display 1920x1080 (1920x1080) @ 60.00 - Full Screen 2019-03-22 18:38:52.905 T:1899347216 INFO: CLangInfo: loading resource.language.de_de language information... 2019-03-22 18:38:52.906 T:1899347216 DEBUG: trying to set locale to de_DE.UTF-8 2019-03-22 18:38:52.908 T:1899347216 INFO: global locale set to C 2019-03-22 18:38:52.908 T:1899347216 INFO: CLangInfo: loading resource.language.de_de language strings... 2019-03-22 18:38:52.961 T:1899347216 DEBUG: LocalizeStrings: loaded 4000 strings from file resource://resource.language.de_de/strings.po 2019-03-22 18:38:52.991 T:1899347216 DEBUG: POParser: id:16313 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead 2019-03-22 18:38:53.006 T:1899347216 DEBUG: LocalizeStrings: loaded 18 strings from file resource://resource.language.en_gb/strings.po 2019-03-22 18:38:53.018 T:1899347216 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.kodi.builtin.aac/resources/language/English/strings.po 2019-03-22 18:38:53.020 T:1899347216 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.kodi.builtin.wma/resources/language/English/strings.po 2019-03-22 18:38:53.021 T:1899347216 DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/game.controller.default/resources/language/resource.language.en_gb/strings.po 2019-03-22 18:38:53.022 T:1899347216 DEBUG: LocalizeStrings: loaded 13 strings from file /usr/share/kodi/addons/game.controller.snes/resources/language/resource.language.en_gb/strings.po 2019-03-22 18:38:53.023 T:1899347216 DEBUG: LocalizeStrings: loaded 11 strings from file /usr/share/kodi/addons/metadata.album.universal/resources/language/German/strings.po 2019-03-22 18:38:53.024 T:1899347216 DEBUG: LocalizeStrings: loaded 6 strings from file /usr/share/kodi/addons/metadata.album.universal/resources/language/English/strings.po 2019-03-22 18:38:53.025 T:1899347216 DEBUG: LocalizeStrings: loaded 23 strings from file /usr/share/kodi/addons/metadata.artists.universal/resources/language/German/strings.po 2019-03-22 18:38:53.026 T:1899347216 DEBUG: LocalizeStrings: loaded 9 strings from file /usr/share/kodi/addons/metadata.artists.universal/resources/language/English/strings.po 2019-03-22 18:38:53.035 T:1899347216 DEBUG: LocalizeStrings: loaded 7 strings from file /home/pi/.kodi/addons/metadata.themoviedb.org/resources/language/resource.language.de_de/strings.po 2019-03-22 18:38:53.035 T:1899347216 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-03-22 18:38:53.035 T:1899347216 DEBUG: LocalizeStrings: loaded 2 strings from file /home/pi/.kodi/addons/metadata.themoviedb.org/resources/language/resource.language.en_gb/strings.po 2019-03-22 18:38:53.036 T:1899347216 DEBUG: LocalizeStrings: loaded 3 strings from file /home/pi/.kodi/addons/metadata.tvshows.themoviedb.org/resources/language/German/strings.po 2019-03-22 18:38:53.037 T:1899347216 DEBUG: LocalizeStrings: loaded 2 strings from file /home/pi/.kodi/addons/metadata.tvshows.themoviedb.org/resources/language/English/strings.po 2019-03-22 18:38:53.044 T:1899347216 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.de_de/strings.po 2019-03-22 18:38:53.044 T:1899347216 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.en_gb/strings.po 2019-03-22 18:38:53.047 T:1899347216 DEBUG: LocalizeStrings: loaded 21 strings from file /home/pi/.kodi/addons/service.xbmc.versioncheck/resources/language/German/strings.po 2019-03-22 18:38:53.049 T:1899347216 DEBUG: LocalizeStrings: loaded 3 strings from file /home/pi/.kodi/addons/service.xbmc.versioncheck/resources/language/English/strings.po 2019-03-22 18:38:53.054 T:1774576368 DEBUG: Thread JobWorker start, auto delete: true 2019-03-22 18:38:53.055 T:1774576368 DEBUG: Initialize, updating databases... 2019-03-22 18:38:53.057 T:1774576368 NOTICE: Running database version Addons27 2019-03-22 18:38:53.059 T:1774576368 NOTICE: Running database version ViewModes6 2019-03-22 18:38:53.062 T:1774576368 NOTICE: Running database version Textures13 2019-03-22 18:38:53.068 T:1774576368 NOTICE: Running database version MyMusic72 2019-03-22 18:38:53.077 T:1774576368 NOTICE: Running database version MyVideos116 2019-03-22 18:38:53.080 T:1774576368 NOTICE: Running database version TV32 2019-03-22 18:38:53.083 T:1774576368 NOTICE: Running database version Epg12 2019-03-22 18:38:53.083 T:1774576368 DEBUG: Initialize, updating databases... DONE 2019-03-22 18:38:53.084 T:1899347216 NOTICE: start dvd mediatype detection 2019-03-22 18:38:53.084 T:1890726640 DEBUG: Thread DetectDVDMedia start, auto delete: false 2019-03-22 18:38:53.084 T:1890726640 DEBUG: Compiled with libcdio Version 0.83 2019-03-22 18:38:53.084 T:1899347216 INFO: DPMS: not supported on this platform 2019-03-22 18:38:53.087 T:1890726640 DEBUG: Thread DetectDVDMedia 1890726640 terminating 2019-03-22 18:38:53.144 T:1899332336 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 2019-03-22 18:38:53.144 T:1899332336 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 2019-03-22 18:38:53.162 T:1899347216 INFO: Unloading old skin ... 2019-03-22 18:38:53.164 T:1899347216 NOTICE: load skin from: /usr/share/kodi/addons/skin.estuary (version: 2.0.21) 2019-03-22 18:38:53.164 T:1899347216 INFO: load fonts for skin... 2019-03-22 18:38:53.167 T:1899347216 INFO: Loading skin includes from /usr/share/kodi/addons/skin.estuary/xml/Includes.xml 2019-03-22 18:38:53.259 T:1899347216 INFO: Loading fonts from /usr/share/kodi/addons/skin.estuary/xml/Font.xml 2019-03-22 18:38:53.291 T:1899347216 DEBUG: LocalizeStrings: loaded 139 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.de_de/strings.po 2019-03-22 18:38:53.293 T:1899347216 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.en_gb/strings.po 2019-03-22 18:38:53.293 T:1899347216 INFO: load new skin... 2019-03-22 18:38:53.293 T:1899347216 INFO: Loading custom window XMLs from skin path /usr/share/kodi/addons/skin.estuary/xml 2019-03-22 18:38:53.306 T:1899347216 DEBUG: Load Skin XML: 12.68ms 2019-03-22 18:38:53.306 T:1899347216 INFO: initialize new skin... 2019-03-22 18:38:53.306 T:1899347216 DEBUG: guilib: Fill viewport on change for solving rendering passes 2019-03-22 18:38:53.306 T:1899347216 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT 2019-03-22 18:38:53.316 T:1899347216 DEBUG: OpenBundle - Opened bundle /usr/share/kodi/addons/skin.estuary/media/Textures.xbt 2019-03-22 18:38:53.316 T:1899347216 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT 2019-03-22 18:38:53.318 T:1899347216 INFO: Loading skin file: VideoOSD.xml, load type: LOAD_ON_GUI_INIT 2019-03-22 18:38:53.339 T:1899347216 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT 2019-03-22 18:38:53.366 T:1899347216 INFO: Loading skin file: DialogSettings.xml, load type: LOAD_ON_GUI_INIT 2019-03-22 18:38:53.376 T:1899347216 INFO: Loading skin file: DialogPVRChannelGuide.xml, load type: LOAD_ON_GUI_INIT 2019-03-22 18:38:53.383 T:1899347216 INFO: Loading skin file: DialogNotification.xml, load type: LOAD_ON_GUI_INIT 2019-03-22 18:38:53.385 T:1899347216 INFO: Loading skin file: Custom_1109_TopBarOverlay.xml, load type: LOAD_ON_GUI_INIT 2019-03-22 18:38:53.391 T:1899347216 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT 2019-03-22 18:38:53.394 T:1899347216 INFO: Loading skin file: DialogSettings.xml, load type: LOAD_ON_GUI_INIT 2019-03-22 18:38:53.402 T:1899347216 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT 2019-03-22 18:38:53.406 T:1899347216 INFO: Previous line repeats 1 times. 2019-03-22 18:38:53.407 T:1899347216 INFO: Loading skin file: DialogPVRChannelsOSD.xml, load type: LOAD_ON_GUI_INIT 2019-03-22 18:38:53.415 T:1899347216 INFO: Loading skin file: DialogSubtitles.xml, load type: LOAD_ON_GUI_INIT 2019-03-22 18:38:53.428 T:1899347216 INFO: Loading resource://resource.uisounds.kodi/sounds.xml 2019-03-22 18:38:53.519 T:1899347216 INFO: skin loaded... 2019-03-22 18:38:53.519 T:1899347216 DEBUG: Activating window ID: 12997 2019-03-22 18:38:53.519 T:1899347216 DEBUG: ------ Window Init () ------ 2019-03-22 18:38:53.519 T:1899347216 DEBUG: Activating window ID: 12999 2019-03-22 18:38:53.519 T:1899347216 DEBUG: ------ Window Init (Startup.xml) ------ 2019-03-22 18:38:53.520 T:1899347216 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME 2019-03-22 18:38:53.520 T:1899347216 DEBUG: Activating window ID: 10000 2019-03-22 18:38:53.520 T:1899347216 DEBUG: ------ Window Deinit (Startup.xml) ------ 2019-03-22 18:38:53.520 T:1899347216 DEBUG: ------ Window Init (Home.xml) ------ 2019-03-22 18:38:53.520 T:1899347216 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY 2019-03-22 18:38:53.715 T:1899347216 DEBUG: CDirectoryProvider[library://video/tvshows/]: refreshing.. 2019-03-22 18:38:53.715 T:1899347216 DEBUG: CDirectoryProvider[videodb://inprogresstvshows]: refreshing.. 2019-03-22 18:38:53.716 T:1899347216 DEBUG: CDirectoryProvider[special://skin/playlists/recent_unwatched_episodes.xsp]: refreshing.. 2019-03-22 18:38:53.716 T:1899347216 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_tvshows.xsp]: refreshing.. 2019-03-22 18:38:53.716 T:1899347216 DEBUG: CDirectoryProvider[videodb://tvshows/genres/]: refreshing.. 2019-03-22 18:38:53.716 T:1899347216 DEBUG: CDirectoryProvider[videodb://tvshows/studios/]: refreshing.. 2019-03-22 18:38:53.716 T:1899347216 DEBUG: CDirectoryProvider[addons://]: refreshing.. 2019-03-22 18:38:53.716 T:1899347216 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 2019-03-22 18:38:53.717 T:1899347216 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 2019-03-22 18:38:53.717 T:1899347216 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing.. 2019-03-22 18:38:53.717 T:1899347216 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 2019-03-22 18:38:53.717 T:1899347216 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 2019-03-22 18:38:53.717 T:1899347216 DEBUG: CDirectoryProvider[library://video/]: refreshing.. 2019-03-22 18:38:53.717 T:1899347216 DEBUG: CDirectoryProvider[sources://video/]: refreshing.. 2019-03-22 18:38:53.717 T:1899347216 DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing.. 2019-03-22 18:38:53.717 T:1899347216 DEBUG: CDirectoryProvider[favourites://]: refreshing.. 2019-03-22 18:38:53.717 T:1899347216 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing.. 2019-03-22 18:38:53.719 T:1762632432 DEBUG: Thread JobWorker start, auto delete: true 2019-03-22 18:38:53.759 T:1899347216 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting 2019-03-22 18:38:53.760 T:1899347216 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 2019-03-22 18:38:53.760 T:1899347216 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting") 2019-03-22 18:38:53.761 T:1899347216 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting 2019-03-22 18:38:53.822 T:1899347216 INFO: JSONRPC v10.1.2: Successfully initialized 2019-03-22 18:38:53.824 T:1899347216 DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid" 2019-03-22 18:38:53.825 T:1899347216 DEBUG: LoadMappings - loaded node "CEC Adapter" 2019-03-22 18:38:53.825 T:1899347216 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter" 2019-03-22 18:38:53.825 T:1899347216 DEBUG: LoadMappings - loaded node "iMON HID device" 2019-03-22 18:38:53.825 T:1899347216 DEBUG: LoadMappings - loaded node "WETEK Play remote" 2019-03-22 18:38:53.825 T:1899347216 DEBUG: LoadMappings - loaded node "" 2019-03-22 18:38:53.826 T:1899347216 DEBUG: CPeripheralBusUSB - initialised udev monitor 2019-03-22 18:38:53.827 T:1739580144 DEBUG: Thread PeripBusUSBUdev start, auto delete: false 2019-03-22 18:38:53.831 T:1731187440 DEBUG: Thread PeripBusCEC start, auto delete: false 2019-03-22 18:38:53.835 T:1722794736 DEBUG: Thread PeripBusAddon start, auto delete: false 2019-03-22 18:38:53.912 T:1899347216 DEBUG: Initialise - initialised peripheral on 'keyboard' with 1 features and 0 sub devices 2019-03-22 18:38:53.912 T:1899347216 NOTICE: Register - new keyboard device registered on application->keyboard: Tastatur (0000:0000) 2019-03-22 18:38:53.912 T:1899347216 DEBUG: Initialise - initialised peripheral on 'mouse' with 1 features and 0 sub devices 2019-03-22 18:38:53.913 T:1899347216 NOTICE: Register - new mouse device registered on application->mouse: Maus (0000:0000) 2019-03-22 18:38:53.913 T:1708126960 DEBUG: Thread PeripEventScanner start, auto delete: false 2019-03-22 18:38:53.919 T:1899347216 DEBUG: ContextMenuManager: addon menus reloaded. 2019-03-22 18:38:53.920 T:1899347216 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 2019-03-22 18:38:53.920 T:1699734256 DEBUG: Thread JobWorker start, auto delete: true 2019-03-22 18:38:53.921 T:1899347216 DEBUG: CPlayerCoreConfig::: created player VideoPlayer 2019-03-22 18:38:53.921 T:1899347216 DEBUG: CPlayerCoreConfig::: created player PAPlayer 2019-03-22 18:38:53.921 T:1899347216 DEBUG: CPlayerCoreConfig::: created player RetroPlayer 2019-03-22 18:38:53.921 T:1899347216 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules 2019-03-22 18:38:53.921 T:1899347216 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mms/udp 2019-03-22 18:38:53.922 T:1899347216 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout 2019-03-22 18:38:53.922 T:1899347216 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp 2019-03-22 18:38:53.922 T:1899347216 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp 2019-03-22 18:38:53.922 T:1899347216 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams 2019-03-22 18:38:53.922 T:1899347216 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp 2019-03-22 18:38:53.922 T:1899347216 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2 2019-03-22 18:38:53.922 T:1899347216 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd 2019-03-22 18:38:53.922 T:1899347216 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage 2019-03-22 18:38:53.922 T:1899347216 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf 2019-03-22 18:38:53.922 T:1899347216 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv 2019-03-22 18:38:53.922 T:1899347216 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio 2019-03-22 18:38:53.922 T:1899347216 NOTICE: Loaded playercorefactory configuration 2019-03-22 18:38:53.923 T:1899347216 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 2019-03-22 18:38:53.923 T:1899347216 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 2019-03-22 18:38:53.923 T:1899347216 INFO: removing tempfiles 2019-03-22 18:38:53.924 T:1899347216 NOTICE: UpdateLibraries: Starting video library startup scan 2019-03-22 18:38:53.943 T:1899347216 DEBUG: CRepositoryUpdater: previous update at 22.03.2019 16:37:54, next at 23.03.2019 16:37:54 2019-03-22 18:38:53.944 T:1691341552 DEBUG: Thread Timer start, auto delete: false 2019-03-22 18:38:53.949 T:1899347216 DEBUG: CServiceAddonManager: starting service.xbmc.versioncheck 2019-03-22 18:38:53.961 T:1682948848 DEBUG: Thread LanguageInvoker start, auto delete: false 2019-03-22 18:38:53.962 T:1899347216 NOTICE: initialize done 2019-03-22 18:38:53.962 T:1682948848 INFO: initializing python engine. 2019-03-22 18:38:53.962 T:1899347216 NOTICE: Running the application... 2019-03-22 18:38:53.962 T:1899332336 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 2019-03-22 18:38:53.963 T:1899332336 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 2019-03-22 18:38:53.965 T:1899347216 DEBUG: no profile autoexec.py (/home/pi/.kodi/userdata/autoexec.py) found, skipping 2019-03-22 18:38:53.965 T:1899347216 DEBUG: NetworkMessage - Starting network services 2019-03-22 18:38:53.976 T:1899347216 DEBUG: CZeroconfAvahi::clientCallback: client is up and running 2019-03-22 18:38:53.977 T:1899347216 NOTICE: starting zeroconf publishing 2019-03-22 18:38:53.979 T:1899347216 NOTICE: CWebServer[2792]: Started 2019-03-22 18:38:53.979 T:1899347216 NOTICE: starting upnp client 2019-03-22 18:38:53.987 T:1899347216 NOTICE: starting upnp server 2019-03-22 18:38:54.000 T:1899347216 NOTICE: starting upnp renderer 2019-03-22 18:38:54.021 T:1540272880 DEBUG: Thread EventServer start, auto delete: false 2019-03-22 18:38:54.021 T:1899347216 ERROR: JSONRPC Server: Failed to connect to sdpd 2019-03-22 18:38:54.022 T:1540272880 NOTICE: ES: Starting UDP Event server on port 9777 2019-03-22 18:38:54.023 T:1899347216 INFO: JSONRPC Server: Successfully initialized 2019-03-22 18:38:54.024 T:1531880176 DEBUG: Thread TCPServer start, auto delete: false 2019-03-22 18:38:54.027 T:1899347216 DEBUG: CPlayerCoreFactory::GetPlayers(/var/run/lirc/lircd) 2019-03-22 18:38:54.027 T:1540272880 NOTICE: UDP: Listening on port 9777 (ipv6 : true) 2019-03-22 18:38:54.028 T:1899347216 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 2019-03-22 18:38:54.028 T:1899347216 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 2019-03-22 18:38:54.028 T:1899347216 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 2019-03-22 18:38:54.028 T:1899347216 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 2019-03-22 18:38:54.028 T:1899347216 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 2019-03-22 18:38:54.028 T:1899347216 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 2019-03-22 18:38:54.028 T:1899347216 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 2019-03-22 18:38:54.028 T:1899347216 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 2019-03-22 18:38:54.028 T:1899347216 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 2019-03-22 18:38:54.028 T:1899347216 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 2019-03-22 18:38:54.028 T:1899347216 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 2019-03-22 18:38:54.028 T:1899347216 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 2019-03-22 18:38:54.028 T:1899347216 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 2019-03-22 18:38:54.028 T:1899347216 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 2019-03-22 18:38:54.028 T:1899347216 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 2019-03-22 18:38:54.029 T:1899347216 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 2019-03-22 18:38:54.029 T:1899347216 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 2019-03-22 18:38:54.035 T:1899347216 DEBUG: CMMALPool::CMMALPool Created pool 0x34a01f0 of size 26 x 0 for port vc.ril.video_decode:out:0(I420) 2019-03-22 18:38:54.049 T:1899347216 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 2019-03-22 18:38:54.049 T:1899347216 NOTICE: VideoPlayer::OpenFile: /var/run/lirc/lircd 2019-03-22 18:38:54.049 T:1899347216 DEBUG: CMMALRenderer::CMMALRenderer 2019-03-22 18:38:54.050 T:1899347216 DEBUG: OnPlayBackStarted: CApplication::OnPlayBackStarted 2019-03-22 18:38:54.056 T:1496302320 DEBUG: Thread MMALProcess start, auto delete: false 2019-03-22 18:38:54.056 T:1496302320 DEBUG: CMMALRenderer::Run - starting 2019-03-22 18:38:54.057 T:1487909616 DEBUG: Thread VideoPlayer start, auto delete: false 2019-03-22 18:38:54.058 T:1487909616 NOTICE: Creating InputStream 2019-03-22 18:38:54.059 T:1487909616 ERROR: CVideoPlayer::OpenInputStream - error opening [/var/run/lirc/lircd] 2019-03-22 18:38:54.061 T:1487909616 NOTICE: CVideoPlayer::OnExit() 2019-03-22 18:38:54.067 T:1445946096 DEBUG: Thread JobWorker start, auto delete: true 2019-03-22 18:38:54.068 T:1899347216 DEBUG: ClampLimits: 0x0 1920x1080 -> 1280x720 clamped=1 2019-03-22 18:38:54.071 T:1487909616 DEBUG: Thread VideoPlayer 1487909616 terminating 2019-03-22 18:38:54.073 T:1858073328 INFO: CActiveAESink::OpenSink - initialize sink 2019-03-22 18:38:54.081 T:1899347216 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x34ac7d0 2019-03-22 18:38:54.083 T:1899347216 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(314128), nBufferAlignment(16) 2019-03-22 18:38:54.089 T:1899347216 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x34bab50 2019-03-22 18:38:54.092 T:1899347216 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x349d428 2019-03-22 18:38:54.093 T:1899347216 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 2019-03-22 18:38:54.123 T:1858073328 DEBUG: CAESinkPi:Drain delay:43ms now:0ms 2019-03-22 18:38:54.123 T:1858073328 DEBUG: CAESinkPi:Deinitialize 2019-03-22 18:38:54.124 T:1858073328 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 2019-03-22 18:38:54.138 T:1858073328 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x6e201ac8 2019-03-22 18:38:54.138 T:1858073328 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 2019-03-22 18:38:54.139 T:1858073328 DEBUG: CAESinkPi:Initialize Format:2 Channels:2 Samplerate:16000 framesize:4 bufsize:1600 bytes/s=64000.00 dest=PI:HDMI 2019-03-22 18:38:54.139 T:1858073328 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 2019-03-22 18:38:54.139 T:1858073328 DEBUG: Output Device : HDMI 2019-03-22 18:38:54.139 T:1858073328 DEBUG: Sample Rate : 16000 2019-03-22 18:38:54.139 T:1858073328 DEBUG: Sample Format : AE_FMT_S16NE 2019-03-22 18:38:54.139 T:1858073328 DEBUG: Channel Count : 2 2019-03-22 18:38:54.139 T:1858073328 DEBUG: Channel Layout: RAW, RAW 2019-03-22 18:38:54.139 T:1858073328 DEBUG: Frames : 400 2019-03-22 18:38:54.139 T:1858073328 DEBUG: Frame Size : 4 2019-03-22 18:38:54.148 T:1868559088 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2019-03-22 18:38:54.153 T:1445946096 DEBUG: Previous line repeats 1 times. 2019-03-22 18:38:54.153 T:1445946096 DEBUG: Loading settings for /var/run/lirc/lircd 2019-03-22 18:38:54.177 T:1699734256 DEBUG: CAddonMgr::GetAvailableUpdates took 81 ms 2019-03-22 18:38:54.191 T:1445946096 DEBUG: OnPlayBackStopped: CApplication::OnPlayBackStopped 2019-03-22 18:38:54.192 T:1899332336 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 2019-03-22 18:38:54.192 T:1899332336 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 2019-03-22 18:38:54.227 T:1731187440 DEBUG: GetMappingForDevice - device (2708:1001) mapped to CEC Adapter (type = cec) 2019-03-22 18:38:54.227 T:1445946096 DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3a%2f%2fprofile%2fplaylists%2fvideo/special%3a%2f%2fprofile%2fplaylists%2fmixed/) 2019-03-22 18:38:54.228 T:1445946096 DEBUG: Getting Directory (special://profile/playlists/video) 2019-03-22 18:38:54.229 T:1731187440 DEBUG: InitialiseFeature - using libCEC v4.0.4 2019-03-22 18:38:54.229 T:1731187440 DEBUG: Initialise - initialised peripheral on 'RPI' with 2 features and 0 sub devices 2019-03-22 18:38:54.229 T:1731187440 NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001) 2019-03-22 18:38:54.229 T:1731187440 DEBUG: Thread PeripBusCEC 1731187440 terminating 2019-03-22 18:38:54.229 T:1311761136 DEBUG: Thread CECAdapter start, auto delete: false 2019-03-22 18:38:54.229 T:1311761136 DEBUG: OpenConnection - opening a connection to the CEC adapter: RPI 2019-03-22 18:38:54.231 T:1445946096 DEBUG: Getting Directory (special://profile/playlists/mixed) 2019-03-22 18:38:54.232 T:1445946096 DEBUG: CMultiPathDirectory::MergeItems, items = 0 2019-03-22 18:38:54.249 T:1774576368 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:kevpi port:2792 2019-03-22 18:38:54.249 T:1774576368 DEBUG: CZeroconfAvahi::addService() named: kevpi type: _http._tcp port:2792 2019-03-22 18:38:54.254 T:1774576368 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:kevpi port:2792 2019-03-22 18:38:54.255 T:1774576368 DEBUG: CZeroconfAvahi::addService() named: kevpi type: _xbmc-jsonrpc-h._tcp port:2792 2019-03-22 18:38:54.259 T:1774576368 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:kevpi port:9090 2019-03-22 18:38:54.259 T:1774576368 DEBUG: CZeroconfAvahi::addService() named: kevpi type: _xbmc-jsonrpc._tcp port:9090 2019-03-22 18:38:54.263 T:1774576368 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:kevpi port:9777 2019-03-22 18:38:54.263 T:1774576368 DEBUG: CZeroconfAvahi::addService() named: kevpi type: _xbmc-events._udp port:9777 2019-03-22 18:38:54.263 T:1899347216 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x34ac7d0 2019-03-22 18:38:54.265 T:1899347216 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x34bab50 2019-03-22 18:38:54.267 T:1899347216 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x349d428 2019-03-22 18:38:54.268 T:1899347216 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/backgrounds/primary.jpg 1280x720 2019-03-22 18:38:54.269 T:1899347216 DEBUG: ClampLimits: 0x0 900x506 -> 900x506 clamped=0 2019-03-22 18:38:54.276 T:1899347216 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x28334e8 2019-03-22 18:38:54.277 T:1899347216 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(93824), nBufferAlignment(16) 2019-03-22 18:38:54.279 T:1899347216 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x32c8520 2019-03-22 18:38:54.280 T:1899347216 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 2019-03-22 18:38:54.295 T:1899347216 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x28334e8 2019-03-22 18:38:54.295 T:1899347216 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x32c8520 2019-03-22 18:38:54.296 T:1899347216 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/backgrounds/pattern1.jpg 900x506 2019-03-22 18:38:54.297 T:1899347216 DEBUG: CDirectoryProvider[library://video/tvshows/]: refreshing.. 2019-03-22 18:38:54.298 T:1899347216 DEBUG: CDirectoryProvider[videodb://inprogresstvshows]: refreshing.. 2019-03-22 18:38:54.299 T:1899347216 DEBUG: CDirectoryProvider[special://skin/playlists/recent_unwatched_episodes.xsp]: refreshing.. 2019-03-22 18:38:54.299 T:1899347216 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_tvshows.xsp]: refreshing.. 2019-03-22 18:38:54.299 T:1899347216 DEBUG: CDirectoryProvider[videodb://tvshows/genres/]: refreshing.. 2019-03-22 18:38:54.299 T:1899347216 DEBUG: CDirectoryProvider[videodb://tvshows/studios/]: refreshing.. 2019-03-22 18:38:54.306 T:1899347216 DEBUG: ------ Window Init () ------ 2019-03-22 18:38:54.323 T:1699734256 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update 2019-03-22 18:38:54.341 T:1699734256 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-03-22 18:38:54.348 T:1699734256 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-03-22 18:38:54.356 T:1699734256 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update 2019-03-22 18:38:54.431 T:1682948848 DEBUG: CPythonInvoker(0, /home/pi/.kodi/addons/service.xbmc.versioncheck/service.py): start processing 2019-03-22 18:38:54.485 T:1899332336 DEBUG: CAnnouncementManager - Announcement: OnChanged from xbmc 2019-03-22 18:38:54.485 T:1899332336 DEBUG: GOT ANNOUNCEMENT, type: 1024, from xbmc, message OnChanged 2019-03-22 18:38:54.485 T:1899332336 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 2019-03-22 18:38:54.485 T:1899332336 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 2019-03-22 18:38:54.485 T:1899332336 DEBUG: UPnP: Building didl for object '/var/run/lirc/lircd' 2019-03-22 18:38:54.533 T:1699734256 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 2019-03-22 18:38:54.540 T:1699734256 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 != '')) AND (artistview.strArtist <> 'Verschiedene Interpreten') 2019-03-22 18:38:54.585 T:1899347216 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2019-03-22 18:38:54.686 T:1899347216 NOTICE: CVideoPlayer::CloseFile() 2019-03-22 18:38:54.686 T:1899347216 DEBUG: DeleteRenderer - deleting renderer 2019-03-22 18:38:54.686 T:1899347216 DEBUG: CMMALRenderer::~CMMALRenderer 2019-03-22 18:38:54.686 T:1899347216 DEBUG: CMMALRenderer::UnInitMMAL 2019-03-22 18:38:54.686 T:1496302320 DEBUG: CMMALRenderer::Run - stopping 2019-03-22 18:38:54.686 T:1496302320 DEBUG: Thread MMALProcess 1496302320 terminating 2019-03-22 18:38:54.686 T:1899347216 NOTICE: VideoPlayer: waiting for threads to exit 2019-03-22 18:38:54.686 T:1899347216 NOTICE: VideoPlayer: finished waiting 2019-03-22 18:38:54.686 T:1868559088 DEBUG: CActiveAE::DiscardStream - audio stream deleted 2019-03-22 18:38:54.687 T:1868559088 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2019-03-22 18:38:54.690 T:1899347216 DEBUG: Previous line repeats 2 times. 2019-03-22 18:38:54.690 T:1899347216 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 2019-03-22 18:38:54.691 T:1899347216 DEBUG: CMMALPool::~CMMALPool Destroying pool 0x34a01f0 for port vc.ril.video_decode:out:0(I420) 2019-03-22 18:38:54.691 T:1858073328 INFO: CActiveAESink::OpenSink - initialize sink 2019-03-22 18:38:54.691 T:1858073328 DEBUG: CAESinkPi:Drain delay:0ms now:0ms 2019-03-22 18:38:54.691 T:1858073328 DEBUG: CAESinkPi:Deinitialize 2019-03-22 18:38:54.692 T:1858073328 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 2019-03-22 18:38:54.692 T:1858073328 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 2019-03-22 18:38:54.692 T:1858073328 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:8816 bytes/s=352800.00 dest=PI:HDMI 2019-03-22 18:38:54.692 T:1858073328 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 2019-03-22 18:38:54.692 T:1899347216 DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------ 2019-03-22 18:38:54.693 T:1899347216 DEBUG: LogindUPowerSyscall - Received unknown signal NameAcquired 2019-03-22 18:38:54.694 T:1899347216 DEBUG: ------ Window Init (DialogNotification.xml) ------ 2019-03-22 18:38:54.696 T:1899347216 DEBUG: CDirectoryProvider[library://video/tvshows/]: refreshing.. 2019-03-22 18:38:54.696 T:1899347216 DEBUG: CDirectoryProvider[videodb://inprogresstvshows]: refreshing.. 2019-03-22 18:38:54.696 T:1899347216 DEBUG: CDirectoryProvider[special://skin/playlists/recent_unwatched_episodes.xsp]: refreshing.. 2019-03-22 18:38:54.696 T:1899347216 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_tvshows.xsp]: refreshing.. 2019-03-22 18:38:54.696 T:1899347216 DEBUG: CDirectoryProvider[videodb://tvshows/genres/]: refreshing.. 2019-03-22 18:38:54.696 T:1899347216 DEBUG: CDirectoryProvider[videodb://tvshows/studios/]: refreshing.. 2019-03-22 18:38:54.696 T:1858073328 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x6e213aa0 2019-03-22 18:38:54.698 T:1858073328 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(8816), nBufferAlignment(16) 2019-03-22 18:38:54.700 T:1858073328 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 2019-03-22 18:38:54.700 T:1858073328 DEBUG: Output Device : HDMI 2019-03-22 18:38:54.700 T:1858073328 DEBUG: Sample Rate : 44100 2019-03-22 18:38:54.700 T:1858073328 DEBUG: Sample Format : AE_FMT_FLOAT 2019-03-22 18:38:54.700 T:1858073328 DEBUG: Channel Count : 2 2019-03-22 18:38:54.700 T:1858073328 DEBUG: Channel Layout: FL, FR 2019-03-22 18:38:54.700 T:1858073328 DEBUG: Frames : 1102 2019-03-22 18:38:54.700 T:1858073328 DEBUG: Frame Size : 8 2019-03-22 18:38:54.702 T:1868559088 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2019-03-22 18:38:54.709 T:1445946096 DEBUG: Previous line repeats 1 times. 2019-03-22 18:38:54.710 T:1445946096 NOTICE: VideoInfoScanner: Starting scan .. 2019-03-22 18:38:54.710 T:1899332336 DEBUG: CAnnouncementManager - Announcement: OnScanStarted from xbmc 2019-03-22 18:38:54.710 T:1899332336 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnScanStarted 2019-03-22 18:38:54.713 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: loading setting definitions 2019-03-22 18:38:54.713 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: trying to load setting definitions from old format... 2019-03-22 18:38:54.714 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: loading setting values 2019-03-22 18:38:54.722 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: loading setting definitions 2019-03-22 18:38:54.723 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: trying to load setting definitions from old format... 2019-03-22 18:38:54.723 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: loading setting values 2019-03-22 18:38:54.760 T:1682948848 DEBUG: -->Python Interpreter Initialized<-- 2019-03-22 18:38:54.760 T:1682948848 DEBUG: CPythonInvoker(0, /home/pi/.kodi/addons/service.xbmc.versioncheck/service.py): the source file to load is "/home/pi/.kodi/addons/service.xbmc.versioncheck/service.py" 2019-03-22 18:38:54.761 T:1682948848 DEBUG: CPythonInvoker(0, /home/pi/.kodi/addons/service.xbmc.versioncheck/service.py): setting the Python path to /home/pi/.kodi/addons/service.xbmc.versioncheck:/usr/lib/python2.7:/usr/lib/python2.7/plat-arm-linux-gnueabihf:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat 2019-03-22 18:38:54.761 T:1682948848 DEBUG: CPythonInvoker(0, /home/pi/.kodi/addons/service.xbmc.versioncheck/service.py): entering source directory /home/pi/.kodi/addons/service.xbmc.versioncheck 2019-03-22 18:38:54.761 T:1682948848 DEBUG: CPythonInvoker(0, /home/pi/.kodi/addons/service.xbmc.versioncheck/service.py): instantiating addon using automatically obtained id of "service.xbmc.versioncheck" dependent on version 2.1.0 of the xbmc.python api 2019-03-22 18:38:54.769 T:1445946096 DEBUG: VideoInfoScanner: Skipping dir '/mnt/Serien/Bones/' due to no change 2019-03-22 18:38:54.777 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: loading setting definitions 2019-03-22 18:38:54.777 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: trying to load setting definitions from old format... 2019-03-22 18:38:54.778 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: loading setting values 2019-03-22 18:38:54.786 T:1899347216 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2019-03-22 18:38:54.786 T:1899347216 WARNING: OnMessage: Suspiciously long time to handle GUI_MSG_PLAYBACK_STARTED (0.30s) 2019-03-22 18:38:54.838 T:1445946096 DEBUG: VideoInfoScanner: Skipping dir '/mnt/Serien/Criminal Minds/' due to no change 2019-03-22 18:38:54.843 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: loading setting definitions 2019-03-22 18:38:54.843 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: trying to load setting definitions from old format... 2019-03-22 18:38:54.843 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: loading setting values 2019-03-22 18:38:54.865 T:1445946096 DEBUG: VideoInfoScanner: Skipping dir '/mnt/Serien/Fringe/' due to no change 2019-03-22 18:38:54.867 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: loading setting definitions 2019-03-22 18:38:54.867 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: trying to load setting definitions from old format... 2019-03-22 18:38:54.868 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: loading setting values 2019-03-22 18:38:54.903 T:1774576368 DEBUG: ClampLimits: 1920x1080 379x540 -> 379x540 clamped=0 2019-03-22 18:38:54.913 T:1445946096 DEBUG: VideoInfoScanner: Skipping dir '/mnt/Serien/NCIS/' due to no change 2019-03-22 18:38:54.913 T:1774576368 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x6e231678 2019-03-22 18:38:54.914 T:1774576368 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 2019-03-22 18:38:54.917 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: loading setting definitions 2019-03-22 18:38:54.917 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: trying to load setting definitions from old format... 2019-03-22 18:38:54.917 T:1774576368 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x683e2180 2019-03-22 18:38:54.918 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: loading setting values 2019-03-22 18:38:54.918 T:1774576368 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 2019-03-22 18:38:54.927 T:1774576368 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x6e231678 2019-03-22 18:38:54.932 T:1774576368 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x683e2180 2019-03-22 18:38:54.932 T:1774576368 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/9/994ed38f.jpg 379x540 2019-03-22 18:38:54.935 T:1774576368 DEBUG: ClampLimits: 1920x1080 379x540 -> 379x540 clamped=0 2019-03-22 18:38:54.951 T:1774576368 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x6e21def8 2019-03-22 18:38:54.952 T:1774576368 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 2019-03-22 18:38:54.960 T:1774576368 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x6e23bc80 2019-03-22 18:38:54.963 T:1774576368 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 2019-03-22 18:38:54.977 T:1445946096 DEBUG: VideoInfoScanner: Skipping dir '/mnt/Serien/Supernatural/' due to no change 2019-03-22 18:38:54.984 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: loading setting definitions 2019-03-22 18:38:54.984 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: trying to load setting definitions from old format... 2019-03-22 18:38:54.985 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: loading setting values 2019-03-22 18:38:54.995 T:1682948848 DEBUG: CAddonSettings[service.xbmc.versioncheck]: loading setting definitions 2019-03-22 18:38:54.995 T:1682948848 DEBUG: CAddonSettings[service.xbmc.versioncheck]: trying to load setting definitions from old format... 2019-03-22 18:38:54.996 T:1682948848 DEBUG: Version Check: Version 0.4.6 started 2019-03-22 18:38:55.011 T:1774576368 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x6e21def8 2019-03-22 18:38:55.013 T:1774576368 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x6e23bc80 2019-03-22 18:38:55.014 T:1774576368 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/c/ca113cc5.jpg 379x540 2019-03-22 18:38:55.016 T:1774576368 DEBUG: ClampLimits: 1920x1080 379x540 -> 379x540 clamped=0 2019-03-22 18:38:55.018 T:1445946096 DEBUG: VideoInfoScanner: Skipping dir '/mnt/Serien/The Mentalist/' due to no change 2019-03-22 18:38:55.023 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: loading setting definitions 2019-03-22 18:38:55.024 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: trying to load setting definitions from old format... 2019-03-22 18:38:55.024 T:1774576368 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x6e231678 2019-03-22 18:38:55.024 T:1445946096 DEBUG: CAddonSettings[metadata.tvshows.themoviedb.org]: loading setting values 2019-03-22 18:38:55.025 T:1774576368 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 2019-03-22 18:38:55.029 T:1774576368 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x683e2180 2019-03-22 18:38:55.030 T:1774576368 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 2019-03-22 18:38:55.041 T:1774576368 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x6e231678 2019-03-22 18:38:55.043 T:1774576368 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x683e2180 2019-03-22 18:38:55.043 T:1774576368 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/6/6afc2d8f.jpg 379x540 2019-03-22 18:38:55.044 T:1445946096 DEBUG: VideoInfoScanner: Skipping dir '/mnt/Serien/The Walking Dead/' due to no change 2019-03-22 18:38:55.054 T:1699734256 DEBUG: ClampLimits: 1920x1080 379x540 -> 379x540 clamped=0 2019-03-22 18:38:55.060 T:1699734256 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x6d816970 2019-03-22 18:38:55.061 T:1699734256 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 2019-03-22 18:38:55.064 T:1699734256 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x4ecd6388 2019-03-22 18:38:55.065 T:1699734256 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 2019-03-22 18:38:55.076 T:1674556144 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 2019-03-22 18:38:55.084 T:1699734256 DEBUG: Previous line repeats 1 times. 2019-03-22 18:38:55.084 T:1699734256 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x6d816970 2019-03-22 18:38:55.086 T:1699734256 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x4ecd6388 2019-03-22 18:38:55.086 T:1674556144 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 2019-03-22 18:38:55.086 T:1699734256 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/5/5789d627.jpg 379x540 2019-03-22 18:38:55.088 T:1699734256 DEBUG: ClampLimits: 1920x1080 379x540 -> 379x540 clamped=0 2019-03-22 18:38:55.090 T:1674556144 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 2019-03-22 18:38:55.094 T:1699734256 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x4ecdc878 2019-03-22 18:38:55.095 T:1699734256 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 2019-03-22 18:38:55.099 T:1699734256 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x4ecd6388 2019-03-22 18:38:55.100 T:1699734256 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 2019-03-22 18:38:55.110 T:1699734256 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x4ecdc878 2019-03-22 18:38:55.112 T:1699734256 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x4ecd6388 2019-03-22 18:38:55.112 T:1699734256 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/3/30d4d3b1.jpg 379x540 2019-03-22 18:38:55.114 T:1699734256 DEBUG: ClampLimits: 1920x1080 379x540 -> 379x540 clamped=0 2019-03-22 18:38:55.133 T:1699734256 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x4ecda7b8 2019-03-22 18:38:55.136 T:1699734256 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 2019-03-22 18:38:55.139 T:1699734256 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x4ecd6388 2019-03-22 18:38:55.141 T:1699734256 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 2019-03-22 18:38:55.170 T:1699734256 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x4ecda7b8 2019-03-22 18:38:55.207 T:1699734256 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x4ecd6388 2019-03-22 18:38:55.207 T:1699734256 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/9/97593914.jpg 379x540 2019-03-22 18:38:55.209 T:1699734256 DEBUG: ClampLimits: 1920x1080 379x540 -> 379x540 clamped=0 2019-03-22 18:38:55.230 T:1445946096 NOTICE: VideoInfoScanner: Finished scan. Scanning for video info took 00:00 2019-03-22 18:38:55.230 T:1899332336 DEBUG: CAnnouncementManager - Announcement: OnScanFinished from xbmc 2019-03-22 18:38:55.230 T:1899332336 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnScanFinished 2019-03-22 18:38:55.233 T:1899347216 DEBUG: ClampLimits: 0x0 900x506 -> 900x506 clamped=0 2019-03-22 18:38:55.235 T:1699734256 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x6d805d38 2019-03-22 18:38:55.236 T:1699734256 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 2019-03-22 18:38:55.242 T:1899347216 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x3491230 2019-03-22 18:38:55.243 T:1899347216 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(93824), nBufferAlignment(16) 2019-03-22 18:38:55.245 T:1699734256 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x6d89a7c0 2019-03-22 18:38:55.246 T:1699734256 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 2019-03-22 18:38:55.254 T:1899347216 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x34e5a28 2019-03-22 18:38:55.256 T:1899347216 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 2019-03-22 18:38:55.257 T:1699734256 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x6d805d38 2019-03-22 18:38:55.259 T:1699734256 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x6d89a7c0 2019-03-22 18:38:55.259 T:1699734256 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/5/58a1c2f1.jpg 379x540 2019-03-22 18:38:55.274 T:1899347216 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x3491230 2019-03-22 18:38:55.275 T:1899347216 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x34e5a28 2019-03-22 18:38:55.276 T:1899347216 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/backgrounds/pattern1.jpg 900x506 2019-03-22 18:38:55.276 T:1899347216 DEBUG: CDirectoryProvider[videodb://inprogresstvshows]: refreshing.. 2019-03-22 18:38:55.276 T:1899347216 DEBUG: CDirectoryProvider[special://skin/playlists/recent_unwatched_episodes.xsp]: refreshing.. 2019-03-22 18:38:55.277 T:1899347216 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_tvshows.xsp]: refreshing.. 2019-03-22 18:38:55.277 T:1899347216 DEBUG: CDirectoryProvider[videodb://tvshows/genres/]: refreshing.. 2019-03-22 18:38:55.277 T:1899347216 DEBUG: CDirectoryProvider[videodb://tvshows/studios/]: refreshing.. 2019-03-22 18:38:55.316 T:1774576368 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update 2019-03-22 18:38:55.470 T:1311761136 DEBUG: OpenConnection - connection to the CEC adapter opened 2019-03-22 18:38:55.471 T:1311761136 DEBUG: SetConfigurationFromLibCEC - settings updated by libCEC 2019-03-22 18:38:55.471 T:1401934576 DEBUG: Thread CECAdapterUpdate start, auto delete: false 2019-03-22 18:38:55.507 T:1899347216 DEBUG: ------ Window Deinit (DialogExtendedProgressBar.xml) ------ 2019-03-22 18:38:55.540 T:1774576368 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 2019-03-22 18:38:55.550 T:1774576368 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 != '')) AND (artistview.strArtist <> 'Verschiedene Interpreten') 2019-03-22 18:38:55.700 T:1899347216 DEBUG: [Warning] CGUITextureManager::GetTexturePath: could not find texture 'DefaultStudio.png' 2019-03-22 18:38:55.742 T:1445946096 DEBUG: Previous line repeats 3 times. 2019-03-22 18:38:55.742 T:1445946096 DEBUG: ClampLimits: 1920x1080 1280x720 -> 1280x720 clamped=0 2019-03-22 18:38:55.778 T:1445946096 DEBUG: Previous line repeats 3 times. 2019-03-22 18:38:55.778 T:1445946096 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x5495ad78 2019-03-22 18:38:55.779 T:1699734256 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x4ecd4240 2019-03-22 18:38:55.779 T:1445946096 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(171472), nBufferAlignment(16) 2019-03-22 18:38:55.779 T:1699734256 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(214496), nBufferAlignment(16) 2019-03-22 18:38:55.783 T:1445946096 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x5493a6f0 2019-03-22 18:38:55.784 T:1445946096 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 2019-03-22 18:38:55.788 T:1762632432 DEBUG: ffmpeg[690FA2F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-03-22 18:38:55.796 T:1774576368 DEBUG: ffmpeg[69C5E2F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-03-22 18:38:55.806 T:1762632432 DEBUG: ClampLimits: 1920x1080 1280x720 -> 1280x720 clamped=0 2019-03-22 18:38:55.814 T:1699734256 DEBUG: Previous line repeats 1 times. 2019-03-22 18:38:55.815 T:1699734256 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x6d89a7c0 2019-03-22 18:38:55.815 T:1445946096 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x5495ad78 2019-03-22 18:38:55.816 T:1699734256 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 2019-03-22 18:38:55.817 T:1445946096 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x5493a6f0 2019-03-22 18:38:55.818 T:1445946096 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/9/914d054c.jpg 1280x720 2019-03-22 18:38:55.844 T:1699734256 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x4ecd4240 2019-03-22 18:38:55.845 T:1699734256 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x6d89a7c0 2019-03-22 18:38:55.845 T:1699734256 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/e/e61ceb18.jpg 1280x720 2019-03-22 18:38:55.845 T:1699734256 DEBUG: DoWork - took 103 ms to load special://masterprofile/Thumbnails/e/e61ceb18.jpg 2019-03-22 18:38:55.854 T:1774576368 DEBUG: ffmpeg[69C5E2F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-03-22 18:38:55.859 T:1762632432 DEBUG: ffmpeg[690FA2F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-03-22 18:38:58.277 T:1385149168 DEBUG: CWebServer[2792]: request received for /jsonrpc 2019-03-22 18:38:58.314 T:1531880176 DEBUG: Previous line repeats 1 times. 2019-03-22 18:38:58.314 T:1531880176 DEBUG: JSONRPC Server: New connection detected 2019-03-22 18:38:58.314 T:1531880176 INFO: JSONRPC Server: New connection added 2019-03-22 18:38:59.820 T:1385149168 DEBUG: CWebServer[2792]: request received for /jsonrpc 2019-03-22 18:39:00.079 T:1682948848 DEBUG: Previous line repeats 1 times. 2019-03-22 18:39:00.079 T:1682948848 DEBUG: Version Check: Version installed {u'major': 18, u'tag': u'stable', u'minor': 1, u'revision': u'20190220-5494e5ffac'} 2019-03-22 18:39:00.080 T:1682948848 INFO: CPythonInvoker(0, /home/pi/.kodi/addons/service.xbmc.versioncheck/service.py): script successfully run 2019-03-22 18:39:00.080 T:1682948848 DEBUG: onExecutionDone(0, /home/pi/.kodi/addons/service.xbmc.versioncheck/service.py) 2019-03-22 18:39:00.100 T:1682948848 INFO: Python interpreter stopped 2019-03-22 18:39:00.100 T:1682948848 DEBUG: Thread LanguageInvoker 1682948848 terminating 2019-03-22 18:39:00.159 T:1899347216 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 2019-03-22 18:39:01.047 T:1540272880 DEBUG: EventClient: button code 0 pressed 2019-03-22 18:39:01.079 T:1899347216 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up 2019-03-22 18:39:01.377 T:1385149168 DEBUG: CWebServer[2792]: request received for /jsonrpc 2019-03-22 18:39:01.693 T:1540272880 DEBUG: Previous line repeats 1 times. 2019-03-22 18:39:01.693 T:1540272880 DEBUG: EventClient: button code 0 pressed 2019-03-22 18:39:01.699 T:1899347216 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select 2019-03-22 18:39:01.699 T:1899347216 DEBUG: Activating window ID: 10111 2019-03-22 18:39:01.699 T:1899347216 DEBUG: ------ Window Init (DialogButtonMenu.xml) ------ 2019-03-22 18:39:01.699 T:1899347216 INFO: Loading skin file: DialogButtonMenu.xml, load type: KEEP_IN_MEMORY 2019-03-22 18:39:02.791 T:1540272880 DEBUG: EventClient: button code 0 pressed 2019-03-22 18:39:02.798 T:1899347216 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select 2019-03-22 18:39:02.832 T:1899347216 NOTICE: stop player 2019-03-22 18:39:02.832 T:1899347216 NOTICE: Storing total System Uptime 2019-03-22 18:39:02.832 T:1899332336 DEBUG: CAnnouncementManager - Announcement: OnQuit from xbmc 2019-03-22 18:39:02.832 T:1899332336 DEBUG: GOT ANNOUNCEMENT, type: 8, from xbmc, message OnQuit 2019-03-22 18:39:02.832 T:1899347216 NOTICE: Saving settings 2019-03-22 18:39:02.848 T:1899347216 NOTICE: Saving skin settings 2019-03-22 18:39:02.852 T:1899347216 NOTICE: stop all 2019-03-22 18:39:02.852 T:1445946096 DEBUG: Thread JobWorker 1445946096 terminating (autodelete) 2019-03-22 18:39:02.853 T:1699734256 DEBUG: Thread JobWorker 1699734256 terminating (autodelete) 2019-03-22 18:39:02.853 T:1899347216 DEBUG: NetworkMessage - Signaling network services to stop 2019-03-22 18:39:02.853 T:1899347216 NOTICE: ES: Stopping event server 2019-03-22 18:39:02.853 T:1774576368 DEBUG: Thread JobWorker 1774576368 terminating (autodelete) 2019-03-22 18:39:02.853 T:1899347216 DEBUG: NetworkMessage - Waiting for network services to stop 2019-03-22 18:39:02.854 T:1899347216 NOTICE: stopping upnp 2019-03-22 18:39:02.854 T:1762632432 DEBUG: Thread JobWorker 1762632432 terminating (autodelete) 2019-03-22 18:39:02.932 T:1385149168 DEBUG: CWebServer[2792]: request received for /jsonrpc 2019-03-22 18:39:03.216 T:1899347216 DEBUG: Previous line repeats 1 times. 2019-03-22 18:39:03.216 T:1899347216 NOTICE: stopping zeroconf publishing 2019-03-22 18:39:03.222 T:1899347216 NOTICE: CWebServer[2792]: Stopped 2019-03-22 18:39:03.324 T:1531880176 DEBUG: Thread TCPServer 1531880176 terminating 2019-03-22 18:39:03.793 T:1540272880 NOTICE: ES: UDP Event server stopped 2019-03-22 18:39:03.793 T:1540272880 DEBUG: Thread EventServer 1540272880 terminating 2019-03-22 18:39:03.793 T:1899347216 NOTICE: stop dvd detect media 2019-03-22 18:39:03.794 T:1899347216 DEBUG: CServiceAddonManager: stopping service.xbmc.versioncheck. 2019-03-22 18:39:03.794 T:1899347216 INFO: CServiceAddonManager: failed to stop service.xbmc.versioncheck (may have ended) 2019-03-22 18:39:03.794 T:1868559088 DEBUG: Thread ActiveAE 1868559088 terminating 2019-03-22 18:39:03.799 T:1858073328 DEBUG: Thread AESink 1858073328 terminating 2019-03-22 18:39:03.849 T:1899347216 DEBUG: CAESinkPi:Drain delay:49ms now:0ms 2019-03-22 18:39:03.849 T:1899347216 DEBUG: CAESinkPi:Deinitialize 2019-03-22 18:39:03.849 T:1899347216 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 2019-03-22 18:39:03.853 T:1899347216 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x6e213aa0 2019-03-22 18:39:03.854 T:1899347216 NOTICE: stopped 2019-03-22 18:39:04.055 T:1899347216 NOTICE: destroy 2019-03-22 18:39:04.056 T:1708126960 DEBUG: Thread PeripEventScanner 1708126960 terminating 2019-03-22 18:39:04.068 T:1739580144 DEBUG: Thread PeripBusUSBUdev 1739580144 terminating 2019-03-22 18:39:05.201 T:1401934576 DEBUG: Thread CECAdapterUpdate 1401934576 terminating 2019-03-22 18:39:05.243 T:1311761136 DEBUG: Process - CEC adapter processor thread ended 2019-03-22 18:39:05.244 T:1311761136 DEBUG: Thread CECAdapter 1311761136 terminating 2019-03-22 18:39:05.745 T:1722794736 DEBUG: Thread PeripBusAddon 1722794736 terminating 2019-03-22 18:39:05.830 T:1899347216 NOTICE: unload skin 2019-03-22 18:39:05.830 T:1899347216 INFO: Unloading old skin ... 2019-03-22 18:39:05.835 T:1899347216 DEBUG: ------ Window Deinit () ------ 2019-03-22 18:39:05.835 T:1899347216 DEBUG: ------ Window Deinit (Home.xml) ------ 2019-03-22 18:39:05.836 T:1899347216 DEBUG: FreeVisualisation() done 2019-03-22 18:39:05.850 T:1899347216 DEBUG: Previous line repeats 1 times. 2019-03-22 18:39:05.850 T:1899347216 DEBUG: ------ Window Deinit (DialogButtonMenu.xml) ------ 2019-03-22 18:39:05.857 T:1899347216 DEBUG: CloseBundle - Closed bundle 2019-03-22 18:39:05.888 T:1899347216 NOTICE: unload sections 2019-03-22 18:39:05.897 T:1899332336 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 2019-03-22 18:39:05.897 T:1899347216 DEBUG: LogindUPowerSyscall - delay lock sleep released 2019-03-22 18:39:05.900 T:1691341552 DEBUG: Thread Timer 1691341552 terminating 2019-03-22 18:39:05.902 T:1899347216 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x28f6dc8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-03-22 18:39:05.902 T:1899347216 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x28d1690 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-03-22 18:39:05.902 T:1899347216 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x28bed20 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-03-22 18:39:05.902 T:1899347216 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x28fa7f0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-03-22 18:39:05.902 T:1899347216 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x28e8d30 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-03-22 18:39:05.902 T:1899347216 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x28d90b0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-03-22 18:39:05.902 T:1899347216 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x28ed4f8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-03-22 18:39:05.904 T:1899347216 DEBUG: object 0 --> 0 instances 2019-03-22 18:39:05.904 T:1899347216 DEBUG: object 1 --> 0 instances 2019-03-22 18:39:05.904 T:1899347216 DEBUG: object 2 --> 0 instances 2019-03-22 18:39:05.904 T:1899347216 DEBUG: object 3 --> 0 instances 2019-03-22 18:39:05.904 T:1899347216 DEBUG: object 4 --> 0 instances 2019-03-22 18:39:05.904 T:1899347216 DEBUG: object 5 --> 0 instances 2019-03-22 18:39:05.904 T:1899347216 DEBUG: object 6 --> 0 instances 2019-03-22 18:39:05.904 T:1899347216 DEBUG: object 7 --> 0 instances 2019-03-22 18:39:05.904 T:1899347216 DEBUG: object 8 --> 0 instances 2019-03-22 18:39:05.904 T:1899347216 DEBUG: object 9 --> 0 instances 2019-03-22 18:39:05.923 T:1879044848 DEBUG: Thread libinput 1879044848 terminating 2019-03-22 18:39:05.924 T:1889530608 DEBUG: Thread Lirc 1889530608 terminating 2019-03-22 18:39:05.931 T:1899332336 DEBUG: Thread Announce 1899332336 terminating 2019-03-22 18:39:05.940 T:1899347216 NOTICE: application stopped... 2019-03-22 18:39:05.940 T:1784652528 DEBUG: Thread CRBPWorker 1784652528 terminating