2019-03-16 11:25:16.658 T:1937791376 NOTICE: ----------------------------------------------------------------------- 2019-03-16 11:25:16.659 T:1937791376 NOTICE: Starting Kodi (18.1 Git:newclock5_18.1-Leia). Platform: Linux ARM 32-bit 2019-03-16 11:25:16.659 T:1937791376 NOTICE: Using Release Kodi x32 build (version for Raspberry Pi) 2019-03-16 11:25:16.659 T:1937791376 NOTICE: Kodi compiled 2019-02-21 by GCC 8.2.0 for Linux ARM 32-bit version 4.19.23 (267031) 2019-03-16 11:25:16.659 T:1937791376 NOTICE: Running on LibreELEC (official): 9.0.1, kernel: Linux ARM 32-bit version 4.19.23 2019-03-16 11:25:16.659 T:1937791376 NOTICE: FFmpeg version/source: 4.0.3-Kodi 2019-03-16 11:25:16.659 T:1937791376 NOTICE: Host CPU: ARMv7 Processor rev 4 (v7l), 4 cores available 2019-03-16 11:25:16.660 T:1937791376 NOTICE: ARM Features: Neon enabled 2019-03-16 11:25:16.660 T:1937791376 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi/ 2019-03-16 11:25:16.660 T:1937791376 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi 2019-03-16 11:25:16.660 T:1937791376 NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons 2019-03-16 11:25:16.660 T:1937791376 NOTICE: special://masterprofile/ is mapped to: /storage/.kodi/userdata 2019-03-16 11:25:16.660 T:1937791376 NOTICE: special://envhome/ is mapped to: /storage 2019-03-16 11:25:16.660 T:1937791376 NOTICE: special://home/ is mapped to: /storage/.kodi 2019-03-16 11:25:16.660 T:1937791376 NOTICE: special://temp/ is mapped to: /storage/.kodi/temp 2019-03-16 11:25:16.660 T:1937791376 NOTICE: special://logpath/ is mapped to: /storage/.kodi/temp 2019-03-16 11:25:16.660 T:1937791376 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin 2019-03-16 11:25:16.660 T:1937791376 NOTICE: Local hostname: chaospi 2019-03-16 11:25:16.661 T:1937791376 NOTICE: Log File is located: /storage/.kodi/temp/kodi.log 2019-03-16 11:25:16.661 T:1937791376 NOTICE: ----------------------------------------------------------------------- 2019-03-16 11:25:16.682 T:1937791376 INFO: loading settings 2019-03-16 11:25:16.686 T:1937791376 NOTICE: special://profile/ is mapped to: special://masterprofile/ 2019-03-16 11:25:16.721 T:1937791376 DEBUG: CSkinSettings: no tag found 2019-03-16 11:25:16.721 T:1937791376 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml 2019-03-16 11:25:16.723 T:1937791376 DEBUG: CMediaSourceSettings: tag is missing or sources.xml is malformed 2019-03-16 11:25:16.723 T:1937791376 DEBUG: CMediaSourceSettings: tag is missing or sources.xml is malformed 2019-03-16 11:25:16.723 T:1937791376 DEBUG: CMediaSourceSettings: tag is missing or sources.xml is malformed 2019-03-16 11:25:16.725 T:1937791376 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml 2019-03-16 11:25:16.725 T:1937791376 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are... /usr/bin/cputemp /usr/bin/gputemp false 1 30 720 540 2019-03-16 11:25:16.725 T:1937791376 WARNING: CSettingsManager: missing version attribute 2019-03-16 11:25:16.727 T:1937791376 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 2019-03-16 11:25:16.727 T:1937791376 NOTICE: Default Video Player: VideoPlayer 2019-03-16 11:25:16.727 T:1937791376 NOTICE: Default Audio Player: paplayer 2019-03-16 11:25:16.727 T:1937791376 NOTICE: Enabled debug logging due to GUI setting (2) 2019-03-16 11:25:16.727 T:1937791376 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 2019-03-16 11:25:16.742 T:1937791376 INFO: creating subdirectories 2019-03-16 11:25:16.742 T:1937791376 INFO: userdata folder: special://masterprofile/ 2019-03-16 11:25:16.742 T:1937791376 INFO: recording folder: 2019-03-16 11:25:16.742 T:1937791376 INFO: screenshots folder: /storage/screenshots/ 2019-03-16 11:25:16.893 T:1937791376 DEBUG: DllBcm: Using omx system library 2019-03-16 11:25:16.917 T:1937791376 NOTICE: PulseAudio: Server found running - will try to use Pulse 2019-03-16 11:25:16.918 T:1861219184 DEBUG: Thread Lirc start, auto delete: false 2019-03-16 11:25:16.918 T:1928328048 DEBUG: Thread libinput start, auto delete: false 2019-03-16 11:25:16.918 T:1861219184 INFO: Loading special://xbmc/system/Lircmap.xml 2019-03-16 11:25:16.928 T:1861219184 INFO: * Adding remote mapping for device 'mceusb' 2019-03-16 11:25:16.928 T:1861219184 INFO: * Adding remote mapping for device 'XboxDVDDongle' 2019-03-16 11:25:16.928 T:1861219184 INFO: * Adding remote mapping for device 'Microsoft_Xbox' 2019-03-16 11:25:16.928 T:1861219184 INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote' 2019-03-16 11:25:16.928 T:1861219184 INFO: * Adding remote mapping for device 'anysee' 2019-03-16 11:25:16.928 T:1861219184 INFO: * Adding remote mapping for device 'iMON-PAD' 2019-03-16 11:25:16.928 T:1861219184 INFO: * Adding remote mapping for device 'Antec_Veris_RM200' 2019-03-16 11:25:16.929 T:1861219184 INFO: * Adding remote mapping for device 'MCE_via_iMON' 2019-03-16 11:25:16.929 T:1861219184 INFO: * Adding remote mapping for device 'TwinHanRemote' 2019-03-16 11:25:16.929 T:1861219184 INFO: * Adding remote mapping for device 'linux-input-layer' 2019-03-16 11:25:16.929 T:1861219184 INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote' 2019-03-16 11:25:16.929 T:1861219184 INFO: * Adding remote mapping for device 'mediacenter' 2019-03-16 11:25:16.929 T:1861219184 INFO: * Adding remote mapping for device 'devinput' 2019-03-16 11:25:16.929 T:1861219184 INFO: * Adding remote mapping for device 'devinput-32' 2019-03-16 11:25:16.929 T:1861219184 INFO: * Adding remote mapping for device 'devinput-64' 2019-03-16 11:25:16.930 T:1861219184 DEBUG: CIRTranslator::Load - no userdata Lircmap.xml found, skipping 2019-03-16 11:25:17.018 T:1937791376 NOTICE: Running database version Addons27 2019-03-16 11:25:17.339 T:1937791376 INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/kodi/addons: No such file or directory' 2019-03-16 11:25:17.340 T:1937791376 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.' 2019-03-16 11:25:17.340 T:1937791376 NOTICE: ADDON: audioencoder.kodi.builtin.aac v1.0.0 installed 2019-03-16 11:25:17.340 T:1937791376 NOTICE: ADDON: audioencoder.kodi.builtin.wma v1.0.0 installed 2019-03-16 11:25:17.340 T:1937791376 NOTICE: ADDON: driver.dvb.crazycat v9.0.0 installed 2019-03-16 11:25:17.340 T:1937791376 NOTICE: ADDON: driver.dvb.dvb-latest v9.0.0 installed 2019-03-16 11:25:17.340 T:1937791376 NOTICE: ADDON: game.controller.default v1.0.8 installed 2019-03-16 11:25:17.340 T:1937791376 NOTICE: ADDON: game.controller.snes v1.0.8 installed 2019-03-16 11:25:17.340 T:1937791376 NOTICE: ADDON: inputstream.adaptive v2.3.15.0 installed 2019-03-16 11:25:17.340 T:1937791376 NOTICE: ADDON: kodi.binary.global.audioengine v1.0.1 installed 2019-03-16 11:25:17.340 T:1937791376 NOTICE: ADDON: kodi.binary.global.filesystem v1.0.2 installed 2019-03-16 11:25:17.340 T:1937791376 NOTICE: ADDON: kodi.binary.global.general v1.0.3 installed 2019-03-16 11:25:17.340 T:1937791376 NOTICE: ADDON: kodi.binary.global.gui v5.12.0 installed 2019-03-16 11:25:17.340 T:1937791376 NOTICE: ADDON: kodi.binary.global.main v1.0.14 installed 2019-03-16 11:25:17.340 T:1937791376 NOTICE: ADDON: kodi.binary.global.network v1.0.0 installed 2019-03-16 11:25:17.340 T:1937791376 NOTICE: ADDON: kodi.binary.instance.audiodecoder v2.0.0 installed 2019-03-16 11:25:17.340 T:1937791376 NOTICE: ADDON: kodi.binary.instance.audioencoder v2.0.0 installed 2019-03-16 11:25:17.340 T:1937791376 NOTICE: ADDON: kodi.binary.instance.game v1.1.0 installed 2019-03-16 11:25:17.340 T:1937791376 NOTICE: ADDON: kodi.binary.instance.imagedecoder v2.0.0 installed 2019-03-16 11:25:17.340 T:1937791376 NOTICE: ADDON: kodi.binary.instance.inputstream v2.0.8 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: kodi.binary.instance.peripheral v1.3.7 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: kodi.binary.instance.pvr v5.10.3 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: kodi.binary.instance.screensaver v2.0.0 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: kodi.binary.instance.vfs v2.0.0 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: kodi.binary.instance.videocodec v1.0.1 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: kodi.binary.instance.visualization v2.0.1 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: kodi.resource v1.0.0 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: metadata.album.universal v3.1.1 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: metadata.artists.universal v4.2.1 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: metadata.common.allmusic.com v3.2.0 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: metadata.common.fanart.tv v3.6.0 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: metadata.common.imdb.com v3.1.4 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: metadata.common.musicbrainz.org v2.2.1 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: metadata.common.theaudiodb.com v2.0.1 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: metadata.common.themoviedb.org v3.1.9 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: metadata.local v1.0.0 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: metadata.themoviedb.org v5.1.5 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: metadata.tvshows.themoviedb.org v3.1.0 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: os.libreelec.tv v9.0 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: os.openelec.tv v9.0 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: peripheral.joystick v1.4.7 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: plugin.video.skygo.de v1.13.4 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: repository.kodi.game v1.0.0 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: repository.kodinerds v9.0.103.103 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: repository.libreelec.tv v9.0.1 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: repository.xbmc.org v3.1.5 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: resource.images.weathericons.default v1.1.8 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: resource.language.en_gb v2.0.1 installed 2019-03-16 11:25:17.341 T:1937791376 NOTICE: ADDON: resource.uisounds.kodi v1.0.0 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: screensaver.xbmc.builtin.black v1.0.32 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: screensaver.xbmc.builtin.dim v1.0.53 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: script.common.plugin.cache v2.5.10 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: script.module.certifi v2017.07.27.1 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: script.module.chardet v3.0.4 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: script.module.cryptopy v1.2.6 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: script.module.idna v2.6 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: script.module.inputstreamhelper v0.3.3 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: script.module.pil v1.1.7 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: script.module.pycryptodome v3.4.3 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: script.module.pydes v2.0.1 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: script.module.requests v2.19.1 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: script.module.routing v0.2.1 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: script.module.urllib3 v1.22 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: script.program.driverselect v0.1.6 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: service.libreelec.settings v9.0.0 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: skin.estuary v2.0.21 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: webinterface.default v18.x-2.4.6 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: xbmc.addon v18.1.0 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: xbmc.core v0.1.0 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: xbmc.gui v5.14.0 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: xbmc.json v10.1.2 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: xbmc.metadata v2.1.0 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: xbmc.python v2.26.0 installed 2019-03-16 11:25:17.342 T:1937791376 NOTICE: ADDON: xbmc.webinterface v1.0.0 installed 2019-03-16 11:25:17.371 T:1937791376 DEBUG: CFavourites::Load - no system favourites found, skipping 2019-03-16 11:25:17.371 T:1937791376 DEBUG: CFavourites::Load - no userdata favourites found, skipping 2019-03-16 11:25:17.375 T:1937791376 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-16 11:25:17.375 T:1937791376 INFO: Selected Logind/UPower as PowerSyscall 2019-03-16 11:25:17.376 T:1937791376 ERROR: DBus error: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files 2019-03-16 11:25:17.376 T:1937791376 INFO: LogindUPowerSyscall - UPower not found, battery information will not be available 2019-03-16 11:25:17.383 T:1937791376 DEBUG: LogindUPowerSyscall - inhibit lock taken, fd 18 2019-03-16 11:25:17.386 T:1937791376 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-16 11:25:17.386 T:1916023664 DEBUG: Thread ActiveAE start, auto delete: false 2019-03-16 11:25:17.387 T:1906307952 DEBUG: Thread AESink start, auto delete: false 2019-03-16 11:25:17.387 T:1895822192 DEBUG: Thread FDEventMonitor start, auto delete: false 2019-03-16 11:25:17.397 T:1916023664 INFO: CAESinkALSA - Unable to open device "default" for playback 2019-03-16 11:25:17.409 T:1916023664 DEBUG: PulseAudio: Context authorizing 2019-03-16 11:25:17.410 T:1916023664 DEBUG: PulseAudio: Context setting name 2019-03-16 11:25:17.410 T:1916023664 DEBUG: PulseAudio: Context ready 2019-03-16 11:25:17.411 T:1916023664 WARNING: Pulseaudio module module-allow-passthrough not loaded - opening PT devices might fail 2019-03-16 11:25:17.412 T:1916023664 NOTICE: Found 2 Lists of Devices 2019-03-16 11:25:17.412 T:1916023664 NOTICE: Enumerated PI devices: 2019-03-16 11:25:17.412 T:1916023664 NOTICE: Device 1 2019-03-16 11:25:17.412 T:1916023664 NOTICE: m_deviceName : HDMI 2019-03-16 11:25:17.412 T:1916023664 NOTICE: m_displayName : HDMI 2019-03-16 11:25:17.412 T:1916023664 NOTICE: m_displayNameExtra: 2019-03-16 11:25:17.412 T:1916023664 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_channels : FL, FR 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_sampleRates : 8000,11025,16000,22050,24000,32000,44100,48000,88200,96000,176400,192000 2019-03-16 11:25:17.413 T:1916023664 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-16 11:25:17.413 T:1916023664 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-16 11:25:17.413 T:1916023664 NOTICE: Device 2 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_deviceName : Analogue 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_displayName : Analogue 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_displayNameExtra: 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_deviceType : AE_DEVTYPE_PCM 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_channels : FL, FR 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_sampleRates : 48000 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_streamTypes : No passthrough capabilities 2019-03-16 11:25:17.413 T:1916023664 NOTICE: Device 3 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_deviceName : Both 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_displayName : HDMI and Analogue 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_displayNameExtra: 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_deviceType : AE_DEVTYPE_PCM 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_channels : FL, FR 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_sampleRates : 48000 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_streamTypes : No passthrough capabilities 2019-03-16 11:25:17.413 T:1916023664 NOTICE: Enumerated PULSE devices: 2019-03-16 11:25:17.413 T:1916023664 NOTICE: Device 1 2019-03-16 11:25:17.413 T:1916023664 NOTICE: m_deviceName : Default 2019-03-16 11:25:17.414 T:1916023664 NOTICE: m_displayName : Default 2019-03-16 11:25:17.414 T:1916023664 NOTICE: m_displayNameExtra: Bluetooth Audio (PULSEAUDIO) 2019-03-16 11:25:17.414 T:1916023664 NOTICE: m_deviceType : AE_DEVTYPE_PCM 2019-03-16 11:25:17.414 T:1916023664 NOTICE: m_channels : FL, FR 2019-03-16 11:25:17.414 T:1916023664 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000 2019-03-16 11:25:17.414 T:1916023664 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT 2019-03-16 11:25:17.414 T:1916023664 NOTICE: m_streamTypes : No passthrough capabilities 2019-03-16 11:25:17.414 T:1906307952 INFO: CActiveAESink::OpenSink - initialize sink 2019-03-16 11:25:17.414 T:1906307952 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 2019-03-16 11:25:17.414 T:1906307952 DEBUG: DllBcm: Using omx system library 2019-03-16 11:25:17.415 T:1906307952 DEBUG: SECTION:LoadDLL(libopenmaxil.so) 2019-03-16 11:25:17.417 T:1906307952 DEBUG: Loading: libopenmaxil.so 2019-03-16 11:25:17.424 T:1817162608 DEBUG: Thread CRBPWorker start, auto delete: false 2019-03-16 11:25:17.425 T:1906307952 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI 2019-03-16 11:25:17.425 T:1906307952 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 2019-03-16 11:25:17.426 T:1906307952 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x71002f50 2019-03-16 11:25:17.428 T:1906307952 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignment(16) 2019-03-16 11:25:17.428 T:1906307952 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 2019-03-16 11:25:17.428 T:1906307952 DEBUG: Output Device : HDMI 2019-03-16 11:25:17.428 T:1906307952 DEBUG: Sample Rate : 44100 2019-03-16 11:25:17.428 T:1906307952 DEBUG: Sample Format : AE_FMT_FLOAT 2019-03-16 11:25:17.428 T:1906307952 DEBUG: Channel Count : 2 2019-03-16 11:25:17.428 T:1906307952 DEBUG: Channel Layout: FL, FR 2019-03-16 11:25:17.428 T:1906307952 DEBUG: Frames : 2205 2019-03-16 11:25:17.428 T:1906307952 DEBUG: Frame Size : 8 2019-03-16 11:25:17.440 T:1937791376 INFO: CKeyboardLayoutManager: loading keyboard layouts from special://xbmc/system/keyboardlayouts... 2019-03-16 11:25:17.448 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Arabic QWERTY" successfully loaded 2019-03-16 11:25:17.449 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian ЯВЕРТЪ" successfully loaded 2019-03-16 11:25:17.450 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian АБВ" successfully loaded 2019-03-16 11:25:17.451 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BasePY" successfully loaded 2019-03-16 11:25:17.451 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BaiduPY" successfully loaded 2019-03-16 11:25:17.452 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Croatian QWERTY" successfully loaded 2019-03-16 11:25:17.453 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Czech QWERTZ" successfully loaded 2019-03-16 11:25:17.454 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Danish QWERTY" successfully loaded 2019-03-16 11:25:17.455 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "English QWERTY" successfully loaded 2019-03-16 11:25:17.455 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "English AZERTY" successfully loaded 2019-03-16 11:25:17.456 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "English ABC" successfully loaded 2019-03-16 11:25:17.457 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "French AZERTY" successfully loaded 2019-03-16 11:25:17.458 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "German QWERTZ" successfully loaded 2019-03-16 11:25:17.458 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "German ABC" successfully loaded 2019-03-16 11:25:17.459 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Greek QWERTY" successfully loaded 2019-03-16 11:25:17.460 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew QWERTY" successfully loaded 2019-03-16 11:25:17.461 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew ABC" successfully loaded 2019-03-16 11:25:17.462 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Hungarian QWERTZ" successfully loaded 2019-03-16 11:25:17.463 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Icelandic QWERTY" successfully loaded 2019-03-16 11:25:17.463 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Italian QWERTY" successfully loaded 2019-03-16 11:25:17.464 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Korean ㄱㄴㄷ" successfully loaded 2019-03-16 11:25:17.465 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian AZERTY" successfully loaded 2019-03-16 11:25:17.466 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian QWERTY" successfully loaded 2019-03-16 11:25:17.467 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Norwegian QWERTY" successfully loaded 2019-03-16 11:25:17.468 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Polish QWERTY" successfully loaded 2019-03-16 11:25:17.469 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Portuguese (Portugal) QWERTY" successfully loaded 2019-03-16 11:25:17.469 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Romanian QWERTY" successfully loaded 2019-03-16 11:25:17.471 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian ЙЦУКЕН" successfully loaded 2019-03-16 11:25:17.471 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian АБВ" successfully loaded 2019-03-16 11:25:17.472 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Silesian QWERTY" successfully loaded 2019-03-16 11:25:17.473 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTZ" successfully loaded 2019-03-16 11:25:17.474 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTY" successfully loaded 2019-03-16 11:25:17.474 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak ABC" successfully loaded 2019-03-16 11:25:17.475 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovenian QWERTZ" successfully loaded 2019-03-16 11:25:17.476 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Spanish QWERTY" successfully loaded 2019-03-16 11:25:17.477 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Swedish QWERTY" successfully loaded 2019-03-16 11:25:17.478 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Thai Kedmanee" successfully loaded 2019-03-16 11:25:17.479 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Turkish QWERTY" successfully loaded 2019-03-16 11:25:17.480 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian ЙЦУКЕН" successfully loaded 2019-03-16 11:25:17.480 T:1937791376 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian АБВ" successfully loaded 2019-03-16 11:25:17.482 T:1937791376 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-16 11:25:17.482 T:1937791376 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-16 11:25:17.485 T:1937791376 DEBUG: Selected UDev as storage provider 2019-03-16 11:25:17.485 T:1937791376 NOTICE: Raspberry PI firmware version: Feb 12 2019 19:46:13 Copyright (c) 2012 Broadcom version 8eff5e4023657a8b3b59e1f90dc966f62d74908c (clean) (release) (start_x) 2019-03-16 11:25:17.485 T:1937791376 NOTICE: ARM mem: 768MB GPU mem: 256MB MPG2:0 WVC1:0 2019-03-16 11:25:17.485 T:1937791376 NOTICE: cache.memorysize: 20MB 2019-03-16 11:25:17.485 T:1937791376 NOTICE: Config: aphy_params_current=819 arm_freq=1200 audio_pwm_mode=514 config_hdmi_boost=5 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 hdmi_ignore_cec_init=1 init_uart_clock=0x2dc6c00 lcd_framerate=60 over_voltage_avs=56250 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-16 11:25:17.486 T:1937791376 NOTICE: Config: device_tree=- 2019-03-16 11:25:17.486 T:1937791376 DEBUG: EGL initial desktop resolution 1280x720 (1280x720) @ 50.00 - Full Screen (1.00) 2019-03-16 11:25:17.486 T:1937791376 DEBUG: EGL get supported modes (2) = 1, prefer_group=1, prefer_mode=13 2019-03-16 11:25:17.486 T:1937791376 DEBUG: EGL mode 0: 640x480 (640x480) @ 60.00 - Full Screen (1.00) :4 2019-03-16 11:25:17.487 T:1937791376 DEBUG: EGL get supported modes (1) = 16, prefer_group=1, prefer_mode=13 2019-03-16 11:25:17.487 T:1937791376 DEBUG: EGL mode 0: 640x480 (640x480) @ 60.00 - Full Screen (1.00) :1 2019-03-16 11:25:17.487 T:1937791376 DEBUG: EGL mode 1: 720x480 (720x480) @ 60.00 - Full Screen (0.89) :2 2019-03-16 11:25:17.487 T:1937791376 DEBUG: EGL mode 2: 720x480 (720x480) @ 60.00 - Full Screen (1.19) :3 2019-03-16 11:25:17.487 T:1937791376 DEBUG: EGL mode 3: 1280x720 (1280x720) @ 60.00 - Full Screen (1.00) N:4 2019-03-16 11:25:17.487 T:1937791376 DEBUG: EGL mode 4: 1920x1080 (1920x1080) @ 60.00i - Full Screen (1.00) I:5 2019-03-16 11:25:17.487 T:1937791376 DEBUG: EGL mode 5: 720x480 (720x480) @ 60.00i - Full Screen (0.89) I:6 2019-03-16 11:25:17.487 T:1937791376 DEBUG: EGL mode 6: 720x480 (720x480) @ 60.00i - Full Screen (1.19) I:7 2019-03-16 11:25:17.487 T:1937791376 DEBUG: EGL mode 7: 1920x1080 (1920x1080) @ 60.00 - Full Screen (1.00) :10 2019-03-16 11:25:17.487 T:1937791376 DEBUG: EGL mode 8: 720x576 (720x576) @ 50.00 - Full Screen (1.07) :11 2019-03-16 11:25:17.487 T:1937791376 DEBUG: EGL mode 9: 720x576 (720x576) @ 50.00 - Full Screen (1.42) :12 2019-03-16 11:25:17.487 T:1937791376 DEBUG: EGL mode 10: 1280x720 (1280x720) @ 50.00 - Full Screen (1.00) N:13 2019-03-16 11:25:17.487 T:1937791376 DEBUG: EGL mode 11: 1920x1080 (1920x1080) @ 50.00i - Full Screen (1.00) I:14 2019-03-16 11:25:17.487 T:1937791376 DEBUG: EGL mode 12: 720x576 (720x576) @ 50.00i - Full Screen (1.07) I:15 2019-03-16 11:25:17.487 T:1937791376 DEBUG: EGL mode 13: 720x576 (720x576) @ 50.00i - Full Screen (1.42) I:16 2019-03-16 11:25:17.488 T:1937791376 DEBUG: EGL mode 14: 1920x1080 (1920x1080) @ 50.00 - Full Screen (1.00) :1f 2019-03-16 11:25:17.488 T:1937791376 DEBUG: EGL mode 15: 1920x1080 (1920x1080) @ 24.00 - Full Screen (1.00) :20 2019-03-16 11:25:17.488 T:1937791376 DEBUG: EGL probe resolution 1280x720 (1280x720) @ 50.00 - Full Screen:13010004 2019-03-16 11:25:17.488 T:1937791376 NOTICE: Found resolution 640 x 480 with 640 x 480 @ 60.000000 Hz 2019-03-16 11:25:17.488 T:1937791376 NOTICE: Found resolution 640 x 480 with 640 x 480 @ 59.940063 Hz 2019-03-16 11:25:17.488 T:1937791376 NOTICE: Found resolution 720 x 480 with 720 x 480 @ 60.000000 Hz 2019-03-16 11:25:17.488 T:1937791376 NOTICE: Found resolution 720 x 480 with 720 x 480 @ 59.940063 Hz 2019-03-16 11:25:17.488 T:1937791376 NOTICE: Found resolution 1280 x 720 with 1280 x 720 @ 60.000000 Hz 2019-03-16 11:25:17.488 T:1937791376 NOTICE: Found resolution 1280 x 720 with 1280 x 720 @ 59.940063 Hz 2019-03-16 11:25:17.488 T:1937791376 NOTICE: Found resolution 1920 x 1080 with 1920 x 1080 @ 60.000000 Hz 2019-03-16 11:25:17.488 T:1937791376 NOTICE: Found resolution 1920 x 1080 with 1920 x 1080 @ 59.940063 Hz 2019-03-16 11:25:17.488 T:1937791376 NOTICE: Found resolution 720 x 576 with 720 x 576 @ 50.000000 Hz 2019-03-16 11:25:17.488 T:1937791376 NOTICE: Found resolution 1280 x 720 with 1280 x 720 @ 50.000000 Hz 2019-03-16 11:25:17.488 T:1937791376 NOTICE: Found resolution 1920 x 1080 with 1920 x 1080 @ 50.000000 Hz 2019-03-16 11:25:17.488 T:1937791376 NOTICE: Found resolution 1920 x 1080 with 1920 x 1080 @ 24.000000 Hz 2019-03-16 11:25:17.488 T:1937791376 NOTICE: Found resolution 1920 x 1080 with 1920 x 1080 @ 23.976025 Hz 2019-03-16 11:25:17.488 T:1937791376 NOTICE: Found (1280x720@50.000000) at 25, setting to RES_DESKTOP at 16 2019-03-16 11:25:17.489 T:1937791376 NOTICE: EGL_VERSION = 1.4 2019-03-16 11:25:17.489 T:1937791376 NOTICE: EGL_VENDOR = Broadcom 2019-03-16 11:25:17.489 T:1937791376 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-16 11:25:17.489 T:1937791376 NOTICE: EGL_CLIENT_EXTENSIONS = NULL 2019-03-16 11:25:17.489 T:1937791376 DEBUG: EGL Config Attributes: 2019-03-16 11:25:17.489 T:1937791376 DEBUG: EGL_BUFFER_SIZE: 32 2019-03-16 11:25:17.489 T:1937791376 DEBUG: EGL_ALPHA_SIZE: 8 2019-03-16 11:25:17.489 T:1937791376 DEBUG: EGL_BLUE_SIZE: 8 2019-03-16 11:25:17.489 T:1937791376 DEBUG: EGL_GREEN_SIZE: 8 2019-03-16 11:25:17.489 T:1937791376 DEBUG: EGL_RED_SIZE: 8 2019-03-16 11:25:17.489 T:1937791376 DEBUG: EGL_DEPTH_SIZE: 24 2019-03-16 11:25:17.489 T:1937791376 DEBUG: EGL_STENCIL_SIZE: 0 2019-03-16 11:25:17.489 T:1937791376 DEBUG: EGL_CONFIG_CAVEAT: 0x3038 2019-03-16 11:25:17.489 T:1937791376 DEBUG: EGL_CONFIG_ID: 3 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_LEVEL: 0 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_MAX_PBUFFER_HEIGHT: 2048 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_MAX_PBUFFER_PIXELS: 4194304 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_MAX_PBUFFER_WIDTH: 2048 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_NATIVE_RENDERABLE: 1 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_NATIVE_VISUAL_ID: 37928 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_NATIVE_VISUAL_TYPE: 0x3038 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_SAMPLES: 0 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_SAMPLE_BUFFERS: 0 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_SURFACE_TYPE: 1639 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_TRANSPARENT_TYPE: 0x3038 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_TRANSPARENT_BLUE_VALUE: 0 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_TRANSPARENT_GREEN_VALUE: 0 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_TRANSPARENT_RED_VALUE: 0 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_BIND_TO_TEXTURE_RGB: 0 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_BIND_TO_TEXTURE_RGBA: 1 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_MIN_SWAP_INTERVAL: 0 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_MAX_SWAP_INTERVAL: 2147483647 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_LUMINANCE_SIZE: 0 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_ALPHA_MASK_SIZE: 0 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_COLOR_BUFFER_TYPE: 0x308e 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_RENDERABLE_TYPE: 7 2019-03-16 11:25:17.490 T:1937791376 DEBUG: EGL_CONFORMANT: 7 2019-03-16 11:25:17.491 T:1937791376 INFO: RetroPlayer[PROCESS]: Registering process control for RPi 2019-03-16 11:25:17.491 T:1937791376 INFO: RetroPlayer[RENDER]: Registering renderer factory for OpenGLES 2019-03-16 11:25:17.491 T:1937791376 NOTICE: Checking resolution 16 2019-03-16 11:25:17.593 T:1906307952 DEBUG: CAESinkPi:Drain delay:100ms now:0ms 2019-03-16 11:25:17.593 T:1906307952 DEBUG: CAESinkPi:Deinitialize 2019-03-16 11:25:17.593 T:1906307952 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 2019-03-16 11:25:17.606 T:1906307952 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x71002f50 2019-03-16 11:25:17.613 T:1937791376 DEBUG: EGL set HDMI mode (1,19)=0 off 2019-03-16 11:25:17.762 T:1850733424 DEBUG: EGL tv_service_callback (8,1,19) 2019-03-16 11:25:17.762 T:1937791376 DEBUG: EGL set resolution 1280x720 -> 1280x720 @ 50.00 fps (1,19) flags:13010004 aspect:1.00 2019-03-16 11:25:17.782 T:1916023664 DEBUG: CActiveAE - display reset event 2019-03-16 11:25:17.782 T:1906307952 INFO: CActiveAESink::OpenSink - initialize sink 2019-03-16 11:25:17.782 T:1906307952 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 2019-03-16 11:25:17.782 T:1906307952 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI 2019-03-16 11:25:17.783 T:1906307952 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 2019-03-16 11:25:17.784 T:1906307952 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x71002f50 2019-03-16 11:25:17.785 T:1906307952 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignment(16) 2019-03-16 11:25:17.786 T:1906307952 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 2019-03-16 11:25:17.786 T:1906307952 DEBUG: Output Device : HDMI 2019-03-16 11:25:17.786 T:1906307952 DEBUG: Sample Rate : 44100 2019-03-16 11:25:17.786 T:1906307952 DEBUG: Sample Format : AE_FMT_FLOAT 2019-03-16 11:25:17.786 T:1906307952 DEBUG: Channel Count : 2 2019-03-16 11:25:17.786 T:1906307952 DEBUG: Channel Layout: FL, FR 2019-03-16 11:25:17.786 T:1906307952 DEBUG: Frames : 2205 2019-03-16 11:25:17.786 T:1906307952 DEBUG: Frame Size : 8 2019-03-16 11:25:17.787 T:1937791376 NOTICE: GL_VENDOR = Broadcom 2019-03-16 11:25:17.787 T:1937791376 NOTICE: GL_RENDERER = VideoCore IV HW 2019-03-16 11:25:17.787 T:1937791376 NOTICE: GL_VERSION = OpenGL ES 2.0 2019-03-16 11:25:17.787 T:1937791376 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 2019-03-16 11:25:17.787 T:1937791376 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-16 11:25:17.788 T:1916023664 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2019-03-16 11:25:17.792 T:1937791376 DEBUG: GL: Vertex Shader compilation log: 2019-03-16 11:25:17.792 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.793 T:1937791376 DEBUG: GL: Pixel Shader compilation log: 2019-03-16 11:25:17.793 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.806 T:1937791376 DEBUG: GL: Vertex Shader compilation log: 2019-03-16 11:25:17.806 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.807 T:1937791376 DEBUG: GL: Pixel Shader compilation log: 2019-03-16 11:25:17.807 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.821 T:1937791376 DEBUG: GL: Vertex Shader compilation log: 2019-03-16 11:25:17.821 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.821 T:1937791376 DEBUG: GL: Pixel Shader compilation log: 2019-03-16 11:25:17.822 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.836 T:1937791376 DEBUG: GL: Vertex Shader compilation log: 2019-03-16 11:25:17.836 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.836 T:1937791376 DEBUG: GL: Pixel Shader compilation log: 2019-03-16 11:25:17.836 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.852 T:1937791376 DEBUG: GL: Vertex Shader compilation log: 2019-03-16 11:25:17.852 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.852 T:1937791376 DEBUG: GL: Pixel Shader compilation log: 2019-03-16 11:25:17.852 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.867 T:1937791376 DEBUG: GL: Vertex Shader compilation log: 2019-03-16 11:25:17.867 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.868 T:1937791376 DEBUG: GL: Pixel Shader compilation log: 2019-03-16 11:25:17.868 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.882 T:1937791376 DEBUG: GL: Vertex Shader compilation log: 2019-03-16 11:25:17.882 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.883 T:1937791376 DEBUG: GL: Pixel Shader compilation log: 2019-03-16 11:25:17.883 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.898 T:1937791376 DEBUG: GL: Vertex Shader compilation log: 2019-03-16 11:25:17.898 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.899 T:1937791376 DEBUG: GL: Pixel Shader compilation log: 2019-03-16 11:25:17.899 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.913 T:1937791376 DEBUG: GL: Vertex Shader compilation log: 2019-03-16 11:25:17.913 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.914 T:1937791376 DEBUG: GL: Pixel Shader compilation log: 2019-03-16 11:25:17.914 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.931 T:1937791376 DEBUG: GL: Vertex Shader compilation log: 2019-03-16 11:25:17.932 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.932 T:1937791376 DEBUG: GL: Pixel Shader compilation log: 2019-03-16 11:25:17.932 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.948 T:1937791376 DEBUG: GL: Vertex Shader compilation log: 2019-03-16 11:25:17.949 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:17.949 T:1937791376 DEBUG: GL: Pixel Shader compilation log: 2019-03-16 11:25:17.949 T:1937791376 DEBUG: Compiled 2019-03-16 11:25:18.088 T:1906307952 DEBUG: CAESinkPi:Drain delay:100ms now:0ms 2019-03-16 11:25:18.088 T:1906307952 DEBUG: CAESinkPi:Deinitialize 2019-03-16 11:25:18.089 T:1906307952 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 2019-03-16 11:25:18.091 T:1906307952 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x71002f50 2019-03-16 11:25:18.099 T:1937791376 DEBUG: EGL set HDMI mode (1,19)=0 off 2019-03-16 11:25:18.243 T:1850733424 DEBUG: EGL tv_service_callback (8,1,19) 2019-03-16 11:25:18.244 T:1937791376 DEBUG: EGL set resolution 1280x720 -> 1280x720 @ 50.00 fps (1,19) flags:13010004 aspect:1.00 2019-03-16 11:25:18.263 T:1916023664 DEBUG: CActiveAE - display reset event 2019-03-16 11:25:18.264 T:1906307952 INFO: CActiveAESink::OpenSink - initialize sink 2019-03-16 11:25:18.264 T:1906307952 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 2019-03-16 11:25:18.264 T:1906307952 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI 2019-03-16 11:25:18.264 T:1906307952 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 2019-03-16 11:25:18.267 T:1906307952 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x71002f50 2019-03-16 11:25:18.269 T:1906307952 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignment(16) 2019-03-16 11:25:18.269 T:1937791376 INFO: GLES: Maximum texture width: 2048 2019-03-16 11:25:18.269 T:1937791376 DEBUG: guilib: Fill viewport on change for solving rendering passes 2019-03-16 11:25:18.270 T:1906307952 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 2019-03-16 11:25:18.270 T:1906307952 DEBUG: Output Device : HDMI 2019-03-16 11:25:18.270 T:1906307952 DEBUG: Sample Rate : 44100 2019-03-16 11:25:18.270 T:1906307952 DEBUG: Sample Format : AE_FMT_FLOAT 2019-03-16 11:25:18.270 T:1906307952 DEBUG: Channel Count : 2 2019-03-16 11:25:18.270 T:1906307952 DEBUG: Channel Layout: FL, FR 2019-03-16 11:25:18.270 T:1906307952 DEBUG: Frames : 2205 2019-03-16 11:25:18.270 T:1906307952 DEBUG: Frame Size : 8 2019-03-16 11:25:18.274 T:1916023664 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2019-03-16 11:25:18.319 T:1937791376 WARNING: COMXImageFile::GetCodingType progressive images not supported by decoder 2019-03-16 11:25:18.320 T:1937791376 DEBUG: COMXImageFile::ReadFile /usr/share/kodi/media/splash.jpg GetCodingType=0x7fffffff (1920x1080) 2019-03-16 11:25:18.320 T:1937791376 NOTICE: LoadJpeg: unable to load /usr/share/kodi/media/splash.jpg 2019-03-16 11:25:19.064 T:1937791376 INFO: GLES: Enabling VSYNC 2019-03-16 11:25:19.065 T:1937791376 INFO: load keymapping 2019-03-16 11:25:19.069 T:1937791376 INFO: Loading special://xbmc/system/keymaps/appcommand.xml 2019-03-16 11:25:19.069 T:1937791376 INFO: Loading special://xbmc/system/keymaps/customcontroller.AppleRemote.xml 2019-03-16 11:25:19.072 T:1937791376 INFO: Loading special://xbmc/system/keymaps/customcontroller.Harmony.xml 2019-03-16 11:25:19.078 T:1937791376 INFO: Loading special://xbmc/system/keymaps/gamepad.xml 2019-03-16 11:25:19.082 T:1937791376 INFO: Loading special://xbmc/system/keymaps/joystick.xml 2019-03-16 11:25:19.087 T:1937791376 INFO: Loading special://xbmc/system/keymaps/keyboard.xml 2019-03-16 11:25:19.101 T:1937791376 INFO: Loading special://xbmc/system/keymaps/mouse.xml 2019-03-16 11:25:19.102 T:1937791376 INFO: Loading special://xbmc/system/keymaps/remote.xml 2019-03-16 11:25:19.111 T:1937791376 INFO: Loading special://xbmc/system/keymaps/touchscreen.xml 2019-03-16 11:25:19.116 T:1937791376 INFO: GUI format 1280x720, Display 1280x720 (1280x720) @ 50.00 - Full Screen 2019-03-16 11:25:19.116 T:1937791376 WARNING: CLangInfo: could not find language add-on 'resource.language.de_de', loading default.. 2019-03-16 11:25:19.116 T:1937791376 INFO: CLangInfo: loading resource.language.en_gb language information... 2019-03-16 11:25:19.122 T:1937791376 DEBUG: trying to set locale to en_US.UTF-8 2019-03-16 11:25:19.154 T:1937791376 INFO: global locale set to C 2019-03-16 11:25:19.155 T:1937791376 INFO: CLangInfo: loading resource.language.en_gb language strings... 2019-03-16 11:25:19.202 T:1937791376 DEBUG: LocalizeStrings: loaded 4009 strings from file resource://resource.language.en_gb/strings.po 2019-03-16 11:25:19.218 T:1937791376 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.kodi.builtin.aac/resources/language/English/strings.po 2019-03-16 11:25:19.219 T:1937791376 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.kodi.builtin.wma/resources/language/English/strings.po 2019-03-16 11:25:19.221 T:1937791376 DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/game.controller.default/resources/language/resource.language.en_gb/strings.po 2019-03-16 11:25:19.225 T:1937791376 DEBUG: LocalizeStrings: loaded 13 strings from file /usr/share/kodi/addons/game.controller.snes/resources/language/resource.language.en_gb/strings.po 2019-03-16 11:25:19.227 T:1937791376 DEBUG: LocalizeStrings: loaded 17 strings from file /usr/share/kodi/addons/metadata.album.universal/resources/language/English/strings.po 2019-03-16 11:25:19.231 T:1937791376 DEBUG: LocalizeStrings: loaded 32 strings from file /usr/share/kodi/addons/metadata.artists.universal/resources/language/English/strings.po 2019-03-16 11:25:19.241 T:1937791376 DEBUG: LocalizeStrings: loaded 7 strings from file /storage/.kodi/addons/metadata.themoviedb.org/resources/language/resource.language.de_de/strings.po 2019-03-16 11:25:19.243 T:1937791376 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-16 11:25:19.243 T:1937791376 DEBUG: LocalizeStrings: loaded 2 strings from file /storage/.kodi/addons/metadata.themoviedb.org/resources/language/resource.language.en_gb/strings.po 2019-03-16 11:25:19.247 T:1937791376 DEBUG: LocalizeStrings: loaded 5 strings from file /storage/.kodi/addons/metadata.tvshows.themoviedb.org/resources/language/English/strings.po 2019-03-16 11:25:19.250 T:1937791376 DEBUG: LocalizeStrings: loaded 9 strings from file /usr/share/kodi/addons/peripheral.joystick/resources/language/English/strings.po 2019-03-16 11:25:19.260 T:1937791376 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-16 11:25:19.261 T:1937791376 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-16 11:25:19.263 T:1937791376 DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/script.program.driverselect/resources/language/resource.language.de_de/strings.po 2019-03-16 11:25:19.264 T:1937791376 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/script.program.driverselect/resources/language/resource.language.en_gb/strings.po 2019-03-16 11:25:19.268 T:1937791376 DEBUG: LocalizeStrings: loaded 230 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/resource.language.de_de/strings.po 2019-03-16 11:25:19.270 T:1937791376 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/resource.language.en_gb/strings.po 2019-03-16 11:25:19.284 T:1937791376 DEBUG: LocalizeStrings: loaded 7 strings from file /storage/.kodi/addons/script.common.plugin.cache/resources/language/English/strings.xml 2019-03-16 11:25:19.289 T:1937791376 DEBUG: LocalizeStrings: loaded 22 strings from file /storage/.kodi/addons/inputstream.adaptive/resources/language/resource.language.en_gb/strings.po 2019-03-16 11:25:19.292 T:1937791376 DEBUG: LocalizeStrings: loaded 29 strings from file /storage/.kodi/addons/script.module.inputstreamhelper/resources/language/resource.language.de_de/strings.po 2019-03-16 11:25:19.294 T:1937791376 DEBUG: POParser: id:30002 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-16 11:25:19.295 T:1937791376 DEBUG: POParser: id:30024 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-16 11:25:19.295 T:1937791376 DEBUG: LocalizeStrings: loaded 14 strings from file /storage/.kodi/addons/script.module.inputstreamhelper/resources/language/resource.language.en_gb/strings.po 2019-03-16 11:25:19.297 T:1808769904 DEBUG: Thread JobWorker start, auto delete: true 2019-03-16 11:25:19.297 T:1808769904 DEBUG: Initialize, updating databases... 2019-03-16 11:25:19.300 T:1808769904 NOTICE: Running database version Addons27 2019-03-16 11:25:19.307 T:1808769904 NOTICE: Running database version ViewModes6 2019-03-16 11:25:19.319 T:1808769904 NOTICE: Running database version Textures13 2019-03-16 11:25:19.340 T:1808769904 NOTICE: Running database version MyMusic72 2019-03-16 11:25:19.372 T:1808769904 NOTICE: Running database version MyVideos116 2019-03-16 11:25:19.381 T:1808769904 NOTICE: Running database version TV32 2019-03-16 11:25:19.387 T:1808769904 NOTICE: Running database version Epg12 2019-03-16 11:25:19.388 T:1808769904 DEBUG: Initialize, updating databases... DONE 2019-03-16 11:25:19.389 T:1937791376 NOTICE: start dvd mediatype detection 2019-03-16 11:25:19.389 T:1919525744 DEBUG: Thread DetectDVDMedia start, auto delete: false 2019-03-16 11:25:19.389 T:1937791376 INFO: DPMS: not supported on this platform 2019-03-16 11:25:19.389 T:1919525744 DEBUG: Compiled with libcdio Version 0.94 2019-03-16 11:25:19.392 T:1919525744 DEBUG: Thread DetectDVDMedia 1919525744 terminating 2019-03-16 11:25:19.432 T:1937777520 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 2019-03-16 11:25:19.433 T:1937777520 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 2019-03-16 11:25:19.452 T:1937791376 INFO: Unloading old skin ... 2019-03-16 11:25:19.456 T:1937791376 NOTICE: load skin from: /usr/share/kodi/addons/skin.estuary (version: 2.0.21) 2019-03-16 11:25:19.456 T:1937791376 INFO: load fonts for skin... 2019-03-16 11:25:19.466 T:1937791376 INFO: Loading skin includes from /usr/share/kodi/addons/skin.estuary/xml/Includes.xml 2019-03-16 11:25:19.633 T:1937791376 INFO: Loading fonts from /usr/share/kodi/addons/skin.estuary/xml/Font.xml 2019-03-16 11:25:19.783 T:1937791376 DEBUG: LocalizeStrings: loaded 139 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.de_de/strings.po 2019-03-16 11:25:19.785 T:1937791376 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.en_gb/strings.po 2019-03-16 11:25:19.785 T:1937791376 INFO: load new skin... 2019-03-16 11:25:19.785 T:1937791376 INFO: Loading custom window XMLs from skin path /usr/share/kodi/addons/skin.estuary/xml 2019-03-16 11:25:19.806 T:1937791376 DEBUG: Load Skin XML: 20.57ms 2019-03-16 11:25:19.806 T:1937791376 INFO: initialize new skin... 2019-03-16 11:25:19.806 T:1937791376 DEBUG: guilib: Fill viewport on change for solving rendering passes 2019-03-16 11:25:19.806 T:1937791376 INFO: Loading skin file: VideoOSD.xml, load type: LOAD_ON_GUI_INIT 2019-03-16 11:25:19.845 T:1937791376 DEBUG: OpenBundle - Opened bundle /usr/share/kodi/addons/skin.estuary/media/Textures.xbt 2019-03-16 11:25:19.867 T:1937791376 INFO: Loading skin file: DialogPVRChannelGuide.xml, load type: LOAD_ON_GUI_INIT 2019-03-16 11:25:19.876 T:1937791376 INFO: Loading skin file: Custom_1109_TopBarOverlay.xml, load type: LOAD_ON_GUI_INIT 2019-03-16 11:25:19.883 T:1937791376 INFO: Loading skin file: DialogPVRChannelsOSD.xml, load type: LOAD_ON_GUI_INIT 2019-03-16 11:25:19.893 T:1937791376 INFO: Loading skin file: DialogNotification.xml, load type: LOAD_ON_GUI_INIT 2019-03-16 11:25:19.896 T:1937791376 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT 2019-03-16 11:25:19.930 T:1937791376 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT 2019-03-16 11:25:19.934 T:1937791376 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT 2019-03-16 11:25:19.937 T:1937791376 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT 2019-03-16 11:25:19.940 T:1937791376 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT 2019-03-16 11:25:19.942 T:1937791376 INFO: Loading skin file: DialogSettings.xml, load type: LOAD_ON_GUI_INIT 2019-03-16 11:25:19.963 T:1937791376 INFO: Previous line repeats 1 times. 2019-03-16 11:25:19.964 T:1937791376 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT 2019-03-16 11:25:19.967 T:1937791376 INFO: Loading skin file: DialogSubtitles.xml, load type: LOAD_ON_GUI_INIT 2019-03-16 11:25:19.983 T:1937791376 INFO: Loading resource://resource.uisounds.kodi/sounds.xml 2019-03-16 11:25:20.057 T:1937791376 INFO: skin loaded... 2019-03-16 11:25:20.057 T:1937791376 DEBUG: Activating window ID: 12997 2019-03-16 11:25:20.057 T:1937791376 DEBUG: ------ Window Init () ------ 2019-03-16 11:25:20.058 T:1937791376 DEBUG: Activating window ID: 12999 2019-03-16 11:25:20.058 T:1937791376 DEBUG: ------ Window Init (Startup.xml) ------ 2019-03-16 11:25:20.058 T:1937791376 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME 2019-03-16 11:25:20.059 T:1937791376 DEBUG: Activating window ID: 10000 2019-03-16 11:25:20.059 T:1937791376 DEBUG: ------ Window Deinit (Startup.xml) ------ 2019-03-16 11:25:20.059 T:1937791376 DEBUG: ------ Window Init (Home.xml) ------ 2019-03-16 11:25:20.059 T:1937791376 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY 2019-03-16 11:25:20.260 T:1937791376 DEBUG: CDirectoryProvider[addons://]: refreshing.. 2019-03-16 11:25:20.261 T:1937791376 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 2019-03-16 11:25:20.261 T:1937791376 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 2019-03-16 11:25:20.261 T:1937791376 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing.. 2019-03-16 11:25:20.261 T:1937791376 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 2019-03-16 11:25:20.261 T:1937791376 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 2019-03-16 11:25:20.261 T:1937791376 DEBUG: CDirectoryProvider[library://video/]: refreshing.. 2019-03-16 11:25:20.261 T:1937791376 DEBUG: CDirectoryProvider[sources://video/]: refreshing.. 2019-03-16 11:25:20.261 T:1937791376 DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing.. 2019-03-16 11:25:20.262 T:1937791376 DEBUG: CDirectoryProvider[favourites://]: refreshing.. 2019-03-16 11:25:20.262 T:1937791376 DEBUG: CDirectoryProvider[sources://pictures/]: refreshing.. 2019-03-16 11:25:20.262 T:1937791376 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing.. 2019-03-16 11:25:20.263 T:1800377200 DEBUG: Thread JobWorker start, auto delete: true 2019-03-16 11:25:20.289 T:1808769904 DEBUG: Previous line repeats 1 times. 2019-03-16 11:25:20.289 T:1808769904 DEBUG: CAddonMgr::GetAvailableUpdates took 28 ms 2019-03-16 11:25:20.330 T:1937791376 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting 2019-03-16 11:25:20.330 T:1937791376 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 2019-03-16 11:25:20.330 T:1937791376 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting") 2019-03-16 11:25:20.331 T:1937791376 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting 2019-03-16 11:25:20.345 T:1808769904 DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3a%2f%2fprofile%2fplaylists%2fvideo/special%3a%2f%2fprofile%2fplaylists%2fmixed/) 2019-03-16 11:25:20.345 T:1808769904 DEBUG: Getting Directory (special://profile/playlists/video) 2019-03-16 11:25:20.347 T:1808769904 DEBUG: Getting Directory (special://profile/playlists/mixed) 2019-03-16 11:25:20.349 T:1808769904 DEBUG: CMultiPathDirectory::MergeItems, items = 0 2019-03-16 11:25:20.366 T:1800377200 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update 2019-03-16 11:25:20.380 T:1800377200 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-16 11:25:20.384 T:1800377200 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-16 11:25:20.387 T:1800377200 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update 2019-03-16 11:25:20.391 T:1937791376 INFO: JSONRPC v10.1.2: Successfully initialized 2019-03-16 11:25:20.394 T:1937791376 DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid" 2019-03-16 11:25:20.394 T:1937791376 DEBUG: LoadMappings - loaded node "CEC Adapter" 2019-03-16 11:25:20.394 T:1937791376 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter" 2019-03-16 11:25:20.394 T:1937791376 DEBUG: LoadMappings - loaded node "iMON HID device" 2019-03-16 11:25:20.395 T:1937791376 DEBUG: LoadMappings - loaded node "WETEK Play remote" 2019-03-16 11:25:20.395 T:1937791376 DEBUG: LoadMappings - loaded node "" 2019-03-16 11:25:20.395 T:1937791376 DEBUG: CPeripheralBusUSB - initialised udev monitor 2019-03-16 11:25:20.396 T:1937791376 DEBUG: Add-on bus: Registering add-on peripheral.joystick 2019-03-16 11:25:20.396 T:1937791376 DEBUG: PERIPHERAL - CreateAddon - creating peripheral add-on instance 'Joystick Support' 2019-03-16 11:25:20.396 T:1937791376 DEBUG: ADDON: Dll Initializing - Joystick Support 2019-03-16 11:25:20.397 T:1937791376 DEBUG: SECTION:LoadDLL(/usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.4.7) 2019-03-16 11:25:20.397 T:1937791376 DEBUG: Loading: /usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.4.7 2019-03-16 11:25:20.415 T:1937791376 DEBUG: AddOnLog: Joystick Support: Loaded 14 joystick families with 97 total joysticks 2019-03-16 11:25:20.416 T:1937791376 DEBUG: Calling TransferSettings for: Joystick Support 2019-03-16 11:25:20.416 T:1937791376 DEBUG: CAddonSettings[peripheral.joystick]: loading setting definitions 2019-03-16 11:25:20.417 T:1937791376 INFO: AddOnLog: Joystick Support: Enabling joystick interface "linux" 2019-03-16 11:25:20.417 T:1775199088 DEBUG: Thread PeripBusUSBUdev start, auto delete: false 2019-03-16 11:25:20.418 T:1766806384 DEBUG: Thread PeripBusCEC start, auto delete: false 2019-03-16 11:25:20.421 T:1800377200 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 2019-03-16 11:25:20.421 T:1758413680 DEBUG: Thread PeripBusAddon start, auto delete: false 2019-03-16 11:25:20.424 T:1937791376 DEBUG: Initialise - initialised peripheral on 'keyboard' with 1 features and 0 sub devices 2019-03-16 11:25:20.424 T:1937791376 NOTICE: Register - new keyboard device registered on application->keyboard: Keyboard (0000:0000) 2019-03-16 11:25:20.425 T:1937791376 DEBUG: Initialise - initialised peripheral on 'mouse' with 1 features and 0 sub devices 2019-03-16 11:25:20.425 T:1937791376 NOTICE: Register - new mouse device registered on application->mouse: Mouse (0000:0000) 2019-03-16 11:25:20.428 T:1800377200 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 <> 'Various artists') 2019-03-16 11:25:20.429 T:1937791376 DEBUG: ContextMenuManager: addon menus reloaded. 2019-03-16 11:25:20.429 T:1937791376 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 2019-03-16 11:25:20.430 T:1937791376 DEBUG: CPlayerCoreConfig::: created player VideoPlayer 2019-03-16 11:25:20.430 T:1937791376 DEBUG: CPlayerCoreConfig::: created player PAPlayer 2019-03-16 11:25:20.430 T:1937791376 DEBUG: CPlayerCoreConfig::: created player RetroPlayer 2019-03-16 11:25:20.430 T:1937791376 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules 2019-03-16 11:25:20.430 T:1937791376 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mms/udp 2019-03-16 11:25:20.430 T:1937791376 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout 2019-03-16 11:25:20.430 T:1937791376 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp 2019-03-16 11:25:20.430 T:1937791376 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp 2019-03-16 11:25:20.430 T:1937791376 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams 2019-03-16 11:25:20.430 T:1937791376 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp 2019-03-16 11:25:20.430 T:1937791376 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2 2019-03-16 11:25:20.430 T:1937791376 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd 2019-03-16 11:25:20.430 T:1937791376 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage 2019-03-16 11:25:20.430 T:1937791376 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf 2019-03-16 11:25:20.430 T:1937791376 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv 2019-03-16 11:25:20.431 T:1937791376 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio 2019-03-16 11:25:20.431 T:1937791376 NOTICE: Loaded playercorefactory configuration 2019-03-16 11:25:20.431 T:1937791376 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 2019-03-16 11:25:20.431 T:1937791376 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 2019-03-16 11:25:20.431 T:1937791376 INFO: removing tempfiles 2019-03-16 11:25:20.438 T:1750020976 DEBUG: Thread PeripEventScanner start, auto delete: false 2019-03-16 11:25:20.447 T:1937791376 DEBUG: CRepositoryUpdater: previous update at 03/16/2019 10:19:07 AM, next at 03/17/2019 10:19:07 AM 2019-03-16 11:25:20.451 T:1937791376 DEBUG: CServiceAddonManager: starting service.libreelec.settings 2019-03-16 11:25:20.452 T:1741628272 DEBUG: Thread Timer start, auto delete: false 2019-03-16 11:25:20.454 T:1733235568 DEBUG: Thread LanguageInvoker start, auto delete: false 2019-03-16 11:25:20.455 T:1733235568 INFO: initializing python engine. 2019-03-16 11:25:20.458 T:1937791376 DEBUG: CServiceAddonManager: starting script.common.plugin.cache 2019-03-16 11:25:20.459 T:1724842864 DEBUG: Thread LanguageInvoker start, auto delete: false 2019-03-16 11:25:20.459 T:1937791376 NOTICE: initialize done 2019-03-16 11:25:20.459 T:1724842864 INFO: initializing python engine. 2019-03-16 11:25:20.459 T:1937791376 NOTICE: Running the application... 2019-03-16 11:25:20.477 T:1937791376 DEBUG: no profile autoexec.py (/storage/.kodi/userdata/autoexec.py) found, skipping 2019-03-16 11:25:20.477 T:1937791376 DEBUG: NetworkMessage - Starting network services 2019-03-16 11:25:20.484 T:1937791376 DEBUG: CZeroconfAvahi::clientCallback: client is up and running 2019-03-16 11:25:20.484 T:1937791376 NOTICE: starting zeroconf publishing 2019-03-16 11:25:20.485 T:1937791376 NOTICE: CWebServer[8080]: Started 2019-03-16 11:25:20.485 T:1791984496 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:Kodi (chaospi) port:8080 2019-03-16 11:25:20.486 T:1800377200 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:Kodi (chaospi) port:8080 2019-03-16 11:25:20.486 T:1791984496 DEBUG: CZeroconfAvahi::addService() named: Kodi (chaospi) type: _xbmc-jsonrpc-h._tcp port:8080 2019-03-16 11:25:20.486 T:1937791376 INFO: JSONRPC Server: Successfully initialized 2019-03-16 11:25:20.487 T:1937791376 DEBUG: SECTION:LoadDLL(libshairplay.so.0) 2019-03-16 11:25:20.487 T:1808769904 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:Kodi (chaospi) port:9090 2019-03-16 11:25:20.489 T:1937791376 DEBUG: Loading: libshairplay.so.0 2019-03-16 11:25:20.492 T:1691272048 DEBUG: Thread EventServer start, auto delete: false 2019-03-16 11:25:20.492 T:1691272048 NOTICE: ES: Starting UDP Event server on port 9777 2019-03-16 11:25:20.493 T:1691272048 NOTICE: UDP: Listening on port 9777 (ipv6 : true) 2019-03-16 11:25:20.494 T:1791984496 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:Kodi (chaospi) port:9777 2019-03-16 11:25:20.494 T:1800377200 DEBUG: CZeroconfAvahi::addService() named: Kodi (chaospi) type: _http._tcp port:8080 2019-03-16 11:25:20.495 T:1682879344 DEBUG: Thread TCPServer start, auto delete: false 2019-03-16 11:25:20.505 T:1800377200 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airtunes type: _raop._tcp name:B827EBBBD8D4@Kodi (chaospi) port:36666 2019-03-16 11:25:20.505 T:1808769904 DEBUG: CZeroconfAvahi::addService() named: Kodi (chaospi) type: _xbmc-jsonrpc._tcp port:9090 2019-03-16 11:25:20.512 T:1791984496 DEBUG: CZeroconfAvahi::addService() named: Kodi (chaospi) type: _xbmc-events._udp port:9777 2019-03-16 11:25:20.518 T:1800377200 DEBUG: CZeroconfAvahi::addService() named: B827EBBBD8D4@Kodi (chaospi) type: _raop._tcp port:36666 2019-03-16 11:25:20.534 T:1733235568 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): start processing 2019-03-16 11:25:20.534 T:1724842864 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/script.common.plugin.cache/default.py): start processing 2019-03-16 11:25:20.534 T:1937791376 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x20b94d0 2019-03-16 11:25:20.536 T:1937791376 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(314128), nBufferAlignment(16) 2019-03-16 11:25:20.540 T:1937791376 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x20a8a20 2019-03-16 11:25:20.543 T:1937791376 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x20a8960 2019-03-16 11:25:20.544 T:1937791376 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 2019-03-16 11:25:20.577 T:1733235568 DEBUG: -->Python Interpreter Initialized<-- 2019-03-16 11:25:20.578 T:1733235568 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): the source file to load is "/usr/share/kodi/addons/service.libreelec.settings/service.py" 2019-03-16 11:25:20.578 T:1733235568 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): setting the Python path to /usr/share/kodi/addons/service.libreelec.settings:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/gtk-2.0 2019-03-16 11:25:20.578 T:1733235568 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): entering source directory /usr/share/kodi/addons/service.libreelec.settings 2019-03-16 11:25:20.598 T:1733235568 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): instantiating addon using automatically obtained id of "service.libreelec.settings" dependent on version 2.1.0 of the xbmc.python api 2019-03-16 11:25:20.688 T:1766806384 DEBUG: GetMappingForDevice - device (2708:1001) mapped to CEC Adapter (type = cec) 2019-03-16 11:25:20.692 T:1766806384 DEBUG: InitialiseFeature - using libCEC v4.0.4 2019-03-16 11:25:20.692 T:1766806384 DEBUG: Initialise - initialised peripheral on 'RPI' with 2 features and 0 sub devices 2019-03-16 11:25:20.692 T:1657701232 DEBUG: Thread CECAdapter start, auto delete: false 2019-03-16 11:25:20.692 T:1766806384 NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001) 2019-03-16 11:25:20.692 T:1657701232 DEBUG: OpenConnection - opening a connection to the CEC adapter: RPI 2019-03-16 11:25:20.692 T:1766806384 DEBUG: Thread PeripBusCEC 1766806384 terminating 2019-03-16 11:25:20.697 T:1937791376 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x20b94d0 2019-03-16 11:25:20.698 T:1937791376 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x20a8a20 2019-03-16 11:25:20.699 T:1937791376 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x20a8960 2019-03-16 11:25:20.699 T:1937791376 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/backgrounds/primary.jpg 1280x720 2019-03-16 11:25:20.713 T:1937791376 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x20b94d0 2019-03-16 11:25:20.714 T:1937791376 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(93824), nBufferAlignment(16) 2019-03-16 11:25:20.718 T:1937791376 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x20a8960 2019-03-16 11:25:20.719 T:1937791376 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 2019-03-16 11:25:20.735 T:1937791376 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x20b94d0 2019-03-16 11:25:20.736 T:1937791376 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x20a8960 2019-03-16 11:25:20.737 T:1937791376 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/backgrounds/pattern1.jpg 900x506 2019-03-16 11:25:20.753 T:1937791376 DEBUG: ------ Window Init () ------ 2019-03-16 11:25:20.759 T:1937791376 DEBUG: ------ Window Init (Pointer.xml) ------ 2019-03-16 11:25:20.901 T:1937791376 DEBUG: ------ Window Init (DialogNotification.xml) ------ 2019-03-16 11:25:20.993 T:1937791376 DEBUG: LogindUPowerSyscall - Received unknown signal NameAcquired 2019-03-16 11:25:21.193 T:1733235568 DEBUG: ## LibreELEC Addon ## 9.0.0 2019-03-16 11:25:21.201 T:1724842864 DEBUG: -->Python Interpreter Initialized<-- 2019-03-16 11:25:21.201 T:1724842864 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/script.common.plugin.cache/default.py): the source file to load is "/storage/.kodi/addons/script.common.plugin.cache/default.py" 2019-03-16 11:25:21.201 T:1724842864 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/script.common.plugin.cache/default.py): setting the Python path to /storage/.kodi/addons/script.common.plugin.cache:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/gtk-2.0 2019-03-16 11:25:21.201 T:1724842864 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/script.common.plugin.cache/default.py): entering source directory /storage/.kodi/addons/script.common.plugin.cache 2019-03-16 11:25:21.202 T:1724842864 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/script.common.plugin.cache/default.py): instantiating addon using automatically obtained id of "script.common.plugin.cache" dependent on version 2.24.0 of the xbmc.python api 2019-03-16 11:25:21.206 T:1724842864 DEBUG: CAddonSettings[script.common.plugin.cache]: loading setting definitions 2019-03-16 11:25:21.206 T:1724842864 DEBUG: CAddonSettings[script.common.plugin.cache]: trying to load setting definitions from old format... 2019-03-16 11:25:21.371 T:1716450160 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 2019-03-16 11:25:21.376 T:1724842864 DEBUG: CAddonSettings[script.common.plugin.cache]: loading setting definitions 2019-03-16 11:25:21.377 T:1724842864 DEBUG: CAddonSettings[script.common.plugin.cache]: trying to load setting definitions from old format... 2019-03-16 11:25:21.380 T:1716450160 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 2019-03-16 11:25:21.507 T:1937791376 DEBUG: Previous line repeats 3 times. 2019-03-16 11:25:21.507 T:1937791376 DEBUG: ------ Window Deinit (Pointer.xml) ------ 2019-03-16 11:25:21.608 T:1724842864 DEBUG: StorageServer Module loaded RUN 2019-03-16 11:25:21.608 T:1724842864 DEBUG: StorageClient-2.5.4 Starting server 2019-03-16 11:25:22.257 T:1657701232 DEBUG: OpenConnection - connection to the CEC adapter opened 2019-03-16 11:25:22.258 T:1657701232 DEBUG: SetConfigurationFromLibCEC - settings updated by libCEC 2019-03-16 11:25:22.258 T:1632969584 DEBUG: Thread CECAdapterUpdate start, auto delete: false 2019-03-16 11:25:23.009 T:1632969584 DEBUG: UpdateMenuLanguage - using TV menu language is disabled 2019-03-16 11:25:23.144 T:1733235568 INFO: ## LibreELEC Addon ## system::set_hostname ## chaospi 2019-03-16 11:25:23.146 T:1733235568 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## us 2019-03-16 11:25:23.147 T:1733235568 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## loadkmap < `ls -1 /usr/lib/keymaps/*/us.bmap` 2019-03-16 11:25:25.178 T:1632969584 DEBUG: UpdateAudioSystemStatus - no CEC capable amplifier found 2019-03-16 11:25:25.783 T:1733235568 INFO: ## LibreELEC Addon ## updates::updateThread ## Started 2019-03-16 11:25:25.786 T:1733235568 INFO: ## LibreELEC Addon ## updates::set_auto_update ## auto 2019-03-16 11:25:25.938 T:1607361392 INFO: ## LibreELEC Addon ## _service_::run ## WAITING: 2019-03-16 11:25:25.954 T:1615754096 INFO: ## LibreELEC Addon ## xdbus Monitor started. ## 2019-03-16 11:25:30.571 T:1937791376 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 2019-03-16 11:25:45.741 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 2019-03-16 11:25:45.742 T:1666093936 DEBUG: PushCecKeypress - added key a7 2019-03-16 11:25:45.784 T:1937791376 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down 2019-03-16 11:25:45.947 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 205 (rep:0 size:0) 2019-03-16 11:25:45.947 T:1666093936 DEBUG: PushCecKeypress - ignored key a7 2019-03-16 11:25:46.416 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 2019-03-16 11:25:46.416 T:1666093936 DEBUG: PushCecKeypress - added key a7 2019-03-16 11:25:46.423 T:1937791376 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down 2019-03-16 11:25:46.491 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 75 (rep:0 size:0) 2019-03-16 11:25:46.491 T:1666093936 DEBUG: PushCecKeypress - ignored key a7 2019-03-16 11:25:46.973 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 2019-03-16 11:25:48.460 T:1666093936 DEBUG: PushCecKeypress - added key a7 2019-03-16 11:25:48.460 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 75 (rep:0 size:1) 2019-03-16 11:25:48.460 T:1666093936 DEBUG: PushCecKeypress - ignored key a7 2019-03-16 11:25:48.460 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:1) 2019-03-16 11:25:48.460 T:1666093936 DEBUG: PushCecKeypress - added key a7 2019-03-16 11:25:48.460 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 73 (rep:0 size:2) 2019-03-16 11:25:48.460 T:1666093936 DEBUG: PushCecKeypress - ignored key a7 2019-03-16 11:25:48.460 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:2) 2019-03-16 11:25:48.460 T:1666093936 DEBUG: PushCecKeypress - added key a7 2019-03-16 11:25:48.460 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 74 (rep:0 size:3) 2019-03-16 11:25:48.460 T:1666093936 DEBUG: PushCecKeypress - ignored key a7 2019-03-16 11:25:48.460 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:3) 2019-03-16 11:25:48.460 T:1666093936 DEBUG: PushCecKeypress - added key a7 2019-03-16 11:25:48.486 T:1937791376 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down 2019-03-16 11:25:48.643 T:1666093936 DEBUG: Previous line repeats 3 times. 2019-03-16 11:25:48.643 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 206 (rep:0 size:0) 2019-03-16 11:25:48.643 T:1666093936 DEBUG: PushCecKeypress - ignored key a7 2019-03-16 11:25:49.480 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 2019-03-16 11:25:49.480 T:1666093936 DEBUG: PushCecKeypress - added key a7 2019-03-16 11:25:49.483 T:1937791376 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down 2019-03-16 11:25:49.522 T:1808769904 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x710252b8 2019-03-16 11:25:49.523 T:1808769904 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 2019-03-16 11:25:49.527 T:1808769904 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x71026650 2019-03-16 11:25:49.528 T:1808769904 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 2019-03-16 11:25:49.537 T:1808769904 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x710252b8 2019-03-16 11:25:49.539 T:1808769904 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x71026650 2019-03-16 11:25:49.540 T:1808769904 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/4/478b2277.jpg 400x400 2019-03-16 11:25:49.555 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 75 (rep:0 size:0) 2019-03-16 11:25:49.555 T:1666093936 DEBUG: PushCecKeypress - ignored key a7 2019-03-16 11:25:50.741 T:1666093936 DEBUG: PushCecKeypress - received key a8 duration 0 (rep:0 size:0) 2019-03-16 11:25:50.742 T:1666093936 DEBUG: PushCecKeypress - added key a8 2019-03-16 11:25:50.777 T:1937791376 DEBUG: HandleKey: 168 (0xa8, obc87) pressed, action is Right 2019-03-16 11:25:50.815 T:1666093936 DEBUG: PushCecKeypress - received key a8 duration 74 (rep:0 size:0) 2019-03-16 11:25:50.815 T:1666093936 DEBUG: PushCecKeypress - ignored key a8 2019-03-16 11:25:51.306 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 2019-03-16 11:25:51.306 T:1666093936 DEBUG: PushCecKeypress - added key a7 2019-03-16 11:25:51.338 T:1937791376 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down 2019-03-16 11:25:51.340 T:1791984496 DEBUG: GetImageHash - unable to stat url /storage/.kodi/addons/plugin.video.skygo.de/fanart.jpg 2019-03-16 11:25:51.379 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 72 (rep:0 size:0) 2019-03-16 11:25:51.379 T:1666093936 DEBUG: PushCecKeypress - ignored key a7 2019-03-16 11:25:52.078 T:1666093936 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 2019-03-16 11:25:53.478 T:1666093936 DEBUG: PushCecKeypress - added key b 2019-03-16 11:25:53.478 T:1666093936 DEBUG: PushCecKeypress - received key b duration 72 (rep:0 size:1) 2019-03-16 11:25:53.478 T:1666093936 DEBUG: PushCecKeypress - replaced key b 2019-03-16 11:25:53.501 T:1937791376 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select 2019-03-16 11:25:53.501 T:1937791376 DEBUG: Activating window ID: 10025 2019-03-16 11:25:53.791 T:1937791376 DEBUG: ------ Window Deinit (Home.xml) ------ 2019-03-16 11:25:53.791 T:1937791376 DEBUG: FreeVisualisation() done 2019-03-16 11:25:53.823 T:1937791376 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 2019-03-16 11:25:53.824 T:1937791376 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 2019-03-16 11:25:54.060 T:1937791376 DEBUG: CDirectoryProvider[]: refreshing.. 2019-03-16 11:25:54.060 T:1800377200 ERROR: GetDirectory - Error getting 2019-03-16 11:25:54.060 T:1937791376 DEBUG: CDirectoryProvider[]: refreshing.. 2019-03-16 11:25:54.061 T:1800377200 ERROR: GetDirectory - Error getting 2019-03-16 11:25:54.061 T:1937791376 DEBUG: CDirectoryProvider[]: refreshing.. 2019-03-16 11:25:54.061 T:1808769904 ERROR: GetDirectory - Error getting 2019-03-16 11:25:54.061 T:1937791376 DEBUG: CDirectoryProvider[]: refreshing.. 2019-03-16 11:25:54.061 T:1808769904 ERROR: GetDirectory - Error getting 2019-03-16 11:25:54.061 T:1937791376 DEBUG: CDirectoryProvider[]: refreshing.. 2019-03-16 11:25:54.061 T:1808769904 ERROR: GetDirectory - Error getting 2019-03-16 11:25:54.061 T:1937791376 DEBUG: CDirectoryProvider[]: refreshing.. 2019-03-16 11:25:54.061 T:1808769904 ERROR: GetDirectory - Error getting 2019-03-16 11:25:54.062 T:1937791376 DEBUG: CDirectoryProvider[]: refreshing.. 2019-03-16 11:25:54.062 T:1808769904 ERROR: GetDirectory - Error getting 2019-03-16 11:25:54.106 T:1937791376 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/) 2019-03-16 11:25:54.106 T:1937791376 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 2019-03-16 11:25:54.107 T:1598251888 DEBUG: Thread waiting start, auto delete: false 2019-03-16 11:25:54.207 T:1937791376 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2019-03-16 11:25:59.113 T:1800377200 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 5007 ms 2019-03-16 11:25:59.114 T:1598251888 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','1','','resume:false') 2019-03-16 11:25:59.115 T:1589859184 DEBUG: Thread LanguageInvoker start, auto delete: false 2019-03-16 11:25:59.115 T:1589859184 INFO: initializing python engine. 2019-03-16 11:25:59.115 T:1589859184 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing 2019-03-16 11:25:59.147 T:1589859184 DEBUG: -->Python Interpreter Initialized<-- 2019-03-16 11:25:59.147 T:1589859184 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo.de/default.py" 2019-03-16 11:25:59.149 T:1589859184 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /storage/.kodi/addons/plugin.video.skygo.de:/storage/.kodi/addons/script.common.plugin.cache/lib:/storage/.kodi/addons/script.module.certifi/lib:/storage/.kodi/addons/script.module.chardet/lib:/storage/.kodi/addons/script.module.cryptopy/lib:/storage/.kodi/addons/script.module.idna/lib:/storage/.kodi/addons/script.module.inputstreamhelper/lib:/storage/.kodi/addons/script.module.pydes/lib:/storage/.kodi/addons/script.module.requests/lib:/storage/.kodi/addons/script.module.routing/lib:/storage/.kodi/addons/script.module.urllib3/lib:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/gtk-2.0 2019-03-16 11:25:59.149 T:1589859184 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de 2019-03-16 11:25:59.149 T:1589859184 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): instantiating addon using automatically obtained id of "plugin.video.skygo.de" dependent on version 2.1.0 of the xbmc.python api 2019-03-16 11:25:59.450 T:1589859184 DEBUG: CAddonSettings[script.common.plugin.cache]: loading setting definitions 2019-03-16 11:25:59.451 T:1589859184 DEBUG: CAddonSettings[script.common.plugin.cache]: trying to load setting definitions from old format... 2019-03-16 11:25:59.455 T:1589859184 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting definitions 2019-03-16 11:25:59.455 T:1589859184 DEBUG: CAddonSettings[plugin.video.skygo.de]: trying to load setting definitions from old format... 2019-03-16 11:25:59.457 T:1589859184 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting values 2019-03-16 11:26:00.231 T:1589859184 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting definitions 2019-03-16 11:26:00.231 T:1589859184 DEBUG: CAddonSettings[plugin.video.skygo.de]: trying to load setting definitions from old format... 2019-03-16 11:26:00.232 T:1589859184 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting values 2019-03-16 11:26:01.639 T:1598251888 DEBUG: Thread waiting 1598251888 terminating 2019-03-16 11:26:01.639 T:1589859184 INFO: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 2019-03-16 11:26:01.644 T:1937791376 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2019-03-16 11:26:01.645 T:1937791376 DEBUG: Saving fileitems [plugin://plugin.video.skygo.de/] 2019-03-16 11:26:01.645 T:1937791376 DEBUG: -- items: 9, sort method: 0, ascending: false 2019-03-16 11:26:01.656 T:1598251888 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-03-16 11:26:01.686 T:1598251888 DEBUG: Thread BackgroundLoader 1598251888 terminating 2019-03-16 11:26:03.678 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 2019-03-16 11:26:03.678 T:1666093936 DEBUG: PushCecKeypress - added key a7 2019-03-16 11:26:03.683 T:1937791376 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down 2019-03-16 11:26:03.751 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 74 (rep:0 size:0) 2019-03-16 11:26:03.751 T:1666093936 DEBUG: PushCecKeypress - ignored key a7 2019-03-16 11:26:05.232 T:1666093936 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 2019-03-16 11:26:05.232 T:1666093936 DEBUG: PushCecKeypress - added key b 2019-03-16 11:26:05.272 T:1937791376 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select 2019-03-16 11:26:05.275 T:1937791376 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listLiveTvChannelDirs&zz) 2019-03-16 11:26:05.275 T:1937791376 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 2019-03-16 11:26:05.278 T:1598251888 DEBUG: Thread waiting start, auto delete: false 2019-03-16 11:26:05.378 T:1937791376 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2019-03-16 11:26:05.431 T:1666093936 DEBUG: PushCecKeypress - received key b duration 200 (rep:0 size:0) 2019-03-16 11:26:05.431 T:1666093936 DEBUG: PushCecKeypress - ignored key b 2019-03-16 11:26:08.799 T:1808769904 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 3524 ms 2019-03-16 11:26:08.799 T:1598251888 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','1','?action=listLiveTvChannelDirs&zz','resume:false') 2019-03-16 11:26:08.799 T:1598251888 DEBUG: GetLanguageInvoker - Reusing LanguageInvokerThread 2 for script /storage/.kodi/addons/plugin.video.skygo.de/default.py 2019-03-16 11:26:08.799 T:1589859184 INFO: initializing python engine. 2019-03-16 11:26:08.799 T:1589859184 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing 2019-03-16 11:26:08.799 T:1589859184 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de 2019-03-16 11:26:08.800 T:1589859184 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): instantiating addon using automatically obtained id of "plugin.video.skygo.de" dependent on version 2.1.0 of the xbmc.python api 2019-03-16 11:26:08.806 T:1589859184 DEBUG: [Sky Go] params = {'action': 'listLiveTvChannelDirs'} 2019-03-16 11:26:08.807 T:1589859184 INFO: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 2019-03-16 11:26:08.808 T:1598251888 DEBUG: Thread waiting 1598251888 terminating 2019-03-16 11:26:08.811 T:1937791376 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2019-03-16 11:26:08.812 T:1937791376 DEBUG: Saving fileitems [plugin://plugin.video.skygo.de/?action=listLiveTvChannelDirs&zz] 2019-03-16 11:26:08.812 T:1937791376 DEBUG: -- items: 4, sort method: 0, ascending: false 2019-03-16 11:26:08.818 T:1598251888 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-03-16 11:26:08.831 T:1598251888 DEBUG: Thread BackgroundLoader 1598251888 terminating 2019-03-16 11:26:10.149 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 2019-03-16 11:26:10.149 T:1666093936 DEBUG: PushCecKeypress - added key a7 2019-03-16 11:26:10.159 T:1937791376 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down 2019-03-16 11:26:10.226 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 77 (rep:0 size:0) 2019-03-16 11:26:10.227 T:1666093936 DEBUG: PushCecKeypress - ignored key a7 2019-03-16 11:26:10.779 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 2019-03-16 11:26:10.780 T:1666093936 DEBUG: PushCecKeypress - added key a7 2019-03-16 11:26:10.819 T:1937791376 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down 2019-03-16 11:26:10.855 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 76 (rep:0 size:0) 2019-03-16 11:26:10.855 T:1666093936 DEBUG: PushCecKeypress - ignored key a7 2019-03-16 11:26:12.927 T:1666093936 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 2019-03-16 11:26:12.927 T:1666093936 DEBUG: PushCecKeypress - added key b 2019-03-16 11:26:12.928 T:1937791376 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select 2019-03-16 11:26:12.930 T:1937791376 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listLiveTvChannels&channeldir_name=cinema&zz) 2019-03-16 11:26:12.930 T:1937791376 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/?action=listLiveTvChannelDirs&zz] 2019-03-16 11:26:12.931 T:1598251888 DEBUG: Thread waiting start, auto delete: false 2019-03-16 11:26:13.000 T:1666093936 DEBUG: PushCecKeypress - received key b duration 73 (rep:0 size:0) 2019-03-16 11:26:13.000 T:1666093936 DEBUG: PushCecKeypress - ignored key b 2019-03-16 11:26:13.031 T:1937791376 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2019-03-16 11:26:18.022 T:1791984496 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 5092 ms 2019-03-16 11:26:18.023 T:1598251888 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','1','?action=listLiveTvChannels&channeldir_name=cinema&zz','resume:false') 2019-03-16 11:26:18.023 T:1598251888 DEBUG: GetLanguageInvoker - Reusing LanguageInvokerThread 2 for script /storage/.kodi/addons/plugin.video.skygo.de/default.py 2019-03-16 11:26:18.023 T:1589859184 INFO: initializing python engine. 2019-03-16 11:26:18.023 T:1589859184 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing 2019-03-16 11:26:18.023 T:1589859184 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de 2019-03-16 11:26:18.023 T:1589859184 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): instantiating addon using automatically obtained id of "plugin.video.skygo.de" dependent on version 2.1.0 of the xbmc.python api 2019-03-16 11:26:18.030 T:1589859184 DEBUG: [Sky Go] params = {'action': 'listLiveTvChannels', 'channeldir_name': 'cinema'} 2019-03-16 11:26:19.741 T:1589859184 INFO: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 2019-03-16 11:26:19.774 T:1598251888 DEBUG: Thread waiting 1598251888 terminating 2019-03-16 11:26:19.774 T:1937791376 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2019-03-16 11:26:19.796 T:1598251888 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-03-16 11:26:19.835 T:1598251888 DEBUG: Thread BackgroundLoader 1598251888 terminating 2019-03-16 11:26:22.539 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 2019-03-16 11:26:22.539 T:1666093936 DEBUG: PushCecKeypress - added key a7 2019-03-16 11:26:22.574 T:1937791376 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down 2019-03-16 11:26:22.612 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 72 (rep:0 size:0) 2019-03-16 11:26:22.612 T:1666093936 DEBUG: PushCecKeypress - ignored key a7 2019-03-16 11:26:23.132 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 2019-03-16 11:26:23.132 T:1666093936 DEBUG: PushCecKeypress - added key a7 2019-03-16 11:26:23.152 T:1937791376 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down 2019-03-16 11:26:23.154 T:1808769904 INFO: easy_acquire - Created session to https://skyticket.sky.de 2019-03-16 11:26:23.203 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 72 (rep:0 size:0) 2019-03-16 11:26:23.203 T:1666093936 DEBUG: PushCecKeypress - ignored key a7 2019-03-16 11:26:23.565 T:1808769904 DEBUG: CCurlFile::GetMimeType - https://skyticket.sky.de/st/bin/EPGEvent/ipad/event_4521085.png|User-Agent=Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/70.0.3538.110 Safari/537.36 -> image/png 2019-03-16 11:26:23.566 T:1808769904 DEBUG: CurlFile::Open(0x20c0770) https://skyticket.sky.de/st/bin/EPGEvent/ipad/event_4521085.png 2019-03-16 11:26:23.653 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 2019-03-16 11:26:23.653 T:1666093936 DEBUG: PushCecKeypress - added key a7 2019-03-16 11:26:23.664 T:1937791376 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down 2019-03-16 11:26:23.674 T:1800377200 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x725210f0 2019-03-16 11:26:23.675 T:1800377200 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 2019-03-16 11:26:23.679 T:1800377200 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x7255d870 2019-03-16 11:26:23.679 T:1800377200 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 2019-03-16 11:26:23.684 T:1800377200 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x725210f0 2019-03-16 11:26:23.685 T:1800377200 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x7255d870 2019-03-16 11:26:23.685 T:1800377200 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/1/17798ccf.jpg 404x227 2019-03-16 11:26:23.727 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 75 (rep:0 size:0) 2019-03-16 11:26:23.728 T:1666093936 DEBUG: PushCecKeypress - ignored key a7 2019-03-16 11:26:24.240 T:1808769904 DEBUG: Caching image 'https://skyticket.sky.de/st/bin/EPGEvent/ipad/event_4521085.png|User-Agent=Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/70.0.3538.110 Safari/537.36' to 'a/a35430ab.jpg': 2019-03-16 11:26:24.241 T:1808769904 DEBUG: cached image 'special://masterprofile/Thumbnails/a/a35430ab.jpg' size 404x227 2019-03-16 11:26:24.242 T:1808769904 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_encode input port 340 output port 341 m_handle 0x5d962590 2019-03-16 11:26:24.243 T:1808769904 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_encode) - port(340), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(399360), nBufferAlignment(16) 2019-03-16 11:26:24.244 T:1808769904 DEBUG: COMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.image_encode) - port(341), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(96960) nBufferAlignment(16) 2019-03-16 11:26:24.254 T:1808769904 DEBUG: COMXImageEnc::CreateThumbnailFromSurface : special://masterprofile/Thumbnails/a/a35430ab.jpg width 404 height 227 2019-03-16 11:26:24.256 T:1808769904 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_encode handle 0x5d962590 2019-03-16 11:26:24.970 T:1666093936 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 2019-03-16 11:26:24.970 T:1666093936 DEBUG: PushCecKeypress - added key b 2019-03-16 11:26:24.996 T:1937791376 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select 2019-03-16 11:26:25.013 T:1937791376 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?parental_rating=12&vod_id=822935&art=%7B%27fanart%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%2C+%27poster%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%2C+%27thumb%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%7D&zz=&action=playVod&infolabels=%7B%27plot%27%3A+u%2710%3A55+-+13%3A25%5Cn%5CnActionfilm%27%2C+%27title%27%3A+u%27Avengers%3A+Infinity+War%27%2C+%27mediatype%27%3A+%27movie%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+9000%2C+%27genre%27%3A+%27%27%7D 2019-03-16 11:26:25.019 T:1937791376 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','1','?parental_rating=12&vod_id=822935&art=%7B%27fanart%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%2C+%27poster%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%2C+%27thumb%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%7D&zz=&action=playVod&infolabels=%7B%27plot%27%3A+u%2710%3A55+-+13%3A25%5Cn%5CnActionfilm%27%2C+%27title%27%3A+u%27Avengers%3A+Infinity+War%27%2C+%27mediatype%27%3A+%27movie%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+9000%2C+%27genre%27%3A+%27%27%7D','resume:false') 2019-03-16 11:26:25.019 T:1937791376 DEBUG: GetLanguageInvoker - Reusing LanguageInvokerThread 2 for script /storage/.kodi/addons/plugin.video.skygo.de/default.py 2019-03-16 11:26:25.019 T:1589859184 INFO: initializing python engine. 2019-03-16 11:26:25.019 T:1589859184 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing 2019-03-16 11:26:25.019 T:1589859184 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de 2019-03-16 11:26:25.019 T:1589859184 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): instantiating addon using automatically obtained id of "plugin.video.skygo.de" dependent on version 2.1.0 of the xbmc.python api 2019-03-16 11:26:25.033 T:1937777520 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 2019-03-16 11:26:25.033 T:1937777520 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 2019-03-16 11:26:25.034 T:1589859184 DEBUG: [Sky Go] params = {'action': 'playVod', 'parental_rating': '12', 'vod_id': '822935', 'art': "{'fanart': u'https://skyticket.sky.de/st/bin/EPGEvent/ipad/event_4521035.png|User-Agent=Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/70.0.3538.110 Safari/537.36', 'poster': u'https://skyticket.sky.de/st/bin/EPGEvent/ipad/event_4521035.png|User-Agent=Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/70.0.3538.110 Safari/537.36', 'thumb': u'https://skyticket.sky.de/st/bin/EPGEvent/ipad/event_4521035.png|User-Agent=Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/70.0.3538.110 Safari/537.36'}", 'infolabels': "{'plot': u'10:55 - 13:25\\n\\nActionfilm', 'title': u'Avengers: Infinity War', 'mediatype': 'movie', 'originaltitle': '', 'cast': [], 'duration': 9000, 'genre': ''}"} 2019-03-16 11:26:25.039 T:1598251888 DEBUG: Thread scriptobs start, auto delete: false 2019-03-16 11:26:25.046 T:1666093936 DEBUG: PushCecKeypress - received key b duration 76 (rep:0 size:0) 2019-03-16 11:26:25.046 T:1666093936 DEBUG: PushCecKeypress - ignored key b 2019-03-16 11:26:25.239 T:1937791376 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2019-03-16 11:26:26.039 T:1589859184 DEBUG: [script.module.inputstreamhelper-0.3.3]: Platform information: ('Linux', 'chaospi', '4.19.23', '#1 SMP Thu Feb 21 04:04:42 CET 2019', 'armv7l', '') 2019-03-16 11:26:27.569 T:1589859184 DEBUG: [script.module.inputstreamhelper-0.3.3]: jsonrpc payload: {'params': {'addonid': 'inputstream.adaptive'}, 'jsonrpc': '2.0', 'id': 1, 'method': 'Addons.GetAddonDetails'} 2019-03-16 11:26:27.570 T:1589859184 DEBUG: [script.module.inputstreamhelper-0.3.3]: jsonrpc response: {"id":1,"jsonrpc":"2.0","result":{"addon":{"addonid":"inputstream.adaptive","type":"kodi.inputstream"}}} 2019-03-16 11:26:27.570 T:1589859184 DEBUG: [script.module.inputstreamhelper-0.3.3]: inputstream.adaptive is installed. 2019-03-16 11:26:27.570 T:1589859184 DEBUG: [script.module.inputstreamhelper-0.3.3]: jsonrpc payload: {'params': {'properties': ['enabled'], 'addonid': 'inputstream.adaptive'}, 'jsonrpc': '2.0', 'id': 1, 'method': 'Addons.GetAddonDetails'} 2019-03-16 11:26:27.571 T:1589859184 DEBUG: [script.module.inputstreamhelper-0.3.3]: jsonrpc response: {"id":1,"jsonrpc":"2.0","result":{"addon":{"addonid":"inputstream.adaptive","enabled":true,"type":"kodi.inputstream"}}} 2019-03-16 11:26:27.572 T:1589859184 DEBUG: [script.module.inputstreamhelper-0.3.3]: inputstream.adaptive 2.3.15.0 is enabled. 2019-03-16 11:26:27.572 T:1589859184 DEBUG: [script.module.inputstreamhelper-0.3.3]: inputstream.adaptive 2.3.15.0 is installed and enabled. 2019-03-16 11:26:29.357 T:1589859184 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 2019-03-16 11:26:29.369 T:1589859184 DEBUG: Previous line repeats 3 times. 2019-03-16 11:26:29.369 T:1589859184 DEBUG: [script.module.inputstreamhelper-0.3.3]: Found Widevine binary at /storage/.kodi/cdm/libwidevinecdm.so 2019-03-16 11:26:32.915 T:1589859184 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 2019-03-16 11:26:38.169 T:1589859184 DEBUG: Previous line repeats 3 times. 2019-03-16 11:26:38.170 T:1589859184 DEBUG: [script.module.inputstreamhelper-0.3.3]: ['ldd', '/storage/.kodi/cdm/libwidevinecdm.so'] cmd executed successfully. 2019-03-16 11:26:38.170 T:1589859184 DEBUG: [script.module.inputstreamhelper-0.3.3]: ['ldd', '/storage/.kodi/cdm/libwidevinecdm.so'] cmd output: linux-vdso.so.1 (0x7eb03000) /usr/lib/libarmmem-v7l.so (0x768de000) libpthread.so.0 => /usr/lib/libpthread.so.0 (0x768b5000) libm.so.6 => /usr/lib/libm.so.6 (0x76837000) libdl.so.2 => /usr/lib/libdl.so.2 (0x76824000) librt.so.1 => /usr/lib/librt.so.1 (0x7680d000) libnss3.so => /usr/lib/libnss3.so (0x7671a000) libnssutil3.so => /usr/lib/libnssutil3.so (0x766e8000) libnspr4.so => /usr/lib/libnspr4.so (0x766b4000) libc.so.6 => /usr/lib/libc.so.6 (0x76577000) /usr/lib/ld-linux-armhf.so.3 (0x76f87000) libplc4.so => /usr/lib/libplc4.so (0x76fae000) libplds4.so => /usr/lib/libplds4.so (0x76faa000) 2019-03-16 11:26:38.170 T:1589859184 DEBUG: [script.module.inputstreamhelper-0.3.3]: There are no missing Widevine libraries! :-) 2019-03-16 11:26:38.171 T:1589859184 DEBUG: CAddonSettings[script.module.inputstreamhelper]: loading setting definitions 2019-03-16 11:26:38.171 T:1589859184 DEBUG: CAddonSettings[script.module.inputstreamhelper]: trying to load setting definitions from old format... 2019-03-16 11:26:38.173 T:1589859184 DEBUG: CAddonSettings[script.module.inputstreamhelper]: loading setting values 2019-03-16 11:26:38.173 T:1589859184 DEBUG: [script.module.inputstreamhelper-0.3.3]: Widevine update check was made on 2019-03-16T11:08:52 2019-03-16 11:26:38.431 T:1589859184 DEBUG: [Sky Go] User still logged in 2019-03-16 11:26:38.450 T:1589859184 INFO: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 2019-03-16 11:26:38.456 T:1937791376 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2019-03-16 11:26:38.456 T:1598251888 DEBUG: Thread scriptobs 1598251888 terminating 2019-03-16 11:26:38.474 T:1937791376 DEBUG: CPlayerCoreFactory::GetPlayers(http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051200____100332002/F30051200____100332002.ism/Manifest) 2019-03-16 11:26:38.474 T:1937791376 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 2019-03-16 11:26:38.474 T:1937791376 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 2019-03-16 11:26:38.474 T:1937791376 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 2019-03-16 11:26:38.474 T:1937791376 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 2019-03-16 11:26:38.474 T:1937791376 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 2019-03-16 11:26:38.475 T:1937791376 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 2019-03-16 11:26:38.475 T:1937791376 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 2019-03-16 11:26:38.475 T:1937791376 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams 2019-03-16 11:26:38.475 T:1937791376 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp 2019-03-16 11:26:38.475 T:1937791376 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2 2019-03-16 11:26:38.475 T:1937791376 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 2019-03-16 11:26:38.475 T:1937791376 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 2019-03-16 11:26:38.475 T:1937791376 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 2019-03-16 11:26:38.475 T:1937791376 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 2019-03-16 11:26:38.476 T:1937791376 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 2019-03-16 11:26:38.476 T:1937791376 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 2019-03-16 11:26:38.476 T:1937791376 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 2019-03-16 11:26:38.476 T:1937791376 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 2019-03-16 11:26:38.476 T:1937791376 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 2019-03-16 11:26:38.476 T:1937791376 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 2019-03-16 11:26:38.479 T:1937791376 DEBUG: CMMALPool::CMMALPool Created pool 0x255eea0 of size 26 x 0 for port vc.ril.video_decode:out:0(I420) 2019-03-16 11:26:38.484 T:1937791376 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 2019-03-16 11:26:38.484 T:1937791376 NOTICE: VideoPlayer::OpenFile: plugin://plugin.video.skygo.de/?parental_rating=12&vod_id=822935&art=%7B%27fanart%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%2C+%27poster%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%2C+%27thumb%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%7D&zz=&action=playVod&infolabels=%7B%27plot%27%3A+u%2710%3A55+-+13%3A25%5Cn%5CnActionfilm%27%2C+%27title%27%3A+u%27Avengers%3A+Infinity+War%27%2C+%27mediatype%27%3A+%27movie%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+9000%2C+%27genre%27%3A+%27%27%7D 2019-03-16 11:26:38.485 T:1937791376 INFO: easy_acquire - Created session to http://skywebvod-s.akamaihd.net 2019-03-16 11:26:38.756 T:1937791376 DEBUG: CCurlFile::GetMimeType - http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051200____100332002/F30051200____100332002.ism/Manifest -> text/xml 2019-03-16 11:26:38.757 T:1937791376 DEBUG: CMMALRenderer::CMMALRenderer 2019-03-16 11:26:38.757 T:1568478064 DEBUG: Thread MMALProcess start, auto delete: false 2019-03-16 11:26:38.757 T:1937791376 DEBUG: OnPlayBackStarted: CApplication::OnPlayBackStarted 2019-03-16 11:26:38.757 T:1560085360 DEBUG: Thread VideoPlayer start, auto delete: false 2019-03-16 11:26:38.757 T:1568478064 DEBUG: CMMALRenderer::Run - starting 2019-03-16 11:26:38.758 T:1560085360 NOTICE: Creating InputStream 2019-03-16 11:26:38.759 T:1560085360 DEBUG: ADDON: Dll Initializing - InputStream Adaptive 2019-03-16 11:26:38.759 T:1560085360 DEBUG: SECTION:LoadDLL(/storage/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.2.3.15) 2019-03-16 11:26:38.759 T:1560085360 DEBUG: Loading: /storage/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.2.3.15 2019-03-16 11:26:38.773 T:1937791376 DEBUG: CVideoGUIInfo::InitCurrentItem(plugin://plugin.video.skygo.de/?parental_rating=12&vod_id=822935&art=%7B%27fanart%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%2C+%27poster%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%2C+%27thumb%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%7D&zz=&action=playVod&infolabels=%7B%27plot%27%3A+u%2710%3A55+-+13%3A25%5Cn%5CnActionfilm%27%2C+%27title%27%3A+u%27Avengers%3A+Infinity+War%27%2C+%27mediatype%27%3A+%27movie%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+9000%2C+%27genre%27%3A+%27%27%7D) 2019-03-16 11:26:38.774 T:1937791376 DEBUG: CPlayerGUIInfo::InitCurrentItem(plugin://plugin.video.skygo.de/?parental_rating=12&vod_id=822935&art=%7B%27fanart%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%2C+%27poster%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%2C+%27thumb%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%7D&zz=&action=playVod&infolabels=%7B%27plot%27%3A+u%2710%3A55+-+13%3A25%5Cn%5CnActionfilm%27%2C+%27title%27%3A+u%27Avengers%3A+Infinity+War%27%2C+%27mediatype%27%3A+%27movie%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+9000%2C+%27genre%27%3A+%27%27%7D) 2019-03-16 11:26:38.775 T:1937777520 DEBUG: CAnnouncementManager - Announcement: OnChanged from xbmc 2019-03-16 11:26:38.775 T:1937777520 DEBUG: GOT ANNOUNCEMENT, type: 1024, from xbmc, message OnChanged 2019-03-16 11:26:38.777 T:1808769904 DEBUG: Loading settings for plugin://plugin.video.skygo.de/?parental_rating=12&vod_id=822935&art=%7B%27fanart%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%2C+%27poster%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%2C+%27thumb%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%7D&zz=&action=playVod&infolabels=%7B%27plot%27%3A+u%2710%3A55+-+13%3A25%5Cn%5CnActionfilm%27%2C+%27title%27%3A+u%27Avengers%3A+Infinity+War%27%2C+%27mediatype%27%3A+%27movie%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+9000%2C+%27genre%27%3A+%27%27%7D 2019-03-16 11:26:38.814 T:1937777520 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 2019-03-16 11:26:38.814 T:1937777520 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 2019-03-16 11:26:38.875 T:1937791376 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2019-03-16 11:26:38.888 T:1560085360 INFO: AddOnLog: InputStream Adaptive: SetVideoResolution (1280 x 720) 2019-03-16 11:26:38.888 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: Open() 2019-03-16 11:26:38.888 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_data: [not shown] 2019-03-16 11:26:38.888 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_flags: persistent_storage 2019-03-16 11:26:38.888 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_key: [not shown] 2019-03-16 11:26:38.888 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_type: com.widevine.alpha 2019-03-16 11:26:38.888 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.manifest_type: ism 2019-03-16 11:26:38.889 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: Initial bandwidth: 4000000 2019-03-16 11:26:38.890 T:1560085360 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 2019-03-16 11:26:38.891 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: MAXRESOLUTION selected: 0 2019-03-16 11:26:38.892 T:1560085360 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 2019-03-16 11:26:38.893 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: MAXRESOLUTIONSECURE selected: 0 2019-03-16 11:26:38.894 T:1560085360 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 2019-03-16 11:26:38.894 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: STREAMSELECTION selected: 0 2019-03-16 11:26:38.896 T:1560085360 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 2019-03-16 11:26:38.902 T:1560085360 DEBUG: Previous line repeats 3 times. 2019-03-16 11:26:38.902 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: Searching for decrypters in: /usr/lib/kodi/addons/inputstream.adaptive/ 2019-03-16 11:26:38.902 T:1560085360 ERROR: GetDirectory - Error getting /usr/lib/kodi/addons/inputstream.adaptive/ 2019-03-16 11:26:38.902 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: Searching for decrypters in: /storage/.kodi/addons/inputstream.adaptive 2019-03-16 11:26:38.957 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: Found decrypter: /storage/.kodi/addons/inputstream.adaptive/libssd_wv.so 2019-03-16 11:26:38.957 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: Supported URN: urn:uuid:EDEF8BA9-79D6-4ACE-A3C8-27DCD51D21ED 2019-03-16 11:26:38.957 T:1560085360 DEBUG: CurlFile::Open(0x21579e8) http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051200____100332002/F30051200____100332002.ism/Manifest 2019-03-16 11:26:39.127 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: Effective URL http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051200____100332002/F30051200____100332002.ism/Manifest 2019-03-16 11:26:39.535 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: Download http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051200____100332002/F30051200____100332002.ism/Manifest finished 2019-03-16 11:26:39.541 T:1560085360 INFO: AddOnLog: InputStream Adaptive: Successfully parsed .mpd file. #Streams: 3 Type: VOD, Download speed: 0.0000 Bytes/s 2019-03-16 11:26:39.543 T:1560085360 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 2019-03-16 11:26:39.548 T:1560085360 DEBUG: Previous line repeats 1 times. 2019-03-16 11:26:39.548 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: Entering encryption section 2019-03-16 11:26:39.819 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: cdm::OnInitialized: true 2019-03-16 11:26:39.824 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: Initializing stream with KID: D693CF739EBC4E01B5785C0B1CB15813 2019-03-16 11:26:45.039 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 1 arrived! 2019-03-16 11:26:45.042 T:1560085360 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Content-Type: ' 2019-03-16 11:26:45.042 T:1560085360 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Expect: ' 2019-03-16 11:26:45.042 T:1560085360 DEBUG: CurlFile::Open(0x21579e8) https://wvguard.sky.de/WidevineLicenser/WidevineLicenser 2019-03-16 11:26:45.042 T:1560085360 INFO: easy_acquire - Created session to https://wvguard.sky.de 2019-03-16 11:26:45.653 T:1560085360 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 500 2019-03-16 11:26:45.653 T:1560085360 ERROR: CCurlFile::Open failed with code 500 for https://wvguard.sky.de/WidevineLicenser/WidevineLicenser: 2019-03-16 11:26:45.655 T:1560085360 ERROR: AddOnLog: InputStream Adaptive: License server returned failure 2019-03-16 11:26:45.655 T:1560085360 ERROR: AddOnLog: InputStream Adaptive: License update not successful (no keys) 2019-03-16 11:26:45.691 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 4 arrived! 2019-03-16 11:26:45.691 T:1560085360 ERROR: AddOnLog: InputStream Adaptive: Initialize failed (SingleSampleDecrypter) 2019-03-16 11:26:45.691 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: Session::~Session() 2019-03-16 11:26:45.693 T:1560085360 ERROR: CVideoPlayer::OpenInputStream - error opening [plugin://plugin.video.skygo.de/?parental_rating=12&vod_id=822935&art=%7B%27fanart%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%2C+%27poster%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%2C+%27thumb%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%7D&zz=&action=playVod&infolabels=%7B%27plot%27%3A+u%2710%3A55+-+13%3A25%5Cn%5CnActionfilm%27%2C+%27title%27%3A+u%27Avengers%3A+Infinity+War%27%2C+%27mediatype%27%3A+%27movie%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+9000%2C+%27genre%27%3A+%27%27%7D] 2019-03-16 11:26:45.694 T:1560085360 NOTICE: CVideoPlayer::OnExit() 2019-03-16 11:26:45.700 T:1560085360 DEBUG: AddOnLog: InputStream Adaptive: Close() 2019-03-16 11:26:45.700 T:1560085360 DEBUG: SECTION:UnloadDll(/storage/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.2.3.15) 2019-03-16 11:26:45.701 T:1560085360 INFO: ADDON: Dll Destroyed - InputStream Adaptive 2019-03-16 11:26:45.701 T:1560085360 DEBUG: Thread VideoPlayer 1560085360 terminating 2019-03-16 11:26:45.704 T:1791984496 INFO: Deleting settings information for files plugin://plugin.video.skygo.de?parental_rating=12&vod_id=822935&art=%7B%27fanart%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%2C+%27poster%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%2C+%27thumb%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%7D&zz=&action=playVod&infolabels=%7B%27plot%27%3A+u%2710%3A55+-+13%3A25%5Cn%5CnActionfilm%27%2C+%27title%27%3A+u%27Avengers%3A+Infinity+War%27%2C+%27mediatype%27%3A+%27movie%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+9000%2C+%27genre%27%3A+%27%27%7D 2019-03-16 11:26:45.706 T:1800377200 DEBUG: DoWork - Saving file state for video item plugin://plugin.video.skygo.de/?parental_rating=12&vod_id=822935&art=%7B%27fanart%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%2C+%27poster%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%2C+%27thumb%27%3A+u%27https%3A%2F%2Fskyticket.sky.de%2Fst%2Fbin%2FEPGEvent%2Fipad%2Fevent_4521035.png%7CUser-Agent%3DMozilla%2F5.0+%28Windows+NT+10.0%3B+Win64%3B+x64%29+AppleWebKit%2F537.36+%28KHTML%2C+like+Gecko%29+Chrome%2F70.0.3538.110+Safari%2F537.36%27%7D&zz=&action=playVod&infolabels=%7B%27plot%27%3A+u%2710%3A55+-+13%3A25%5Cn%5CnActionfilm%27%2C+%27title%27%3A+u%27Avengers%3A+Infinity+War%27%2C+%27mediatype%27%3A+%27movie%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+9000%2C+%27genre%27%3A+%27%27%7D 2019-03-16 11:26:49.136 T:1808769904 DEBUG: OnPlayBackStopped: CApplication::OnPlayBackStopped 2019-03-16 11:26:49.155 T:1937777520 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 2019-03-16 11:26:49.155 T:1937777520 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 2019-03-16 11:26:49.238 T:1937791376 NOTICE: CVideoPlayer::CloseFile() 2019-03-16 11:26:49.238 T:1937791376 DEBUG: DeleteRenderer - deleting renderer 2019-03-16 11:26:49.238 T:1937791376 DEBUG: CMMALRenderer::~CMMALRenderer 2019-03-16 11:26:49.238 T:1937791376 DEBUG: CMMALRenderer::UnInitMMAL 2019-03-16 11:26:49.238 T:1568478064 DEBUG: CMMALRenderer::Run - stopping 2019-03-16 11:26:49.238 T:1568478064 DEBUG: Thread MMALProcess 1568478064 terminating 2019-03-16 11:26:49.238 T:1937791376 NOTICE: VideoPlayer: waiting for threads to exit 2019-03-16 11:26:49.239 T:1937791376 NOTICE: VideoPlayer: finished waiting 2019-03-16 11:26:49.241 T:1937791376 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 2019-03-16 11:26:49.241 T:1937791376 DEBUG: CMMALPool::~CMMALPool Destroying pool 0x255eea0 for port vc.ril.video_decode:out:0(I420) 2019-03-16 11:26:49.249 T:1937791376 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2019-03-16 11:26:53.537 T:1666093936 DEBUG: PushCecKeypress - received key d8 duration 0 (rep:0 size:0) 2019-03-16 11:26:53.537 T:1666093936 DEBUG: PushCecKeypress - added key d8 2019-03-16 11:26:53.571 T:1937791376 DEBUG: HandleKey: menu (0xd8) pressed, action is Back 2019-03-16 11:26:53.573 T:1937791376 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listLiveTvChannelDirs&zz) 2019-03-16 11:26:53.573 T:1937791376 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 2019-03-16 11:26:53.574 T:1937791376 DEBUG: Loading items: 4, directory: plugin://plugin.video.skygo.de/?action=listLiveTvChannelDirs&zz sort method: 0, ascending: false 2019-03-16 11:26:53.740 T:1666093936 DEBUG: PushCecKeypress - received key d8 duration 203 (rep:0 size:0) 2019-03-16 11:26:53.740 T:1666093936 DEBUG: PushCecKeypress - ignored key d8 2019-03-16 11:26:57.279 T:1800377200 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 3706 ms 2019-03-16 11:26:57.285 T:1598251888 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-03-16 11:26:57.298 T:1598251888 DEBUG: Thread BackgroundLoader 1598251888 terminating 2019-03-16 11:26:57.307 T:1937791376 INFO: CheckIdle - Closing session to https://skyticket.sky.de (easy=0x71032c78, multi=0x710c3a20) 2019-03-16 11:27:03.544 T:1666093936 DEBUG: PushCecKeypress - received key d8 duration 0 (rep:0 size:0) 2019-03-16 11:27:03.544 T:1666093936 DEBUG: PushCecKeypress - added key d8 2019-03-16 11:27:03.588 T:1937791376 DEBUG: HandleKey: menu (0xd8) pressed, action is Back 2019-03-16 11:27:03.589 T:1937791376 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/) 2019-03-16 11:27:03.589 T:1937791376 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 2019-03-16 11:27:03.592 T:1937791376 DEBUG: Loading items: 9, directory: plugin://plugin.video.skygo.de/ sort method: 0, ascending: false 2019-03-16 11:27:03.748 T:1666093936 DEBUG: PushCecKeypress - received key d8 duration 204 (rep:0 size:0) 2019-03-16 11:27:03.748 T:1666093936 DEBUG: PushCecKeypress - ignored key d8 2019-03-16 11:27:03.847 T:1808769904 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 259 ms 2019-03-16 11:27:03.853 T:1598251888 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-03-16 11:27:03.868 T:1598251888 DEBUG: Thread BackgroundLoader 1598251888 terminating 2019-03-16 11:27:06.379 T:1666093936 DEBUG: PushCecKeypress - received key d8 duration 0 (rep:0 size:0) 2019-03-16 11:27:06.379 T:1666093936 DEBUG: PushCecKeypress - added key d8 2019-03-16 11:27:06.384 T:1937791376 DEBUG: HandleKey: menu (0xd8) pressed, action is Back 2019-03-16 11:27:06.384 T:1937791376 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 2019-03-16 11:27:06.584 T:1666093936 DEBUG: PushCecKeypress - received key d8 duration 204 (rep:0 size:0) 2019-03-16 11:27:06.584 T:1666093936 DEBUG: PushCecKeypress - ignored key d8 2019-03-16 11:27:06.690 T:1937791376 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 2019-03-16 11:27:06.691 T:1937791376 DEBUG: FreeVisualisation() done 2019-03-16 11:27:06.704 T:1937791376 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 2019-03-16 11:27:06.704 T:1937791376 DEBUG: ------ Window Init (Home.xml) ------ 2019-03-16 11:27:06.704 T:1937791376 DEBUG: CDirectoryProvider[addons://]: refreshing.. 2019-03-16 11:27:06.705 T:1937791376 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 2019-03-16 11:27:06.705 T:1937791376 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 2019-03-16 11:27:06.705 T:1937791376 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing.. 2019-03-16 11:27:06.705 T:1937791376 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 2019-03-16 11:27:06.706 T:1937791376 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 2019-03-16 11:27:06.706 T:1937791376 DEBUG: CDirectoryProvider[library://video/]: refreshing.. 2019-03-16 11:27:06.706 T:1937791376 DEBUG: CDirectoryProvider[sources://video/]: refreshing.. 2019-03-16 11:27:06.706 T:1937791376 DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing.. 2019-03-16 11:27:06.706 T:1937791376 DEBUG: CDirectoryProvider[favourites://]: refreshing.. 2019-03-16 11:27:06.706 T:1937791376 DEBUG: CDirectoryProvider[sources://pictures/]: refreshing.. 2019-03-16 11:27:06.706 T:1937791376 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing.. 2019-03-16 11:27:06.734 T:1791984496 DEBUG: CAddonMgr::GetAvailableUpdates took 29 ms 2019-03-16 11:27:06.743 T:1598251888 DEBUG: Thread JobWorker start, auto delete: true 2019-03-16 11:27:06.744 T:1598251888 DEBUG: GetImageHash - unable to stat url /storage/.kodi/addons/plugin.video.skygo.de/fanart.jpg 2019-03-16 11:27:06.802 T:1791984496 DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3a%2f%2fprofile%2fplaylists%2fvideo/special%3a%2f%2fprofile%2fplaylists%2fmixed/) 2019-03-16 11:27:06.802 T:1791984496 DEBUG: Getting Directory (special://profile/playlists/video) 2019-03-16 11:27:06.803 T:1791984496 DEBUG: Getting Directory (special://profile/playlists/mixed) 2019-03-16 11:27:06.804 T:1791984496 DEBUG: CMultiPathDirectory::MergeItems, items = 0 2019-03-16 11:27:09.876 T:1937791376 INFO: CheckIdle - Closing session to http://skywebvod-s.akamaihd.net (easy=0x219b148, multi=0x2227430) 2019-03-16 11:27:11.813 T:1666093936 DEBUG: PushCecKeypress - received key a9 duration 0 (rep:0 size:0) 2019-03-16 11:27:11.813 T:1666093936 DEBUG: PushCecKeypress - added key a9 2019-03-16 11:27:11.848 T:1937791376 DEBUG: HandleKey: 169 (0xa9, obc86) pressed, action is Left 2019-03-16 11:27:11.884 T:1666093936 DEBUG: PushCecKeypress - received key a9 duration 72 (rep:0 size:0) 2019-03-16 11:27:11.884 T:1666093936 DEBUG: PushCecKeypress - ignored key a9 2019-03-16 11:27:12.897 T:1666093936 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 2019-03-16 11:27:12.897 T:1666093936 DEBUG: PushCecKeypress - added key a6 2019-03-16 11:27:12.914 T:1937791376 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up 2019-03-16 11:27:13.061 T:1666093936 DEBUG: PushCecKeypress - received key a6 duration 165 (rep:0 size:0) 2019-03-16 11:27:13.061 T:1666093936 DEBUG: PushCecKeypress - ignored key a6 2019-03-16 11:27:13.156 T:1666093936 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 2019-03-16 11:27:13.156 T:1666093936 DEBUG: PushCecKeypress - added key a6 2019-03-16 11:27:13.164 T:1937791376 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up 2019-03-16 11:27:13.226 T:1666093936 DEBUG: PushCecKeypress - received key a6 duration 70 (rep:0 size:0) 2019-03-16 11:27:13.226 T:1666093936 DEBUG: PushCecKeypress - ignored key a6 2019-03-16 11:27:13.401 T:1666093936 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 2019-03-16 11:27:13.402 T:1666093936 DEBUG: PushCecKeypress - added key a6 2019-03-16 11:27:13.404 T:1937791376 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up 2019-03-16 11:27:13.472 T:1666093936 DEBUG: PushCecKeypress - received key a6 duration 71 (rep:0 size:0) 2019-03-16 11:27:13.472 T:1666093936 DEBUG: PushCecKeypress - ignored key a6 2019-03-16 11:27:13.772 T:1666093936 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 2019-03-16 11:27:13.772 T:1666093936 DEBUG: PushCecKeypress - added key a6 2019-03-16 11:27:13.784 T:1937791376 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up 2019-03-16 11:27:13.844 T:1666093936 DEBUG: PushCecKeypress - received key a6 duration 73 (rep:0 size:0) 2019-03-16 11:27:13.844 T:1666093936 DEBUG: PushCecKeypress - ignored key a6 2019-03-16 11:27:14.482 T:1666093936 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 2019-03-16 11:27:14.482 T:1666093936 DEBUG: PushCecKeypress - added key a6 2019-03-16 11:27:14.484 T:1937791376 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up 2019-03-16 11:27:14.556 T:1666093936 DEBUG: PushCecKeypress - received key a6 duration 74 (rep:0 size:0) 2019-03-16 11:27:14.556 T:1666093936 DEBUG: PushCecKeypress - ignored key a6 2019-03-16 11:27:15.101 T:1666093936 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 2019-03-16 11:27:15.101 T:1666093936 DEBUG: PushCecKeypress - added key a6 2019-03-16 11:27:16.381 T:1666093936 DEBUG: PushCecKeypress - received key a6 duration 77 (rep:0 size:1) 2019-03-16 11:27:16.381 T:1666093936 DEBUG: PushCecKeypress - ignored key a6 2019-03-16 11:27:16.382 T:1666093936 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 2019-03-16 11:27:16.382 T:1666093936 DEBUG: PushCecKeypress - added key a6 2019-03-16 11:27:16.382 T:1666093936 DEBUG: PushCecKeypress - received key a6 duration 201 (rep:0 size:1) 2019-03-16 11:27:16.382 T:1666093936 DEBUG: PushCecKeypress - ignored key a6 2019-03-16 11:27:16.382 T:1937791376 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up 2019-03-16 11:27:16.388 T:1937791376 INFO: CheckIdle - Closing session to https://wvguard.sky.de (easy=0x250f7b8, multi=0x25f17d8) 2019-03-16 11:27:16.389 T:1937791376 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up 2019-03-16 11:27:17.132 T:1666093936 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 2019-03-16 11:27:17.132 T:1666093936 DEBUG: PushCecKeypress - added key a6 2019-03-16 11:27:17.144 T:1937791376 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up 2019-03-16 11:27:17.336 T:1666093936 DEBUG: PushCecKeypress - received key a6 duration 203 (rep:0 size:0) 2019-03-16 11:27:17.336 T:1666093936 DEBUG: PushCecKeypress - ignored key a6 2019-03-16 11:27:27.769 T:1666093936 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 2019-03-16 11:27:27.769 T:1666093936 DEBUG: PushCecKeypress - added key b 2019-03-16 11:27:27.784 T:1937791376 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select 2019-03-16 11:27:27.784 T:1937791376 DEBUG: Activating window ID: 10111 2019-03-16 11:27:27.784 T:1937791376 DEBUG: ------ Window Init (DialogButtonMenu.xml) ------ 2019-03-16 11:27:27.784 T:1937791376 INFO: Loading skin file: DialogButtonMenu.xml, load type: KEEP_IN_MEMORY 2019-03-16 11:27:27.841 T:1666093936 DEBUG: PushCecKeypress - received key b duration 72 (rep:0 size:0) 2019-03-16 11:27:27.841 T:1666093936 DEBUG: PushCecKeypress - ignored key b 2019-03-16 11:27:29.118 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 2019-03-16 11:27:29.118 T:1666093936 DEBUG: PushCecKeypress - added key a7 2019-03-16 11:27:29.134 T:1937791376 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down 2019-03-16 11:27:29.192 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 75 (rep:0 size:0) 2019-03-16 11:27:29.193 T:1666093936 DEBUG: PushCecKeypress - ignored key a7 2019-03-16 11:27:29.416 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 2019-03-16 11:27:29.416 T:1666093936 DEBUG: PushCecKeypress - added key a7 2019-03-16 11:27:29.460 T:1937791376 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down 2019-03-16 11:27:29.490 T:1666093936 DEBUG: PushCecKeypress - received key a7 duration 75 (rep:0 size:0) 2019-03-16 11:27:29.490 T:1666093936 DEBUG: PushCecKeypress - ignored key a7 2019-03-16 11:27:29.915 T:1666093936 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 2019-03-16 11:27:29.915 T:1666093936 DEBUG: PushCecKeypress - added key b 2019-03-16 11:27:29.929 T:1937791376 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select 2019-03-16 11:27:29.974 T:1937791376 INFO: Saving exitCode 66 2019-03-16 11:27:29.990 T:1666093936 DEBUG: PushCecKeypress - received key b duration 75 (rep:0 size:0) 2019-03-16 11:27:29.990 T:1666093936 DEBUG: PushCecKeypress - ignored key b 2019-03-16 11:27:30.092 T:1937791376 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2019-03-16 11:27:30.095 T:1937777520 DEBUG: CAnnouncementManager - Announcement: OnRestart from xbmc 2019-03-16 11:27:30.095 T:1937777520 DEBUG: GOT ANNOUNCEMENT, type: 8, from xbmc, message OnRestart 2019-03-16 11:27:30.148 T:1568478064 DEBUG: Thread POSIX signal handler start, auto delete: true 2019-03-16 11:27:31.531 T:1568478064 DEBUG: Thread POSIX signal handler 1568478064 terminating (autodelete) 2019-03-16 11:27:31.544 T:1937791376 NOTICE: stop player 2019-03-16 11:27:31.544 T:1937791376 NOTICE: Storing total System Uptime 2019-03-16 11:27:31.544 T:1937777520 DEBUG: CAnnouncementManager - Announcement: OnQuit from xbmc 2019-03-16 11:27:31.544 T:1937777520 DEBUG: GOT ANNOUNCEMENT, type: 8, from xbmc, message OnQuit 2019-03-16 11:27:31.544 T:1937791376 NOTICE: Saving settings 2019-03-16 11:27:31.557 T:1937791376 NOTICE: Saving skin settings 2019-03-16 11:27:31.559 T:1937791376 NOTICE: stop all 2019-03-16 11:27:31.560 T:1598251888 DEBUG: Thread JobWorker 1598251888 terminating (autodelete) 2019-03-16 11:27:31.560 T:1808769904 DEBUG: Thread JobWorker 1808769904 terminating (autodelete) 2019-03-16 11:27:31.560 T:1791984496 DEBUG: Thread JobWorker 1791984496 terminating (autodelete) 2019-03-16 11:27:31.560 T:1800377200 DEBUG: Thread JobWorker 1800377200 terminating (autodelete) 2019-03-16 11:27:31.560 T:1937791376 DEBUG: NetworkMessage - Signaling network services to stop 2019-03-16 11:27:31.560 T:1937791376 NOTICE: ES: Stopping event server 2019-03-16 11:27:31.619 T:1691272048 NOTICE: ES: UDP Event server stopped 2019-03-16 11:27:31.620 T:1691272048 DEBUG: Thread EventServer 1691272048 terminating 2019-03-16 11:27:31.634 T:1682879344 DEBUG: Thread TCPServer 1682879344 terminating 2019-03-16 11:27:31.703 T:1632969584 DEBUG: Thread CECAdapterUpdate 1632969584 terminating 2019-03-16 11:27:31.710 T:1657701232 DEBUG: Process - CEC adapter processor thread ended 2019-03-16 11:27:31.710 T:1657701232 DEBUG: Thread CECAdapter 1657701232 terminating 2019-03-16 11:27:32.292 T:1937791376 DEBUG: CZeroconfAvahi::doRemoveService named: servers.airtunes 2019-03-16 11:27:32.295 T:1937791376 DEBUG: NetworkMessage - Waiting for network services to stop 2019-03-16 11:27:32.295 T:1937791376 NOTICE: stopping zeroconf publishing 2019-03-16 11:27:32.302 T:1937791376 NOTICE: CWebServer[8080]: Stopped 2019-03-16 11:27:32.302 T:1937791376 NOTICE: stop dvd detect media 2019-03-16 11:27:32.302 T:1937791376 DEBUG: CServiceAddonManager: stopping script.common.plugin.cache. 2019-03-16 11:27:32.303 T:1937791376 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/script.common.plugin.cache/default.py): trigger Monitor abort request 2019-03-16 11:27:32.359 T:1724842864 DEBUG: StorageServer-2.5.4 Closed down 2019-03-16 11:27:32.360 T:1724842864 INFO: CPythonInvoker(1, /storage/.kodi/addons/script.common.plugin.cache/default.py): script successfully run 2019-03-16 11:27:32.360 T:1724842864 DEBUG: onExecutionDone(1, /storage/.kodi/addons/script.common.plugin.cache/default.py) 2019-03-16 11:27:32.371 T:1724842864 INFO: Python interpreter interrupted by user 2019-03-16 11:27:32.372 T:1937791376 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/script.common.plugin.cache/default.py): script termination took 69ms 2019-03-16 11:27:32.372 T:1937791376 DEBUG: CServiceAddonManager: stopping service.libreelec.settings. 2019-03-16 11:27:32.372 T:1724842864 DEBUG: Thread LanguageInvoker 1724842864 terminating 2019-03-16 11:27:32.372 T:1937791376 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): trigger Monitor abort request 2019-03-16 11:27:32.373 T:1615754096 INFO: ## LibreELEC Addon ## xdbus Monitor stopped. ## 2019-03-16 11:27:32.397 T:1733235568 DEBUG: ## LibreELEC Addon ## STOP SERVICE DONE ! 2019-03-16 11:27:32.398 T:1607361392 INFO: ## LibreELEC Addon ## _service_::run ## MESSAGE:'exit' 2019-03-16 11:27:32.399 T:1733235568 INFO: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): script successfully run 2019-03-16 11:27:32.399 T:1733235568 INFO: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): waiting on thread 1624146800 2019-03-16 11:27:32.441 T:1624146800 INFO: ## LibreELEC Addon ## updates::updateThread ## Stopped 2019-03-16 11:27:32.500 T:1733235568 DEBUG: onExecutionDone(0, /usr/share/kodi/addons/service.libreelec.settings/service.py) 2019-03-16 11:27:32.526 T:1733235568 INFO: Python interpreter interrupted by user 2019-03-16 11:27:32.527 T:1937791376 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): script termination took 155ms 2019-03-16 11:27:32.527 T:1733235568 DEBUG: Thread LanguageInvoker 1733235568 terminating 2019-03-16 11:27:32.527 T:1916023664 DEBUG: Thread ActiveAE 1916023664 terminating 2019-03-16 11:27:32.576 T:1906307952 DEBUG: Thread AESink 1906307952 terminating 2019-03-16 11:27:32.675 T:1937791376 DEBUG: CAESinkPi:Drain delay:99ms now:0ms 2019-03-16 11:27:32.675 T:1937791376 DEBUG: CAESinkPi:Deinitialize 2019-03-16 11:27:32.676 T:1937791376 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 2019-03-16 11:27:32.685 T:1937791376 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x71002f50 2019-03-16 11:27:32.687 T:1937791376 NOTICE: stopped 2019-03-16 11:27:32.887 T:1937791376 NOTICE: destroy 2019-03-16 11:27:32.888 T:1750020976 DEBUG: Thread PeripEventScanner 1750020976 terminating 2019-03-16 11:27:32.924 T:1775199088 DEBUG: Thread PeripBusUSBUdev 1775199088 terminating 2019-03-16 11:27:33.213 T:1758413680 DEBUG: Thread PeripBusAddon 1758413680 terminating 2019-03-16 11:27:33.420 T:1937791376 INFO: AddOnLog: Joystick Support: Disabling joystick interface "linux" 2019-03-16 11:27:33.420 T:1937791376 DEBUG: SECTION:UnloadDll(/usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.4.7) 2019-03-16 11:27:33.421 T:1937791376 INFO: ADDON: Dll Destroyed - Joystick Support 2019-03-16 11:27:33.422 T:1937791376 NOTICE: unload skin 2019-03-16 11:27:33.422 T:1937791376 INFO: Unloading old skin ... 2019-03-16 11:27:33.431 T:1937791376 DEBUG: ------ Window Deinit () ------ 2019-03-16 11:27:33.434 T:1937791376 DEBUG: ------ Window Deinit (DialogButtonMenu.xml) ------ 2019-03-16 11:27:33.435 T:1937791376 DEBUG: ------ Window Deinit (Home.xml) ------ 2019-03-16 11:27:33.435 T:1937791376 DEBUG: FreeVisualisation() done 2019-03-16 11:27:33.466 T:1937791376 DEBUG: Previous line repeats 2 times. 2019-03-16 11:27:33.467 T:1937791376 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2019-03-16 11:27:33.470 T:1937791376 DEBUG: CloseBundle - Closed bundle 2019-03-16 11:27:33.508 T:1589859184 DEBUG: onExecutionDone(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py) 2019-03-16 11:27:33.585 T:1589859184 INFO: Python interpreter stopped 2019-03-16 11:27:33.585 T:1589859184 INFO: Previous line repeats 3 times. 2019-03-16 11:27:33.585 T:1589859184 DEBUG: Thread LanguageInvoker 1589859184 terminating 2019-03-16 11:27:33.609 T:1937791376 NOTICE: unload sections 2019-03-16 11:27:33.615 T:1937777520 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 2019-03-16 11:27:33.615 T:1937791376 DEBUG: LogindUPowerSyscall - delay lock sleep released 2019-03-16 11:27:33.618 T:1741628272 DEBUG: Thread Timer 1741628272 terminating 2019-03-16 11:27:33.620 T:1937791376 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x187d640 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-03-16 11:27:33.620 T:1937791376 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x184cbc0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-03-16 11:27:33.620 T:1937791376 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x1896108 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-03-16 11:27:33.620 T:1937791376 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x187a490 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-03-16 11:27:33.620 T:1937791376 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x1979da0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-03-16 11:27:33.620 T:1937791376 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x187b628 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-03-16 11:27:33.624 T:1937791376 DEBUG: object 0 --> 0 instances 2019-03-16 11:27:33.624 T:1937791376 DEBUG: object 1 --> 0 instances 2019-03-16 11:27:33.624 T:1937791376 DEBUG: object 2 --> 0 instances 2019-03-16 11:27:33.624 T:1937791376 DEBUG: object 3 --> 0 instances 2019-03-16 11:27:33.624 T:1937791376 DEBUG: object 4 --> 0 instances 2019-03-16 11:27:33.624 T:1937791376 DEBUG: object 5 --> 0 instances 2019-03-16 11:27:33.624 T:1937791376 DEBUG: object 6 --> 0 instances 2019-03-16 11:27:33.624 T:1937791376 DEBUG: object 7 --> 0 instances 2019-03-16 11:27:33.624 T:1937791376 DEBUG: object 8 --> 0 instances 2019-03-16 11:27:33.624 T:1937791376 DEBUG: object 9 --> 0 instances 2019-03-16 11:27:33.765 T:1928328048 DEBUG: Thread libinput 1928328048 terminating 2019-03-16 11:27:33.766 T:1861219184 DEBUG: Thread Lirc 1861219184 terminating 2019-03-16 11:27:33.777 T:1937777520 DEBUG: Thread Announce 1937777520 terminating 2019-03-16 11:27:33.782 T:1937791376 NOTICE: application stopped... 2019-03-16 11:27:33.782 T:1817162608 DEBUG: Thread CRBPWorker 1817162608 terminating