09:29:52.519 T:1942900752 NOTICE: special://profile/ is mapped to: special://masterprofile/ 09:29:52.519 T:1942900752 NOTICE: ----------------------------------------------------------------------- 09:29:52.519 T:1942900752 NOTICE: Starting Kodi (18.0-ALPHA1 Git:f0ec8aa). Platform: Linux ARM 32-bit 09:29:52.519 T:1942900752 NOTICE: Using Debug Kodi x32 build (version for Raspberry Pi) 09:29:52.519 T:1942900752 NOTICE: Kodi compiled Sep 29 2017 by GCC 7.2.0 for Linux ARM 32-bit version 4.13.3 (265475) 09:29:52.520 T:1942900752 NOTICE: Running on LibreELEC (Milhouse): devel-20170929084035-#0928b-g5d02e52 [Build #0928b] 9.0, kernel: Linux ARM 32-bit version 4.13.3 09:29:52.520 T:1942900752 NOTICE: FFmpeg version/source: ffmpeg-3.3-kodi 09:29:52.520 T:1942900752 NOTICE: Host CPU: ARMv7 Processor rev 5 (v7l), 4 cores available 09:29:52.520 T:1942900752 NOTICE: ARM Features: Neon enabled 09:29:52.520 T:1942900752 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi/ 09:29:52.520 T:1942900752 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi 09:29:52.520 T:1942900752 NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons 09:29:52.520 T:1942900752 NOTICE: special://masterprofile/ is mapped to: /storage/.kodi/userdata 09:29:52.520 T:1942900752 NOTICE: special://envhome/ is mapped to: /storage 09:29:52.520 T:1942900752 NOTICE: special://home/ is mapped to: /storage/.kodi 09:29:52.521 T:1942900752 NOTICE: special://temp/ is mapped to: /storage/.kodi/temp 09:29:52.521 T:1942900752 NOTICE: special://logpath/ is mapped to: /storage/.kodi/temp 09:29:52.521 T:1942900752 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin 09:29:52.521 T:1942900752 NOTICE: Local hostname: LibreELEC 09:29:52.521 T:1942900752 NOTICE: Log File is located: /storage/.kodi/temp//kodi.log 09:29:52.521 T:1942900752 NOTICE: ----------------------------------------------------------------------- 09:29:52.865 T:1942900752 NOTICE: load settings... 09:29:52.943 T:1942900752 DEBUG: CSettings: loaded settings definition from special://xbmc/system/settings/settings.xml 09:29:53.003 T:1942900752 DEBUG: CSettings: loaded settings definition from special://xbmc/system/settings/rbp.xml 09:29:53.007 T:1942900752 DEBUG: CSettings: loaded settings definition from special://xbmc/system/settings/rbp2.xml 09:29:53.011 T:1932522384 DEBUG: Thread FDEventMonitor start, auto delete: false 09:29:53.040 T:1942900752 INFO: CAESinkALSA - Unable to open device "default" for playback 09:29:53.091 T:1942900752 DEBUG: PulseAudio: Context authorizing 09:29:53.094 T:1942900752 DEBUG: PulseAudio: Context setting name 09:29:53.094 T:1942900752 DEBUG: PulseAudio: Context ready 09:29:53.098 T:1942900752 NOTICE: Found 2 Lists of Devices 09:29:53.098 T:1942900752 NOTICE: Enumerated PI devices: 09:29:53.098 T:1942900752 NOTICE: Device 1 09:29:53.098 T:1942900752 NOTICE: m_deviceName : HDMI 09:29:53.099 T:1942900752 NOTICE: m_displayName : HDMI 09:29:53.099 T:1942900752 NOTICE: m_displayNameExtra: 09:29:53.099 T:1942900752 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 09:29:53.099 T:1942900752 NOTICE: m_channels : FL, FR 09:29:53.099 T:1942900752 NOTICE: m_sampleRates : 8000,11025,16000,22050,24000,32000,44100,48000,88200,96000,176400,192000 09:29:53.099 T:1942900752 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 09:29:53.099 T:1942900752 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 09:29:53.099 T:1942900752 NOTICE: Device 2 09:29:53.099 T:1942900752 NOTICE: m_deviceName : Analogue 09:29:53.099 T:1942900752 NOTICE: m_displayName : Analogue 09:29:53.099 T:1942900752 NOTICE: m_displayNameExtra: 09:29:53.099 T:1942900752 NOTICE: m_deviceType : AE_DEVTYPE_PCM 09:29:53.099 T:1942900752 NOTICE: m_channels : FL, FR 09:29:53.099 T:1942900752 NOTICE: m_sampleRates : 48000 09:29:53.100 T:1942900752 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 09:29:53.100 T:1942900752 NOTICE: m_streamTypes : No passthrough capabilities 09:29:53.100 T:1942900752 NOTICE: Device 3 09:29:53.100 T:1942900752 NOTICE: m_deviceName : Both 09:29:53.100 T:1942900752 NOTICE: m_displayName : HDMI and Analogue 09:29:53.100 T:1942900752 NOTICE: m_displayNameExtra: 09:29:53.100 T:1942900752 NOTICE: m_deviceType : AE_DEVTYPE_PCM 09:29:53.100 T:1942900752 NOTICE: m_channels : FL, FR 09:29:53.100 T:1942900752 NOTICE: m_sampleRates : 48000 09:29:53.100 T:1942900752 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 09:29:53.100 T:1942900752 NOTICE: m_streamTypes : No passthrough capabilities 09:29:53.100 T:1942900752 NOTICE: Enumerated PULSE devices: 09:29:53.100 T:1942900752 NOTICE: Device 1 09:29:53.100 T:1942900752 NOTICE: m_deviceName : Default 09:29:53.100 T:1942900752 NOTICE: m_displayName : Default 09:29:53.100 T:1942900752 NOTICE: m_displayNameExtra: Bluetooth Audio (PULSEAUDIO) 09:29:53.100 T:1942900752 NOTICE: m_deviceType : AE_DEVTYPE_PCM 09:29:53.101 T:1942900752 NOTICE: m_channels : FL, FR 09:29:53.101 T:1942900752 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000 09:29:53.101 T:1942900752 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT 09:29:53.101 T:1942900752 NOTICE: m_streamTypes : No passthrough capabilities 09:29:53.104 T:1942900752 DEBUG: CSettings: loaded settings definition from special://xbmc/system/settings/appliance.xml 09:29:53.109 T:1942900752 DEBUG: SECTION:LoadDLL(libbluray.so.2) 09:29:53.112 T:1942900752 DEBUG: Loading: libbluray.so.2 09:29:53.223 T:1942900752 DEBUG: CSkinSettings: no tag found 09:29:53.225 T:1942900752 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml 09:29:53.225 T:1942900752 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are... false 1 30 720 540 09:29:53.226 T:1942900752 WARNING: CSettingsManager: missing version attribute 09:29:53.229 T:1942900752 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 09:29:53.229 T:1942900752 NOTICE: Default Video Player: VideoPlayer 09:29:53.229 T:1942900752 NOTICE: Default Audio Player: paplayer 09:29:53.229 T:1942900752 NOTICE: Enabled debug logging due to GUI setting (2) 09:29:53.229 T:1942900752 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 09:29:53.230 T:1942900752 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml 09:29:53.234 T:1942900752 DEBUG: CMediaSourceSettings: tag is missing or sources.xml is malformed 09:29:53.234 T:1942900752 DEBUG: CMediaSourceSettings: tag is missing or sources.xml is malformed 09:29:53.235 T:1942900752 DEBUG: CMediaSourceSettings: tag is missing or sources.xml is malformed 09:29:53.235 T:1942900752 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 09:29:53.236 T:1942900752 DEBUG: CPlayerCoreConfig::: created player VideoPlayer 09:29:53.236 T:1942900752 DEBUG: CPlayerCoreConfig::: created player PAPlayer 09:29:53.236 T:1942900752 DEBUG: CPlayerCoreConfig::: created player RetroPlayer 09:29:53.236 T:1942900752 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules 09:29:53.236 T:1942900752 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mms/udp 09:29:53.236 T:1942900752 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout 09:29:53.237 T:1942900752 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp 09:29:53.237 T:1942900752 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp 09:29:53.237 T:1942900752 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams 09:29:53.237 T:1942900752 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp 09:29:53.237 T:1942900752 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2 09:29:53.237 T:1942900752 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd 09:29:53.237 T:1942900752 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage 09:29:53.237 T:1942900752 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf 09:29:53.237 T:1942900752 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv 09:29:53.237 T:1942900752 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio 09:29:53.237 T:1942900752 NOTICE: Loaded playercorefactory configuration 09:29:53.238 T:1942900752 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 09:29:53.238 T:1942900752 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 09:29:53.272 T:1942900752 INFO: creating subdirectories 09:29:53.272 T:1942900752 INFO: userdata folder: special://masterprofile/ 09:29:53.272 T:1942900752 INFO: recording folder: 09:29:53.272 T:1942900752 INFO: screenshots folder: /storage/screenshots/ 09:29:53.605 T:1942900752 NOTICE: Running database version Addons27 09:29:53.606 T:1942900752 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcpluff-arm.so) 09:29:53.606 T:1942900752 DEBUG: Loading: /usr/lib/kodi/system/libcpluff-arm.so 09:29:54.170 T:1942900752 INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/kodi/addons: No such file or directory' 09:29:54.172 T:1942900752 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.' 09:29:54.172 T:1942900752 NOTICE: ADDON: xbmc.json v8.3.0 installed 09:29:54.172 T:1942900752 NOTICE: ADDON: metadata.common.fanart.tv v3.1.5 installed 09:29:54.172 T:1942900752 NOTICE: ADDON: resource.images.weathericons.default v1.1.8 installed 09:29:54.172 T:1942900752 NOTICE: ADDON: pvr.octonet v999.0.5.0 installed 09:29:54.172 T:1942900752 NOTICE: ADDON: pvr.vbox v999.4.2.0 installed 09:29:54.172 T:1942900752 NOTICE: ADDON: script.module.cryptopy v1.2.6 installed 09:29:54.172 T:1942900752 NOTICE: ADDON: imagedecoder.raw v999.2.0.0 installed 09:29:54.172 T:1942900752 NOTICE: ADDON: repository.xbmc.org v3.0.3 installed 09:29:54.172 T:1942900752 NOTICE: ADDON: webinterface.default v2.4.4 installed 09:29:54.172 T:1942900752 NOTICE: ADDON: kodi.binary.instance.screensaver v2.0.0 installed 09:29:54.172 T:1942900752 NOTICE: ADDON: kodi.binary.instance.videocodec v1.0.1 installed 09:29:54.172 T:1942900752 NOTICE: ADDON: pvr.vdr.vnsi v999.3.4.1 installed 09:29:54.172 T:1942900752 NOTICE: ADDON: screensaver.xbmc.builtin.black v1.0.31 installed 09:29:54.173 T:1942900752 NOTICE: ADDON: peripheral.joystick v999.1.4.2 installed 09:29:54.173 T:1942900752 NOTICE: ADDON: pvr.mediaportal.tvserver v999.3.3.3 installed 09:29:54.173 T:1942900752 NOTICE: ADDON: repository.kodinerds v8.1.103.103 installed 09:29:54.173 T:1942900752 NOTICE: ADDON: script.module.pydes v2.0.1 installed 09:29:54.173 T:1942900752 NOTICE: ADDON: kodi.binary.global.main v1.0.12 installed 09:29:54.173 T:1942900752 NOTICE: ADDON: driver.dvb.crazycat v999.9.0.0 installed 09:29:54.173 T:1942900752 NOTICE: ADDON: game.controller.default v1.0.4 installed 09:29:54.173 T:1942900752 NOTICE: ADDON: kodi.binary.global.gui v5.12.0 installed 09:29:54.173 T:1942900752 NOTICE: ADDON: repository.retroplayer.libreelec.tv v9.0.0 installed 09:29:54.173 T:1942900752 NOTICE: ADDON: screensaver.xbmc.builtin.dim v1.0.35 installed 09:29:54.173 T:1942900752 NOTICE: ADDON: service.libreelec.settings v9.0.0 installed 09:29:54.173 T:1942900752 NOTICE: ADDON: metadata.themoviedb.org v3.9.5 installed 09:29:54.173 T:1942900752 NOTICE: ADDON: kodi.binary.global.general v1.0.3 installed 09:29:54.173 T:1942900752 NOTICE: ADDON: kodi.binary.instance.audioencoder v2.0.0 installed 09:29:54.173 T:1942900752 NOTICE: ADDON: pvr.wmc v999.2.2.0 installed 09:29:54.173 T:1942900752 NOTICE: ADDON: xbmc.metadata v2.1.0 installed 09:29:54.173 T:1942900752 NOTICE: ADDON: inputstream.rtmp v999.2.0.1 installed 09:29:54.174 T:1942900752 NOTICE: ADDON: pvr.dvblink v999.4.4.1 installed 09:29:54.174 T:1942900752 NOTICE: ADDON: pvr.hdhomerun v999.3.1.5 installed 09:29:54.174 T:1942900752 NOTICE: ADDON: kodi.binary.instance.peripheral v1.3.4 installed 09:29:54.174 T:1942900752 NOTICE: ADDON: kodi.resource v1.0.0 installed 09:29:54.174 T:1942900752 NOTICE: ADDON: script.common.plugin.cache v2.5.8 installed 09:29:54.174 T:1942900752 NOTICE: ADDON: script.module.pil v1.1.7 installed 09:29:54.174 T:1942900752 NOTICE: ADDON: xbmc.gui v5.13.0 installed 09:29:54.174 T:1942900752 NOTICE: ADDON: os.openelec.tv v9.0 installed 09:29:54.174 T:1942900752 NOTICE: ADDON: inputstream.adaptive v999.2.1.4 installed 09:29:54.174 T:1942900752 NOTICE: ADDON: pvr.mythtv v999.5.4.1 installed 09:29:54.174 T:1942900752 NOTICE: ADDON: pvr.vuplus v999.3.5.2 installed 09:29:54.174 T:1942900752 NOTICE: ADDON: repository.kodi.game v1.0.0 installed 09:29:54.174 T:1942900752 NOTICE: ADDON: xbmc.core v0.1.0 installed 09:29:54.174 T:1942900752 NOTICE: ADDON: script.module.requests v2.12.4 installed 09:29:54.174 T:1942900752 NOTICE: ADDON: os.libreelec.tv v9.0 installed 09:29:54.174 T:1942900752 NOTICE: ADDON: pvr.demo v999.3.2.1 installed 09:29:54.175 T:1942900752 NOTICE: ADDON: audioencoder.kodi.builtin.aac v1.0.0 installed 09:29:54.175 T:1942900752 NOTICE: ADDON: audioencoder.kodi.builtin.wma v1.0.0 installed 09:29:54.175 T:1942900752 NOTICE: ADDON: kodi.binary.instance.imagedecoder v2.0.0 installed 09:29:54.175 T:1942900752 NOTICE: ADDON: kodi.binary.instance.vfs v2.0.0 installed 09:29:54.175 T:1942900752 NOTICE: ADDON: pvr.iptvsimple v999.3.3.1 installed 09:29:54.175 T:1942900752 NOTICE: ADDON: repository.libreelec.tv v9.0.0 installed 09:29:54.175 T:1942900752 NOTICE: ADDON: pvr.njoy v999.3.2.0 installed 09:29:54.175 T:1942900752 NOTICE: ADDON: pvr.nextpvr v999.3.2.1 installed 09:29:54.175 T:1942900752 NOTICE: ADDON: script.module.pycryptodome v3.4.3 installed 09:29:54.175 T:1942900752 NOTICE: ADDON: script.module.routing v0.2.0 installed 09:29:54.175 T:1942900752 NOTICE: ADDON: metadata.album.universal v2.7.3 installed 09:29:54.175 T:1942900752 NOTICE: ADDON: kodi.binary.instance.adsp v0.2.0 installed 09:29:54.175 T:1942900752 NOTICE: ADDON: kodi.binary.instance.game v1.0.32 installed 09:29:54.175 T:1942900752 NOTICE: ADDON: kodi.binary.global.audioengine v1.0.1 installed 09:29:54.175 T:1942900752 NOTICE: ADDON: metadata.common.htbackdrops.com v1.3.4 installed 09:29:54.175 T:1942900752 NOTICE: ADDON: pvr.dvbviewer v999.3.3.1 installed 09:29:54.175 T:1942900752 NOTICE: ADDON: resource.language.en_gb v2.0.1 installed 09:29:54.175 T:1942900752 NOTICE: ADDON: kodi.binary.instance.pvr v5.7.1 installed 09:29:54.176 T:1942900752 NOTICE: ADDON: pvr.teleboy v999.18.0.5 installed 09:29:54.176 T:1942900752 NOTICE: ADDON: kodi.binary.instance.audiodecoder v2.0.0 installed 09:29:54.176 T:1942900752 NOTICE: ADDON: metadata.tvdb.com v1.8.5 installed 09:29:54.176 T:1942900752 NOTICE: ADDON: metadata.common.musicbrainz.org v2.1.2 installed 09:29:54.176 T:1942900752 NOTICE: ADDON: plugin.video.skygo.de v1.10.6.1 installed 09:29:54.176 T:1942900752 NOTICE: ADDON: metadata.common.allmusic.com v3.1.1 installed 09:29:54.176 T:1942900752 NOTICE: ADDON: kodi.binary.global.network v1.0.0 installed 09:29:54.176 T:1942900752 NOTICE: ADDON: metadata.local v1.0.0 installed 09:29:54.176 T:1942900752 NOTICE: ADDON: kodi.binary.instance.inputstream v2.0.4 installed 09:29:54.176 T:1942900752 NOTICE: ADDON: xbmc.webinterface v1.0.0 installed 09:29:54.176 T:1942900752 NOTICE: ADDON: pvr.zattoo v999.18.0.17 installed 09:29:54.176 T:1942900752 NOTICE: ADDON: resource.language.de_de v9.0.0 installed 09:29:54.176 T:1942900752 NOTICE: ADDON: metadata.common.themoviedb.org v2.16.0 installed 09:29:54.176 T:1942900752 NOTICE: ADDON: kodi.binary.global.filesystem v1.0.2 installed 09:29:54.176 T:1942900752 NOTICE: ADDON: resource.uisounds.kodi v1.0.0 installed 09:29:54.176 T:1942900752 NOTICE: ADDON: metadata.artists.universal v3.7.3 installed 09:29:54.176 T:1942900752 NOTICE: ADDON: metadata.common.theaudiodb.com v1.9.1 installed 09:29:54.177 T:1942900752 NOTICE: ADDON: metadata.common.imdb.com v2.8.8 installed 09:29:54.177 T:1942900752 NOTICE: ADDON: xbmc.python v2.25.0 installed 09:29:54.177 T:1942900752 NOTICE: ADDON: kodi.binary.instance.visualization v2.0.1 installed 09:29:54.177 T:1942900752 NOTICE: ADDON: pvr.hts v999.4.2.1 installed 09:29:54.177 T:1942900752 NOTICE: ADDON: xbmc.addon v17.9.701 installed 09:29:54.177 T:1942900752 NOTICE: ADDON: skin.estuary v2.0.4 installed 16:23:54.195 T:1942900752 DEBUG: CFavourites::Load - no system favourites found, skipping 16:23:54.195 T:1942900752 DEBUG: CFavourites::Load - no userdata favourites found, skipping 16:23:54.196 T:1854927760 DEBUG: Thread RemoteControl start, auto delete: false 16:23:54.196 T:1854927760 INFO: LIRC Process: using: /run/lirc/lircd 16:23:54.196 T:1920533392 DEBUG: Thread ActiveAE start, auto delete: false 16:23:54.197 T:1910502288 DEBUG: Thread AESink start, auto delete: false 16:23:54.197 T:1854927760 INFO: LIRC Connect: successfully started 16:23:54.197 T:1920533392 DEBUG: CSettingsManager: requested setting (audiooutput.dspaddonsenabled) was not found. 16:23:54.197 T:1854927760 DEBUG: Thread RemoteControl 1854927760 terminating 16:23:54.197 T:1910502288 INFO: CActiveAESink::OpenSink - initialize sink 16:23:54.197 T:1910502288 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 16:23:54.197 T:1910502288 DEBUG: DllBcm: Using omx system library 16:23:54.200 T:1910502288 DEBUG: SECTION:LoadDLL(libopenmaxil.so) 16:23:54.204 T:1910502288 DEBUG: Loading: libopenmaxil.so 16:23:54.209 T:1910502288 DEBUG: Raspberry PI resuming video output 16:23:54.210 T:1910502288 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:8816 bytes/s=352800.00 dest=PI:HDMI 16:23:54.210 T:1846539152 DEBUG: Thread CRBPWorker start, auto delete: false 16:23:54.210 T:1910502288 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 16:23:54.212 T:1910502288 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x71400758 16:23:54.214 T:1910502288 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(8816), nBufferAlignment(16) 16:23:54.215 T:1910502288 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 16:23:54.215 T:1910502288 DEBUG: Output Device : HDMI 16:23:54.215 T:1910502288 DEBUG: Sample Rate : 44100 16:23:54.215 T:1910502288 DEBUG: Sample Format : AE_FMT_FLOAT 16:23:54.215 T:1910502288 DEBUG: Channel Count : 2 16:23:54.215 T:1910502288 DEBUG: Channel Layout: FL, FR 16:23:54.215 T:1910502288 DEBUG: Frames : 1102 16:23:54.215 T:1910502288 DEBUG: Frame Size : 8 16:23:54.234 T:1942900752 INFO: CKeyboardLayoutManager: loading keyboard layouts from special://xbmc/system/keyboardlayouts... 16:23:54.259 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Arabic QWERTY" successfully loaded 16:23:54.261 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian ЯВЕРТЪ" successfully loaded 16:23:54.262 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian АБВ" successfully loaded 16:23:54.264 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BasePY" successfully loaded 16:23:54.265 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BaiduPY" successfully loaded 16:23:54.267 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Croatian QWERTY" successfully loaded 16:23:54.268 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Czech QWERTZ" successfully loaded 16:23:54.270 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Danish QWERTY" successfully loaded 16:23:54.272 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "English QWERTY" successfully loaded 16:23:54.273 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "English AZERTY" successfully loaded 16:23:54.274 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "English ABC" successfully loaded 16:23:54.275 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "French AZERTY" successfully loaded 16:23:54.277 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "German QWERTZ" successfully loaded 16:23:54.278 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "German ABC" successfully loaded 16:23:54.280 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Greek QWERTY" successfully loaded 16:23:54.282 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew QWERTY" successfully loaded 16:23:54.283 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew ABC" successfully loaded 16:23:54.284 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Hungarian QWERTZ" successfully loaded 16:23:54.286 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Icelandic QWERTY" successfully loaded 16:23:54.288 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Italian QWERTY" successfully loaded 16:23:54.289 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Korean ㄱㄴㄷ" successfully loaded 16:23:54.291 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian AZERTY" successfully loaded 16:23:54.292 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian QWERTY" successfully loaded 16:23:54.294 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Norwegian QWERTY" successfully loaded 16:23:54.295 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Polish QWERTY" successfully loaded 16:23:54.297 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Portuguese (Portugal) QWERTY" successfully loaded 16:23:54.298 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Romanian QWERTY" successfully loaded 16:23:54.300 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian ЙЦУКЕН" successfully loaded 16:23:54.301 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian АБВ" successfully loaded 16:23:54.303 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Silesian QWERTY" successfully loaded 16:23:54.306 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTZ" successfully loaded 16:23:54.307 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTY" successfully loaded 16:23:54.308 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak ABC" successfully loaded 16:23:54.309 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovenian QWERTZ" successfully loaded 16:23:54.311 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Spanish QWERTY" successfully loaded 16:23:54.313 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Swedish QWERTY" successfully loaded 16:23:54.314 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Thai Kedmanee" successfully loaded 16:23:54.316 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Turkish QWERTY" successfully loaded 16:23:54.318 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian ЙЦУКЕН" successfully loaded 16:23:54.319 T:1942900752 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian АБВ" successfully loaded 16:23:54.329 T:1942900752 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 16:23:54.335 T:1942900752 DEBUG: Selected UDev as storage provider 16:23:54.336 T:1942900752 NOTICE: Raspberry PI firmware version: Sep 22 2017 21:36:43 Copyright (c) 2012 Broadcom version f5217b8887607d0dd890a434de9c73d9aa9a7c0f (clean) (release) 16:23:54.336 T:1942900752 NOTICE: ARM mem: 768MB GPU mem: 256MB MPG2:0 WVC1:0 16:23:54.336 T:1942900752 NOTICE: cache.memorysize: 20MB libass.cache: 21MB 16:23:54.336 T:1942900752 NOTICE: Config: arm_freq=900 audio_pwm_mode=1 config_hdmi_boost=5 disable_commandline_tags=2 disable_l2cache=1 enable_uart=1 force_eeprom_read=1 force_pwm_open=1 framebuffer_ignore_alpha=1 framebuffer_swap=1 hdmi_channel_map=8 hdmi_force_cec_address=65535 hdmi_ignore_cec_init=1 init_uart_clock=0x2dc6c00 lcd_framerate=60 over_voltage_avs=0x1b774 over_voltage_avs_boost=0x155cc overscan_bottom=48 overscan_left=48 overscan_right=48 overscan_top=48 pause_burst_frames=1 program_serial_random=1 sdram_freq=450 temp_limit=85 16:23:54.337 T:1942900752 NOTICE: Config: device_tree=- 16:23:54.337 T:1942900752 DEBUG: EGL initial desktop resolution 1920x1080 (1920x1080) @ 60.00 - Full Screen (1.00) 16:23:54.338 T:1942900752 DEBUG: EGL get supported modes (2) = 3, prefer_group=1, prefer_mode=10 16:23:54.338 T:1942900752 DEBUG: EGL mode 0: 640x480 (640x480) @ 60.00 - Full Screen (1.00) :4 16:23:54.338 T:1942900752 DEBUG: EGL mode 1: 800x600 (800x600) @ 60.00 - Full Screen (1.00) :9 16:23:54.338 T:1942900752 DEBUG: EGL mode 2: 1024x768 (1024x768) @ 60.00 - Full Screen (1.00) :10 16:23:54.339 T:1942900752 DEBUG: EGL get supported modes (1) = 21, prefer_group=1, prefer_mode=10 16:23:54.339 T:1942900752 DEBUG: EGL mode 0: 640x480 (640x480) @ 60.00 - Full Screen (1.00) :1 16:23:54.339 T:1942900752 DEBUG: EGL mode 1: 720x480 (720x480) @ 60.00 - Full Screen (0.89) :2 16:23:54.339 T:1942900752 DEBUG: EGL mode 2: 720x480 (720x480) @ 60.00 - Full Screen (1.19) :3 16:23:54.339 T:1942900752 DEBUG: EGL mode 3: 1280x720 (1280x720) @ 60.00 - Full Screen (1.00) :4 16:23:54.339 T:1942900752 DEBUG: EGL mode 4: 1920x1080 (1920x1080) @ 60.00i - Full Screen (1.00) I:5 16:23:54.339 T:1942900752 DEBUG: EGL mode 5: 720x480 (720x480) @ 60.00i - Full Screen (0.89) I:6 16:23:54.339 T:1942900752 DEBUG: EGL mode 6: 720x480 (720x480) @ 60.00i - Full Screen (1.19) I:7 16:23:54.340 T:1942900752 DEBUG: EGL mode 7: 720x480 (720x480) @ 60.00 - Full Screen (0.89) :e 16:23:54.340 T:1942900752 DEBUG: EGL mode 8: 720x480 (720x480) @ 60.00 - Full Screen (1.19) :f 16:23:54.340 T:1942900752 DEBUG: EGL mode 9: 1920x1080 (1920x1080) @ 60.00 - Full Screen (1.00) N:10 16:23:54.340 T:1942900752 DEBUG: EGL mode 10: 720x576 (720x576) @ 50.00 - Full Screen (1.07) :11 16:23:54.340 T:1942900752 DEBUG: EGL mode 11: 720x576 (720x576) @ 50.00 - Full Screen (1.42) :12 16:23:54.340 T:1942900752 DEBUG: EGL mode 12: 1280x720 (1280x720) @ 50.00 - Full Screen (1.00) :13 16:23:54.340 T:1942900752 DEBUG: EGL mode 13: 1920x1080 (1920x1080) @ 50.00i - Full Screen (1.00) I:14 16:23:54.340 T:1942900752 DEBUG: EGL mode 14: 720x576 (720x576) @ 50.00i - Full Screen (1.07) I:15 16:23:54.340 T:1942900752 DEBUG: EGL mode 15: 720x576 (720x576) @ 50.00i - Full Screen (1.42) I:16 16:23:54.340 T:1942900752 DEBUG: EGL mode 16: 720x576 (720x576) @ 50.00 - Full Screen (1.07) :1d 16:23:54.340 T:1942900752 DEBUG: EGL mode 17: 720x576 (720x576) @ 50.00 - Full Screen (1.42) :1e 16:23:54.341 T:1942900752 DEBUG: EGL mode 18: 1920x1080 (1920x1080) @ 50.00 - Full Screen (1.00) :1f 16:23:54.341 T:1942900752 DEBUG: EGL mode 19: 1920x1080 (1920x1080) @ 24.00 - Full Screen (1.00) :20 16:23:54.341 T:1942900752 DEBUG: EGL mode 20: 1920x1080 (1920x1080) @ 30.00 - Full Screen (1.00) :22 16:23:54.341 T:1942900752 DEBUG: EGL probe resolution 1920x1080 (1920x1080) @ 60.00 - Full Screen:10010004 16:23:54.341 T:1942900752 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 60.000000 Hz 16:23:54.341 T:1942900752 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 59.940063 Hz 16:23:54.341 T:1942900752 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 60.000000 Hz 16:23:54.341 T:1942900752 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 59.940063 Hz 16:23:54.341 T:1942900752 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 60.000000 Hz 16:23:54.341 T:1942900752 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 59.940063 Hz 16:23:54.341 T:1942900752 NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 60.000000 Hz 16:23:54.341 T:1942900752 NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 59.940063 Hz 16:23:54.341 T:1942900752 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 60.000000 Hz 16:23:54.342 T:1942900752 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 59.940063 Hz 16:23:54.342 T:1942900752 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 60.000000 Hz 16:23:54.342 T:1942900752 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 59.940063 Hz 16:23:54.342 T:1942900752 NOTICE: Found resolution 720 x 576 for display 0 with 720 x 576 @ 50.000000 Hz 16:23:54.342 T:1942900752 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 50.000000 Hz 16:23:54.342 T:1942900752 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 50.000000 Hz 16:23:54.342 T:1942900752 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 24.000000 Hz 16:23:54.342 T:1942900752 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 23.976025 Hz 16:23:54.342 T:1942900752 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 30.000000 Hz 16:23:54.342 T:1942900752 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 29.970032 Hz 16:23:54.342 T:1942900752 NOTICE: Found (1920x1080@60.000000) at 26, setting to RES_DESKTOP at 16 16:23:54.344 T:1942900752 NOTICE: Checking resolution 16 16:23:54.406 T:1910502288 DEBUG: CAESinkPi:Drain delay:50ms now:0ms 16:23:54.406 T:1910502288 DEBUG: CAESinkPi:Deinitialize 16:23:54.406 T:1910502288 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 16:23:54.417 T:1910502288 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x71400758 16:23:54.427 T:1942900752 DEBUG: EGL set HDMI mode (1,16)=0 off 16:23:54.562 T:1891627920 DEBUG: EGL tv_service_callback (8,1,16) 16:23:54.563 T:1942900752 DEBUG: EGL set resolution 1920x1080 -> 1920x1080 @ 60.00 fps (1,16) flags:10010004 aspect:1.00 16:23:54.579 T:1920533392 DEBUG: CActiveAE - display reset event 16:23:54.579 T:1910502288 INFO: CActiveAESink::OpenSink - initialize sink 16:23:54.579 T:1910502288 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 16:23:54.580 T:1910502288 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:8816 bytes/s=352800.00 dest=PI:HDMI 16:23:54.580 T:1910502288 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 16:23:54.582 T:1910502288 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x71400758 16:23:54.584 T:1910502288 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(8816), nBufferAlignment(16) 16:23:54.584 T:1910502288 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 16:23:54.584 T:1910502288 DEBUG: Output Device : HDMI 16:23:54.584 T:1910502288 DEBUG: Sample Rate : 44100 16:23:54.584 T:1910502288 DEBUG: Sample Format : AE_FMT_FLOAT 16:23:54.584 T:1910502288 DEBUG: Channel Count : 2 16:23:54.584 T:1910502288 DEBUG: Channel Layout: FL, FR 16:23:54.584 T:1910502288 DEBUG: Frames : 1102 16:23:54.584 T:1910502288 DEBUG: Frame Size : 8 16:23:54.587 T:1920533392 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 16:23:54.593 T:1942900752 NOTICE: GL_VENDOR = Broadcom 16:23:54.593 T:1942900752 NOTICE: GL_RENDERER = VideoCore IV HW 16:23:54.593 T:1942900752 NOTICE: GL_VERSION = OpenGL ES 2.0 16:23:54.593 T:1942900752 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 16:23:54.594 T:1942900752 DEBUG: GLES: Extension Support Test - GL_NVX_gpu_memory_info NO 16:23:54.594 T:1942900752 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 16:23:54.594 T:1942900752 DEBUG: GLES: Extension Support Test - GL_EXT_texture_format_BGRA8888 YES 16:23:54.594 T:1942900752 DEBUG: GLES: Extension Support Test - GL_IMG_texture_format_BGRA8888 NO 16:23:54.594 T:1942900752 DEBUG: GLES: Extension Support Test - GL_APPLE_texture_format_BGRA8888 NO 16:23:54.597 T:1942900752 DEBUG: GL: Vertex Shader compilation log: 16:23:54.597 T:1942900752 DEBUG: Compiled 16:23:54.597 T:1942900752 DEBUG: GL: Vertex Shader compiled successfully 16:23:54.598 T:1942900752 DEBUG: GL: Pixel Shader compilation log: 16:23:54.598 T:1942900752 DEBUG: Compiled 16:23:54.598 T:1942900752 DEBUG: GL: Fragment Shader compiled successfully 16:23:54.616 T:1942900752 DEBUG: GUI Shader [guishader_frag_default.glsl]- Initialise successful : 0x1c42818 16:23:54.617 T:1942900752 DEBUG: GL: Vertex Shader compilation log: 16:23:54.618 T:1942900752 DEBUG: Compiled 16:23:54.618 T:1942900752 DEBUG: GL: Vertex Shader compiled successfully 16:23:54.618 T:1942900752 DEBUG: GL: Pixel Shader compilation log: 16:23:54.618 T:1942900752 DEBUG: Compiled 16:23:54.619 T:1942900752 DEBUG: GL: Fragment Shader compiled successfully 16:23:54.638 T:1942900752 DEBUG: GUI Shader [guishader_frag_texture.glsl]- Initialise successful : 0x1ad78d8 16:23:54.639 T:1942900752 DEBUG: GL: Vertex Shader compilation log: 16:23:54.639 T:1942900752 DEBUG: Compiled 16:23:54.639 T:1942900752 DEBUG: GL: Vertex Shader compiled successfully 16:23:54.640 T:1942900752 DEBUG: GL: Pixel Shader compilation log: 16:23:54.640 T:1942900752 DEBUG: Compiled 16:23:54.640 T:1942900752 DEBUG: GL: Fragment Shader compiled successfully 16:23:54.661 T:1942900752 DEBUG: GUI Shader [guishader_frag_multi.glsl]- Initialise successful : 0x1c50128 16:23:54.662 T:1942900752 DEBUG: GL: Vertex Shader compilation log: 16:23:54.662 T:1942900752 DEBUG: Compiled 16:23:54.662 T:1942900752 DEBUG: GL: Vertex Shader compiled successfully 16:23:54.663 T:1942900752 DEBUG: GL: Pixel Shader compilation log: 16:23:54.663 T:1942900752 DEBUG: Compiled 16:23:54.663 T:1942900752 DEBUG: GL: Fragment Shader compiled successfully 16:23:54.683 T:1942900752 DEBUG: GUI Shader [guishader_frag_fonts.glsl]- Initialise successful : 0x1c48ed0 16:23:54.685 T:1942900752 DEBUG: GL: Vertex Shader compilation log: 16:23:54.685 T:1942900752 DEBUG: Compiled 16:23:54.685 T:1942900752 DEBUG: GL: Vertex Shader compiled successfully 16:23:54.685 T:1942900752 DEBUG: GL: Pixel Shader compilation log: 16:23:54.686 T:1942900752 DEBUG: Compiled 16:23:54.686 T:1942900752 DEBUG: GL: Fragment Shader compiled successfully 16:23:54.705 T:1942900752 DEBUG: GUI Shader [guishader_frag_texture_noblend.glsl]- Initialise successful : 0x1d21090 16:23:54.707 T:1942900752 DEBUG: GL: Vertex Shader compilation log: 16:23:54.707 T:1942900752 DEBUG: Compiled 16:23:54.707 T:1942900752 DEBUG: GL: Vertex Shader compiled successfully 16:23:54.708 T:1942900752 DEBUG: GL: Pixel Shader compilation log: 16:23:54.708 T:1942900752 DEBUG: Compiled 16:23:54.708 T:1942900752 DEBUG: GL: Fragment Shader compiled successfully 16:23:54.729 T:1942900752 DEBUG: GUI Shader [guishader_frag_multi_blendcolor.glsl]- Initialise successful : 0x1a574c0 16:23:54.730 T:1942900752 DEBUG: GL: Vertex Shader compilation log: 16:23:54.730 T:1942900752 DEBUG: Compiled 16:23:54.730 T:1942900752 DEBUG: GL: Vertex Shader compiled successfully 16:23:54.731 T:1942900752 DEBUG: GL: Pixel Shader compilation log: 16:23:54.731 T:1942900752 DEBUG: Compiled 16:23:54.731 T:1942900752 DEBUG: GL: Fragment Shader compiled successfully 16:23:54.751 T:1942900752 DEBUG: GUI Shader [guishader_frag_rgba.glsl]- Initialise successful : 0x1d1ec78 16:23:54.751 T:1942900752 DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external YES 16:23:54.753 T:1942900752 DEBUG: GL: Vertex Shader compilation log: 16:23:54.753 T:1942900752 DEBUG: Compiled 16:23:54.753 T:1942900752 DEBUG: GL: Vertex Shader compiled successfully 16:23:54.753 T:1942900752 DEBUG: GL: Pixel Shader compilation log: 16:23:54.754 T:1942900752 DEBUG: Compiled 16:23:54.754 T:1942900752 DEBUG: GL: Fragment Shader compiled successfully 16:23:54.776 T:1942900752 DEBUG: GUI Shader [guishader_frag_rgba_oes.glsl]- Initialise successful : 0x1c4da20 16:23:54.778 T:1942900752 DEBUG: GL: Vertex Shader compilation log: 16:23:54.778 T:1942900752 DEBUG: Compiled 16:23:54.778 T:1942900752 DEBUG: GL: Vertex Shader compiled successfully 16:23:54.778 T:1942900752 DEBUG: GL: Pixel Shader compilation log: 16:23:54.779 T:1942900752 DEBUG: Compiled 16:23:54.779 T:1942900752 DEBUG: GL: Fragment Shader compiled successfully 16:23:54.799 T:1942900752 DEBUG: GUI Shader [guishader_frag_rgba_blendcolor.glsl]- Initialise successful : 0x1d20730 16:23:54.800 T:1942900752 DEBUG: GL: Vertex Shader compilation log: 16:23:54.800 T:1942900752 DEBUG: Compiled 16:23:54.800 T:1942900752 DEBUG: GL: Vertex Shader compiled successfully 16:23:54.801 T:1942900752 DEBUG: GL: Pixel Shader compilation log: 16:23:54.801 T:1942900752 DEBUG: Compiled 16:23:54.801 T:1942900752 DEBUG: GL: Fragment Shader compiled successfully 16:23:54.826 T:1942900752 DEBUG: GUI Shader [guishader_frag_rgba_bob.glsl]- Initialise successful : 0x1c495e8 16:23:54.826 T:1942900752 DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external YES 16:23:54.827 T:1942900752 DEBUG: GL: Vertex Shader compilation log: 16:23:54.827 T:1942900752 DEBUG: Compiled 16:23:54.827 T:1942900752 DEBUG: GL: Vertex Shader compiled successfully 16:23:54.828 T:1942900752 DEBUG: GL: Pixel Shader compilation log: 16:23:54.828 T:1942900752 DEBUG: Compiled 16:23:54.828 T:1942900752 DEBUG: GL: Fragment Shader compiled successfully 16:23:54.856 T:1942900752 DEBUG: GUI Shader [guishader_frag_rgba_bob_oes.glsl]- Initialise successful : 0x1c49688 16:23:54.915 T:1910502288 DEBUG: CAESinkPi:Drain delay:49ms now:0ms 16:23:54.915 T:1910502288 DEBUG: CAESinkPi:Deinitialize 16:23:54.916 T:1910502288 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 16:23:54.928 T:1910502288 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x71400758 16:23:54.941 T:1942900752 DEBUG: EGL set HDMI mode (1,16)=0 off 16:23:55.080 T:1891627920 DEBUG: EGL tv_service_callback (8,1,16) 16:23:55.081 T:1942900752 DEBUG: EGL set resolution 1920x1080 -> 1920x1080 @ 60.00 fps (1,16) flags:10010004 aspect:1.00 16:23:55.097 T:1920533392 DEBUG: CActiveAE - display reset event 16:23:55.097 T:1910502288 INFO: CActiveAESink::OpenSink - initialize sink 16:23:55.097 T:1910502288 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 16:23:55.098 T:1910502288 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:8816 bytes/s=352800.00 dest=PI:HDMI 16:23:55.098 T:1910502288 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 16:23:55.100 T:1910502288 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x71400758 16:23:55.102 T:1910502288 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(8816), nBufferAlignment(16) 16:23:55.103 T:1910502288 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 16:23:55.103 T:1910502288 DEBUG: Output Device : HDMI 16:23:55.103 T:1910502288 DEBUG: Sample Rate : 44100 16:23:55.103 T:1910502288 DEBUG: Sample Format : AE_FMT_FLOAT 16:23:55.103 T:1910502288 DEBUG: Channel Count : 2 16:23:55.104 T:1910502288 DEBUG: Channel Layout: FL, FR 16:23:55.104 T:1910502288 DEBUG: Frames : 1102 16:23:55.104 T:1910502288 DEBUG: Frame Size : 8 16:23:55.107 T:1920533392 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 16:23:55.108 T:1942900752 INFO: GLES: Maximum texture width: 2048 16:23:55.483 T:1942900752 INFO: GLES: Enabling VSYNC 16:23:55.483 T:1942900752 INFO: GLES: Selected vsync mode 10 16:23:55.484 T:1942900752 INFO: load keymapping 16:23:55.491 T:1942900752 INFO: Loading special://xbmc/system/keymaps/appcommand.xml 16:23:55.493 T:1942900752 INFO: Loading special://xbmc/system/keymaps/customcontroller.AppleRemote.xml 16:23:55.499 T:1942900752 INFO: Loading special://xbmc/system/keymaps/customcontroller.Harmony.xml 16:23:55.511 T:1942900752 INFO: Loading special://xbmc/system/keymaps/gamepad.xml 16:23:55.519 T:1942900752 INFO: Loading special://xbmc/system/keymaps/joystick.xml 16:23:55.529 T:1942900752 INFO: Loading special://xbmc/system/keymaps/keyboard.xml 16:23:55.553 T:1942900752 INFO: Loading special://xbmc/system/keymaps/mouse.xml 16:23:55.555 T:1942900752 INFO: Loading special://xbmc/system/keymaps/remote.xml 16:23:55.572 T:1942900752 INFO: Loading special://xbmc/system/keymaps/touchscreen.xml 16:23:55.582 T:1942900752 INFO: Loading special://xbmc/system/Lircmap.xml 16:23:55.595 T:1942900752 INFO: * Adding remote mapping for device 'mceusb' 16:23:55.595 T:1942900752 INFO: * Adding remote mapping for device 'XboxDVDDongle' 16:23:55.595 T:1942900752 INFO: * Adding remote mapping for device 'Microsoft_Xbox' 16:23:55.595 T:1942900752 INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote' 16:23:55.596 T:1942900752 INFO: * Adding remote mapping for device 'anysee' 16:23:55.596 T:1942900752 INFO: * Adding remote mapping for device 'iMON-PAD' 16:23:55.596 T:1942900752 INFO: * Adding remote mapping for device 'Antec_Veris_RM200' 16:23:55.596 T:1942900752 INFO: * Adding remote mapping for device 'MCE_via_iMON' 16:23:55.596 T:1942900752 INFO: * Adding remote mapping for device 'TwinHanRemote' 16:23:55.596 T:1942900752 INFO: * Adding remote mapping for device 'linux-input-layer' 16:23:55.597 T:1942900752 INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote' 16:23:55.597 T:1942900752 INFO: * Adding remote mapping for device 'mediacenter' 16:23:55.597 T:1942900752 INFO: * Adding remote mapping for device 'devinput' 16:23:55.597 T:1942900752 INFO: * Adding remote mapping for device 'devinput-32' 16:23:55.598 T:1942900752 INFO: * Adding remote mapping for device 'devinput-64' 16:23:55.599 T:1942900752 DEBUG: CIRTranslator::Load - no userdata Lircmap.xml found, skipping 16:23:55.599 T:1942900752 INFO: GUI format 1920x1080, Display 1920x1080 (1920x1080) @ 60.00 - Full Screen 16:23:55.600 T:1942900752 DEBUG: guilib: Fill viewport on change for solving rendering passes 16:23:55.600 T:1942900752 INFO: CLangInfo: loading resource.language.de_de language information... 16:23:55.609 T:1942900752 DEBUG: trying to set locale to de_BE.UTF-8 16:23:55.639 T:1942900752 INFO: global locale set to C 16:23:55.639 T:1942900752 INFO: CLangInfo: loading resource.language.de_de language strings... 16:23:55.765 T:1942900752 DEBUG: LocalizeStrings: loaded 3847 strings from file resource://resource.language.de_de/strings.po 16:23:55.810 T:1942900752 DEBUG: POParser: id:16313 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead 16:23:55.840 T:1942900752 DEBUG: LocalizeStrings: loaded 49 strings from file resource://resource.language.en_gb/strings.po 16:23:55.893 T:1942900752 DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/game.controller.default/resources/language/resource.language.en_gb/strings.po 16:23:55.919 T:1942900752 DEBUG: LocalizeStrings: loaded 11 strings from file /storage/.kodi/addons/metadata.album.universal/resources/language/German/strings.po 16:23:55.924 T:1942900752 DEBUG: LocalizeStrings: loaded 2 strings from file /storage/.kodi/addons/metadata.album.universal/resources/language/English/strings.po 16:23:55.935 T:1942900752 DEBUG: LocalizeStrings: loaded 23 strings from file /storage/.kodi/addons/metadata.artists.universal/resources/language/German/strings.po 16:23:55.941 T:1942900752 DEBUG: LocalizeStrings: loaded 3 strings from file /storage/.kodi/addons/metadata.artists.universal/resources/language/English/strings.po 16:23:55.973 T:1942900752 DEBUG: LocalizeStrings: loaded 7 strings from file /storage/.kodi/addons/metadata.themoviedb.org/resources/language/German/strings.po 16:23:55.980 T:1942900752 DEBUG: LocalizeStrings: loaded 0 strings from file /storage/.kodi/addons/metadata.themoviedb.org/resources/language/English/strings.po 16:23:55.990 T:1942900752 DEBUG: LocalizeStrings: loaded 5 strings from file /storage/.kodi/addons/metadata.tvdb.com/resources/language/German/strings.po 16:23:55.996 T:1942900752 DEBUG: LocalizeStrings: loaded 2 strings from file /storage/.kodi/addons/metadata.tvdb.com/resources/language/English/strings.po 16:23:56.001 T:1942900752 DEBUG: LocalizeStrings: loaded 9 strings from file /usr/share/kodi/addons/peripheral.joystick/resources/language/English/strings.po 16:23:56.027 T:1942900752 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.de_de/strings.po 16:23:56.028 T:1942900752 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.en_gb/strings.po 16:23:56.046 T:1942900752 DEBUG: LocalizeStrings: loaded 200 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/German/strings.po 16:23:56.059 T:1942900752 DEBUG: LocalizeStrings: loaded 6 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/English/strings.po 16:23:56.078 T:1942900752 DEBUG: LocalizeStrings: loaded 10 strings from file /usr/share/kodi/addons/inputstream.adaptive/resources/language/resource.language.en_gb/strings.po 16:23:56.086 T:1942900752 DEBUG: LocalizeStrings: loaded 67 strings from file /usr/share/kodi/addons/pvr.dvblink/resources/language/resource.language.de_de/strings.po 16:23:56.088 T:1942900752 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/pvr.dvblink/resources/language/resource.language.en_gb/strings.po 16:23:56.091 T:1942900752 DEBUG: LocalizeStrings: loaded 43 strings from file /usr/share/kodi/addons/pvr.dvbviewer/resources/language/resource.language.de_de/strings.po 16:23:56.092 T:1942900752 DEBUG: LocalizeStrings: loaded 5 strings from file /usr/share/kodi/addons/pvr.dvbviewer/resources/language/resource.language.en_gb/strings.po 16:23:56.094 T:1942900752 DEBUG: LocalizeStrings: loaded 5 strings from file /usr/share/kodi/addons/pvr.hdhomerun/resources/language/resource.language.de_de/strings.po 16:23:56.095 T:1942900752 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/pvr.hdhomerun/resources/language/resource.language.en_gb/strings.po 16:23:56.103 T:1942900752 DEBUG: LocalizeStrings: loaded 74 strings from file /usr/share/kodi/addons/pvr.hts/resources/language/resource.language.de_de/strings.po 16:23:56.105 T:1942900752 DEBUG: LocalizeStrings: loaded 4 strings from file /usr/share/kodi/addons/pvr.hts/resources/language/resource.language.en_gb/strings.po 16:23:56.108 T:1942900752 DEBUG: LocalizeStrings: loaded 22 strings from file /usr/share/kodi/addons/pvr.iptvsimple/resources/language/resource.language.de_de/strings.po 16:23:56.109 T:1942900752 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/pvr.iptvsimple/resources/language/resource.language.en_gb/strings.po 16:23:56.117 T:1942900752 DEBUG: LocalizeStrings: loaded 71 strings from file /usr/share/kodi/addons/pvr.mediaportal.tvserver/resources/language/resource.language.de_de/strings.po 16:23:56.119 T:1942900752 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/pvr.mediaportal.tvserver/resources/language/resource.language.en_gb/strings.po 16:23:56.124 T:1942900752 DEBUG: LocalizeStrings: loaded 101 strings from file /usr/share/kodi/addons/pvr.mythtv/resources/language/resource.language.de_de/strings.po 16:23:56.126 T:1942900752 DEBUG: LocalizeStrings: loaded 2 strings from file /usr/share/kodi/addons/pvr.mythtv/resources/language/resource.language.en_gb/strings.po 16:23:56.129 T:1942900752 DEBUG: LocalizeStrings: loaded 28 strings from file /usr/share/kodi/addons/pvr.nextpvr/resources/language/resource.language.de_de/strings.po 16:23:56.130 T:1942900752 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/pvr.nextpvr/resources/language/resource.language.en_gb/strings.po 16:23:56.132 T:1942900752 DEBUG: LocalizeStrings: loaded 2 strings from file /usr/share/kodi/addons/pvr.njoy/resources/language/resource.language.de_de/strings.po 16:23:56.133 T:1942900752 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/pvr.njoy/resources/language/resource.language.en_gb/strings.po 16:23:56.137 T:1942900752 DEBUG: LocalizeStrings: loaded 2 strings from file /usr/share/kodi/addons/pvr.octonet/resources/language/resource.language.en_gb/strings.po 16:23:56.139 T:1942900752 DEBUG: LocalizeStrings: loaded 4 strings from file /usr/share/kodi/addons/pvr.teleboy/resources/language/resource.language.en_gb/strings.po 16:23:56.142 T:1942900752 DEBUG: LocalizeStrings: loaded 25 strings from file /usr/share/kodi/addons/pvr.vbox/resources/language/resource.language.de_de/strings.po 16:23:56.143 T:1942900752 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/pvr.vbox/resources/language/resource.language.en_gb/strings.po 16:23:56.147 T:1942900752 DEBUG: LocalizeStrings: loaded 69 strings from file /usr/share/kodi/addons/pvr.vdr.vnsi/resources/language/resource.language.de_de/strings.po 16:23:56.148 T:1942900752 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/pvr.vdr.vnsi/resources/language/resource.language.en_gb/strings.po 16:23:56.151 T:1942900752 DEBUG: LocalizeStrings: loaded 27 strings from file /usr/share/kodi/addons/pvr.vuplus/resources/language/resource.language.de_de/strings.po 16:23:56.152 T:1942900752 DEBUG: LocalizeStrings: loaded 2 strings from file /usr/share/kodi/addons/pvr.vuplus/resources/language/resource.language.en_gb/strings.po 16:23:56.167 T:1942900752 DEBUG: LocalizeStrings: loaded 70 strings from file /usr/share/kodi/addons/pvr.wmc/resources/language/resource.language.de_de/strings.po 16:23:56.170 T:1942900752 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/pvr.wmc/resources/language/resource.language.en_gb/strings.po 16:23:56.173 T:1942900752 DEBUG: LocalizeStrings: loaded 7 strings from file /usr/share/kodi/addons/pvr.zattoo/resources/language/resource.language.en_gb/strings.po 16:23:56.193 T:1942900752 DEBUG: LocalizeStrings: loaded 7 strings from file /storage/.kodi/addons/script.common.plugin.cache/resources/language/English/strings.xml 16:23:56.207 T:1942900752 DEBUG: SECTION:LoadDLL(libcurl.so.4) 16:23:56.210 T:1942900752 DEBUG: Loading: libcurl.so.4 16:23:56.259 T:1838150544 DEBUG: Thread JobWorker start, auto delete: true 16:23:56.265 T:1838150544 NOTICE: Running database version Addons27 16:23:56.266 T:1838150544 DEBUG: Initialize, updating databases... 16:23:56.276 T:1838150544 NOTICE: Running database version ViewModes6 16:23:56.301 T:1838150544 NOTICE: Running database version Textures13 16:23:56.332 T:1838150544 NOTICE: Running database version MyMusic67 16:23:56.384 T:1838150544 NOTICE: Running database version MyVideos108 16:23:56.394 T:1838150544 NOTICE: Running database version TV31 16:23:56.405 T:1838150544 NOTICE: Running database version Epg11 16:23:56.413 T:1838150544 DEBUG: Initialize, updating databases... DONE 16:23:56.414 T:1942900752 NOTICE: start dvd mediatype detection 16:23:56.415 T:1942900752 INFO: DPMS: not supported on this platform 16:23:56.415 T:1933665168 DEBUG: Thread DetectDVDMedia start, auto delete: false 16:23:56.415 T:1933665168 DEBUG: Compiled with libcdio Version 0.94 16:23:56.419 T:1933665168 DEBUG: Thread DetectDVDMedia 1933665168 terminating 16:23:56.470 T:1942897552 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 16:23:56.471 T:1942897552 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 16:23:56.505 T:1942900752 INFO: Unloading old skin ... 16:23:56.512 T:1942900752 NOTICE: load skin from: /usr/share/kodi/addons/skin.estuary (version: 2.0.4) 16:23:56.513 T:1942900752 INFO: load fonts for skin... 16:23:56.522 T:1942900752 INFO: Loading skin includes from /usr/share/kodi/addons/skin.estuary/xml/Includes.xml 16:23:56.816 T:1942900752 INFO: Loading fonts from /usr/share/kodi/addons/skin.estuary/xml/Font.xml 16:23:57.070 T:1942900752 DEBUG: LocalizeStrings: loaded 131 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.de_de/strings.po 16:23:57.073 T:1942900752 DEBUG: LocalizeStrings: loaded 4 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.en_gb/strings.po 16:23:57.073 T:1942900752 INFO: load new skin... 16:23:57.073 T:1942900752 INFO: Loading custom window XMLs from skin path /usr/share/kodi/addons/skin.estuary/xml 16:23:57.108 T:1942900752 DEBUG: Load Skin XML: 34.92ms 16:23:57.108 T:1942900752 INFO: initialize new skin... 16:23:57.108 T:1942900752 DEBUG: guilib: Fill viewport on change for solving rendering passes 16:23:57.109 T:1942900752 DEBUG: Alloc resources: 0.01ms (0.01 ms skin load) 16:23:57.109 T:1942900752 INFO: Loading skin file: VideoOSD.xml, load type: LOAD_ON_GUI_INIT 16:23:57.143 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/VideoOSD.xml loaded in 33.86ms 16:23:57.155 T:1942900752 DEBUG: OpenBundle - Opened bundle /usr/share/kodi/addons/skin.estuary/media/Textures.xbt 16:23:57.205 T:1942900752 DEBUG: Alloc resources: 96.10ms (34.16 ms skin load) 16:23:57.205 T:1942900752 INFO: Loading skin file: DialogPVRChannelGuide.xml, load type: LOAD_ON_GUI_INIT 16:23:57.221 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/DialogPVRChannelGuide.xml loaded in 15.97ms 16:23:57.223 T:1942900752 DEBUG: Alloc resources: 18.00ms (16.23 ms skin load) 16:23:57.223 T:1942900752 INFO: Loading skin file: Custom_1109_TopBarOverlay.xml, load type: LOAD_ON_GUI_INIT 16:23:57.234 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/Custom_1109_TopBarOverlay.xml loaded in 11.13ms 16:23:57.235 T:1942900752 DEBUG: Alloc resources: 11.37ms (11.36 ms skin load) 16:23:57.235 T:1942900752 INFO: Loading skin file: DialogPVRChannelsOSD.xml, load type: LOAD_ON_GUI_INIT 16:23:57.254 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/DialogPVRChannelsOSD.xml loaded in 18.77ms 16:23:57.254 T:1942900752 DEBUG: Alloc resources: 19.06ms (19.01 ms skin load) 16:23:57.254 T:1942900752 INFO: Loading skin file: DialogNotification.xml, load type: LOAD_ON_GUI_INIT 16:23:57.258 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/DialogNotification.xml loaded in 4.19ms 16:23:57.258 T:1942900752 DEBUG: Alloc resources: 4.38ms (4.38 ms skin load) 16:23:57.258 T:1942900752 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT 16:23:57.294 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/DialogSeekBar.xml loaded in 35.89ms 16:23:57.295 T:1942900752 DEBUG: Alloc resources: 36.84ms (36.13 ms skin load) 16:23:57.295 T:1942900752 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT 16:23:57.303 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/DialogExtendedProgressBar.xml loaded in 7.41ms 16:23:57.303 T:1942900752 DEBUG: Alloc resources: 7.89ms (7.59 ms skin load) 16:23:57.303 T:1942900752 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT 16:23:57.309 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/DialogVolumeBar.xml loaded in 5.54ms 16:23:57.309 T:1942900752 DEBUG: Alloc resources: 5.81ms (5.76 ms skin load) 16:23:57.309 T:1942900752 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT 16:23:57.313 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/Pointer.xml loaded in 3.27ms 16:23:57.313 T:1942900752 DEBUG: Alloc resources: 4.04ms (3.46 ms skin load) 16:23:57.313 T:1942900752 INFO: Loading skin file: DialogSettings.xml, load type: LOAD_ON_GUI_INIT 16:23:57.337 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/DialogSettings.xml loaded in 23.83ms 16:23:57.343 T:1942900752 DEBUG: Alloc resources: 29.02ms (24.09 ms skin load) 16:23:57.343 T:1942900752 INFO: Loading skin file: DialogSettings.xml, load type: LOAD_ON_GUI_INIT 16:23:57.363 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/DialogSettings.xml loaded in 20.28ms 16:23:57.364 T:1942900752 DEBUG: Alloc resources: 21.42ms (20.58 ms skin load) 16:23:57.364 T:1942900752 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT 16:23:57.372 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/DialogBusy.xml loaded in 7.48ms 16:23:57.372 T:1942900752 DEBUG: Alloc resources: 7.79ms (7.73 ms skin load) 16:23:57.372 T:1942900752 INFO: Loading skin file: DialogSubtitles.xml, load type: LOAD_ON_GUI_INIT 16:23:57.402 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/DialogSubtitles.xml loaded in 29.75ms 16:23:57.403 T:1942900752 DEBUG: Alloc resources: 30.27ms (30.05 ms skin load) 16:23:57.407 T:1942900752 INFO: Loading resource://resource.uisounds.kodi/sounds.xml 16:23:57.673 T:1942900752 INFO: skin loaded... 16:23:57.673 T:1942900752 DEBUG: Activating window ID: 12997 16:23:57.673 T:1942900752 DEBUG: ------ Window Init () ------ 16:23:57.673 T:1942900752 DEBUG: Alloc resources: 0.01ms (0.01 ms skin load) 16:23:57.674 T:1942900752 INFO: load splash image: /usr/share/kodi/media/Splash.png 16:23:57.743 T:1942900752 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting 16:23:57.744 T:1942900752 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 16:23:57.744 T:1942900752 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting") 16:23:57.745 T:1942900752 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting 16:23:57.855 T:1942900752 INFO: JSONRPC v8.3.0: Successfully initialized 16:23:57.863 T:1942900752 DEBUG: CServiceAddonManager: starting service.libreelec.settings 16:23:57.864 T:1827664784 DEBUG: Thread LanguageInvoker start, auto delete: false 16:23:57.864 T:1942900752 DEBUG: CServiceAddonManager: starting script.common.plugin.cache 16:23:57.864 T:1827664784 INFO: initializing python engine. 16:23:57.864 T:1819276176 DEBUG: Thread LanguageInvoker start, auto delete: false 16:23:57.865 T:1819276176 INFO: initializing python engine. 16:23:57.865 T:1942900752 DEBUG: Activating window ID: 12999 16:23:57.865 T:1942900752 DEBUG: ------ Window Init (Startup.xml) ------ 16:23:57.865 T:1942900752 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME 16:23:57.867 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/Startup.xml loaded in 1.86ms 16:23:57.867 T:1942900752 DEBUG: Alloc resources: 2.14ms (2.13 ms skin load) 16:23:57.868 T:1942900752 DEBUG: Activating window ID: 10000 16:23:57.868 T:1942900752 DEBUG: ------ Window Deinit (Startup.xml) ------ 16:23:57.868 T:1942900752 DEBUG: ------ Window Init (Home.xml) ------ 16:23:57.868 T:1942900752 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY 16:23:57.958 T:1827664784 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): start processing 16:23:57.958 T:1819276176 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/script.common.plugin.cache/default.py): start processing 16:23:58.102 T:1827664784 DEBUG: -->Python Interpreter Initialized<-- 16:23:58.102 T:1827664784 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" 16:23:58.102 T:1819276176 DEBUG: -->Python Interpreter Initialized<-- 16:23:58.103 T:1819276176 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" 16:23:58.103 T:1819276176 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 16:23:58.103 T:1819276176 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/script.common.plugin.cache/default.py): entering source directory /storage/.kodi/addons/script.common.plugin.cache 16:23:58.104 T:1827664784 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 16:23:58.104 T:1827664784 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): entering source directory /usr/share/kodi/addons/service.libreelec.settings 16:23:58.104 T:1819276176 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 16:23:58.114 T:1819276176 DEBUG: CAddonSettings[script.common.plugin.cache]: loading setting definitions 16:23:58.114 T:1819276176 DEBUG: CAddonSettings[script.common.plugin.cache]: trying to load setting definitions from old format... 16:23:58.258 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/Home.xml loaded in 390.25ms 16:23:58.260 T:1942900752 DEBUG: CDirectoryProvider[addons://]: refreshing.. 16:23:58.270 T:1942900752 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 16:23:58.271 T:1942900752 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 16:23:58.271 T:1810887568 DEBUG: Thread JobWorker start, auto delete: true 16:23:58.271 T:1942900752 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing.. 16:23:58.272 T:1942900752 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 16:23:58.272 T:1942900752 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 16:23:58.272 T:1942900752 DEBUG: CDirectoryProvider[library://video/]: refreshing.. 16:23:58.272 T:1942900752 DEBUG: CDirectoryProvider[sources://video/]: refreshing.. 16:23:58.272 T:1942900752 DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing.. 16:23:58.273 T:1802498960 DEBUG: Thread JobWorker start, auto delete: true 16:23:58.273 T:1942900752 DEBUG: CDirectoryProvider[favourites://]: refreshing.. 16:23:58.273 T:1942900752 DEBUG: CDirectoryProvider[sources://pictures/]: refreshing.. 16:23:58.292 T:1942900752 DEBUG: Alloc resources: 424.51ms (390.59 ms skin load) 16:23:58.298 T:1942900752 DEBUG: StereoscopicsManager::Initialize: stereo:0 16:23:58.301 T:1827664784 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 16:23:58.307 T:1942900752 DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid" 16:23:58.310 T:1942900752 DEBUG: LoadMappings - loaded node "CEC Adapter" 16:23:58.310 T:1942900752 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter" 16:23:58.311 T:1942900752 DEBUG: LoadMappings - loaded node "iMON HID device" 16:23:58.311 T:1942900752 DEBUG: LoadMappings - loaded node "WETEK Play remote" 16:23:58.314 T:1942900752 DEBUG: LoadMappings - loaded node "" 16:23:58.315 T:1942900752 DEBUG: CPeripheralBusUSB - initialised udev monitor 16:23:58.315 T:1942900752 DEBUG: SECTION:LoadDLL(libcec.so.4) 16:23:58.318 T:1942900752 DEBUG: Loading: libcec.so.4 16:23:58.327 T:1838150544 DEBUG: CAddonMgr::GetAvailableUpdates took 65 ms 16:23:58.400 T:1942900752 DEBUG: Add-on bus: Registering add-on peripheral.joystick 16:23:58.401 T:1942900752 DEBUG: PERIPHERAL - CreateAddon - creating peripheral add-on instance 'Joystick Support' 16:23:58.401 T:1942900752 DEBUG: ADDON: Dll Initializing - Joystick Support 16:23:58.402 T:1942900752 DEBUG: SECTION:LoadDLL(/usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.4.2) 16:23:58.402 T:1942900752 DEBUG: Loading: /usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.4.2 16:23:58.494 T:1802498960 DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3a%2f%2fprofile%2fplaylists%2fvideo/special%3a%2f%2fprofile%2fplaylists%2fmixed/) 16:23:58.495 T:1802498960 DEBUG: Getting Directory (special://profile/playlists/video) 16:23:58.498 T:1802498960 DEBUG: Getting Directory (special://profile/playlists/mixed) 16:23:58.504 T:1942900752 DEBUG: AddOnLog: Joystick Support: Loaded 14 joystick families with 97 total joysticks 16:23:58.505 T:1942900752 DEBUG: Calling TransferSettings for: Joystick Support 16:23:58.506 T:1942900752 DEBUG: CAddonSettings[peripheral.joystick]: loading setting definitions 16:23:58.507 T:1802498960 DEBUG: CMultiPathDirectory::MergeItems, items = 0 16:23:58.508 T:1802498960 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update 16:23:58.509 T:1942900752 INFO: AddOnLog: Joystick Support: Enabling joystick interface "linux" 16:23:58.511 T:1784976272 DEBUG: Thread PeripBusUSBUdev start, auto delete: false 16:23:58.520 T:1776587664 DEBUG: Thread PeripBusCEC start, auto delete: false 16:23:58.525 T:1768199056 DEBUG: Thread PeripBusAddon start, auto delete: false 16:23:58.528 T:1942900752 DEBUG: Initialise - initialised peripheral on '1' with 1 features and 0 sub devices 16:23:58.528 T:1942900752 NOTICE: Register - new joystickemulation device registered on application->1: Tastatur-Spieler (0000:0000) 16:23:58.534 T:1759613840 DEBUG: Thread PeripEventScanner start, auto delete: false 16:23:58.537 T:1942900752 DEBUG: ContextMenuManager: addon menus reloaded. 16:23:58.537 T:1942900752 INFO: removing tempfiles 16:23:58.548 T:1802498960 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 16:23:58.554 T:1802498960 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 16:23:58.592 T:1802498960 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update 16:23:58.608 T:1942900752 DEBUG: CRepositoryUpdater: previous update at 31.12.1969 23:59:59, next at 06.10.2017 16:23:58 16:23:58.615 T:1749341072 DEBUG: Thread Timer start, auto delete: false 16:23:58.620 T:1749341072 DEBUG: CRepositoryUpdater: running scheduled update 16:23:58.654 T:1942900752 DEBUG: CServiceAddonManager: service.libreelec.settings already started. 16:23:58.654 T:1942900752 DEBUG: CServiceAddonManager: script.common.plugin.cache already started. 16:23:58.654 T:1942900752 NOTICE: initialize done 16:23:58.655 T:1942900752 NOTICE: Running the application... 16:23:58.698 T:1749341072 DEBUG: Thread Timer 1749341072 terminating 16:23:58.698 T:1838150544 DEBUG: CRepositoryUpdateJob[repository.kodi.game] checking for updates. 16:23:58.707 T:1942900752 DEBUG: no profile autoexec.py (/storage/.kodi/userdata/autoexec.py) found, skipping 16:23:58.707 T:1942900752 DEBUG: NetworkMessage - Starting network services 16:23:58.711 T:1838150544 DEBUG: CFileCache::Open - opening using cache 16:23:58.712 T:1838150544 DEBUG: CurlFile::Open(0x6ea4da30) https://raw.githubusercontent.com/kodi-game/repository.kodi.game/master/release/addons.xml.md5 16:23:58.713 T:1838150544 INFO: easy_acquire - Created session to https://raw.githubusercontent.com 16:23:58.720 T:1802498960 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 16:23:58.722 T:1810887568 DEBUG: CRepositoryUpdateJob[repository.libreelec.tv] checking for updates. 16:23:58.728 T:1810887568 DEBUG: CFileCache::Open - opening <9.0/RPi2/arm/addons.xml.gz.md5> using cache 16:23:58.729 T:1810887568 DEBUG: CurlFile::Open(0x72a2f818) http://addons.libreelec.tv/9.0/RPi2/arm/addons.xml.gz.md5 16:23:58.729 T:1810887568 INFO: easy_acquire - Created session to http://addons.libreelec.tv 16:23:58.732 T:1942900752 DEBUG: CZeroconfAvahi::clientCallback: client is up and running 16:23:58.733 T:1942900752 NOTICE: starting zeroconf publishing 16:23:58.735 T:1942900752 NOTICE: CWebServer[8080]: Started 16:23:58.738 T:1942900752 INFO: JSONRPC Server: Successfully initialized 16:23:58.738 T:1705894800 DEBUG: Thread EventServer start, auto delete: false 16:23:58.738 T:1705894800 NOTICE: ES: Starting UDP Event server on port 9777 16:23:58.739 T:1942900752 DEBUG: SECTION:LoadDLL(libshairplay.so.0) 16:23:58.739 T:1705894800 NOTICE: UDP: Listening on port 9777 (ipv6 : false) 16:23:58.739 T:1697506192 DEBUG: Thread TCPServer start, auto delete: false 16:23:58.742 T:1942900752 DEBUG: Loading: libshairplay.so.0 16:23:58.742 T:1802498960 DEBUG: GetArtistsByWhere query: SELECT COUNT(DISTINCT artistview.idArtist) FROM artistview WHERE ((EXISTS (SELECT 1 FROM song_artist WHERE song_artist.idArtist = artistview.idArtist AND song_artist.idRole = 1) OR EXISTS (SELECT 1 FROM album_artist WHERE album_artist.idArtist = artistview.idArtist)) AND (artistview.strArtist != '')) AND (artistview.strArtist <> 'Verschiedene Interpreten') 16:23:58.758 T:1942900752 INFO: AIRPLAY: Cleaning up photoassetcache 16:23:58.767 T:1942900752 INFO: AIRPLAY Server: Successfully initialized 16:23:58.772 T:1680270224 DEBUG: Thread AirPlayServer start, auto delete: false 16:23:58.797 T:1802498960 DEBUG: CRepositoryUpdateJob[repository.xbmc.org] checking for updates. 16:23:58.804 T:1802498960 DEBUG: CFileCache::Open - opening using cache 16:23:58.805 T:1802498960 DEBUG: CurlFile::Open(0x7292b6e8) http://mirrors.kodi.tv/addons/leia/addons.xml.gz.md5 16:23:58.805 T:1802498960 INFO: easy_acquire - Created session to http://mirrors.kodi.tv 16:23:58.920 T:1819276176 DEBUG: CAddonSettings[script.common.plugin.cache]: loading setting definitions 16:23:58.920 T:1819276176 DEBUG: CAddonSettings[script.common.plugin.cache]: trying to load setting definitions from old format... 16:23:58.922 T:1670378384 DEBUG: Thread FileCache start, auto delete: false 16:23:58.927 T:1942900752 INFO: Found input device /dev/input/event0 16:23:58.929 T:1670378384 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 16:23:58.979 T:1670378384 DEBUG: Thread FileCache 1670378384 terminating 16:23:58.984 T:1942900752 INFO: opened device 'Logitech USB Receiver' (file name /dev/input/event0), m_bSkipNonKeyEvents 0 16:23:58.984 T:1942900752 NOTICE: Logitech USB Receiver: keys:0 ext:0 but:16 rel:4 abs:0 m_deviceType:1 bits:110001 16:23:59.004 T:1670378384 DEBUG: Thread FileCache start, auto delete: false 16:23:59.004 T:1670378384 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 16:23:59.052 T:1776587664 DEBUG: GetMappingForDevice - device (2708:1001) mapped to CEC Adapter (type = cec) 16:23:59.055 T:1670378384 DEBUG: Thread FileCache 1670378384 terminating 16:23:59.077 T:1942900752 INFO: Found input device /dev/input/event1 16:23:59.077 T:1942900752 INFO: opened device 'Logitech USB Receiver' (file name /dev/input/event1), m_bSkipNonKeyEvents 0 16:23:59.077 T:1942900752 NOTICE: Logitech USB Receiver: keys:35 ext:70 but:0 rel:1 abs:0 m_deviceType:c bits:111000 16:23:59.083 T:1776587664 DEBUG: InitialiseFeature - using libCEC v4.0.2 16:23:59.084 T:1776587664 DEBUG: Initialise - initialised peripheral on 'RPI' with 2 features and 0 sub devices 16:23:59.084 T:1776587664 NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001) 16:23:59.084 T:1739449232 DEBUG: Thread CECAdapter start, auto delete: false 16:23:59.084 T:1739449232 DEBUG: OpenConnection - opening a connection to the CEC adapter: RPI 16:23:59.111 T:1651504016 DEBUG: Thread FileCache start, auto delete: false 16:23:59.112 T:1651504016 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 16:23:59.125 T:1810887568 DEBUG: CRepositoryUpdateJob[repository.libreelec.tv] checksum not changed. 16:23:59.126 T:1810887568 DEBUG: CRepositoryUpdateJob[repository.retroplayer.libreelec.tv] checking for updates. 16:23:59.130 T:1810887568 DEBUG: CFileCache::Open - opening using cache 16:23:59.131 T:1810887568 DEBUG: CurlFile::Open(0x72a2f818) http://lrusak.libreelec.tv/addons/9.0/RPi2/arm/addons.xml.md5 16:23:59.131 T:1810887568 INFO: easy_acquire - Created session to http://lrusak.libreelec.tv 16:23:59.162 T:1651504016 DEBUG: Thread FileCache 1651504016 terminating 16:23:59.177 T:1942900752 INFO: Found input device /dev/input/event2 16:23:59.177 T:1942900752 INFO: opened device 'SIGMACHIP USB Keyboard' (file name /dev/input/event2), m_bSkipNonKeyEvents 0 16:23:59.177 T:1942900752 NOTICE: SIGMACHIP USB Keyboard: keys:35 ext:0 but:0 rel:0 abs:0 m_deviceType:4 bits:100001 16:23:59.267 T:1942900752 INFO: Found input device /dev/input/event3 16:23:59.267 T:1942900752 INFO: opened device 'SIGMACHIP USB Keyboard' (file name /dev/input/event3), m_bSkipNonKeyEvents 0 16:23:59.267 T:1942900752 NOTICE: SIGMACHIP USB Keyboard: keys:1 ext:64 but:0 rel:1 abs:0 m_deviceType:8 bits:111000 16:23:59.268 T:1641018256 DEBUG: Thread CLinuxInputDevicesCheckHotplugged start, auto delete: false 16:23:59.284 T:1802498960 DEBUG: CRepositoryUpdateJob[repository.xbmc.org] checksum not changed. 16:23:59.285 T:1802498960 DEBUG: CRepositoryUpdateJob[repository.kodinerds] checking for updates. 16:23:59.290 T:1802498960 DEBUG: CFileCache::Open - opening using cache 16:23:59.290 T:1802498960 DEBUG: CurlFile::Open(0x7292b6e8) https://raw.githubusercontent.com/kodinerds/repo/master/addons.xml.md5 16:23:59.321 T:1651504016 DEBUG: Thread FileCache start, auto delete: false 16:23:59.321 T:1651504016 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 16:23:59.336 T:1632629648 DEBUG: Thread FileCache start, auto delete: false 16:23:59.336 T:1632629648 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 16:23:59.372 T:1651504016 DEBUG: Thread FileCache 1651504016 terminating 16:23:59.387 T:1632629648 DEBUG: Thread FileCache 1632629648 terminating 16:23:59.470 T:1838150544 DEBUG: CRepositoryUpdateJob[repository.kodi.game] checksum not changed. 16:23:59.471 T:1838150544 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:Kodi (LibreELEC) port:8080 16:23:59.471 T:1838150544 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _http._tcp port:8080 16:23:59.481 T:1838150544 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:Kodi (LibreELEC) port:8080 16:23:59.481 T:1838150544 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _xbmc-jsonrpc-h._tcp port:8080 16:23:59.489 T:1838150544 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:Kodi (LibreELEC) port:9090 16:23:59.489 T:1838150544 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _xbmc-jsonrpc._tcp port:9090 16:23:59.495 T:1838150544 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:Kodi (LibreELEC) port:9777 16:23:59.512 T:1838150544 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _xbmc-events._udp port:9777 16:23:59.521 T:1838150544 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airtunes type: _raop._tcp name:B827EB7C4AA1@Kodi (LibreELEC) port:36666 16:23:59.524 T:1838150544 DEBUG: CZeroconfAvahi::addService() named: B827EB7C4AA1@Kodi (LibreELEC) type: _raop._tcp port:36666 16:23:59.534 T:1838150544 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airplay type: _airplay._tcp name:Kodi (LibreELEC) port:36667 16:23:59.534 T:1838150544 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _airplay._tcp port:36667 16:23:59.546 T:1802498960 DEBUG: CRepositoryUpdateJob[repository.kodinerds] checksum not changed. 16:23:59.726 T:1810887568 DEBUG: CRepositoryUpdateJob[repository.retroplayer.libreelec.tv] checksum not changed. 16:23:59.727 T:1810887568 DEBUG: CRepositoryUpdater: done. 16:23:59.788 T:1810887568 DEBUG: CAddonMgr::GetAvailableUpdates took 60 ms 16:23:59.797 T:1776587664 INFO: Found input device /dev/input/event0 16:23:59.841 T:1810887568 DEBUG: CAddonMgr::GetAvailableUpdates took 52 ms 16:23:59.854 T:1776587664 INFO: opened device 'Logitech USB Receiver' (file name /dev/input/event0), m_bSkipNonKeyEvents 0 16:23:59.854 T:1776587664 NOTICE: Logitech USB Receiver: keys:0 ext:0 but:16 rel:4 abs:0 m_deviceType:1 bits:110001 16:23:59.876 T:1810887568 DEBUG: CRepositoryUpdater: previous update at 06.10.2017 16:23:58, next at 07.10.2017 16:23:58 16:23:59.876 T:1632629648 DEBUG: Thread Timer start, auto delete: false 16:23:59.938 T:1827664784 DEBUG: ## LibreELEC Addon ## 9.0.0 16:23:59.951 T:1819276176 DEBUG: StorageServer Module loaded RUN 16:23:59.951 T:1819276176 DEBUG: StorageClient-2.5.4 Starting server 16:23:59.960 T:1776587664 INFO: Found input device /dev/input/event1 16:23:59.961 T:1776587664 INFO: opened device 'Logitech USB Receiver' (file name /dev/input/event1), m_bSkipNonKeyEvents 0 16:23:59.961 T:1776587664 NOTICE: Logitech USB Receiver: keys:35 ext:70 but:0 rel:1 abs:0 m_deviceType:c bits:111000 16:24:00.087 T:1776587664 INFO: Found input device /dev/input/event2 16:24:00.087 T:1776587664 INFO: opened device 'SIGMACHIP USB Keyboard' (file name /dev/input/event2), m_bSkipNonKeyEvents 0 16:24:00.087 T:1776587664 NOTICE: SIGMACHIP USB Keyboard: keys:35 ext:0 but:0 rel:0 abs:0 m_deviceType:4 bits:100001 16:24:00.190 T:1776587664 INFO: Found input device /dev/input/event3 16:24:00.191 T:1776587664 INFO: opened device 'SIGMACHIP USB Keyboard' (file name /dev/input/event3), m_bSkipNonKeyEvents 0 16:24:00.191 T:1776587664 NOTICE: SIGMACHIP USB Keyboard: keys:1 ext:64 but:0 rel:1 abs:0 m_deviceType:8 bits:111000 16:24:00.191 T:1776587664 DEBUG: Thread PeripBusCEC 1776587664 terminating 16:24:00.253 T:1942900752 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x281b670 16:24:00.255 T:1942900752 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(314128), nBufferAlignment(16) 16:24:00.263 T:1942900752 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x2871738 16:24:00.266 T:1942900752 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x27fde28 16:24:00.268 T:1942900752 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 16:24:00.424 T:1731060624 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 16:24:00.491 T:1942900752 DEBUG: Previous line repeats 5 times. 16:24:00.491 T:1942900752 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x281b670 16:24:00.492 T:1942900752 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x2871738 16:24:00.494 T:1942900752 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x27fde28 16:24:00.494 T:1942900752 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/backgrounds/primary.jpg 1280x720 16:24:00.521 T:1942900752 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x281b670 16:24:00.522 T:1942900752 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(93824), nBufferAlignment(16) 16:24:00.527 T:1942900752 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x27fde28 16:24:00.529 T:1942900752 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 16:24:00.570 T:1942900752 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x281b670 16:24:00.572 T:1942900752 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x27fde28 16:24:00.572 T:1942900752 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/backgrounds/pattern1.jpg 900x506 16:24:00.614 T:1942900752 DEBUG: ------ Window Init () ------ 16:24:00.614 T:1942900752 DEBUG: Alloc resources: 0.01ms (0.01 ms skin load) 16:24:00.626 T:1942900752 DEBUG: ------ Window Init (Pointer.xml) ------ 16:24:00.848 T:1942900752 DEBUG: ------ Window Init (DialogNotification.xml) ------ 16:24:00.848 T:1942900752 DEBUG: Window DialogNotification.xml was already loaded 16:24:00.849 T:1942900752 DEBUG: Alloc resources: 0.02ms 16:24:00.862 T:1942900752 DEBUG: ------ Window Deinit (Pointer.xml) ------ 16:24:00.904 T:1827664784 INFO: ## LibreELEC Addon ## system::set_hostname ## LibreELEC 16:24:00.906 T:1827664784 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## de 16:24:00.907 T:1827664784 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## loadkmap < `ls -1 /usr/lib/keymaps/*/de.bmap` 16:24:01.014 T:1739449232 DEBUG: OpenConnection - connection to the CEC adapter opened 16:24:01.015 T:1739449232 DEBUG: SetConfigurationFromLibCEC - settings updated by libCEC 16:24:01.018 T:1776587664 DEBUG: Thread CECAdapterUpdate start, auto delete: false 16:24:01.062 T:1827664784 INFO: ## LibreELEC Addon ## system::updateThread ## Started 16:24:01.066 T:1827664784 INFO: ## LibreELEC Addon ## system::set_auto_update ## manual 16:24:01.200 T:1614799760 INFO: ## LibreELEC Addon ## _service_::run ## WAITING: 16:24:01.237 T:1623188368 INFO: ## LibreELEC Addon ## xdbus Monitor started. ## 16:24:01.293 T:1776587664 DEBUG: UpdateMenuLanguage - using TV menu language is disabled 16:24:02.449 T:1942900752 DEBUG: ------ Window Init (Pointer.xml) ------ 16:24:03.739 T:1776587664 DEBUG: UpdateAudioSystemStatus - no CEC capable amplifier found 16:24:05.752 T:1802498960 DEBUG: GetImageHash - unable to stat url /storage/.kodi/addons/plugin.video.skygo.de/fanart.jpg 16:24:06.431 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:24:06.432 T:1942900752 DEBUG: Activating window ID: 10025 16:24:06.743 T:1942900752 DEBUG: ------ Window Deinit (Home.xml) ------ 16:24:06.743 T:1942900752 DEBUG: FreeVisualisation() done 16:24:06.782 T:1942900752 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 16:24:06.783 T:1942900752 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 16:24:07.137 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/MyVideoNav.xml loaded in 354.28ms 16:24:07.137 T:1942900752 DEBUG: CDirectoryProvider[]: refreshing.. 16:24:07.138 T:1810887568 ERROR: GetDirectory - Error getting 16:24:07.138 T:1942900752 DEBUG: CDirectoryProvider[]: refreshing.. 16:24:07.138 T:1838150544 ERROR: GetDirectory - Error getting 16:24:07.138 T:1942900752 DEBUG: CDirectoryProvider[]: refreshing.. 16:24:07.138 T:1838150544 DEBUG: Previous line repeats 1 times. 16:24:07.138 T:1838150544 ERROR: GetDirectory - Error getting 16:24:07.138 T:1942900752 DEBUG: CDirectoryProvider[]: refreshing.. 16:24:07.138 T:1802498960 ERROR: GetDirectory - Error getting 16:24:07.138 T:1942900752 DEBUG: CDirectoryProvider[]: refreshing.. 16:24:07.139 T:1838150544 ERROR: GetDirectory - Error getting 16:24:07.139 T:1942900752 ERROR: Previous line repeats 1 times. 16:24:07.139 T:1942900752 DEBUG: CDirectoryProvider[]: refreshing.. 16:24:07.139 T:1802498960 ERROR: GetDirectory - Error getting 16:24:07.141 T:1942900752 DEBUG: Alloc resources: 358.48ms (354.53 ms skin load) 16:24:07.221 T:1942900752 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/) 16:24:07.221 T:1942900752 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 16:24:07.267 T:1802498960 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 46 ms 16:24:07.268 T:1838150544 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','1','','resume:false') 16:24:07.269 T:1604309904 DEBUG: Thread LanguageInvoker start, auto delete: false 16:24:07.269 T:1604309904 INFO: initializing python engine. 16:24:07.269 T:1604309904 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing 16:24:07.327 T:1604309904 DEBUG: -->Python Interpreter Initialized<-- 16:24:07.328 T:1604309904 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" 16:24:07.331 T:1604309904 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.cryptopy/lib:/storage/.kodi/addons/script.module.pydes/lib:/storage/.kodi/addons/script.module.requests/lib:/storage/.kodi/addons/script.module.routing/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 16:24:07.331 T:1604309904 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de 16:24:07.331 T:1604309904 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 16:24:07.724 T:1942900752 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:24:07.724 T:1942900752 DEBUG: Window DialogBusy.xml was already loaded 16:24:07.724 T:1942900752 DEBUG: Alloc resources: 0.03ms 16:24:08.648 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting definitions 16:24:08.648 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: trying to load setting definitions from old format... 16:24:08.653 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting values 16:24:08.654 T:1604309904 DEBUG: false 16:24:08.951 T:1604309904 DEBUG: CAddonSettings[script.common.plugin.cache]: loading setting definitions 16:24:08.951 T:1604309904 DEBUG: CAddonSettings[script.common.plugin.cache]: trying to load setting definitions from old format... 16:24:08.958 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting definitions 16:24:08.958 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: trying to load setting definitions from old format... 16:24:08.960 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting values 16:24:09.064 T:1604309904 DEBUG: ['plugin://plugin.video.skygo.de/', '1', '', 'resume:false'] 16:24:09.382 T:1942900752 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 16:24:09.392 T:1604309904 INFO: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 16:24:09.394 T:1942900752 DEBUG: Saving fileitems [plugin://plugin.video.skygo.de/] 16:24:09.395 T:1942900752 DEBUG: -- items: 10, sort method: 0, ascending: false 16:24:09.414 T:1589638032 DEBUG: Thread BackgroundLoader start, auto delete: false 16:24:09.427 T:1942900752 WARNING: CGUIWindowManager - HandleAction - ignoring action 107, because topmost modal dialog closing animation is running 16:24:09.471 T:1589638032 WARNING: Previous line repeats 3 times. 16:24:09.471 T:1589638032 DEBUG: Thread BackgroundLoader 1589638032 terminating 16:24:09.488 T:1942900752 WARNING: CGUIWindowManager - HandleAction - ignoring action 107, because topmost modal dialog closing animation is running 16:24:09.522 T:1604309904 WARNING: Previous line repeats 4 times. 16:24:09.522 T:1604309904 INFO: Python script stopped 16:24:09.522 T:1604309904 DEBUG: Thread LanguageInvoker 1604309904 terminating 16:24:09.531 T:1942900752 WARNING: CGUIWindowManager - HandleAction - ignoring action 107, because topmost modal dialog closing animation is running 16:24:09.621 T:1942900752 WARNING: Previous line repeats 8 times. 16:24:09.622 T:1942900752 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:24:12.315 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:24:12.317 T:1942900752 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listLiveTvChannelDirs) 16:24:12.327 T:1942900752 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 16:24:12.378 T:1838150544 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 51 ms 16:24:12.379 T:1810887568 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','2','?action=listLiveTvChannelDirs','resume:false') 16:24:12.379 T:1604309904 DEBUG: Thread LanguageInvoker start, auto delete: false 16:24:12.379 T:1604309904 INFO: initializing python engine. 16:24:12.379 T:1604309904 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing 16:24:12.433 T:1604309904 DEBUG: -->Python Interpreter Initialized<-- 16:24:12.433 T:1604309904 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo.de/default.py" 16:24:12.435 T:1604309904 DEBUG: CPythonInvoker(3, /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.cryptopy/lib:/storage/.kodi/addons/script.module.pydes/lib:/storage/.kodi/addons/script.module.requests/lib:/storage/.kodi/addons/script.module.routing/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 16:24:12.435 T:1604309904 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de 16:24:12.435 T:1604309904 DEBUG: CPythonInvoker(3, /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 16:24:12.831 T:1942900752 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:24:12.831 T:1942900752 DEBUG: Window DialogBusy.xml was already loaded 16:24:12.831 T:1942900752 DEBUG: Alloc resources: 0.18ms 16:24:13.321 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting definitions 16:24:13.321 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: trying to load setting definitions from old format... 16:24:13.324 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting values 16:24:13.324 T:1604309904 DEBUG: false 16:24:13.588 T:1604309904 DEBUG: CAddonSettings[script.common.plugin.cache]: loading setting definitions 16:24:13.589 T:1604309904 DEBUG: CAddonSettings[script.common.plugin.cache]: trying to load setting definitions from old format... 16:24:13.594 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting definitions 16:24:13.594 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: trying to load setting definitions from old format... 16:24:13.596 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting values 16:24:13.649 T:1604309904 DEBUG: {'action': 'listLiveTvChannelDirs'} 16:24:14.446 T:1604309904 INFO: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 16:24:14.448 T:1942900752 DEBUG: Saving fileitems [plugin://plugin.video.skygo.de/?action=listLiveTvChannelDirs] 16:24:14.449 T:1942900752 DEBUG: -- items: 4, sort method: 0, ascending: false 16:24:14.464 T:1589638032 DEBUG: Thread BackgroundLoader start, auto delete: false 16:24:14.503 T:1589638032 DEBUG: Thread BackgroundLoader 1589638032 terminating 16:24:14.610 T:1604309904 INFO: Python script stopped 16:24:14.610 T:1604309904 DEBUG: Thread LanguageInvoker 1604309904 terminating 16:24:14.623 T:1942900752 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:24:17.044 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:24:17.048 T:1942900752 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listLiveTvChannels&channeldir_name=sport) 16:24:17.048 T:1942900752 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/?action=listLiveTvChannelDirs] 16:24:17.167 T:1810887568 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 118 ms 16:24:17.168 T:1838150544 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','3','?action=listLiveTvChannels&channeldir_name=sport','resume:false') 16:24:17.168 T:1604309904 DEBUG: Thread LanguageInvoker start, auto delete: false 16:24:17.169 T:1604309904 INFO: initializing python engine. 16:24:17.169 T:1604309904 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing 16:24:17.222 T:1604309904 DEBUG: -->Python Interpreter Initialized<-- 16:24:17.222 T:1604309904 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo.de/default.py" 16:24:17.224 T:1604309904 DEBUG: CPythonInvoker(4, /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.cryptopy/lib:/storage/.kodi/addons/script.module.pydes/lib:/storage/.kodi/addons/script.module.requests/lib:/storage/.kodi/addons/script.module.routing/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 16:24:17.224 T:1604309904 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de 16:24:17.224 T:1604309904 DEBUG: CPythonInvoker(4, /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 16:24:17.554 T:1942900752 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:24:17.555 T:1942900752 DEBUG: Window DialogBusy.xml was already loaded 16:24:17.555 T:1942900752 DEBUG: Alloc resources: 0.15ms 16:24:18.119 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting definitions 16:24:18.119 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: trying to load setting definitions from old format... 16:24:18.122 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting values 16:24:18.123 T:1604309904 DEBUG: false 16:24:18.420 T:1604309904 DEBUG: CAddonSettings[script.common.plugin.cache]: loading setting definitions 16:24:18.420 T:1604309904 DEBUG: CAddonSettings[script.common.plugin.cache]: trying to load setting definitions from old format... 16:24:18.426 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting definitions 16:24:18.426 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: trying to load setting definitions from old format... 16:24:18.428 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting values 16:24:18.484 T:1604309904 DEBUG: {'action': 'listLiveTvChannels', 'channeldir_name': 'sport'} 16:24:21.166 T:1604309904 INFO: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 16:24:21.196 T:1942900752 DEBUG: Saving fileitems [plugin://plugin.video.skygo.de/?action=listLiveTvChannels&channeldir_name=sport] 16:24:21.198 T:1942900752 DEBUG: -- items: 3, sort method: 0, ascending: false 16:24:21.218 T:1589638032 DEBUG: Thread BackgroundLoader start, auto delete: false 16:24:21.268 T:1589638032 DEBUG: Thread BackgroundLoader 1589638032 terminating 16:24:21.365 T:1604309904 INFO: Python script stopped 16:24:21.371 T:1604309904 DEBUG: Thread LanguageInvoker 1604309904 terminating 16:24:21.440 T:1942900752 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:24:22.417 T:1810887568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x72a2fa20 16:24:22.420 T:1810887568 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 16:24:22.427 T:1810887568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x72a81410 16:24:22.428 T:1810887568 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 16:24:22.457 T:1810887568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x72a2fa20 16:24:22.459 T:1810887568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x72a81410 16:24:22.460 T:1810887568 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/5/586953e8.jpg 404x227 16:24:22.644 T:1838150544 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x62fbf6f0 16:24:22.646 T:1838150544 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 16:24:22.652 T:1838150544 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x6ea3a758 16:24:22.653 T:1838150544 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 16:24:22.684 T:1838150544 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x62fbf6f0 16:24:22.686 T:1838150544 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x6ea3a758 16:24:22.687 T:1838150544 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/a/ac0b4100.jpg 404x227 16:24:22.911 T:1810887568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x72a2d040 16:24:22.914 T:1810887568 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 16:24:22.919 T:1810887568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x72a81410 16:24:22.921 T:1810887568 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 16:24:22.929 T:1810887568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x72a2d040 16:24:22.931 T:1810887568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x72a81410 16:24:22.932 T:1810887568 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/2/23929db4.jpg 404x227 16:24:23.415 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:24:23.441 T:1942900752 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242820_242821%2Fsporth01.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Golf%3A+European+Senior+Tour+Highlights+Paris+Legends+Championship%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+1+HD+%7C+%5B%2FCOLOR%5DGolf%3A+European+Senior+Tour+Highlights+Paris+Legends+Championship%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+3600%2C+%27genre%27%3A+u%27Sport+%28allgemein%29%2C+Golf%27%7D 16:24:23.449 T:1942900752 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','4','?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242820_242821%2Fsporth01.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Golf%3A+European+Senior+Tour+Highlights+Paris+Legends+Championship%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+1+HD+%7C+%5B%2FCOLOR%5DGolf%3A+European+Senior+Tour+Highlights+Paris+Legends+Championship%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+3600%2C+%27genre%27%3A+u%27Sport+%28allgemein%29%2C+Golf%27%7D','resume:false') 16:24:23.450 T:1604309904 DEBUG: Thread LanguageInvoker start, auto delete: false 16:24:23.451 T:1604309904 INFO: initializing python engine. 16:24:23.451 T:1604309904 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing 16:24:23.471 T:1589638032 DEBUG: Thread scriptobs start, auto delete: false 16:24:23.477 T:1942897552 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 16:24:23.477 T:1942897552 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 16:24:23.514 T:1604309904 DEBUG: -->Python Interpreter Initialized<-- 16:24:23.515 T:1604309904 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo.de/default.py" 16:24:23.517 T:1604309904 DEBUG: CPythonInvoker(5, /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.cryptopy/lib:/storage/.kodi/addons/script.module.pydes/lib:/storage/.kodi/addons/script.module.requests/lib:/storage/.kodi/addons/script.module.routing/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 16:24:23.517 T:1604309904 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de 16:24:23.517 T:1604309904 DEBUG: CPythonInvoker(5, /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 16:24:23.671 T:1942900752 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:24:23.671 T:1942900752 DEBUG: Window DialogBusy.xml was already loaded 16:24:23.672 T:1942900752 DEBUG: Alloc resources: 0.11ms 16:24:24.463 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting definitions 16:24:24.464 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: trying to load setting definitions from old format... 16:24:24.466 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting values 16:24:24.467 T:1604309904 DEBUG: false 16:24:24.694 T:1604309904 DEBUG: CAddonSettings[script.common.plugin.cache]: loading setting definitions 16:24:24.694 T:1604309904 DEBUG: CAddonSettings[script.common.plugin.cache]: trying to load setting definitions from old format... 16:24:24.701 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting definitions 16:24:24.701 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: trying to load setting definitions from old format... 16:24:24.704 T:1604309904 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting values 16:24:24.762 T:1604309904 DEBUG: {'action': 'playLive', 'manifest_url': 'http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest', 'parental_rating': '0', 'infolabels': "{'plot': u'Golf: European Senior Tour Highlights Paris Legends Championship', 'title': u'[COLOR blue]Sky Sport 1 HD | [/COLOR]Golf: European Senior Tour Highlights Paris Legends Championship', 'originaltitle': '', 'cast': [], 'duration': 3600, 'genre': u'Sport (allgemein), Golf'}", 'package_code': 'OSPS'} 16:24:25.299 T:1604309904 DEBUG: {u'tcFlag': u'Y', u'flagMPPinSet': u'N', u'email': u'max.krisch@gmail.com', u'customerCode': u'7249848334', u'resultCode': u'S_100', u'privacyFlag': u'Y', u'extraCustFlag': u'N', u'bookmarkFlag': u'Y', u'skygoSessionId': u'SG-9c9f1913-c755-49be-acf0-ad5de0d3bcab', u'entitlements': [u'OOHD', u'OOSP', u'OSPS'], u'presentation': u'KEINE ANGABE', u'cableSubFlag': u'Y', u'flagTEF': u'N', u'doubleOptInFlag': u'Y', u'mktgFlag': u'N', u'firstName': u'HERBERT', u'gender': u'NA', u'age': u'71', u'lastName': u'KRISCH', u'resultMessage': u'OK', u'accountCreated': u'2016/04/06', u'country': u'AT'} 16:24:25.300 T:1604309904 DEBUG: User still logged in 16:24:25.357 T:1604309904 INFO: CPythonInvoker(5, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 16:24:25.370 T:1589638032 DEBUG: Thread scriptobs 1589638032 terminating 16:24:25.371 T:1942900752 INFO: easy_acquire - Created session to http://livemss1it-s.akamaihd.net 16:24:25.465 T:1942900752 DEBUG: CCurlFile::GetMimeType - http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest -> text/xml 16:24:25.488 T:1942900752 DEBUG: Loading settings for http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest 16:24:25.508 T:1942900752 DEBUG: CPlayerCoreFactory::GetPlayers(http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest) 16:24:25.509 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 16:24:25.509 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 16:24:25.509 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 16:24:25.509 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 16:24:25.509 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 16:24:25.509 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 16:24:25.509 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 16:24:25.510 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams 16:24:25.510 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp 16:24:25.510 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2 16:24:25.510 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 16:24:25.510 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 16:24:25.510 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 16:24:25.510 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 16:24:25.511 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 16:24:25.511 T:1942900752 DEBUG: CPlayerCoreFactory::GetPlayers: matched {0} rules with players 16:24:25.511 T:1942900752 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 16:24:25.511 T:1942900752 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 16:24:25.511 T:1942900752 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 16:24:25.511 T:1942900752 DEBUG: CPlayerCoreFactory::GetPlayers: added {0} players 16:24:25.516 T:1942900752 DEBUG: CMMALPool::CMMALPool Created pool 0x2be29f0 of size 26 x 0 for port vc.ril.video_decode:out:0(I420) 16:24:25.526 T:1942900752 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 16:24:25.527 T:1942900752 NOTICE: VideoPlayer::OpenFile: http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest 16:24:25.527 T:1942900752 DEBUG: OnPlayBackStarted: CApplication::OnPlayBackStarted 16:24:25.539 T:1942900752 DEBUG: CCurlFile::GetMimeType - http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest -> text/xml 16:24:25.539 T:1942900752 DEBUG: CMMALRenderer::CMMALRenderer 16:24:25.540 T:1567429520 DEBUG: Thread MMALProcess start, auto delete: false 16:24:25.540 T:1567429520 DEBUG: CMMALRenderer::Run - starting 16:24:25.541 T:1550652304 DEBUG: Thread BackgroundLoader start, auto delete: false 16:24:25.541 T:1559040912 DEBUG: Thread VideoPlayer start, auto delete: false 16:24:25.541 T:1559040912 NOTICE: Creating InputStream 16:24:25.542 T:1559040912 DEBUG: ADDON: Dll Initializing - InputStream Adaptive 16:24:25.543 T:1559040912 DEBUG: SECTION:LoadDLL(/usr/lib/kodi/addons/inputstream.adaptive/inputstream.adaptive.so.2.1.4) 16:24:25.543 T:1559040912 DEBUG: Loading: /usr/lib/kodi/addons/inputstream.adaptive/inputstream.adaptive.so.2.1.4 16:24:25.562 T:1604309904 INFO: Python script stopped 16:24:25.563 T:1604309904 DEBUG: Thread LanguageInvoker 1604309904 terminating 16:24:25.589 T:1810887568 DEBUG: CGUIInfoManager::SetCurrentMovie(http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest) 16:24:25.634 T:1942897552 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 16:24:25.635 T:1942897552 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 16:24:25.635 T:1942897552 DEBUG: CAnnouncementManager - Announcement: OnChanged from xbmc 16:24:25.636 T:1550652304 DEBUG: Thread BackgroundLoader 1550652304 terminating 16:24:25.636 T:1942897552 DEBUG: GOT ANNOUNCEMENT, type: 1024, from xbmc, message OnChanged 16:24:25.758 T:1942900752 NOTICE: m_playbackStarting 16:24:25.758 T:1942900752 NOTICE: StereoscopicsManager::IsPlaying 16:24:25.758 T:1559040912 INFO: AddOnLog: InputStream Adaptive: SetVideoResolution (1920 x 1080) 16:24:25.758 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: Open() 16:24:25.759 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_data: [not shown] 16:24:25.759 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_key: [not shown] 16:24:25.759 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_type: com.widevine.alpha 16:24:25.759 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.manifest_type: ism 16:24:25.761 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: Initial bandwidth: 4000000 16:24:25.764 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:24:25.764 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:24:25.765 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: MAXRESOLUTION selected: 0 16:24:25.766 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:24:25.767 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:24:25.768 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: MAXRESOLUTIONSECURE selected: 2 16:24:25.769 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:24:25.769 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:24:25.771 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: STREAMSELECTION selected: 0 16:24:25.772 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:24:25.772 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:24:25.775 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:24:25.775 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:24:25.777 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: Searching for decrypters in: /usr/lib/kodi/addons/inputstream.adaptive/ 16:24:25.790 T:1942900752 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:24:25.982 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: Found decrypter: /usr/lib/kodi/addons/inputstream.adaptive/libssd_wv.so 16:24:25.982 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: Supported URN: urn:uuid:EDEF8BA9-79D6-4ACE-A3C8-27DCD51D21ED 16:24:25.983 T:1559040912 DEBUG: CurlFile::Open(0x733213c8) http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest 16:24:26.082 T:1942900752 NOTICE: m_playbackStarting 16:24:26.082 T:1942900752 NOTICE: StereoscopicsManager::IsPlaying 16:24:26.140 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest finished 16:24:26.141 T:1559040912 INFO: AddOnLog: InputStream Adaptive: Successfully parsed .mpd file. #Streams: 2 Download speed: 0.0000 Bytes/s 16:24:26.143 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:24:26.143 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:24:26.145 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:24:26.145 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:24:26.147 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: Entering encryption section 16:24:26.155 T:1559040912 ERROR: AddOnLog: InputStream Adaptive: Unable to load widevine shared library (/storage/.kodi/cdm/libwidevinecdm.so) 16:24:26.156 T:1559040912 ERROR: AddOnLog: InputStream Adaptive: OpenDRMSystem failed 16:24:26.156 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: Session::~Session() 16:24:26.158 T:1559040912 ERROR: CVideoPlayer::OpenInputStream - error opening [http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest] 16:24:26.159 T:1559040912 NOTICE: CVideoPlayer::OnExit() 16:24:26.159 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: Close() 16:24:26.159 T:1559040912 DEBUG: SECTION:UnloadDll(/usr/lib/kodi/addons/inputstream.adaptive/inputstream.adaptive.so.2.1.4) 16:24:26.160 T:1559040912 INFO: ADDON: Dll Destroyed - InputStream Adaptive 16:24:26.161 T:1559040912 DEBUG: Thread VideoPlayer 1559040912 terminating 16:24:26.165 T:1942900752 DEBUG: ------ Window Init (DialogConfirm.xml) ------ 16:24:26.165 T:1942900752 INFO: Loading skin file: DialogConfirm.xml, load type: KEEP_IN_MEMORY 16:24:26.180 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/DialogConfirm.xml loaded in 14.68ms 16:24:26.181 T:1942900752 DEBUG: Alloc resources: 15.27ms (14.93 ms skin load) 16:24:26.599 T:1942900752 NOTICE: m_playbackStarting 16:24:29.232 T:1942900752 NOTICE: Previous line repeats 4 times. 16:24:29.232 T:1942900752 INFO: CheckIdle - Closing session to http://addons.libreelec.tv (easy=0x72a1c8b8, multi=0x72a2d4a8) 16:24:29.233 T:1942900752 INFO: CheckIdle - Closing session to http://mirrors.kodi.tv (easy=0x729515d0, multi=0x729d3558) 16:24:29.234 T:1942900752 NOTICE: m_playbackStarting 16:24:29.766 T:1942900752 INFO: CheckIdle - Closing session to https://raw.githubusercontent.com (easy=0x6ea22e00, multi=0x6ea40e00) 16:24:29.788 T:1942900752 INFO: CheckIdle - Closing session to http://lrusak.libreelec.tv (easy=0x72a68488, multi=0x72a17470) 16:24:29.789 T:1942900752 NOTICE: m_playbackStarting 16:24:33.566 T:1942900752 NOTICE: Previous line repeats 7 times. 16:24:33.566 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:24:33.566 T:1942900752 NOTICE: m_playbackStarting 16:24:33.844 T:1942900752 DEBUG: ------ Window Deinit (DialogConfirm.xml) ------ 16:24:33.866 T:1810887568 DEBUG: OnPlayBackStopped: CApplication::OnPlayBackStopped 16:24:33.886 T:1942897552 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 16:24:33.886 T:1942897552 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 16:24:33.899 T:1942900752 NOTICE: m_playbackStarting 16:24:33.984 T:1802498960 DEBUG: DoWork - Saving file state for video item plugin://plugin.video.skygo.de/?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242820_242821%2Fsporth01.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Golf%3A+European+Senior+Tour+Highlights+Paris+Legends+Championship%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+1+HD+%7C+%5B%2FCOLOR%5DGolf%3A+European+Senior+Tour+Highlights+Paris+Legends+Championship%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+3600%2C+%27genre%27%3A+u%27Sport+%28allgemein%29%2C+Golf%27%7D 16:24:34.543 T:1838150544 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x6ea22ce8 16:24:34.546 T:1838150544 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 16:24:34.552 T:1838150544 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x6ea3a758 16:24:34.553 T:1838150544 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 16:24:34.562 T:1838150544 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x6ea22ce8 16:24:34.564 T:1838150544 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x6ea3a758 16:24:34.564 T:1838150544 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/5/586953e8.jpg 404x227 16:24:39.653 T:1942900752 DEBUG: ------ Window Deinit (Pointer.xml) ------ 16:24:56.434 T:1942900752 INFO: CheckIdle - Closing session to http://livemss1it-s.akamaihd.net (easy=0x2d07b88, multi=0x5e072da8) 16:25:04.535 T:1810887568 DEBUG: Thread JobWorker 1810887568 terminating (autodelete) 16:25:04.536 T:1802498960 DEBUG: Thread JobWorker 1802498960 terminating (autodelete) 16:25:04.566 T:1838150544 DEBUG: Thread JobWorker 1838150544 terminating (autodelete) 16:25:09.254 T:1910502288 DEBUG: CAESinkPi:Drain delay:50ms now:0ms 16:25:19.255 T:1910502288 DEBUG: CAESinkPi:Deinitialize 16:25:19.255 T:1910502288 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 16:25:19.263 T:1910502288 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x71400758 16:26:41.260 T:1942900752 DEBUG: ------ Window Init (Pointer.xml) ------ 16:26:41.373 T:1838150544 DEBUG: Thread JobWorker start, auto delete: true 16:26:41.382 T:1838150544 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x71523908 16:26:41.384 T:1838150544 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 16:26:41.390 T:1838150544 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x71523810 16:26:41.392 T:1838150544 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 16:26:41.401 T:1838150544 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x71523908 16:26:41.403 T:1838150544 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x71523810 16:26:41.404 T:1838150544 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/a/ac0b4100.jpg 404x227 16:26:41.462 T:1838150544 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x7150c6f8 16:26:41.464 T:1838150544 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 16:26:41.469 T:1838150544 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x71523810 16:26:41.470 T:1838150544 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 16:26:41.478 T:1838150544 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x7150c6f8 16:26:41.479 T:1838150544 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x71523810 16:26:41.479 T:1838150544 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/2/23929db4.jpg 404x227 16:26:43.438 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:26:43.473 T:1942900752 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242820_242821%2Fsporth01.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Golf%3A+European+Senior+Tour+Highlights+Paris+Legends+Championship%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+1+HD+%7C+%5B%2FCOLOR%5DGolf%3A+European+Senior+Tour+Highlights+Paris+Legends+Championship%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+3600%2C+%27genre%27%3A+u%27Sport+%28allgemein%29%2C+Golf%27%7D 16:26:43.516 T:1942897552 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 16:26:43.516 T:1942897552 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 16:26:43.526 T:1942900752 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','5','?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242820_242821%2Fsporth01.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Golf%3A+European+Senior+Tour+Highlights+Paris+Legends+Championship%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+1+HD+%7C+%5B%2FCOLOR%5DGolf%3A+European+Senior+Tour+Highlights+Paris+Legends+Championship%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+3600%2C+%27genre%27%3A+u%27Sport+%28allgemein%29%2C+Golf%27%7D','resume:false') 16:26:43.527 T:1802498960 DEBUG: Thread LanguageInvoker start, auto delete: false 16:26:43.528 T:1802498960 INFO: initializing python engine. 16:26:43.528 T:1802498960 DEBUG: CPythonInvoker(6, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing 16:26:43.548 T:1810887568 DEBUG: Thread scriptobs start, auto delete: false 16:26:43.552 T:1942897552 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 16:26:43.553 T:1942897552 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 16:26:43.589 T:1802498960 DEBUG: -->Python Interpreter Initialized<-- 16:26:43.590 T:1802498960 DEBUG: CPythonInvoker(6, /storage/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo.de/default.py" 16:26:43.592 T:1802498960 DEBUG: CPythonInvoker(6, /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.cryptopy/lib:/storage/.kodi/addons/script.module.pydes/lib:/storage/.kodi/addons/script.module.requests/lib:/storage/.kodi/addons/script.module.routing/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 16:26:43.592 T:1802498960 DEBUG: CPythonInvoker(6, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de 16:26:43.592 T:1802498960 DEBUG: CPythonInvoker(6, /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 16:26:43.748 T:1942900752 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:26:43.748 T:1942900752 DEBUG: Window DialogBusy.xml was already loaded 16:26:43.749 T:1942900752 DEBUG: Alloc resources: 0.11ms 16:26:44.507 T:1802498960 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting definitions 16:26:44.507 T:1802498960 DEBUG: CAddonSettings[plugin.video.skygo.de]: trying to load setting definitions from old format... 16:26:44.510 T:1802498960 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting values 16:26:44.511 T:1802498960 DEBUG: false 16:26:44.755 T:1802498960 DEBUG: CAddonSettings[script.common.plugin.cache]: loading setting definitions 16:26:44.755 T:1802498960 DEBUG: CAddonSettings[script.common.plugin.cache]: trying to load setting definitions from old format... 16:26:44.760 T:1802498960 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting definitions 16:26:44.760 T:1802498960 DEBUG: CAddonSettings[plugin.video.skygo.de]: trying to load setting definitions from old format... 16:26:44.763 T:1802498960 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting values 16:26:44.815 T:1802498960 DEBUG: {'action': 'playLive', 'manifest_url': 'http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest', 'parental_rating': '0', 'infolabels': "{'plot': u'Golf: European Senior Tour Highlights Paris Legends Championship', 'title': u'[COLOR blue]Sky Sport 1 HD | [/COLOR]Golf: European Senior Tour Highlights Paris Legends Championship', 'originaltitle': '', 'cast': [], 'duration': 3600, 'genre': u'Sport (allgemein), Golf'}", 'package_code': 'OSPS'} 16:26:45.165 T:1802498960 DEBUG: {u'tcFlag': u'Y', u'flagMPPinSet': u'N', u'email': u'max.krisch@gmail.com', u'customerCode': u'7249848334', u'resultCode': u'S_100', u'privacyFlag': u'Y', u'extraCustFlag': u'N', u'bookmarkFlag': u'Y', u'skygoSessionId': u'SG-9c9f1913-c755-49be-acf0-ad5de0d3bcab', u'entitlements': [u'OOHD', u'OOSP', u'OSPS'], u'presentation': u'KEINE ANGABE', u'cableSubFlag': u'Y', u'flagTEF': u'N', u'doubleOptInFlag': u'Y', u'mktgFlag': u'N', u'firstName': u'HERBERT', u'gender': u'NA', u'age': u'71', u'lastName': u'KRISCH', u'resultMessage': u'OK', u'accountCreated': u'2016/04/06', u'country': u'AT'} 16:26:45.165 T:1802498960 DEBUG: User still logged in 16:26:45.213 T:1802498960 INFO: CPythonInvoker(6, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 16:26:45.227 T:1810887568 DEBUG: Thread scriptobs 1810887568 terminating 16:26:45.228 T:1942900752 INFO: easy_acquire - Created session to http://livemss1it-s.akamaihd.net 16:26:45.348 T:1942900752 DEBUG: CCurlFile::GetMimeType - http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest -> text/xml 16:26:45.370 T:1942900752 DEBUG: Loading settings for http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest 16:26:45.390 T:1802498960 INFO: Python script stopped 16:26:45.391 T:1942900752 DEBUG: CPlayerCoreFactory::GetPlayers(http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest) 16:26:45.391 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 16:26:45.391 T:1802498960 DEBUG: Thread LanguageInvoker 1802498960 terminating 16:26:45.391 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 16:26:45.391 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 16:26:45.391 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 16:26:45.391 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 16:26:45.391 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 16:26:45.392 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 16:26:45.392 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams 16:26:45.392 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp 16:26:45.392 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2 16:26:45.392 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 16:26:45.392 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 16:26:45.392 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 16:26:45.392 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 16:26:45.392 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 16:26:45.393 T:1942900752 DEBUG: CPlayerCoreFactory::GetPlayers: matched {0} rules with players 16:26:45.393 T:1942900752 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 16:26:45.393 T:1942900752 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 16:26:45.393 T:1942900752 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 16:26:45.393 T:1942900752 DEBUG: CPlayerCoreFactory::GetPlayers: added {0} players 16:26:45.393 T:1942900752 NOTICE: VideoPlayer::OpenFile: http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest 16:26:45.393 T:1942900752 DEBUG: OnPlayBackStarted: CApplication::OnPlayBackStarted 16:26:45.405 T:1942900752 DEBUG: CCurlFile::GetMimeType - http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest -> text/xml 16:26:45.405 T:1802498960 DEBUG: Thread VideoPlayer start, auto delete: false 16:26:45.406 T:1810887568 DEBUG: Thread BackgroundLoader start, auto delete: false 16:26:45.406 T:1802498960 NOTICE: Creating InputStream 16:26:45.406 T:1942900752 WARNING: CGUIWindowManager - HandleAction - ignoring action 107, because topmost modal dialog closing animation is running 16:26:45.407 T:1802498960 WARNING: Previous line repeats 2 times. 16:26:45.407 T:1802498960 DEBUG: ADDON: Dll Initializing - InputStream Adaptive 16:26:45.407 T:1802498960 DEBUG: SECTION:LoadDLL(/usr/lib/kodi/addons/inputstream.adaptive/inputstream.adaptive.so.2.1.4) 16:26:45.408 T:1802498960 DEBUG: Loading: /usr/lib/kodi/addons/inputstream.adaptive/inputstream.adaptive.so.2.1.4 16:26:45.419 T:1838150544 DEBUG: CGUIInfoManager::SetCurrentMovie(http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest) 16:26:45.419 T:1942900752 WARNING: CGUIWindowManager - HandleAction - ignoring action 107, because topmost modal dialog closing animation is running 16:26:45.465 T:1942897552 WARNING: Previous line repeats 1 times. 16:26:45.465 T:1942897552 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 16:26:45.466 T:1942897552 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 16:26:45.471 T:1942897552 DEBUG: CAnnouncementManager - Announcement: OnChanged from xbmc 16:26:45.471 T:1942897552 DEBUG: GOT ANNOUNCEMENT, type: 1024, from xbmc, message OnChanged 16:26:45.471 T:1942900752 WARNING: CGUIWindowManager - HandleAction - ignoring action 107, because topmost modal dialog closing animation is running 16:26:45.483 T:1810887568 WARNING: Previous line repeats 1 times. 16:26:45.483 T:1810887568 DEBUG: Thread BackgroundLoader 1810887568 terminating 16:26:45.486 T:1942900752 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:26:45.592 T:1942900752 NOTICE: m_playbackStarting 16:26:45.593 T:1942900752 NOTICE: StereoscopicsManager::IsPlaying 16:26:45.593 T:1802498960 INFO: AddOnLog: InputStream Adaptive: SetVideoResolution (1920 x 1080) 16:26:45.593 T:1802498960 DEBUG: AddOnLog: InputStream Adaptive: Open() 16:26:45.593 T:1802498960 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_data: [not shown] 16:26:45.594 T:1802498960 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_key: [not shown] 16:26:45.594 T:1802498960 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_type: com.widevine.alpha 16:26:45.594 T:1802498960 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.manifest_type: ism 16:26:45.595 T:1802498960 DEBUG: AddOnLog: InputStream Adaptive: Initial bandwidth: 4000000 16:26:45.597 T:1802498960 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:26:45.597 T:1802498960 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:26:45.599 T:1802498960 DEBUG: AddOnLog: InputStream Adaptive: MAXRESOLUTION selected: 0 16:26:45.600 T:1802498960 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:26:45.600 T:1802498960 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:26:45.601 T:1802498960 DEBUG: AddOnLog: InputStream Adaptive: MAXRESOLUTIONSECURE selected: 2 16:26:45.603 T:1802498960 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:26:45.603 T:1802498960 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:26:45.605 T:1802498960 DEBUG: AddOnLog: InputStream Adaptive: STREAMSELECTION selected: 0 16:26:45.606 T:1802498960 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:26:45.606 T:1802498960 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:26:45.609 T:1802498960 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:26:45.609 T:1802498960 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:26:45.611 T:1802498960 DEBUG: AddOnLog: InputStream Adaptive: Searching for decrypters in: /usr/lib/kodi/addons/inputstream.adaptive/ 16:26:45.765 T:1802498960 DEBUG: AddOnLog: InputStream Adaptive: Found decrypter: /usr/lib/kodi/addons/inputstream.adaptive/libssd_wv.so 16:26:45.765 T:1802498960 DEBUG: AddOnLog: InputStream Adaptive: Supported URN: urn:uuid:EDEF8BA9-79D6-4ACE-A3C8-27DCD51D21ED 16:26:45.767 T:1802498960 DEBUG: CurlFile::Open(0x7292c3e8) http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest 16:26:45.924 T:1802498960 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest finished 16:26:45.925 T:1802498960 INFO: AddOnLog: InputStream Adaptive: Successfully parsed .mpd file. #Streams: 2 Download speed: 0.0000 Bytes/s 16:26:45.926 T:1802498960 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:26:45.926 T:1802498960 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:26:45.929 T:1802498960 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:26:45.930 T:1802498960 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:26:45.931 T:1802498960 DEBUG: AddOnLog: InputStream Adaptive: Entering encryption section 16:26:45.934 T:1802498960 ERROR: AddOnLog: InputStream Adaptive: Unable to load widevine shared library (/storage/.kodi/cdm/libwidevinecdm.so) 16:26:45.934 T:1802498960 ERROR: AddOnLog: InputStream Adaptive: OpenDRMSystem failed 16:26:45.935 T:1802498960 DEBUG: AddOnLog: InputStream Adaptive: Session::~Session() 16:26:45.937 T:1802498960 ERROR: CVideoPlayer::OpenInputStream - error opening [http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest] 16:26:45.937 T:1802498960 NOTICE: CVideoPlayer::OnExit() 16:26:45.938 T:1802498960 DEBUG: AddOnLog: InputStream Adaptive: Close() 16:26:45.938 T:1802498960 DEBUG: SECTION:UnloadDll(/usr/lib/kodi/addons/inputstream.adaptive/inputstream.adaptive.so.2.1.4) 16:26:45.939 T:1802498960 INFO: ADDON: Dll Destroyed - InputStream Adaptive 16:26:45.939 T:1802498960 DEBUG: Thread VideoPlayer 1802498960 terminating 16:26:45.954 T:1942900752 DEBUG: ------ Window Init (DialogConfirm.xml) ------ 16:26:45.955 T:1942900752 DEBUG: Window DialogConfirm.xml was already loaded 16:26:45.955 T:1942900752 DEBUG: Alloc resources: 0.31ms 16:26:46.021 T:1942900752 NOTICE: m_playbackStarting 16:26:47.921 T:1942900752 NOTICE: Previous line repeats 3 times. 16:26:47.922 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:26:47.922 T:1942900752 NOTICE: m_playbackStarting 16:26:48.155 T:1942900752 NOTICE: Previous line repeats 1 times. 16:26:48.155 T:1942900752 WARNING: CGUIWindowManager - HandleAction - ignoring action 107, because topmost modal dialog closing animation is running 16:26:48.165 T:1942900752 WARNING: Previous line repeats 1 times. 16:26:48.165 T:1942900752 DEBUG: ------ Window Deinit (DialogConfirm.xml) ------ 16:26:48.188 T:1838150544 DEBUG: OnPlayBackStopped: CApplication::OnPlayBackStopped 16:26:48.196 T:1838150544 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x71548af8 16:26:48.197 T:1838150544 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 16:26:48.202 T:1838150544 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x715b8058 16:26:48.204 T:1838150544 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 16:26:48.211 T:1942897552 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 16:26:48.211 T:1942897552 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 16:26:48.212 T:1838150544 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x71548af8 16:26:48.214 T:1838150544 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x715b8058 16:26:48.214 T:1838150544 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/5/586953e8.jpg 404x227 16:26:48.221 T:1942900752 NOTICE: m_playbackStarting 16:26:48.329 T:1838150544 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x715731a8 16:26:48.330 T:1838150544 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 16:26:48.334 T:1838150544 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x715b8058 16:26:48.335 T:1838150544 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 16:26:48.342 T:1838150544 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x715731a8 16:26:48.344 T:1838150544 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x715b8058 16:26:48.345 T:1838150544 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/a/ac0b4100.jpg 404x227 16:26:48.622 T:1838150544 DEBUG: DoWork - Saving file state for video item plugin://plugin.video.skygo.de/?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242820_242821%2Fsporth01.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Golf%3A+European+Senior+Tour+Highlights+Paris+Legends+Championship%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+1+HD+%7C+%5B%2FCOLOR%5DGolf%3A+European+Senior+Tour+Highlights+Paris+Legends+Championship%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+3600%2C+%27genre%27%3A+u%27Sport+%28allgemein%29%2C+Golf%27%7D 16:26:54.093 T:1942900752 DEBUG: ------ Window Deinit (Pointer.xml) ------ 16:27:16.255 T:1942900752 INFO: CheckIdle - Closing session to http://livemss1it-s.akamaihd.net (easy=0x2cd22b8, multi=0x7293ad10) 16:27:18.689 T:1838150544 DEBUG: Thread JobWorker 1838150544 terminating (autodelete) 16:29:49.483 T:1942897552 DEBUG: CAnnouncementManager - Announcement: OnScreensaverActivated from xbmc 16:29:49.483 T:1942897552 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverActivated 16:29:49.490 T:1942900752 DEBUG: CAddonSettings[screensaver.xbmc.builtin.dim]: loading setting definitions 16:29:49.491 T:1942900752 DEBUG: CAddonSettings[screensaver.xbmc.builtin.dim]: trying to load setting definitions from old format... 16:29:49.492 T:1942900752 DEBUG: ------ Window Init () ------ 16:29:49.492 T:1942900752 DEBUG: Alloc resources: 0.01ms (0.01 ms skin load) 16:33:46.961 T:1942897552 DEBUG: CAnnouncementManager - Announcement: OnScreensaverDeactivated from xbmc 16:33:46.961 T:1942897552 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverDeactivated 16:33:46.968 T:1942900752 DEBUG: ------ Window Init (Pointer.xml) ------ 16:33:47.046 T:1838150544 DEBUG: Thread JobWorker start, auto delete: true 16:33:47.054 T:1838150544 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x6ea3fae8 16:33:47.056 T:1838150544 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 16:33:47.061 T:1838150544 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x5df56a00 16:33:47.063 T:1838150544 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 16:33:47.071 T:1838150544 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x6ea3fae8 16:33:47.073 T:1838150544 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x5df56a00 16:33:47.074 T:1838150544 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/a/ac0b4100.jpg 404x227 16:33:47.095 T:1838150544 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x6ea3efd8 16:33:47.097 T:1838150544 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 16:33:47.102 T:1838150544 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x5df56a00 16:33:47.103 T:1838150544 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 16:33:47.112 T:1838150544 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x6ea3efd8 16:33:47.114 T:1838150544 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x5df56a00 16:33:47.115 T:1838150544 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/2/23929db4.jpg 404x227 16:33:47.976 T:1942900752 DEBUG: ------ Window Deinit () ------ 16:33:48.211 T:1942900752 DEBUG: ProcessMouse: unknown mouse command 57608 16:33:48.211 T:1942900752 DEBUG: ProcessMouse: unknown mouse command 57607 16:33:48.217 T:1942900752 DEBUG: Previous line repeats 1 times. 16:33:48.217 T:1942900752 DEBUG: ------ Window Deinit (Pointer.xml) ------ 16:33:48.261 T:1942900752 DEBUG: ProcessMouse: unknown mouse command 57609 16:33:48.985 T:1942900752 DEBUG: ------ Window Init (Pointer.xml) ------ 16:33:49.644 T:1942900752 DEBUG: ProcessMouse: trying mouse action rightclick 16:33:49.645 T:1942900752 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 16:33:49.968 T:1942900752 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 16:33:49.969 T:1942900752 DEBUG: FreeVisualisation() done 16:33:49.977 T:1942900752 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 16:33:49.977 T:1942900752 DEBUG: ------ Window Init (Home.xml) ------ 16:33:49.978 T:1942900752 DEBUG: CDirectoryProvider[addons://]: refreshing.. 16:33:49.978 T:1942900752 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 16:33:49.979 T:1942900752 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 16:33:49.979 T:1802498960 DEBUG: Thread JobWorker start, auto delete: true 16:33:49.979 T:1942900752 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing.. 16:33:49.979 T:1942900752 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 16:33:49.979 T:1942900752 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 16:33:49.980 T:1810887568 DEBUG: Thread JobWorker start, auto delete: true 16:33:49.983 T:1942900752 DEBUG: Window Home.xml was already loaded 16:33:49.983 T:1942900752 DEBUG: Alloc resources: 5.10ms 16:33:50.035 T:1838150544 DEBUG: CAddonMgr::GetAvailableUpdates took 56 ms 16:33:50.897 T:1802498960 DEBUG: GetImageHash - unable to stat url /storage/.kodi/addons/plugin.video.skygo.de/fanart.jpg 16:33:57.646 T:1942900752 DEBUG: Previous line repeats 1 times. 16:33:57.646 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:33:57.647 T:1942900752 DEBUG: Activating window ID: 10040 16:33:57.991 T:1942900752 DEBUG: ------ Window Deinit (Home.xml) ------ 16:33:57.991 T:1942900752 DEBUG: FreeVisualisation() done 16:33:58.068 T:1942900752 DEBUG: ------ Window Init (AddonBrowser.xml) ------ 16:33:58.068 T:1942900752 INFO: Loading skin file: AddonBrowser.xml, load type: KEEP_IN_MEMORY 16:33:58.226 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/AddonBrowser.xml loaded in 157.53ms 16:33:58.226 T:1942900752 DEBUG: CDirectoryProvider[]: refreshing.. 16:33:58.226 T:1802498960 ERROR: GetDirectory - Error getting 16:33:58.227 T:1942900752 DEBUG: CDirectoryProvider[]: refreshing.. 16:33:58.227 T:1810887568 DEBUG: Previous line repeats 1 times. 16:33:58.227 T:1810887568 ERROR: GetDirectory - Error getting 16:33:58.229 T:1942900752 ERROR: Previous line repeats 1 times. 16:33:58.229 T:1942900752 DEBUG: Alloc resources: 161.13ms (157.79 ms skin load) 16:33:58.229 T:1942900752 DEBUG: CGUIMediaWindow::GetDirectory (addons://user/) 16:33:58.230 T:1942900752 DEBUG: ParentPath = [addons://user/] 16:33:58.280 T:1942900752 DEBUG: [Warning] CGUITextureManager::GetTexturePath: could not find texture 'DefaultAddonImageDecoder.png' 16:33:58.294 T:1559040912 DEBUG: Thread BackgroundLoader start, auto delete: false 16:33:58.298 T:1559040912 DEBUG: Thread BackgroundLoader 1559040912 terminating 16:34:02.744 T:1942900752 DEBUG: ProcessMouse: trying mouse action wheeldown 16:34:06.994 T:1942900752 DEBUG: Previous line repeats 2 times. 16:34:06.994 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:34:06.997 T:1942900752 DEBUG: CGUIMediaWindow::GetDirectory (addons://user/kodi.inputstream) 16:34:06.997 T:1942900752 DEBUG: ParentPath = [addons://user/] 16:34:07.126 T:1838150544 DEBUG: CAddonMgr::GetAvailableUpdates took 58 ms 16:34:07.139 T:1559040912 DEBUG: Thread BackgroundLoader start, auto delete: false 16:34:07.144 T:1559040912 DEBUG: Thread BackgroundLoader 1559040912 terminating 16:34:07.145 T:1802498960 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.adaptive/icon.png 16:34:07.146 T:1802498960 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.rtmp/icon.png 16:34:07.964 T:1838150544 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.rtmp/fanart.jpg 16:34:07.967 T:1802498960 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.rtmp/icon.png 16:34:08.081 T:1810887568 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.adaptive/fanart.jpg 16:34:08.082 T:1838150544 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.adaptive/icon.png 16:34:08.764 T:1838150544 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.adaptive/fanart.jpg 16:34:08.765 T:1810887568 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.adaptive/icon.png 16:34:10.778 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:34:10.779 T:1942900752 DEBUG: ------ Window Init (DialogAddonInfo.xml) ------ 16:34:10.779 T:1942900752 INFO: Loading skin file: DialogAddonInfo.xml, load type: KEEP_IN_MEMORY 16:34:10.839 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/DialogAddonInfo.xml loaded in 59.47ms 16:34:10.842 T:1942900752 DEBUG: Alloc resources: 62.99ms (59.82 ms skin load) 16:34:10.844 T:1942900752 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:34:10.844 T:1942900752 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:34:10.861 T:1802498960 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.adaptive/icon.png 16:34:13.678 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:34:14.344 T:1942900752 DEBUG: Previous line repeats 1 times. 16:34:14.345 T:1942900752 DEBUG: ------ Window Init (DialogSelect.xml) ------ 16:34:14.345 T:1942900752 INFO: Loading skin file: DialogSelect.xml, load type: KEEP_IN_MEMORY 16:34:14.372 T:1942900752 DEBUG: Skin file /usr/share/kodi/addons/skin.estuary/xml/DialogSelect.xml loaded in 26.83ms 16:34:14.372 T:1942900752 DEBUG: Alloc resources: 27.48ms (27.23 ms skin load) 16:34:17.694 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:34:17.962 T:1942900752 DEBUG: ------ Window Deinit (DialogSelect.xml) ------ 16:34:18.119 T:1942900752 DEBUG: CAddonInstaller: installing 'inputstream.adaptive' version '2.0.18.0' from repository 'repository.libreelec.tv' 16:34:18.132 T:1838150544 DEBUG: CAddonInstallJob[inputstream.adaptive]: requires kodi.binary.global.filesystem version 1.0.1 which is not available 16:34:18.132 T:1838150544 ERROR: CAddonInstallJob[inputstream.adaptive]: Die Abhängigkeit auf kodi.binary.global.filesystem in Version 1.0.1 konnte nicht aufgelöst werden. 16:34:18.145 T:1942900752 DEBUG: ------ Window Init (DialogNotification.xml) ------ 16:34:18.146 T:1942900752 DEBUG: Window DialogNotification.xml was already loaded 16:34:18.146 T:1942900752 DEBUG: Alloc resources: 0.01ms 16:34:18.151 T:1838150544 INFO: easy_acquire - Created session to http://addons.libreelec.tv 16:34:18.204 T:1942900752 DEBUG: CGUIMediaWindow::GetDirectory (addons://user/kodi.inputstream) 16:34:18.204 T:1942900752 DEBUG: ParentPath = [addons://user/kodi.inputstream] 16:34:18.278 T:1838150544 DEBUG: GetImageHash - unable to stat url http://addons.libreelec.tv/9.0/RPi2/arm/inputstream.adaptive/icon.png 16:34:18.309 T:1802498960 DEBUG: CAddonMgr::GetAvailableUpdates took 49 ms 16:34:18.321 T:1559040912 DEBUG: Thread BackgroundLoader start, auto delete: false 16:34:18.326 T:1559040912 DEBUG: Thread BackgroundLoader 1559040912 terminating 16:34:18.326 T:1838150544 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.adaptive/icon.png 16:34:18.327 T:1838150544 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.rtmp/icon.png 16:34:18.385 T:1942900752 DEBUG: ------ Window Deinit (DialogAddonInfo.xml) ------ 16:34:23.902 T:1942900752 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 16:34:23.915 T:1942900752 DEBUG: ------ Window Deinit (Pointer.xml) ------ 16:34:24.769 T:1942900752 DEBUG: ------ Window Init (Pointer.xml) ------ 16:34:25.864 T:1802498960 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.adaptive/fanart.jpg 16:34:25.866 T:1838150544 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.adaptive/icon.png 16:34:26.298 T:1810887568 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.rtmp/fanart.jpg 16:34:26.299 T:1838150544 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.rtmp/icon.png 16:34:26.844 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:34:26.846 T:1942900752 DEBUG: ------ Window Init (DialogAddonInfo.xml) ------ 16:34:26.851 T:1942900752 DEBUG: Window DialogAddonInfo.xml was already loaded 16:34:26.851 T:1942900752 DEBUG: Alloc resources: 4.53ms 16:34:26.871 T:1810887568 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.rtmp/icon.png 16:34:28.511 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:34:28.527 T:1942900752 DEBUG: ------ Window Init (DialogSelect.xml) ------ 16:34:28.528 T:1942900752 DEBUG: Window DialogSelect.xml was already loaded 16:34:28.528 T:1942900752 DEBUG: Alloc resources: 0.56ms 16:34:29.978 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:34:30.061 T:1942900752 DEBUG: ProcessMouse: trying mouse action doubleclick 16:34:30.061 T:1942900752 WARNING: CGUIWindowManager - HandleAction - ignoring action 103, because topmost modal dialog closing animation is running 16:34:30.266 T:1942900752 DEBUG: ------ Window Deinit (DialogSelect.xml) ------ 16:34:30.388 T:1942900752 DEBUG: CAddonInstaller: installing 'inputstream.rtmp' version '2.0.1.0' from repository 'repository.libreelec.tv' 16:34:30.400 T:1838150544 DEBUG: CAddonInstallJob[inputstream.rtmp]: requires kodi.binary.global.main version 1.0.11 which is not available 16:34:30.401 T:1838150544 ERROR: CAddonInstallJob[inputstream.rtmp]: Die Abhängigkeit auf kodi.binary.global.main in Version 1.0.11 konnte nicht aufgelöst werden. 16:34:30.414 T:1942900752 DEBUG: ------ Window Init (DialogNotification.xml) ------ 16:34:30.415 T:1942900752 DEBUG: Window DialogNotification.xml was already loaded 16:34:30.415 T:1942900752 DEBUG: Alloc resources: 0.01ms 16:34:30.468 T:1942900752 DEBUG: CGUIMediaWindow::GetDirectory (addons://user/kodi.inputstream) 16:34:30.468 T:1942900752 DEBUG: ParentPath = [addons://user/kodi.inputstream] 16:34:30.482 T:1838150544 DEBUG: GetImageHash - unable to stat url http://addons.libreelec.tv/9.0/RPi2/arm/inputstream.rtmp/icon.png 16:34:30.571 T:1802498960 DEBUG: CAddonMgr::GetAvailableUpdates took 48 ms 16:34:30.583 T:1559040912 DEBUG: Thread BackgroundLoader start, auto delete: false 16:34:30.583 T:1942900752 WARNING: CGUIWindowManager - HandleAction - ignoring action 107, because topmost modal dialog closing animation is running 16:34:30.587 T:1810887568 WARNING: Previous line repeats 3 times. 16:34:30.588 T:1810887568 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.adaptive/icon.png 16:34:30.589 T:1559040912 DEBUG: Thread BackgroundLoader 1559040912 terminating 16:34:30.590 T:1810887568 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.rtmp/icon.png 16:34:30.619 T:1942900752 WARNING: CGUIWindowManager - HandleAction - ignoring action 107, because topmost modal dialog closing animation is running 16:34:30.643 T:1942900752 WARNING: Previous line repeats 5 times. 16:34:30.644 T:1942900752 DEBUG: ------ Window Deinit (DialogAddonInfo.xml) ------ 16:34:30.913 T:1802498960 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.adaptive/fanart.jpg 16:34:30.916 T:1838150544 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.adaptive/icon.png 16:34:35.366 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:34:35.448 T:1942900752 DEBUG: ------ Window Init (DialogAddonInfo.xml) ------ 16:34:35.449 T:1942900752 DEBUG: Window DialogAddonInfo.xml was already loaded 16:34:35.450 T:1942900752 DEBUG: Alloc resources: 1.30ms 16:34:35.451 T:1942900752 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:34:35.451 T:1942900752 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:34:35.462 T:1838150544 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.adaptive/icon.png 16:34:36.158 T:1942900752 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 16:34:36.411 T:1942900752 DEBUG: ProcessMouse: trying mouse action rightclick 16:34:36.511 T:1942900752 WARNING: CGUIWindowManager - HandleAction - ignoring action 107, because topmost modal dialog closing animation is running 16:34:36.728 T:1942900752 WARNING: Previous line repeats 7 times. 16:34:36.728 T:1942900752 DEBUG: ------ Window Deinit (DialogAddonInfo.xml) ------ 16:34:38.247 T:1802498960 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.rtmp/fanart.jpg 16:34:38.249 T:1810887568 DEBUG: GetImageHash - unable to stat url /usr/share/kodi/addons/inputstream.rtmp/icon.png 16:34:47.780 T:1942900752 DEBUG: ------ Window Deinit (Pointer.xml) ------ 16:34:55.842 T:1942900752 DEBUG: ------ Window Init (Pointer.xml) ------ 16:34:56.845 T:1942900752 DEBUG: ProcessMouse: trying mouse action rightclick 16:34:56.845 T:1942900752 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 16:34:57.156 T:1942900752 DEBUG: ------ Window Deinit (AddonBrowser.xml) ------ 16:34:57.156 T:1942900752 DEBUG: FreeVisualisation() done 16:34:57.161 T:1942900752 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 16:34:57.161 T:1942900752 DEBUG: ------ Window Init (Home.xml) ------ 16:34:57.164 T:1942900752 DEBUG: Window Home.xml was already loaded 16:34:57.164 T:1942900752 DEBUG: Alloc resources: 2.98ms 16:34:57.897 T:1838150544 DEBUG: GetImageHash - unable to stat url /storage/.kodi/addons/plugin.video.skygo.de/fanart.jpg 16:34:58.461 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:34:58.462 T:1942900752 DEBUG: Activating window ID: 10025 16:34:58.790 T:1942900752 DEBUG: ------ Window Deinit (Home.xml) ------ 16:34:58.790 T:1942900752 DEBUG: FreeVisualisation() done 16:34:58.792 T:1942900752 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 16:34:58.794 T:1942900752 DEBUG: Window MyVideoNav.xml was already loaded 16:34:58.794 T:1942900752 DEBUG: Alloc resources: 2.33ms 16:34:58.796 T:1942900752 ERROR: Control 55 in window 10025 has been asked to focus, but it can't 16:34:58.812 T:1942900752 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listLiveTvChannels&channeldir_name=sport) 16:34:58.812 T:1942900752 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/?action=listLiveTvChannels&channeldir_name=sport] 16:34:58.815 T:1942900752 DEBUG: Loading items: 3, directory: plugin://plugin.video.skygo.de/?action=listLiveTvChannels&channeldir_name=sport sort method: 0, ascending: false 16:34:58.975 T:1838150544 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 162 ms 16:34:58.991 T:1559040912 DEBUG: Thread BackgroundLoader start, auto delete: false 16:34:59.012 T:1838150544 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x6ea13140 16:34:59.013 T:1838150544 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 16:34:59.018 T:1838150544 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x6ea4e910 16:34:59.019 T:1838150544 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 16:34:59.027 T:1838150544 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x6ea13140 16:34:59.028 T:1559040912 DEBUG: Thread BackgroundLoader 1559040912 terminating 16:34:59.029 T:1838150544 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x6ea4e910 16:34:59.029 T:1838150544 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/2/23929db4.jpg 404x227 16:35:00.435 T:1810887568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x5db87da8 16:35:00.437 T:1810887568 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 16:35:00.441 T:1810887568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x5db1ee70 16:35:00.442 T:1810887568 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 16:35:00.450 T:1810887568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x5db87da8 16:35:00.451 T:1810887568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x5db1ee70 16:35:00.452 T:1810887568 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/a/ac0b4100.jpg 404x227 16:35:00.578 T:1942900752 INFO: CheckIdle - Closing session to http://addons.libreelec.tv (easy=0x5de6e598, multi=(nil)) 16:35:00.788 T:1802498960 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x7154bd80 16:35:00.789 T:1802498960 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16) 16:35:00.796 T:1802498960 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x7155e998 16:35:00.797 T:1802498960 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16) 16:35:00.811 T:1802498960 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x7154bd80 16:35:00.813 T:1802498960 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x7155e998 16:35:00.814 T:1802498960 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/5/586953e8.jpg 404x227 16:35:01.695 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:35:01.735 T:1942900752 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242824_242825%2Fsport-at.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Eishockey%3A+%5Cxd6sterreich+EBEL+EC+Klagenfurter+AC+-+EC+Liwest+Black+Wings+Linz%2C+7.+Runde%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+Austria+HD+%7C+%5B%2FCOLOR%5DEishockey%3A+%5Cxd6sterreich+EBEL+EC+Klagenfurter+AC+-+EC+Liwest+Black+Wings+Linz%2C+7.+Runde%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+0%2C+%27genre%27%3A+%27%27%7D 16:35:01.736 T:1942897552 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 16:35:01.736 T:1942897552 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 16:35:01.748 T:1942900752 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','6','?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242824_242825%2Fsport-at.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Eishockey%3A+%5Cxd6sterreich+EBEL+EC+Klagenfurter+AC+-+EC+Liwest+Black+Wings+Linz%2C+7.+Runde%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+Austria+HD+%7C+%5B%2FCOLOR%5DEishockey%3A+%5Cxd6sterreich+EBEL+EC+Klagenfurter+AC+-+EC+Liwest+Black+Wings+Linz%2C+7.+Runde%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+0%2C+%27genre%27%3A+%27%27%7D','resume:false') 16:35:01.748 T:1559040912 DEBUG: Thread LanguageInvoker start, auto delete: false 16:35:01.749 T:1559040912 INFO: initializing python engine. 16:35:01.749 T:1559040912 DEBUG: CPythonInvoker(7, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing 16:35:01.769 T:1550652304 DEBUG: Thread scriptobs start, auto delete: false 16:35:01.770 T:1942897552 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 16:35:01.771 T:1942897552 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 16:35:01.804 T:1559040912 DEBUG: -->Python Interpreter Initialized<-- 16:35:01.804 T:1559040912 DEBUG: CPythonInvoker(7, /storage/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo.de/default.py" 16:35:01.805 T:1559040912 DEBUG: CPythonInvoker(7, /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.cryptopy/lib:/storage/.kodi/addons/script.module.pydes/lib:/storage/.kodi/addons/script.module.requests/lib:/storage/.kodi/addons/script.module.routing/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 16:35:01.806 T:1559040912 DEBUG: CPythonInvoker(7, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de 16:35:01.806 T:1559040912 DEBUG: CPythonInvoker(7, /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 16:35:01.969 T:1942900752 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:35:01.969 T:1942900752 DEBUG: Window DialogBusy.xml was already loaded 16:35:01.969 T:1942900752 DEBUG: Alloc resources: 0.08ms 16:35:02.678 T:1559040912 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting definitions 16:35:02.679 T:1559040912 DEBUG: CAddonSettings[plugin.video.skygo.de]: trying to load setting definitions from old format... 16:35:02.681 T:1559040912 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting values 16:35:02.682 T:1559040912 DEBUG: false 16:35:02.903 T:1559040912 DEBUG: CAddonSettings[script.common.plugin.cache]: loading setting definitions 16:35:02.903 T:1559040912 DEBUG: CAddonSettings[script.common.plugin.cache]: trying to load setting definitions from old format... 16:35:02.908 T:1559040912 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting definitions 16:35:02.908 T:1559040912 DEBUG: CAddonSettings[plugin.video.skygo.de]: trying to load setting definitions from old format... 16:35:02.911 T:1559040912 DEBUG: CAddonSettings[plugin.video.skygo.de]: loading setting values 16:35:02.964 T:1559040912 DEBUG: {'action': 'playLive', 'manifest_url': 'http://livemss1it-s.akamaihd.net/live/242824_242825/sport-at.isml/Manifest', 'parental_rating': '0', 'infolabels': "{'plot': u'Eishockey: \\xd6sterreich EBEL EC Klagenfurter AC - EC Liwest Black Wings Linz, 7. Runde', 'title': u'[COLOR blue]Sky Sport Austria HD | [/COLOR]Eishockey: \\xd6sterreich EBEL EC Klagenfurter AC - EC Liwest Black Wings Linz, 7. Runde', 'originaltitle': '', 'cast': [], 'duration': 0, 'genre': ''}", 'package_code': 'OSPS'} 16:35:03.294 T:1559040912 DEBUG: {u'resultCode': u'S_218', u'resultMessage': u'KO'} 16:35:03.294 T:1559040912 DEBUG: User not logged in or Session on other device 16:35:03.294 T:1559040912 DEBUG: Session invalid - Customer Code not found in SilkCache 16:35:03.507 T:1559040912 DEBUG: {u'gender': u'NA', u'tcFlag': u'Y', u'mktgFlag': u'N', u'firstName': u'HERBERT', u'country': u'AT', u'age': u'71', u'extraCustFlag': u'N', u'resultMessage': u'OK', u'flagMPPinSet': u'N', u'privacyFlag': u'Y', u'resultCode': u'T_100', u'customerCode': u'7249848334', u'flagTEF': u'N', u'cableSubFlag': u'Y', u'skygoSessionId': u'SG-811d2f3f-77b9-48ce-b093-eefe0b0ae21f', u'lastName': u'KRISCH', u'entitlements': [u'OOHD', u'OOSP', u'OSPS'], u'bookmarkFlag': u'Y', u'accountCreated': u'2016/04/06', u'presentation': u'KEINE ANGABE', u'email': u'max.krisch@gmail.com'} 16:35:03.569 T:1559040912 DEBUG: {u'tcFlag': u'Y', u'flagMPPinSet': u'N', u'email': u'max.krisch@gmail.com', u'customerCode': u'7249848334', u'resultCode': u'S_100', u'privacyFlag': u'Y', u'extraCustFlag': u'N', u'bookmarkFlag': u'Y', u'skygoSessionId': u'SG-811d2f3f-77b9-48ce-b093-eefe0b0ae21f', u'entitlements': [u'OOHD', u'OOSP', u'OSPS'], u'presentation': u'KEINE ANGABE', u'cableSubFlag': u'Y', u'flagTEF': u'N', u'doubleOptInFlag': u'Y', u'mktgFlag': u'N', u'firstName': u'HERBERT', u'gender': u'NA', u'age': u'71', u'lastName': u'KRISCH', u'resultMessage': u'OK', u'accountCreated': u'2016/04/06', u'country': u'AT'} 16:35:03.569 T:1559040912 DEBUG: User still logged in 16:35:03.616 T:1559040912 INFO: CPythonInvoker(7, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 16:35:03.627 T:1550652304 DEBUG: Thread scriptobs 1550652304 terminating 16:35:03.627 T:1942900752 INFO: easy_acquire - Created session to http://livemss1it-s.akamaihd.net 16:35:03.797 T:1559040912 INFO: Python script stopped 16:35:03.798 T:1559040912 DEBUG: Thread LanguageInvoker 1559040912 terminating 16:35:03.873 T:1942900752 DEBUG: CCurlFile::GetMimeType - http://livemss1it-s.akamaihd.net/live/242824_242825/sport-at.isml/Manifest -> text/xml 16:35:03.900 T:1942900752 DEBUG: Loading settings for http://livemss1it-s.akamaihd.net/live/242824_242825/sport-at.isml/Manifest 16:35:03.924 T:1942900752 DEBUG: CPlayerCoreFactory::GetPlayers(http://livemss1it-s.akamaihd.net/live/242824_242825/sport-at.isml/Manifest) 16:35:03.924 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 16:35:03.924 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 16:35:03.924 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 16:35:03.925 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 16:35:03.925 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 16:35:03.925 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 16:35:03.925 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 16:35:03.925 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams 16:35:03.925 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp 16:35:03.925 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2 16:35:03.926 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 16:35:03.926 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 16:35:03.926 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 16:35:03.926 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 16:35:03.926 T:1942900752 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 16:35:03.926 T:1942900752 DEBUG: CPlayerCoreFactory::GetPlayers: matched {0} rules with players 16:35:03.926 T:1942900752 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 16:35:03.927 T:1942900752 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 16:35:03.927 T:1942900752 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 16:35:03.927 T:1942900752 DEBUG: CPlayerCoreFactory::GetPlayers: added {0} players 16:35:03.927 T:1942900752 NOTICE: VideoPlayer::OpenFile: http://livemss1it-s.akamaihd.net/live/242824_242825/sport-at.isml/Manifest 16:35:03.927 T:1942900752 DEBUG: OnPlayBackStarted: CApplication::OnPlayBackStarted 16:35:03.938 T:1942900752 DEBUG: CCurlFile::GetMimeType - http://livemss1it-s.akamaihd.net/live/242824_242825/sport-at.isml/Manifest -> text/xml 16:35:03.939 T:1559040912 DEBUG: Thread VideoPlayer start, auto delete: false 16:35:03.939 T:1550652304 DEBUG: Thread BackgroundLoader start, auto delete: false 16:35:03.940 T:1559040912 NOTICE: Creating InputStream 16:35:03.941 T:1559040912 DEBUG: ADDON: Dll Initializing - InputStream Adaptive 16:35:03.942 T:1559040912 DEBUG: SECTION:LoadDLL(/usr/lib/kodi/addons/inputstream.adaptive/inputstream.adaptive.so.2.1.4) 16:35:03.942 T:1559040912 DEBUG: Loading: /usr/lib/kodi/addons/inputstream.adaptive/inputstream.adaptive.so.2.1.4 16:35:03.967 T:1810887568 DEBUG: CGUIInfoManager::SetCurrentMovie(http://livemss1it-s.akamaihd.net/live/242824_242825/sport-at.isml/Manifest) 16:35:04.004 T:1550652304 DEBUG: Thread BackgroundLoader 1550652304 terminating 16:35:04.011 T:1942897552 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 16:35:04.012 T:1942897552 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 16:35:04.012 T:1942897552 DEBUG: CAnnouncementManager - Announcement: OnChanged from xbmc 16:35:04.012 T:1942897552 DEBUG: GOT ANNOUNCEMENT, type: 1024, from xbmc, message OnChanged 16:35:04.110 T:1942900752 NOTICE: m_playbackStarting 16:35:04.110 T:1942900752 NOTICE: StereoscopicsManager::IsPlaying 16:35:04.111 T:1559040912 INFO: AddOnLog: InputStream Adaptive: SetVideoResolution (1920 x 1080) 16:35:04.111 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: Open() 16:35:04.111 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_data: [not shown] 16:35:04.111 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_key: [not shown] 16:35:04.111 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_type: com.widevine.alpha 16:35:04.111 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.manifest_type: ism 16:35:04.113 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: Initial bandwidth: 4000000 16:35:04.114 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:35:04.114 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:35:04.116 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: MAXRESOLUTION selected: 0 16:35:04.117 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:35:04.117 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:35:04.118 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: MAXRESOLUTIONSECURE selected: 2 16:35:04.120 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:35:04.120 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:35:04.121 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: STREAMSELECTION selected: 0 16:35:04.122 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:35:04.123 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:35:04.126 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:35:04.126 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:35:04.128 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: Searching for decrypters in: /usr/lib/kodi/addons/inputstream.adaptive/ 16:35:04.141 T:1942900752 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:35:04.277 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: Found decrypter: /usr/lib/kodi/addons/inputstream.adaptive/libssd_wv.so 16:35:04.278 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: Supported URN: urn:uuid:EDEF8BA9-79D6-4ACE-A3C8-27DCD51D21ED 16:35:04.279 T:1559040912 DEBUG: CurlFile::Open(0x5f028fd8) http://livemss1it-s.akamaihd.net/live/242824_242825/sport-at.isml/Manifest 16:35:04.445 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242824_242825/sport-at.isml/Manifest finished 16:35:04.446 T:1559040912 INFO: AddOnLog: InputStream Adaptive: Successfully parsed .mpd file. #Streams: 2 Download speed: 0.0000 Bytes/s 16:35:04.448 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:35:04.448 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:35:04.450 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 16:35:04.450 T:1559040912 DEBUG: CAddonSettings[inputstream.adaptive]: trying to load setting definitions from old format... 16:35:04.451 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: Entering encryption section 16:35:04.453 T:1559040912 ERROR: AddOnLog: InputStream Adaptive: Unable to load widevine shared library (/storage/.kodi/cdm/libwidevinecdm.so) 16:35:04.454 T:1559040912 ERROR: AddOnLog: InputStream Adaptive: OpenDRMSystem failed 16:35:04.454 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: Session::~Session() 16:35:04.456 T:1559040912 ERROR: CVideoPlayer::OpenInputStream - error opening [http://livemss1it-s.akamaihd.net/live/242824_242825/sport-at.isml/Manifest] 16:35:04.457 T:1559040912 NOTICE: CVideoPlayer::OnExit() 16:35:04.457 T:1559040912 DEBUG: AddOnLog: InputStream Adaptive: Close() 16:35:04.457 T:1559040912 DEBUG: SECTION:UnloadDll(/usr/lib/kodi/addons/inputstream.adaptive/inputstream.adaptive.so.2.1.4) 16:35:04.458 T:1559040912 INFO: ADDON: Dll Destroyed - InputStream Adaptive 16:35:04.458 T:1559040912 DEBUG: Thread VideoPlayer 1559040912 terminating 16:35:04.461 T:1942900752 DEBUG: ------ Window Init (DialogConfirm.xml) ------ 16:35:04.462 T:1942900752 DEBUG: Window DialogConfirm.xml was already loaded 16:35:04.462 T:1942900752 DEBUG: Alloc resources: 0.40ms 16:35:04.495 T:1942900752 NOTICE: m_playbackStarting 16:35:07.528 T:1942900752 NOTICE: Previous line repeats 5 times. 16:35:07.528 T:1942900752 DEBUG: ProcessMouse: trying mouse action leftclick 16:35:07.528 T:1942900752 NOTICE: m_playbackStarting 16:35:07.775 T:1942900752 NOTICE: Previous line repeats 1 times. 16:35:07.776 T:1942900752 DEBUG: ------ Window Deinit (DialogConfirm.xml) ------ 16:35:07.794 T:1838150544 DEBUG: OnPlayBackStopped: CApplication::OnPlayBackStopped 16:35:07.813 T:1942897552 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 16:35:07.813 T:1942897552 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 16:35:07.828 T:1942900752 NOTICE: m_playbackStarting 16:35:08.195 T:1810887568 DEBUG: DoWork - Saving file state for video item plugin://plugin.video.skygo.de/?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242824_242825%2Fsport-at.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Eishockey%3A+%5Cxd6sterreich+EBEL+EC+Klagenfurter+AC+-+EC+Liwest+Black+Wings+Linz%2C+7.+Runde%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+Austria+HD+%7C+%5B%2FCOLOR%5DEishockey%3A+%5Cxd6sterreich+EBEL+EC+Klagenfurter+AC+-+EC+Liwest+Black+Wings+Linz%2C+7.+Runde%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+0%2C+%27genre%27%3A+%27%27%7D 16:35:15.768 T:1942900752 DEBUG: ------ Window Deinit (Pointer.xml) ------ 16:35:34.478 T:1942900752 INFO: CheckIdle - Closing session to http://livemss1it-s.akamaihd.net (easy=0x2ad2820, multi=0x5ec26af8) 16:35:38.195 T:1838150544 DEBUG: Thread JobWorker 1838150544 terminating (autodelete) 16:35:38.195 T:1802498960 DEBUG: Thread JobWorker 1802498960 terminating (autodelete) 16:35:38.329 T:1810887568 DEBUG: Thread JobWorker 1810887568 terminating (autodelete) 16:38:10.881 T:1942897552 DEBUG: CAnnouncementManager - Announcement: OnScreensaverActivated from xbmc 16:38:10.881 T:1942897552 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverActivated 16:38:10.893 T:1942900752 DEBUG: CAddonSettings[screensaver.xbmc.builtin.dim]: loading setting definitions 16:38:10.894 T:1942900752 DEBUG: CAddonSettings[screensaver.xbmc.builtin.dim]: trying to load setting definitions from old format... 16:38:10.895 T:1942900752 DEBUG: ------ Window Init () ------ 16:38:10.895 T:1942900752 DEBUG: Alloc resources: 0.01ms (0.01 ms skin load)