06:31:17 9.048134 T:1961185280 NOTICE: special://profile/ is mapped to: special://masterprofile/
06:31:17 9.048512 T:1961185280 NOTICE: -----------------------------------------------------------------------
06:31:17 9.048663 T:1961185280 NOTICE: Starting Kodi (17.0-BETA3 Git:7041777). Platform: Linux ARM 32-bit
06:31:17 9.048774 T:1961185280 NOTICE: Using Release Kodi x32 build (version for Raspberry Pi)
06:31:17 9.048894 T:1961185280 NOTICE: Kodi compiled Oct 10 2016 by GCC 5.4.0 for Linux ARM 32-bit version 4.7.6 (263942)
06:31:17 9.049520 T:1961185280 NOTICE: Running on LibreELEC (community) - Version: 7.90.007 8.0, kernel: Linux ARM 32-bit version 4.7.6
06:31:17 9.049850 T:1961185280 NOTICE: FFmpeg version/source: ffmpeg-3.1-kodi
06:31:17 9.049965 T:1961185280 NOTICE: Host CPU: ARMv7 Processor rev 5 (v7l), 4 cores available
06:31:17 9.050149 T:1961185280 NOTICE: ARM Features: Neon enabled
06:31:17 9.050257 T:1961185280 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi/
06:31:17 9.050381 T:1961185280 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi
06:31:17 9.050483 T:1961185280 NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons
06:31:17 9.050581 T:1961185280 NOTICE: special://masterprofile/ is mapped to: /storage/.kodi/userdata
06:31:17 9.050677 T:1961185280 NOTICE: special://envhome/ is mapped to: /storage
06:31:17 9.050770 T:1961185280 NOTICE: special://home/ is mapped to: /storage/.kodi
06:31:17 9.050864 T:1961185280 NOTICE: special://temp/ is mapped to: /storage/.kodi/temp
06:31:17 9.050957 T:1961185280 NOTICE: special://logpath/ is mapped to: /storage/.kodi/temp
06:31:17 9.051131 T:1961185280 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin
06:31:17 9.051307 T:1961185280 NOTICE: Local hostname: LibreELEC
06:31:17 9.051501 T:1961185280 NOTICE: Log File is located: /storage/.kodi/temp//kodi.log
06:31:17 9.065107 T:1961185280 NOTICE: -----------------------------------------------------------------------
06:31:17 9.258361 T:1961185280 ERROR: DBus: Error org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files
06:31:17 9.285459 T:1961185280 NOTICE: load settings...
06:31:18 9.616937 T:1961185280 NOTICE: Found 2 Lists of Devices
06:31:18 9.617187 T:1961185280 NOTICE: Enumerated PI devices:
06:31:18 9.617294 T:1961185280 NOTICE: Device 1
06:31:18 9.618171 T:1961185280 NOTICE: m_deviceName : HDMI
06:31:18 9.618318 T:1961185280 NOTICE: m_displayName : HDMI
06:31:18 9.618419 T:1961185280 NOTICE: m_displayNameExtra:
06:31:18 9.618520 T:1961185280 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
06:31:18 9.618614 T:1961185280 NOTICE: m_channels : FL,FR
06:31:18 9.618711 T:1961185280 NOTICE: m_sampleRates : 8000,11025,16000,22050,24000,32000,44100,48000,88200,96000,176400,192000
06:31:18 9.618810 T:1961185280 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
06:31:18 9.618932 T:1961185280 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
06:31:18 9.619071 T:1961185280 NOTICE: Device 2
06:31:18 9.619268 T:1961185280 NOTICE: m_deviceName : Analogue
06:31:18 9.619369 T:1961185280 NOTICE: m_displayName : Analogue
06:31:18 9.619463 T:1961185280 NOTICE: m_displayNameExtra:
06:31:18 9.619557 T:1961185280 NOTICE: m_deviceType : AE_DEVTYPE_PCM
06:31:18 9.619649 T:1961185280 NOTICE: m_channels : FL,FR
06:31:18 9.619740 T:1961185280 NOTICE: m_sampleRates : 48000
06:31:18 9.619836 T:1961185280 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP
06:31:18 9.619925 T:1961185280 NOTICE: m_streamTypes : No passthrough capabilities
06:31:18 9.620194 T:1961185280 NOTICE: Device 3
06:31:18 9.620390 T:1961185280 NOTICE: m_deviceName : Both
06:31:18 9.620499 T:1961185280 NOTICE: m_displayName : HDMI and Analogue
06:31:18 9.620597 T:1961185280 NOTICE: m_displayNameExtra:
06:31:18 9.620689 T:1961185280 NOTICE: m_deviceType : AE_DEVTYPE_PCM
06:31:18 9.620782 T:1961185280 NOTICE: m_channels : FL,FR
06:31:18 9.620872 T:1961185280 NOTICE: m_sampleRates : 48000
06:31:18 9.620970 T:1961185280 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP
06:31:18 9.621061 T:1961185280 NOTICE: m_streamTypes : No passthrough capabilities
06:31:18 9.621156 T:1961185280 NOTICE: Enumerated PULSE devices:
06:31:18 9.621244 T:1961185280 NOTICE: Device 1
06:31:18 9.621442 T:1961185280 NOTICE: m_deviceName : Default
06:31:18 9.621537 T:1961185280 NOTICE: m_displayName : Default
06:31:18 9.621641 T:1961185280 NOTICE: m_displayNameExtra: Bluetooth Audio (PULSEAUDIO)
06:31:18 9.621734 T:1961185280 NOTICE: m_deviceType : AE_DEVTYPE_PCM
06:31:18 9.621825 T:1961185280 NOTICE: m_channels : FL,FR
06:31:18 9.621920 T:1961185280 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000
06:31:18 9.622011 T:1961185280 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT
06:31:18 9.622100 T:1961185280 NOTICE: m_streamTypes : No passthrough capabilities
06:31:18 9.682302 T:1961185280 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml
06:31:18 9.689498 T:1961185280 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are...
false
720
540
30
06:31:18 9.694265 T:1961185280 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml)
06:31:18 9.694487 T:1961185280 NOTICE: Default Video Player: VideoPlayer
06:31:18 9.694601 T:1961185280 NOTICE: Default Audio Player: paplayer
06:31:18 9.694735 T:1961185280 NOTICE: Enabled debug logging due to GUI setting (2)
06:31:18 9.694868 T:1961185280 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM"
06:31:18 9.695446 T:1961185280 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml
06:31:18 9.698070 T:1961185280 DEBUG: CMediaSourceSettings: tag is missing or sources.xml is malformed
06:31:18 9.698468 T:1961185280 DEBUG: CMediaSourceSettings: tag is missing or sources.xml is malformed
06:31:18 9.698821 T:1961185280 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
06:31:18 9.701285 T:1961185280 DEBUG: CPlayerCoreConfig::: created player VideoPlayer
06:31:18 9.701461 T:1961185280 DEBUG: CPlayerCoreConfig::: created player PAPlayer
06:31:18 9.701591 T:1961185280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules
06:31:18 9.701725 T:1961185280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mms/udp
06:31:18 9.701971 T:1961185280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout
06:31:18 9.702109 T:1961185280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp
06:31:18 9.702229 T:1961185280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp
06:31:18 9.702349 T:1961185280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams
06:31:18 9.702459 T:1961185280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp
06:31:18 9.702577 T:1961185280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2
06:31:18 9.702725 T:1961185280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd
06:31:18 9.702861 T:1961185280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage
06:31:18 9.702978 T:1961185280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf
06:31:18 9.703088 T:1961185280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv
06:31:18 9.703207 T:1961185280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio
06:31:18 9.703392 T:1961185280 NOTICE: Loaded playercorefactory configuration
06:31:18 9.704219 T:1961185280 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
06:31:18 9.704708 T:1961185280 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
06:31:18 9.757215 T:1961185280 INFO: creating subdirectories
06:31:18 9.757578 T:1961185280 INFO: userdata folder: special://masterprofile/
06:31:18 9.757736 T:1961185280 INFO: recording folder:
06:31:18 9.757888 T:1961185280 INFO: screenshots folder: /storage/screenshots/
06:31:18 9.899002 T:1961185280 NOTICE: Running database version Addons26
06:31:18 9.900774 T:1961185280 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcpluff-arm.so)
06:31:18 9.901212 T:1961185280 DEBUG: Loading: /usr/lib/kodi/system/libcpluff-arm.so
06:31:18 10.197602 T:1961185280 INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/kodi/addons: No such file or directory'
06:31:18 10.198080 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.'
06:31:18 10.198380 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been installed.'
06:31:18 10.198571 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in resource.images.weathericons.default has been installed.'
06:31:18 10.198717 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in xbmc.audioencoder has been installed.'
06:31:18 10.198868 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.'
06:31:18 10.199024 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.'
06:31:18 10.199171 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in kodi.audiodecoder has been installed.'
06:31:18 10.199325 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.'
06:31:18 10.199468 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in kodi.peripheral has been installed.'
06:31:18 10.199629 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in kodi.guilib has been installed.'
06:31:18 10.199779 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in peripheral.joystick has been installed.'
06:31:18 10.199924 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in kodi.adsp has been installed.'
06:31:18 10.200152 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.wma has been installed.'
06:31:18 10.200334 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in repository.johtru.com has been installed.'
06:31:18 10.200476 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in script.module.pydes has been installed.'
06:31:18 10.200602 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in game.controller.default has been installed.'
06:31:18 10.200743 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in service.libreelec.settings has been installed.'
06:31:18 10.200873 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.'
06:31:18 10.201008 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in kodi.game has been installed.'
06:31:18 10.201237 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.'
06:31:18 10.201399 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.'
06:31:18 10.201544 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in kodi.resource has been installed.'
06:31:18 10.201694 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in script.module.pyxbmct has been installed.'
06:31:18 10.201833 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in script.module.beautifulsoup has been installed.'
06:31:18 10.201966 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.'
06:31:18 10.202092 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.'
06:31:18 10.202216 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in os.openelec.tv has been installed.'
06:31:18 10.202355 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in repository.kodi.game has been installed.'
06:31:18 10.202505 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.'
06:31:18 10.202643 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in inputstream.mpd has been installed.'
06:31:18 10.202776 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in os.libreelec.tv has been installed.'
06:31:18 10.202914 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in script.module.requests has been installed.'
06:31:18 10.203048 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in inputstream.smoothstream has been installed.'
06:31:18 10.203178 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in kodi.inputstream has been installed.'
06:31:18 10.203307 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in repository.sandmann79.plugins has been installed.'
06:31:18 10.203542 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in repository.libreelec.tv has been installed.'
06:31:18 10.203689 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been installed.'
06:31:18 10.203836 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.aac has been installed.'
06:31:18 10.204008 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been installed.'
06:31:18 10.204148 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in script.module.routing has been installed.'
06:31:18 10.204285 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.'
06:31:18 10.204419 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in resource.language.en_gb has been installed.'
06:31:18 10.204554 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.'
06:31:18 10.204689 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.'
06:31:18 10.204823 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been installed.'
06:31:18 10.204953 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.skygo.de has been installed.'
06:31:18 10.205098 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in metadata.local has been installed.'
06:31:18 10.205237 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in xbmc.webinterface has been installed.'
06:31:18 10.205370 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in resource.uisounds.confluence has been installed.'
06:31:18 10.205495 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in script.module.amazon.database has been installed.'
06:31:18 10.205621 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in script.module.mechanize has been installed.'
06:31:18 10.205755 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.'
06:31:18 10.205903 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been installed.'
06:31:18 10.206054 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been installed.'
06:31:18 10.206210 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.'
06:31:18 10.206390 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.'
06:31:18 10.206632 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.'
06:31:18 10.206854 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in xbmc.codec has been installed.'
06:31:18 10.206999 T:1961185280 DEBUG: ADDON: cpluff: 'Plug-in skin.estuary has been installed.'
06:31:18 10.207110 T:1961185280 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.'
06:31:18 10.252069 T:1873802144 DEBUG: Thread JobWorker start, auto delete: true
06:31:18 10.290777 T:1961185280 NOTICE: ADDONS: Using repository repository.kodi.game
06:31:18 10.291006 T:1961185280 NOTICE: ADDONS: Using repository repository.libreelec.tv
06:31:18 10.291113 T:1961185280 NOTICE: ADDONS: Using repository repository.xbmc.org
06:31:18 10.291212 T:1961185280 NOTICE: ADDONS: Using repository repository.sandmann79.plugins
06:31:18 10.291305 T:1961185280 NOTICE: ADDONS: Using repository repository.johtru.com
06:31:18 10.302435 T:1961185280 DEBUG: ADDON: Dll Initializing - InputStream MPEG DASH
06:31:18 10.302891 T:1961185280 DEBUG: SECTION:LoadDLL(/storage/.kodi/addons/inputstream.mpd/inputstream.mpd.so.1.2.17)
06:31:18 10.303118 T:1961185280 DEBUG: Loading: /storage/.kodi/addons/inputstream.mpd/inputstream.mpd.so.1.2.17
06:31:18 10.402521 T:1961185280 DEBUG: AddOnLog: InputStream MPEG DASH: libXBMC_addon successfully loaded
06:31:18 10.403720 T:1961185280 DEBUG: AddOnLog: InputStream MPEG DASH: ADDON_Create()
06:31:18 10.403979 T:1961185280 DEBUG: AddOnLog: InputStream MPEG DASH: ADDON_Destroy()
06:31:18 10.404883 T:1961185280 DEBUG: SECTION:UnloadDll(/storage/.kodi/addons/inputstream.mpd/inputstream.mpd.so.1.2.17)
06:31:18 10.409544 T:1961185280 INFO: ADDON: Dll Destroyed - InputStream MPEG DASH
06:31:18 10.410377 T:1961185280 DEBUG: ADDON: Dll Initializing - InputStream SmoothStreamingMedia
06:31:18 10.410806 T:1961185280 DEBUG: SECTION:LoadDLL(/storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.3)
06:31:18 10.411049 T:1961185280 DEBUG: Loading: /storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.3
06:31:19 10.488628 T:1961185280 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: ADDON_Create()
06:31:19 10.488863 T:1961185280 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: ADDON_Destroy()
06:31:19 10.489729 T:1961185280 DEBUG: SECTION:UnloadDll(/storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.3)
06:31:19 10.490486 T:1961185280 INFO: ADDON: Dll Destroyed - InputStream SmoothStreamingMedia
06:31:19 10.497363 T:1939850144 DEBUG: Thread ActiveAE start, auto delete: false
06:31:19 10.497874 T:1929376672 DEBUG: Thread AESink start, auto delete: false
06:31:19 10.498578 T:1929376672 INFO: CActiveAESink::OpenSink - initialize sink
06:31:19 10.498769 T:1929376672 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI
06:31:19 10.498968 T:1929376672 DEBUG: DllBcm: Using omx system library
06:31:19 10.502640 T:1929376672 DEBUG: SECTION:LoadDLL(libopenmaxil.so)
06:31:19 10.507660 T:1929376672 DEBUG: Loading: libopenmaxil.so
06:31:19 10.515843 T:1857024928 DEBUG: Thread CRBPWorker start, auto delete: false
06:31:19 10.516154 T:1929376672 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008
06:31:19 10.516329 T:1929376672 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI
06:31:19 10.519117 T:1929376672 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x726020d8
06:31:19 10.521396 T:1929376672 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignmen(16)
06:31:19 10.522160 T:1929376672 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized:
06:31:19 10.522267 T:1929376672 DEBUG: Output Device : HDMI
06:31:19 10.522361 T:1929376672 DEBUG: Sample Rate : 44100
06:31:19 10.522522 T:1929376672 DEBUG: Sample Format : AE_FMT_FLOAT
06:31:19 10.522619 T:1929376672 DEBUG: Channel Count : 2
06:31:19 10.522717 T:1929376672 DEBUG: Channel Layout: FL,FR
06:31:19 10.522808 T:1929376672 DEBUG: Frames : 2205
06:31:19 10.522896 T:1929376672 DEBUG: Frame Size : 8
06:31:19 10.535382 T:1848636320 DEBUG: Thread RemoteControl start, auto delete: false
06:31:19 10.535724 T:1848636320 INFO: LIRC Process: using: /run/lirc/lircd
06:31:19 10.536447 T:1848636320 INFO: LIRC Connect: successfully started
06:31:19 10.536627 T:1848636320 DEBUG: Thread RemoteControl 1848636320 terminating
06:31:19 10.555606 T:1961185280 INFO: CKeyboardLayoutManager: loading keyboard layouts from special://xbmc/system/keyboardlayouts...
06:31:19 10.567167 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Arabic QWERTY" successfully loaded
06:31:19 10.570791 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian ЯВЕРТЪ" successfully loaded
06:31:19 10.572166 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian АБВ" successfully loaded
06:31:19 10.575416 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BasePY" successfully loaded
06:31:19 10.576725 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BaiduPY" successfully loaded
06:31:19 10.579633 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Czech QWERTZ" successfully loaded
06:31:19 10.582264 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Danish QWERTY" successfully loaded
06:31:19 10.585846 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "English QWERTY" successfully loaded
06:31:19 10.587307 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "English AZERTY" successfully loaded
06:31:19 10.588588 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "English ABC" successfully loaded
06:31:19 10.591711 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "French AZERTY" successfully loaded
06:31:19 10.594534 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "German QWERTZ" successfully loaded
06:31:19 10.597246 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Greek QWERTY" successfully loaded
06:31:19 10.600369 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew QWERTY" successfully loaded
06:31:19 10.601613 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew ABC" successfully loaded
06:31:19 10.604496 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Hungarian QWERTZ" successfully loaded
06:31:19 10.607241 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Italian QWERTY" successfully loaded
06:31:19 10.609995 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Korean ㄱㄴㄷ" successfully loaded
06:31:19 10.613215 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian AZERTY" successfully loaded
06:31:19 10.614634 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian QWERTY" successfully loaded
06:31:19 10.617363 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Norwegian QWERTY" successfully loaded
06:31:19 10.620180 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Polish QWERTY" successfully loaded
06:31:19 10.623037 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Portuguese (Portugal) QWERTY" successfully loaded
06:31:19 10.625793 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Romanian QWERTY" successfully loaded
06:31:19 10.629053 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian ЙЦУКЕН" successfully loaded
06:31:19 10.630475 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian АБВ" successfully loaded
06:31:19 10.633283 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Silesian QWERTY" successfully loaded
06:31:19 10.637261 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTZ" successfully loaded
06:31:19 10.638905 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTY" successfully loaded
06:31:19 10.640470 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak ABC" successfully loaded
06:31:19 10.643616 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Spanish QWERTY" successfully loaded
06:31:19 10.646245 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Swedish QWERTY" successfully loaded
06:31:19 10.648940 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Turkish QWERTY" successfully loaded
06:31:19 10.652164 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian ЙЦУКЕН" successfully loaded
06:31:19 10.653585 T:1961185280 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian АБВ" successfully loaded
06:31:19 10.656131 T:1961185280 DEBUG: UDisks: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UDisks was not provided by any .service files
06:31:19 10.657628 T:1961185280 DEBUG: DeviceKit.Disks: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.DeviceKit.Disks was not provided by any .service files
06:31:19 10.667628 T:1961185280 DEBUG: Selected UDev as storage provider
06:31:19 10.668637 T:1961185280 NOTICE: Raspberry PI firmware version: Oct 4 2016 19:03:30
Copyright (c) 2012 Broadcom
version c844c61ad08f94946910d0d5e1be076df4c8c56d (clean) (release)
06:31:19 10.668796 T:1961185280 NOTICE: ARM mem: 752MB GPU mem: 256MB MPG2:0 WVC1:0
06:31:19 10.668896 T:1961185280 NOTICE: cache.memorysize: 20MB
06:31:19 10.669401 T:1961185280 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
pause_burst_frames=1
program_serial_random=1
sdram_freq=450
temp_limit=85
06:31:19 10.669749 T:1961185280 NOTICE: Config:
device_tree=-
06:31:19 10.669879 T:1961185280 DEBUG: DllBcm: Using omx system library
06:31:19 10.669983 T:1961185280 NOTICE: InitWindowSystem: Using EGL Implementation: raspberrypi
06:31:19 10.672256 T:1961185280 DEBUG: EGL initial desktop resolution 1600x1200 (1440x1080) @ 60.00 - Full Screen (1.00)
06:31:19 10.672991 T:1961185280 DEBUG: EGL get supported modes (2) = 19, prefer_group=2, prefer_mode=33
06:31:19 10.673163 T:1961185280 DEBUG: EGL mode 0: 640x480 (640x480) @ 60.00 - Full Screen (1.00) :4
06:31:19 10.673315 T:1961185280 DEBUG: EGL mode 1: 640x480 (640x480) @ 72.00 - Full Screen (1.00) :5
06:31:19 10.673548 T:1961185280 DEBUG: EGL mode 2: 640x480 (640x480) @ 75.00 - Full Screen (1.00) :6
06:31:19 10.673669 T:1961185280 DEBUG: EGL mode 3: 800x600 (800x600) @ 56.00 - Full Screen (1.00) :8
06:31:19 10.673785 T:1961185280 DEBUG: EGL mode 4: 800x600 (800x600) @ 60.00 - Full Screen (1.00) :9
06:31:19 10.674006 T:1961185280 DEBUG: EGL mode 5: 800x600 (800x600) @ 72.00 - Full Screen (1.00) :a
06:31:19 10.674145 T:1961185280 DEBUG: EGL mode 6: 800x600 (800x600) @ 75.00 - Full Screen (1.00) :b
06:31:19 10.674258 T:1961185280 DEBUG: EGL mode 7: 1024x768 (1024x768) @ 60.00 - Full Screen (1.00) :10
06:31:19 10.674391 T:1961185280 DEBUG: EGL mode 8: 1024x768 (1024x768) @ 70.00 - Full Screen (1.00) :11
06:31:19 10.674505 T:1961185280 DEBUG: EGL mode 9: 1024x768 (1024x768) @ 75.00 - Full Screen (1.00) :12
06:31:19 10.674623 T:1961185280 DEBUG: EGL mode 10: 1152x864 (1152x864) @ 75.00 - Full Screen (1.00) :15
06:31:19 10.674752 T:1961185280 DEBUG: EGL mode 11: 1280x800 (1280x800) @ 60.00 - Full Screen (1.00) :1c
06:31:19 10.674884 T:1961185280 DEBUG: EGL mode 12: 1280x960 (1280x960) @ 60.00 - Full Screen (1.00) :20
06:31:19 10.675014 T:1961185280 DEBUG: EGL mode 13: 1280x1024 (1280x1024) @ 60.00 - Full Screen (1.00) :23
06:31:19 10.675145 T:1961185280 DEBUG: EGL mode 14: 1280x1024 (1280x1024) @ 75.00 - Full Screen (1.00) :24
06:31:19 10.675271 T:1961185280 DEBUG: EGL mode 15: 1440x900 (1440x900) @ 60.00 - Full Screen (1.00) :2f
06:31:19 10.675402 T:1961185280 DEBUG: EGL mode 16: 1600x1200 (1440x1080) @ 60.00 - Full Screen (1.00) :33
06:31:19 10.675532 T:1961185280 DEBUG: EGL mode 17: 1680x1050 (1680x1050) @ 60.00 - Full Screen (1.00) :3a
06:31:19 10.675667 T:1961185280 DEBUG: EGL mode 18: 1920x1080 (1920x1080) @ 60.00 - Full Screen (1.00) :52
06:31:19 10.675974 T:1961185280 DEBUG: EGL probe resolution 1600x1200 (1440x1080) @ 60.00 - Full Screen:33020004
06:31:19 10.676096 T:1961185280 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 60.000000 Hz
06:31:19 10.676226 T:1961185280 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 59.940063 Hz
06:31:19 10.676336 T:1961185280 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 72.000000 Hz
06:31:19 10.676444 T:1961185280 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 71.928070 Hz
06:31:19 10.676565 T:1961185280 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 75.000000 Hz
06:31:19 10.676711 T:1961185280 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 56.000000 Hz
06:31:19 10.676834 T:1961185280 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 60.000000 Hz
06:31:19 10.676944 T:1961185280 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 59.940063 Hz
06:31:19 10.677051 T:1961185280 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 72.000000 Hz
06:31:19 10.677159 T:1961185280 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 71.928070 Hz
06:31:19 10.677266 T:1961185280 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 75.000000 Hz
06:31:19 10.677373 T:1961185280 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 60.000000 Hz
06:31:19 10.677479 T:1961185280 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 59.940063 Hz
06:31:19 10.677597 T:1961185280 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 70.000000 Hz
06:31:19 10.677705 T:1961185280 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 75.000000 Hz
06:31:19 10.677812 T:1961185280 NOTICE: Found resolution 1152 x 864 for display 0 with 1152 x 864 @ 75.000000 Hz
06:31:19 10.677917 T:1961185280 NOTICE: Found resolution 1280 x 800 for display 0 with 1280 x 800 @ 60.000000 Hz
06:31:19 10.678023 T:1961185280 NOTICE: Found resolution 1280 x 800 for display 0 with 1280 x 800 @ 59.940063 Hz
06:31:19 10.678178 T:1961185280 NOTICE: Found resolution 1280 x 960 for display 0 with 1280 x 960 @ 60.000000 Hz
06:31:19 10.678290 T:1961185280 NOTICE: Found resolution 1280 x 960 for display 0 with 1280 x 960 @ 59.940063 Hz
06:31:19 10.678395 T:1961185280 NOTICE: Found resolution 1280 x 1024 for display 0 with 1280 x 1024 @ 60.000000 Hz
06:31:19 10.678501 T:1961185280 NOTICE: Found resolution 1280 x 1024 for display 0 with 1280 x 1024 @ 59.940063 Hz
06:31:19 10.678672 T:1961185280 NOTICE: Found resolution 1280 x 1024 for display 0 with 1280 x 1024 @ 75.000000 Hz
06:31:19 10.678782 T:1961185280 NOTICE: Found resolution 1440 x 900 for display 0 with 1440 x 900 @ 60.000000 Hz
06:31:19 10.678887 T:1961185280 NOTICE: Found resolution 1440 x 900 for display 0 with 1440 x 900 @ 59.940063 Hz
06:31:19 10.678993 T:1961185280 NOTICE: Found resolution 1440 x 1080 for display 0 with 1600 x 1200 @ 60.000000 Hz
06:31:19 10.679100 T:1961185280 NOTICE: Found resolution 1440 x 1080 for display 0 with 1600 x 1200 @ 59.940063 Hz
06:31:19 10.679205 T:1961185280 NOTICE: Found resolution 1680 x 1050 for display 0 with 1680 x 1050 @ 60.000000 Hz
06:31:19 10.679316 T:1961185280 NOTICE: Found resolution 1680 x 1050 for display 0 with 1680 x 1050 @ 59.940063 Hz
06:31:19 10.679421 T:1961185280 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 60.000000 Hz
06:31:19 10.679526 T:1961185280 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 59.940063 Hz
06:31:19 10.679635 T:1961185280 NOTICE: Found (1440x1080@60.000000) at 41, setting to RES_DESKTOP at 16
06:31:19 10.679778 T:1961185280 NOTICE: Checking resolution 16
06:31:19 10.785303 T:1929376672 DEBUG: CAESinkPi:Drain delay:99ms now:0ms
06:31:19 10.785448 T:1929376672 DEBUG: CAESinkPi:Deinitialize
06:31:19 10.785954 T:1929376672 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000
06:31:19 10.792840 T:1929376672 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x726020d8
06:31:19 10.810495 T:1961185280 DEBUG: EGL set HDMI mode (2,51)=0 off
06:31:19 10.922968 T:1902113696 DEBUG: EGL tv_service_callback (4,2,51)
06:31:19 10.924573 T:1961185280 DEBUG: EGL set resolution 1440x1080 -> 1600x1200 @ 60.00 fps (2,51) flags:33020004 aspect:1.00
06:31:19 10.947189 T:1961185280 DEBUG: CreateWindow: Created surface of size 1440x1080
06:31:19 10.947991 T:1939850144 DEBUG: CActiveAE - display reset event
06:31:19 10.948245 T:1961185280 NOTICE: GL_VENDOR = Broadcom
06:31:19 10.948366 T:1961185280 NOTICE: GL_RENDERER = VideoCore IV HW
06:31:19 10.948470 T:1961185280 NOTICE: GL_VERSION = OpenGL ES 2.0
06:31:19 10.948571 T:1961185280 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00
06:31:19 10.948678 T:1929376672 INFO: CActiveAESink::OpenSink - initialize sink
06:31:19 10.948798 T:1961185280 DEBUG: GLES: Extension Support Test - GL_NVX_gpu_memory_info NO
06:31:19 10.948915 T:1929376672 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI
06:31:19 10.949039 T:1961185280 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
06:31:19 10.949182 T:1961185280 DEBUG: GLES: Extension Support Test - GL_EXT_texture_format_BGRA8888 YES
06:31:19 10.949321 T:1961185280 DEBUG: GLES: Extension Support Test - GL_IMG_texture_format_BGRA8888 NO
06:31:19 10.949443 T:1961185280 DEBUG: GLES: Extension Support Test - GL_APPLE_texture_format_BGRA8888 NO
06:31:19 10.949553 T:1929376672 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008
06:31:19 10.949702 T:1929376672 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI
06:31:19 10.951845 T:1929376672 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x7260bf10
06:31:19 10.954252 T:1929376672 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignmen(16)
06:31:19 10.955029 T:1929376672 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized:
06:31:19 10.955234 T:1961185280 DEBUG: GL: Vertex Shader compilation log:
06:31:19 10.955372 T:1929376672 DEBUG: Output Device : HDMI
06:31:19 10.955498 T:1929376672 DEBUG: Sample Rate : 44100
06:31:19 10.955605 T:1961185280 DEBUG: Compiled
06:31:19 10.955712 T:1961185280 DEBUG: GL: Vertex Shader compiled successfully
06:31:19 10.955819 T:1929376672 DEBUG: Sample Format : AE_FMT_FLOAT
06:31:19 10.955934 T:1929376672 DEBUG: Channel Count : 2
06:31:19 10.956035 T:1929376672 DEBUG: Channel Layout: FL,FR
06:31:19 10.956139 T:1929376672 DEBUG: Frames : 2205
06:31:19 10.956230 T:1929376672 DEBUG: Frame Size : 8
06:31:19 10.956329 T:1961185280 DEBUG: GL: Pixel Shader compilation log:
06:31:19 10.956581 T:1961185280 DEBUG: Compiled
06:31:19 10.956736 T:1961185280 DEBUG: GL: Fragment Shader compiled successfully
06:31:19 10.965601 T:1939850144 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
06:31:19 10.981636 T:1961185280 DEBUG: GUI Shader [guishader_frag_default.glsl]- Initialise successful : 0x34884d8
06:31:19 10.983296 T:1961185280 DEBUG: GL: Vertex Shader compilation log:
06:31:19 10.983643 T:1961185280 DEBUG: Compiled
06:31:19 10.983758 T:1961185280 DEBUG: GL: Vertex Shader compiled successfully
06:31:19 10.984349 T:1961185280 DEBUG: GL: Pixel Shader compilation log:
06:31:19 10.984589 T:1961185280 DEBUG: Compiled
06:31:19 10.984686 T:1961185280 DEBUG: GL: Fragment Shader compiled successfully
06:31:19 11.004546 T:1961185280 DEBUG: GUI Shader [guishader_frag_texture.glsl]- Initialise successful : 0x348e8e8
06:31:19 11.006003 T:1961185280 DEBUG: GL: Vertex Shader compilation log:
06:31:19 11.006268 T:1961185280 DEBUG: Compiled
06:31:19 11.006369 T:1961185280 DEBUG: GL: Vertex Shader compiled successfully
06:31:19 11.006972 T:1961185280 DEBUG: GL: Pixel Shader compilation log:
06:31:19 11.007200 T:1961185280 DEBUG: Compiled
06:31:19 11.007297 T:1961185280 DEBUG: GL: Fragment Shader compiled successfully
06:31:19 11.029763 T:1961185280 DEBUG: GUI Shader [guishader_frag_multi.glsl]- Initialise successful : 0x348f4d8
06:31:19 11.031246 T:1961185280 DEBUG: GL: Vertex Shader compilation log:
06:31:19 11.031501 T:1961185280 DEBUG: Compiled
06:31:19 11.031598 T:1961185280 DEBUG: GL: Vertex Shader compiled successfully
06:31:19 11.032192 T:1961185280 DEBUG: GL: Pixel Shader compilation log:
06:31:19 11.032413 T:1961185280 DEBUG: Compiled
06:31:19 11.032508 T:1961185280 DEBUG: GL: Fragment Shader compiled successfully
06:31:19 11.052571 T:1961185280 DEBUG: GUI Shader [guishader_frag_fonts.glsl]- Initialise successful : 0x348f550
06:31:19 11.054025 T:1961185280 DEBUG: GL: Vertex Shader compilation log:
06:31:19 11.054268 T:1961185280 DEBUG: Compiled
06:31:19 11.054363 T:1961185280 DEBUG: GL: Vertex Shader compiled successfully
06:31:19 11.054936 T:1961185280 DEBUG: GL: Pixel Shader compilation log:
06:31:19 11.055159 T:1961185280 DEBUG: Compiled
06:31:19 11.055255 T:1961185280 DEBUG: GL: Fragment Shader compiled successfully
06:31:19 11.077035 T:1961185280 DEBUG: GUI Shader [guishader_frag_texture_noblend.glsl]- Initialise successful : 0x348df28
06:31:19 11.078437 T:1961185280 DEBUG: GL: Vertex Shader compilation log:
06:31:19 11.078682 T:1961185280 DEBUG: Compiled
06:31:19 11.078779 T:1961185280 DEBUG: GL: Vertex Shader compiled successfully
06:31:19 11.079395 T:1961185280 DEBUG: GL: Pixel Shader compilation log:
06:31:19 11.079618 T:1961185280 DEBUG: Compiled
06:31:19 11.079712 T:1961185280 DEBUG: GL: Fragment Shader compiled successfully
06:31:19 11.102500 T:1961185280 DEBUG: GUI Shader [guishader_frag_multi_blendcolor.glsl]- Initialise successful : 0x3313958
06:31:19 11.103927 T:1961185280 DEBUG: GL: Vertex Shader compilation log:
06:31:19 11.104176 T:1961185280 DEBUG: Compiled
06:31:19 11.104275 T:1961185280 DEBUG: GL: Vertex Shader compiled successfully
06:31:19 11.104946 T:1961185280 DEBUG: GL: Pixel Shader compilation log:
06:31:19 11.105224 T:1961185280 DEBUG: Compiled
06:31:19 11.105321 T:1961185280 DEBUG: GL: Fragment Shader compiled successfully
06:31:19 11.127973 T:1961185280 DEBUG: GUI Shader [guishader_frag_rgba.glsl]- Initialise successful : 0x33139d0
06:31:19 11.128121 T:1961185280 DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external YES
06:31:19 11.129590 T:1961185280 DEBUG: GL: Vertex Shader compilation log:
06:31:19 11.129849 T:1961185280 DEBUG: Compiled
06:31:19 11.129948 T:1961185280 DEBUG: GL: Vertex Shader compiled successfully
06:31:19 11.130614 T:1961185280 DEBUG: GL: Pixel Shader compilation log:
06:31:19 11.130841 T:1961185280 DEBUG: Compiled
06:31:19 11.130938 T:1961185280 DEBUG: GL: Fragment Shader compiled successfully
06:31:19 11.153325 T:1961185280 DEBUG: GUI Shader [guishader_frag_rgba_oes.glsl]- Initialise successful : 0x348dfa0
06:31:19 11.154778 T:1961185280 DEBUG: GL: Vertex Shader compilation log:
06:31:19 11.155028 T:1961185280 DEBUG: Compiled
06:31:19 11.155143 T:1961185280 DEBUG: GL: Vertex Shader compiled successfully
06:31:19 11.155745 T:1961185280 DEBUG: GL: Pixel Shader compilation log:
06:31:19 11.155967 T:1961185280 DEBUG: Compiled
06:31:19 11.156060 T:1961185280 DEBUG: GL: Fragment Shader compiled successfully
06:31:19 11.178503 T:1961185280 DEBUG: GUI Shader [guishader_frag_rgba_blendcolor.glsl]- Initialise successful : 0x3314578
06:31:19 11.179974 T:1961185280 DEBUG: GL: Vertex Shader compilation log:
06:31:19 11.180264 T:1961185280 DEBUG: Compiled
06:31:19 11.180365 T:1961185280 DEBUG: GL: Vertex Shader compiled successfully
06:31:19 11.181068 T:1961185280 DEBUG: GL: Pixel Shader compilation log:
06:31:19 11.181289 T:1961185280 DEBUG: Compiled
06:31:19 11.181383 T:1961185280 DEBUG: GL: Fragment Shader compiled successfully
06:31:19 11.205810 T:1961185280 DEBUG: GUI Shader [guishader_frag_rgba_bob.glsl]- Initialise successful : 0x3452680
06:31:19 11.205943 T:1961185280 DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external YES
06:31:19 11.207406 T:1961185280 DEBUG: GL: Vertex Shader compilation log:
06:31:19 11.207656 T:1961185280 DEBUG: Compiled
06:31:19 11.207753 T:1961185280 DEBUG: GL: Vertex Shader compiled successfully
06:31:19 11.208504 T:1961185280 DEBUG: GL: Pixel Shader compilation log:
06:31:19 11.208728 T:1961185280 DEBUG: Compiled
06:31:19 11.208822 T:1961185280 DEBUG: GL: Fragment Shader compiled successfully
06:31:19 11.238380 T:1961185280 DEBUG: GUI Shader [guishader_frag_rgba_bob_oes.glsl]- Initialise successful : 0x34526f8
06:31:19 11.238524 T:1961185280 DEBUG: CWinSystemEGL::CreateNewWindow: No need to create a new window
06:31:19 11.238660 T:1961185280 INFO: GLES: Maximum texture width: 2048
06:31:20 11.909415 T:1961185280 INFO: GLES: Enabling VSYNC
06:31:20 11.909676 T:1961185280 INFO: GLES: Selected vsync mode 10
06:31:20 11.909875 T:1961185280 INFO: load keymapping
06:31:20 11.920858 T:1961185280 INFO: Loading special://xbmc/system/keymaps/appcommand.xml
06:31:20 11.923604 T:1961185280 INFO: Loading special://xbmc/system/keymaps/customcontroller.AppleRemote.xml
06:31:20 11.933309 T:1961185280 INFO: Loading special://xbmc/system/keymaps/customcontroller.Harmony.xml
06:31:20 11.952151 T:1961185280 INFO: Loading special://xbmc/system/keymaps/gamepad.xml
06:31:20 11.968133 T:1961185280 INFO: Loading special://xbmc/system/keymaps/joystick.xml
06:31:20 11.984452 T:1961185280 INFO: Loading special://xbmc/system/keymaps/keyboard.xml
06:31:20 12.034615 T:1961185280 INFO: Loading special://xbmc/system/keymaps/mouse.xml
06:31:20 12.039054 T:1961185280 INFO: Loading special://xbmc/system/keymaps/remote.xml
06:31:20 12.077203 T:1961185280 INFO: Loading special://xbmc/system/keymaps/touchscreen.xml
06:31:20 12.091416 T:1961185280 INFO: Loading special://xbmc/system/Lircmap.xml
06:31:20 12.109274 T:1961185280 INFO: * Adding remote mapping for device 'mceusb'
06:31:20 12.109899 T:1961185280 INFO: * Adding remote mapping for device 'XboxDVDDongle'
06:31:20 12.110250 T:1961185280 INFO: * Adding remote mapping for device 'Microsoft_Xbox'
06:31:20 12.110502 T:1961185280 INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote'
06:31:20 12.110765 T:1961185280 INFO: * Adding remote mapping for device 'anysee'
06:31:20 12.111011 T:1961185280 INFO: * Adding remote mapping for device 'iMON-PAD'
06:31:20 12.111270 T:1961185280 INFO: * Adding remote mapping for device 'Antec_Veris_RM200'
06:31:20 12.111537 T:1961185280 INFO: * Adding remote mapping for device 'MCE_via_iMON'
06:31:20 12.111810 T:1961185280 INFO: * Adding remote mapping for device 'TwinHanRemote'
06:31:20 12.112024 T:1961185280 INFO: * Adding remote mapping for device 'linux-input-layer'
06:31:20 12.112445 T:1961185280 INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote'
06:31:20 12.112549 T:1961185280 INFO: * Adding remote mapping for device 'mediacenter'
06:31:20 12.112803 T:1961185280 INFO: * Adding remote mapping for device 'devinput'
06:31:20 12.115406 T:1961185280 DEBUG: CButtonTranslator::Load - no userdata Lircmap.xml found, skipping
06:31:20 12.115561 T:1961185280 INFO: GUI format 1440x1080, Display 1600x1200 (1440x1080) @ 60.00 - Full Screen
06:31:20 12.115659 T:1961185280 DEBUG: guilib: Fill viewport on change for solving rendering passes
06:31:20 12.117696 T:1961185280 INFO: CLangInfo: loading resource.language.en_gb language information...
06:31:20 12.127049 T:1961185280 DEBUG: trying to set locale to en_US.UTF-8
06:31:20 12.145589 T:1961185280 INFO: global locale set to C
06:31:20 12.146515 T:1961185280 INFO: CLangInfo: loading resource.language.en_gb language strings...
06:31:20 12.270658 T:1961185280 DEBUG: LocalizeStrings: loaded 3771 strings from file resource://resource.language.en_gb/strings.po
06:31:20 12.307746 T:1961185280 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.xbmc.builtin.aac/resources/language/English/strings.po
06:31:20 12.310206 T:1961185280 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.xbmc.builtin.wma/resources/language/English/strings.po
06:31:20 12.313817 T:1961185280 DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/game.controller.default/resources/language/resource.language.en_gb/strings.po
06:31:20 12.320893 T:1961185280 DEBUG: LocalizeStrings: loaded 13 strings from file /storage/.kodi/addons/metadata.album.universal/resources/language/English/strings.po
06:31:20 12.327323 T:1961185280 DEBUG: LocalizeStrings: loaded 26 strings from file /storage/.kodi/addons/metadata.artists.universal/resources/language/English/strings.po
06:31:20 12.343884 T:1961185280 DEBUG: LocalizeStrings: loaded 7 strings from file /storage/.kodi/addons/metadata.themoviedb.org/resources/language/English/strings.po
06:31:20 12.346973 T:1961185280 DEBUG: LocalizeStrings: loaded 7 strings from file /usr/share/kodi/addons/metadata.tvdb.com/resources/language/English/strings.po
06:31:20 12.349789 T:1961185280 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/peripheral.joystick/resources/language/English/strings.po
06:31:20 12.359682 T:1961185280 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.en_gb/strings.po
06:31:20 12.374236 T:1961185280 DEBUG: LocalizeStrings: loaded 202 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/English/strings.po
06:31:20 12.379901 T:1961185280 DEBUG: LocalizeStrings: loaded 7 strings from file /storage/.kodi/addons/inputstream.mpd/resources/language/resource.language.en_gb/strings.po
06:31:20 12.382280 T:1961185280 DEBUG: LocalizeStrings: loaded 5 strings from file /storage/.kodi/addons/inputstream.smoothstream/resources/language/resource.language.en_gb/strings.po
06:31:20 12.403288 T:1961185280 DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid"
06:31:20 12.404139 T:1961185280 DEBUG: LoadMappings - loaded node "CEC Adapter"
06:31:20 12.404295 T:1961185280 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter"
06:31:20 12.404642 T:1961185280 DEBUG: LoadMappings - loaded node "iMON HID device"
06:31:20 12.404796 T:1961185280 DEBUG: LoadMappings - loaded node "WETEK Play remote"
06:31:20 12.404955 T:1961185280 DEBUG: LoadMappings - loaded node ""
06:31:20 12.405610 T:1961185280 DEBUG: CPeripheralBusUSB - initialised udev monitor
06:31:20 12.405722 T:1961185280 DEBUG: SECTION:LoadDLL(libcec.so.3)
06:31:20 12.408696 T:1961185280 DEBUG: Loading: libcec.so.3
06:31:21 12.440211 T:1961185280 DEBUG: Add-on bus: Registering add-on peripheral.joystick
06:31:21 12.440797 T:1961185280 DEBUG: PERIPHERAL - CreateAddon - creating peripheral add-on instance 'Joystick Support'
06:31:21 12.440888 T:1961185280 DEBUG: ADDON: Dll Initializing - Joystick Support
06:31:21 12.441422 T:1961185280 DEBUG: SECTION:LoadDLL(/usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.2.0)
06:31:21 12.441602 T:1961185280 DEBUG: Loading: /usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.2.0
06:31:21 12.497272 T:1961185280 DEBUG: AddOnLog: Joystick Support: Loaded 14 joystick families with 14 total joysticks
06:31:21 12.497833 T:1961185280 DEBUG: Calling TransferSettings for: Joystick Support
06:31:21 12.498563 T:1839178656 DEBUG: Thread PeripBusUSBUdev start, auto delete: false
06:31:21 12.498930 T:1830790048 DEBUG: Thread PeripBusCEC start, auto delete: false
06:31:21 12.499314 T:1822401440 DEBUG: Thread PeripBusAddon start, auto delete: false
06:31:21 12.499725 T:1961185280 DEBUG: SECTION:LoadDLL(libcurl.so.4)
06:31:21 12.499990 T:1814012832 DEBUG: Thread PeripEventScanner start, auto delete: false
06:31:21 12.502966 T:1961185280 DEBUG: Loading: libcurl.so.4
06:31:21 12.604077 T:1961185280 NOTICE: Running database version Addons26
06:31:21 12.604699 T:1961185280 DEBUG: Initialize, updating databases...
06:31:21 12.610650 T:1961185280 NOTICE: Running database version ViewModes6
06:31:21 12.619197 T:1961185280 NOTICE: Running database version Textures13
06:31:21 12.641248 T:1961185280 NOTICE: Running database version MyMusic60
06:31:21 12.677257 T:1961185280 NOTICE: Running database version MyVideos107
06:31:21 12.685169 T:1961185280 NOTICE: Running database version TV29
06:31:21 12.691118 T:1961185280 NOTICE: Running database version Epg11
06:31:21 12.695828 T:1961185280 DEBUG: Initialize, updating databases... DONE
06:31:21 12.696864 T:1961185280 NOTICE: start dvd mediatype detection
06:31:21 12.697252 T:1961185280 INFO: DPMS: not supported on this platform
06:31:21 12.697384 T:1930580896 DEBUG: Thread DetectDVDMedia start, auto delete: false
06:31:21 12.697499 T:1930580896 DEBUG: Compiled with libcdio Version 0.93
06:31:21 12.702045 T:1930580896 DEBUG: Thread DetectDVDMedia 1930580896 terminating
06:31:21 12.762649 T:1961178016 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
06:31:21 12.762936 T:1961178016 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
06:31:21 12.780868 T:1830790048 DEBUG: GetMappingForDevice - device (2708:1001) mapped to CEC Adapter (type = cec)
06:31:21 12.787930 T:1830790048 DEBUG: InitialiseFeature - using libCEC v3.1.0
06:31:21 12.788259 T:1830790048 DEBUG: Initialise - initialised peripheral on 'RPI' with 2 features and 0 sub devices
06:31:21 12.788389 T:1830790048 NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001)
06:31:21 12.788479 T:1795158944 DEBUG: Thread CECAdapter start, auto delete: false
06:31:21 12.788577 T:1830790048 DEBUG: Thread PeripBusCEC 1830790048 terminating
06:31:21 12.788663 T:1795158944 DEBUG: OpenConnection - opening a connection to the CEC adapter: RPI
06:31:21 12.800629 T:1961185280 INFO: Unloading old skin ...
06:31:21 12.801879 T:1961185280 INFO: load skin from: /usr/share/kodi/addons/skin.estuary (version: 0.8.5)
06:31:21 12.802109 T:1961185280 INFO: load fonts for skin...
06:31:21 12.811741 T:1961185280 INFO: Loading fonts from /usr/share/kodi/addons/skin.estuary/1080i/Font.xml
06:31:21 12.969177 T:1961185280 DEBUG: LocalizeStrings: loaded 148 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.en_gb/strings.po
06:31:21 12.970083 T:1961185280 INFO: Loading skin includes from /usr/share/kodi/addons/skin.estuary/1080i/Includes.xml
06:31:21 13.235818 T:1961185280 INFO: load new skin...
06:31:21 13.236263 T:1961185280 INFO: Loading user windows, path /usr/share/kodi/addons/skin.estuary/1080i
06:31:21 13.269373 T:1961185280 DEBUG: Load Skin XML: 34.33ms
06:31:21 13.269535 T:1961185280 INFO: initialize new skin...
06:31:21 13.269621 T:1961185280 DEBUG: guilib: Fill viewport on change for solving rendering passes
06:31:21 13.269719 T:1961185280 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT
06:31:21 13.288359 T:1961185280 DEBUG: OpenBundle - Opened bundle /usr/share/kodi/addons/skin.estuary/media/Textures.xbt
06:31:21 13.296809 T:1961185280 INFO: Loading skin file: DialogNotification.xml, load type: LOAD_ON_GUI_INIT
06:31:21 13.301588 T:1961185280 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT
06:31:21 13.322321 T:1961185280 INFO: Loading skin file: DialogSettings.xml, load type: LOAD_ON_GUI_INIT
06:31:21 13.373911 T:1961185280 INFO: Previous line repeats 1 times.
06:31:21 13.374089 T:1961185280 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
06:31:21 13.380395 T:1961185280 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT
06:31:21 13.388645 T:1961185280 INFO: Loading skin file: DialogSubtitles.xml, load type: LOAD_ON_GUI_INIT
06:31:21 13.416763 T:1961185280 INFO: Loading skin file: DialogPVRChannelsOSD.xml, load type: LOAD_ON_GUI_INIT
06:31:22 13.438757 T:1961185280 INFO: Loading skin file: DialogPVRGuideOSD.xml, load type: LOAD_ON_GUI_INIT
06:31:22 13.452230 T:1961185280 INFO: Loading skin file: VideoOSD.xml, load type: LOAD_ON_GUI_INIT
06:31:22 13.533288 T:1961185280 INFO: Loading resource://resource.uisounds.confluence/sounds.xml
06:31:22 13.742239 T:1961185280 INFO: skin loaded...
06:31:22 13.742509 T:1961185280 DEBUG: Activating window ID: 12997
06:31:22 13.742666 T:1961185280 DEBUG: ------ Window Init () ------
06:31:22 13.743096 T:1961185280 INFO: load splash image: /usr/share/kodi/media/Splash.png
06:31:22 13.829685 T:1961185280 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting
06:31:22 13.829881 T:1961185280 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList"
06:31:22 13.829964 T:1961185280 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting")
06:31:22 13.831051 T:1961185280 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting
06:31:22 13.943662 T:1961185280 ERROR: JSONRPC: Unable to parse JSON Schema definition for ""
06:31:22 13.943848 T:1961185280 ERROR: JSONRPC: Invalid JSON Schema definition for method ""
06:31:22 13.970684 T:1961185280 INFO: JSONRPC v7.22.0: Successfully initialized
06:31:22 13.970865 T:1961185280 DEBUG: ADDON: Starting service addons.
06:31:22 13.976235 T:1961185280 DEBUG: Activating window ID: 12999
06:31:22 13.976406 T:1961185280 DEBUG: ------ Window Init (Startup.xml) ------
06:31:22 13.976490 T:1961185280 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME
06:31:22 13.977567 T:1961185280 DEBUG: Activating window ID: 10000
06:31:22 13.977683 T:1961185280 DEBUG: ------ Window Deinit (Startup.xml) ------
06:31:22 13.977777 T:1961185280 DEBUG: ------ Window Init (Home.xml) ------
06:31:22 13.977850 T:1961185280 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY
06:31:22 14.210762 T:1795158944 DEBUG: OpenConnection - connection to the CEC adapter opened
06:31:22 14.211479 T:1776284576 DEBUG: Thread CECAdapterUpdate start, auto delete: false
06:31:23 14.672272 T:1961185280 DEBUG: CDirectoryProvider[special://skin/playlists/inprogress_movies.xsp]: refreshing..
06:31:23 14.672667 T:1961185280 DEBUG: CDirectoryProvider[videodb://recentlyaddedmovies/]: refreshing..
06:31:23 14.673124 T:1961185280 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_movies.xsp]: refreshing..
06:31:23 14.673251 T:1767895968 DEBUG: Thread JobWorker start, auto delete: true
06:31:23 14.673390 T:1961185280 DEBUG: CDirectoryProvider[special://skin/playlists/random_movies.xsp]: refreshing..
06:31:23 14.673731 T:1759507360 DEBUG: Thread JobWorker start, auto delete: true
06:31:23 14.673968 T:1961185280 DEBUG: CDirectoryProvider[videodb://inprogresstvshows]: refreshing..
06:31:23 14.674110 T:1961185280 DEBUG: CDirectoryProvider[videodb://recentlyaddedepisodes/]: refreshing..
06:31:23 14.674248 T:1961185280 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_tvshows.xsp]: refreshing..
06:31:23 14.705285 T:1961185280 DEBUG: CDirectoryProvider[musicdb://recentlyplayedalbums]: refreshing..
06:31:23 14.705523 T:1961185280 DEBUG: CDirectoryProvider[musicdb://recentlyaddedalbums/]: refreshing..
06:31:23 14.705645 T:1961185280 DEBUG: CDirectoryProvider[special://skin/playlists/random_albums.xsp]: refreshing..
06:31:23 14.705746 T:1961185280 DEBUG: CDirectoryProvider[special://skin/playlists/random_artists.xsp]: refreshing..
06:31:23 14.705851 T:1961185280 DEBUG: CDirectoryProvider[special://skin/playlists/unplayed_albums.xsp]: refreshing..
06:31:23 14.705984 T:1961185280 DEBUG: CDirectoryProvider[special://skin/playlists/mostplayed_albums.xsp]: refreshing..
06:31:23 14.706277 T:1961185280 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing..
06:31:23 14.706409 T:1961185280 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing..
06:31:23 14.706512 T:1961185280 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing..
06:31:23 14.706632 T:1961185280 DEBUG: CDirectoryProvider[]: refreshing..
06:31:23 14.706823 T:1961185280 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing..
06:31:23 14.707078 T:1961185280 DEBUG: CDirectoryProvider[sources://video/]: refreshing..
06:31:23 14.707199 T:1961185280 DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing..
06:31:23 14.707497 T:1961185280 DEBUG: CDirectoryProvider[pvr://channels/tv/*?view=lastplayed]: refreshing..
06:31:23 14.707628 T:1961185280 DEBUG: CDirectoryProvider[pvr://recordings/tv/active?view=flat]: refreshing..
06:31:23 14.707870 T:1961185280 DEBUG: CDirectoryProvider[pvr://channels/radio/*?view=lastplayed]: refreshing..
06:31:23 14.707983 T:1961185280 DEBUG: CDirectoryProvider[pvr://recordings/radio/active?view=flat]: refreshing..
06:31:23 14.728325 T:1767895968 DEBUG: RunQuery took 7 ms for 0 items query: select * from movie_view ORDER BY dateAdded desc, idMovie desc LIMIT 25
06:31:23 14.744305 T:1759507360 DEBUG: RunQuery took 7 ms for 0 items query: select * from movie_view WHERE ((movie_view.playCount IS NULL OR movie_view.playCount = 0))
06:31:23 14.747883 T:1873802144 DEBUG: RunQuery took 6 ms for 0 items query: select * from movie_view WHERE (movie_view.idFile IN (SELECT DISTINCT idFile FROM bookmark WHERE type = 1))
06:31:23 14.792385 T:1767895968 DEBUG: RunQuery took 7 ms for 0 items query: select * from movie_view
06:31:23 14.806469 T:1759507360 DEBUG: RunQuery took 6 ms for 0 items query: SELECT * FROM tvshow_view WHERE watchedCount != 0 AND totalCount != watchedCount ORDER BY c00
06:31:23 14.807730 T:1873802144 DEBUG: RunQuery took 6 ms for 0 items query: select * from episode_view ORDER BY dateAdded desc, idEpisode desc LIMIT 25
06:31:23 14.819629 T:1961185280 DEBUG: ContextMenuManager: addon menus reloaded.
06:31:23 14.819845 T:1961185280 INFO: removing tempfiles
06:31:23 14.822872 T:1961185280 DEBUG: ADDON: Starting service addons.
06:31:23 14.830209 T:1751118752 DEBUG: Thread LanguageInvoker start, auto delete: false
06:31:23 14.835515 T:1759507360 DEBUG: GetRecentlyPlayedAlbums query: SELECT albumview.*, albumartistview.* FROM (SELECT idAlbum FROM albumview WHERE albumview.lastplayed IS NOT NULL AND albumview.strReleaseType = 'album' ORDER BY albumview.lastplayed DESC LIMIT 25) as playedalbums JOIN albumview ON albumview.idAlbum = playedalbums.idAlbum JOIN albumartistview ON albumview.idAlbum = albumartistview.idAlbum ORDER BY albumview.lastplayed DESC, albumartistview.iorder
06:31:23 14.836040 T:1751118752 INFO: initializing python engine.
06:31:23 14.838367 T:1873802144 DEBUG: GetRecentlyAddedAlbums query: SELECT albumview.*, albumartistview.* FROM (SELECT idAlbum FROM album WHERE strAlbum != '' ORDER BY idAlbum DESC LIMIT 25) AS recentalbums JOIN albumview ON albumview.idAlbum = recentalbums.idAlbum JOIN albumartistview ON albumview.idAlbum = albumartistview.idAlbum ORDER BY albumview.idAlbum desc, albumartistview.iOrder
06:31:23 14.857950 T:1961185280 DEBUG: CRepositoryUpdater: previous update at 10/23/2016 3:58:09 PM, next at 10/24/2016 3:58:09 PM
06:31:23 14.858379 T:1961185280 NOTICE: initialize done
06:31:23 14.858503 T:1961185280 NOTICE: Running the application...
06:31:23 14.864766 T:1759507360 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE albumview.strReleaseType = 'album'
06:31:23 14.865618 T:1742730144 DEBUG: Thread Timer start, auto delete: false
06:31:23 14.865919 T:1767895968 DEBUG: RunQuery took 10 ms for 0 items query: SELECT * FROM tvshow_view WHERE ((tvshow_view.watchedcount = 0)) AND ((tvshow_view.totalCount > 0))
06:31:23 14.867351 T:1742730144 DEBUG: CRepositoryUpdater: running scheduled update
06:31:23 14.868845 T:1759507360 DEBUG: GetAlbumsByWhere - query took 3 ms
06:31:23 14.890548 T:1742730144 DEBUG: Thread Timer 1742730144 terminating
06:31:23 14.895099 T:1961185280 DEBUG: no profile autoexec.py (/storage/.kodi/userdata/autoexec.py) found, skipping
06:31:23 14.895346 T:1961185280 DEBUG: NetworkMessage - Starting network services
06:31:23 14.906832 T:1961185280 DEBUG: CZeroconfAvahi::clientCallback: client is up and running
06:31:23 14.907158 T:1961185280 NOTICE: starting zeroconf publishing
06:31:23 14.908038 T:1961185280 NOTICE: CWebServer[8080]: Started
06:31:23 14.908252 T:1961185280 NOTICE: starting upnp client
06:31:23 14.908607 T:1961185280 DEBUG: GetFirstConnectedInterface no connected interface found - requery list
06:31:23 14.913242 T:1873802144 DEBUG: GetArtistsByWhere query: SELECT artistview.* FROM artistview WHERE (artistview.idArtist IN (SELECT album_artist.idArtist FROM album_artist ) OR artistview.idArtist IN (SELECT song_artist.idArtist FROM song_artist WHERE song_artist.idRole = 1)) and artistview.strArtist != '' and artistview.strArtist <> 'Various artists'
06:31:23 14.913524 T:1759507360 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE (albumview.strReleaseType = 'album') AND (((CAST(albumview.iTimesPlayed as DECIMAL(5,1)) = 0)))
06:31:23 14.915696 T:1767895968 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE (albumview.strReleaseType = 'album') AND (((CAST(albumview.iTimesPlayed as DECIMAL(5,1)) > 0)))
06:31:23 14.916356 T:1759507360 DEBUG: GetAlbumsByWhere - query took 2 ms
06:31:23 14.917355 T:1961185280 INFO: JSONRPC Server: Successfully initialized
06:31:23 14.917645 T:1873802144 DEBUG: Time to retrieve artists from dataset = 10
06:31:23 14.917828 T:1961185280 DEBUG: GetFirstConnectedInterface no connected interface found - requery list
06:31:23 14.918776 T:1961185280 DEBUG: SECTION:LoadDLL(libshairplay.so.0)
06:31:23 14.920160 T:1692398496 DEBUG: Thread EventServer start, auto delete: false
06:31:23 14.920353 T:1692398496 NOTICE: ES: Starting UDP Event server on port 9777
06:31:23 14.920449 T:1767895968 DEBUG: GetAlbumsByWhere - query took 4 ms
06:31:23 14.921197 T:1692398496 NOTICE: UDP: Listening on port 9777 (ipv6 : false)
06:31:23 14.923270 T:1961185280 DEBUG: Loading: libshairplay.so.0
06:31:23 14.923485 T:1684009888 DEBUG: Thread TCPServer start, auto delete: false
06:31:23 14.930113 T:1961185280 DEBUG: GetFirstConnectedInterface no connected interface found - requery list
06:31:23 14.931685 T:1961185280 INFO: AIRPLAY: Cleaning up photoassetcache
06:31:23 14.934612 T:1961185280 INFO: AIRPLAY Server: Successfully initialized
06:31:23 14.935163 T:1961185280 DEBUG: GetFirstConnectedInterface no connected interface found - requery list
06:31:23 14.936822 T:1667232672 DEBUG: Thread AirPlayServer start, auto delete: false
06:31:23 14.937648 T:1759507360 ERROR: GetDirectory - Error getting
06:31:23 14.964432 T:1767895968 DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3A%2F%2Fprofile%2Fplaylists%2Fvideo/special%3A%2F%2Fprofile%2Fplaylists%2Fmixed/)
06:31:23 14.964972 T:1767895968 DEBUG: Getting Directory (special://profile/playlists/video)
06:31:23 14.967171 T:1759507360 DEBUG: CPVRDirectory::GetDirectory(pvr://channels/tv/*?view=lastplayed)
06:31:23 14.968967 T:1767895968 DEBUG: Getting Directory (special://profile/playlists/mixed)
06:31:23 14.969560 T:1759507360 DEBUG: CPVRDirectory::GetDirectory(pvr://recordings/tv/active?view=flat)
06:31:23 14.971543 T:1767895968 DEBUG: CMultiPathDirectory::MergeItems, items = 0
06:31:23 14.972045 T:1759507360 DEBUG: CPVRDirectory::GetDirectory(pvr://channels/radio/*?view=lastplayed)
06:31:23 14.972928 T:1767895968 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update
06:31:23 14.974386 T:1759507360 DEBUG: CPVRDirectory::GetDirectory(pvr://recordings/radio/active?view=flat)
06:31:23 14.978632 T:1751118752 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): start processing
06:31:23 14.979613 T:1759507360 DEBUG: CRepositoryUpdateJob[repository.kodi.game] checking for updates.
06:31:23 14.988430 T:1759507360 DEBUG: CFileCache::Open - opening using cache
06:31:23 14.989167 T:1759507360 DEBUG: CurlFile::Open(0x73b7cb88) https://raw.githubusercontent.com/kodi-game/repository.kodi.game/master/release/addons.xml.md5
06:31:23 14.989971 T:1759507360 INFO: easy_aquire - Created session to https://raw.githubusercontent.com
06:31:23 15.012661 T:1767895968 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.itrack, songartistview.iOrder
06:31:23 15.018126 T:1767895968 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
06:31:23 15.025759 T:1767895968 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
06:31:23 15.037680 T:1873802144 DEBUG: CRepositoryUpdateJob[repository.libreelec.tv] checking for updates.
06:31:23 15.044780 T:1873802144 DEBUG: CFileCache::Open - opening <8.0/RPi2/arm/addons.xml.gz.md5> using cache
06:31:23 15.045610 T:1873802144 DEBUG: CurlFile::Open(0x69f7b950) http://addons.libreelec.tv/8.0/RPi2/arm/addons.xml.gz.md5
06:31:23 15.046629 T:1873802144 INFO: easy_aquire - Created session to http://addons.libreelec.tv
06:31:23 15.058823 T:1751118752 DEBUG: -->Python Interpreter Initialized<--
06:31:23 15.059196 T:1751118752 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"
06:31:23 15.059567 T:1751118752 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
06:31:23 15.059771 T:1751118752 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): entering source directory /usr/share/kodi/addons/service.libreelec.settings
06:31:23 15.060087 T:1751118752 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
06:31:23 15.074450 T:1767895968 DEBUG: RunQuery took 3 ms for 0 items query: select * from movie_view ORDER BY dateAdded desc, idMovie desc LIMIT 10
06:31:23 15.076890 T:1961185280 INFO: Found input device /dev/input/event0
06:31:23 15.079589 T:1767895968 DEBUG: RunQuery took 4 ms for 0 items query: select * from episode_view ORDER BY dateAdded desc, idEpisode desc LIMIT 10
06:31:23 15.083984 T:1767895968 DEBUG: RunQuery took 2 ms for 0 items query: select * from musicvideo_view ORDER BY dateAdded desc, idMVideo desc LIMIT 10
06:31:23 15.088539 T:1767895968 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
06:31:23 15.092865 T:1759507360 ERROR: CCurlFile::FillBuffer - Failed: Couldn't resolve host name(6)
06:31:23 15.093102 T:1759507360 ERROR: CCurlFile::Open failed with code 0 for https://raw.githubusercontent.com/kodi-game/repository.kodi.game/master/release/addons.xml.md5
06:31:23 15.093274 T:1759507360 ERROR: Open - failed to open source
06:31:23 15.093469 T:1759507360 ERROR: CRepository: failed read 'https://raw.githubusercontent.com/kodi-game/repository.kodi.game/master/release/addons.xml.md5'
06:31:23 15.100723 T:1767895968 DEBUG: GetArtistsByWhere query: SELECT COUNT(DISTINCT artistview.idArtist) FROM artistview WHERE (artistview.idArtist IN (SELECT album_artist.idArtist FROM album_artist ) OR artistview.idArtist IN (SELECT song_artist.idArtist FROM song_artist WHERE song_artist.idRole = 1)) and artistview.strArtist != '' and artistview.strArtist <> 'Various artists'
06:31:23 15.122179 T:1759507360 DEBUG: CRepositoryUpdateJob[repository.xbmc.org] checking for updates.
06:31:23 15.128240 T:1759507360 DEBUG: CFileCache::Open - opening using cache
06:31:23 15.128923 T:1759507360 DEBUG: CurlFile::Open(0x73b85480) http://mirrors.kodi.tv/addons/krypton/addons.xml.gz.md5
06:31:23 15.129716 T:1759507360 INFO: easy_aquire - Created session to http://mirrors.kodi.tv
06:31:23 15.130226 T:1961185280 INFO: opened device 'HID 0461:4d03' (file name /dev/input/event0), m_bSkipNonKeyEvents 0
06:31:23 15.131229 T:1640367008 DEBUG: Thread CLinuxInputDevicesCheckHotplugged start, auto delete: false
06:31:23 15.148238 T:1873802144 ERROR: CCurlFile::FillBuffer - Failed: Couldn't resolve host name(6)
06:31:23 15.148517 T:1873802144 ERROR: CCurlFile::Open failed with code 0 for http://addons.libreelec.tv/8.0/RPi2/arm/addons.xml.gz.md5
06:31:23 15.148719 T:1873802144 ERROR: Open - failed to open source
06:31:23 15.148858 T:1873802144 ERROR: CRepository: failed read 'http://addons.libreelec.tv/8.0/RPi2/arm/addons.xml.gz.md5'
06:31:23 15.154452 T:1961185280 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x3ef9b00
06:31:23 15.156153 T:1767895968 DEBUG: CRepositoryUpdateJob[repository.sandmann79.plugins] checking for updates.
06:31:23 15.159416 T:1961185280 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16)
06:31:23 15.163139 T:1961185280 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x3ef55d0
06:31:23 15.173500 T:1961185280 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
06:31:23 15.207012 T:1961185280 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x3ef9b00
06:31:23 15.208339 T:1961185280 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x3ef55d0
06:31:23 15.208579 T:1961185280 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/backgrounds/SKINDEFAULT.jpg 1280x720
06:31:23 15.231226 T:1759507360 ERROR: CCurlFile::FillBuffer - Failed: Couldn't resolve host name(6)
06:31:23 15.231423 T:1759507360 ERROR: CCurlFile::Open failed with code 0 for http://mirrors.kodi.tv/addons/krypton/addons.xml.gz.md5
06:31:23 15.231578 T:1759507360 ERROR: Open - failed to open source
06:31:23 15.231707 T:1759507360 ERROR: CRepository: failed read 'http://mirrors.kodi.tv/addons/krypton/addons.xml.gz.md5'
06:31:23 15.274238 T:1873802144 DEBUG: CRepositoryUpdateJob[repository.johtru.com] checking for updates.
06:31:23 15.279963 T:1873802144 DEBUG: CFileCache::Open - opening using cache
06:31:23 15.280819 T:1873802144 DEBUG: CurlFile::Open(0x73c91dc8) https://raw.githubusercontent.com/trummerjo/repository.johtru.com/master/addons.xml.md5
06:31:23 15.329802 T:1961185280 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x3ef79a0
06:31:23 15.331035 T:1961185280 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(201536), nBufferAlignmen(16)
06:31:23 15.335846 T:1961185280 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x3fe3f58
06:31:23 15.338204 T:1961185280 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x3ef9b00
06:31:23 15.343295 T:1961185280 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
06:31:23 15.353228 T:1759507360 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:Kodi (LibreELEC) port:8080
06:31:23 15.353593 T:1759507360 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _http._tcp port:8080
06:31:23 15.365534 T:1767895968 DEBUG: CFileCache::Open - opening using cache
06:31:23 15.366232 T:1767895968 DEBUG: CurlFile::Open(0x73ca52f0) https://raw.githubusercontent.com/Sandmann79/xbmc/master/packages/addons.xml.md5
06:31:23 15.367606 T:1759507360 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:Kodi (LibreELEC) port:8080
06:31:23 15.367844 T:1742730144 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
06:31:23 15.368044 T:1767895968 INFO: easy_aquire - Created session to https://raw.githubusercontent.com
06:31:23 15.368451 T:1759507360 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _xbmc-jsonrpc-h._tcp port:8080
06:31:23 15.371303 T:1767895968 ERROR: CCurlFile::FillBuffer - Failed: Couldn't resolve host name(6)
06:31:23 15.372575 T:1767895968 ERROR: CCurlFile::Open failed with code 0 for https://raw.githubusercontent.com/Sandmann79/xbmc/master/packages/addons.xml.md5
06:31:23 15.374624 T:1767895968 ERROR: Open - failed to open source
06:31:23 15.374816 T:1767895968 ERROR: CRepository: failed read 'https://raw.githubusercontent.com/Sandmann79/xbmc/master/packages/addons.xml.md5'
06:31:23 15.378715 T:1759507360 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:Kodi (LibreELEC) port:9090
06:31:23 15.378965 T:1742730144 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
06:31:23 15.380492 T:1759507360 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _xbmc-jsonrpc._tcp port:9090
06:31:23 15.382311 T:1873802144 ERROR: CCurlFile::FillBuffer - Failed: Couldn't resolve host name(6)
06:31:23 15.382539 T:1873802144 ERROR: CCurlFile::Open failed with code 0 for https://raw.githubusercontent.com/trummerjo/repository.johtru.com/master/addons.xml.md5
06:31:23 15.382719 T:1873802144 ERROR: Open - failed to open source
06:31:23 15.382861 T:1873802144 ERROR: CRepository: failed read 'https://raw.githubusercontent.com/trummerjo/repository.johtru.com/master/addons.xml.md5'
06:31:23 15.388371 T:1742730144 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
06:31:23 15.388599 T:1759507360 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:Kodi (LibreELEC) port:9777
06:31:23 15.388697 T:1759507360 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _xbmc-events._udp port:9777
06:31:23 15.395361 T:1742730144 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
06:31:23 15.395673 T:1759507360 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airtunes type: _raop._tcp name:000102030405@Kodi (LibreELEC) port:36666
06:31:23 15.396201 T:1759507360 DEBUG: CZeroconfAvahi::addService() named: 000102030405@Kodi (LibreELEC) type: _raop._tcp port:36666
06:31:23 15.407187 T:1742730144 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
06:31:23 15.407509 T:1759507360 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airplay type: _airplay._tcp name:Kodi (LibreELEC) port:36667
06:31:23 15.407810 T:1759507360 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _airplay._tcp port:36667
06:31:23 15.416310 T:1742730144 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
06:31:24 15.457290 T:1961185280 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x3ef79a0
06:31:24 15.458426 T:1961185280 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x3fe3f58
06:31:24 15.460093 T:1961185280 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x3ef9b00
06:31:24 15.460524 T:1961185280 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/home-images/movie.jpg 927x540
06:31:24 15.494181 T:1961185280 DEBUG: ------ Window Init () ------
06:31:24 15.498678 T:1873802144 DEBUG: CRepositoryUpdater: done.
06:31:24 15.561311 T:1873802144 DEBUG: CAddonMgr::GetAvailableUpdates took 63 ms
06:31:24 15.586356 T:1873802144 DEBUG: CRepositoryUpdater: previous update at 09/29/2016 6:31:23 AM, next at 09/30/2016 6:31:23 AM
06:31:24 15.586906 T:1658844064 DEBUG: Thread Timer start, auto delete: false
06:31:24 15.707095 T:1961185280 DEBUG: LogindUPowerSyscall - Received unknown signal NameAcquired
06:31:24 15.707825 T:1961185280 DEBUG: ------ Window Init (DialogNotification.xml) ------
06:31:24 15.913592 T:1751118752 DEBUG: ## LibreELEC Addon ## 0.8.3
06:31:24 15.924067 T:1751118752 WARNING: CSkinInfo: failed to load skin settings
18:42:12 17.012596 T:1751118752 INFO: ## LibreELEC Addon ## system::set_hostname ## LibreELEC
18:42:12 17.016926 T:1751118752 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## us
18:42:12 17.017431 T:1751118752 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## loadkmap < `ls -1 /usr/lib/keymaps/*/us.bmap`
18:42:13 17.177008 T:1751118752 INFO: ## LibreELEC Addon ## system::updateThread ## Started
18:42:13 17.183140 T:1751118752 INFO: ## LibreELEC Addon ## system::set_auto_update ## manual
18:42:13 17.225649 T:1614803872 INFO: ## LibreELEC Addon ## _service_::run ## WAITING:
18:42:13 17.288214 T:1623192480 INFO: ## LibreELEC Addon ## xdbus Monitor started. ##
18:42:17 21.331202 T:1961185280 DEBUG: ------ Window Deinit (DialogNotification.xml) ------
18:42:41 45.245049 T:1961185280 INFO: CheckIdle - Closing session to http://addons.libreelec.tv (easy=0x73c967e8, multi=0x73c14768)
18:42:41 45.246304 T:1961185280 INFO: CheckIdle - Closing session to http://mirrors.kodi.tv (easy=0x73b9ace8, multi=0x73b858a0)
18:42:41 45.587036 T:1759507360 DEBUG: Thread JobWorker 1759507360 terminating (autodelete)
18:42:41 45.587299 T:1767895968 DEBUG: Thread JobWorker 1767895968 terminating (autodelete)
18:42:41 45.587563 T:1873802144 DEBUG: Thread JobWorker 1873802144 terminating (autodelete)
18:42:41 45.749947 T:1961185280 INFO: CheckIdle - Closing session to https://raw.githubusercontent.com (easy=0x73b89d98, multi=0x73b7ccb8)
18:42:41 45.750690 T:1961185280 INFO: CheckIdle - Closing session to https://raw.githubusercontent.com (easy=0x69f301d8, multi=0x73c17808)
18:43:17 81.416534 T:1929376672 DEBUG: CAESinkPi:Drain delay:100ms now:0ms
18:43:27 91.417213 T:1929376672 DEBUG: CAESinkPi:Deinitialize
18:43:27 91.418076 T:1929376672 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000
18:43:27 91.426193 T:1929376672 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x7260bf10
18:44:27 152.021317 T:1961185280 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x4148880
18:44:27 152.022736 T:1961185280 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(181744), nBufferAlignmen(16)
18:44:27 152.026978 T:1961185280 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x4028540
18:44:27 152.029129 T:1961185280 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x40f80c0
18:44:27 152.030304 T:1961185280 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:44:28 152.225739 T:1961185280 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x4148880
18:44:28 152.227097 T:1961185280 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x4028540
18:44:28 152.228714 T:1961185280 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x40f80c0
18:44:28 152.229019 T:1961185280 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/home-images/tv.jpg 810x540
18:44:29 153.164597 T:1873802144 DEBUG: Thread JobWorker start, auto delete: true
18:44:29 153.190475 T:1961185280 DEBUG: Previous line repeats 1 times.
18:44:29 153.190659 T:1961185280 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x3fc4960
18:44:29 153.191635 T:1961185280 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(263024), nBufferAlignmen(16)
18:44:29 153.195358 T:1961185280 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x4123648
18:44:29 153.197113 T:1961185280 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x4079e00
18:44:29 153.197983 T:1961185280 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:44:29 153.293777 T:1961185280 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x3fc4960
18:44:29 153.294785 T:1961185280 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x4123648
18:44:29 153.296021 T:1961185280 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x4079e00
18:44:29 153.296326 T:1961185280 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/home-images/add-ons.jpg 927x540
18:44:29 153.796829 T:1961185280 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x3f23400
18:44:29 153.797836 T:1961185280 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(186016), nBufferAlignmen(16)
18:44:29 153.801163 T:1961185280 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x4123648
18:44:29 153.802811 T:1961185280 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x4112a48
18:44:29 153.803665 T:1961185280 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:44:29 153.912338 T:1961185280 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x3f23400
18:44:29 153.913773 T:1961185280 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x4123648
18:44:29 153.915436 T:1961185280 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x4112a48
18:44:29 153.915741 T:1961185280 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/home-images/pictures.jpg 927x540
18:44:30 154.323059 T:1961185280 DEBUG: ProcessMouse: trying mouse action leftclick
18:44:30 154.323853 T:1961185280 DEBUG: Activating window ID: 11100
18:44:30 154.632782 T:1961185280 DEBUG: ------ Window Deinit (Home.xml) ------
18:44:30 154.639664 T:1961185280 DEBUG: ------ Window Init (Custom_1100_AddonLauncher.xml) ------
18:44:30 154.639832 T:1961185280 INFO: Loading skin file: Custom_1100_AddonLauncher.xml, load type: KEEP_IN_MEMORY
18:44:30 154.778122 T:1961185280 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing..
18:44:30 154.778427 T:1961185280 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing..
18:44:30 154.778595 T:1961185280 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing..
18:44:30 154.778839 T:1961185280 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing..
18:44:30 154.779297 T:1759507360 DEBUG: Thread JobWorker start, auto delete: true
18:44:30 154.779861 T:1961185280 DEBUG: CDirectoryProvider[addons://outdated/]: refreshing..
18:44:30 154.882339 T:1767895968 DEBUG: CAddonMgr::GetAvailableUpdates took 60 ms
18:44:30 154.939362 T:1767895968 DEBUG: CAddonMgr::GetAvailableUpdates took 56 ms
18:44:32 156.939850 T:1961185280 DEBUG: ProcessMouse: trying mouse action leftclick
18:44:32 156.940598 T:1961185280 DEBUG: Activating window ID: 10025
18:44:33 157.245544 T:1961185280 DEBUG: ------ Window Deinit (Custom_1100_AddonLauncher.xml) ------
18:44:33 157.309448 T:1961185280 DEBUG: ------ Window Init (MyVideoNav.xml) ------
18:44:33 157.309677 T:1961185280 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY
18:44:33 157.699860 T:1961185280 DEBUG: CDirectoryProvider[]: refreshing..
18:44:33 157.700439 T:1759507360 ERROR: GetDirectory - Error getting
18:44:33 157.700912 T:1961185280 DEBUG: CDirectoryProvider[]: refreshing..
18:44:33 157.701157 T:1873802144 ERROR: GetDirectory - Error getting
18:44:33 157.703262 T:1961185280 DEBUG: CGUIMediaWindow::GetDirectory (addons://sources/video/)
18:44:33 157.703506 T:1961185280 DEBUG: ParentPath = [addons://sources/video/]
18:44:33 157.721146 T:1606415264 DEBUG: Thread BackgroundLoader start, auto delete: false
18:44:33 157.743668 T:1606415264 DEBUG: Thread BackgroundLoader 1606415264 terminating
18:44:35 159.212112 T:1961185280 DEBUG: ProcessMouse: trying mouse action leftclick
18:44:35 159.215347 T:1961185280 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/)
18:44:35 159.215561 T:1961185280 DEBUG: ParentPath = [addons://sources/video]
18:44:35 159.229187 T:1767895968 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 14 ms
18:44:35 159.230072 T:1759507360 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','1','')
18:44:35 159.230835 T:1606415264 DEBUG: Thread LanguageInvoker start, auto delete: false
18:44:35 159.231155 T:1606415264 INFO: initializing python engine.
18:44:35 159.231293 T:1606415264 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing
18:44:35 159.306015 T:1606415264 DEBUG: -->Python Interpreter Initialized<--
18:44:35 159.306458 T:1606415264 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo.de/default.py"
18:44:35 159.307922 T:1606415264 DEBUG: CPythonInvoker(1, /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.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
18:44:35 159.308151 T:1606415264 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de
18:44:35 159.308395 T:1606415264 DEBUG: CPythonInvoker(1, /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
18:44:35 159.718552 T:1961185280 DEBUG: ------ Window Init (DialogBusy.xml) ------
18:44:36 160.152176 T:1606415264 DEBUG: true
18:44:36 160.184067 T:1606415264 INFO: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run
18:44:36 160.202316 T:1594880928 DEBUG: Thread BackgroundLoader start, auto delete: false
18:44:36 160.259430 T:1594880928 DEBUG: Thread BackgroundLoader 1594880928 terminating
18:44:36 160.274750 T:1606415264 INFO: Python script stopped
18:44:36 160.274994 T:1606415264 DEBUG: Thread LanguageInvoker 1606415264 terminating
18:44:36 160.418579 T:1961185280 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
18:45:05 189.229675 T:1873802144 DEBUG: Thread JobWorker 1873802144 terminating (autodelete)
18:45:05 189.230072 T:1767895968 DEBUG: Thread JobWorker 1767895968 terminating (autodelete)
18:45:06 190.184265 T:1759507360 DEBUG: Thread JobWorker 1759507360 terminating (autodelete)
18:45:25 209.923065 T:1961185280 DEBUG: ProcessMouse: trying mouse action leftclick
18:45:25 209.926193 T:1961185280 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listPage&page=movies)
18:45:25 209.926392 T:1961185280 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/]
18:45:25 209.926819 T:1759507360 DEBUG: Thread JobWorker start, auto delete: true
18:45:25 209.941681 T:1759507360 DEBUG: Previous line repeats 1 times.
18:45:25 209.941803 T:1759507360 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 15 ms
18:45:25 209.942108 T:1873802144 DEBUG: Thread JobWorker start, auto delete: true
18:45:25 209.942749 T:1767895968 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','2','?action=listPage&page=movies')
18:45:25 209.943161 T:1606415264 DEBUG: Thread LanguageInvoker start, auto delete: false
18:45:25 209.943405 T:1606415264 INFO: initializing python engine.
18:45:25 209.943512 T:1606415264 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing
18:45:25 209.992905 T:1606415264 DEBUG: -->Python Interpreter Initialized<--
18:45:25 209.993240 T:1606415264 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"
18:45:25 209.994308 T:1606415264 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.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
18:45:25 209.994461 T:1606415264 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de
18:45:25 209.994644 T:1606415264 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
18:45:26 210.430649 T:1961185280 DEBUG: ------ Window Init (DialogBusy.xml) ------
18:45:26 210.683884 T:1606415264 DEBUG: true
18:45:26 210.704178 T:1606415264 DEBUG: {'action': 'listPage', 'page': 'movies'}
18:45:26 210.926804 T:1606415264 INFO: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run
18:45:26 210.952576 T:1594880928 DEBUG: Thread BackgroundLoader start, auto delete: false
18:45:26 211.037796 T:1594880928 DEBUG: Thread BackgroundLoader 1594880928 terminating
18:45:26 211.042938 T:1606415264 INFO: Python script stopped
18:45:26 211.043259 T:1606415264 DEBUG: Thread LanguageInvoker 1606415264 terminating
18:45:27 211.154114 T:1961185280 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
18:45:30 214.406418 T:1961185280 DEBUG: ProcessMouse: trying mouse action leftclick
18:45:30 214.410233 T:1961185280 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listing&path=%2Fsg%2Fmultiplatform%2Fweb%2Fjson%2Fautomatic_listing%2Ffilm%2Fmostwatched%2F32.json)
18:45:30 214.410507 T:1961185280 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/?action=listPage&page=movies]
18:45:30 214.425064 T:1873802144 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 15 ms
18:45:30 214.425690 T:1767895968 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','3','?action=listing&path=%2Fsg%2Fmultiplatform%2Fweb%2Fjson%2Fautomatic_listing%2Ffilm%2Fmostwatched%2F32.json')
18:45:30 214.426193 T:1606415264 DEBUG: Thread LanguageInvoker start, auto delete: false
18:45:30 214.426453 T:1606415264 INFO: initializing python engine.
18:45:30 214.426559 T:1606415264 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing
18:45:30 214.477112 T:1606415264 DEBUG: -->Python Interpreter Initialized<--
18:45:30 214.477432 T:1606415264 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"
18:45:30 214.478409 T:1606415264 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.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
18:45:30 214.478546 T:1606415264 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de
18:45:30 214.478729 T:1606415264 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
18:45:30 214.915817 T:1961185280 DEBUG: ------ Window Init (DialogBusy.xml) ------
18:45:31 215.153152 T:1606415264 DEBUG: true
18:45:31 215.175125 T:1606415264 DEBUG: {'action': 'listing', 'path': '/sg/multiplatform/web/json/automatic_listing/film/mostwatched/32.json'}
18:45:35 219.310242 T:1606415264 INFO: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run
18:45:35 219.403030 T:1961185280 DEBUG: RunQuery took 0 ms for 5 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=2
18:45:35 219.421387 T:1594880928 DEBUG: Thread BackgroundLoader start, auto delete: false
18:45:35 219.436722 T:1606415264 INFO: Python script stopped
18:45:35 219.437057 T:1606415264 DEBUG: Thread LanguageInvoker 1606415264 terminating
18:45:35 219.550827 T:1594880928 DEBUG: Thread BackgroundLoader 1594880928 terminating
18:45:35 219.584366 T:1961185280 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
18:45:36 220.380096 T:1873802144 INFO: easy_aquire - Created session to https://www.skygo.sky.de
18:45:36 220.733170 T:1767895968 INFO: Previous line repeats 1 times.
18:45:36 220.733505 T:1767895968 DEBUG: CurlFile::Open(0x6fc12a20) https://www.skygo.sky.de/sg/bin/Asset/web/dvd_cover_748939.jpg
18:45:36 220.785172 T:1873802144 DEBUG: CurlFile::Open(0x7278c9a0) https://www.skygo.sky.de/bin/Picture/101/C_1_Picture_144784_hero_img.jpg
18:45:36 220.821167 T:1580725152 DEBUG: Thread JobWorker start, auto delete: true
18:45:36 220.959702 T:1759507360 DEBUG: ffmpeg[68DFF3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
18:45:36 220.984421 T:1759507360 DEBUG: DoWork - took 173 ms to load special://masterprofile/Thumbnails/2/22f9bbdb.jpg
18:45:37 221.250809 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x6fc75bd8
18:45:37 221.252640 T:1767895968 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16)
18:45:37 221.258133 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_encode input port 340 output port 341 m_handle 0x6fc00e10
18:45:37 221.260223 T:1767895968 DEBUG: COMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.image_encode) - port(341), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(81920) nBufferAlignmen(16)
18:45:37 221.276367 T:1767895968 DEBUG: COMXReEnc::ReEncode : https://www.skygo.sky.de/sg/bin/Asset/web/dvd_cover_748939.jpg 126x187 -> 126x187
18:45:37 221.279678 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x6fc75bd8
18:45:37 221.286407 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_encode handle 0x6fc00e10
18:45:37 221.310333 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x6fc00b10
18:45:37 221.311935 T:1767895968 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16)
18:45:37 221.316208 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x6fc00e10
18:45:37 221.318024 T:1767895968 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:45:37 221.326157 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x6fc00b10
18:45:37 221.328644 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x6fc00e10
18:45:37 221.329254 T:1961185280 DEBUG: ProcessMouse: trying mouse action leftclick
18:45:37 221.329437 T:1767895968 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/c/c89daec6.jpg 126x187
18:45:37 221.330093 T:1767895968 DEBUG: Fast Caching image 'https://www.skygo.sky.de/sg/bin/Asset/web/dvd_cover_748939.jpg' to 'c/c89daec6.jpg': 0x46f9a70
18:45:37 221.363098 T:1961185280 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?action=playVod&vod_id=751985
18:45:37 221.369308 T:1961185280 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','4','?action=playVod&vod_id=751985')
18:45:37 221.370087 T:1594880928 DEBUG: Thread LanguageInvoker start, auto delete: false
18:45:37 221.370438 T:1594880928 INFO: initializing python engine.
18:45:37 221.370590 T:1594880928 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing
18:45:37 221.393463 T:1606415264 DEBUG: Thread scriptobs start, auto delete: false
18:45:37 221.393799 T:1961178016 DEBUG: GetMovieId (plugin://plugin.video.skygo.de/?action=playVod&vod_id=751985), query = select idMovie from movie where idFile=2
18:45:37 221.395935 T:1961178016 DEBUG: GetEpisodeId (plugin://plugin.video.skygo.de/?action=playVod&vod_id=751985), query = select idEpisode from episode where idFile=2
18:45:37 221.398239 T:1961178016 DEBUG: GetMusicVideoId (plugin://plugin.video.skygo.de/?action=playVod&vod_id=751985), query = select idMVideo from musicvideo where idFile=2
18:45:37 221.405594 T:1961178016 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc
18:45:37 221.406174 T:1961178016 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd
18:45:37 221.447311 T:1594880928 DEBUG: -->Python Interpreter Initialized<--
18:45:37 221.447739 T:1594880928 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"
18:45:37 221.449112 T:1594880928 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.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
18:45:37 221.449341 T:1594880928 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de
18:45:37 221.449600 T:1594880928 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
18:45:37 221.522324 T:1873802144 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x727862b0
18:45:37 221.523758 T:1873802144 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(255296), nBufferAlignmen(16)
18:45:37 221.529846 T:1873802144 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x727234f0
18:45:37 221.532913 T:1873802144 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_encode input port 340 output port 341 m_handle 0x72785a78
18:45:37 221.535690 T:1873802144 DEBUG: COMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.image_encode) - port(341), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(921600) nBufferAlignmen(16)
18:45:37 221.590836 T:1961185280 DEBUG: ------ Window Init (DialogBusy.xml) ------
18:45:37 221.750244 T:1873802144 DEBUG: COMXReEnc::ReEncode : https://www.skygo.sky.de/bin/Picture/101/C_1_Picture_144784_hero_img.jpg 2048x1152 -> 1280x720
18:45:37 221.754837 T:1873802144 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x727862b0
18:45:37 221.756409 T:1873802144 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x727234f0
18:45:37 221.758728 T:1873802144 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_encode handle 0x72785a78
18:45:37 221.779770 T:1873802144 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x727862b0
18:45:37 221.781265 T:1873802144 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(127504), nBufferAlignmen(16)
18:45:37 221.798248 T:1873802144 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x72710388
18:45:37 221.801437 T:1873802144 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:45:37 221.828186 T:1873802144 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x727862b0
18:45:37 221.830078 T:1873802144 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x72710388
18:45:37 221.830475 T:1873802144 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/d/d1a9894b.jpg 1280x720
18:45:37 221.830856 T:1873802144 DEBUG: Fast Caching image 'https://www.skygo.sky.de/bin/Picture/101/C_1_Picture_144784_hero_img.jpg' to 'd/d1a9894b.jpg': 0x3f3f3c8
18:45:38 222.452057 T:1594880928 DEBUG: true
18:45:38 222.483215 T:1594880928 DEBUG: {'action': 'playVod', 'vod_id': '751985'}
18:45:39 223.189621 T:1594880928 DEBUG: {u'resultCode': u'S_218', u'resultMessage': u'KO'}
18:45:39 223.190170 T:1594880928 DEBUG: User not logged in or Session on other device
18:45:39 223.190506 T:1594880928 DEBUG: Session invalid - Customer Code not found in SilkCache
18:45:39 223.543823 T:1594880928 DEBUG: User still logged in
18:45:40 224.714600 T:1594880928 INFO: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run
18:45:40 224.729706 T:1606415264 DEBUG: Thread scriptobs 1606415264 terminating
18:45:40 224.730270 T:1961185280 INFO: easy_aquire - Created session to http://skywebvod-s.akamaihd.net
18:45:40 224.848175 T:1594880928 INFO: Python script stopped
18:45:40 224.848419 T:1594880928 DEBUG: Thread LanguageInvoker 1594880928 terminating
18:45:41 225.250244 T:1961185280 DEBUG: CCurlFile::GetMimeType - http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F02008140____100332001/F02008140____100332001.ism/Manifest -> text/xml
18:45:41 225.268402 T:1961185280 DEBUG: Loading settings for http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F02008140____100332001/F02008140____100332001.ism/Manifest
18:45:41 225.285660 T:1961185280 DEBUG: CPlayerCoreFactory::GetPlayers(http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F02008140____100332001/F02008140____100332001.ism/Manifest)
18:45:41 225.285843 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
18:45:41 225.285980 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
18:45:41 225.286041 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp
18:45:41 225.286240 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
18:45:41 225.286392 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
18:45:41 225.286591 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
18:45:41 225.286819 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
18:45:41 225.286987 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams
18:45:41 225.287064 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp
18:45:41 225.287201 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2
18:45:41 225.287338 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
18:45:41 225.287415 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
18:45:41 225.287537 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
18:45:41 225.287659 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
18:45:41 225.287781 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
18:45:41 225.287918 T:1961185280 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
18:45:41 225.288010 T:1961185280 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer)
18:45:41 225.288071 T:1961185280 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
18:45:41 225.288132 T:1961185280 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
18:45:41 225.288193 T:1961185280 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
18:45:41 225.294373 T:1961185280 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData
18:45:41 225.294769 T:1961185280 NOTICE: VideoPlayer: Opening: http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F02008140____100332001/F02008140____100332001.ism/Manifest
18:45:41 225.294861 T:1961185280 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
18:45:41 225.327530 T:1961185280 DEBUG: CCurlFile::GetMimeType - http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F02008140____100332001/F02008140____100332001.ism/Manifest -> text/xml
18:45:41 225.327774 T:1961185280 DEBUG: CMMALRenderer::CMMALRenderer
18:45:41 225.328171 T:1961185280 DEBUG: CMMALRenderer::UnInitMMAL
18:45:41 225.328278 T:1961185280 DEBUG: CMMALRenderer::PreInit
18:45:41 225.328369 T:1594880928 DEBUG: Thread MMALProcess start, auto delete: false
18:45:41 225.328461 T:1594880928 DEBUG: CMMALRenderer::Run - starting
18:45:41 225.328552 T:1606415264 DEBUG: Thread VideoPlayer start, auto delete: false
18:45:41 225.328857 T:1606415264 NOTICE: Creating InputStream
18:45:41 225.329132 T:1606415264 DEBUG: ADDON: Dll Initializing - InputStream SmoothStreamingMedia
18:45:41 225.329361 T:1606415264 DEBUG: SECTION:LoadDLL(/storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.3)
18:45:41 225.329498 T:1606415264 DEBUG: Loading: /storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.3
18:45:41 225.369522 T:1606415264 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: ADDON_Create()
18:45:41 225.369720 T:1606415264 INFO: AddOnLog: InputStream SmoothStreamingMedia: SetVideoResolution (1440 x 1080)
18:45:41 225.370148 T:1606415264 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Open()
18:45:41 225.370300 T:1606415264 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_data: [not shown]
18:45:41 225.370377 T:1606415264 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_key: [not shown]
18:45:41 225.370453 T:1606415264 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_type: com.widevine.alpha
18:45:41 225.371338 T:1606415264 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MAXRESOLUTION'
18:45:41 225.373428 T:1606415264 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'DECRYPTERPATH'
18:45:41 225.374557 T:1606415264 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Searching for decrypters in: /storage/.kodi/cdm
18:45:41 225.435623 T:1606415264 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Found decrypter: /storage/.kodi/cdm/libssd_wv.so
18:45:41 225.435837 T:1606415264 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Supported URN: urn:uuid:EDEF8BA9-79D6-4ACE-A3C8-27DCD51D21ED
18:45:41 225.436951 T:1606415264 DEBUG: CurlFile::Open(0x45c3f78) http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F02008140____100332001/F02008140____100332001.ism/Manifest
18:45:41 225.759750 T:1606415264 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Download http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F02008140____100332001/F02008140____100332001.ism/Manifest finished
18:45:41 225.760681 T:1606415264 INFO: AddOnLog: InputStream SmoothStreamingMedia: Successfully parsed .mpd file. Download speed: 0.0000 Bytes/s
18:45:41 225.760803 T:1606415264 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MINBANDWIDTH'
18:45:41 225.762039 T:1606415264 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MAXBANDWIDTH'
18:45:42 226.078613 T:1961185280 DEBUG: ------ Window Init (DialogBusy.xml) ------
18:45:42 226.938705 T:1606415264 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: CDMMessage: 1 arrived!
18:45:42 226.947296 T:1606415264 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Content-Type: '
18:45:42 226.947479 T:1606415264 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Expect: '
18:45:42 226.948120 T:1606415264 DEBUG: CurlFile::Open(0x44a4d50) https://wvguard.sky.de/WidevineLicenser/WidevineLicenser
18:45:42 226.948700 T:1606415264 INFO: easy_aquire - Created session to https://wvguard.sky.de
18:45:43 227.587799 T:1606415264 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 500
18:45:43 227.588287 T:1606415264 ERROR: CCurlFile::Open failed with code 500 for https://wvguard.sky.de/WidevineLicenser/WidevineLicenser|Content-Type&Expect&Referer=http%3A%2F%2Fwww.skygo.sky.de%2Ffilm%2Fscifi--fantasy%2Fjupiter-ascending%2Fasset%2Ffilmsection%2F144836.html&User-Agent=Mozilla%2F5.0%20(X11%3B%20Linux%20x86_64)%20AppleWebKit%2F537.36%20(KHTML%2C%20like%20Gecko)%20Chrome%2F49.0.2623.87%20Safari%2F537.36&acceptencoding=gzip%2C%20deflate&postdata=CAEStQwK5goIARLxCQq0AggCEhZDaHJvbWVDRE0tQ2hyb21lT1MtQVJNGIOnjo4FIo4CMIIBCgKCAQEAsDzo%2Bs1OMbZGG9XLnUcAbWMrn8nJ%2BZT%2F%2BmwUdgw8cZ1HXRKiz%2FikZDkcyD4dMUJ3bjxPXp20FcwRzoPc7wQwmX0r7Hu%2FAkMOJE5x0%2F7rIgNME1bX4BF4jvnxy9XV%2Fzl9k5%2FsAXuE7DmBw11JW57VoclFawW8R3f6C7j6jmntRdT%2FvjZQjW8c3xYZBfIUyNXTxPpjj%2Bak4Tag%2FOZe%2Bo7eUi3029%2F8SVPH2GYWz5%2B3%2BKs2a9VlEC9vvMU60x3Lj7FP8aN835PoLcBRJVj5zHpm6GouI4YjGovnqmwkkinK8ohLDZVi1Zvq4wyp%2Fc54qsxDzlAg7k467yzMyjE3gsWngQIDAQABKMYgEoACucqMKVKOLDtryRtyUSInJfLm0jvMHPkKc7aSXYFpqGDIxVZE3a8GAGaO66JCEXTA6%2FllCrfRoXxqN6MF49pIBtbo9fGrb2IBeVFkdki12vD8tp%2FL3QMOq21ajd7CdHDY2%2Bighodev47nLpLS6hi1ju6wlSsa%2B3TOtlDMYDCsN%2Ff7UZ73W8%2FIIcnWA%2BFwQlgXVfDL3ugKu8ox%2BbAkjCxknncBRpmloqssz%2FxHqTDDvIWWSsRMPMdSOz%2BfnJQEKD2H%2BJocrOKgY8NXq%2B8otI9wGPcrUX2WGF8PxnvqilHRL2eZ2lp%2BS9eecQkEXZLGbGTZoP2N%2Fv7NHHY5LxA6fAVZvRq0BQquAggBEhAcpx1ZtWZFgxSev3rSMoVEGJ2jjo4FIo4CMIIBCgKCAQEAyeoN9jjxNASFTiPyJymuFXSNkVeamh9Hzo31ofd1ROv%2F40hoc5M0V0rog0yCIRLz7WSuGCK6rrUgHRx%2FTEi7nIgeH5AhVVAjIJ9oHScsJgExrhWkjcOTU1mxhBeUBvPxUMYB912VKnZszV652zYjqMVCUCiv9OIFvqhCU7XFqvWzo31ki70eCOGshmT7uYLmzkFwixxJ6%2FdgO4cBNbMIzSlAXqCCzk3%2BriYu1nTqGXxFByGZ3x32lgD0rYO0kDSgHGW%2BvnXkCrMeLog37gdzcguPffjxZrmTm1UIvBhiOovPqHqZlGFyJtt1Kv9aTKoSYhu5I78FoMSecqvye%2FkMzQIDAQABKMYgEoADELzBNMGbeoR5XwyjUXoClZ8gCCEgUO2jxjzOfIBuC7NlNE9mH%2Flxv5KUduYoyT9AIqCd7%2BZd1Y7S46dsEQMaxtHTyiQXqq8PXLL0kFZi5KLgdVRFLYsBQHYfx3TnZCfo86B6blVwvfpQWq09FDNGbF7rYMx%2BPb78ljoJlTXDF2As%2FuzmNhHnKju8p6Y4qM42W7sit7pdkcqCCCbukSULLHGcXwYJnvT9BQsx5rPkewEAKA0g0dtF3xXXd8NBunT0hVP77f3F5PTAkdSwcb7dDcsB%2BMvcQdLYSMkrU6GMOT3cRMqkFEryx8zbfVAhQ8I%2BYcbPsQfrMqYA39L5LvY61MSAzG9XNfbdjPKPzcE5l%2FwbGQ1U3c0VT5NsQpkP%2Blyz%2BIP8lfUqTXxpLur76M8rEzUc94s3sWUFrKiXoWr7sGaEM9L8L2zTlFjstw8z%2FCtrQUtzzA2Tjf5Ocm0wYVMWUoUGCr3F%2B6ulLCUj3MWPHNwMSNle%2BXIEkEUtdBlAMOsfGhgKEWFyY2hpdGVjdHVyZV9uYW1lEgNhcm0aFgoMY29tcGFueV9uYW1lEgZHb29nbGUaFwoKbW9kZWxfbmFtZRIJQ2hyb21lQ0RNGhkKDXBsYXRmb3JtX25hbWUSCENocm9tZU9TMggIARAAGAAgARK%2FAQq8AQqlARIQUChsgHTSIUOHnveBcrWYBCKQAR5raWQ9ODA2YzI4NTAtZDI3NC00MzIxLTg3OWUtZjc4MTcyYjU5ODA0JnNlc3Npb25JZD1TRy03NDhkY2NhYS00OTNmLTQ3MjEtYTVmYi0zMjRmODlkY2RhMTAmYXBpeElkPTkzMDYyODI3JnBsYXRmb3JtSWQ9V0VCJnByb2R1Y3Q9QlcmY2hhbm5lbElkPRABGhCnZtFjWjN86IpzbCdmu98vGAEg1oq0wAUwFRqAAgyqQy6349hPCdokfoVeQAMvCC1%2FCgT0bYdLdkmbU8rDrFRf%2BevmdPJWpb3%2FeXmOk4aD488UQiPAWP%2FtxBs83IemcqiDHWTsBLoIMyoOC1tFOGpLlVnpFJspkQgoD%2FWeeuNdnrXPAiBMTBRoH31CbH6wx4hgYEWM03br31eGtcI%2FFQdbnEHDIBRbcfe82KSPNgBfFfTgsnpJ3qDzdHDxGxqyTV%2B3t5sz%2BP1JiRwKueYJl%2BpFsFDLNZ2TP74QcyboqVvwcU0IrlvYH%2FYqcq7seolzX4o%2FbNU0wDCAOLphAbpI9yr6gUeQVmawqlBCbYpPhGj4ulL%2BzgJC5zf73KEYKyM%3D&seekable=0
18:45:43 227.588730 T:1606415264 ERROR: AddOnLog: InputStream SmoothStreamingMedia: License server returned failure
18:45:43 227.588913 T:1606415264 ERROR: AddOnLog: InputStream SmoothStreamingMedia: Unable to generate a license
18:45:43 227.592911 T:1606415264 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: GetStreamIds()
18:45:43 227.593140 T:1606415264 ERROR: CVideoPlayer::OpenInputStream - error opening [http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F02008140____100332001/F02008140____100332001.ism/Manifest]
18:45:43 227.593246 T:1606415264 NOTICE: CVideoPlayer::OnExit()
18:45:43 227.593445 T:1606415264 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Close()
18:45:43 227.593552 T:1606415264 INFO: ADDON: Dll Stopped - InputStream SmoothStreamingMedia
18:45:43 227.593719 T:1606415264 DEBUG: OnPlayBackStopped: play state was 1, starting 1
18:45:43 227.593872 T:1606415264 DEBUG: Thread VideoPlayer 1606415264 terminating
18:45:43 227.594025 T:1961185280 DEBUG: OnPlayBackStopped: play state was 3, starting 0
18:45:43 227.594574 T:1961185280 ERROR: Playlist Player: skipping unplayable item: 0, path [plugin://plugin.video.skygo.de/?action=playVod&vod_id=751985]
18:45:43 227.594788 T:1961185280 DEBUG: Playlist Player: no more playable items... aborting playback
18:45:43 227.595840 T:1606415264 DEBUG: Thread BackgroundLoader start, auto delete: false
18:45:43 227.615936 T:1961185280 NOTICE: CVideoPlayer::CloseFile()
18:45:43 227.616211 T:1961185280 NOTICE: VideoPlayer: waiting for threads to exit
18:45:43 227.616348 T:1961185280 NOTICE: VideoPlayer: finished waiting
18:45:43 227.616516 T:1961185280 DEBUG: DeleteRenderer - deleting renderer
18:45:43 227.616684 T:1961185280 DEBUG: CMMALRenderer::~CMMALRenderer
18:45:43 227.616806 T:1961185280 DEBUG: CMMALRenderer::UnInitMMAL
18:45:43 227.617065 T:1594880928 DEBUG: CMMALRenderer::Run - stopping
18:45:43 227.617264 T:1594880928 DEBUG: Thread MMALProcess 1594880928 terminating
18:45:43 227.617432 T:1961185280 NOTICE: CVideoPlayer::CloseFile()
18:45:43 227.617554 T:1961185280 NOTICE: VideoPlayer: waiting for threads to exit
18:45:43 227.617752 T:1961185280 NOTICE: VideoPlayer: finished waiting
18:45:43 227.623047 T:1961185280 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData
18:45:43 227.644485 T:1961178016 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
18:45:43 227.645081 T:1961178016 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
18:45:43 227.755234 T:1606415264 DEBUG: Thread BackgroundLoader 1606415264 terminating
18:45:43 227.783905 T:1961185280 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
18:45:43 227.823502 T:1580725152 DEBUG: DoWork - Saving file state for video item plugin://plugin.video.skygo.de/?action=playVod&vod_id=751985
18:45:44 228.278824 T:1759507360 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x408ad38
18:45:44 228.280624 T:1759507360 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(127504), nBufferAlignmen(16)
18:45:44 228.280991 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x6fc12ce0
18:45:44 228.283752 T:1767895968 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16)
18:45:44 228.285980 T:1759507360 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x4129f10
18:45:44 228.287125 T:1759507360 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:45:44 228.317093 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x6fc7bc88
18:45:44 228.317337 T:1759507360 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x408ad38
18:45:44 228.319641 T:1759507360 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x4129f10
18:45:44 228.319855 T:1767895968 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:45:44 228.320129 T:1759507360 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/d/d1a9894b.jpg 1280x720
18:45:44 228.327835 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x6fc12ce0
18:45:44 228.330261 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x6fc7bc88
18:45:44 228.330811 T:1767895968 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/c/c89daec6.jpg 126x187
18:46:07 251.738632 T:1961185280 INFO: CheckIdle - Closing session to https://www.skygo.sky.de (easy=0x72711ab0, multi=0x727114b0)
18:46:07 251.755554 T:1961185280 INFO: CheckIdle - Closing session to https://www.skygo.sky.de (easy=0x6fc00fd0, multi=0x6fc00ea8)
18:46:11 255.877899 T:1961185280 INFO: CheckIdle - Closing session to http://skywebvod-s.akamaihd.net (easy=0x47b8af8, multi=0x45c3cf0)
18:46:13 257.956512 T:1961185280 INFO: CheckIdle - Closing session to https://wvguard.sky.de (easy=0x47a4d28, multi=0x4479818)
18:46:14 258.264557 T:1873802144 DEBUG: Thread JobWorker 1873802144 terminating (autodelete)
18:46:14 258.320557 T:1759507360 DEBUG: Thread JobWorker 1759507360 terminating (autodelete)
18:46:14 258.331299 T:1767895968 DEBUG: Thread JobWorker 1767895968 terminating (autodelete)
18:46:14 258.744202 T:1580725152 DEBUG: Thread JobWorker 1580725152 terminating (autodelete)
18:48:30 394.693115 T:1580725152 DEBUG: Thread JobWorker start, auto delete: true
18:48:30 394.718262 T:1580725152 DEBUG: Previous line repeats 1 times.
18:48:30 394.718506 T:1580725152 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x69ed0fe8
18:48:30 394.720245 T:1580725152 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(191584), nBufferAlignmen(16)
18:48:30 394.722046 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x69f56ac0
18:48:30 394.724152 T:1767895968 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16)
18:48:30 394.726227 T:1580725152 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x69e89150
18:48:30 394.727783 T:1580725152 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:48:30 394.761505 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x73c156f8
18:48:30 394.762054 T:1580725152 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x69ed0fe8
18:48:30 394.763367 T:1767895968 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:48:30 394.763763 T:1580725152 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x69e89150
18:48:30 394.764069 T:1580725152 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/2/22f9bbdb.jpg 1280x720
18:48:30 394.777466 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x69f56ac0
18:48:30 394.779266 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x73c156f8
18:48:30 394.779755 T:1767895968 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/2/2095fd99.jpg 126x187
18:48:30 394.809479 T:1580725152 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x69ed0fe8
18:48:30 394.810883 T:1580725152 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(123504), nBufferAlignmen(16)
18:48:30 394.811066 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x73c07e60
18:48:30 394.813141 T:1767895968 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16)
18:48:30 394.815460 T:1580725152 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x69e89150
18:48:30 394.816803 T:1580725152 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:48:30 394.845215 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x69f56ac0
18:48:30 394.845856 T:1580725152 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x69ed0fe8
18:48:30 394.847015 T:1767895968 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:48:30 394.847565 T:1580725152 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x69e89150
18:48:30 394.847961 T:1580725152 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/e/ef499a8d.jpg 1280x720
18:48:30 394.861145 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x73c07e60
18:48:30 394.862946 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x69f56ac0
18:48:30 394.863403 T:1767895968 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/d/db76d68d.jpg 126x187
18:48:31 395.251404 T:1580725152 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x69ed0fe8
18:48:31 395.252563 T:1580725152 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(130064), nBufferAlignmen(16)
18:48:31 395.252716 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x73c91cc8
18:48:31 395.254730 T:1767895968 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16)
18:48:31 395.257050 T:1580725152 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x69e89150
18:48:31 395.258148 T:1580725152 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:48:31 395.282959 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x73c07e60
18:48:31 395.283752 T:1580725152 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x69ed0fe8
18:48:31 395.284637 T:1767895968 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:48:31 395.285889 T:1580725152 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x69e89150
18:48:31 395.286224 T:1580725152 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/7/78055762.jpg 1280x720
18:48:31 395.292511 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x73c91cc8
18:48:31 395.294128 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x73c07e60
18:48:31 395.294495 T:1767895968 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/c/c8142a6b.jpg 126x187
18:48:31 395.315399 T:1580725152 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x69ed0fe8
18:48:31 395.316681 T:1580725152 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(143552), nBufferAlignmen(16)
18:48:31 395.316864 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x69f6d8a0
18:48:31 395.318634 T:1767895968 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16)
18:48:31 395.320831 T:1580725152 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x69e89150
18:48:31 395.321930 T:1580725152 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:48:31 395.350555 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x73c91cc8
18:48:31 395.351471 T:1580725152 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x69ed0fe8
18:48:31 395.351990 T:1767895968 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:48:31 395.353424 T:1580725152 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x69e89150
18:48:31 395.353760 T:1580725152 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/e/e2cd96a7.jpg 1280x720
18:48:31 395.364166 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x69f6d8a0
18:48:31 395.365967 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x73c91cc8
18:48:31 395.366364 T:1767895968 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/6/69989a14.jpg 126x187
18:48:31 395.486389 T:1580725152 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x69e89150
18:48:31 395.487885 T:1580725152 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(163072), nBufferAlignmen(16)
18:48:31 395.488159 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x69f6f3e8
18:48:31 395.490906 T:1767895968 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16)
18:48:31 395.492950 T:1580725152 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x69ed0fe8
18:48:31 395.494385 T:1580725152 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:48:31 395.522369 T:1580725152 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x69e89150
18:48:31 395.523041 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x69f6d8a0
18:48:31 395.524506 T:1580725152 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x69ed0fe8
18:48:31 395.524872 T:1580725152 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/8/8cb7b668.jpg 1280x720
18:48:31 395.525024 T:1767895968 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:48:31 395.531952 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x69f6f3e8
18:48:31 395.534302 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x69f6d8a0
18:48:31 395.534729 T:1767895968 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/e/e4ead114.jpg 126x187
18:48:31 395.710083 T:1580725152 INFO: easy_aquire - Created session to https://www.skygo.sky.de
18:48:32 396.075317 T:1767895968 INFO: Previous line repeats 1 times.
18:48:32 396.075623 T:1767895968 DEBUG: CurlFile::Open(0x69f6eaf0) https://www.skygo.sky.de/sg/bin/Asset/web/dvd_cover_751854.jpg
18:48:32 396.087311 T:1580725152 DEBUG: CurlFile::Open(0x69e8e7f8) https://www.skygo.sky.de/bin/Picture/89/C_1_Picture_148881_hero_img.jpg
18:48:32 396.123749 T:1961185280 DEBUG: ProcessMouse: trying mouse action leftclick
18:48:32 396.155304 T:1961185280 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?action=playVod&vod_id=751854
18:48:32 396.156158 T:1961178016 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
18:48:32 396.156403 T:1961178016 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
18:48:32 396.161804 T:1961185280 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','5','?action=playVod&vod_id=751854')
18:48:32 396.162537 T:1606415264 DEBUG: Thread LanguageInvoker start, auto delete: false
18:48:32 396.162933 T:1606415264 INFO: initializing python engine.
18:48:32 396.163055 T:1606415264 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing
18:48:32 396.183289 T:1873802144 DEBUG: Thread scriptobs start, auto delete: false
18:48:32 396.191528 T:1961178016 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc
18:48:32 396.191895 T:1961178016 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd
18:48:32 396.238037 T:1606415264 DEBUG: -->Python Interpreter Initialized<--
18:48:32 396.238495 T:1606415264 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"
18:48:32 396.239929 T:1606415264 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.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
18:48:32 396.240143 T:1606415264 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de
18:48:32 396.240417 T:1606415264 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
18:48:32 396.383453 T:1961185280 DEBUG: ------ Window Init (DialogBusy.xml) ------
18:48:32 396.565399 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x73c00728
18:48:32 396.567444 T:1767895968 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16)
18:48:32 396.585480 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_encode input port 340 output port 341 m_handle 0x69fa9df0
18:48:32 396.590118 T:1767895968 DEBUG: COMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.image_encode) - port(341), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(81920) nBufferAlignmen(16)
18:48:32 396.595856 T:1767895968 DEBUG: COMXReEnc::ReEncode : https://www.skygo.sky.de/sg/bin/Asset/web/dvd_cover_751854.jpg 126x187 -> 126x187
18:48:32 396.600830 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x73c00728
18:48:32 396.605530 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_encode handle 0x69fa9df0
18:48:32 396.612946 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x69fa9df0
18:48:32 396.615356 T:1767895968 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16)
18:48:32 396.622009 T:1767895968 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x73c10fc8
18:48:32 396.624756 T:1767895968 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:48:32 396.634094 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x69fa9df0
18:48:32 396.638428 T:1767895968 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x73c10fc8
18:48:32 396.639008 T:1767895968 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/8/8807a15d.jpg 126x187
18:48:32 396.639404 T:1767895968 DEBUG: Fast Caching image 'https://www.skygo.sky.de/sg/bin/Asset/web/dvd_cover_751854.jpg' to '8/8807a15d.jpg': 0x414c998
18:48:32 396.734192 T:1580725152 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x69e596b8
18:48:32 396.735626 T:1580725152 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(325744), nBufferAlignmen(16)
18:48:32 396.741638 T:1580725152 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x5d915a30
18:48:32 396.744598 T:1580725152 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_encode input port 340 output port 341 m_handle 0x69e59460
18:48:32 396.746368 T:1580725152 DEBUG: COMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.image_encode) - port(341), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(921600) nBufferAlignmen(16)
18:48:32 396.967438 T:1580725152 DEBUG: COMXReEnc::ReEncode : https://www.skygo.sky.de/bin/Picture/89/C_1_Picture_148881_hero_img.jpg 2048x1152 -> 1280x720
18:48:32 396.971802 T:1580725152 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x69e596b8
18:48:32 396.973419 T:1580725152 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x5d915a30
18:48:32 396.975800 T:1580725152 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_encode handle 0x69e59460
18:48:32 396.998688 T:1580725152 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x69e596b8
18:48:32 397.000366 T:1580725152 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(173488), nBufferAlignmen(16)
18:48:32 397.005005 T:1580725152 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x5d915a30
18:48:32 397.006409 T:1580725152 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16)
18:48:32 397.033630 T:1580725152 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x69e596b8
18:48:32 397.035706 T:1580725152 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x5d915a30
18:48:32 397.036133 T:1580725152 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/2/2df4a415.jpg 1280x720
18:48:32 397.036469 T:1580725152 DEBUG: Fast Caching image 'https://www.skygo.sky.de/bin/Picture/89/C_1_Picture_148881_hero_img.jpg' to '2/2df4a415.jpg': 0x46eebf8
18:48:33 397.267365 T:1606415264 DEBUG: true
18:48:33 397.295471 T:1606415264 DEBUG: {'action': 'playVod', 'vod_id': '751854'}
18:48:38 402.864166 T:1606415264 DEBUG: {u'resultCode': u'S_218', u'resultMessage': u'KO'}
18:48:38 402.864594 T:1606415264 DEBUG: User not logged in or Session on other device
18:48:38 402.867584 T:1606415264 DEBUG: Session invalid - Customer Code not found in SilkCache
18:48:39 403.478088 T:1606415264 DEBUG: User still logged in
18:48:40 404.090424 T:1606415264 INFO: CPythonInvoker(5, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run
18:48:40 404.109344 T:1873802144 DEBUG: Thread scriptobs 1873802144 terminating
18:48:40 404.110046 T:1961185280 INFO: easy_aquire - Created session to http://skywebvod-s.akamaihd.net
18:48:40 404.224335 T:1961185280 DEBUG: CCurlFile::GetMimeType - http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051750____100332001/F30051750____100332001.ism/Manifest -> text/xml
18:48:40 404.255920 T:1961185280 DEBUG: Loading settings for http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051750____100332001/F30051750____100332001.ism/Manifest
18:48:40 404.263062 T:1606415264 INFO: Python script stopped
18:48:40 404.263428 T:1606415264 DEBUG: Thread LanguageInvoker 1606415264 terminating
18:48:40 404.283386 T:1961185280 DEBUG: CPlayerCoreFactory::GetPlayers(http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051750____100332001/F30051750____100332001.ism/Manifest)
18:48:40 404.283600 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
18:48:40 404.283783 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
18:48:40 404.283875 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp
18:48:40 404.284149 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
18:48:40 404.284363 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
18:48:40 404.284576 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
18:48:40 404.284760 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
18:48:40 404.285004 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams
18:48:40 404.285187 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp
18:48:40 404.285400 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2
18:48:40 404.285583 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
18:48:40 404.285706 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
18:48:40 404.285858 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
18:48:40 404.286072 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
18:48:40 404.286255 T:1961185280 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
18:48:40 404.286499 T:1961185280 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
18:48:40 404.286682 T:1961185280 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer)
18:48:40 404.286774 T:1961185280 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
18:48:40 404.286896 T:1961185280 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
18:48:40 404.286987 T:1961185280 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
18:48:40 404.295227 T:1961185280 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData
18:48:40 404.295685 T:1961185280 NOTICE: VideoPlayer: Opening: http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051750____100332001/F30051750____100332001.ism/Manifest
18:48:40 404.295807 T:1961185280 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
18:48:40 404.333618 T:1961185280 DEBUG: CCurlFile::GetMimeType - http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051750____100332001/F30051750____100332001.ism/Manifest -> text/xml
18:48:40 404.333893 T:1961185280 DEBUG: CMMALRenderer::CMMALRenderer
18:48:40 404.334167 T:1961185280 DEBUG: CMMALRenderer::UnInitMMAL
18:48:40 404.334290 T:1606415264 DEBUG: Thread MMALProcess start, auto delete: false
18:48:40 404.334442 T:1606415264 DEBUG: CMMALRenderer::Run - starting
18:48:40 404.334595 T:1961185280 DEBUG: CMMALRenderer::PreInit
18:48:40 404.334930 T:1873802144 DEBUG: Thread VideoPlayer start, auto delete: false
18:48:40 404.335358 T:1873802144 NOTICE: Creating InputStream
18:48:40 404.335815 T:1873802144 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: ADDON_Destroy()
18:48:40 404.336823 T:1873802144 DEBUG: SECTION:UnloadDll(/storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.3)
18:48:40 404.337830 T:1873802144 INFO: ADDON: Dll Destroyed - InputStream SmoothStreamingMedia
18:48:40 404.337982 T:1873802144 DEBUG: ADDON: Dll Initializing - InputStream SmoothStreamingMedia
18:48:40 404.338287 T:1873802144 DEBUG: SECTION:LoadDLL(/storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.3)
18:48:40 404.338501 T:1873802144 DEBUG: Loading: /storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.3
18:48:40 404.391785 T:1873802144 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: ADDON_Create()
18:48:40 404.392090 T:1873802144 INFO: AddOnLog: InputStream SmoothStreamingMedia: SetVideoResolution (1440 x 1080)
18:48:40 404.392548 T:1873802144 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Open()
18:48:40 404.392761 T:1873802144 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_data: [not shown]
18:48:40 404.392853 T:1873802144 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_key: [not shown]
18:48:40 404.392975 T:1873802144 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_type: com.widevine.alpha
18:48:40 404.394104 T:1873802144 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MAXRESOLUTION'
18:48:40 404.395905 T:1873802144 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'DECRYPTERPATH'
18:48:40 404.397583 T:1873802144 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Searching for decrypters in: /storage/.kodi/cdm
18:48:40 404.448883 T:1873802144 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Found decrypter: /storage/.kodi/cdm/libssd_wv.so
18:48:40 404.449188 T:1873802144 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Supported URN: urn:uuid:EDEF8BA9-79D6-4ACE-A3C8-27DCD51D21ED
18:48:40 404.450745 T:1873802144 DEBUG: CurlFile::Open(0x73b7cae8) http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051750____100332001/F30051750____100332001.ism/Manifest
18:48:40 404.850586 T:1873802144 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Download http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051750____100332001/F30051750____100332001.ism/Manifest finished
18:48:40 404.852112 T:1873802144 INFO: AddOnLog: InputStream SmoothStreamingMedia: Successfully parsed .mpd file. Download speed: 0.0000 Bytes/s
18:48:40 404.852264 T:1873802144 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MINBANDWIDTH'
18:48:40 404.854126 T:1873802144 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MAXBANDWIDTH'
18:48:41 405.085083 T:1961185280 DEBUG: ------ Window Init (DialogBusy.xml) ------
18:48:42 406.269653 T:1873802144 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: CDMMessage: 1 arrived!
18:48:42 406.275574 T:1873802144 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Content-Type: '
18:48:42 406.275757 T:1873802144 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Expect: '
18:48:42 406.276764 T:1873802144 DEBUG: CurlFile::Open(0x73b87180) https://wvguard.sky.de/WidevineLicenser/WidevineLicenser
18:48:42 406.277588 T:1873802144 INFO: easy_aquire - Created session to https://wvguard.sky.de
18:48:42 407.053589 T:1873802144 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 500
18:48:42 407.053986 T:1873802144 ERROR: CCurlFile::Open failed with code 500 for https://wvguard.sky.de/WidevineLicenser/WidevineLicenser|Content-Type&Expect&Referer=http%3A%2F%2Fwww.skygo.sky.de%2Ffilm%2Fscifi--fantasy%2Fjupiter-ascending%2Fasset%2Ffilmsection%2F144836.html&User-Agent=Mozilla%2F5.0%20(X11%3B%20Linux%20x86_64)%20AppleWebKit%2F537.36%20(KHTML%2C%20like%20Gecko)%20Chrome%2F49.0.2623.87%20Safari%2F537.36&acceptencoding=gzip%2C%20deflate&postdata=CAEStQwK5goIARLxCQq0AggCEhZDaHJvbWVDRE0tQ2hyb21lT1MtQVJNGIOnjo4FIo4CMIIBCgKCAQEAsDzo%2Bs1OMbZGG9XLnUcAbWMrn8nJ%2BZT%2F%2BmwUdgw8cZ1HXRKiz%2FikZDkcyD4dMUJ3bjxPXp20FcwRzoPc7wQwmX0r7Hu%2FAkMOJE5x0%2F7rIgNME1bX4BF4jvnxy9XV%2Fzl9k5%2FsAXuE7DmBw11JW57VoclFawW8R3f6C7j6jmntRdT%2FvjZQjW8c3xYZBfIUyNXTxPpjj%2Bak4Tag%2FOZe%2Bo7eUi3029%2F8SVPH2GYWz5%2B3%2BKs2a9VlEC9vvMU60x3Lj7FP8aN835PoLcBRJVj5zHpm6GouI4YjGovnqmwkkinK8ohLDZVi1Zvq4wyp%2Fc54qsxDzlAg7k467yzMyjE3gsWngQIDAQABKMYgEoACucqMKVKOLDtryRtyUSInJfLm0jvMHPkKc7aSXYFpqGDIxVZE3a8GAGaO66JCEXTA6%2FllCrfRoXxqN6MF49pIBtbo9fGrb2IBeVFkdki12vD8tp%2FL3QMOq21ajd7CdHDY2%2Bighodev47nLpLS6hi1ju6wlSsa%2B3TOtlDMYDCsN%2Ff7UZ73W8%2FIIcnWA%2BFwQlgXVfDL3ugKu8ox%2BbAkjCxknncBRpmloqssz%2FxHqTDDvIWWSsRMPMdSOz%2BfnJQEKD2H%2BJocrOKgY8NXq%2B8otI9wGPcrUX2WGF8PxnvqilHRL2eZ2lp%2BS9eecQkEXZLGbGTZoP2N%2Fv7NHHY5LxA6fAVZvRq0BQquAggBEhAcpx1ZtWZFgxSev3rSMoVEGJ2jjo4FIo4CMIIBCgKCAQEAyeoN9jjxNASFTiPyJymuFXSNkVeamh9Hzo31ofd1ROv%2F40hoc5M0V0rog0yCIRLz7WSuGCK6rrUgHRx%2FTEi7nIgeH5AhVVAjIJ9oHScsJgExrhWkjcOTU1mxhBeUBvPxUMYB912VKnZszV652zYjqMVCUCiv9OIFvqhCU7XFqvWzo31ki70eCOGshmT7uYLmzkFwixxJ6%2FdgO4cBNbMIzSlAXqCCzk3%2BriYu1nTqGXxFByGZ3x32lgD0rYO0kDSgHGW%2BvnXkCrMeLog37gdzcguPffjxZrmTm1UIvBhiOovPqHqZlGFyJtt1Kv9aTKoSYhu5I78FoMSecqvye%2FkMzQIDAQABKMYgEoADELzBNMGbeoR5XwyjUXoClZ8gCCEgUO2jxjzOfIBuC7NlNE9mH%2Flxv5KUduYoyT9AIqCd7%2BZd1Y7S46dsEQMaxtHTyiQXqq8PXLL0kFZi5KLgdVRFLYsBQHYfx3TnZCfo86B6blVwvfpQWq09FDNGbF7rYMx%2BPb78ljoJlTXDF2As%2FuzmNhHnKju8p6Y4qM42W7sit7pdkcqCCCbukSULLHGcXwYJnvT9BQsx5rPkewEAKA0g0dtF3xXXd8NBunT0hVP77f3F5PTAkdSwcb7dDcsB%2BMvcQdLYSMkrU6GMOT3cRMqkFEryx8zbfVAhQ8I%2BYcbPsQfrMqYA39L5LvY61MSAzG9XNfbdjPKPzcE5l%2FwbGQ1U3c0VT5NsQpkP%2Blyz%2BIP8lfUqTXxpLur76M8rEzUc94s3sWUFrKiXoWr7sGaEM9L8L2zTlFjstw8z%2FCtrQUtzzA2Tjf5Ocm0wYVMWUoUGCr3F%2B6ulLCUj3MWPHNwMSNle%2BXIEkEUtdBlAMOsfGhgKEWFyY2hpdGVjdHVyZV9uYW1lEgNhcm0aFgoMY29tcGFueV9uYW1lEgZHb29nbGUaFwoKbW9kZWxfbmFtZRIJQ2hyb21lQ0RNGhkKDXBsYXRmb3JtX25hbWUSCENocm9tZU9TMggIARAAGAAgARK%2FAQq8AQqlARIQj0eJRxRkwEGw%2BQeqkcXL3iKQAR5raWQ9NDc4OTQ3OGYtNjQxNC00MWMwLWIwZjktMDdhYTkxYzVjYmRlJnNlc3Npb25JZD1TRy02NjEyYzc5MS00ZDViLTQ1OTktYWVhMS1hOTc4NDYzODQzODcmYXBpeElkPTkzMDYyODA2JnBsYXRmb3JtSWQ9V0VCJnByb2R1Y3Q9QlcmY2hhbm5lbElkPRABGhCNAM9ka7xxjrpE6aum2kTQGAEgiYy0wAUwFRqAAlomB1XilEH32sCqbBogNkK7jgl93dP9hDwZ94kqB9GX%2F6K5Bpzt2aGT03JRyZzJU61vTvhZ9QSUFhs8FwpxLHcGoKIxF%2FDJd4kQnZBGS9oKWzhftgflR1ExEQBXKI5wj5dOecueWB9MkjYZMfynlbXeYFD6d2D9m6v4R43tDnDjviuabnx6duSKc8YAfKp0zgSUNUalV382aA0k6yghMjKA%2FnDV%2B9K5Gh06dKuul0mJZVho4bgFsqjzU%2FcTWdWQ09qBy3s7juZ8hIlLALqmlvrXcfVjBB0uzH8jku76VV4ZNoB9EnmH0NbIbumEh7EhU79JvQqzhVDiZeF7eTNr3yA%3D&seekable=0
18:48:42 407.054321 T:1873802144 ERROR: AddOnLog: InputStream SmoothStreamingMedia: License server returned failure
18:48:42 407.054474 T:1873802144 ERROR: AddOnLog: InputStream SmoothStreamingMedia: Unable to generate a license
18:48:42 407.058411 T:1873802144 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: GetStreamIds()
18:48:42 407.058594 T:1873802144 ERROR: CVideoPlayer::OpenInputStream - error opening [http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051750____100332001/F30051750____100332001.ism/Manifest]
18:48:42 407.058685 T:1873802144 NOTICE: CVideoPlayer::OnExit()
18:48:42 407.058777 T:1873802144 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Close()
18:48:42 407.058838 T:1873802144 INFO: ADDON: Dll Stopped - InputStream SmoothStreamingMedia
18:48:42 407.058960 T:1873802144 DEBUG: OnPlayBackStopped: play state was 1, starting 1
18:48:42 407.059082 T:1873802144 DEBUG: Thread VideoPlayer 1873802144 terminating
18:48:42 407.059265 T:1961185280 DEBUG: OnPlayBackStopped: play state was 3, starting 0
18:48:42 407.059753 T:1961185280 ERROR: Playlist Player: skipping unplayable item: 0, path [plugin://plugin.video.skygo.de/?action=playVod&vod_id=751854]
18:48:42 407.059998 T:1961185280 DEBUG: Playlist Player: one or more items failed to play... aborting playback
18:48:42 407.060150 T:1961185280 DEBUG: ------ Window Init (DialogConfirm.xml) ------
18:48:42 407.060272 T:1961185280 INFO: Loading skin file: DialogConfirm.xml, load type: KEEP_IN_MEMORY
18:48:43 407.075958 T:1961185280 NOTICE: CVideoPlayer::CloseFile()
18:48:43 407.076202 T:1961185280 NOTICE: VideoPlayer: waiting for threads to exit
18:48:43 407.076324 T:1961185280 NOTICE: VideoPlayer: finished waiting
18:48:43 407.076447 T:1961185280 DEBUG: DeleteRenderer - deleting renderer
18:48:43 407.076508 T:1961185280 DEBUG: CMMALRenderer::~CMMALRenderer
18:48:43 407.076660 T:1961185280 DEBUG: CMMALRenderer::UnInitMMAL
18:48:43 407.076843 T:1606415264 DEBUG: CMMALRenderer::Run - stopping
18:48:43 407.076996 T:1606415264 DEBUG: Thread MMALProcess 1606415264 terminating
18:48:43 407.077118 T:1961185280 NOTICE: CVideoPlayer::CloseFile()
18:48:43 407.077209 T:1961185280 NOTICE: VideoPlayer: waiting for threads to exit
18:48:43 407.077301 T:1961185280 NOTICE: VideoPlayer: finished waiting
18:48:43 407.081024 T:1961185280 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData
18:48:43 407.083588 T:1961178016 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
18:48:43 407.083832 T:1961178016 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
18:48:43 407.308472 T:1961185280 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
18:48:43 407.440399 T:1767895968 DEBUG: DoWork - Saving file state for video item plugin://plugin.video.skygo.de/?action=playVod&vod_id=751854
18:49:02 426.715515 T:1961185280 INFO: CheckIdle - Closing session to https://www.skygo.sky.de (easy=0x73c967e8, multi=0x5e462828)
18:49:03 427.244781 T:1961185280 INFO: CheckIdle - Closing session to https://www.skygo.sky.de (easy=0x5d9227d8, multi=0x69e8dea0)
18:49:10 434.985504 T:1961185280 INFO: CheckIdle - Closing session to http://skywebvod-s.akamaihd.net (easy=0x47035b0, multi=0x73b593f0)
18:49:13 437.440216 T:1580725152 DEBUG: Thread JobWorker 1580725152 terminating (autodelete)
18:49:13 437.537628 T:1767895968 DEBUG: Thread JobWorker 1767895968 terminating (autodelete)
18:49:13 437.561249 T:1961185280 INFO: CheckIdle - Closing session to https://wvguard.sky.de (easy=0x73b6f450, multi=0x73bd94a8)