15:11:45.059 T:1961996288 NOTICE: special://profile/ is mapped to: special://masterprofile/ 15:11:45.059 T:1961996288 NOTICE: ----------------------------------------------------------------------- 15:11:45.059 T:1961996288 NOTICE: Starting Kodi (17.0-BETA6 Git:654f1b7). Platform: Linux ARM 32-bit 15:11:45.059 T:1961996288 NOTICE: Using Release Kodi x32 build (version for Raspberry Pi) 15:11:45.059 T:1961996288 NOTICE: Kodi compiled Dec 5 2016 by GCC 6.2.0 for Linux ARM 32-bit version 4.8.12 (264204) 15:11:45.059 T:1961996288 NOTICE: Running on LibreELEC (community) - Version: 7.90.009 8.0, kernel: Linux ARM 32-bit version 4.8.12 15:11:45.059 T:1961996288 NOTICE: FFmpeg version/source: ffmpeg-3.1-kodi 15:11:45.059 T:1961996288 NOTICE: Host CPU: ARMv7 Processor rev 4 (v7l), 4 cores available 15:11:45.059 T:1961996288 NOTICE: ARM Features: Neon enabled 15:11:45.059 T:1961996288 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi/ 15:11:45.059 T:1961996288 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi 15:11:45.059 T:1961996288 NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons 15:11:45.059 T:1961996288 NOTICE: special://masterprofile/ is mapped to: /storage/.kodi/userdata 15:11:45.059 T:1961996288 NOTICE: special://envhome/ is mapped to: /storage 15:11:45.059 T:1961996288 NOTICE: special://home/ is mapped to: /storage/.kodi 15:11:45.059 T:1961996288 NOTICE: special://temp/ is mapped to: /storage/.kodi/temp 15:11:45.059 T:1961996288 NOTICE: special://logpath/ is mapped to: /storage/.kodi/temp 15:11:45.060 T:1961996288 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin 15:11:45.060 T:1961996288 NOTICE: Local hostname: raspiKodi 15:11:45.060 T:1961996288 NOTICE: Log File is located: /storage/.kodi/temp//kodi.log 15:11:45.074 T:1961996288 NOTICE: ----------------------------------------------------------------------- 15:11:45.207 T:1961996288 ERROR: DBus: Error org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files 15:11:45.215 T:1961996288 NOTICE: load settings... 15:11:45.336 T:1961996288 NOTICE: Found 2 Lists of Devices 15:11:45.336 T:1961996288 NOTICE: Enumerated PI devices: 15:11:45.336 T:1961996288 NOTICE: Device 1 15:11:45.336 T:1961996288 NOTICE: m_deviceName : HDMI 15:11:45.336 T:1961996288 NOTICE: m_displayName : HDMI 15:11:45.336 T:1961996288 NOTICE: m_displayNameExtra: 15:11:45.336 T:1961996288 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 15:11:45.336 T:1961996288 NOTICE: m_channels : FL,FR 15:11:45.336 T:1961996288 NOTICE: m_sampleRates : 8000,11025,16000,22050,24000,32000,44100,48000,88200,96000,176400,192000 15:11:45.336 T:1961996288 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 15:11:45.336 T:1961996288 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 15:11:45.337 T:1961996288 NOTICE: Device 2 15:11:45.337 T:1961996288 NOTICE: m_deviceName : Analogue 15:11:45.337 T:1961996288 NOTICE: m_displayName : Analogue 15:11:45.337 T:1961996288 NOTICE: m_displayNameExtra: 15:11:45.337 T:1961996288 NOTICE: m_deviceType : AE_DEVTYPE_PCM 15:11:45.337 T:1961996288 NOTICE: m_channels : FL,FR 15:11:45.337 T:1961996288 NOTICE: m_sampleRates : 48000 15:11:45.337 T:1961996288 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 15:11:45.337 T:1961996288 NOTICE: m_streamTypes : No passthrough capabilities 15:11:45.337 T:1961996288 NOTICE: Device 3 15:11:45.337 T:1961996288 NOTICE: m_deviceName : Both 15:11:45.337 T:1961996288 NOTICE: m_displayName : HDMI and Analogue 15:11:45.337 T:1961996288 NOTICE: m_displayNameExtra: 15:11:45.337 T:1961996288 NOTICE: m_deviceType : AE_DEVTYPE_PCM 15:11:45.337 T:1961996288 NOTICE: m_channels : FL,FR 15:11:45.337 T:1961996288 NOTICE: m_sampleRates : 48000 15:11:45.337 T:1961996288 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 15:11:45.337 T:1961996288 NOTICE: m_streamTypes : No passthrough capabilities 15:11:45.337 T:1961996288 NOTICE: Enumerated PULSE devices: 15:11:45.337 T:1961996288 NOTICE: Device 1 15:11:45.337 T:1961996288 NOTICE: m_deviceName : Default 15:11:45.337 T:1961996288 NOTICE: m_displayName : Default 15:11:45.337 T:1961996288 NOTICE: m_displayNameExtra: Bluetooth Audio (PULSEAUDIO) 15:11:45.337 T:1961996288 NOTICE: m_deviceType : AE_DEVTYPE_PCM 15:11:45.337 T:1961996288 NOTICE: m_channels : FL,FR 15:11:45.337 T:1961996288 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000 15:11:45.337 T:1961996288 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT 15:11:45.337 T:1961996288 NOTICE: m_streamTypes : No passthrough capabilities 15:11:45.364 T:1961996288 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml 15:11:45.371 T:1961996288 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are... false 720 540 30 15:11:45.372 T:1961996288 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 15:11:45.372 T:1961996288 NOTICE: Default Video Player: VideoPlayer 15:11:45.372 T:1961996288 NOTICE: Default Audio Player: paplayer 15:11:45.373 T:1961996288 NOTICE: Enabled debug logging due to GUI setting (2) 15:11:45.373 T:1961996288 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 15:11:45.373 T:1961996288 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml 15:11:45.374 T:1961996288 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 15:11:45.375 T:1961996288 DEBUG: CPlayerCoreConfig::: created player VideoPlayer 15:11:45.375 T:1961996288 DEBUG: CPlayerCoreConfig::: created player PAPlayer 15:11:45.375 T:1961996288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules 15:11:45.375 T:1961996288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mms/udp 15:11:45.375 T:1961996288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout 15:11:45.375 T:1961996288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp 15:11:45.375 T:1961996288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp 15:11:45.376 T:1961996288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams 15:11:45.376 T:1961996288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp 15:11:45.376 T:1961996288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2 15:11:45.376 T:1961996288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd 15:11:45.376 T:1961996288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage 15:11:45.376 T:1961996288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf 15:11:45.376 T:1961996288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv 15:11:45.376 T:1961996288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio 15:11:45.376 T:1961996288 NOTICE: Loaded playercorefactory configuration 15:11:45.376 T:1961996288 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 15:11:45.376 T:1961996288 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 15:11:45.394 T:1961996288 INFO: creating subdirectories 15:11:45.394 T:1961996288 INFO: userdata folder: special://masterprofile/ 15:11:45.394 T:1961996288 INFO: recording folder: 15:11:45.394 T:1961996288 INFO: screenshots folder: /storage/screenshots/ 15:11:45.487 T:1961996288 NOTICE: Running database version Addons26 15:11:45.487 T:1961996288 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcpluff-arm.so) 15:11:45.487 T:1961996288 DEBUG: Loading: /usr/lib/kodi/system/libcpluff-arm.so 15:11:45.665 T:1961996288 INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/kodi/addons: No such file or directory' 15:11:45.665 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.' 15:11:45.665 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been installed.' 15:11:45.665 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in resource.images.weathericons.default has been installed.' 15:11:45.665 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.audioencoder has been installed.' 15:11:45.665 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.' 15:11:45.665 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.' 15:11:45.665 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in kodi.audiodecoder has been installed.' 15:11:45.665 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in kodi.peripheral has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in kodi.guilib has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in peripheral.joystick has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in kodi.adsp has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.wma has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in repository.johtru.com has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in game.controller.default has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in service.libreelec.settings has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in repository.kodinerds_RPi2 has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in kodi.game has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in kodi.resource has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in os.openelec.tv has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in inputstream.adaptive has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in repository.kodi.game has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in metadata.musicvideos.theaudiodb.com has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in os.libreelec.tv has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in script.module.requests has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in kodi.inputstream has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in repository.libreelec.tv has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.aac has been installed.' 15:11:45.666 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in script.module.routing has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in resource.language.en_gb has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.skygo.de has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in metadata.local has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.webinterface has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in resource.language.fi_fi has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in resource.uisounds.kodi has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in resource.language.de_de has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.codec has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Plug-in skin.estuary has been installed.' 15:11:45.667 T:1961996288 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.' 15:11:45.695 T:1874850720 DEBUG: Thread JobWorker start, auto delete: true 15:11:45.708 T:1961996288 NOTICE: ADDONS: Using repository repository.xbmc.org 15:11:45.708 T:1961996288 NOTICE: ADDONS: Using repository repository.johtru.com 15:11:45.708 T:1961996288 NOTICE: ADDONS: Using repository repository.kodinerds_RPi2 15:11:45.708 T:1961996288 NOTICE: ADDONS: Using repository repository.kodi.game 15:11:45.708 T:1961996288 NOTICE: ADDONS: Using repository repository.libreelec.tv 15:11:45.712 T:1961996288 DEBUG: ADDON: Dll Initializing - InputStream Adaptive 15:11:45.712 T:1961996288 DEBUG: SECTION:LoadDLL(/storage/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.1.0.4) 15:11:45.712 T:1961996288 DEBUG: Loading: /storage/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.1.0.4 15:11:45.771 T:1961996288 DEBUG: AddOnLog: InputStream Adaptive: libXBMC_addon successfully loaded 15:11:45.774 T:1961996288 DEBUG: AddOnLog: InputStream Adaptive: ADDON_Create() 15:11:45.774 T:1961996288 DEBUG: AddOnLog: InputStream Adaptive: ADDON_Destroy() 15:11:45.775 T:1961996288 DEBUG: SECTION:UnloadDll(/storage/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.1.0.4) 15:11:45.775 T:1961996288 INFO: ADDON: Dll Destroyed - InputStream Adaptive 15:11:45.779 T:1940747168 DEBUG: Thread ActiveAE start, auto delete: false 15:11:45.779 T:1930425248 DEBUG: Thread AESink start, auto delete: false 15:11:45.779 T:1930425248 INFO: CActiveAESink::OpenSink - initialize sink 15:11:45.779 T:1930425248 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 15:11:45.779 T:1930425248 DEBUG: DllBcm: Using omx system library 15:11:45.781 T:1930425248 DEBUG: SECTION:LoadDLL(libopenmaxil.so) 15:11:45.783 T:1930425248 DEBUG: Loading: libopenmaxil.so 15:11:45.787 T:1858073504 DEBUG: Thread CRBPWorker start, auto delete: false 15:11:45.787 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 15:11:45.787 T:1930425248 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI 15:11:45.788 T:1930425248 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x72701b98 15:11:45.789 T:1930425248 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignmen(16) 15:11:45.789 T:1930425248 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 15:11:45.789 T:1930425248 DEBUG: Output Device : HDMI 15:11:45.789 T:1930425248 DEBUG: Sample Rate : 44100 15:11:45.789 T:1930425248 DEBUG: Sample Format : AE_FMT_FLOAT 15:11:45.789 T:1930425248 DEBUG: Channel Count : 2 15:11:45.789 T:1930425248 DEBUG: Channel Layout: FL,FR 15:11:45.789 T:1930425248 DEBUG: Frames : 2205 15:11:45.789 T:1930425248 DEBUG: Frame Size : 8 15:11:45.794 T:1849684896 DEBUG: Thread RemoteControl start, auto delete: false 15:11:45.794 T:1849684896 INFO: LIRC Process: using: /run/lirc/lircd 15:11:45.794 T:1849684896 INFO: LIRC Connect: successfully started 15:11:45.794 T:1849684896 DEBUG: Thread RemoteControl 1849684896 terminating 15:11:45.801 T:1961996288 INFO: CKeyboardLayoutManager: loading keyboard layouts from special://xbmc/system/keyboardlayouts... 15:11:45.807 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Arabic QWERTY" successfully loaded 15:11:45.809 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian ЯВЕРТЪ" successfully loaded 15:11:45.809 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian АБВ" successfully loaded 15:11:45.810 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BasePY" successfully loaded 15:11:45.811 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BaiduPY" successfully loaded 15:11:45.812 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Czech QWERTZ" successfully loaded 15:11:45.813 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Danish QWERTY" successfully loaded 15:11:45.814 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "English QWERTY" successfully loaded 15:11:45.814 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "English AZERTY" successfully loaded 15:11:45.815 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "English ABC" successfully loaded 15:11:45.816 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "French AZERTY" successfully loaded 15:11:45.817 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "German QWERTZ" successfully loaded 15:11:45.818 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Greek QWERTY" successfully loaded 15:11:45.819 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew QWERTY" successfully loaded 15:11:45.819 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew ABC" successfully loaded 15:11:45.820 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Hungarian QWERTZ" successfully loaded 15:11:45.821 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Italian QWERTY" successfully loaded 15:11:45.822 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Korean ㄱㄴㄷ" successfully loaded 15:11:45.823 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian AZERTY" successfully loaded 15:11:45.824 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian QWERTY" successfully loaded 15:11:45.824 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Norwegian QWERTY" successfully loaded 15:11:45.825 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Polish QWERTY" successfully loaded 15:11:45.826 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Portuguese (Portugal) QWERTY" successfully loaded 15:11:45.827 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Romanian QWERTY" successfully loaded 15:11:45.828 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian ЙЦУКЕН" successfully loaded 15:11:45.829 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian АБВ" successfully loaded 15:11:45.830 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Silesian QWERTY" successfully loaded 15:11:45.831 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTZ" successfully loaded 15:11:45.832 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTY" successfully loaded 15:11:45.832 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak ABC" successfully loaded 15:11:45.833 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Spanish QWERTY" successfully loaded 15:11:45.834 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Swedish QWERTY" successfully loaded 15:11:45.835 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Turkish QWERTY" successfully loaded 15:11:45.836 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian ЙЦУКЕН" successfully loaded 15:11:45.837 T:1961996288 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian АБВ" successfully loaded 15:11:45.838 T:1961996288 DEBUG: UDisks: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UDisks was not provided by any .service files 15:11:45.838 T:1961996288 DEBUG: DeviceKit.Disks: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.DeviceKit.Disks was not provided by any .service files 15:11:45.840 T:1961996288 DEBUG: Selected UDev as storage provider 15:11:45.841 T:1961996288 NOTICE: Raspberry PI firmware version: Nov 25 2016 16:09:34 Copyright (c) 2012 Broadcom version 48a26a2ae46c497139b3d5a9c8d15485c7b3bfbc (clean) (release) 15:11:45.841 T:1961996288 NOTICE: ARM mem: 688MB GPU mem: 320MB MPG2:0 WVC1:0 15:11:45.841 T:1961996288 NOTICE: cache.memorysize: 20MB 15:11:45.841 T:1961996288 NOTICE: Config: arm_freq=1200 audio_pwm_mode=1 config_hdmi_boost=5 core_freq=400 desired_osc_freq=0x36ee80 disable_commandline_tags=2 disable_l2cache=1 force_eeprom_read=1 force_pwm_open=1 framebuffer_ignore_alpha=1 framebuffer_swap=1 gpu_freq=300 hdmi_channel_map=8 hdmi_force_cec_address=65535 hdmi_ignore_cec_init=1 init_uart_clock=0x2dc6c00 lcd_framerate=60 over_voltage_avs=0x13d62 overscan_bottom=48 overscan_left=48 overscan_right=48 overscan_top=48 pause_burst_frames=1 program_serial_random=1 sdram_freq=450 temp_limit=85 15:11:45.841 T:1961996288 NOTICE: Config: device_tree=- 15:11:45.841 T:1961996288 DEBUG: DllBcm: Using omx system library 15:11:45.841 T:1961996288 NOTICE: InitWindowSystem: Using EGL Implementation: raspberrypi 15:11:45.842 T:1961996288 DEBUG: EGL initial desktop resolution 1920x1080 (1920x1080) @ 50.00 - Full Screen (1.00) 15:11:45.843 T:1961996288 DEBUG: EGL get supported modes (2) = 15, prefer_group=1, prefer_mode=1f 15:11:45.843 T:1961996288 DEBUG: EGL mode 0: 640x480 (640x480) @ 60.00 - Full Screen (1.00) :4 15:11:45.843 T:1961996288 DEBUG: EGL mode 1: 640x480 (640x480) @ 72.00 - Full Screen (1.00) :5 15:11:45.843 T:1961996288 DEBUG: EGL mode 2: 640x480 (640x480) @ 75.00 - Full Screen (1.00) :6 15:11:45.843 T:1961996288 DEBUG: EGL mode 3: 800x600 (800x600) @ 56.00 - Full Screen (1.00) :8 15:11:45.843 T:1961996288 DEBUG: EGL mode 4: 800x600 (800x600) @ 60.00 - Full Screen (1.00) :9 15:11:45.843 T:1961996288 DEBUG: EGL mode 5: 800x600 (800x600) @ 72.00 - Full Screen (1.00) :a 15:11:45.843 T:1961996288 DEBUG: EGL mode 6: 800x600 (800x600) @ 75.00 - Full Screen (1.00) :b 15:11:45.843 T:1961996288 DEBUG: EGL mode 7: 1024x768 (1024x768) @ 60.00 - Full Screen (1.00) :10 15:11:45.843 T:1961996288 DEBUG: EGL mode 8: 1024x768 (1024x768) @ 70.00 - Full Screen (1.00) :11 15:11:45.843 T:1961996288 DEBUG: EGL mode 9: 1024x768 (1024x768) @ 75.00 - Full Screen (1.00) :12 15:11:45.843 T:1961996288 DEBUG: EGL mode 10: 1280x768 (1280x768) @ 60.00 - Full Screen (1.00) :16 15:11:45.843 T:1961996288 DEBUG: EGL mode 11: 1280x768 (1280x768) @ 60.00 - Full Screen (1.00) :17 15:11:45.843 T:1961996288 DEBUG: EGL mode 12: 1280x1024 (1280x1024) @ 60.00 - Full Screen (1.00) :23 15:11:45.843 T:1961996288 DEBUG: EGL mode 13: 1280x1024 (1280x1024) @ 75.00 - Full Screen (1.00) :24 15:11:45.843 T:1961996288 DEBUG: EGL mode 14: 1360x768 (1360x768) @ 60.00 - Full Screen (1.00) :27 15:11:45.843 T:1961996288 DEBUG: EGL get supported modes (1) = 18, prefer_group=1, prefer_mode=1f 15:11:45.843 T:1961996288 DEBUG: EGL mode 0: 640x480 (640x480) @ 60.00 - Full Screen (1.00) :1 15:11:45.843 T:1961996288 DEBUG: EGL mode 1: 720x480 (720x480) @ 60.00 - Full Screen (0.89) :2 15:11:45.843 T:1961996288 DEBUG: EGL mode 2: 720x480 (720x480) @ 60.00 - Full Screen (1.19) :3 15:11:45.844 T:1961996288 DEBUG: EGL mode 3: 1280x720 (1280x720) @ 60.00 - Full Screen (1.00) :4 15:11:45.844 T:1961996288 DEBUG: EGL mode 4: 1920x1080 (1920x1080) @ 60.00i - Full Screen (1.00) I:5 15:11:45.844 T:1961996288 DEBUG: EGL mode 5: 720x480 (720x480) @ 60.00i - Full Screen (0.89) I:6 15:11:45.844 T:1961996288 DEBUG: EGL mode 6: 720x480 (720x480) @ 60.00i - Full Screen (1.19) I:7 15:11:45.844 T:1961996288 DEBUG: EGL mode 7: 1920x1080 (1920x1080) @ 60.00 - Full Screen (1.00) :10 15:11:45.844 T:1961996288 DEBUG: EGL mode 8: 720x576 (720x576) @ 50.00 - Full Screen (1.07) :11 15:11:45.844 T:1961996288 DEBUG: EGL mode 9: 720x576 (720x576) @ 50.00 - Full Screen (1.42) :12 15:11:45.844 T:1961996288 DEBUG: EGL mode 10: 1280x720 (1280x720) @ 50.00 - Full Screen (1.00) :13 15:11:45.844 T:1961996288 DEBUG: EGL mode 11: 1920x1080 (1920x1080) @ 50.00i - Full Screen (1.00) I:14 15:11:45.844 T:1961996288 DEBUG: EGL mode 12: 720x576 (720x576) @ 50.00i - Full Screen (1.07) I:15 15:11:45.844 T:1961996288 DEBUG: EGL mode 13: 720x576 (720x576) @ 50.00i - Full Screen (1.42) I:16 15:11:45.844 T:1961996288 DEBUG: EGL mode 14: 1920x1080 (1920x1080) @ 50.00 - Full Screen (1.00) N:1f 15:11:45.844 T:1961996288 DEBUG: EGL mode 15: 1920x1080 (1920x1080) @ 24.00 - Full Screen (1.00) :20 15:11:45.844 T:1961996288 DEBUG: EGL mode 16: 1920x1080 (1920x1080) @ 25.00 - Full Screen (1.00) :21 15:11:45.844 T:1961996288 DEBUG: EGL mode 17: 1920x1080 (1920x1080) @ 30.00 - Full Screen (1.00) :22 15:11:45.844 T:1961996288 DEBUG: EGL probe resolution 1920x1080 (1920x1080) @ 50.00 - Full Screen:1f010004 15:11:45.844 T:1961996288 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 60.000000 Hz 15:11:45.844 T:1961996288 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 59.940063 Hz 15:11:45.844 T:1961996288 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 72.000000 Hz 15:11:45.844 T:1961996288 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 71.928070 Hz 15:11:45.844 T:1961996288 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 75.000000 Hz 15:11:45.844 T:1961996288 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 56.000000 Hz 15:11:45.844 T:1961996288 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 60.000000 Hz 15:11:45.844 T:1961996288 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 59.940063 Hz 15:11:45.844 T:1961996288 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 72.000000 Hz 15:11:45.844 T:1961996288 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 71.928070 Hz 15:11:45.845 T:1961996288 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 75.000000 Hz 15:11:45.845 T:1961996288 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 60.000000 Hz 15:11:45.845 T:1961996288 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 59.940063 Hz 15:11:45.845 T:1961996288 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 70.000000 Hz 15:11:45.845 T:1961996288 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 75.000000 Hz 15:11:45.845 T:1961996288 NOTICE: Found resolution 1280 x 768 for display 0 with 1280 x 768 @ 60.000000 Hz 15:11:45.845 T:1961996288 NOTICE: Found resolution 1280 x 768 for display 0 with 1280 x 768 @ 59.940063 Hz 15:11:45.845 T:1961996288 NOTICE: Found resolution 1280 x 1024 for display 0 with 1280 x 1024 @ 60.000000 Hz 15:11:45.845 T:1961996288 NOTICE: Found resolution 1280 x 1024 for display 0 with 1280 x 1024 @ 59.940063 Hz 15:11:45.845 T:1961996288 NOTICE: Found resolution 1280 x 1024 for display 0 with 1280 x 1024 @ 75.000000 Hz 15:11:45.845 T:1961996288 NOTICE: Found resolution 1360 x 768 for display 0 with 1360 x 768 @ 60.000000 Hz 15:11:45.845 T:1961996288 NOTICE: Found resolution 1360 x 768 for display 0 with 1360 x 768 @ 59.940063 Hz 15:11:45.845 T:1961996288 NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 60.000000 Hz 15:11:45.845 T:1961996288 NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 59.940063 Hz 15:11:45.845 T:1961996288 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 60.000000 Hz 15:11:45.845 T:1961996288 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 59.940063 Hz 15:11:45.845 T:1961996288 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 60.000000 Hz 15:11:45.846 T:1961996288 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 59.940063 Hz 15:11:45.846 T:1961996288 NOTICE: Found resolution 720 x 576 for display 0 with 720 x 576 @ 50.000000 Hz 15:11:45.846 T:1961996288 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 50.000000 Hz 15:11:45.846 T:1961996288 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 50.000000 Hz 15:11:45.846 T:1961996288 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 24.000000 Hz 15:11:45.846 T:1961996288 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 23.976025 Hz 15:11:45.846 T:1961996288 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 25.000000 Hz 15:11:45.846 T:1961996288 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 30.000000 Hz 15:11:45.846 T:1961996288 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 29.970032 Hz 15:11:45.846 T:1961996288 NOTICE: Found (1920x1080@50.000000) at 46, setting to RES_DESKTOP at 16 15:11:45.846 T:1961996288 NOTICE: Checking resolution 16 16:51:31.941 T:1930425248 DEBUG: CAESinkPi:Drain delay:99ms now:0ms 16:51:31.941 T:1930425248 DEBUG: CAESinkPi:Deinitialize 16:51:31.941 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 16:51:31.951 T:1930425248 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x72701b98 16:51:31.957 T:1961996288 DEBUG: EGL set HDMI mode (1,31)=0 off 16:51:32.101 T:1903162272 DEBUG: EGL tv_service_callback (8,1,31) 16:51:32.102 T:1961996288 DEBUG: EGL set resolution 1920x1080 -> 1920x1080 @ 50.00 fps (1,31) flags:1f010004 aspect:1.00 16:51:32.130 T:1961996288 DEBUG: CreateWindow: Created surface of size 1920x1080 16:51:32.130 T:1940747168 DEBUG: CActiveAE - display reset event 16:51:32.130 T:1961996288 NOTICE: GL_VENDOR = Broadcom 16:51:32.130 T:1961996288 NOTICE: GL_RENDERER = VideoCore IV HW 16:51:32.130 T:1961996288 NOTICE: GL_VERSION = OpenGL ES 2.0 16:51:32.130 T:1930425248 INFO: CActiveAESink::OpenSink - initialize sink 16:51:32.130 T:1961996288 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 16:51:32.130 T:1930425248 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 16:51:32.130 T:1961996288 DEBUG: GLES: Extension Support Test - GL_NVX_gpu_memory_info NO 16:51:32.130 T:1961996288 NOTICE: GL_EXTENSIONS = GL_OES_compressed_ETC1_RGB8_texture GL_OES_compressed_paletted_texture GL_OES_texture_npot GL_OES_depth24 GL_OES_vertex_half_float GL_OES_EGL_image GL_OES_EGL_image_external GL_EXT_discard_framebuffer GL_OES_rgb8_rgba8 GL_OES_depth32 GL_OES_mapbuffer GL_EXT_texture_format_BGRA8888 GL_APPLE_rgb_422 GL_EXT_debug_marker 16:51:32.130 T:1961996288 DEBUG: GLES: Extension Support Test - GL_EXT_texture_format_BGRA8888 YES 16:51:32.130 T:1961996288 DEBUG: GLES: Extension Support Test - GL_IMG_texture_format_BGRA8888 NO 16:51:32.130 T:1961996288 DEBUG: GLES: Extension Support Test - GL_APPLE_texture_format_BGRA8888 NO 16:51:32.130 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 16:51:32.131 T:1930425248 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI 16:51:32.131 T:1930425248 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x72701ad0 16:51:32.132 T:1930425248 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignmen(16) 16:51:32.133 T:1930425248 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 16:51:32.133 T:1930425248 DEBUG: Output Device : HDMI 16:51:32.133 T:1930425248 DEBUG: Sample Rate : 44100 16:51:32.133 T:1930425248 DEBUG: Sample Format : AE_FMT_FLOAT 16:51:32.133 T:1930425248 DEBUG: Channel Count : 2 16:51:32.133 T:1961996288 DEBUG: GL: Vertex Shader compilation log: 16:51:32.133 T:1930425248 DEBUG: Channel Layout: FL,FR 16:51:32.133 T:1930425248 DEBUG: Frames : 2205 16:51:32.133 T:1930425248 DEBUG: Frame Size : 8 16:51:32.133 T:1961996288 DEBUG: Compiled 16:51:32.133 T:1961996288 DEBUG: GL: Vertex Shader compiled successfully 16:51:32.133 T:1961996288 DEBUG: GL: Pixel Shader compilation log: 16:51:32.133 T:1961996288 DEBUG: Compiled 16:51:32.133 T:1961996288 DEBUG: GL: Fragment Shader compiled successfully 16:51:32.136 T:1940747168 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 16:51:32.148 T:1961996288 DEBUG: GUI Shader [guishader_frag_default.glsl]- Initialise successful : 0x2abcfc0 16:51:32.148 T:1961996288 DEBUG: GL: Vertex Shader compilation log: 16:51:32.148 T:1961996288 DEBUG: Compiled 16:51:32.149 T:1961996288 DEBUG: GL: Vertex Shader compiled successfully 16:51:32.149 T:1961996288 DEBUG: GL: Pixel Shader compilation log: 16:51:32.149 T:1961996288 DEBUG: Compiled 16:51:32.149 T:1961996288 DEBUG: GL: Fragment Shader compiled successfully 16:51:32.161 T:1961996288 DEBUG: GUI Shader [guishader_frag_texture.glsl]- Initialise successful : 0x2aba780 16:51:32.162 T:1961996288 DEBUG: GL: Vertex Shader compilation log: 16:51:32.162 T:1961996288 DEBUG: Compiled 16:51:32.162 T:1961996288 DEBUG: GL: Vertex Shader compiled successfully 16:51:32.163 T:1961996288 DEBUG: GL: Pixel Shader compilation log: 16:51:32.163 T:1961996288 DEBUG: Compiled 16:51:32.163 T:1961996288 DEBUG: GL: Fragment Shader compiled successfully 16:51:32.177 T:1961996288 DEBUG: GUI Shader [guishader_frag_multi.glsl]- Initialise successful : 0x2aba7f8 16:51:32.177 T:1961996288 DEBUG: GL: Vertex Shader compilation log: 16:51:32.177 T:1961996288 DEBUG: Compiled 16:51:32.177 T:1961996288 DEBUG: GL: Vertex Shader compiled successfully 16:51:32.178 T:1961996288 DEBUG: GL: Pixel Shader compilation log: 16:51:32.178 T:1961996288 DEBUG: Compiled 16:51:32.178 T:1961996288 DEBUG: GL: Fragment Shader compiled successfully 16:51:32.192 T:1961996288 DEBUG: GUI Shader [guishader_frag_fonts.glsl]- Initialise successful : 0x2931db0 16:51:32.192 T:1961996288 DEBUG: GL: Vertex Shader compilation log: 16:51:32.192 T:1961996288 DEBUG: Compiled 16:51:32.192 T:1961996288 DEBUG: GL: Vertex Shader compiled successfully 16:51:32.193 T:1961996288 DEBUG: GL: Pixel Shader compilation log: 16:51:32.193 T:1961996288 DEBUG: Compiled 16:51:32.193 T:1961996288 DEBUG: GL: Fragment Shader compiled successfully 16:51:32.205 T:1961996288 DEBUG: GUI Shader [guishader_frag_texture_noblend.glsl]- Initialise successful : 0x2931e28 16:51:32.206 T:1961996288 DEBUG: GL: Vertex Shader compilation log: 16:51:32.206 T:1961996288 DEBUG: Compiled 16:51:32.206 T:1961996288 DEBUG: GL: Vertex Shader compiled successfully 16:51:32.206 T:1961996288 DEBUG: GL: Pixel Shader compilation log: 16:51:32.206 T:1961996288 DEBUG: Compiled 16:51:32.206 T:1961996288 DEBUG: GL: Fragment Shader compiled successfully 16:51:32.220 T:1961996288 DEBUG: GUI Shader [guishader_frag_multi_blendcolor.glsl]- Initialise successful : 0x29314d8 16:51:32.220 T:1961996288 DEBUG: GL: Vertex Shader compilation log: 16:51:32.220 T:1961996288 DEBUG: Compiled 16:51:32.220 T:1961996288 DEBUG: GL: Vertex Shader compiled successfully 16:51:32.221 T:1961996288 DEBUG: GL: Pixel Shader compilation log: 16:51:32.221 T:1961996288 DEBUG: Compiled 16:51:32.221 T:1961996288 DEBUG: GL: Fragment Shader compiled successfully 16:51:32.234 T:1961996288 DEBUG: GUI Shader [guishader_frag_rgba.glsl]- Initialise successful : 0x2931550 16:51:32.234 T:1961996288 DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external YES 16:51:32.234 T:1961996288 DEBUG: GL: Vertex Shader compilation log: 16:51:32.234 T:1961996288 DEBUG: Compiled 16:51:32.234 T:1961996288 DEBUG: GL: Vertex Shader compiled successfully 16:51:32.235 T:1961996288 DEBUG: GL: Pixel Shader compilation log: 16:51:32.235 T:1961996288 DEBUG: Compiled 16:51:32.235 T:1961996288 DEBUG: GL: Fragment Shader compiled successfully 16:51:32.250 T:1961996288 DEBUG: GUI Shader [guishader_frag_rgba_oes.glsl]- Initialise successful : 0x2931958 16:51:32.251 T:1961996288 DEBUG: GL: Vertex Shader compilation log: 16:51:32.251 T:1961996288 DEBUG: Compiled 16:51:32.251 T:1961996288 DEBUG: GL: Vertex Shader compiled successfully 16:51:32.251 T:1961996288 DEBUG: GL: Pixel Shader compilation log: 16:51:32.251 T:1961996288 DEBUG: Compiled 16:51:32.251 T:1961996288 DEBUG: GL: Fragment Shader compiled successfully 16:51:32.264 T:1961996288 DEBUG: GUI Shader [guishader_frag_rgba_blendcolor.glsl]- Initialise successful : 0x29319d0 16:51:32.265 T:1961996288 DEBUG: GL: Vertex Shader compilation log: 16:51:32.265 T:1961996288 DEBUG: Compiled 16:51:32.265 T:1961996288 DEBUG: GL: Vertex Shader compiled successfully 16:51:32.265 T:1961996288 DEBUG: GL: Pixel Shader compilation log: 16:51:32.265 T:1961996288 DEBUG: Compiled 16:51:32.265 T:1961996288 DEBUG: GL: Fragment Shader compiled successfully 16:51:32.282 T:1961996288 DEBUG: GUI Shader [guishader_frag_rgba_bob.glsl]- Initialise successful : 0x29373b8 16:51:32.282 T:1961996288 DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external YES 16:51:32.282 T:1961996288 DEBUG: GL: Vertex Shader compilation log: 16:51:32.282 T:1961996288 DEBUG: Compiled 16:51:32.282 T:1961996288 DEBUG: GL: Vertex Shader compiled successfully 16:51:32.283 T:1961996288 DEBUG: GL: Pixel Shader compilation log: 16:51:32.283 T:1961996288 DEBUG: Compiled 16:51:32.283 T:1961996288 DEBUG: GL: Fragment Shader compiled successfully 16:51:32.301 T:1961996288 DEBUG: GUI Shader [guishader_frag_rgba_bob_oes.glsl]- Initialise successful : 0x2937430 16:51:32.301 T:1961996288 DEBUG: CWinSystemEGL::CreateNewWindow: No need to create a new window 16:51:32.301 T:1961996288 INFO: GLES: Maximum texture width: 2048 16:51:32.676 T:1961996288 INFO: GLES: Enabling VSYNC 16:51:32.676 T:1961996288 INFO: GLES: Selected vsync mode 10 16:51:32.676 T:1961996288 INFO: load keymapping 16:51:32.680 T:1961996288 INFO: Loading special://xbmc/system/keymaps/appcommand.xml 16:51:32.680 T:1961996288 INFO: Loading special://xbmc/system/keymaps/customcontroller.AppleRemote.xml 16:51:32.684 T:1961996288 INFO: Loading special://xbmc/system/keymaps/customcontroller.Harmony.xml 16:51:32.691 T:1961996288 INFO: Loading special://xbmc/system/keymaps/gamepad.xml 16:51:32.697 T:1961996288 INFO: Loading special://xbmc/system/keymaps/joystick.xml 16:51:32.702 T:1961996288 INFO: Loading special://xbmc/system/keymaps/keyboard.xml 16:51:32.721 T:1961996288 INFO: Loading special://xbmc/system/keymaps/mouse.xml 16:51:32.723 T:1961996288 INFO: Loading special://xbmc/system/keymaps/remote.xml 16:51:32.738 T:1961996288 INFO: Loading special://xbmc/system/keymaps/touchscreen.xml 16:51:32.746 T:1961996288 INFO: Loading special://xbmc/system/Lircmap.xml 16:51:32.757 T:1961996288 INFO: * Adding remote mapping for device 'mceusb' 16:51:32.758 T:1961996288 INFO: * Adding remote mapping for device 'XboxDVDDongle' 16:51:32.758 T:1961996288 INFO: * Adding remote mapping for device 'Microsoft_Xbox' 16:51:32.758 T:1961996288 INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote' 16:51:32.758 T:1961996288 INFO: * Adding remote mapping for device 'anysee' 16:51:32.758 T:1961996288 INFO: * Adding remote mapping for device 'iMON-PAD' 16:51:32.758 T:1961996288 INFO: * Adding remote mapping for device 'Antec_Veris_RM200' 16:51:32.758 T:1961996288 INFO: * Adding remote mapping for device 'MCE_via_iMON' 16:51:32.758 T:1961996288 INFO: * Adding remote mapping for device 'TwinHanRemote' 16:51:32.758 T:1961996288 INFO: * Adding remote mapping for device 'linux-input-layer' 16:51:32.758 T:1961996288 INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote' 16:51:32.758 T:1961996288 INFO: * Adding remote mapping for device 'mediacenter' 16:51:32.758 T:1961996288 INFO: * Adding remote mapping for device 'devinput' 16:51:32.760 T:1961996288 DEBUG: CButtonTranslator::Load - no userdata Lircmap.xml found, skipping 16:51:32.760 T:1961996288 INFO: GUI format 1920x1080, Display 1920x1080 (1920x1080) @ 50.00 - Full Screen 16:51:32.760 T:1961996288 DEBUG: guilib: Fill viewport on change for solving rendering passes 16:51:32.760 T:1961996288 INFO: CLangInfo: loading resource.language.de_de language information... 16:51:32.766 T:1961996288 DEBUG: trying to set locale to de_DE.UTF-8 16:51:32.776 T:1961996288 INFO: global locale set to C 16:51:32.776 T:1961996288 INFO: CLangInfo: loading resource.language.de_de language strings... 16:51:32.847 T:1961996288 DEBUG: LocalizeStrings: loaded 3742 strings from file resource://resource.language.de_de/strings.po 16:51:32.882 T:1961996288 DEBUG: POParser: id:16313 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead 16:51:32.887 T:1961996288 DEBUG: POParser: id:20433 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead 16:51:32.893 T:1961996288 DEBUG: POParser: id:36178 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead 16:51:32.893 T:1961996288 DEBUG: POParser: id:36180 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead 16:51:32.898 T:1961996288 DEBUG: POParser: id:38040 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead 16:51:32.898 T:1961996288 DEBUG: POParser: id:38041 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead 16:51:32.899 T:1961996288 DEBUG: LocalizeStrings: loaded 47 strings from file resource://resource.language.en_gb/strings.po 16:51:32.919 T:1961996288 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.xbmc.builtin.wma/resources/language/English/strings.po 16:51:32.930 T:1961996288 DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/game.controller.default/resources/language/resource.language.en_gb/strings.po 16:51:32.931 T:1961996288 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.de_de/strings.po 16:51:32.931 T:1961996288 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.en_gb/strings.po 16:51:32.942 T:1961996288 DEBUG: LocalizeStrings: loaded 183 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/German/strings.po 16:51:32.951 T:1961996288 DEBUG: POParser: id:609 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead 16:51:32.951 T:1961996288 DEBUG: POParser: id:610 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead 16:51:32.952 T:1961996288 DEBUG: POParser: id:32187 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead 16:51:32.952 T:1961996288 DEBUG: LocalizeStrings: loaded 21 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/English/strings.po 16:51:32.957 T:1961996288 DEBUG: LocalizeStrings: loaded 7 strings from file /storage/.kodi/addons/metadata.themoviedb.org/resources/language/German/strings.po 16:51:32.959 T:1961996288 DEBUG: LocalizeStrings: loaded 0 strings from file /storage/.kodi/addons/metadata.themoviedb.org/resources/language/English/strings.po 16:51:32.962 T:1961996288 DEBUG: LocalizeStrings: loaded 2 strings from file /storage/.kodi/addons/metadata.musicvideos.theaudiodb.com/resources/language/German/strings.po 16:51:32.964 T:1961996288 DEBUG: LocalizeStrings: loaded 0 strings from file /storage/.kodi/addons/metadata.musicvideos.theaudiodb.com/resources/language/English/strings.po 16:51:32.971 T:1961996288 DEBUG: LocalizeStrings: loaded 11 strings from file /storage/.kodi/addons/metadata.album.universal/resources/language/German/strings.po 16:51:32.972 T:1961996288 DEBUG: LocalizeStrings: loaded 2 strings from file /storage/.kodi/addons/metadata.album.universal/resources/language/English/strings.po 16:51:32.976 T:1961996288 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.xbmc.builtin.aac/resources/language/English/strings.po 16:51:32.984 T:1961996288 DEBUG: LocalizeStrings: loaded 5 strings from file /storage/.kodi/addons/metadata.tvdb.com/resources/language/German/strings.po 16:51:32.986 T:1961996288 DEBUG: LocalizeStrings: loaded 2 strings from file /storage/.kodi/addons/metadata.tvdb.com/resources/language/English/strings.po 16:51:32.997 T:1961996288 DEBUG: LocalizeStrings: loaded 23 strings from file /storage/.kodi/addons/metadata.artists.universal/resources/language/German/strings.po 16:51:32.999 T:1961996288 DEBUG: LocalizeStrings: loaded 3 strings from file /storage/.kodi/addons/metadata.artists.universal/resources/language/English/strings.po 16:51:33.005 T:1961996288 DEBUG: LocalizeStrings: loaded 7 strings from file /storage/.kodi/addons/inputstream.adaptive/resources/language/resource.language.en_gb/strings.po 16:51:33.009 T:1961996288 DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid" 16:51:33.009 T:1961996288 DEBUG: LoadMappings - loaded node "CEC Adapter" 16:51:33.009 T:1961996288 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter" 16:51:33.010 T:1961996288 DEBUG: LoadMappings - loaded node "iMON HID device" 16:51:33.010 T:1961996288 DEBUG: LoadMappings - loaded node "WETEK Play remote" 16:51:33.010 T:1961996288 DEBUG: LoadMappings - loaded node "" 16:51:33.010 T:1961996288 DEBUG: CPeripheralBusUSB - initialised udev monitor 16:51:33.010 T:1961996288 DEBUG: SECTION:LoadDLL(libcec.so.4) 16:51:33.012 T:1961996288 DEBUG: Loading: libcec.so.4 16:51:33.029 T:1841296288 DEBUG: Thread PeripBusUSBUdev start, auto delete: false 16:51:33.029 T:1832907680 DEBUG: Thread PeripBusCEC start, auto delete: false 16:51:33.029 T:1824519072 DEBUG: Thread PeripBusAddon start, auto delete: false 16:51:33.029 T:1961996288 DEBUG: SECTION:LoadDLL(libcurl.so.4) 16:51:33.029 T:1816130464 DEBUG: Thread PeripEventScanner start, auto delete: false 16:51:33.031 T:1961996288 DEBUG: Loading: libcurl.so.4 16:51:33.046 T:1874850720 NOTICE: Running database version Addons26 16:51:33.047 T:1874850720 DEBUG: Initialize, updating databases... 16:51:33.050 T:1874850720 NOTICE: Running database version ViewModes6 16:51:33.068 T:1874850720 NOTICE: Running database version Textures13 16:51:33.083 T:1874850720 NOTICE: Running database version MyMusic60 16:51:33.119 T:1874850720 NOTICE: Running database version MyVideos107 16:51:33.128 T:1874850720 NOTICE: Running database version TV29 16:51:33.131 T:1874850720 NOTICE: Running database version Epg11 16:51:33.134 T:1874850720 DEBUG: Initialize, updating databases... DONE 16:51:33.135 T:1961996288 NOTICE: start dvd mediatype detection 16:51:33.135 T:1961996288 INFO: DPMS: not supported on this platform 16:51:33.135 T:1931867040 DEBUG: Thread DetectDVDMedia start, auto delete: false 16:51:33.135 T:1931867040 DEBUG: Compiled with libcdio Version 0.93 16:51:33.138 T:1931867040 DEBUG: Thread DetectDVDMedia 1931867040 terminating 16:51:33.154 T:1832907680 DEBUG: GetMappingForDevice - device (2708:1001) mapped to CEC Adapter (type = cec) 16:51:33.163 T:1832907680 DEBUG: InitialiseFeature - using libCEC v4.0.0 16:51:33.163 T:1832907680 DEBUG: Initialise - initialised peripheral on 'RPI' with 2 features and 0 sub devices 16:51:33.163 T:1797256096 DEBUG: Thread CECAdapter start, auto delete: false 16:51:33.163 T:1832907680 NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001) 16:51:33.163 T:1797256096 DEBUG: OpenConnection - opening a connection to the CEC adapter: RPI 16:51:33.163 T:1832907680 DEBUG: Thread PeripBusCEC 1832907680 terminating 16:51:33.171 T:1961993120 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 16:51:33.171 T:1961993120 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 16:51:33.188 T:1961996288 INFO: Unloading old skin ... 16:51:33.194 T:1961996288 INFO: load skin from: /usr/share/kodi/addons/skin.estuary (version: 1.9.1) 16:51:33.194 T:1961996288 INFO: load fonts for skin... 16:51:33.199 T:1961996288 INFO: Loading fonts from /usr/share/kodi/addons/skin.estuary/xml/Font.xml 16:51:33.319 T:1961996288 DEBUG: LocalizeStrings: loaded 135 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.de_de/strings.po 16:51:33.320 T:1961996288 DEBUG: POParser: id:31018 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead 16:51:33.320 T:1961996288 DEBUG: POParser: id:31030 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead 16:51:33.320 T:1961996288 DEBUG: POParser: id:31062 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead 16:51:33.321 T:1961996288 DEBUG: POParser: id:31131 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead 16:51:33.321 T:1961996288 DEBUG: LocalizeStrings: loaded 28 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.en_gb/strings.po 16:51:33.321 T:1961996288 INFO: Loading skin includes from /usr/share/kodi/addons/skin.estuary/xml/Includes.xml 16:51:33.462 T:1961996288 INFO: load new skin... 16:51:33.462 T:1961996288 INFO: Loading user windows, path /usr/share/kodi/addons/skin.estuary/xml 16:51:33.480 T:1961996288 DEBUG: Load Skin XML: 18.86ms 16:51:33.480 T:1961996288 INFO: initialize new skin... 16:51:33.480 T:1961996288 DEBUG: guilib: Fill viewport on change for solving rendering passes 16:51:33.480 T:1961996288 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT 16:51:33.493 T:1961996288 DEBUG: OpenBundle - Opened bundle /usr/share/kodi/addons/skin.estuary/media/Textures.xbt 16:51:33.505 T:1961996288 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT 16:51:33.509 T:1961996288 INFO: Loading skin file: DialogNotification.xml, load type: LOAD_ON_GUI_INIT 16:51:33.514 T:1961996288 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT 16:51:33.534 T:1961996288 INFO: Loading skin file: DialogSettings.xml, load type: LOAD_ON_GUI_INIT 16:51:33.571 T:1961996288 INFO: Previous line repeats 1 times. 16:51:33.571 T:1961996288 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT 16:51:33.575 T:1961996288 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT 16:51:33.579 T:1961996288 INFO: Loading skin file: DialogSubtitles.xml, load type: LOAD_ON_GUI_INIT 16:51:33.594 T:1961996288 INFO: Loading skin file: DialogPVRChannelsOSD.xml, load type: LOAD_ON_GUI_INIT 16:51:33.604 T:1961996288 INFO: Loading skin file: DialogPVRGuideOSD.xml, load type: LOAD_ON_GUI_INIT 16:51:33.612 T:1961996288 INFO: Loading skin file: VideoOSD.xml, load type: LOAD_ON_GUI_INIT 16:51:33.640 T:1961996288 INFO: Loading resource://resource.uisounds.kodi/sounds.xml 16:51:33.787 T:1961996288 INFO: skin loaded... 16:51:33.787 T:1961996288 DEBUG: Activating window ID: 12997 16:51:33.787 T:1961996288 DEBUG: ------ Window Init () ------ 16:51:33.787 T:1961996288 INFO: load splash image: /usr/share/kodi/media/Splash.png 16:51:33.833 T:1961996288 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting 16:51:33.833 T:1961996288 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 16:51:33.833 T:1961996288 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting") 16:51:33.834 T:1961996288 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting 16:51:33.908 T:1961996288 INFO: JSONRPC v7.22.3: Successfully initialized 16:51:33.908 T:1961996288 DEBUG: ADDON: Starting service addons. 16:51:33.910 T:1961996288 DEBUG: Activating window ID: 12999 16:51:33.910 T:1961996288 DEBUG: ------ Window Init (Startup.xml) ------ 16:51:33.911 T:1961996288 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME 16:51:33.911 T:1961996288 DEBUG: Activating window ID: 10000 16:51:33.911 T:1961996288 DEBUG: ------ Window Deinit (Startup.xml) ------ 16:51:33.911 T:1961996288 DEBUG: ------ Window Init (Home.xml) ------ 16:51:33.911 T:1961996288 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY 16:51:34.292 T:1961996288 DEBUG: CDirectoryProvider[library://video/movies/]: refreshing.. 16:51:34.292 T:1961996288 DEBUG: CDirectoryProvider[special://skin/playlists/inprogress_movies.xsp]: refreshing.. 16:51:34.292 T:1961996288 DEBUG: CDirectoryProvider[special://skin/playlists/recent_unwatched_movies.xsp]: refreshing.. 16:51:34.292 T:1780478880 DEBUG: Thread JobWorker start, auto delete: true 16:51:34.292 T:1961996288 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_movies.xsp]: refreshing.. 16:51:34.293 T:1961996288 DEBUG: CDirectoryProvider[special://skin/playlists/random_movies.xsp]: refreshing.. 16:51:34.293 T:1961996288 DEBUG: CDirectoryProvider[videodb://movies/genres/]: refreshing.. 16:51:34.293 T:1961996288 DEBUG: CDirectoryProvider[videodb://movies/sets/]: refreshing.. 16:51:34.293 T:1961996288 DEBUG: CDirectoryProvider[library://video/tvshows/]: refreshing.. 16:51:34.293 T:1961996288 DEBUG: CDirectoryProvider[videodb://inprogresstvshows]: refreshing.. 16:51:34.293 T:1961996288 DEBUG: CDirectoryProvider[special://skin/playlists/recent_unwatched_episodes.xsp]: refreshing.. 16:51:34.293 T:1961996288 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_tvshows.xsp]: refreshing.. 16:51:34.293 T:1961996288 DEBUG: CDirectoryProvider[videodb://tvshows/genres/]: refreshing.. 16:51:34.293 T:1961996288 DEBUG: CDirectoryProvider[videodb://tvshows/studios/]: refreshing.. 16:51:34.293 T:1961996288 DEBUG: CDirectoryProvider[library://music/]: refreshing.. 16:51:34.293 T:1961996288 DEBUG: CDirectoryProvider[musicdb://recentlyplayedalbums]: refreshing.. 16:51:34.293 T:1961996288 DEBUG: CDirectoryProvider[musicdb://recentlyaddedalbums/]: refreshing.. 16:51:34.293 T:1961996288 DEBUG: CDirectoryProvider[special://skin/playlists/random_albums.xsp]: refreshing.. 16:51:34.293 T:1961996288 DEBUG: CDirectoryProvider[special://skin/playlists/random_artists.xsp]: refreshing.. 16:51:34.293 T:1961996288 DEBUG: CDirectoryProvider[special://skin/playlists/unplayed_albums.xsp]: refreshing.. 16:51:34.293 T:1961996288 DEBUG: CDirectoryProvider[special://skin/playlists/mostplayed_albums.xsp]: refreshing.. 16:51:34.293 T:1772090272 DEBUG: Thread JobWorker start, auto delete: true 16:51:34.294 T:1961996288 DEBUG: CDirectoryProvider[addons://]: refreshing.. 16:51:34.294 T:1961996288 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 16:51:34.294 T:1961996288 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 16:51:34.294 T:1961996288 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 16:51:34.294 T:1961996288 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 16:51:34.294 T:1961996288 DEBUG: CDirectoryProvider[library://video/]: refreshing.. 16:51:34.294 T:1961996288 DEBUG: CDirectoryProvider[sources://video/]: refreshing.. 16:51:34.294 T:1961996288 DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing.. 16:51:34.294 T:1961996288 DEBUG: CDirectoryProvider[favourites://]: refreshing.. 16:51:34.294 T:1961996288 DEBUG: CDirectoryProvider[library://music/musicvideos/]: refreshing.. 16:51:34.294 T:1961996288 DEBUG: CDirectoryProvider[videodb://recentlyaddedmusicvideos/]: refreshing.. 16:51:34.294 T:1961996288 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_musicvideos.xsp]: refreshing.. 16:51:34.294 T:1961996288 DEBUG: CDirectoryProvider[special://skin/playlists/random_musicvideo_artists.xsp]: refreshing.. 16:51:34.294 T:1961996288 DEBUG: CDirectoryProvider[special://skin/playlists/random_musicvideos.xsp]: refreshing.. 16:51:34.294 T:1961996288 DEBUG: CDirectoryProvider[videodb://musicvideos/studios/]: refreshing.. 16:51:34.294 T:1961996288 DEBUG: CDirectoryProvider[sources://pictures/]: refreshing.. 16:51:34.339 T:1780478880 DEBUG: RunQuery took 2 ms for 1 items query: select * from movie_view WHERE (movie_view.idFile IN (SELECT DISTINCT idFile FROM bookmark WHERE type = 1)) 16:51:34.350 T:1772090272 DEBUG: RunQuery took 5 ms for 5 items query: select * from movie_view WHERE ((movie_view.dateAdded > '1900-01-01')) AND ((movie_view.playCount IS NULL OR movie_view.playCount < 1)) 16:51:34.373 T:1961996288 DEBUG: ContextMenuManager: addon menus reloaded. 16:51:34.374 T:1961996288 INFO: removing tempfiles 16:51:34.376 T:1961996288 DEBUG: ADDON: Starting service addons. 16:51:34.382 T:1761604512 DEBUG: Thread LanguageInvoker start, auto delete: false 16:51:34.383 T:1761604512 INFO: initializing python engine. 16:51:34.402 T:1874850720 DEBUG: RunQuery took 3 ms for 5 items query: select * from movie_view 16:51:34.403 T:1797256096 DEBUG: OpenConnection - connection to the CEC adapter opened 16:51:34.410 T:1797256096 DEBUG: SetConfigurationFromLibCEC - settings updated by libCEC 16:51:34.411 T:1750021024 DEBUG: Thread CECAdapterUpdate start, auto delete: false 16:51:34.414 T:1961996288 DEBUG: CRepositoryUpdater: previous update at 11.12.2016 16:23:10, next at 12.12.2016 16:23:10 16:51:34.414 T:1780478880 DEBUG: RunQuery took 2 ms for 5 items query: select * from movie_view WHERE ((movie_view.playCount IS NULL OR movie_view.playCount = 0)) 16:51:34.415 T:1961996288 NOTICE: initialize done 16:51:34.415 T:1961996288 NOTICE: Running the application... 16:51:34.416 T:1741632416 DEBUG: Thread Timer start, auto delete: false 16:51:34.436 T:1961996288 DEBUG: no profile autoexec.py (/storage/.kodi/userdata/autoexec.py) found, skipping 16:51:34.436 T:1961996288 DEBUG: NetworkMessage - Starting network services 16:51:34.443 T:1961996288 DEBUG: CZeroconfAvahi::clientCallback: client is up and running 16:51:34.443 T:1961996288 NOTICE: starting zeroconf publishing 16:51:34.446 T:1961996288 NOTICE: CWebServer[8080]: Started 16:51:34.446 T:1961996288 NOTICE: starting upnp client 16:51:34.456 T:1772090272 DEBUG: RunQuery took 5 ms for 8 items query: SELECT genre.genre_id, genre.name, count(1), count(files.playCount) FROM genre JOIN genre_link ON genre.genre_id = genre_link.genre_id JOIN movie_view ON genre_link.media_id = movie_view.idMovie AND genre_link.media_type='movie' JOIN files ON files.idFile = movie_view.idFile GROUP BY genre.genre_id 16:51:34.456 T:1961996288 INFO: JSONRPC Server: Successfully initialized 16:51:34.457 T:1961996288 DEBUG: SECTION:LoadDLL(libshairplay.so.0) 16:51:34.459 T:1674523552 DEBUG: Thread EventServer start, auto delete: false 16:51:34.461 T:1961996288 DEBUG: Loading: libshairplay.so.0 16:51:34.461 T:1674523552 NOTICE: ES: Starting UDP Event server on port 9777 16:51:34.461 T:1674523552 NOTICE: UDP: Listening on port 9777 (ipv6 : false) 16:51:34.462 T:1666134944 DEBUG: Thread TCPServer start, auto delete: false 16:51:34.467 T:1874850720 DEBUG: RunQuery took 3 ms for 1 items query: select * from movie_view JOIN sets ON movie_view.idSet = sets.idSet ORDER BY sets.idSet 16:51:34.467 T:1961996288 INFO: AIRPLAY: Cleaning up photoassetcache 16:51:34.469 T:1961996288 INFO: AIRPLAY Server: Successfully initialized 16:51:34.472 T:1640969120 DEBUG: Thread CLinuxInputDevicesCheckHotplugged start, auto delete: false 16:51:34.476 T:1761604512 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): start processing 16:51:34.477 T:1649357728 DEBUG: Thread AirPlayServer start, auto delete: false 16:51:34.491 T:1961996288 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x35bea78 16:51:34.492 T:1961996288 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 16:51:34.494 T:1961996288 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x35e3e88 16:51:34.495 T:1961996288 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:51:34.515 T:1780478880 DEBUG: RunQuery took 9 ms for 0 items query: SELECT * FROM tvshow_view WHERE watchedCount != 0 AND totalCount != watchedCount ORDER BY c00 16:51:34.522 T:1961996288 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x35bea78 16:51:34.523 T:1961996288 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x35e3e88 16:51:34.523 T:1961996288 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/backgrounds/primary.jpg 1280x720 16:51:34.528 T:1761604512 DEBUG: -->Python Interpreter Initialized<-- 16:51:34.528 T:1761604512 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): the source file to load is "/usr/share/kodi/addons/service.libreelec.settings/service.py" 16:51:34.528 T:1761604512 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): setting the Python path to /usr/share/kodi/addons/service.libreelec.settings:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/gtk-2.0 16:51:34.528 T:1761604512 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): entering source directory /usr/share/kodi/addons/service.libreelec.settings 16:51:34.528 T:1761604512 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): instantiating addon using automatically obtained id of "service.libreelec.settings" dependent on version 2.1.0 of the xbmc.python api 16:51:34.529 T:1772090272 DEBUG: RunQuery took 4 ms for 2 items query: SELECT * FROM tvshow_view WHERE ((tvshow_view.watchedcount = 0)) AND ((tvshow_view.totalCount > 0)) 16:51:34.564 T:1780478880 DEBUG: RunQuery took 15 ms for 5 items query: SELECT genre.genre_id, genre.name FROM genre JOIN genre_link ON genre.genre_id = genre_link.genre_id JOIN tvshow_view ON genre_link.media_id = tvshow_view.idShow AND genre_link.media_type='tvshow' GROUP BY genre.genre_id 16:51:34.570 T:1772090272 DEBUG: RunQuery took 4 ms for 1 items query: SELECT studio.studio_id, studio.name FROM studio JOIN studio_link ON studio.studio_id = studio_link.studio_id JOIN tvshow_view ON studio_link.media_id = tvshow_view.idShow AND studio_link.media_type='tvshow' GROUP BY studio.studio_id 16:51:34.580 T:1615803296 DEBUG: Thread JobWorker start, auto delete: true 16:51:34.581 T:1874850720 DEBUG: RunQuery took 29 ms for 72 items query: select * from episode_view WHERE ((episode_view.dateAdded > '1900-01-01')) AND ((episode_view.playCount IS NULL OR episode_view.playCount < 1)) 16:51:34.595 T:1615803296 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x36b2648 16:51:34.595 T:1961996288 DEBUG: ------ Window Init () ------ 16:51:34.595 T:1615803296 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 16:51:34.598 T:1615803296 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x3764198 16:51:34.599 T:1615803296 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:51:34.606 T:1961996288 DEBUG: ------ Window Init (Pointer.xml) ------ 16:51:34.609 T:1615803296 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x36b2648 16:51:34.609 T:1772090272 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x73d70d50 16:51:34.611 T:1615803296 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x3764198 16:51:34.611 T:1772090272 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 16:51:34.611 T:1615803296 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/6/63bcf8e5.jpg 360x540 16:51:34.619 T:1772090272 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x73d5d9f0 16:51:34.619 T:1772090272 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:51:34.645 T:1772090272 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x73d70d50 16:51:34.648 T:1772090272 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x73d5d9f0 16:51:34.649 T:1772090272 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/e/eb5b6263.jpg 360x540 16:51:34.649 T:1615803296 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x36b2470 16:51:34.650 T:1615803296 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 16:51:34.655 T:1615803296 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x31e3c30 16:51:34.656 T:1615803296 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:51:34.668 T:1780478880 DEBUG: ffmpeg[6A1FF3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 16:51:34.691 T:1615803296 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x36b2470 16:51:34.693 T:1615803296 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x31e3c30 16:51:34.693 T:1615803296 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/8/82cbe7cb.jpg 360x540 16:51:34.693 T:1772090272 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x73d0fcd0 16:51:34.697 T:1772090272 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 16:51:34.700 T:1772090272 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x73d710c0 16:51:34.700 T:1615803296 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 16:51:34.700 T:1772090272 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:51:34.712 T:1615803296 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 16:51:34.726 T:1772090272 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x73d0fcd0 16:51:34.727 T:1615803296 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE albumview.strReleaseType = 'album' 16:51:34.728 T:1772090272 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x73d710c0 16:51:34.728 T:1615803296 DEBUG: GetAlbumsByWhere - query took 1 ms 16:51:34.728 T:1772090272 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/1/160bd62e.jpg 360x540 16:51:34.743 T:1874850720 DEBUG: GetArtistsByWhere query: SELECT artistview.* FROM artistview WHERE ((EXISTS (SELECT 1 FROM song_artist WHERE song_artist.idArtist = artistview.idArtist AND song_artist.idRole = 1) OR EXISTS (SELECT 1 FROM album_artist WHERE album_artist.idArtist = artistview.idArtist)) AND (artistview.strArtist != '')) AND (artistview.strArtist <> 'Verschiedene Interpreten') 16:51:34.747 T:1874850720 DEBUG: Time to retrieve artists from dataset = 7 16:51:34.757 T:1772090272 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE (((CAST(albumview.iTimesPlayed as DECIMAL(5,1)) = 0))) AND (albumview.strReleaseType = 'album') 16:51:34.758 T:1772090272 DEBUG: GetAlbumsByWhere - query took 1 ms 16:51:34.767 T:1615803296 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE (((CAST(albumview.iTimesPlayed as DECIMAL(5,1)) > 0))) AND (albumview.strReleaseType = 'album') 16:51:34.768 T:1615803296 DEBUG: GetAlbumsByWhere - query took 1 ms 16:51:34.789 T:1874850720 DEBUG: CAddonMgr::GetAvailableUpdates took 39 ms 16:51:34.829 T:1961996288 DEBUG: ------ Window Init (DialogNotification.xml) ------ 16:51:34.863 T:1772090272 DEBUG: CFavourites::Load - no system favourites found, skipping 16:51:34.864 T:1772090272 DEBUG: CFavourites::Load - no userdata favourites found, skipping 16:51:34.865 T:1615803296 DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3A%2F%2Fprofile%2Fplaylists%2Fvideo/special%3A%2F%2Fprofile%2Fplaylists%2Fmixed/) 16:51:34.866 T:1615803296 DEBUG: Getting Directory (special://profile/playlists/video) 16:51:34.872 T:1615803296 DEBUG: Getting Directory (special://profile/playlists/mixed) 16:51:34.877 T:1615803296 DEBUG: CMultiPathDirectory::MergeItems, items = 0 16:51:34.883 T:1961996288 DEBUG: LogindUPowerSyscall - Received unknown signal NameAcquired 16:51:34.897 T:1615803296 DEBUG: RunQuery took 2 ms for 0 items query: select * from musicvideo_view ORDER BY dateAdded desc, idMVideo desc LIMIT 25 16:51:34.913 T:1772090272 DEBUG: RunQuery took 1 ms for 0 items query: select * from musicvideo_view WHERE ((musicvideo_view.playCount IS NULL OR musicvideo_view.playCount = 0)) 16:51:34.937 T:1772090272 DEBUG: RunQuery took 4 ms for 0 items query: select * from musicvideo_view 16:51:34.940 T:1615803296 DEBUG: GetPeopleNav - query took 2 ms 16:51:34.952 T:1772090272 DEBUG: RunQuery took 2 ms for 0 items query: SELECT studio.studio_id, studio.name, count(1), count(files.playCount) FROM studio JOIN studio_link ON studio.studio_id = studio_link.studio_id JOIN musicvideo_view ON studio_link.media_id = musicvideo_view.idMVideo AND studio_link.media_type='musicvideo' JOIN files ON files.idFile = musicvideo_view.idFile GROUP BY studio.studio_id 16:51:34.960 T:1772090272 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update 16:51:34.983 T:1772090272 DEBUG: GetRecentlyAddedAlbumSongs() query: SELECT songview.*, songartistview.* FROM (SELECT idAlbum FROM album ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN songview ON songview.idAlbum = recentalbums.idAlbum JOIN songartistview ON songview.idSong = songartistview.idSong ORDER BY songview.idAlbum DESC, songview.idSong, songartistview.idRole, songartistview.iOrder 16:51:34.986 T:1772090272 DEBUG: GetRecentlyAddedAlbums query: SELECT albumview.*, albumartistview.* FROM (SELECT idAlbum FROM album WHERE strAlbum != '' ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN albumview ON albumview.idAlbum = recentalbums.idAlbum JOIN albumartistview ON albumview.idAlbum = albumartistview.idAlbum ORDER BY albumview.idAlbum desc, albumartistview.iOrder 16:51:34.992 T:1772090272 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update 16:51:35.008 T:1615803296 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:Kodi (raspiKodi) port:8080 16:51:35.009 T:1615803296 DEBUG: CZeroconfAvahi::addService() named: Kodi (raspiKodi) type: _http._tcp port:8080 16:51:35.018 T:1615803296 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:Kodi (raspiKodi) port:8080 16:51:35.018 T:1615803296 DEBUG: CZeroconfAvahi::addService() named: Kodi (raspiKodi) type: _xbmc-jsonrpc-h._tcp port:8080 16:51:35.024 T:1772090272 DEBUG: RunQuery took 2 ms for 5 items query: select * from movie_view ORDER BY dateAdded desc, idMovie desc LIMIT 10 16:51:35.024 T:1615803296 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:Kodi (raspiKodi) port:9090 16:51:35.024 T:1615803296 DEBUG: CZeroconfAvahi::addService() named: Kodi (raspiKodi) type: _xbmc-jsonrpc._tcp port:9090 16:51:35.029 T:1615803296 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:Kodi (raspiKodi) port:9777 16:51:35.029 T:1615803296 DEBUG: CZeroconfAvahi::addService() named: Kodi (raspiKodi) type: _xbmc-events._udp port:9777 16:51:35.034 T:1615803296 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airtunes type: _raop._tcp name:B827EBB70543@Kodi (raspiKodi) port:36666 16:51:35.034 T:1615803296 DEBUG: CZeroconfAvahi::addService() named: B827EBB70543@Kodi (raspiKodi) type: _raop._tcp port:36666 16:51:35.041 T:1615803296 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airplay type: _airplay._tcp name:Kodi (raspiKodi) port:36667 16:51:35.041 T:1615803296 DEBUG: CZeroconfAvahi::addService() named: Kodi (raspiKodi) type: _airplay._tcp port:36667 16:51:35.042 T:1772090272 DEBUG: RunQuery took 7 ms for 10 items query: select * from episode_view ORDER BY dateAdded desc, idEpisode desc LIMIT 10 16:51:35.071 T:1772090272 DEBUG: RunQuery took 3 ms for 0 items query: select * from musicvideo_view ORDER BY dateAdded desc, idMVideo desc LIMIT 10 16:51:35.078 T:1772090272 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 16:51:35.085 T:1772090272 DEBUG: GetArtistsByWhere query: SELECT COUNT(DISTINCT artistview.idArtist) FROM artistview WHERE ((EXISTS (SELECT 1 FROM song_artist WHERE song_artist.idArtist = artistview.idArtist AND song_artist.idRole = 1) OR EXISTS (SELECT 1 FROM album_artist WHERE album_artist.idArtist = artistview.idArtist)) AND (artistview.strArtist != '')) AND (artistview.strArtist <> 'Verschiedene Interpreten') 16:51:35.138 T:1761604512 DEBUG: ## LibreELEC Addon ## 0.8.5 16:51:35.144 T:1761604512 WARNING: CSkinInfo: failed to load skin settings 16:51:35.735 T:1761604512 INFO: ## LibreELEC Addon ## system::set_hostname ## raspiKodi 16:51:35.737 T:1761604512 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## us 16:51:35.737 T:1761604512 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## loadkmap < `ls -1 /usr/lib/keymaps/*/us.bmap` 16:51:35.802 T:1761604512 INFO: ## LibreELEC Addon ## system::updateThread ## Started 16:51:35.803 T:1761604512 INFO: ## LibreELEC Addon ## system::set_auto_update ## manual 16:51:35.821 T:1538257824 INFO: ## LibreELEC Addon ## _service_::run ## WAITING: 16:51:35.839 T:1546646432 INFO: ## LibreELEC Addon ## xdbus Monitor started. ## 16:51:35.880 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:51:35.907 T:1733243808 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 16:51:35.963 T:1961996288 DEBUG: Previous line repeats 5 times. 16:51:35.963 T:1961996288 DEBUG: ------ Window Deinit (Pointer.xml) ------ 16:51:38.396 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:51:38.427 T:1780478880 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x7315d6b0 16:51:38.427 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x73d4cbb0 16:51:38.429 T:1874850720 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 16:51:38.432 T:1874850720 DEBUG: Previous line repeats 1 times. 16:51:38.432 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x73d13c28 16:51:38.433 T:1874850720 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:51:38.434 T:1624191904 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:51:38.441 T:1780478880 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x7310eff0 16:51:38.442 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x73d4cbb0 16:51:38.442 T:1780478880 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:51:38.444 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x73d13c28 16:51:38.445 T:1874850720 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/c/ce1a3ee6.jpg 400x225 16:51:38.449 T:1780478880 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x7315d6b0 16:51:38.451 T:1780478880 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x7310eff0 16:51:38.451 T:1780478880 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/e/e60addee.jpg 400x225 16:51:38.461 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x73d566c0 16:51:38.462 T:1874850720 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 16:51:38.466 T:1780478880 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x7315d6b0 16:51:38.466 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x73d09aa0 16:51:38.467 T:1780478880 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 16:51:38.468 T:1874850720 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:51:38.476 T:1780478880 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x73157000 16:51:38.477 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x73d566c0 16:51:38.477 T:1780478880 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:51:38.479 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x73d09aa0 16:51:38.479 T:1874850720 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/8/8717596b.jpg 400x225 16:51:38.480 T:1874850720 ERROR: DoWork - Direct texture file loading failed for resource://resource.images.studios.white/AMC.png 16:51:38.480 T:1874850720 DEBUG: GetImageHash - unable to stat url resource://resource.images.studios.white/AMC.png 16:51:38.484 T:1780478880 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x7315d6b0 16:51:38.486 T:1780478880 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x73157000 16:51:38.486 T:1780478880 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/d/d7ef92d0.jpg 400x225 16:51:38.492 T:1772090272 DEBUG: ffmpeg[699FF3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 16:51:38.507 T:1615803296 DEBUG: ffmpeg[604F33A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 16:51:38.513 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:51:38.561 T:1961996288 DEBUG: Previous line repeats 1 times. 16:51:38.562 T:1961996288 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x39d29a0 16:51:38.562 T:1961996288 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(184336), nBufferAlignmen(16) 16:51:38.564 T:1961996288 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x37340c0 16:51:38.565 T:1961996288 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x3092270 16:51:38.566 T:1961996288 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:51:38.642 T:1961996288 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x39d29a0 16:51:38.642 T:1961996288 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x37340c0 16:51:38.643 T:1961996288 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x3092270 16:51:38.643 T:1961996288 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/home-images/music.jpg 927x540 16:51:38.730 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:51:38.938 T:1961996288 DEBUG: Previous line repeats 4 times. 16:51:38.938 T:1961996288 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x36f3a70 16:51:38.938 T:1961996288 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 16:51:38.940 T:1961996288 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x381b228 16:51:38.941 T:1961996288 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x36f7f38 16:51:38.942 T:1961996288 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:51:39.016 T:1961996288 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x36f3a70 16:51:39.016 T:1961996288 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x381b228 16:51:39.017 T:1961996288 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x36f7f38 16:51:39.017 T:1961996288 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/home-images/tv.jpg 927x540 16:51:39.333 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:51:40.607 T:1961996288 DEBUG: Previous line repeats 5 times. 16:51:40.607 T:1961996288 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 16:51:41.343 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:51:41.881 T:1961996288 DEBUG: Previous line repeats 3 times. 16:51:41.881 T:1961996288 DEBUG: Activating window ID: 10025 16:51:42.183 T:1961996288 DEBUG: ------ Window Deinit (Home.xml) ------ 16:51:42.216 T:1961996288 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 16:51:42.216 T:1961996288 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 16:51:42.432 T:1961996288 DEBUG: CDirectoryProvider[]: refreshing.. 16:51:42.433 T:1780478880 DEBUG: Previous line repeats 1 times. 16:51:42.433 T:1780478880 ERROR: GetDirectory - Error getting 16:51:42.433 T:1961996288 DEBUG: CDirectoryProvider[]: refreshing.. 16:51:42.433 T:1772090272 ERROR: GetDirectory - Error getting 16:51:42.433 T:1961996288 DEBUG: CDirectoryProvider[]: refreshing.. 16:51:42.433 T:1772090272 ERROR: GetDirectory - Error getting 16:51:42.433 T:1961996288 DEBUG: CDirectoryProvider[]: refreshing.. 16:51:42.433 T:1772090272 ERROR: GetDirectory - Error getting 16:51:42.433 T:1961996288 DEBUG: CDirectoryProvider[]: refreshing.. 16:51:42.433 T:1874850720 DEBUG: Previous line repeats 1 times. 16:51:42.433 T:1874850720 ERROR: GetDirectory - Error getting 16:51:42.475 T:1961996288 ERROR: Previous line repeats 2 times. 16:51:42.475 T:1961996288 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/) 16:51:42.475 T:1961996288 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 16:51:42.491 T:1780478880 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 16 ms 16:51:42.491 T:1874850720 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','1','') 16:51:42.492 T:1576006560 DEBUG: Thread LanguageInvoker start, auto delete: false 16:51:42.492 T:1576006560 INFO: initializing python engine. 16:51:42.492 T:1576006560 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing 16:51:42.521 T:1576006560 DEBUG: -->Python Interpreter Initialized<-- 16:51:42.521 T:1576006560 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" 16:51:42.522 T:1576006560 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 16:51:42.522 T:1576006560 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de 16:51:42.522 T:1576006560 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 16:51:42.976 T:1961996288 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:51:43.040 T:1576006560 DEBUG: true 16:51:43.056 T:1576006560 INFO: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 16:51:43.064 T:1584395168 DEBUG: Thread BackgroundLoader start, auto delete: false 16:51:43.089 T:1584395168 DEBUG: Thread BackgroundLoader 1584395168 terminating 16:51:43.097 T:1961996288 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:51:43.119 T:1576006560 INFO: Python script stopped 16:51:43.119 T:1576006560 DEBUG: Thread LanguageInvoker 1576006560 terminating 16:51:44.742 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:51:46.677 T:1961996288 DEBUG: Previous line repeats 19 times. 16:51:46.677 T:1961996288 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listLiveTvChannels) 16:51:46.677 T:1961996288 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 16:51:46.692 T:1780478880 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 15 ms 16:51:46.692 T:1615803296 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','2','?action=listLiveTvChannels') 16:51:46.692 T:1576006560 DEBUG: Thread LanguageInvoker start, auto delete: false 16:51:46.692 T:1576006560 INFO: initializing python engine. 16:51:46.692 T:1576006560 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing 16:51:46.721 T:1576006560 DEBUG: -->Python Interpreter Initialized<-- 16:51:46.721 T:1576006560 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo.de/default.py" 16:51:46.721 T:1576006560 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 16:51:46.721 T:1576006560 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de 16:51:46.722 T:1576006560 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): instantiating addon using automatically obtained id of "plugin.video.skygo.de" dependent on version 2.1.0 of the xbmc.python api 16:51:47.148 T:1576006560 DEBUG: true 16:51:47.158 T:1576006560 DEBUG: {'action': 'listLiveTvChannels'} 16:51:47.179 T:1961996288 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:51:47.843 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:51:48.043 T:1576006560 INFO: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 16:51:48.082 T:1961996288 DEBUG: RunQuery took 0 ms for 4 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=11 16:51:48.090 T:1584395168 DEBUG: Thread BackgroundLoader start, auto delete: false 16:51:48.121 T:1584395168 DEBUG: Thread BackgroundLoader 1584395168 terminating 16:51:48.121 T:1576006560 INFO: Python script stopped 16:51:48.121 T:1576006560 DEBUG: Thread LanguageInvoker 1576006560 terminating 16:51:48.323 T:1961996288 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:51:48.865 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:51:55.556 T:1961996288 DEBUG: Previous line repeats 20 times. 16:51:55.557 T:1961996288 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?action=playLiveTvChannel&epg_channel_id=128&mediaUrl=http%3A%2F%2Flive247-s.akamaihd.net%2Flive%2F232444_232445%2F24sporth01.isml%2FManifest 16:51:55.560 T:1961996288 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','3','?action=playLiveTvChannel&epg_channel_id=128&mediaUrl=http%3A%2F%2Flive247-s.akamaihd.net%2Flive%2F232444_232445%2F24sporth01.isml%2FManifest') 16:51:55.560 T:1576006560 DEBUG: Thread LanguageInvoker start, auto delete: false 16:51:55.560 T:1576006560 INFO: initializing python engine. 16:51:55.560 T:1576006560 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing 16:51:55.566 T:1961993120 DEBUG: GetMovieId (plugin://plugin.video.skygo.de/?action=playLiveTvChannel&epg_channel_id=128&mediaUrl=http%3A%2F%2Flive247-s.akamaihd.net%2Flive%2F232444_232445%2F24sporth01.isml%2FManifest), query = select idMovie from movie where idFile=78 16:51:55.566 T:1961993120 DEBUG: GetEpisodeId (plugin://plugin.video.skygo.de/?action=playLiveTvChannel&epg_channel_id=128&mediaUrl=http%3A%2F%2Flive247-s.akamaihd.net%2Flive%2F232444_232445%2F24sporth01.isml%2FManifest), query = select idEpisode from episode where idFile=78 16:51:55.567 T:1961993120 DEBUG: GetMusicVideoId (plugin://plugin.video.skygo.de/?action=playLiveTvChannel&epg_channel_id=128&mediaUrl=http%3A%2F%2Flive247-s.akamaihd.net%2Flive%2F232444_232445%2F24sporth01.isml%2FManifest), query = select idMVideo from musicvideo where idFile=78 16:51:55.570 T:1961993120 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 16:51:55.570 T:1961993120 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 16:51:55.580 T:1584395168 DEBUG: Thread scriptobs start, auto delete: false 16:51:55.590 T:1576006560 DEBUG: -->Python Interpreter Initialized<-- 16:51:55.590 T:1576006560 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo.de/default.py" 16:51:55.590 T:1576006560 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 16:51:55.590 T:1576006560 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de 16:51:55.590 T:1576006560 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.skygo.de/default.py): instantiating addon using automatically obtained id of "plugin.video.skygo.de" dependent on version 2.1.0 of the xbmc.python api 16:51:55.780 T:1961996288 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:51:56.025 T:1576006560 DEBUG: true 16:51:56.038 T:1576006560 DEBUG: {'action': 'playLiveTvChannel', 'epg_channel_id': '128', 'mediaUrl': 'http://live247-s.akamaihd.net/live/232444_232445/24sporth01.isml/Manifest'} 16:51:56.039 T:1576006560 DEBUG: http://www.skygo.sky.de/epgd/sg/web/eventList/11.12.2016/128/ 16:51:56.834 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:51:56.983 T:1576006560 DEBUG: {u'resultCode': u'S_218', u'resultMessage': u'KO'} 16:51:56.983 T:1576006560 DEBUG: User not logged in or Session on other device 16:51:56.983 T:1576006560 DEBUG: Session invalid - Customer Code not found in SilkCache 16:51:57.303 T:1576006560 DEBUG: {u'gender': u'M', u'tcFlag': u'Y', u'mktgFlag': u'Y', u'firstName': u'HANS', u'country': u'DE', u'age': u'48', u'extraCustFlag': u'N', u'resultMessage': u'OK', u'privacyFlag': u'Y', u'resultCode': u'S_100', u'bookmarkFlag': u'Y', u'customerCode': u'9645871289', u'cableSubFlag': u'N', u'skygoSessionId': u'SG-eae78261-e962-4cb9-a49e-64b41d4abba2', u'lastName': u'FRITSCH', u'entitlements': [u'KIDS', u'O3FB', u'O3SE', u'O3SF', u'O3SP', u'O3SW', u'OFBP', u'OFBS', u'OFEH', u'OFES', u'OOFH', u'OOHD', u'OOSF', u'OOSP', u'OOSW', u'OOWE', u'OSFH', u'OSPS', u'OWEH', u'OWES', u'OWFS', u'OWHE'], u'doubleOptInFlag': u'N', u'accountCreated': u'2010/11/08', u'presentation': u'HERR', u'email': u'fdf68@gmx.de'} 16:51:57.303 T:1576006560 DEBUG: User still logged in 16:51:57.371 T:1576006560 INFO: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 16:51:57.390 T:1584395168 DEBUG: Thread scriptobs 1584395168 terminating 16:51:57.390 T:1961996288 INFO: easy_aquire - Created session to http://live_mss-s.akamaihd.net 16:51:57.500 T:1576006560 INFO: Python script stopped 16:51:57.500 T:1576006560 DEBUG: Thread LanguageInvoker 1576006560 terminating 16:51:57.532 T:1961996288 DEBUG: CCurlFile::GetMimeType - http://live_mss-s.akamaihd.net/live/228188_228189/sporth01.isml/Manifest -> text/xml 16:51:57.542 T:1961996288 DEBUG: Loading settings for http://live_mss-s.akamaihd.net/live/228188_228189/sporth01.isml/Manifest 16:51:57.551 T:1961996288 DEBUG: CPlayerCoreFactory::GetPlayers(http://live_mss-s.akamaihd.net/live/228188_228189/sporth01.isml/Manifest) 16:51:57.552 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 16:51:57.552 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 16:51:57.552 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 16:51:57.552 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 16:51:57.552 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 16:51:57.552 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 16:51:57.552 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 16:51:57.552 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams 16:51:57.552 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp 16:51:57.552 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2 16:51:57.552 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 16:51:57.552 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 16:51:57.552 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 16:51:57.552 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 16:51:57.552 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 16:51:57.552 T:1961996288 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 16:51:57.552 T:1961996288 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 16:51:57.552 T:1961996288 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 16:51:57.553 T:1961996288 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 16:51:57.553 T:1961996288 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 16:51:57.557 T:1961996288 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 16:51:57.557 T:1961996288 NOTICE: VideoPlayer: Opening: http://live_mss-s.akamaihd.net/live/228188_228189/sporth01.isml/Manifest 16:51:57.557 T:1961996288 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 16:51:57.581 T:1961996288 DEBUG: CCurlFile::GetMimeType - http://live_mss-s.akamaihd.net/live/228188_228189/sporth01.isml/Manifest -> text/xml 16:51:57.581 T:1961996288 DEBUG: CMMALRenderer::CMMALRenderer 16:51:57.582 T:1961996288 DEBUG: CMMALRenderer::UnInitMMAL 16:51:57.582 T:1961996288 DEBUG: CMMALRenderer::PreInit 16:51:57.582 T:1576006560 DEBUG: Thread MMALProcess start, auto delete: false 16:51:57.582 T:1576006560 DEBUG: CMMALRenderer::Run - starting 16:51:57.582 T:1584395168 DEBUG: Thread VideoPlayer start, auto delete: false 16:51:57.582 T:1584395168 NOTICE: Creating InputStream 16:51:57.583 T:1584395168 DEBUG: CurlFile::Open(0x5e6fe820) http://live_mss-s.akamaihd.net/live/228188_228189/sporth01.isml/Manifest 16:51:57.730 T:1584395168 DEBUG: CFileCache::Open - opening using cache 16:51:57.731 T:1584395168 DEBUG: CurlFile::Open(0x690ab000) http://live_mss-s.akamaihd.net/live/228188_228189/sporth01.isml/Manifest 16:51:57.791 T:1592783776 DEBUG: Thread FileCache start, auto delete: false 16:51:57.791 T:1584395168 NOTICE: Creating Demuxer 16:51:57.845 T:1592783776 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 16:51:57.929 T:1584395168 ERROR: Open - error probing input format, http://live_mss-s.akamaihd.net/live/228188_228189/sporth01.isml/Manifest 16:51:57.929 T:1584395168 ERROR: OpenDemuxStream - Error creating demuxer 16:51:57.929 T:1584395168 NOTICE: CVideoPlayer::OnExit() 16:51:57.929 T:1592783776 DEBUG: Thread FileCache 1592783776 terminating 16:51:57.929 T:1584395168 DEBUG: OnPlayBackStopped: play state was 1, starting 1 16:51:57.929 T:1584395168 DEBUG: Thread VideoPlayer 1584395168 terminating 16:51:57.929 T:1961996288 DEBUG: OnPlayBackStopped: play state was 3, starting 0 16:51:57.929 T:1961996288 ERROR: Playlist Player: skipping unplayable item: 0, path [plugin://plugin.video.skygo.de/?action=playLiveTvChannel&epg_channel_id=128&mediaUrl=http%3A%2F%2Flive247-s.akamaihd.net%2Flive%2F232444_232445%2F24sporth01.isml%2FManifest] 16:51:57.930 T:1961996288 DEBUG: Playlist Player: no more playable items... aborting playback 16:51:57.930 T:1584395168 DEBUG: Thread BackgroundLoader start, auto delete: false 16:51:57.947 T:1961993120 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 16:51:57.947 T:1961993120 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 16:51:57.949 T:1961996288 NOTICE: CVideoPlayer::CloseFile() 16:51:57.949 T:1961996288 NOTICE: VideoPlayer: waiting for threads to exit 16:51:57.949 T:1961996288 NOTICE: VideoPlayer: finished waiting 16:51:57.949 T:1961996288 DEBUG: DeleteRenderer - deleting renderer 16:51:57.949 T:1961996288 DEBUG: CMMALRenderer::~CMMALRenderer 16:51:57.949 T:1961996288 DEBUG: CMMALRenderer::UnInitMMAL 16:51:57.949 T:1576006560 DEBUG: CMMALRenderer::Run - stopping 16:51:57.949 T:1576006560 DEBUG: Thread MMALProcess 1576006560 terminating 16:51:57.950 T:1961996288 NOTICE: CVideoPlayer::CloseFile() 16:51:57.950 T:1961996288 NOTICE: VideoPlayer: waiting for threads to exit 16:51:57.950 T:1961996288 NOTICE: VideoPlayer: finished waiting 16:51:57.952 T:1961996288 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 16:51:57.962 T:1584395168 DEBUG: Thread BackgroundLoader 1584395168 terminating 16:51:57.969 T:1961996288 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:51:59.829 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:52:00.649 T:1961996288 DEBUG: Previous line repeats 3 times. 16:52:00.649 T:1961996288 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?action=playLiveTvChannel&epg_channel_id=127&mediaUrl=http%3A%2F%2Flivemss2-s.akamaihd.net%2Flive%2F241542_241543%2Fbulihd10.isml%2FManifest 16:52:00.650 T:1961993120 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 16:52:00.650 T:1961993120 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 16:52:00.653 T:1961996288 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','4','?action=playLiveTvChannel&epg_channel_id=127&mediaUrl=http%3A%2F%2Flivemss2-s.akamaihd.net%2Flive%2F241542_241543%2Fbulihd10.isml%2FManifest') 16:52:00.653 T:1584395168 DEBUG: Thread LanguageInvoker start, auto delete: false 16:52:00.653 T:1584395168 INFO: initializing python engine. 16:52:00.653 T:1584395168 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing 16:52:00.661 T:1961993120 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 16:52:00.661 T:1961993120 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 16:52:00.673 T:1576006560 DEBUG: Thread scriptobs start, auto delete: false 16:52:00.683 T:1584395168 DEBUG: -->Python Interpreter Initialized<-- 16:52:00.683 T:1584395168 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo.de/default.py" 16:52:00.683 T:1584395168 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 16:52:00.683 T:1584395168 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de 16:52:00.684 T:1584395168 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.skygo.de/default.py): instantiating addon using automatically obtained id of "plugin.video.skygo.de" dependent on version 2.1.0 of the xbmc.python api 16:52:00.873 T:1961996288 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:52:01.068 T:1584395168 DEBUG: true 16:52:01.079 T:1584395168 DEBUG: {'action': 'playLiveTvChannel', 'epg_channel_id': '127', 'mediaUrl': 'http://livemss2-s.akamaihd.net/live/241542_241543/bulihd10.isml/Manifest'} 16:52:01.079 T:1584395168 DEBUG: http://www.skygo.sky.de/epgd/sg/web/eventList/11.12.2016/127/ 16:52:01.304 T:1584395168 INFO: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 16:52:01.317 T:1961996288 DEBUG: ------ Window Init (DialogNotification.xml) ------ 16:52:01.380 T:1584395168 INFO: Python script stopped 16:52:01.380 T:1584395168 DEBUG: Thread LanguageInvoker 1584395168 terminating 16:52:01.397 T:1576006560 DEBUG: Thread scriptobs 1576006560 terminating 16:52:01.398 T:1961996288 ERROR: Playlist Player: skipping unplayable item: 0, path [plugin://plugin.video.skygo.de/?action=playLiveTvChannel&epg_channel_id=127&mediaUrl=http%3A%2F%2Flivemss2-s.akamaihd.net%2Flive%2F241542_241543%2Fbulihd10.isml%2FManifest] 16:52:01.398 T:1961996288 DEBUG: Playlist Player: no more playable items... aborting playback 16:52:01.398 T:1576006560 DEBUG: Thread BackgroundLoader start, auto delete: false 16:52:01.420 T:1576006560 DEBUG: Thread BackgroundLoader 1576006560 terminating 16:52:01.567 T:1961996288 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:52:02.840 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:52:07.087 T:1961996288 DEBUG: Previous line repeats 1 times. 16:52:07.087 T:1961996288 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 16:52:07.744 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:52:10.273 T:1961996288 DEBUG: Previous line repeats 15 times. 16:52:10.273 T:1961996288 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?action=playLiveTvChannel&epg_channel_id=17&mediaUrl=http%3A%2F%2Flive_mss-s.akamaihd.net%2Flive%2F228210_228211%2Fssn-hd.isml%2FManifest 16:52:10.274 T:1961993120 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 16:52:10.274 T:1961993120 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 16:52:10.280 T:1961996288 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','5','?action=playLiveTvChannel&epg_channel_id=17&mediaUrl=http%3A%2F%2Flive_mss-s.akamaihd.net%2Flive%2F228210_228211%2Fssn-hd.isml%2FManifest') 16:52:10.280 T:1592783776 DEBUG: Thread LanguageInvoker start, auto delete: false 16:52:10.281 T:1592783776 INFO: initializing python engine. 16:52:10.281 T:1592783776 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing 16:52:10.296 T:1961993120 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 16:52:10.296 T:1961993120 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 16:52:10.301 T:1632580512 DEBUG: Thread scriptobs start, auto delete: false 16:52:10.327 T:1592783776 DEBUG: -->Python Interpreter Initialized<-- 16:52:10.327 T:1592783776 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo.de/default.py" 16:52:10.327 T:1592783776 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 16:52:10.327 T:1592783776 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de 16:52:10.328 T:1592783776 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/plugin.video.skygo.de/default.py): instantiating addon using automatically obtained id of "plugin.video.skygo.de" dependent on version 2.1.0 of the xbmc.python api 16:52:10.501 T:1961996288 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:52:10.721 T:1592783776 DEBUG: true 16:52:10.732 T:1592783776 DEBUG: {'action': 'playLiveTvChannel', 'epg_channel_id': '17', 'mediaUrl': 'http://live_mss-s.akamaihd.net/live/228210_228211/ssn-hd.isml/Manifest'} 16:52:10.733 T:1592783776 DEBUG: http://www.skygo.sky.de/epgd/sg/web/eventList/11.12.2016/17/ 16:52:11.409 T:1592783776 DEBUG: {u'gender': u'M', u'tcFlag': u'Y', u'mktgFlag': u'Y', u'firstName': u'HANS', u'country': u'DE', u'age': u'48', u'extraCustFlag': u'N', u'resultMessage': u'OK', u'privacyFlag': u'Y', u'resultCode': u'S_100', u'bookmarkFlag': u'Y', u'customerCode': u'9645871289', u'cableSubFlag': u'N', u'skygoSessionId': u'SG-eae78261-e962-4cb9-a49e-64b41d4abba2', u'lastName': u'FRITSCH', u'entitlements': [u'KIDS', u'O3FB', u'O3SE', u'O3SF', u'O3SP', u'O3SW', u'OFBP', u'OFBS', u'OFEH', u'OFES', u'OOFH', u'OOHD', u'OOSF', u'OOSP', u'OOSW', u'OOWE', u'OSFH', u'OSPS', u'OWEH', u'OWES', u'OWFS', u'OWHE'], u'doubleOptInFlag': u'N', u'accountCreated': u'2010/11/08', u'presentation': u'HERR', u'email': u'fdf68@gmx.de'} 16:52:11.410 T:1592783776 DEBUG: User still logged in 16:52:11.421 T:1592783776 INFO: CPythonInvoker(5, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 16:52:11.438 T:1632580512 DEBUG: Thread scriptobs 1632580512 terminating 16:52:11.466 T:1961996288 DEBUG: CCurlFile::GetMimeType - http://live_mss-s.akamaihd.net/live/228210_228211/ssn-hd.isml/Manifest -> text/xml 16:52:11.477 T:1961996288 DEBUG: Loading settings for http://live_mss-s.akamaihd.net/live/228210_228211/ssn-hd.isml/Manifest 16:52:11.488 T:1961996288 DEBUG: CPlayerCoreFactory::GetPlayers(http://live_mss-s.akamaihd.net/live/228210_228211/ssn-hd.isml/Manifest) 16:52:11.488 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 16:52:11.489 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 16:52:11.489 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 16:52:11.489 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 16:52:11.489 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 16:52:11.489 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 16:52:11.489 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 16:52:11.489 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams 16:52:11.489 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp 16:52:11.489 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2 16:52:11.489 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 16:52:11.489 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 16:52:11.489 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 16:52:11.489 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 16:52:11.489 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 16:52:11.489 T:1961996288 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 16:52:11.489 T:1961996288 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 16:52:11.489 T:1961996288 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 16:52:11.489 T:1961996288 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 16:52:11.489 T:1961996288 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 16:52:11.494 T:1961996288 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 16:52:11.494 T:1961996288 NOTICE: VideoPlayer: Opening: http://live_mss-s.akamaihd.net/live/228210_228211/ssn-hd.isml/Manifest 16:52:11.494 T:1961996288 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 16:52:11.513 T:1961996288 DEBUG: CCurlFile::GetMimeType - http://live_mss-s.akamaihd.net/live/228210_228211/ssn-hd.isml/Manifest -> text/xml 16:52:11.513 T:1961996288 DEBUG: CMMALRenderer::CMMALRenderer 16:52:11.513 T:1961996288 DEBUG: CMMALRenderer::UnInitMMAL 16:52:11.513 T:1961996288 DEBUG: CMMALRenderer::PreInit 16:52:11.513 T:1632580512 DEBUG: Thread MMALProcess start, auto delete: false 16:52:11.514 T:1632580512 DEBUG: CMMALRenderer::Run - starting 16:52:11.514 T:1515000736 DEBUG: Thread VideoPlayer start, auto delete: false 16:52:11.514 T:1515000736 NOTICE: Creating InputStream 16:52:11.514 T:1515000736 DEBUG: CurlFile::Open(0x5a4d0820) http://live_mss-s.akamaihd.net/live/228210_228211/ssn-hd.isml/Manifest 16:52:11.516 T:1592783776 INFO: Python script stopped 16:52:11.516 T:1592783776 DEBUG: Thread LanguageInvoker 1592783776 terminating 16:52:11.553 T:1515000736 DEBUG: CFileCache::Open - opening using cache 16:52:11.554 T:1515000736 DEBUG: CurlFile::Open(0x5aa13db8) http://live_mss-s.akamaihd.net/live/228210_228211/ssn-hd.isml/Manifest 16:52:11.623 T:1592783776 DEBUG: Thread FileCache start, auto delete: false 16:52:11.623 T:1515000736 NOTICE: Creating Demuxer 16:52:11.837 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:52:11.935 T:1592783776 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 16:52:12.053 T:1515000736 ERROR: Open - error probing input format, http://live_mss-s.akamaihd.net/live/228210_228211/ssn-hd.isml/Manifest 16:52:12.054 T:1515000736 ERROR: OpenDemuxStream - Error creating demuxer 16:52:12.054 T:1515000736 NOTICE: CVideoPlayer::OnExit() 16:52:12.054 T:1592783776 DEBUG: Thread FileCache 1592783776 terminating 16:52:12.054 T:1515000736 DEBUG: OnPlayBackStopped: play state was 1, starting 1 16:52:12.054 T:1515000736 DEBUG: Thread VideoPlayer 1515000736 terminating 16:52:12.054 T:1961996288 DEBUG: OnPlayBackStopped: play state was 3, starting 0 16:52:12.055 T:1961996288 ERROR: Playlist Player: skipping unplayable item: 0, path [plugin://plugin.video.skygo.de/?action=playLiveTvChannel&epg_channel_id=17&mediaUrl=http%3A%2F%2Flive_mss-s.akamaihd.net%2Flive%2F228210_228211%2Fssn-hd.isml%2FManifest] 16:52:12.055 T:1961996288 DEBUG: Playlist Player: no more playable items... aborting playback 16:52:12.055 T:1515000736 DEBUG: Thread BackgroundLoader start, auto delete: false 16:52:12.082 T:1961996288 NOTICE: CVideoPlayer::CloseFile() 16:52:12.083 T:1961996288 NOTICE: VideoPlayer: waiting for threads to exit 16:52:12.083 T:1961996288 NOTICE: VideoPlayer: finished waiting 16:52:12.083 T:1961996288 DEBUG: DeleteRenderer - deleting renderer 16:52:12.083 T:1961996288 DEBUG: CMMALRenderer::~CMMALRenderer 16:52:12.083 T:1961996288 DEBUG: CMMALRenderer::UnInitMMAL 16:52:12.083 T:1961993120 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 16:52:12.083 T:1632580512 DEBUG: CMMALRenderer::Run - stopping 16:52:12.083 T:1961993120 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 16:52:12.083 T:1632580512 DEBUG: Thread MMALProcess 1632580512 terminating 16:52:12.083 T:1961996288 NOTICE: CVideoPlayer::CloseFile() 16:52:12.083 T:1961996288 NOTICE: VideoPlayer: waiting for threads to exit 16:52:12.083 T:1961996288 NOTICE: VideoPlayer: finished waiting 16:52:12.089 T:1961996288 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 16:52:12.111 T:1515000736 DEBUG: Thread BackgroundLoader 1515000736 terminating 16:52:12.118 T:1961996288 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:52:14.839 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:52:16.949 T:1961996288 DEBUG: Previous line repeats 1 times. 16:52:16.950 T:1961996288 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?action=playLiveTvChannel&epg_channel_id=17&mediaUrl=http%3A%2F%2Flive_mss-s.akamaihd.net%2Flive%2F228210_228211%2Fssn-hd.isml%2FManifest 16:52:16.950 T:1961993120 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 16:52:16.950 T:1961993120 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 16:52:16.956 T:1961996288 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','6','?action=playLiveTvChannel&epg_channel_id=17&mediaUrl=http%3A%2F%2Flive_mss-s.akamaihd.net%2Flive%2F228210_228211%2Fssn-hd.isml%2FManifest') 16:52:16.956 T:1515000736 DEBUG: Thread LanguageInvoker start, auto delete: false 16:52:16.956 T:1515000736 INFO: initializing python engine. 16:52:16.957 T:1515000736 DEBUG: CPythonInvoker(6, /storage/.kodi/addons/plugin.video.skygo.de/default.py): start processing 16:52:16.972 T:1961993120 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 16:52:16.973 T:1961993120 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 16:52:16.977 T:1632580512 DEBUG: Thread scriptobs start, auto delete: false 16:52:17.011 T:1515000736 DEBUG: -->Python Interpreter Initialized<-- 16:52:17.012 T:1515000736 DEBUG: CPythonInvoker(6, /storage/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo.de/default.py" 16:52:17.013 T:1515000736 DEBUG: CPythonInvoker(6, /storage/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /storage/.kodi/addons/plugin.video.skygo.de:/storage/.kodi/addons/script.module.requests/lib:/storage/.kodi/addons/script.module.routing/lib:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/gtk-2.0 16:52:17.013 T:1515000736 DEBUG: CPythonInvoker(6, /storage/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo.de 16:52:17.013 T:1515000736 DEBUG: CPythonInvoker(6, /storage/.kodi/addons/plugin.video.skygo.de/default.py): instantiating addon using automatically obtained id of "plugin.video.skygo.de" dependent on version 2.1.0 of the xbmc.python api 16:52:17.181 T:1961996288 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:52:17.444 T:1515000736 DEBUG: true 16:52:17.454 T:1515000736 DEBUG: {'action': 'playLiveTvChannel', 'epg_channel_id': '17', 'mediaUrl': 'http://live_mss-s.akamaihd.net/live/228210_228211/ssn-hd.isml/Manifest'} 16:52:17.455 T:1515000736 DEBUG: http://www.skygo.sky.de/epgd/sg/web/eventList/11.12.2016/17/ 16:52:17.843 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:52:18.011 T:1515000736 DEBUG: {u'gender': u'M', u'tcFlag': u'Y', u'mktgFlag': u'Y', u'firstName': u'HANS', u'country': u'DE', u'age': u'48', u'extraCustFlag': u'N', u'resultMessage': u'OK', u'privacyFlag': u'Y', u'resultCode': u'S_100', u'bookmarkFlag': u'Y', u'customerCode': u'9645871289', u'cableSubFlag': u'N', u'skygoSessionId': u'SG-eae78261-e962-4cb9-a49e-64b41d4abba2', u'lastName': u'FRITSCH', u'entitlements': [u'KIDS', u'O3FB', u'O3SE', u'O3SF', u'O3SP', u'O3SW', u'OFBP', u'OFBS', u'OFEH', u'OFES', u'OOFH', u'OOHD', u'OOSF', u'OOSP', u'OOSW', u'OOWE', u'OSFH', u'OSPS', u'OWEH', u'OWES', u'OWFS', u'OWHE'], u'doubleOptInFlag': u'N', u'accountCreated': u'2010/11/08', u'presentation': u'HERR', u'email': u'fdf68@gmx.de'} 16:52:18.011 T:1515000736 DEBUG: User still logged in 16:52:18.084 T:1515000736 INFO: CPythonInvoker(6, /storage/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 16:52:18.101 T:1632580512 DEBUG: Thread scriptobs 1632580512 terminating 16:52:18.128 T:1961996288 DEBUG: CCurlFile::GetMimeType - http://live_mss-s.akamaihd.net/live/228210_228211/ssn-hd.isml/Manifest -> text/xml 16:52:18.140 T:1961996288 DEBUG: Loading settings for http://live_mss-s.akamaihd.net/live/228210_228211/ssn-hd.isml/Manifest 16:52:18.151 T:1961996288 DEBUG: CPlayerCoreFactory::GetPlayers(http://live_mss-s.akamaihd.net/live/228210_228211/ssn-hd.isml/Manifest) 16:52:18.151 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 16:52:18.151 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 16:52:18.151 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 16:52:18.151 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 16:52:18.151 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 16:52:18.151 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 16:52:18.151 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 16:52:18.151 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams 16:52:18.152 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp 16:52:18.152 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2 16:52:18.152 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 16:52:18.152 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 16:52:18.152 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 16:52:18.152 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 16:52:18.152 T:1961996288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 16:52:18.152 T:1961996288 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 16:52:18.152 T:1961996288 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 16:52:18.152 T:1961996288 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 16:52:18.152 T:1961996288 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 16:52:18.152 T:1961996288 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 16:52:18.157 T:1961996288 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 16:52:18.157 T:1961996288 NOTICE: VideoPlayer: Opening: http://live_mss-s.akamaihd.net/live/228210_228211/ssn-hd.isml/Manifest 16:52:18.157 T:1961996288 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 16:52:18.176 T:1961996288 DEBUG: CCurlFile::GetMimeType - http://live_mss-s.akamaihd.net/live/228210_228211/ssn-hd.isml/Manifest -> text/xml 16:52:18.176 T:1961996288 DEBUG: CMMALRenderer::CMMALRenderer 16:52:18.177 T:1961996288 DEBUG: CMMALRenderer::UnInitMMAL 16:52:18.177 T:1961996288 DEBUG: CMMALRenderer::PreInit 16:52:18.177 T:1632580512 DEBUG: Thread MMALProcess start, auto delete: false 16:52:18.177 T:1632580512 DEBUG: CMMALRenderer::Run - starting 16:52:18.177 T:1592783776 DEBUG: Thread VideoPlayer start, auto delete: false 16:52:18.177 T:1592783776 NOTICE: Creating InputStream 16:52:18.177 T:1592783776 DEBUG: CurlFile::Open(0x5eefe820) http://live_mss-s.akamaihd.net/live/228210_228211/ssn-hd.isml/Manifest 16:52:18.178 T:1515000736 INFO: Python script stopped 16:52:18.178 T:1515000736 DEBUG: Thread LanguageInvoker 1515000736 terminating 16:52:18.210 T:1592783776 DEBUG: CFileCache::Open - opening using cache 16:52:18.211 T:1592783776 DEBUG: CurlFile::Open(0x5af461e8) http://live_mss-s.akamaihd.net/live/228210_228211/ssn-hd.isml/Manifest 16:52:18.275 T:1515000736 DEBUG: Thread FileCache start, auto delete: false 16:52:18.275 T:1592783776 NOTICE: Creating Demuxer 16:52:18.329 T:1515000736 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 16:52:18.412 T:1592783776 ERROR: Open - error probing input format, http://live_mss-s.akamaihd.net/live/228210_228211/ssn-hd.isml/Manifest 16:52:18.412 T:1592783776 ERROR: OpenDemuxStream - Error creating demuxer 16:52:18.412 T:1592783776 NOTICE: CVideoPlayer::OnExit() 16:52:18.412 T:1515000736 DEBUG: Thread FileCache 1515000736 terminating 16:52:18.412 T:1592783776 DEBUG: OnPlayBackStopped: play state was 1, starting 1 16:52:18.413 T:1961996288 DEBUG: OnPlayBackStopped: play state was 3, starting 0 16:52:18.413 T:1961996288 ERROR: Playlist Player: skipping unplayable item: 0, path [plugin://plugin.video.skygo.de/?action=playLiveTvChannel&epg_channel_id=17&mediaUrl=http%3A%2F%2Flive_mss-s.akamaihd.net%2Flive%2F228210_228211%2Fssn-hd.isml%2FManifest] 16:52:18.413 T:1961996288 DEBUG: Playlist Player: one or more items failed to play... aborting playback 16:52:18.413 T:1961996288 DEBUG: ------ Window Init (DialogConfirm.xml) ------ 16:52:18.413 T:1961996288 INFO: Loading skin file: DialogConfirm.xml, load type: KEEP_IN_MEMORY 16:52:18.415 T:1592783776 DEBUG: Thread VideoPlayer 1592783776 terminating 16:52:18.421 T:1961996288 NOTICE: CVideoPlayer::CloseFile() 16:52:18.421 T:1961996288 NOTICE: VideoPlayer: waiting for threads to exit 16:52:18.421 T:1961996288 NOTICE: VideoPlayer: finished waiting 16:52:18.421 T:1961996288 DEBUG: DeleteRenderer - deleting renderer 16:52:18.421 T:1961996288 DEBUG: CMMALRenderer::~CMMALRenderer 16:52:18.421 T:1961996288 DEBUG: CMMALRenderer::UnInitMMAL 16:52:18.421 T:1632580512 DEBUG: CMMALRenderer::Run - stopping 16:52:18.421 T:1632580512 DEBUG: Thread MMALProcess 1632580512 terminating 16:52:18.421 T:1961996288 NOTICE: CVideoPlayer::CloseFile() 16:52:18.422 T:1961996288 NOTICE: VideoPlayer: waiting for threads to exit 16:52:18.422 T:1961996288 NOTICE: VideoPlayer: finished waiting 16:52:18.423 T:1961993120 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 16:52:18.423 T:1961993120 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 16:52:18.424 T:1961996288 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 16:52:18.454 T:1961996288 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:52:20.837 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:52:22.666 T:1961996288 DEBUG: Previous line repeats 1 times. 16:52:22.671 T:1961996288 DEBUG: ------ Window Deinit (DialogConfirm.xml) ------ 16:52:22.696 T:1961993120 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 16:52:22.696 T:1961993120 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 16:52:22.696 T:1632580512 DEBUG: Thread BackgroundLoader start, auto delete: false 16:52:22.718 T:1632580512 DEBUG: Thread BackgroundLoader 1632580512 terminating 16:52:23.835 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:52:39.365 T:1780478880 DEBUG: Previous line repeats 5 times. 16:52:39.365 T:1780478880 DEBUG: Thread JobWorker 1780478880 terminating (autodelete) 16:52:39.365 T:1772090272 DEBUG: Thread JobWorker 1772090272 terminating (autodelete) 16:52:39.365 T:1615803296 DEBUG: Thread JobWorker 1615803296 terminating (autodelete) 16:52:39.365 T:1874850720 DEBUG: Thread JobWorker 1874850720 terminating (autodelete) 16:52:41.839 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:52:48.852 T:1961996288 DEBUG: Previous line repeats 2 times. 16:52:48.852 T:1961996288 INFO: CheckIdle - Closing session to http://live_mss-s.akamaihd.net (easy=0x4012550, multi=0x73d4d1a8) 16:52:50.844 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:53:11.116 T:1961996288 DEBUG: Previous line repeats 6 times. 16:53:11.116 T:1961996288 NOTICE: Samba is idle. Closing the remaining connections 16:53:11.863 T:1555035040 DEBUG: CWebServer[8080]: request received for /jsonrpc 16:53:22.780 T:1930425248 DEBUG: Previous line repeats 3 times. 16:53:22.780 T:1930425248 DEBUG: CAESinkPi:Drain delay:100ms now:0ms 16:53:32.780 T:1930425248 DEBUG: CAESinkPi:Deinitialize 16:53:32.781 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 16:53:32.793 T:1930425248 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x72701ad0