13:55:16 6.496641 T:1962463232 NOTICE: special://profile/ is mapped to: special://masterprofile/ 13:55:16 6.496829 T:1962463232 NOTICE: ----------------------------------------------------------------------- 13:55:16 6.496880 T:1962463232 NOTICE: Starting Kodi (17.0-ALPHA3 Git:fc46cf2). Platform: Linux ARM 32-bit 13:55:16 6.496915 T:1962463232 NOTICE: Using Release Kodi x32 build (version for Raspberry Pi) 13:55:16 6.496954 T:1962463232 NOTICE: Kodi compiled Aug 8 2016 by GCC 5.4.0 for Linux ARM 32-bit version 4.7.0 (263936) 13:55:16 6.497226 T:1962463232 NOTICE: Running on LibreELEC (community) - Version: 7.90.004 8.0, kernel: Linux ARM 32-bit version 4.7.0 13:55:16 6.497260 T:1962463232 NOTICE: FFmpeg version: 3.1.1 13:55:16 6.497289 T:1962463232 NOTICE: WARNING: unsupported ffmpeg version detected 13:55:16 6.497320 T:1962463232 NOTICE: Host CPU: ARMv7 Processor rev 4 (v7l), 4 cores available 13:55:16 6.497348 T:1962463232 NOTICE: ARM Features: Neon enabled 13:55:16 6.497380 T:1962463232 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi 13:55:16 6.497414 T:1962463232 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi 13:55:16 6.497444 T:1962463232 NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons 13:55:16 6.497474 T:1962463232 NOTICE: special://masterprofile/ is mapped to: /storage/.kodi/userdata 13:55:16 6.497504 T:1962463232 NOTICE: special://envhome/ is mapped to: /storage 13:55:16 6.497534 T:1962463232 NOTICE: special://home/ is mapped to: /storage/.kodi 13:55:16 6.497563 T:1962463232 NOTICE: special://temp/ is mapped to: /storage/.kodi/temp 13:55:16 6.497593 T:1962463232 NOTICE: special://logpath/ is mapped to: /storage/.kodi/temp 13:55:16 6.497654 T:1962463232 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin 13:55:16 6.497720 T:1962463232 NOTICE: Local hostname: LibreELEC-3 13:55:16 6.497785 T:1962463232 NOTICE: Log File is located: /storage/.kodi/temp//kodi.log 13:55:16 6.506733 T:1962463232 NOTICE: ----------------------------------------------------------------------- 13:55:16 6.638313 T:1962463232 ERROR: DBus: Error org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files 13:55:16 6.645577 T:1962463232 NOTICE: load settings... 13:55:16 6.707042 T:1962463232 ERROR: CSettingGroup: unable to read setting type of "myvideos.extractchapterthumbs" 13:55:16 6.707147 T:1962463232 WARNING: CSettingCategory: unable to read group "1" 13:55:16 6.759364 T:1962463232 NOTICE: Found 2 Lists of Devices 13:55:16 6.759451 T:1962463232 NOTICE: Enumerated PI devices: 13:55:16 6.759484 T:1962463232 NOTICE: Device 1 13:55:16 6.759854 T:1962463232 NOTICE: m_deviceName : HDMI 13:55:16 6.759890 T:1962463232 NOTICE: m_displayName : HDMI 13:55:16 6.759922 T:1962463232 NOTICE: m_displayNameExtra: 13:55:16 6.759952 T:1962463232 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 13:55:16 6.759981 T:1962463232 NOTICE: m_channels : FL,FR 13:55:16 6.760056 T:1962463232 NOTICE: m_sampleRates : 8000,11025,16000,22050,24000,32000,44100,48000,88200,96000,176400,192000 13:55:16 6.760089 T:1962463232 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 13:55:16 6.760120 T:1962463232 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 13:55:16 6.760166 T:1962463232 NOTICE: Device 2 13:55:16 6.760227 T:1962463232 NOTICE: m_deviceName : Analogue 13:55:16 6.760258 T:1962463232 NOTICE: m_displayName : Analogue 13:55:16 6.760287 T:1962463232 NOTICE: m_displayNameExtra: 13:55:16 6.760317 T:1962463232 NOTICE: m_deviceType : AE_DEVTYPE_PCM 13:55:16 6.760345 T:1962463232 NOTICE: m_channels : FL,FR 13:55:16 6.760374 T:1962463232 NOTICE: m_sampleRates : 48000 13:55:16 6.760427 T:1962463232 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 13:55:16 6.760457 T:1962463232 NOTICE: m_streamTypes : No passthrough capabilities 13:55:16 6.760487 T:1962463232 NOTICE: Device 3 13:55:16 6.760545 T:1962463232 NOTICE: m_deviceName : Both 13:55:16 6.760576 T:1962463232 NOTICE: m_displayName : HDMI and Analogue 13:55:16 6.760606 T:1962463232 NOTICE: m_displayNameExtra: 13:55:16 6.760635 T:1962463232 NOTICE: m_deviceType : AE_DEVTYPE_PCM 13:55:16 6.760664 T:1962463232 NOTICE: m_channels : FL,FR 13:55:16 6.760692 T:1962463232 NOTICE: m_sampleRates : 48000 13:55:16 6.760722 T:1962463232 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 13:55:16 6.760751 T:1962463232 NOTICE: m_streamTypes : No passthrough capabilities 13:55:16 6.760783 T:1962463232 NOTICE: Enumerated PULSE devices: 13:55:16 6.760812 T:1962463232 NOTICE: Device 1 13:55:16 6.760877 T:1962463232 NOTICE: m_deviceName : Default 13:55:16 6.760907 T:1962463232 NOTICE: m_displayName : Default 13:55:16 6.760937 T:1962463232 NOTICE: m_displayNameExtra: Bluetooth Audio (PULSEAUDIO) 13:55:16 6.760965 T:1962463232 NOTICE: m_deviceType : AE_DEVTYPE_PCM 13:55:16 6.760994 T:1962463232 NOTICE: m_channels : FL,FR 13:55:16 6.761024 T:1962463232 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000 13:55:16 6.761054 T:1962463232 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT 13:55:16 6.761083 T:1962463232 NOTICE: m_streamTypes : No passthrough capabilities 13:55:16 6.786386 T:1962463232 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml 13:55:16 6.795636 T:1962463232 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are... false 720 540 30 13:55:16 6.797317 T:1962463232 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 13:55:16 6.797385 T:1962463232 NOTICE: Default Video Player: VideoPlayer 13:55:16 6.797416 T:1962463232 NOTICE: Default Audio Player: paplayer 13:55:16 6.797453 T:1962463232 NOTICE: Enabled debug logging due to GUI setting (2) 13:55:16 6.797483 T:1962463232 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 13:55:16 6.797669 T:1962463232 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml 13:55:17 7.019939 T:1962463232 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 13:55:17 7.021730 T:1962463232 DEBUG: CPlayerCoreConfig::: created player VideoPlayer 13:55:17 7.021830 T:1962463232 DEBUG: CPlayerCoreConfig::: created player PAPlayer 13:55:17 7.021869 T:1962463232 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules 13:55:17 7.021905 T:1962463232 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mms/udp 13:55:17 7.021982 T:1962463232 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout 13:55:17 7.022020 T:1962463232 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp 13:55:17 7.022056 T:1962463232 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp 13:55:17 7.022093 T:1962463232 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams 13:55:17 7.022127 T:1962463232 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp 13:55:17 7.022162 T:1962463232 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2 13:55:17 7.022201 T:1962463232 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd 13:55:17 7.022237 T:1962463232 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage 13:55:17 7.022272 T:1962463232 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf 13:55:17 7.022306 T:1962463232 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv 13:55:17 7.022345 T:1962463232 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio 13:55:17 7.022380 T:1962463232 NOTICE: Loaded playercorefactory configuration 13:55:17 7.022658 T:1962463232 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 13:55:17 7.022815 T:1962463232 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 16:32:36 7.053096 T:1962463232 INFO: creating subdirectories 16:32:36 7.053271 T:1962463232 INFO: userdata folder: special://masterprofile/ 16:32:36 7.053329 T:1962463232 INFO: recording folder: 16:32:36 7.053415 T:1962463232 INFO: screenshots folder: /storage/screenshots/ 16:32:36 7.152803 T:1962463232 NOTICE: Running database version Addons26 16:32:36 7.153551 T:1962463232 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcpluff-arm.so) 16:32:36 7.153703 T:1962463232 DEBUG: Loading: /usr/lib/kodi/system/libcpluff-arm.so 16:32:36 7.312788 T:1962463232 INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/kodi/addons: No such file or directory' 16:32:36 7.312994 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in weather.openweathermap.extended has been installed.' 16:32:36 7.313073 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.' 16:32:36 7.313115 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been installed.' 16:32:36 7.313155 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in resource.images.weathericons.default has been installed.' 16:32:36 7.313190 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in xbmc.audioencoder has been installed.' 16:32:36 7.313230 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in script.openweathermap.maps has been installed.' 16:32:36 7.313269 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.' 16:32:36 7.313307 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.' 16:32:36 7.313389 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in kodi.audiodecoder has been installed.' 16:32:36 7.313432 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.' 16:32:36 7.313469 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in kodi.peripheral has been installed.' 16:32:36 7.313504 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in kodi.guilib has been installed.' 16:32:36 7.313542 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in peripheral.joystick has been installed.' 16:32:36 7.313579 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in kodi.adsp has been installed.' 16:32:36 7.313623 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.wma has been installed.' 16:32:36 7.313662 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in game.controller.default has been installed.' 16:32:36 7.313702 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in service.libreelec.settings has been installed.' 16:32:36 7.313741 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.' 16:32:36 7.313797 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in kodi.game has been installed.' 16:32:36 7.313838 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.' 16:32:36 7.313881 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.' 16:32:36 7.313921 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in kodi.resource has been installed.' 16:32:36 7.313956 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.' 16:32:36 7.313993 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.' 16:32:36 7.314028 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in os.openelec.tv has been installed.' 16:32:36 7.314065 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in repository.kodi.game has been installed.' 16:32:36 7.314099 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.' 16:32:36 7.314134 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in os.libreelec.tv has been installed.' 16:32:36 7.314174 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in script.module.requests has been installed.' 16:32:36 7.314212 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in inputstream.smoothstream has been installed.' 16:32:36 7.314246 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in kodi.inputstream has been installed.' 16:32:36 7.314282 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in repository.libreelec.tv has been installed.' 16:32:36 7.314321 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been installed.' 16:32:36 7.314360 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.aac has been installed.' 16:32:36 7.314399 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been installed.' 16:32:36 7.314437 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in script.module.routing has been installed.' 16:32:36 7.314475 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.' 16:32:36 7.314517 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in resource.language.en_gb has been installed.' 16:32:36 7.314555 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.' 16:32:36 7.314594 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.' 16:32:36 7.314632 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.skygo.de has been installed.' 16:32:36 7.314671 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been installed.' 16:32:36 7.314714 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in metadata.local has been installed.' 16:32:36 7.314750 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in xbmc.webinterface has been installed.' 16:32:36 7.314788 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in resource.uisounds.confluence has been installed.' 16:32:36 7.314837 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.' 16:32:36 7.314876 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in resource.language.de_de has been installed.' 16:32:36 7.314917 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been installed.' 16:32:36 7.314964 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been installed.' 16:32:36 7.315009 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.' 16:32:36 7.315049 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.' 16:32:36 7.315086 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.' 16:32:36 7.315124 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in pvr.hts has been installed.' 16:32:36 7.315159 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in xbmc.codec has been installed.' 16:32:36 7.315197 T:1962463232 DEBUG: ADDON: cpluff: 'Plug-in skin.estuary has been installed.' 16:32:36 7.315228 T:1962463232 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.' 16:32:36 7.334254 T:1874850720 DEBUG: Thread JobWorker start, auto delete: true 16:32:36 7.347329 T:1962463232 NOTICE: ADDONS: Using repository repository.kodi.game 16:32:36 7.347420 T:1962463232 NOTICE: ADDONS: Using repository repository.libreelec.tv 16:32:36 7.347452 T:1962463232 NOTICE: ADDONS: Using repository repository.xbmc.org 16:32:36 7.351407 T:1962463232 DEBUG: ADDON: Dll Initializing - InputStream SmoothStreamingMedia 16:32:36 7.351575 T:1962463232 DEBUG: SECTION:LoadDLL(/storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.0) 16:32:36 7.351652 T:1962463232 DEBUG: Loading: /storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.0 16:32:36 7.395699 T:1962463232 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: ADDON_Create() 16:32:36 7.395797 T:1962463232 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: ADDON_Destroy() 16:32:36 7.396165 T:1962463232 DEBUG: SECTION:UnloadDll(/storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.0) 16:32:36 7.399485 T:1962463232 INFO: ADDON: Dll Destroyed - InputStream SmoothStreamingMedia 16:32:36 7.399893 T:1940906912 DEBUG: Thread ActiveAE start, auto delete: false 16:32:36 7.400064 T:1930425248 DEBUG: Thread AESink start, auto delete: false 16:32:36 7.400303 T:1930425248 INFO: CActiveAESink::OpenSink - initialize sink 16:32:36 7.400361 T:1930425248 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 16:32:36 7.400427 T:1930425248 DEBUG: DllBcm: Using omx system library 16:32:36 7.401854 T:1930425248 DEBUG: SECTION:LoadDLL(libopenmaxil.so) 16:32:36 7.403639 T:1930425248 DEBUG: Loading: libopenmaxil.so 16:32:36 7.406965 T:1858073504 DEBUG: Thread CRBPWorker start, auto delete: false 16:32:36 7.407070 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 16:32:36 7.407129 T:1930425248 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI 16:32:36 7.408268 T:1930425248 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x727020d8 16:32:36 7.409322 T:1930425248 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignmen(16) 16:32:36 7.409614 T:1930425248 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 16:32:36 7.409646 T:1930425248 DEBUG: Output Device : HDMI 16:32:36 7.409675 T:1930425248 DEBUG: Sample Rate : 44100 16:32:36 7.409704 T:1930425248 DEBUG: Sample Format : AE_FMT_FLOAT 16:32:36 7.409732 T:1930425248 DEBUG: Channel Count : 2 16:32:36 7.409765 T:1930425248 DEBUG: Channel Layout: FL,FR 16:32:36 7.409793 T:1930425248 DEBUG: Frames : 2205 16:32:36 7.409821 T:1930425248 DEBUG: Frame Size : 8 16:32:36 7.414855 T:1849684896 DEBUG: Thread RemoteControl start, auto delete: false 16:32:36 7.414996 T:1849684896 INFO: LIRC Process: using: /run/lirc/lircd 16:32:36 7.415305 T:1849684896 INFO: LIRC Connect: successfully started 16:32:36 7.415348 T:1849684896 DEBUG: Thread RemoteControl 1849684896 terminating 16:32:36 7.421912 T:1962463232 INFO: CKeyboardLayoutManager: loading keyboard layouts from special://xbmc/system/keyboardlayouts... 16:32:36 7.426506 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Arabic QWERTY" successfully loaded 16:32:36 7.427886 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian ЯВЕРТЪ" successfully loaded 16:32:36 7.428362 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian АБВ" successfully loaded 16:32:36 7.429501 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BasePY" successfully loaded 16:32:36 7.429942 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BaiduPY" successfully loaded 16:32:36 7.430954 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Czech QWERTZ" successfully loaded 16:32:36 7.431870 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Danish QWERTY" successfully loaded 16:32:36 7.433098 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "English QWERTY" successfully loaded 16:32:36 7.433587 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "English AZERTY" successfully loaded 16:32:36 7.434011 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "English ABC" successfully loaded 16:32:36 7.435051 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "French AZERTY" successfully loaded 16:32:36 7.435951 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "German QWERTZ" successfully loaded 16:32:36 7.436894 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Greek QWERTY" successfully loaded 16:32:36 7.437972 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew QWERTY" successfully loaded 16:32:36 7.438397 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew ABC" successfully loaded 16:32:36 7.439382 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Hungarian QWERTZ" successfully loaded 16:32:36 7.440367 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Korean ㄱㄴㄷ" successfully loaded 16:32:36 7.441480 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian AZERTY" successfully loaded 16:32:36 7.441936 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian QWERTY" successfully loaded 16:32:36 7.442846 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Norwegian QWERTY" successfully loaded 16:32:36 7.443789 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Polish QWERTY" successfully loaded 16:32:36 7.444767 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Portuguese (Portugal) QWERTY" successfully loaded 16:32:36 7.445698 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Romanian QWERTY" successfully loaded 16:32:36 7.446866 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian ЙЦУКЕН" successfully loaded 16:32:36 7.447337 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian АБВ" successfully loaded 16:32:36 7.448656 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTZ" successfully loaded 16:32:36 7.449191 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTY" successfully loaded 16:32:36 7.449696 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak ABC" successfully loaded 16:32:36 7.450747 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Spanish QWERTY" successfully loaded 16:32:36 7.451661 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Swedish QWERTY" successfully loaded 16:32:36 7.452561 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Turkish QWERTY" successfully loaded 16:32:36 7.453732 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian ЙЦУКЕН" successfully loaded 16:32:36 7.454212 T:1962463232 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian АБВ" successfully loaded 16:32:36 7.455185 T:1962463232 DEBUG: UDisks: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UDisks was not provided by any .service files 16:32:36 7.455627 T:1962463232 DEBUG: DeviceKit.Disks: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.DeviceKit.Disks was not provided by any .service files 16:32:36 7.457685 T:1962463232 DEBUG: Selected UDev as storage provider 16:32:36 7.458076 T:1962463232 NOTICE: Raspberry PI firmware version: Jul 22 2016 20:29:36 Copyright (c) 2012 Broadcom version 4b80f6dd44e815b5038c0c39802ebfb5db2ed36c (clean) (release) 16:32:36 7.458118 T:1962463232 NOTICE: ARM mem: 752MB GPU mem: 256MB MPG2:1 WVC1:1 16:32:36 7.458176 T:1962463232 NOTICE: cache.memorysize: 20MB 16:32:36 7.458440 T:1962463232 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=0x19f0a overscan_bottom=48 overscan_left=48 overscan_right=48 overscan_top=48 pause_burst_frames=1 program_serial_random=1 sdram_freq=450 temp_limit=85 16:32:36 7.458566 T:1962463232 NOTICE: Config: decode_MPG2=0x86b2be76 decode_WVC1=0x598c2d3c device_tree=- 16:32:36 7.458611 T:1962463232 DEBUG: DllBcm: Using omx system library 16:32:36 7.458646 T:1962463232 NOTICE: InitWindowSystem: Using EGL Implementation: raspberrypi 16:32:36 7.459697 T:1962463232 DEBUG: EGL initial desktop resolution 1920x1080 (1920x1080) @ 60.00 - Full Screen (1.00) 16:32:36 7.460053 T:1962463232 DEBUG: EGL get supported modes (2) = 10, prefer_group=1, prefer_mode=10 16:32:36 7.460101 T:1962463232 DEBUG: EGL mode 0: 640x480 (640x480) @ 60.00 - Full Screen (1.00) :4 16:32:36 7.460151 T:1962463232 DEBUG: EGL mode 1: 800x600 (800x600) @ 60.00 - Full Screen (1.00) :9 16:32:36 7.460197 T:1962463232 DEBUG: EGL mode 2: 1024x768 (1024x768) @ 60.00 - Full Screen (1.00) :10 16:32:36 7.460240 T:1962463232 DEBUG: EGL mode 3: 1280x800 (1280x800) @ 60.00 - Full Screen (1.00) :1c 16:32:36 7.460287 T:1962463232 DEBUG: EGL mode 4: 1280x960 (1280x960) @ 60.00 - Full Screen (1.00) :20 16:32:36 7.460333 T:1962463232 DEBUG: EGL mode 5: 1280x1024 (1280x1024) @ 60.00 - Full Screen (1.00) :23 16:32:36 7.460383 T:1962463232 DEBUG: EGL mode 6: 1400x1050 (1400x1050) @ 60.00 - Full Screen (1.00) :2a 16:32:36 7.460427 T:1962463232 DEBUG: EGL mode 7: 1440x900 (1440x900) @ 60.00 - Full Screen (1.00) :2f 16:32:36 7.460475 T:1962463232 DEBUG: EGL mode 8: 1600x1200 (1440x1080) @ 60.00 - Full Screen (1.00) :33 16:32:36 7.460519 T:1962463232 DEBUG: EGL mode 9: 1680x1050 (1680x1050) @ 60.00 - Full Screen (1.00) :3a 16:32:36 7.460712 T:1962463232 DEBUG: EGL get supported modes (1) = 30, prefer_group=1, prefer_mode=10 16:32:36 7.460757 T:1962463232 DEBUG: EGL mode 0: 640x480 (640x480) @ 60.00 - Full Screen (1.00) :1 16:32:36 7.460823 T:1962463232 DEBUG: EGL mode 1: 720x480 (720x480) @ 60.00 - Full Screen (0.89) :2 16:32:36 7.460869 T:1962463232 DEBUG: EGL mode 2: 720x480 (720x480) @ 60.00 - Full Screen (1.19) :3 16:32:36 7.460916 T:1962463232 DEBUG: EGL mode 3: 1280x720 (1280x720) @ 60.00 - Full Screen (1.00) :4 16:32:36 7.460971 T:1962463232 DEBUG: EGL mode 4: 1920x1080 (1920x1080) @ 60.00i - Full Screen (1.00) I:5 16:32:36 7.461039 T:1962463232 DEBUG: EGL mode 5: 720x480 (720x480) @ 60.00i - Full Screen (0.89) I:6 16:32:36 7.461084 T:1962463232 DEBUG: EGL mode 6: 720x480 (720x480) @ 60.00i - Full Screen (1.19) I:7 16:32:36 7.461130 T:1962463232 DEBUG: EGL mode 7: 720x480 (720x480) @ 60.00i - Full Screen (0.89) I:a 16:32:36 7.461174 T:1962463232 DEBUG: EGL mode 8: 720x480 (720x480) @ 60.00i - Full Screen (1.19) I:b 16:32:36 7.461220 T:1962463232 DEBUG: EGL mode 9: 720x480 (720x480) @ 60.00 - Full Screen (0.89) :e 16:32:36 7.461266 T:1962463232 DEBUG: EGL mode 10: 720x480 (720x480) @ 60.00 - Full Screen (1.19) :f 16:32:36 7.461311 T:1962463232 DEBUG: EGL mode 11: 1920x1080 (1920x1080) @ 60.00 - Full Screen (1.00) N:10 16:32:36 7.461356 T:1962463232 DEBUG: EGL mode 12: 720x576 (720x576) @ 50.00 - Full Screen (1.07) :11 16:32:36 7.461395 T:1962463232 DEBUG: EGL mode 13: 720x576 (720x576) @ 50.00 - Full Screen (1.42) :12 16:32:36 7.461433 T:1962463232 DEBUG: EGL mode 14: 1280x720 (1280x720) @ 50.00 - Full Screen (1.00) :13 16:32:36 7.461473 T:1962463232 DEBUG: EGL mode 15: 1920x1080 (1920x1080) @ 50.00i - Full Screen (1.00) I:14 16:32:36 7.461511 T:1962463232 DEBUG: EGL mode 16: 720x576 (720x576) @ 50.00i - Full Screen (1.07) I:15 16:32:36 7.461549 T:1962463232 DEBUG: EGL mode 17: 720x576 (720x576) @ 50.00i - Full Screen (1.42) I:16 16:32:36 7.461586 T:1962463232 DEBUG: EGL mode 18: 720x576 (720x576) @ 50.00i - Full Screen (1.07) I:19 16:32:36 7.461624 T:1962463232 DEBUG: EGL mode 19: 720x576 (720x576) @ 50.00i - Full Screen (1.42) I:1a 16:32:36 7.461663 T:1962463232 DEBUG: EGL mode 20: 720x576 (720x576) @ 50.00 - Full Screen (1.07) :1d 16:32:36 7.461701 T:1962463232 DEBUG: EGL mode 21: 720x576 (720x576) @ 50.00 - Full Screen (1.42) :1e 16:32:36 7.461743 T:1962463232 DEBUG: EGL mode 22: 1920x1080 (1920x1080) @ 50.00 - Full Screen (1.00) :1f 16:32:36 7.461781 T:1962463232 DEBUG: EGL mode 23: 1920x1080 (1920x1080) @ 24.00 - Full Screen (1.00) :20 16:32:36 7.461837 T:1962463232 DEBUG: EGL mode 24: 1920x1080 (1920x1080) @ 25.00 - Full Screen (1.00) :21 16:32:36 7.461884 T:1962463232 DEBUG: EGL mode 25: 1920x1080 (1920x1080) @ 30.00 - Full Screen (1.00) :22 16:32:36 7.461939 T:1962463232 DEBUG: EGL mode 26: 720x480 (720x480) @ 60.00 - Full Screen (0.89) :23 16:32:36 7.461985 T:1962463232 DEBUG: EGL mode 27: 720x480 (720x480) @ 60.00 - Full Screen (1.19) :24 16:32:36 7.462030 T:1962463232 DEBUG: EGL mode 28: 720x576 (720x576) @ 50.00 - Full Screen (1.07) :25 16:32:36 7.462069 T:1962463232 DEBUG: EGL mode 29: 720x576 (720x576) @ 50.00 - Full Screen (1.42) :26 16:32:36 7.462106 T:1962463232 DEBUG: EGL probe resolution 1920x1080 (1920x1080) @ 60.00 - Full Screen:10010004 16:32:36 7.462143 T:1962463232 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 60.000000 Hz 16:32:36 7.462184 T:1962463232 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 59.940063 Hz 16:32:36 7.462222 T:1962463232 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 60.000000 Hz 16:32:36 7.462257 T:1962463232 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 59.940063 Hz 16:32:36 7.462291 T:1962463232 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 60.000000 Hz 16:32:36 7.462326 T:1962463232 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 59.940063 Hz 16:32:36 7.462359 T:1962463232 NOTICE: Found resolution 1280 x 800 for display 0 with 1280 x 800 @ 60.000000 Hz 16:32:36 7.462394 T:1962463232 NOTICE: Found resolution 1280 x 800 for display 0 with 1280 x 800 @ 59.940063 Hz 16:32:36 7.462431 T:1962463232 NOTICE: Found resolution 1280 x 960 for display 0 with 1280 x 960 @ 60.000000 Hz 16:32:36 7.462466 T:1962463232 NOTICE: Found resolution 1280 x 960 for display 0 with 1280 x 960 @ 59.940063 Hz 16:32:36 7.462499 T:1962463232 NOTICE: Found resolution 1280 x 1024 for display 0 with 1280 x 1024 @ 60.000000 Hz 16:32:36 7.462545 T:1962463232 NOTICE: Found resolution 1280 x 1024 for display 0 with 1280 x 1024 @ 59.940063 Hz 16:32:36 7.462579 T:1962463232 NOTICE: Found resolution 1400 x 1050 for display 0 with 1400 x 1050 @ 60.000000 Hz 16:32:36 7.462614 T:1962463232 NOTICE: Found resolution 1400 x 1050 for display 0 with 1400 x 1050 @ 59.940063 Hz 16:32:36 7.462647 T:1962463232 NOTICE: Found resolution 1440 x 900 for display 0 with 1440 x 900 @ 60.000000 Hz 16:32:36 7.462682 T:1962463232 NOTICE: Found resolution 1440 x 900 for display 0 with 1440 x 900 @ 59.940063 Hz 16:32:36 7.462716 T:1962463232 NOTICE: Found resolution 1440 x 1080 for display 0 with 1600 x 1200 @ 60.000000 Hz 16:32:36 7.462749 T:1962463232 NOTICE: Found resolution 1440 x 1080 for display 0 with 1600 x 1200 @ 59.940063 Hz 16:32:36 7.462809 T:1962463232 NOTICE: Found resolution 1680 x 1050 for display 0 with 1680 x 1050 @ 60.000000 Hz 16:32:36 7.462845 T:1962463232 NOTICE: Found resolution 1680 x 1050 for display 0 with 1680 x 1050 @ 59.940063 Hz 16:32:36 7.462882 T:1962463232 NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 60.000000 Hz 16:32:36 7.462917 T:1962463232 NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 59.940063 Hz 16:32:36 7.462959 T:1962463232 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 60.000000 Hz 16:32:36 7.462994 T:1962463232 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 59.940063 Hz 16:32:36 7.463028 T:1962463232 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 60.000000 Hz 16:32:36 7.463062 T:1962463232 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 59.940063 Hz 16:32:36 7.463096 T:1962463232 NOTICE: Found resolution 720 x 576 for display 0 with 720 x 576 @ 50.000000 Hz 16:32:36 7.463136 T:1962463232 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 50.000000 Hz 16:32:36 7.463170 T:1962463232 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 50.000000 Hz 16:32:36 7.463206 T:1962463232 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 24.000000 Hz 16:32:36 7.463241 T:1962463232 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 23.976025 Hz 16:32:36 7.463275 T:1962463232 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 25.000000 Hz 16:32:36 7.463308 T:1962463232 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 30.000000 Hz 16:32:36 7.463364 T:1962463232 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 29.970032 Hz 16:32:36 7.463398 T:1962463232 NOTICE: Found (1920x1080@60.000000) at 40, setting to RES_DESKTOP at 16 16:32:36 7.463568 T:1962463232 NOTICE: Checking resolution 16 16:32:37 7.564830 T:1930425248 DEBUG: CAESinkPi:Drain delay:100ms now:0ms 16:32:37 7.564888 T:1930425248 DEBUG: CAESinkPi:Deinitialize 16:32:37 7.565102 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 16:32:37 7.566419 T:1930425248 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x727020d8 16:32:37 7.573212 T:1962463232 DEBUG: EGL set HDMI mode (1,16)=0 off 16:32:37 7.656443 T:1903162272 DEBUG: EGL tv_service_callback (8,1,16) 16:32:37 7.657186 T:1962463232 DEBUG: EGL set resolution 1920x1080 -> 1920x1080 @ 60.00 fps (1,16) flags:10010004 aspect:0.94 16:32:37 7.681336 T:1962463232 DEBUG: CreateWindow: Created surface of size 1920x1080 16:32:37 7.681712 T:1940906912 DEBUG: CActiveAE - display reset event 16:32:37 7.681834 T:1930425248 INFO: CActiveAESink::OpenSink - initialize sink 16:32:37 7.681873 T:1962463232 NOTICE: GL_VENDOR = Broadcom 16:32:37 7.681910 T:1962463232 NOTICE: GL_RENDERER = VideoCore IV HW 16:32:37 7.681942 T:1962463232 NOTICE: GL_VERSION = OpenGL ES 2.0 16:32:37 7.681974 T:1962463232 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 16:32:37 7.682010 T:1930425248 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 16:32:37 7.682077 T:1962463232 DEBUG: GLES: Extension Support Test - GL_NVX_gpu_memory_info NO 16:32:37 7.682119 T:1962463232 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:32:37 7.682179 T:1962463232 DEBUG: GLES: Extension Support Test - GL_EXT_texture_format_BGRA8888 YES 16:32:37 7.682221 T:1962463232 DEBUG: GLES: Extension Support Test - GL_IMG_texture_format_BGRA8888 NO 16:32:37 7.682274 T:1962463232 DEBUG: GLES: Extension Support Test - GL_APPLE_texture_format_BGRA8888 NO 16:32:37 7.682310 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 16:32:37 7.682360 T:1930425248 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI 16:32:37 7.683676 T:1930425248 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x7270bf10 16:32:37 7.684768 T:1962463232 DEBUG: GL: Vertex Shader compilation log: 16:32:37 7.684840 T:1930425248 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignmen(16) 16:32:37 7.684911 T:1962463232 DEBUG: Compiled 16:32:37 7.684973 T:1962463232 DEBUG: GL: Vertex Shader compiled successfully 16:32:37 7.685112 T:1930425248 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 16:32:37 7.685143 T:1930425248 DEBUG: Output Device : HDMI 16:32:37 7.685174 T:1930425248 DEBUG: Sample Rate : 44100 16:32:37 7.685204 T:1930425248 DEBUG: Sample Format : AE_FMT_FLOAT 16:32:37 7.685232 T:1930425248 DEBUG: Channel Count : 2 16:32:37 7.685273 T:1930425248 DEBUG: Channel Layout: FL,FR 16:32:37 7.685302 T:1930425248 DEBUG: Frames : 2205 16:32:37 7.685334 T:1962463232 DEBUG: GL: Pixel Shader compilation log: 16:32:37 7.685370 T:1930425248 DEBUG: Frame Size : 8 16:32:37 7.685426 T:1962463232 DEBUG: Compiled 16:32:37 7.685462 T:1962463232 DEBUG: GL: Fragment Shader compiled successfully 16:32:37 7.688955 T:1940906912 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 16:32:37 7.699672 T:1962463232 DEBUG: GUI Shader [guishader_frag_default.glsl]- Initialise successful : 0x20c1a48 16:32:37 7.700461 T:1962463232 DEBUG: GL: Vertex Shader compilation log: 16:32:37 7.700559 T:1962463232 DEBUG: Compiled 16:32:37 7.700591 T:1962463232 DEBUG: GL: Vertex Shader compiled successfully 16:32:37 7.700922 T:1962463232 DEBUG: GL: Pixel Shader compilation log: 16:32:37 7.701018 T:1962463232 DEBUG: Compiled 16:32:37 7.701048 T:1962463232 DEBUG: GL: Fragment Shader compiled successfully 16:32:37 7.713625 T:1962463232 DEBUG: GUI Shader [guishader_frag_texture.glsl]- Initialise successful : 0x1f43c40 16:32:37 7.714272 T:1962463232 DEBUG: GL: Vertex Shader compilation log: 16:32:37 7.714365 T:1962463232 DEBUG: Compiled 16:32:37 7.714396 T:1962463232 DEBUG: GL: Vertex Shader compiled successfully 16:32:37 7.714721 T:1962463232 DEBUG: GL: Pixel Shader compilation log: 16:32:37 7.714818 T:1962463232 DEBUG: Compiled 16:32:37 7.714849 T:1962463232 DEBUG: GL: Fragment Shader compiled successfully 16:32:37 7.728508 T:1962463232 DEBUG: GUI Shader [guishader_frag_multi.glsl]- Initialise successful : 0x20c3888 16:32:37 7.729168 T:1962463232 DEBUG: GL: Vertex Shader compilation log: 16:32:37 7.729260 T:1962463232 DEBUG: Compiled 16:32:37 7.729291 T:1962463232 DEBUG: GL: Vertex Shader compiled successfully 16:32:37 7.729624 T:1962463232 DEBUG: GL: Pixel Shader compilation log: 16:32:37 7.729712 T:1962463232 DEBUG: Compiled 16:32:37 7.729763 T:1962463232 DEBUG: GL: Fragment Shader compiled successfully 16:32:37 7.743444 T:1962463232 DEBUG: GUI Shader [guishader_frag_fonts.glsl]- Initialise successful : 0x20c23e8 16:32:37 7.744130 T:1962463232 DEBUG: GL: Vertex Shader compilation log: 16:32:37 7.744225 T:1962463232 DEBUG: Compiled 16:32:37 7.744259 T:1962463232 DEBUG: GL: Vertex Shader compiled successfully 16:32:37 7.744572 T:1962463232 DEBUG: GL: Pixel Shader compilation log: 16:32:37 7.744660 T:1962463232 DEBUG: Compiled 16:32:37 7.744692 T:1962463232 DEBUG: GL: Fragment Shader compiled successfully 16:32:37 7.757074 T:1962463232 DEBUG: GUI Shader [guishader_frag_texture_noblend.glsl]- Initialise successful : 0x20c2460 16:32:37 7.757719 T:1962463232 DEBUG: GL: Vertex Shader compilation log: 16:32:37 7.757820 T:1962463232 DEBUG: Compiled 16:32:37 7.757851 T:1962463232 DEBUG: GL: Vertex Shader compiled successfully 16:32:37 7.758188 T:1962463232 DEBUG: GL: Pixel Shader compilation log: 16:32:37 7.758283 T:1962463232 DEBUG: Compiled 16:32:37 7.758314 T:1962463232 DEBUG: GL: Fragment Shader compiled successfully 16:32:37 7.771320 T:1962463232 DEBUG: GUI Shader [guishader_frag_multi_blendcolor.glsl]- Initialise successful : 0x1f3f5e8 16:32:37 7.771946 T:1962463232 DEBUG: GL: Vertex Shader compilation log: 16:32:37 7.772038 T:1962463232 DEBUG: Compiled 16:32:37 7.772069 T:1962463232 DEBUG: GL: Vertex Shader compiled successfully 16:32:37 7.772411 T:1962463232 DEBUG: GL: Pixel Shader compilation log: 16:32:37 7.772498 T:1962463232 DEBUG: Compiled 16:32:37 7.772529 T:1962463232 DEBUG: GL: Fragment Shader compiled successfully 16:32:37 7.785738 T:1962463232 DEBUG: GUI Shader [guishader_frag_rgba.glsl]- Initialise successful : 0x1f3f660 16:32:37 7.785788 T:1962463232 DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external YES 16:32:37 7.786446 T:1962463232 DEBUG: GL: Vertex Shader compilation log: 16:32:37 7.786540 T:1962463232 DEBUG: Compiled 16:32:37 7.786578 T:1962463232 DEBUG: GL: Vertex Shader compiled successfully 16:32:37 7.786924 T:1962463232 DEBUG: GL: Pixel Shader compilation log: 16:32:37 7.787019 T:1962463232 DEBUG: Compiled 16:32:37 7.787054 T:1962463232 DEBUG: GL: Fragment Shader compiled successfully 16:32:37 7.802180 T:1962463232 DEBUG: GUI Shader [guishader_frag_rgba_oes.glsl]- Initialise successful : 0x1f41f00 16:32:37 7.802839 T:1962463232 DEBUG: GL: Vertex Shader compilation log: 16:32:37 7.802931 T:1962463232 DEBUG: Compiled 16:32:37 7.802971 T:1962463232 DEBUG: GL: Vertex Shader compiled successfully 16:32:37 7.803297 T:1962463232 DEBUG: GL: Pixel Shader compilation log: 16:32:37 7.803388 T:1962463232 DEBUG: Compiled 16:32:37 7.803419 T:1962463232 DEBUG: GL: Fragment Shader compiled successfully 16:32:37 7.816218 T:1962463232 DEBUG: GUI Shader [guishader_frag_rgba_blendcolor.glsl]- Initialise successful : 0x1f41f78 16:32:37 7.816865 T:1962463232 DEBUG: GL: Vertex Shader compilation log: 16:32:37 7.816973 T:1962463232 DEBUG: Compiled 16:32:37 7.817005 T:1962463232 DEBUG: GL: Vertex Shader compiled successfully 16:32:37 7.817419 T:1962463232 DEBUG: GL: Pixel Shader compilation log: 16:32:37 7.817508 T:1962463232 DEBUG: Compiled 16:32:37 7.817539 T:1962463232 DEBUG: GL: Fragment Shader compiled successfully 16:32:37 7.834003 T:1962463232 DEBUG: GUI Shader [guishader_frag_rgba_bob.glsl]- Initialise successful : 0x1f40500 16:32:37 7.834063 T:1962463232 DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external YES 16:32:37 7.834756 T:1962463232 DEBUG: GL: Vertex Shader compilation log: 16:32:37 7.834850 T:1962463232 DEBUG: Compiled 16:32:37 7.834881 T:1962463232 DEBUG: GL: Vertex Shader compiled successfully 16:32:37 7.835317 T:1962463232 DEBUG: GL: Pixel Shader compilation log: 16:32:37 7.835407 T:1962463232 DEBUG: Compiled 16:32:37 7.835438 T:1962463232 DEBUG: GL: Fragment Shader compiled successfully 16:32:37 7.853808 T:1962463232 DEBUG: GUI Shader [guishader_frag_rgba_bob_oes.glsl]- Initialise successful : 0x1f40578 16:32:37 7.853883 T:1962463232 DEBUG: CWinSystemEGL::CreateNewWindow: No need to create a new window 16:32:37 7.853946 T:1962463232 INFO: GLES: Maximum texture width: 2048 16:32:37 8.269725 T:1962463232 INFO: GLES: Enabling VSYNC 16:32:37 8.269838 T:1962463232 INFO: GLES: Selected vsync mode 10 16:32:37 8.269917 T:1962463232 INFO: load keymapping 16:32:37 8.273920 T:1962463232 INFO: Loading special://xbmc/system/keymaps/appcommand.xml 16:32:37 8.274604 T:1962463232 INFO: Loading special://xbmc/system/keymaps/customcontroller.AppleRemote.xml 16:32:37 8.277871 T:1962463232 INFO: Loading special://xbmc/system/keymaps/customcontroller.Harmony.xml 16:32:37 8.284809 T:1962463232 INFO: Loading special://xbmc/system/keymaps/gamepad.xml 16:32:37 8.290993 T:1962463232 INFO: Loading special://xbmc/system/keymaps/joystick.xml 16:32:37 8.296484 T:1962463232 INFO: Loading special://xbmc/system/keymaps/keyboard.xml 16:32:37 8.313978 T:1962463232 INFO: Loading special://xbmc/system/keymaps/mouse.xml 16:32:37 8.315333 T:1962463232 INFO: Loading special://xbmc/system/keymaps/remote.xml 16:32:37 8.325856 T:1962463232 ERROR: Window Translator: Can't find window librarysettings 16:32:37 8.329146 T:1962463232 INFO: Loading special://xbmc/system/keymaps/touchscreen.xml 16:32:37 8.334161 T:1962463232 INFO: Loading special://xbmc/system/Lircmap.xml 16:32:37 8.340604 T:1962463232 INFO: * Adding remote mapping for device 'mceusb' 16:32:37 8.340898 T:1962463232 INFO: * Adding remote mapping for device 'XboxDVDDongle' 16:32:37 8.340991 T:1962463232 INFO: * Adding remote mapping for device 'Microsoft_Xbox' 16:32:37 8.341069 T:1962463232 INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote' 16:32:37 8.341151 T:1962463232 INFO: * Adding remote mapping for device 'anysee' 16:32:37 8.341237 T:1962463232 INFO: * Adding remote mapping for device 'iMON-PAD' 16:32:37 8.341340 T:1962463232 INFO: * Adding remote mapping for device 'Antec_Veris_RM200' 16:32:37 8.341432 T:1962463232 INFO: * Adding remote mapping for device 'MCE_via_iMON' 16:32:37 8.341524 T:1962463232 INFO: * Adding remote mapping for device 'TwinHanRemote' 16:32:37 8.341599 T:1962463232 INFO: * Adding remote mapping for device 'linux-input-layer' 16:32:37 8.341743 T:1962463232 INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote' 16:32:37 8.341775 T:1962463232 INFO: * Adding remote mapping for device 'mediacenter' 16:32:37 8.341873 T:1962463232 INFO: * Adding remote mapping for device 'devinput' 16:32:37 8.342849 T:1962463232 DEBUG: CButtonTranslator::Load - no userdata Lircmap.xml found, skipping 16:32:37 8.342891 T:1962463232 INFO: GUI format 1920x1080, Display 1920x1080 (1920x1080) @ 60.00 - Full Screen 16:32:37 8.342921 T:1962463232 DEBUG: guilib: Fill viewport on change for solving rendering passes 16:32:37 8.343732 T:1962463232 INFO: CLangInfo: loading resource.language.de_de language information... 16:32:37 8.346339 T:1962463232 DEBUG: trying to set locale to de_DE.UTF-8 16:32:37 8.351858 T:1962463232 INFO: global locale set to C 16:32:37 8.352183 T:1962463232 INFO: CLangInfo: loading resource.language.de_de language strings... 16:32:37 8.421729 T:1962463232 DEBUG: LocalizeStrings: loaded 3678 strings from file resource://resource.language.de_de/strings.po 16:32:37 8.457790 T:1962463232 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:32:37 8.463696 T:1962463232 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:32:37 8.463767 T:1962463232 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:32:37 8.468062 T:1962463232 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:32:37 8.468110 T:1962463232 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:32:37 8.468441 T:1962463232 DEBUG: POParser: id:38101 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead 16:32:37 8.468742 T:1962463232 DEBUG: LocalizeStrings: loaded 71 strings from file resource://resource.language.en_gb/strings.po 16:32:37 8.483776 T:1962463232 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.xbmc.builtin.aac/resources/language/English/strings.po 16:32:37 8.485259 T:1962463232 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.xbmc.builtin.wma/resources/language/English/strings.po 16:32:38 8.491207 T:1962463232 DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/game.controller.default/resources/language/resource.language.en_gb/strings.po 16:32:38 8.494403 T:1962463232 DEBUG: LocalizeStrings: loaded 11 strings from file /storage/.kodi/addons/metadata.album.universal/resources/language/German/strings.po 16:32:38 8.496034 T:1962463232 DEBUG: LocalizeStrings: loaded 2 strings from file /storage/.kodi/addons/metadata.album.universal/resources/language/English/strings.po 16:32:38 8.498948 T:1962463232 DEBUG: LocalizeStrings: loaded 23 strings from file /storage/.kodi/addons/metadata.artists.universal/resources/language/German/strings.po 16:32:38 8.500679 T:1962463232 DEBUG: LocalizeStrings: loaded 3 strings from file /storage/.kodi/addons/metadata.artists.universal/resources/language/English/strings.po 16:32:38 8.513154 T:1962463232 DEBUG: LocalizeStrings: loaded 7 strings from file /storage/.kodi/addons/metadata.themoviedb.org/resources/language/German/strings.po 16:32:38 8.514867 T:1962463232 DEBUG: LocalizeStrings: loaded 0 strings from file /storage/.kodi/addons/metadata.themoviedb.org/resources/language/English/strings.po 16:32:38 8.516467 T:1962463232 DEBUG: LocalizeStrings: loaded 5 strings from file /usr/share/kodi/addons/metadata.tvdb.com/resources/language/German/strings.po 16:32:38 8.517591 T:1962463232 DEBUG: LocalizeStrings: loaded 2 strings from file /usr/share/kodi/addons/metadata.tvdb.com/resources/language/English/strings.po 16:32:38 8.519458 T:1962463232 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/peripheral.joystick/resources/language/English/strings.po 16:32:38 8.529062 T:1962463232 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.de_de/strings.po 16:32:38 8.529510 T:1962463232 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.en_gb/strings.po 16:32:38 8.536215 T:1962463232 DEBUG: LocalizeStrings: loaded 188 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/German/strings.po 16:32:38 8.538658 T:1962463232 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:32:38 8.538778 T:1962463232 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:32:38 8.538858 T:1962463232 DEBUG: POParser: id:611 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead 16:32:38 8.539711 T:1962463232 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:32:38 8.540408 T:1962463232 DEBUG: LocalizeStrings: loaded 16 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/English/strings.po 16:32:38 8.549059 T:1962463232 DEBUG: LocalizeStrings: loaded 24 strings from file /storage/.kodi/addons/weather.openweathermap.extended/resources/language/German/strings.po 16:32:38 8.551639 T:1962463232 DEBUG: LocalizeStrings: loaded 81 strings from file /storage/.kodi/addons/weather.openweathermap.extended/resources/language/English/strings.po 16:32:38 8.554509 T:1962463232 DEBUG: LocalizeStrings: loaded 68 strings from file /storage/.kodi/addons/pvr.hts/resources/language/resource.language.de_de/strings.po 16:32:38 8.556317 T:1962463232 DEBUG: LocalizeStrings: loaded 0 strings from file /storage/.kodi/addons/pvr.hts/resources/language/resource.language.en_gb/strings.po 16:32:38 8.558615 T:1962463232 DEBUG: LocalizeStrings: loaded 5 strings from file /storage/.kodi/addons/inputstream.smoothstream/resources/language/resource.language.en_gb/strings.po 16:32:38 8.566455 T:1962463232 DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid" 16:32:38 8.566889 T:1962463232 DEBUG: LoadMappings - loaded node "CEC Adapter" 16:32:38 8.566974 T:1962463232 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter" 16:32:38 8.567155 T:1962463232 DEBUG: LoadMappings - loaded node "iMON HID device" 16:32:38 8.567228 T:1962463232 DEBUG: LoadMappings - loaded node "WETEK Play remote" 16:32:38 8.567588 T:1962463232 DEBUG: CPeripheralBusUSB - initialised udev monitor 16:32:38 8.567633 T:1962463232 DEBUG: SECTION:LoadDLL(libcec.so.3) 16:32:38 8.569194 T:1962463232 DEBUG: Loading: libcec.so.3 16:32:38 8.586976 T:1962463232 DEBUG: PERIPHERAL - CreateAddon - creating peripheral add-on instance 'Joystick Support' 16:32:38 8.587081 T:1962463232 DEBUG: ADDON: Dll Initializing - Joystick Support 16:32:38 8.587392 T:1962463232 DEBUG: SECTION:LoadDLL(/usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.1.0) 16:32:38 8.587480 T:1962463232 DEBUG: Loading: /usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.1.0 16:32:38 8.618145 T:1962463232 DEBUG: Calling TransferSettings for: Joystick Support 16:32:38 8.619604 T:1962463232 DEBUG: AddOnLog: Joystick Support: Setting "deadzone" set to 0.200000 16:32:38 8.619894 T:1841296288 DEBUG: Thread PeripBusUSBUdev start, auto delete: false 16:32:38 8.620142 T:1832907680 DEBUG: Thread PeripBusCEC start, auto delete: false 16:32:38 8.620284 T:1824519072 DEBUG: Thread PeripBusAddon start, auto delete: false 16:32:38 8.620429 T:1962463232 DEBUG: SECTION:LoadDLL(libcurl.so.4) 16:32:38 8.620691 T:1816130464 DEBUG: Thread PeripEventScanner start, auto delete: false 16:32:38 8.622142 T:1962463232 DEBUG: Loading: libcurl.so.4 16:32:38 8.638555 T:1962463232 NOTICE: Running database version Addons26 16:32:38 8.639014 T:1962463232 DEBUG: Initialize, updating databases... 16:32:38 8.642649 T:1962463232 NOTICE: Running database version ViewModes6 16:32:38 8.712540 T:1962463232 NOTICE: Running database version Textures13 16:32:38 8.728260 T:1962463232 NOTICE: Running database version MyMusic60 16:32:38 8.747433 T:1832907680 DEBUG: GetMappingForDevice - device (2708:1001) mapped to CEC Adapter (type = cec) 16:32:38 8.749625 T:1832907680 DEBUG: InitialiseFeature - using libCEC v3.1.0 16:32:38 8.749785 T:1832907680 DEBUG: Initialise - initialised peripheral on 'RPI' with 2 features and 0 sub devices 16:32:38 8.749825 T:1796207520 DEBUG: Thread CECAdapter start, auto delete: false 16:32:38 8.749870 T:1832907680 NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001) 16:32:38 8.749910 T:1796207520 DEBUG: OpenConnection - opening a connection to the CEC adapter: RPI 16:32:38 8.749951 T:1832907680 DEBUG: Thread PeripBusCEC 1832907680 terminating 16:32:38 8.755852 T:1962463232 NOTICE: Running database version MyVideos107 16:32:38 8.760633 T:1962463232 NOTICE: Running database version TV29 16:32:38 8.766679 T:1962463232 NOTICE: Running database version Epg11 16:32:38 8.769603 T:1962463232 DEBUG: Initialize, updating databases... DONE 16:32:38 8.769684 T:1962463232 NOTICE: start dvd mediatype detection 16:32:38 8.769870 T:1962463232 INFO: DPMS: not supported on this platform 16:32:38 8.769923 T:1953604512 DEBUG: Thread DetectDVDMedia start, auto delete: false 16:32:38 8.769972 T:1953604512 DEBUG: Compiled with libcdio Version 0.93 16:32:38 8.772631 T:1953604512 DEBUG: Thread DetectDVDMedia 1953604512 terminating 16:32:38 8.801374 T:1962455968 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 16:32:38 8.801507 T:1962455968 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 16:32:38 8.803289 T:1962463232 DEBUG: Activating window ID: 12997 16:32:38 8.803421 T:1962463232 DEBUG: ------ Window Init () ------ 16:32:38 8.803636 T:1962463232 INFO: load splash image: /usr/share/kodi/media/Splash.png 16:32:38 8.806234 T:1962463232 INFO: Unloading old skin ... 16:32:38 8.806750 T:1962463232 INFO: load skin from: /usr/share/kodi/addons/skin.estuary (version: 0.8.4) 16:32:38 8.807634 T:1962463232 INFO: load fonts for skin... 16:32:38 8.812646 T:1962463232 INFO: Loading fonts from /usr/share/kodi/addons/skin.estuary/1080i/Font.xml 16:32:38 8.934588 T:1962463232 DEBUG: LocalizeStrings: loaded 135 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.de_de/strings.po 16:32:38 8.936347 T:1962463232 DEBUG: LocalizeStrings: loaded 7 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.en_gb/strings.po 16:32:38 8.936724 T:1962463232 INFO: Loading skin includes from /usr/share/kodi/addons/skin.estuary/1080i/Includes.xml 16:32:38 9.090130 T:1962463232 INFO: load new skin... 16:32:38 9.090340 T:1962463232 INFO: Loading user windows, path /usr/share/kodi/addons/skin.estuary/1080i 16:32:38 9.109339 T:1962463232 DEBUG: Load Skin XML: 20.02ms 16:32:38 9.109427 T:1962463232 INFO: initialize new skin... 16:32:38 9.109468 T:1962463232 DEBUG: guilib: Fill viewport on change for solving rendering passes 16:32:38 9.109525 T:1962463232 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT 16:32:38 9.127303 T:1962463232 DEBUG: OpenBundle - Opened bundle /usr/share/kodi/addons/skin.estuary/media/Textures.xbt 16:32:38 9.135304 T:1962463232 INFO: Loading skin file: DialogNotification.xml, load type: LOAD_ON_GUI_INIT 16:32:38 9.138058 T:1962463232 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT 16:32:38 9.152761 T:1962463232 INFO: Loading skin file: DialogSettings.xml, load type: LOAD_ON_GUI_INIT 16:32:38 9.187116 T:1962463232 INFO: Previous line repeats 1 times. 16:32:38 9.187215 T:1962463232 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT 16:32:38 9.190869 T:1962463232 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT 16:32:38 9.195589 T:1962463232 INFO: Loading skin file: DialogSubtitles.xml, load type: LOAD_ON_GUI_INIT 16:32:38 9.211319 T:1962463232 INFO: Loading skin file: DialogPVRChannelsOSD.xml, load type: LOAD_ON_GUI_INIT 16:32:38 9.223527 T:1962463232 INFO: Loading skin file: DialogPVRGuideOSD.xml, load type: LOAD_ON_GUI_INIT 16:32:38 9.230996 T:1962463232 INFO: Loading skin file: VideoOSD.xml, load type: LOAD_ON_GUI_INIT 16:32:38 9.277144 T:1962463232 INFO: Loading resource://resource.uisounds.confluence/sounds.xml 16:32:38 9.460293 T:1962463232 INFO: skin loaded... 16:32:38 9.460399 T:1962463232 DEBUG: Activating window ID: 12997 16:32:38 9.460457 T:1962463232 DEBUG: ------ Window Init () ------ 16:32:38 9.460658 T:1962463232 INFO: load splash image: /usr/share/kodi/media/Splash.png 16:32:39 9.507022 T:1962463232 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting 16:32:39 9.507138 T:1962463232 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 16:32:39 9.507177 T:1962463232 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting") 16:32:39 9.507717 T:1962463232 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting 16:32:39 9.571864 T:1962463232 ERROR: JSONRPC: Unable to parse JSON Schema definition for "" 16:32:39 9.571960 T:1962463232 ERROR: JSONRPC: Invalid JSON Schema definition for method "" 16:32:39 9.586428 T:1962463232 INFO: JSONRPC v7.20.1: Successfully initialized 16:32:39 9.586548 T:1962463232 DEBUG: ADDON: Starting service addons. 16:32:39 9.589581 T:1962463232 DEBUG: Activating window ID: 12999 16:32:39 9.589696 T:1962463232 DEBUG: ------ Window Init (Startup.xml) ------ 16:32:39 9.589733 T:1962463232 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME 16:32:39 9.590900 T:1962463232 DEBUG: Activating window ID: 10000 16:32:39 9.591026 T:1962463232 DEBUG: ------ Window Deinit (Startup.xml) ------ 16:32:39 9.591080 T:1962463232 DEBUG: ------ Window Init (Home.xml) ------ 16:32:39 9.591116 T:1962463232 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY 16:32:39 9.954027 T:1962463232 DEBUG: CDirectoryProvider[special://skin/playlists/inprogress_movies.xsp]: refreshing.. 16:32:39 9.954210 T:1962463232 DEBUG: CDirectoryProvider[videodb://recentlyaddedmovies/]: refreshing.. 16:32:39 9.954425 T:1962463232 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_movies.xsp]: refreshing.. 16:32:39 9.954477 T:1779430304 DEBUG: Thread JobWorker start, auto delete: true 16:32:39 9.954535 T:1962463232 DEBUG: CDirectoryProvider[special://skin/playlists/random_movies.xsp]: refreshing.. 16:32:39 9.954697 T:1771041696 DEBUG: Thread JobWorker start, auto delete: true 16:32:39 9.954840 T:1962463232 DEBUG: CDirectoryProvider[videodb://inprogresstvshows]: refreshing.. 16:32:39 9.954913 T:1962463232 DEBUG: CDirectoryProvider[videodb://recentlyaddedepisodes/]: refreshing.. 16:32:39 9.954986 T:1962463232 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_tvshows.xsp]: refreshing.. 16:32:39 9.970622 T:1962463232 DEBUG: CDirectoryProvider[musicdb://recentlyplayedalbums]: refreshing.. 16:32:39 9.970746 T:1962463232 DEBUG: CDirectoryProvider[musicdb://recentlyaddedalbums/]: refreshing.. 16:32:39 9.970795 T:1962463232 DEBUG: CDirectoryProvider[special://skin/playlists/random_albums.xsp]: refreshing.. 16:32:39 9.970865 T:1962463232 DEBUG: CDirectoryProvider[special://skin/playlists/random_artists.xsp]: refreshing.. 16:32:39 9.970912 T:1962463232 DEBUG: CDirectoryProvider[special://skin/playlists/unplayed_albums.xsp]: refreshing.. 16:32:39 9.970986 T:1962463232 DEBUG: CDirectoryProvider[special://skin/playlists/mostplayed_albums.xsp]: refreshing.. 16:32:39 9.971118 T:1962463232 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 16:32:39 9.971189 T:1962463232 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 16:32:39 9.971243 T:1962463232 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 16:32:39 9.971301 T:1962463232 DEBUG: CDirectoryProvider[-]: refreshing.. 16:32:39 9.971351 T:1962463232 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 16:32:39 9.971466 T:1962463232 DEBUG: CDirectoryProvider[sources://video/]: refreshing.. 16:32:39 9.971519 T:1962463232 DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing.. 16:32:39 9.978127 T:1779430304 DEBUG: RunQuery took 3 ms for 0 items query: select * from movie_view ORDER BY dateAdded desc, idMovie desc LIMIT 25 16:32:39 9.984184 T:1874850720 DEBUG: RunQuery took 3 ms for 0 items query: select * from movie_view WHERE (movie_view.idFile IN (SELECT DISTINCT idFile FROM bookmark WHERE type = 1)) 16:32:39 9.997891 T:1771041696 DEBUG: RunQuery took 2 ms for 0 items query: select * from movie_view WHERE ((movie_view.playCount IS NULL OR movie_view.playCount = 0)) 16:32:39 10.004352 T:1779430304 DEBUG: RunQuery took 4 ms for 0 items query: select * from movie_view 16:32:39 10.024804 T:1771041696 DEBUG: RunQuery took 3 ms for 0 items query: select * from episode_view ORDER BY dateAdded desc, idEpisode desc LIMIT 25 16:32:39 10.034460 T:1874850720 DEBUG: RunQuery took 2 ms for 0 items query: SELECT * FROM tvshow_view WHERE watchedCount != 0 AND totalCount != watchedCount ORDER BY c00 16:32:39 10.041344 T:1796207520 DEBUG: OpenConnection - connection to the CEC adapter opened 16:32:39 10.041521 T:1796207520 DEBUG: SetConfigurationFromLibCEC - settings updated by libCEC 16:32:39 10.042005 T:1760555936 DEBUG: Thread CECAdapterUpdate start, auto delete: false 16:32:39 10.043994 T:1779430304 DEBUG: RunQuery took 5 ms for 0 items query: SELECT * FROM tvshow_view WHERE ((CAST(tvshow_view.watchedcount as DECIMAL(5,1)) = 0)) AND ((CAST(tvshow_view.totalCount as DECIMAL(5,1)) > 0)) 16:32:39 10.045609 T:1962463232 INFO: removing tempfiles 16:32:39 10.046647 T:1874850720 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:32:39 10.047396 T:1962463232 DEBUG: ADDON: Starting service addons. 16:32:39 10.053136 T:1752167328 DEBUG: Thread LanguageInvoker start, auto delete: false 16:32:39 10.053326 T:1752167328 INFO: initializing python engine. 16:32:39 10.054640 T:1771041696 DEBUG: GetRecentlyPlayedAlbums query: SELECT albumview.*, albumartistview.* FROM (SELECT idAlbum FROM albumview WHERE albumview.lastplayed IS NOT NULL 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:32:39 10.058013 T:1779430304 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE albumview.strReleaseType = 'album' 16:32:39 10.059050 T:1779430304 DEBUG: GetAlbumsByWhere - query took 1 ms 16:32:39 10.070877 T:1962463232 DEBUG: CRepositoryUpdater: previous update at 11.08.2016 21:34:06, next at 12.08.2016 21:34:06 16:32:39 10.071115 T:1962463232 NOTICE: initialize done 16:32:39 10.071163 T:1962463232 NOTICE: Running the application... 16:32:39 10.074417 T:1779430304 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE (albumview.strReleaseType = 'album') AND (((CAST(albumview.iTimesPlayed as DECIMAL(5,1)) = 0))) 16:32:39 10.076505 T:1779430304 DEBUG: GetAlbumsByWhere - query took 2 ms 16:32:39 10.079280 T:1743778720 DEBUG: Thread Timer start, auto delete: false 16:32:39 10.079488 T:1874850720 DEBUG: GetArtistsByWhere query: SELECT artistview.* FROM artistview WHERE (artistview.idArtist IN (SELECT album_artist.idArtist FROM album_artist ) OR artistview.idArtist IN (SELECT song_artist.idArtist FROM song_artist WHERE song_artist.idRole = 1)) and artistview.strArtist != '' and artistview.strArtist <> 'Verschiedene Interpreten' 16:32:39 10.080634 T:1874850720 DEBUG: Time to retrieve artists from dataset = 11 16:32:39 10.092770 T:1771041696 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE (albumview.strReleaseType = 'album') AND (((CAST(albumview.iTimesPlayed as DECIMAL(5,1)) > 0))) 16:32:39 10.095465 T:1874850720 ERROR: GetDirectory - Error getting - 16:32:39 10.096244 T:1962463232 DEBUG: no profile autoexec.py (/storage/.kodi/userdata/autoexec.py) found, skipping 16:32:39 10.096333 T:1962463232 DEBUG: NetworkMessage - Starting network services 16:32:39 10.097909 T:1771041696 DEBUG: GetAlbumsByWhere - query took 4 ms 16:32:39 10.103638 T:1962463232 DEBUG: CZeroconfAvahi::clientCallback: client is up and running 16:32:39 10.103981 T:1962463232 NOTICE: starting zeroconf publishing 16:32:39 10.104897 T:1962463232 NOTICE: CWebServer[8080]: Started 16:32:39 10.105093 T:1962463232 NOTICE: starting upnp client 16:32:39 10.107353 T:1779430304 DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3A%2F%2Fprofile%2Fplaylists%2Fvideo/special%3A%2F%2Fprofile%2Fplaylists%2Fmixed/) 16:32:39 10.107649 T:1779430304 DEBUG: Getting Directory (special://profile/playlists/video) 16:32:39 10.109150 T:1779430304 DEBUG: Getting Directory (special://profile/playlists/mixed) 16:32:39 10.110497 T:1779430304 DEBUG: CMultiPathDirectory::MergeItems, items = 0 16:32:39 10.110912 T:1779430304 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update 16:32:39 10.127316 T:1779430304 DEBUG: GetRecentlyAddedAlbumSongs() query: SELECT songview.*, songartistview.* FROM (SELECT idAlbum FROM album ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN songview ON songview.idAlbum = recentalbums.idAlbum JOIN songartistview ON songview.idSong = songartistview.idSong ORDER BY songview.idAlbum desc, songview.itrack, songartistview.iOrder 16:32:39 10.129548 T:1779430304 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:32:39 10.130172 T:1874850720 DEBUG: PVR - Create - creating PVR add-on instance 'Tvheadend HTSP Client' 16:32:39 10.130309 T:1874850720 DEBUG: ADDON: Dll Initializing - Tvheadend HTSP Client 16:32:39 10.130514 T:1874850720 DEBUG: SECTION:LoadDLL(/storage/.kodi/addons/pvr.hts/pvr.hts.so.3.4.6) 16:32:39 10.130612 T:1874850720 DEBUG: Loading: /storage/.kodi/addons/pvr.hts/pvr.hts.so.3.4.6 16:32:39 10.132570 T:1962463232 INFO: JSONRPC Server: Successfully initialized 16:32:39 10.133996 T:1779430304 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update 16:32:39 10.136069 T:1674572704 DEBUG: Thread EventServer start, auto delete: false 16:32:39 10.137473 T:1666184096 DEBUG: Thread TCPServer start, auto delete: false 16:32:39 10.140103 T:1674572704 NOTICE: ES: Starting UDP Event server on port 9777 16:32:39 10.147012 T:1674572704 NOTICE: UDP: Listening on port 9777 (ipv6 : true) 16:32:39 10.149570 T:1962463232 DEBUG: SECTION:LoadDLL(libshairplay.so.0) 16:32:39 10.153613 T:1962463232 DEBUG: Loading: libshairplay.so.0 16:32:39 10.156974 T:1752167328 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): start processing 16:32:39 10.168020 T:1962463232 INFO: AIRPLAY: Cleaning up photoassetcache 16:32:39 10.169458 T:1874850720 INFO: AddOnLog: Tvheadend HTSP Client: pvr.hts - starting PVR client 16:32:39 10.169722 T:1874850720 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'host' 16:32:39 10.175428 T:1874850720 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'htsp_port' 16:32:39 10.177939 T:1874850720 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'http_port' 16:32:39 10.180319 T:1874850720 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'user' 16:32:39 10.182500 T:1874850720 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'pass' 16:32:39 10.184983 T:1874850720 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'connect_timeout' 16:32:39 10.185682 T:1962463232 INFO: AIRPLAY Server: Successfully initialized 16:32:39 10.186490 T:1597617056 DEBUG: Thread AirPlayServer start, auto delete: false 16:32:39 10.186897 T:1874850720 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'response_timeout' 16:32:39 10.189161 T:1874850720 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'trace_debug' 16:32:39 10.190837 T:1779430304 DEBUG: RunQuery took 5 ms for 0 items query: select * from movie_view ORDER BY dateAdded desc, idMovie desc LIMIT 10 16:32:39 10.191157 T:1874850720 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'epg_async' 16:32:39 10.193066 T:1874850720 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'pretuner_enabled' 16:32:39 10.194332 T:1779430304 DEBUG: RunQuery took 2 ms for 0 items query: select * from episode_view ORDER BY dateAdded desc, idEpisode desc LIMIT 10 16:32:39 10.194987 T:1874850720 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'autorec_approxtime' 16:32:39 10.196775 T:1874850720 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'autorec_maxdiff' 16:32:39 10.197250 T:1779430304 DEBUG: RunQuery took 1 ms for 0 items query: select * from musicvideo_view ORDER BY dateAdded desc, idMVideo desc LIMIT 10 16:32:39 10.198940 T:1874850720 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'streaming_profile' 16:32:39 10.200198 T:1779430304 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 16:32:39 10.200933 T:1874850720 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'dvr_priority' 16:32:39 10.202927 T:1874850720 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'dvr_lifetime' 16:32:39 10.204837 T:1874850720 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'dvr_dubdetect' 16:32:39 10.208755 T:1779430304 DEBUG: GetArtistsByWhere query: SELECT COUNT(DISTINCT artistview.idArtist) FROM artistview WHERE (artistview.idArtist IN (SELECT album_artist.idArtist FROM album_artist ) OR artistview.idArtist IN (SELECT song_artist.idArtist FROM song_artist WHERE song_artist.idRole = 1)) and artistview.strArtist != '' and artistview.strArtist <> 'Verschiedene Interpreten' 16:32:39 10.210336 T:1874850720 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - connection state change (0 -> 7) 16:32:39 10.210606 T:1874850720 DEBUG: PVR - PVRConnectionStateChange - state for connection '192.168.178.20:9982' on client 'Tvheadend HTSP Client' changed from '0' to '7' 16:32:39 10.210905 T:1580839840 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - new connection requested 16:32:39 10.211977 T:1580839840 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - connecting to 192.168.178.20:9982 16:32:39 10.213881 T:1580839840 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - connected 16:32:39 10.216083 T:1771041696 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:Kodi (LibreELEC-3) port:8080 16:32:39 10.216357 T:1771041696 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC-3) type: _http._tcp port:8080 16:32:39 10.221107 T:1874850720 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:Kodi (LibreELEC-3) port:8080 16:32:39 10.221404 T:1566569376 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - sending hello 16:32:39 10.223724 T:1752167328 DEBUG: -->Python Interpreter Initialized<-- 16:32:39 10.224039 T:1752167328 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:32:39 10.224134 T:1771041696 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:Kodi (LibreELEC-3) port:9090 16:32:39 10.224216 T:1874850720 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC-3) type: _xbmc-jsonrpc-h._tcp port:8080 16:32:39 10.224336 T:1752167328 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:32:39 10.224398 T:1752167328 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): entering source directory /usr/share/kodi/addons/service.libreelec.settings 16:32:39 10.224563 T:1752167328 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:32:39 10.230308 T:1874850720 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:Kodi (LibreELEC-3) port:9777 16:32:39 10.230478 T:1771041696 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC-3) type: _xbmc-jsonrpc._tcp port:9090 16:32:39 10.231290 T:1566569376 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - connected to Tvheadend / 4.1-2150~gfd72688~jessie (HTSPv25) 16:32:39 10.231531 T:1566569376 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - sending auth 16:32:39 10.232531 T:1779430304 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airtunes type: _raop._tcp name:B827EB42AC00@Kodi (LibreELEC-3) port:36666 16:32:39 10.233007 T:1566569376 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - rebuilding state 16:32:39 10.234552 T:1566569376 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - async updates requested 16:32:39 10.234689 T:1566569376 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - registered 16:32:39 10.234736 T:1566569376 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - connection state change (7 -> 5) 16:32:39 10.234805 T:1566569376 DEBUG: PVR - PVRConnectionStateChange - state for connection '192.168.178.20:9982' on client 'Tvheadend HTSP Client' changed from '7' to '5' 16:32:39 10.235997 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - tag updated id:2, name:HDTV 16:32:39 10.236571 T:1771041696 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airplay type: _airplay._tcp name:Kodi (LibreELEC-3) port:36667 16:32:39 10.236772 T:1771041696 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC-3) type: _airplay._tcp port:36667 16:32:39 10.237133 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - tag updated id:1, name:TV channels 16:32:39 10.237310 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - tag updated id:3, name:SDTV 16:32:39 10.237688 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:128010971, name:Eurosport 1 Deutschland 16:32:39 10.238338 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:191202120, name:zdf_neo HD 16:32:39 10.238616 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:302473780, name:Disney Channel 16:32:39 10.239228 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:325151858, name:n-tv 16:32:39 10.239431 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:503654340, name:PHOENIX HD 16:32:39 10.240146 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:509516070, name:SIXX 16:32:39 10.240321 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:513482939, name:N24 16:32:39 10.240479 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:621954418, name:Einsfestival HD 16:32:39 10.240809 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:692329524, name:RTL Television 16:32:39 10.241217 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:761786180, name:RTLNITRO 16:32:39 10.241481 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:884121181, name:ServusTV HD Deutschland 16:32:39 10.241621 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:892497276, name:MDR S-Anhalt HD 16:32:39 10.241740 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:1007328395, name:SAT.1 16:32:39 10.242112 T:1874850720 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC-3) type: _xbmc-events._udp port:9777 16:32:39 10.245961 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:1221624737, name:DMAX 16:32:39 10.246239 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:1223282823, name:EinsPlus HD 16:32:39 10.246383 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:1237301768, name:SAT.1 Gold 16:32:39 10.246501 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:1253096193, name:ProSieben 16:32:39 10.246630 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:1261157093, name:arte HD 16:32:39 10.247024 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:1300645495, name:SUPER RTL 16:32:39 10.247126 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:1323717546, name:3sat HD 16:32:39 10.247197 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:1357639275, name:tagesschau24 HD 16:32:39 10.247288 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:1399422645, name:zdf.kultur HD 16:32:39 10.247384 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:1420492742, name:Pro7 MAXX 16:32:39 10.247449 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:1503660646, name:SPORT1 16:32:39 10.247516 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:1524830603, name:DELUXE MUSIC 16:32:39 10.247589 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:1580690978, name:ZDF HD 16:32:39 10.247652 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:1707680083, name:VOX 16:32:39 10.248066 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:1959252437, name:Das Erste HD 16:32:39 10.248144 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:2062362744, name:TELE 5 16:32:39 10.248211 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:2142407025, name:KiKA HD 16:32:39 10.248274 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - channel added id:2144247822, name:kabel eins 16:32:39 10.248406 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - tag updated id:2, name:HDTV 16:32:39 10.248471 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - tag updated id:1, name:TV channels 16:32:39 10.248549 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - tag updated id:3, name:SDTV 16:32:39 10.248855 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - recording id:1824605777, state:completed, title:Der Ghostwriter, desc:Ein britischer Ghostwriter soll die Memoiren des früheren Premierministers Adam Lang fertigstellen. Der Verlag hat Lang einen hohen Millionenbetrag für das Buch zugesagt, und die Zeit drängt. Für Langs "Ghost" verspricht der Auftrag einen Karrieresprung und ein fürstliches Honorar. Doch von Anfang an steht das Projekt unter keinem guten Stern, nicht zuletzt weil der erste Autor, Langs langjähriger Berater, gerade bei einem tragischen Unfall starb ... Regie: Roman Polanski Drehbuch: Robert Harris, Roman Polanski Autor: Robert Harris Komponist: Alexandre Desplat Kamera: Pawel Edelman Schnitt: Hervé de Luze Darsteller: Ewan McGregor (Ghostwriter) Pierce Brosnan (Adam Lang) Kim Cattrall (Amelia Bly) Olivia Williams (Ruth Lang) Tom Wilkinson (Paul Emmett) Timothy Hutton (Sidney Kroll) James Belushi (James Maddox) Jon Bernthal (Rick) Robert Pugh (Richard Rycart), error:none 16:32:39 10.248990 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - recording id:1395971089, state:completed, title:Turbo - Kleine Schnecke, großer Traum, desc:Eine kleine Weinbergschnecke wird zum unterschätzten Star, die sich mit eisernem Willen, ein Portion Lachgas und jeder Menge guter Freunde den Traum ihres Lebens erfüllt., error:none 16:32:39 10.249688 T:1779430304 DEBUG: CZeroconfAvahi::addService() named: B827EB42AC00@Kodi (LibreELEC-3) type: _raop._tcp port:36666 16:32:39 10.250974 T:1589228448 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - profile name: htsp, comment: HTSP Default Stream Settings added 16:32:39 10.259670 T:1566569376 DEBUG: Thread PVRManager start, auto delete: false 16:32:39 10.263429 T:1566569376 DEBUG: PVRManager - Load - active clients found. continue to start 16:32:39 10.276765 T:1962463232 INFO: Found input device /dev/input/event0 16:32:39 10.276926 T:1962463232 INFO: opened device 'Logitech K400' (file name /dev/input/event0), m_bSkipNonKeyEvents 0 16:32:39 10.277555 T:1558180768 DEBUG: Thread CLinuxInputDevicesCheckHotplugged start, auto delete: false 16:32:39 10.297107 T:1962463232 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x2b587a0 16:32:39 10.297688 T:1962463232 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 16:32:39 10.299565 T:1962463232 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x2b510d8 16:32:39 10.300100 T:1962463232 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:32:39 10.327046 T:1962463232 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x2b587a0 16:32:39 10.327866 T:1962463232 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x2b510d8 16:32:39 10.328014 T:1962463232 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/backgrounds/SKINDEFAULT.jpg 1280x720 16:32:39 10.375789 T:1760555936 DEBUG: UpdateMenuLanguage - using TV menu language is disabled 16:32:39 10.379637 T:1962463232 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x1ee95b0 16:32:39 10.380313 T:1962463232 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(201536), nBufferAlignmen(16) 16:32:39 10.382868 T:1962463232 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x2c53de0 16:32:39 10.384075 T:1962463232 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x2b510d8 16:32:39 10.384651 T:1962463232 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:32:39 10.465149 T:1962463232 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x1ee95b0 16:32:39 10.465755 T:1962463232 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x2c53de0 16:32:39 10.466447 T:1962463232 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x2b510d8 16:32:39 10.466580 T:1962463232 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/home-images/movie.jpg 927x540 16:32:39 10.482059 T:1962463232 DEBUG: ------ Window Init () ------ 16:32:40 10.669538 T:1962463232 DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------ 16:32:40 10.670051 T:1566569376 DEBUG: CPVRChannelGroups - Load - loading all radio channel groups 16:32:40 10.670674 T:1566569376 DEBUG: CPVRChannelGroups - Load - 1 radio groups fetched from the database 16:32:40 10.670866 T:1566569376 DEBUG: PVRChannelGroup - Load - 0 channels loaded from the database for group 'Alle Kanäle' 16:32:40 10.671275 T:1962463232 DEBUG: LogindUPowerSyscall - Received unknown signal NameAcquired 16:32:40 10.671805 T:1566569376 DEBUG: CPVRChannelGroups - LoadUserDefinedChannelGroups - 'synchannelgroups' is disabled; skipping groups from clients 16:32:40 10.671869 T:1566569376 DEBUG: CPVRChannelGroups - Load - 1 radio channel groups loaded 16:32:40 10.671910 T:1566569376 DEBUG: CPVRChannelGroups - Load - loading all TV channel groups 16:32:40 10.672269 T:1962463232 DEBUG: ------ Window Init (DialogNotification.xml) ------ 16:32:40 10.673622 T:1566569376 DEBUG: PVR - Get - group 'Alle Kanäle' loaded from the database 16:32:40 10.674099 T:1566569376 DEBUG: CPVRChannelGroups - Load - 1 TV groups fetched from the database 16:32:40 10.677403 T:1566569376 DEBUG: PVRChannelGroup - Load - 31 channels loaded from the database for group 'Alle Kanäle' 16:32:40 10.680317 T:1566569376 DEBUG: CPVRChannelGroups - LoadUserDefinedChannelGroups - 'synchannelgroups' is disabled; skipping groups from clients 16:32:40 10.680634 T:1566569376 DEBUG: CPVRChannelGroups - Load - 1 TV channel groups loaded 16:32:40 10.680707 T:1566569376 DEBUG: CPVRTimers - Update - updating timers 16:32:40 10.681153 T:1566569376 DEBUG: CPVRRecordings - Update - updating recordings 16:32:40 10.682406 T:1491071904 DEBUG: Thread PVRGUIInfo start, auto delete: false 16:32:40 10.682657 T:1566569376 DEBUG: PVRManager - Process - entering main loop 16:32:40 10.684474 T:1779430304 INFO: PVRChannelGroupsContainer - SearchMissingChannelIcons - starting channel icon search 16:32:40 10.685385 T:1482683296 DEBUG: Thread EPGUpdater start, auto delete: false 16:32:40 10.685668 T:1771041696 NOTICE: Start - EPG thread started 16:32:40 10.686319 T:1566569376 DEBUG: CPVRChannelGroup - Persist - persisting channel group 'Alle Kanäle' with 31 channels 16:32:40 10.723486 T:1752167328 DEBUG: ## LibreELEC Addon ## 0.8.2 16:32:40 10.724495 T:1566569376 DEBUG: CPVRTimers - Update - updating timers 16:32:40 10.729154 T:1752167328 WARNING: CSkinInfo: failed to load skin settings 16:32:40 10.733319 T:1962463232 DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------ 16:32:40 10.733958 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Eurosport 1 Deutschland' from client '2146250725' 16:32:40 10.764031 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'zdf_neo HD' from client '2146250725' 16:32:40 10.782310 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Disney Channel' from client '2146250725' 16:32:40 10.806213 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'n-tv' from client '2146250725' 16:32:40 10.827791 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'PHOENIX HD' from client '2146250725' 16:32:40 10.848824 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'SIXX' from client '2146250725' 16:32:40 10.866384 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'N24' from client '2146250725' 16:32:40 10.891959 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Einsfestival HD' from client '2146250725' 16:32:40 10.910038 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'RTL Television' from client '2146250725' 16:32:40 10.922585 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'RTLNITRO' from client '2146250725' 16:32:40 10.940882 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'ServusTV HD Deutschland' from client '2146250725' 16:32:40 10.957309 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'MDR S-Anhalt HD' from client '2146250725' 16:32:40 10.980732 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'SAT.1' from client '2146250725' 16:32:40 10.997802 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'DMAX' from client '2146250725' 16:32:40 11.015311 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'EinsPlus HD' from client '2146250725' 16:32:40 11.023560 T:1735390112 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 16:32:40 11.049016 T:1482683296 DEBUG: Previous line repeats 4 times. 16:32:40 11.049112 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'SAT.1 Gold' from client '2146250725' 16:32:40 11.057261 T:1735390112 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 16:32:40 11.076613 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'ProSieben' from client '2146250725' 16:32:40 11.097935 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'arte HD' from client '2146250725' 16:32:40 11.132199 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'SUPER RTL' from client '2146250725' 16:32:40 11.155045 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel '3sat HD' from client '2146250725' 16:32:40 11.179991 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'tagesschau24 HD' from client '2146250725' 16:32:40 11.204679 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'zdf.kultur HD' from client '2146250725' 16:32:40 11.224545 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Pro7 MAXX' from client '2146250725' 16:32:40 11.247582 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'SPORT1' from client '2146250725' 16:32:40 11.265209 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'DELUXE MUSIC' from client '2146250725' 16:32:40 11.271240 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'ZDF HD' from client '2146250725' 16:32:40 11.290051 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'VOX' from client '2146250725' 16:32:40 11.305305 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'Das Erste HD' from client '2146250725' 16:32:40 11.321649 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'TELE 5' from client '2146250725' 16:32:40 11.331785 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'KiKA HD' from client '2146250725' 16:32:40 11.359756 T:1482683296 DEBUG: EPG - UpdateFromScraper - updating EPG for channel 'kabel eins' from client '2146250725' 16:32:40 11.375458 T:1566569376 DEBUG: CPVRTimers - Update - updating timers 16:32:41 11.541636 T:1752167328 INFO: ## LibreELEC Addon ## system::set_hostname ## LibreELEC-3 16:32:41 11.543553 T:1752167328 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## de 16:32:41 11.543710 T:1752167328 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## loadkmap < `ls -1 /usr/lib/keymaps/*/de.bmap` 16:32:41 11.602831 T:1962463232 DEBUG: ------ Window Deinit (DialogExtendedProgressBar.xml) ------ 16:32:41 11.617888 T:1752167328 INFO: ## LibreELEC Addon ## system::updateThread ## Started 16:32:41 11.618716 T:1752167328 INFO: ## LibreELEC Addon ## system::set_auto_update ## auto 16:32:41 11.642195 T:1631171488 INFO: ## LibreELEC Addon ## _service_::run ## WAITING: 16:32:41 11.652733 T:1614394272 INFO: ## LibreELEC Addon ## xdbus Monitor started. ## 16:32:42 13.314562 T:1760555936 DEBUG: UpdateAudioSystemStatus - CEC capable amplifier found (TX-SR508). volume will be controlled on the amp 16:32:42 13.315120 T:1962455968 DEBUG: CAnnouncementManager - Announcement: OnVolumeChanged from xbmc 16:32:42 13.315508 T:1962455968 DEBUG: GOT ANNOUNCEMENT, type: 64, from xbmc, message OnVolumeChanged 16:32:43 13.933819 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:32:43 13.934098 T:1962463232 DEBUG: OnKey: down (0xf081) pressed, action is Down 16:32:43 13.990070 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:32:43 14.090166 T:1962463232 DEBUG: Previous line repeats 1 times. 16:32:43 14.090342 T:1962463232 DEBUG: OnKey: down (0xf081) pressed, action is Down 16:32:43 14.206624 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:32:43 14.429662 T:1962463232 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x27a6778 16:32:43 14.430755 T:1962463232 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(184336), nBufferAlignmen(16) 16:32:43 14.434850 T:1962463232 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x2d22f90 16:32:43 14.436690 T:1962463232 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x2c36e80 16:32:43 14.437596 T:1962463232 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:32:44 14.552337 T:1962463232 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x27a6778 16:32:44 14.553310 T:1962463232 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x2d22f90 16:32:44 14.554570 T:1962463232 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x2c36e80 16:32:44 14.554802 T:1962463232 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/home-images/music.jpg 927x540 16:32:44 15.442589 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:32:44 15.442822 T:1962463232 DEBUG: OnKey: down (0xf081) pressed, action is Down 16:32:45 15.589987 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:32:45 15.956642 T:1962463232 DEBUG: Previous line repeats 1 times. 16:32:45 15.956772 T:1962463232 DEBUG: OnKey: down (0xf081) pressed, action is Down 16:32:45 16.123220 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:32:45 16.312050 T:1962463232 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x2b91b20 16:32:45 16.312613 T:1962463232 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(263024), nBufferAlignmen(16) 16:32:45 16.315283 T:1962463232 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x2b90da0 16:32:45 16.316296 T:1962463232 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x2b91f60 16:32:45 16.316803 T:1962463232 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:32:45 16.395491 T:1962463232 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x2b91b20 16:32:45 16.396620 T:1962463232 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x2b90da0 16:32:45 16.397932 T:1962463232 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x2b91f60 16:32:45 16.398159 T:1962463232 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/home-images/add-ons.jpg 927x540 16:32:46 17.125887 T:1962463232 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 16:32:46 17.126051 T:1962463232 DEBUG: OnKey: right (0xf083) pressed, action is Right 16:32:46 17.306549 T:1962463232 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 16:32:47 18.271725 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:32:47 18.404238 T:1962463232 DEBUG: OnKey: return (0xf00d) pressed, action is Select 16:32:47 18.404690 T:1962463232 DEBUG: Activating window ID: 10025 16:32:48 18.647089 T:1962463232 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 16:32:48 18.712395 T:1962463232 DEBUG: ------ Window Deinit (Home.xml) ------ 16:32:48 18.753077 T:1962463232 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 16:32:48 18.753185 T:1962463232 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 16:32:48 18.960192 T:1962463232 DEBUG: CDirectoryProvider[]: refreshing.. 16:32:48 18.960457 T:1771041696 ERROR: GetDirectory - Error getting 16:32:48 18.960720 T:1962463232 DEBUG: CDirectoryProvider[]: refreshing.. 16:32:48 18.960815 T:1874850720 ERROR: GetDirectory - Error getting 16:32:48 18.972071 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:32:48 19.012030 T:1962463232 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/) 16:32:48 19.012163 T:1962463232 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 16:32:48 19.020424 T:1779430304 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 8 ms 16:32:48 19.020828 T:1771041696 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','1','') 16:32:48 19.021160 T:1499460512 DEBUG: Thread LanguageInvoker start, auto delete: false 16:32:48 19.021269 T:1499460512 INFO: initializing python engine. 16:32:48 19.021315 T:1499460512 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.skygo-master/default.py): start processing 16:32:48 19.051371 T:1499460512 DEBUG: -->Python Interpreter Initialized<-- 16:32:48 19.051538 T:1499460512 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.skygo-master/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo-master/default.py" 16:32:48 19.052111 T:1499460512 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.skygo-master/default.py): setting the Python path to /storage/.kodi/addons/plugin.video.skygo-master:/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:32:48 19.052176 T:1499460512 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.skygo-master/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo-master 16:32:48 19.052271 T:1499460512 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.skygo-master/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:32:49 19.513571 T:1962463232 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:32:49 19.586929 T:1499460512 DEBUG: false 16:32:49 19.602846 T:1499460512 INFO: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.skygo-master/default.py): script successfully run 16:32:49 19.611702 T:1507849120 DEBUG: Thread BackgroundLoader start, auto delete: false 16:32:49 19.618790 T:1874850720 DEBUG: GetImageHash - unable to stat url 16:32:49 19.639133 T:1507849120 DEBUG: Thread BackgroundLoader 1507849120 terminating 16:32:49 19.644724 T:1962463232 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:32:49 19.661976 T:1771041696 DEBUG: GetImageHash - unable to stat url 16:32:49 19.670425 T:1499460512 INFO: Python script stopped 16:32:49 19.670628 T:1499460512 DEBUG: Thread LanguageInvoker 1499460512 terminating 16:32:49 19.691601 T:1874850720 DEBUG: GetImageHash - unable to stat url 16:32:50 21.323252 T:1962463232 DEBUG: Previous line repeats 44 times. 16:32:50 21.323399 T:1962463232 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 16:32:50 21.323587 T:1962463232 DEBUG: OnKey: right (0xf083) pressed, action is Right 16:32:50 21.325294 T:1779430304 DEBUG: GetImageHash - unable to stat url 16:32:51 21.556547 T:1962463232 DEBUG: Previous line repeats 6 times. 16:32:51 21.556648 T:1962463232 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 16:32:51 21.574781 T:1771041696 DEBUG: GetImageHash - unable to stat url 16:32:52 22.873257 T:1962463232 DEBUG: Previous line repeats 41 times. 16:32:52 22.873390 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:32:52 22.873495 T:1962463232 DEBUG: OnKey: down (0xf081) pressed, action is Down 16:32:52 22.891727 T:1779430304 DEBUG: GetImageHash - unable to stat url 16:32:52 23.023220 T:1962463232 DEBUG: Previous line repeats 4 times. 16:32:52 23.023317 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:32:52 23.041372 T:1874850720 DEBUG: GetImageHash - unable to stat url 16:32:53 23.656553 T:1962463232 DEBUG: Previous line repeats 20 times. 16:32:53 23.656673 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:32:53 23.656782 T:1962463232 DEBUG: OnKey: down (0xf081) pressed, action is Down 16:32:53 23.674767 T:1874850720 DEBUG: GetImageHash - unable to stat url 16:32:53 23.823214 T:1962463232 DEBUG: Previous line repeats 5 times. 16:32:53 23.823309 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:32:53 23.841782 T:1771041696 DEBUG: GetImageHash - unable to stat url 16:32:55 25.756559 T:1962463232 DEBUG: Previous line repeats 55 times. 16:32:55 25.756689 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:32:55 25.775761 T:1874850720 DEBUG: GetImageHash - unable to stat url 16:32:55 25.939926 T:1962463232 DEBUG: Previous line repeats 3 times. 16:32:55 25.940050 T:1962463232 DEBUG: OnKey: return (0xf00d) pressed, action is Select 16:32:55 25.941690 T:1962463232 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listPage&page=movies) 16:32:55 25.941767 T:1962463232 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 16:32:55 25.949591 T:1779430304 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 8 ms 16:32:55 25.950020 T:1771041696 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','2','?action=listPage&page=movies') 16:32:55 25.950315 T:1499460512 DEBUG: Thread LanguageInvoker start, auto delete: false 16:32:55 25.950422 T:1499460512 INFO: initializing python engine. 16:32:55 25.950464 T:1499460512 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo-master/default.py): start processing 16:32:55 25.979561 T:1499460512 DEBUG: -->Python Interpreter Initialized<-- 16:32:55 25.979731 T:1499460512 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo-master/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo-master/default.py" 16:32:55 25.980309 T:1499460512 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo-master/default.py): setting the Python path to /storage/.kodi/addons/plugin.video.skygo-master:/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:32:55 25.980394 T:1499460512 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo-master/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo-master 16:32:55 25.980494 T:1499460512 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo-master/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:32:55 26.368191 T:1499460512 DEBUG: false 16:32:55 26.379303 T:1499460512 DEBUG: {'action': 'listPage', 'page': 'movies'} 16:32:55 26.443624 T:1962463232 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:32:56 26.546772 T:1874850720 DEBUG: GetImageHash - unable to stat url 16:32:56 26.626995 T:1499460512 INFO: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.skygo-master/default.py): script successfully run 16:32:56 26.639040 T:1507849120 DEBUG: Thread BackgroundLoader start, auto delete: false 16:32:56 26.647270 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:32:56 26.663424 T:1779430304 DEBUG: GetImageHash - unable to stat url 16:32:56 26.679634 T:1507849120 DEBUG: Thread BackgroundLoader 1507849120 terminating 16:32:56 26.692429 T:1771041696 DEBUG: GetImageHash - unable to stat url 16:32:56 26.714245 T:1499460512 INFO: Python script stopped 16:32:56 26.714409 T:1499460512 DEBUG: Thread LanguageInvoker 1499460512 terminating 16:32:56 26.741596 T:1874850720 DEBUG: GetImageHash - unable to stat url 16:32:56 26.797852 T:1962463232 DEBUG: Previous line repeats 1 times. 16:32:56 26.797976 T:1962463232 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:32:56 26.824987 T:1771041696 DEBUG: GetImageHash - unable to stat url 16:32:57 27.706545 T:1962463232 DEBUG: Previous line repeats 23 times. 16:32:57 27.706657 T:1962463232 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 16:32:57 27.706781 T:1962463232 DEBUG: OnKey: up (0xf080) pressed, action is Up 16:32:57 27.889872 T:1962463232 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 16:32:59 29.856567 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:32:59 29.856762 T:1962463232 DEBUG: OnKey: down (0xf081) pressed, action is Down 16:32:59 29.991888 T:1779430304 DEBUG: GetImageHash - unable to stat url 16:32:59 30.023233 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:32:59 30.025015 T:1874850720 DEBUG: GetImageHash - unable to stat url 16:33:00 30.639896 T:1962463232 DEBUG: Previous line repeats 18 times. 16:33:00 30.640060 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:33:00 30.640188 T:1962463232 DEBUG: OnKey: down (0xf081) pressed, action is Down 16:33:00 30.642250 T:1874850720 DEBUG: GetImageHash - unable to stat url 16:33:00 30.823221 T:1962463232 DEBUG: Previous line repeats 5 times. 16:33:00 30.823339 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:33:00 30.825201 T:1874850720 DEBUG: GetImageHash - unable to stat url 16:33:01 31.673220 T:1962463232 DEBUG: Previous line repeats 27 times. 16:33:01 31.673347 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:01 31.691511 T:1779430304 DEBUG: GetImageHash - unable to stat url 16:33:01 31.873270 T:1962463232 DEBUG: Previous line repeats 4 times. 16:33:01 31.873386 T:1962463232 DEBUG: OnKey: return (0xf00d) pressed, action is Select 16:33:01 31.875092 T:1962463232 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listing&path=%2Fsg%2Fmultiplatform%2Fweb%2Fjson%2Feditorial_special%2F189.json) 16:33:01 31.875225 T:1962463232 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/?action=listPage&page=movies] 16:33:01 31.918592 T:1771041696 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 43 ms 16:33:01 31.918982 T:1779430304 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','3','?action=listing&path=%2Fsg%2Fmultiplatform%2Fweb%2Fjson%2Feditorial_special%2F189.json') 16:33:01 31.919243 T:1499460512 DEBUG: Thread LanguageInvoker start, auto delete: false 16:33:01 31.919348 T:1499460512 INFO: initializing python engine. 16:33:01 31.919390 T:1499460512 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.skygo-master/default.py): start processing 16:33:01 31.948009 T:1499460512 DEBUG: -->Python Interpreter Initialized<-- 16:33:01 31.948181 T:1499460512 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.skygo-master/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo-master/default.py" 16:33:01 31.948719 T:1499460512 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.skygo-master/default.py): setting the Python path to /storage/.kodi/addons/plugin.video.skygo-master:/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:33:01 31.948774 T:1499460512 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.skygo-master/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo-master 16:33:01 31.948875 T:1499460512 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.skygo-master/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:33:01 32.334976 T:1499460512 DEBUG: false 16:33:01 32.346451 T:1499460512 DEBUG: {'action': 'listing', 'path': '/sg/multiplatform/web/json/editorial_special/189.json'} 16:33:01 32.377522 T:1962463232 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:33:01 32.480961 T:1874850720 DEBUG: GetImageHash - unable to stat url 16:33:05 36.234547 T:1499460512 DEBUG: Previous line repeats 16 times. 16:33:05 36.234730 T:1499460512 INFO: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.skygo-master/default.py): script successfully run 16:33:05 36.357742 T:1499460512 INFO: Python script stopped 16:33:05 36.357952 T:1499460512 DEBUG: Thread LanguageInvoker 1499460512 terminating 16:33:05 36.357998 T:1507849120 DEBUG: Thread BackgroundLoader start, auto delete: false 16:33:05 36.367031 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:05 36.445198 T:1507849120 DEBUG: Thread BackgroundLoader 1507849120 terminating 16:33:06 36.497211 T:1962463232 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:33:07 37.700348 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:33:07 37.700619 T:1962463232 DEBUG: OnKey: down (0xf081) pressed, action is Down 16:33:07 37.704102 T:1779430304 DEBUG: GetImageHash - unable to stat url 16:33:07 37.725670 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x68f76c60 16:33:07 37.726856 T:1874850720 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(97104), nBufferAlignmen(16) 16:33:07 37.729019 T:1771041696 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x68f76b20 16:33:07 37.730465 T:1771041696 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 16:33:07 37.731472 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x68f6f4b0 16:33:07 37.732468 T:1874850720 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:33:07 37.761360 T:1771041696 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x68f6f510 16:33:07 37.761986 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x68f76c60 16:33:07 37.762753 T:1771041696 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:33:07 37.763672 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x68f6f4b0 16:33:07 37.763954 T:1874850720 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/2/27a19fc7.jpg 1280x720 16:33:07 37.774014 T:1771041696 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x68f76b20 16:33:07 37.774994 T:1771041696 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x68f6f510 16:33:07 37.775181 T:1771041696 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/c/c1e7869e.jpg 126x187 16:33:07 37.873230 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:33:08 38.945747 T:1962463232 DEBUG: Previous line repeats 1 times. 16:33:08 38.945881 T:1962463232 DEBUG: OnKey: down (0xf081) pressed, action is Down 16:33:08 38.982147 T:1779430304 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x64dd5ca0 16:33:08 38.983822 T:1779430304 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(330208), nBufferAlignmen(16) 16:33:08 38.984066 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x68f76c60 16:33:08 38.985401 T:1874850720 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 16:33:08 38.991077 T:1779430304 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x731e3a88 16:33:08 38.992477 T:1779430304 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:33:08 39.032276 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x68f705a0 16:33:08 39.033623 T:1779430304 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x64dd5ca0 16:33:08 39.033882 T:1874850720 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:33:08 39.036282 T:1779430304 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x731e3a88 16:33:08 39.036602 T:1779430304 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/9/931d8798.jpg 1280x720 16:33:08 39.046593 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x68f76c60 16:33:08 39.048466 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x68f705a0 16:33:08 39.048794 T:1874850720 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/7/7309ca07.jpg 126x187 16:33:08 39.073357 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:33:09 40.349052 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:10 40.572334 T:1962463232 DEBUG: OnKey: return (0xf00d) pressed, action is Select 16:33:10 40.593876 T:1962463232 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?action=playVod&vod_id=747654 16:33:10 40.607426 T:1962463232 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','4','?action=playVod&vod_id=747654') 16:33:10 40.607929 T:1507849120 DEBUG: Thread LanguageInvoker start, auto delete: false 16:33:10 40.608154 T:1507849120 INFO: initializing python engine. 16:33:10 40.608238 T:1507849120 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.skygo-master/default.py): start processing 16:33:10 40.616173 T:1962455968 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 16:33:10 40.616421 T:1962455968 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 16:33:10 40.628445 T:1499460512 DEBUG: Thread scriptobs start, auto delete: false 16:33:10 40.662628 T:1507849120 DEBUG: -->Python Interpreter Initialized<-- 16:33:10 40.662979 T:1507849120 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.skygo-master/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo-master/default.py" 16:33:10 40.663994 T:1507849120 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.skygo-master/default.py): setting the Python path to /storage/.kodi/addons/plugin.video.skygo-master:/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:33:10 40.664097 T:1507849120 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.skygo-master/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo-master 16:33:10 40.664341 T:1507849120 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.skygo-master/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:33:10 40.828468 T:1962463232 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:33:10 41.073906 T:1507849120 DEBUG: false 16:33:10 41.085823 T:1507849120 DEBUG: {'action': 'playVod', 'vod_id': '747654'} 16:33:11 41.545887 T:1507849120 DEBUG: {u'resultCode': u'S_218', u'resultMessage': u'KO'} 16:33:11 41.546070 T:1507849120 DEBUG: User not logged in or Session on other device 16:33:11 41.546165 T:1507849120 DEBUG: Session invalid - Customer Code not found in SilkCache 16:33:11 41.803066 T:1507849120 DEBUG: {u'tcFlag': u'Y', u'mktgFlag': u'Y', u'firstName': u'TIMO', u'country': u'DE', u'extraCustFlag': u'N', u'resultMessage': u'OK', u'privacyFlag': u'Y', u'resultCode': u'S_100', u'bookmarkFlag': u'Y', u'customerCode': u'9945084432', u'cableSubFlag': u'Y', u'skygoSessionId': u'SG-e33824e8-72be-4e6c-bb32-32c1239ea945', u'lastName': u'', u'entitlements': [u'OOHD', u'OOSW', u'OOSP', u'OOSF', u'OFBP', u'SHDE', u'KIDS', u'OFBS', u'OFEH', u'OFES', u'OSFH', u'OSPS', u'OWEH'], u'doubleOptInFlag': u'N', u'presentation': u'HERR', u'email': u''} 16:33:11 41.803368 T:1507849120 DEBUG: User still logged in 16:33:12 42.870373 T:1507849120 INFO: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.skygo-master/default.py): script successfully run 16:33:12 42.879005 T:1499460512 DEBUG: Thread scriptobs 1499460512 terminating 16:33:12 42.879391 T:1962463232 INFO: easy_aquire - Created session to http://skywebvod-s.akamaihd.net 16:33:12 42.964230 T:1507849120 INFO: Python script stopped 16:33:12 42.964367 T:1507849120 DEBUG: Thread LanguageInvoker 1507849120 terminating 16:33:12 43.113369 T:1962463232 DEBUG: CCurlFile::GetMimeType - http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest -> text/xml 16:33:12 43.128170 T:1962463232 DEBUG: Loading settings for http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest 16:33:12 43.137936 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers(http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest) 16:33:12 43.138050 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 16:33:12 43.138115 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 16:33:12 43.138145 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 16:33:12 43.138245 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 16:33:12 43.138317 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 16:33:12 43.138386 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 16:33:12 43.138454 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 16:33:12 43.138557 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams 16:33:12 43.138588 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp 16:33:12 43.138664 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2 16:33:12 43.138733 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 16:33:12 43.138771 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 16:33:12 43.138832 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 16:33:12 43.138897 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 16:33:12 43.138966 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 16:33:12 43.139030 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 16:33:12 43.139069 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 16:33:12 43.139107 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 16:33:12 43.139137 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 16:33:12 43.139168 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 16:33:12 43.143375 T:1962463232 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 16:33:12 43.143623 T:1962463232 NOTICE: VideoPlayer: Opening: http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest 16:33:12 43.143665 T:1962463232 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 16:33:12 43.198112 T:1962463232 DEBUG: CCurlFile::GetMimeType - http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest -> text/xml 16:33:12 43.198238 T:1962463232 DEBUG: CMMALRenderer::CMMALRenderer 16:33:12 43.198475 T:1962463232 DEBUG: CMMALRenderer::UnInitMMAL 16:33:12 43.198528 T:1962463232 DEBUG: CMMALRenderer::PreInit 16:33:12 43.198570 T:1499460512 DEBUG: Thread MMALProcess start, auto delete: false 16:33:12 43.198612 T:1499460512 DEBUG: CMMALRenderer::Run - starting 16:33:12 43.198650 T:1507849120 DEBUG: Thread VideoPlayer start, auto delete: false 16:33:12 43.198837 T:1507849120 NOTICE: Creating InputStream 16:33:12 43.198994 T:1507849120 DEBUG: ADDON: Dll Initializing - InputStream SmoothStreamingMedia 16:33:12 43.199112 T:1507849120 DEBUG: SECTION:LoadDLL(/storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.0) 16:33:12 43.199192 T:1507849120 DEBUG: Loading: /storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.0 16:33:12 43.226864 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: ADDON_Create() 16:33:12 43.226997 T:1507849120 INFO: AddOnLog: InputStream SmoothStreamingMedia: SetVideoResolution (1920 x 1080) 16:33:12 43.227188 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Open() 16:33:12 43.227287 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_data: [not shown] 16:33:12 43.227325 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_key: [not shown] 16:33:12 43.227360 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_type: com.widevine.alpha 16:33:12 43.228462 T:1507849120 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MAXRESOLUTION' 16:33:12 43.229916 T:1507849120 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'DECRYPTERPATH' 16:33:12 43.230656 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Searching for decrypters in: /storage/.kodi/cdm 16:33:12 43.231655 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Supported URN: 16:33:12 43.232346 T:1507849120 DEBUG: CurlFile::Open(0x73c04b78) http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest 16:33:13 43.623833 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Download http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest finished 16:33:13 43.624405 T:1507849120 INFO: AddOnLog: InputStream SmoothStreamingMedia: Successfully parsed .mpd file. Download speed: 0.0000 Bytes/s 16:33:13 43.624451 T:1507849120 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MINBANDWIDTH' 16:33:13 43.625240 T:1507849120 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MAXBANDWIDTH' 16:33:13 43.626926 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: GetStreamIds() 16:33:13 43.627022 T:1507849120 ERROR: CVideoPlayer::OpenInputStream - error opening [http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest] 16:33:13 43.627064 T:1507849120 NOTICE: CVideoPlayer::OnExit() 16:33:13 43.627102 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Close() 16:33:13 43.627136 T:1507849120 INFO: ADDON: Dll Stopped - InputStream SmoothStreamingMedia 16:33:13 43.627205 T:1507849120 DEBUG: OnPlayBackStopped: play state was 1, starting 1 16:33:13 43.627270 T:1507849120 DEBUG: Thread VideoPlayer 1507849120 terminating 16:33:13 43.627316 T:1962463232 DEBUG: OnPlayBackStopped: play state was 3, starting 0 16:33:13 43.627583 T:1962463232 ERROR: Playlist Player: skipping unplayable item: 0, path [plugin://plugin.video.skygo.de/?action=playVod&vod_id=747654] 16:33:13 43.627636 T:1962463232 DEBUG: Playlist Player: no more playable items... aborting playback 16:33:13 43.628296 T:1507849120 DEBUG: Thread BackgroundLoader start, auto delete: false 16:33:13 43.628532 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:13 43.638748 T:1962463232 NOTICE: CVideoPlayer::CloseFile() 16:33:13 43.638889 T:1962463232 NOTICE: VideoPlayer: waiting for threads to exit 16:33:13 43.638962 T:1962463232 NOTICE: VideoPlayer: finished waiting 16:33:13 43.639042 T:1962463232 DEBUG: DeleteRenderer - deleting renderer 16:33:13 43.639103 T:1962463232 DEBUG: CMMALRenderer::~CMMALRenderer 16:33:13 43.639141 T:1962463232 DEBUG: CMMALRenderer::UnInitMMAL 16:33:13 43.639271 T:1499460512 DEBUG: CMMALRenderer::Run - stopping 16:33:13 43.639328 T:1499460512 DEBUG: Thread MMALProcess 1499460512 terminating 16:33:13 43.639458 T:1962463232 NOTICE: CVideoPlayer::CloseFile() 16:33:13 43.639492 T:1962463232 NOTICE: VideoPlayer: waiting for threads to exit 16:33:13 43.639526 T:1962463232 NOTICE: VideoPlayer: finished waiting 16:33:13 43.641991 T:1962463232 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 16:33:13 43.648499 T:1962455968 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 16:33:13 43.648701 T:1962455968 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 16:33:13 43.654655 T:1962463232 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:33:13 43.715790 T:1507849120 DEBUG: Thread BackgroundLoader 1507849120 terminating 16:33:17 48.423275 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:18 48.616299 T:1962463232 DEBUG: OnKey: return (0xf00d) pressed, action is Select 16:33:18 48.637794 T:1962463232 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?action=playVod&vod_id=747654 16:33:18 48.638374 T:1962455968 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 16:33:18 48.638531 T:1962455968 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 16:33:18 48.651569 T:1962463232 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','5','?action=playVod&vod_id=747654') 16:33:18 48.652126 T:1507849120 DEBUG: Thread LanguageInvoker start, auto delete: false 16:33:18 48.652359 T:1507849120 INFO: initializing python engine. 16:33:18 48.652443 T:1507849120 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/plugin.video.skygo-master/default.py): start processing 16:33:18 48.660923 T:1962455968 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 16:33:18 48.661198 T:1962455968 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 16:33:18 48.672543 T:1499460512 DEBUG: Thread scriptobs start, auto delete: false 16:33:18 48.706726 T:1507849120 DEBUG: -->Python Interpreter Initialized<-- 16:33:18 48.706982 T:1507849120 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/plugin.video.skygo-master/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo-master/default.py" 16:33:18 48.707920 T:1507849120 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/plugin.video.skygo-master/default.py): setting the Python path to /storage/.kodi/addons/plugin.video.skygo-master:/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:33:18 48.708038 T:1507849120 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/plugin.video.skygo-master/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo-master 16:33:18 48.708214 T:1507849120 DEBUG: CPythonInvoker(5, /storage/.kodi/addons/plugin.video.skygo-master/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:33:18 48.872688 T:1962463232 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:33:18 49.130352 T:1507849120 DEBUG: false 16:33:18 49.141529 T:1507849120 DEBUG: {'action': 'playVod', 'vod_id': '747654'} 16:33:19 49.554867 T:1507849120 DEBUG: {u'resultCode': u'S_218', u'resultMessage': u'KO'} 16:33:19 49.555096 T:1507849120 DEBUG: User not logged in or Session on other device 16:33:19 49.555187 T:1507849120 DEBUG: Session invalid - Customer Code not found in SilkCache 16:33:19 49.733448 T:1962463232 DEBUG: ------ Window Init (DialogConfirm.xml) ------ 16:33:19 49.733559 T:1962463232 INFO: Loading skin file: DialogConfirm.xml, load type: KEEP_IN_MEMORY 16:33:23 53.889954 T:1962463232 DEBUG: Keyboard: scancode: 0x69, sym: 0x0114, unicode: 0x0000, modifier: 0x0 16:33:23 53.890430 T:1962463232 DEBUG: OnKey: left (0xf082) pressed, action is Left 16:33:23 54.156612 T:1962463232 DEBUG: Keyboard: scancode: 0x69, sym: 0x0114, unicode: 0x0000, modifier: 0x0 16:33:25 55.706612 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:25 56.090191 T:1962463232 DEBUG: OnKey: return (0xf00d) pressed, action is Select 16:33:25 56.090618 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:25 56.352547 T:1962463232 DEBUG: ------ Window Deinit (DialogConfirm.xml) ------ 16:33:26 56.834728 T:1507849120 DEBUG: {u'tcFlag': u'Y', u'mktgFlag': u'Y', u'firstName': u'TIMO', u'country': u'DE', u'extraCustFlag': u'N', u'resultMessage': u'OK', u'privacyFlag': u'Y', u'resultCode': u'S_100', u'bookmarkFlag': u'Y', u'customerCode': u'9945084432', u'cableSubFlag': u'Y', u'skygoSessionId': u'SG-15b701b9-8b32-4233-8b55-f8645e9c9fdb', u'lastName': u'HARNEITH', u'entitlements': [u'OOHD', u'OOSW', u'OOSP', u'OOSF', u'OFBP', u'SHDE', u'KIDS', u'OFBS', u'OFEH', u'OFES', u'OSFH', u'OSPS', u'OWEH'], u'doubleOptInFlag': u'N', u'presentation': u'HERR', u'email': u''} 16:33:26 56.835072 T:1507849120 DEBUG: User still logged in 16:33:27 57.822723 T:1507849120 INFO: CPythonInvoker(5, /storage/.kodi/addons/plugin.video.skygo-master/default.py): script successfully run 16:33:27 57.831295 T:1499460512 DEBUG: Thread scriptobs 1499460512 terminating 16:33:27 57.887035 T:1962463232 DEBUG: CCurlFile::GetMimeType - http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest -> text/xml 16:33:27 57.902863 T:1962463232 DEBUG: Loading settings for http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest 16:33:27 57.914135 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers(http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest) 16:33:27 57.914272 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 16:33:27 57.914337 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 16:33:27 57.914371 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 16:33:27 57.914482 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 16:33:27 57.914570 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 16:33:27 57.914642 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 16:33:27 57.914715 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 16:33:27 57.914810 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams 16:33:27 57.914841 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp 16:33:27 57.914921 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2 16:33:27 57.914989 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 16:33:27 57.915031 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 16:33:27 57.915092 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 16:33:27 57.915161 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 16:33:27 57.915234 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 16:33:27 57.915302 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 16:33:27 57.915348 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 16:33:27 57.915379 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 16:33:27 57.915413 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 16:33:27 57.915447 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 16:33:27 57.919918 T:1962463232 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 16:33:27 57.920227 T:1962463232 NOTICE: VideoPlayer: Opening: http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest 16:33:27 57.920284 T:1962463232 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 16:33:27 57.920677 T:1507849120 INFO: Python script stopped 16:33:27 57.920795 T:1507849120 DEBUG: Thread LanguageInvoker 1507849120 terminating 16:33:27 57.974907 T:1962463232 DEBUG: CCurlFile::GetMimeType - http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest -> text/xml 16:33:27 57.975040 T:1962463232 DEBUG: CMMALRenderer::CMMALRenderer 16:33:27 57.975151 T:1962463232 DEBUG: CMMALRenderer::UnInitMMAL 16:33:27 57.975189 T:1962463232 DEBUG: CMMALRenderer::PreInit 16:33:27 57.975243 T:1507849120 DEBUG: Thread MMALProcess start, auto delete: false 16:33:27 57.975307 T:1507849120 DEBUG: CMMALRenderer::Run - starting 16:33:27 57.975357 T:1499460512 DEBUG: Thread VideoPlayer start, auto delete: false 16:33:27 57.975540 T:1499460512 NOTICE: Creating InputStream 16:33:27 57.975697 T:1499460512 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: ADDON_Destroy() 16:33:27 57.976250 T:1499460512 DEBUG: SECTION:UnloadDll(/storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.0) 16:33:27 57.976768 T:1499460512 INFO: ADDON: Dll Destroyed - InputStream SmoothStreamingMedia 16:33:27 57.976833 T:1499460512 DEBUG: ADDON: Dll Initializing - InputStream SmoothStreamingMedia 16:33:27 57.976982 T:1499460512 DEBUG: SECTION:LoadDLL(/storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.0) 16:33:27 57.977062 T:1499460512 DEBUG: Loading: /storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.0 16:33:27 58.002998 T:1499460512 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: ADDON_Create() 16:33:27 58.003105 T:1499460512 INFO: AddOnLog: InputStream SmoothStreamingMedia: SetVideoResolution (1920 x 1080) 16:33:27 58.003304 T:1499460512 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Open() 16:33:27 58.003452 T:1499460512 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_data: [not shown] 16:33:27 58.003490 T:1499460512 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_key: [not shown] 16:33:27 58.003536 T:1499460512 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_type: com.widevine.alpha 16:33:27 58.004124 T:1499460512 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MAXRESOLUTION' 16:33:27 58.004951 T:1499460512 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'DECRYPTERPATH' 16:33:27 58.005581 T:1499460512 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Searching for decrypters in: /storage/.kodi/cdm 16:33:27 58.006149 T:1499460512 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Supported URN: 16:33:27 58.006863 T:1499460512 DEBUG: CurlFile::Open(0x731e66e0) http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest 16:33:27 58.211414 T:1499460512 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Download http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest finished 16:33:27 58.212055 T:1499460512 INFO: AddOnLog: InputStream SmoothStreamingMedia: Successfully parsed .mpd file. Download speed: 0.0000 Bytes/s 16:33:27 58.212109 T:1499460512 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MINBANDWIDTH' 16:33:27 58.212902 T:1499460512 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MAXBANDWIDTH' 16:33:27 58.214664 T:1499460512 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: GetStreamIds() 16:33:27 58.214729 T:1499460512 ERROR: CVideoPlayer::OpenInputStream - error opening [http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest] 16:33:27 58.214783 T:1499460512 NOTICE: CVideoPlayer::OnExit() 16:33:27 58.214855 T:1499460512 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Close() 16:33:27 58.214890 T:1499460512 INFO: ADDON: Dll Stopped - InputStream SmoothStreamingMedia 16:33:27 58.214973 T:1499460512 DEBUG: OnPlayBackStopped: play state was 1, starting 1 16:33:27 58.215027 T:1499460512 DEBUG: Thread VideoPlayer 1499460512 terminating 16:33:27 58.215061 T:1962463232 DEBUG: OnPlayBackStopped: play state was 3, starting 0 16:33:27 58.215309 T:1962463232 ERROR: Playlist Player: skipping unplayable item: 0, path [plugin://plugin.video.skygo.de/?action=playVod&vod_id=747654] 16:33:27 58.215359 T:1962463232 DEBUG: Playlist Player: no more playable items... aborting playback 16:33:27 58.216011 T:1499460512 DEBUG: Thread BackgroundLoader start, auto delete: false 16:33:27 58.216232 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:27 58.225853 T:1962463232 NOTICE: CVideoPlayer::CloseFile() 16:33:27 58.225979 T:1962463232 NOTICE: VideoPlayer: waiting for threads to exit 16:33:27 58.226017 T:1962463232 NOTICE: VideoPlayer: finished waiting 16:33:27 58.226082 T:1962463232 DEBUG: DeleteRenderer - deleting renderer 16:33:27 58.226116 T:1962463232 DEBUG: CMMALRenderer::~CMMALRenderer 16:33:27 58.226147 T:1962463232 DEBUG: CMMALRenderer::UnInitMMAL 16:33:27 58.226223 T:1507849120 DEBUG: CMMALRenderer::Run - stopping 16:33:27 58.226311 T:1507849120 DEBUG: Thread MMALProcess 1507849120 terminating 16:33:27 58.226349 T:1962463232 NOTICE: CVideoPlayer::CloseFile() 16:33:27 58.226383 T:1962463232 NOTICE: VideoPlayer: waiting for threads to exit 16:33:27 58.226418 T:1962463232 NOTICE: VideoPlayer: finished waiting 16:33:27 58.229248 T:1962463232 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 16:33:27 58.232384 T:1962455968 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 16:33:27 58.232616 T:1962455968 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 16:33:27 58.243484 T:1962463232 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:33:27 58.308796 T:1499460512 DEBUG: Thread BackgroundLoader 1499460512 terminating 16:33:31 62.352970 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:32 62.579044 T:1962463232 DEBUG: OnKey: return (0xf00d) pressed, action is Select 16:33:32 62.600540 T:1962463232 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?action=playVod&vod_id=747654 16:33:32 62.601139 T:1962455968 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 16:33:32 62.601288 T:1962455968 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 16:33:32 62.615074 T:1962463232 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','6','?action=playVod&vod_id=747654') 16:33:32 62.615700 T:1499460512 DEBUG: Thread LanguageInvoker start, auto delete: false 16:33:32 62.615940 T:1499460512 INFO: initializing python engine. 16:33:32 62.616020 T:1499460512 DEBUG: CPythonInvoker(6, /storage/.kodi/addons/plugin.video.skygo-master/default.py): start processing 16:33:32 62.622501 T:1962455968 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 16:33:32 62.622749 T:1962455968 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 16:33:32 62.636166 T:1507849120 DEBUG: Thread scriptobs start, auto delete: false 16:33:32 62.670986 T:1499460512 DEBUG: -->Python Interpreter Initialized<-- 16:33:32 62.671310 T:1499460512 DEBUG: CPythonInvoker(6, /storage/.kodi/addons/plugin.video.skygo-master/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo-master/default.py" 16:33:32 62.672325 T:1499460512 DEBUG: CPythonInvoker(6, /storage/.kodi/addons/plugin.video.skygo-master/default.py): setting the Python path to /storage/.kodi/addons/plugin.video.skygo-master:/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:33:32 62.672485 T:1499460512 DEBUG: CPythonInvoker(6, /storage/.kodi/addons/plugin.video.skygo-master/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo-master 16:33:32 62.672653 T:1499460512 DEBUG: CPythonInvoker(6, /storage/.kodi/addons/plugin.video.skygo-master/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:33:32 62.836201 T:1962463232 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:33:32 63.123577 T:1499460512 DEBUG: false 16:33:32 63.134354 T:1499460512 DEBUG: {'action': 'playVod', 'vod_id': '747654'} 16:33:33 63.530441 T:1499460512 DEBUG: {u'tcFlag': u'Y', u'mktgFlag': u'Y', u'firstName': u'TIMO', u'country': u'DE', u'extraCustFlag': u'N', u'resultMessage': u'OK', u'privacyFlag': u'Y', u'resultCode': u'S_100', u'bookmarkFlag': u'Y', u'customerCode': u'9945084432', u'cableSubFlag': u'Y', u'skygoSessionId': u'SG-15b701b9-8b32-4233-8b55-f8645e9c9fdb', u'lastName': u'', u'entitlements': [u'OOHD', u'OOSW', u'OOSP', u'OOSF', u'OFBP', u'SHDE', u'KIDS', u'OFBS', u'OFEH', u'OFES', u'OSFH', u'OSPS', u'OWEH'], u'doubleOptInFlag': u'N', u'presentation': u'HERR', u'email': u' '} 16:33:33 63.530655 T:1499460512 DEBUG: User still logged in 16:33:34 64.541252 T:1499460512 INFO: CPythonInvoker(6, /storage/.kodi/addons/plugin.video.skygo-master/default.py): script successfully run 16:33:34 64.551361 T:1507849120 DEBUG: Thread scriptobs 1507849120 terminating 16:33:34 64.607079 T:1962463232 DEBUG: CCurlFile::GetMimeType - http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest -> text/xml 16:33:34 64.622887 T:1962463232 DEBUG: Loading settings for http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest 16:33:34 64.633995 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers(http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest) 16:33:34 64.634117 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 16:33:34 64.634186 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 16:33:34 64.634224 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 16:33:34 64.634323 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 16:33:34 64.634399 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 16:33:34 64.634468 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 16:33:34 64.634544 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 16:33:34 64.634628 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams 16:33:34 64.634674 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp 16:33:34 64.634750 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2 16:33:34 64.634827 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 16:33:34 64.634865 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 16:33:34 64.634926 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 16:33:34 64.635002 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 16:33:34 64.635063 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 16:33:34 64.635132 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 16:33:34 64.635178 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 16:33:34 64.635208 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 16:33:34 64.635269 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 16:33:34 64.635300 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 16:33:34 64.639732 T:1962463232 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 16:33:34 64.639961 T:1962463232 NOTICE: VideoPlayer: Opening: http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest 16:33:34 64.640030 T:1962463232 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 16:33:34 64.642990 T:1499460512 INFO: Python script stopped 16:33:34 64.643112 T:1499460512 DEBUG: Thread LanguageInvoker 1499460512 terminating 16:33:34 64.694885 T:1962463232 DEBUG: CCurlFile::GetMimeType - http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest -> text/xml 16:33:34 64.695007 T:1962463232 DEBUG: CMMALRenderer::CMMALRenderer 16:33:34 64.695122 T:1962463232 DEBUG: CMMALRenderer::UnInitMMAL 16:33:34 64.695160 T:1962463232 DEBUG: CMMALRenderer::PreInit 16:33:34 64.695190 T:1499460512 DEBUG: Thread MMALProcess start, auto delete: false 16:33:34 64.695236 T:1499460512 DEBUG: CMMALRenderer::Run - starting 16:33:34 64.695282 T:1507849120 DEBUG: Thread VideoPlayer start, auto delete: false 16:33:34 64.695457 T:1507849120 NOTICE: Creating InputStream 16:33:34 64.695610 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: ADDON_Destroy() 16:33:34 64.696152 T:1507849120 DEBUG: SECTION:UnloadDll(/storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.0) 16:33:34 64.696556 T:1507849120 INFO: ADDON: Dll Destroyed - InputStream SmoothStreamingMedia 16:33:34 64.696594 T:1507849120 DEBUG: ADDON: Dll Initializing - InputStream SmoothStreamingMedia 16:33:34 64.696823 T:1507849120 DEBUG: SECTION:LoadDLL(/storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.0) 16:33:34 64.696930 T:1507849120 DEBUG: Loading: /storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.0 16:33:34 64.722336 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: ADDON_Create() 16:33:34 64.722443 T:1507849120 INFO: AddOnLog: InputStream SmoothStreamingMedia: SetVideoResolution (1920 x 1080) 16:33:34 64.722641 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Open() 16:33:34 64.722710 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_data: [not shown] 16:33:34 64.722748 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_key: [not shown] 16:33:34 64.722778 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_type: com.widevine.alpha 16:33:34 64.723404 T:1507849120 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MAXRESOLUTION' 16:33:34 64.724182 T:1507849120 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'DECRYPTERPATH' 16:33:34 64.724815 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Searching for decrypters in: /storage/.kodi/cdm 16:33:34 64.725380 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Supported URN: 16:33:34 64.726051 T:1507849120 DEBUG: CurlFile::Open(0x5b0537d8) http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest 16:33:34 64.930649 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Download http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest finished 16:33:34 64.931244 T:1507849120 INFO: AddOnLog: InputStream SmoothStreamingMedia: Successfully parsed .mpd file. Download speed: 0.0000 Bytes/s 16:33:34 64.931305 T:1507849120 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MINBANDWIDTH' 16:33:34 64.932114 T:1507849120 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MAXBANDWIDTH' 16:33:34 64.933838 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: GetStreamIds() 16:33:34 64.933899 T:1507849120 ERROR: CVideoPlayer::OpenInputStream - error opening [http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest] 16:33:34 64.933937 T:1507849120 NOTICE: CVideoPlayer::OnExit() 16:33:34 64.933975 T:1507849120 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Close() 16:33:34 64.934013 T:1507849120 INFO: ADDON: Dll Stopped - InputStream SmoothStreamingMedia 16:33:34 64.934082 T:1507849120 DEBUG: OnPlayBackStopped: play state was 1, starting 1 16:33:34 64.934135 T:1507849120 DEBUG: Thread VideoPlayer 1507849120 terminating 16:33:34 64.934181 T:1962463232 DEBUG: OnPlayBackStopped: play state was 3, starting 0 16:33:34 64.934433 T:1962463232 ERROR: Playlist Player: skipping unplayable item: 0, path [plugin://plugin.video.skygo.de/?action=playVod&vod_id=747654] 16:33:34 64.934486 T:1962463232 DEBUG: Playlist Player: one or more items failed to play... aborting playback 16:33:34 64.934555 T:1962463232 DEBUG: ------ Window Init (DialogConfirm.xml) ------ 16:33:34 64.934593 T:1962463232 INFO: Loading skin file: DialogConfirm.xml, load type: KEEP_IN_MEMORY 16:33:34 64.942467 T:1962463232 NOTICE: CVideoPlayer::CloseFile() 16:33:34 64.942581 T:1962463232 NOTICE: VideoPlayer: waiting for threads to exit 16:33:34 64.942619 T:1962463232 NOTICE: VideoPlayer: finished waiting 16:33:34 64.942680 T:1962463232 DEBUG: DeleteRenderer - deleting renderer 16:33:34 64.942711 T:1962463232 DEBUG: CMMALRenderer::~CMMALRenderer 16:33:34 64.942749 T:1962463232 DEBUG: CMMALRenderer::UnInitMMAL 16:33:34 64.942871 T:1499460512 DEBUG: CMMALRenderer::Run - stopping 16:33:34 64.942940 T:1499460512 DEBUG: Thread MMALProcess 1499460512 terminating 16:33:34 64.943085 T:1962463232 NOTICE: CVideoPlayer::CloseFile() 16:33:34 64.943123 T:1962463232 NOTICE: VideoPlayer: waiting for threads to exit 16:33:34 64.943153 T:1962463232 NOTICE: VideoPlayer: finished waiting 16:33:34 64.945702 T:1962463232 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 16:33:34 64.946602 T:1962455968 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 16:33:34 64.946846 T:1962455968 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 16:33:34 64.992004 T:1962463232 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:33:36 66.689957 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:36 66.943016 T:1962463232 DEBUG: OnKey: return (0xf00d) pressed, action is Select 16:33:36 66.943367 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:36 67.202522 T:1962463232 DEBUG: ------ Window Deinit (DialogConfirm.xml) ------ 16:33:36 67.240501 T:1962455968 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 16:33:36 67.240776 T:1962455968 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 16:33:36 67.240913 T:1622782880 DEBUG: Thread BackgroundLoader start, auto delete: false 16:33:36 67.241302 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:36 67.351379 T:1622782880 DEBUG: Thread BackgroundLoader 1622782880 terminating 16:33:37 67.788689 T:1930425248 DEBUG: CAESinkPi:Drain delay:99ms now:0ms 16:33:37 68.150185 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:37 68.344467 T:1962463232 DEBUG: OnKey: return (0xf00d) pressed, action is Select 16:33:37 68.364838 T:1962463232 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?action=playVod&vod_id=747654 16:33:37 68.378273 T:1962463232 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','7','?action=playVod&vod_id=747654') 16:33:37 68.378876 T:1622782880 DEBUG: Thread LanguageInvoker start, auto delete: false 16:33:37 68.379089 T:1622782880 INFO: initializing python engine. 16:33:37 68.379173 T:1622782880 DEBUG: CPythonInvoker(7, /storage/.kodi/addons/plugin.video.skygo-master/default.py): start processing 16:33:37 68.387047 T:1962455968 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 16:33:37 68.387306 T:1962455968 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 16:33:37 68.399338 T:1639560096 DEBUG: Thread scriptobs start, auto delete: false 16:33:37 68.436081 T:1622782880 DEBUG: -->Python Interpreter Initialized<-- 16:33:37 68.436356 T:1622782880 DEBUG: CPythonInvoker(7, /storage/.kodi/addons/plugin.video.skygo-master/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo-master/default.py" 16:33:37 68.437561 T:1622782880 DEBUG: CPythonInvoker(7, /storage/.kodi/addons/plugin.video.skygo-master/default.py): setting the Python path to /storage/.kodi/addons/plugin.video.skygo-master:/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:33:37 68.437691 T:1622782880 DEBUG: CPythonInvoker(7, /storage/.kodi/addons/plugin.video.skygo-master/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo-master 16:33:37 68.437874 T:1622782880 DEBUG: CPythonInvoker(7, /storage/.kodi/addons/plugin.video.skygo-master/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:33:38 68.599373 T:1962463232 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:33:38 68.890289 T:1622782880 DEBUG: false 16:33:38 68.900909 T:1622782880 DEBUG: {'action': 'playVod', 'vod_id': '747654'} 16:33:38 69.332123 T:1622782880 DEBUG: {u'tcFlag': u'Y', u'mktgFlag': u'Y', u'firstName': u'TIMO', u'country': u'DE', u'extraCustFlag': u'N', u'resultMessage': u'OK', u'privacyFlag': u'Y', u'resultCode': u'S_100', u'bookmarkFlag': u'Y', u'customerCode': u'9945084432', u'cableSubFlag': u'Y', u'skygoSessionId': u'SG-15b701b9-8b32-4233-8b55-f8645e9c9fdb', u'lastName': u'HARNEITH', u'entitlements': [u'OOHD', u'OOSW', u'OOSP', u'OOSF', u'OFBP', u'SHDE', u'KIDS', u'OFBS', u'OFEH', u'OFES', u'OSFH', u'OSPS', u'OWEH'], u'doubleOptInFlag': u'N', u'presentation': u'HERR', u'email': u''} 16:33:38 69.332321 T:1622782880 DEBUG: User still logged in 16:33:39 70.305695 T:1622782880 INFO: CPythonInvoker(7, /storage/.kodi/addons/plugin.video.skygo-master/default.py): script successfully run 16:33:39 70.315254 T:1639560096 DEBUG: Thread scriptobs 1639560096 terminating 16:33:39 70.370514 T:1962463232 DEBUG: CCurlFile::GetMimeType - http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest -> text/xml 16:33:39 70.386299 T:1962463232 DEBUG: Loading settings for http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest 16:33:39 70.397354 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers(http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest) 16:33:39 70.397484 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 16:33:39 70.397545 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 16:33:39 70.397575 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 16:33:39 70.397682 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 16:33:39 70.397758 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 16:33:39 70.397873 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 16:33:39 70.397942 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 16:33:39 70.398033 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams 16:33:39 70.398064 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp 16:33:39 70.398140 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2 16:33:39 70.398209 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 16:33:39 70.398254 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 16:33:39 70.398315 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 16:33:39 70.398384 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 16:33:39 70.398445 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 16:33:39 70.398521 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 16:33:39 70.398560 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 16:33:39 70.398598 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 16:33:39 70.398628 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 16:33:39 70.398659 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 16:33:39 70.403000 T:1962463232 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 16:33:39 70.403221 T:1962463232 NOTICE: VideoPlayer: Opening: http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest 16:33:39 70.403267 T:1962463232 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 16:33:39 70.406227 T:1622782880 INFO: Python script stopped 16:33:39 70.406342 T:1622782880 DEBUG: Thread LanguageInvoker 1622782880 terminating 16:33:39 70.458015 T:1962463232 DEBUG: CCurlFile::GetMimeType - http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest -> text/xml 16:33:39 70.458130 T:1962463232 DEBUG: CMMALRenderer::CMMALRenderer 16:33:39 70.458237 T:1962463232 DEBUG: CMMALRenderer::UnInitMMAL 16:33:39 70.458275 T:1962463232 DEBUG: CMMALRenderer::PreInit 16:33:39 70.458321 T:1622782880 DEBUG: Thread MMALProcess start, auto delete: false 16:33:39 70.458366 T:1622782880 DEBUG: CMMALRenderer::Run - starting 16:33:39 70.458481 T:1639560096 DEBUG: Thread VideoPlayer start, auto delete: false 16:33:39 70.458664 T:1639560096 NOTICE: Creating InputStream 16:33:39 70.458870 T:1639560096 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: ADDON_Destroy() 16:33:39 70.459396 T:1639560096 DEBUG: SECTION:UnloadDll(/storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.0) 16:33:39 70.459801 T:1639560096 INFO: ADDON: Dll Destroyed - InputStream SmoothStreamingMedia 16:33:39 70.459846 T:1639560096 DEBUG: ADDON: Dll Initializing - InputStream SmoothStreamingMedia 16:33:39 70.459976 T:1639560096 DEBUG: SECTION:LoadDLL(/storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.0) 16:33:39 70.460106 T:1639560096 DEBUG: Loading: /storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.0 16:33:39 70.485878 T:1639560096 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: ADDON_Create() 16:33:39 70.486000 T:1639560096 INFO: AddOnLog: InputStream SmoothStreamingMedia: SetVideoResolution (1920 x 1080) 16:33:39 70.486198 T:1639560096 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Open() 16:33:39 70.486267 T:1639560096 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_data: [not shown] 16:33:39 70.486305 T:1639560096 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_key: [not shown] 16:33:39 70.486366 T:1639560096 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_type: com.widevine.alpha 16:33:39 70.487007 T:1639560096 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MAXRESOLUTION' 16:33:39 70.487793 T:1639560096 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'DECRYPTERPATH' 16:33:39 70.488434 T:1639560096 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Searching for decrypters in: /storage/.kodi/cdm 16:33:39 70.489052 T:1639560096 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Supported URN: 16:33:40 70.489731 T:1639560096 DEBUG: CurlFile::Open(0x5daf08f0) http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest 16:33:40 70.695267 T:1639560096 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Download http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest finished 16:33:40 70.696243 T:1639560096 INFO: AddOnLog: InputStream SmoothStreamingMedia: Successfully parsed .mpd file. Download speed: 0.0000 Bytes/s 16:33:40 70.696335 T:1639560096 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MINBANDWIDTH' 16:33:40 70.697929 T:1639560096 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MAXBANDWIDTH' 16:33:40 70.700905 T:1639560096 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: GetStreamIds() 16:33:40 70.701035 T:1639560096 ERROR: CVideoPlayer::OpenInputStream - error opening [http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest] 16:33:40 70.701103 T:1639560096 NOTICE: CVideoPlayer::OnExit() 16:33:40 70.701172 T:1639560096 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Close() 16:33:40 70.701248 T:1639560096 INFO: ADDON: Dll Stopped - InputStream SmoothStreamingMedia 16:33:40 70.701378 T:1639560096 DEBUG: OnPlayBackStopped: play state was 1, starting 1 16:33:40 70.701492 T:1639560096 DEBUG: Thread VideoPlayer 1639560096 terminating 16:33:40 70.701569 T:1962463232 DEBUG: OnPlayBackStopped: play state was 3, starting 0 16:33:40 70.702095 T:1962463232 ERROR: Playlist Player: skipping unplayable item: 0, path [plugin://plugin.video.skygo.de/?action=playVod&vod_id=747654] 16:33:40 70.702194 T:1962463232 DEBUG: Playlist Player: no more playable items... aborting playback 16:33:40 70.703148 T:1639560096 DEBUG: Thread BackgroundLoader start, auto delete: false 16:33:40 70.703598 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:40 70.719337 T:1962463232 NOTICE: CVideoPlayer::CloseFile() 16:33:40 70.719521 T:1962463232 NOTICE: VideoPlayer: waiting for threads to exit 16:33:40 70.719597 T:1962463232 NOTICE: VideoPlayer: finished waiting 16:33:40 70.719727 T:1962463232 DEBUG: DeleteRenderer - deleting renderer 16:33:40 70.719803 T:1962463232 DEBUG: CMMALRenderer::~CMMALRenderer 16:33:40 70.719879 T:1962463232 DEBUG: CMMALRenderer::UnInitMMAL 16:33:40 70.720032 T:1622782880 DEBUG: CMMALRenderer::Run - stopping 16:33:40 70.720139 T:1622782880 DEBUG: Thread MMALProcess 1622782880 terminating 16:33:40 70.720215 T:1962463232 NOTICE: CVideoPlayer::CloseFile() 16:33:40 70.720276 T:1962463232 NOTICE: VideoPlayer: waiting for threads to exit 16:33:40 70.720352 T:1962463232 NOTICE: VideoPlayer: finished waiting 16:33:40 70.725159 T:1962463232 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 16:33:40 70.737801 T:1962455968 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 16:33:40 70.738136 T:1962455968 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 16:33:40 70.741219 T:1962463232 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:33:40 70.808525 T:1639560096 DEBUG: Thread BackgroundLoader 1639560096 terminating 16:33:41 72.262848 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:41 72.423470 T:1962463232 DEBUG: OnKey: return (0xf00d) pressed, action is Select 16:33:41 72.445747 T:1962463232 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?action=playVod&vod_id=747654 16:33:41 72.446404 T:1962455968 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 16:33:41 72.446564 T:1962455968 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 16:33:41 72.458534 T:1962463232 DEBUG: StartScript - calling plugin Skygo('plugin://plugin.video.skygo.de/','8','?action=playVod&vod_id=747654') 16:33:41 72.459000 T:1639560096 DEBUG: Thread LanguageInvoker start, auto delete: false 16:33:41 72.459145 T:1639560096 INFO: initializing python engine. 16:33:41 72.459198 T:1639560096 DEBUG: CPythonInvoker(8, /storage/.kodi/addons/plugin.video.skygo-master/default.py): start processing 16:33:41 72.463387 T:1962455968 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 16:33:41 72.463585 T:1962455968 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 16:33:41 72.479340 T:1622782880 DEBUG: Thread scriptobs start, auto delete: false 16:33:42 72.491035 T:1639560096 DEBUG: -->Python Interpreter Initialized<-- 16:33:42 72.491203 T:1639560096 DEBUG: CPythonInvoker(8, /storage/.kodi/addons/plugin.video.skygo-master/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.skygo-master/default.py" 16:33:42 72.491730 T:1639560096 DEBUG: CPythonInvoker(8, /storage/.kodi/addons/plugin.video.skygo-master/default.py): setting the Python path to /storage/.kodi/addons/plugin.video.skygo-master:/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:33:42 72.491798 T:1639560096 DEBUG: CPythonInvoker(8, /storage/.kodi/addons/plugin.video.skygo-master/default.py): entering source directory /storage/.kodi/addons/plugin.video.skygo-master 16:33:42 72.491898 T:1639560096 DEBUG: CPythonInvoker(8, /storage/.kodi/addons/plugin.video.skygo-master/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:33:42 72.679474 T:1962463232 DEBUG: ------ Window Init (DialogBusy.xml) ------ 16:33:42 72.911629 T:1639560096 DEBUG: false 16:33:42 72.924408 T:1639560096 DEBUG: {'action': 'playVod', 'vod_id': '747654'} 16:33:42 73.297691 T:1639560096 DEBUG: {u'tcFlag': u'Y', u'mktgFlag': u'Y', u'firstName': u'TIMO', u'country': u'DE', u'extraCustFlag': u'N', u'resultMessage': u'OK', u'privacyFlag': u'Y', u'resultCode': u'S_100', u'bookmarkFlag': u'Y', u'customerCode': u'9945084432', u'cableSubFlag': u'Y', u'skygoSessionId': u'SG-15b701b9-8b32-4233-8b55-f8645e9c9fdb', u'lastName': u'HARNEITH', u'entitlements': [u'OOHD', u'OOSW', u'OOSP', u'OOSF', u'OFBP', u'SHDE', u'KIDS', u'OFBS', u'OFEH', u'OFES', u'OSFH', u'OSPS', u'OWEH'], u'doubleOptInFlag': u'N', u'presentation': u'HERR', u'email': u''} 16:33:42 73.297897 T:1639560096 DEBUG: User still logged in 16:33:43 74.277390 T:1639560096 INFO: CPythonInvoker(8, /storage/.kodi/addons/plugin.video.skygo-master/default.py): script successfully run 16:33:43 74.285980 T:1622782880 DEBUG: Thread scriptobs 1622782880 terminating 16:33:43 74.341599 T:1962463232 DEBUG: CCurlFile::GetMimeType - http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest -> text/xml 16:33:43 74.357460 T:1962463232 DEBUG: Loading settings for http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest 16:33:43 74.368576 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers(http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest) 16:33:43 74.368752 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 16:33:43 74.368820 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 16:33:43 74.368851 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 16:33:43 74.368958 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 16:33:43 74.369034 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 16:33:43 74.369102 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 16:33:43 74.369179 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 16:33:43 74.369270 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams 16:33:43 74.369301 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp 16:33:43 74.369385 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2 16:33:43 74.369453 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 16:33:43 74.369492 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 16:33:43 74.369553 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 16:33:43 74.369621 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 16:33:43 74.369690 T:1962463232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 16:33:43 74.369759 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 16:33:43 74.369797 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 16:33:43 74.369835 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 16:33:43 74.369865 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 16:33:43 74.369896 T:1962463232 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 16:33:43 74.374283 T:1962463232 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 16:33:43 74.374504 T:1962463232 NOTICE: VideoPlayer: Opening: http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest 16:33:43 74.374550 T:1962463232 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 16:33:43 74.377113 T:1639560096 INFO: Python script stopped 16:33:43 74.377228 T:1639560096 DEBUG: Thread LanguageInvoker 1639560096 terminating 16:33:43 74.429024 T:1962463232 DEBUG: CCurlFile::GetMimeType - http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest -> text/xml 16:33:43 74.429131 T:1962463232 DEBUG: CMMALRenderer::CMMALRenderer 16:33:43 74.429237 T:1962463232 DEBUG: CMMALRenderer::UnInitMMAL 16:33:43 74.429283 T:1962463232 DEBUG: CMMALRenderer::PreInit 16:33:43 74.429367 T:1639560096 DEBUG: Thread MMALProcess start, auto delete: false 16:33:43 74.429428 T:1639560096 DEBUG: CMMALRenderer::Run - starting 16:33:43 74.429466 T:1622782880 DEBUG: Thread VideoPlayer start, auto delete: false 16:33:43 74.429649 T:1622782880 NOTICE: Creating InputStream 16:33:43 74.429825 T:1622782880 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: ADDON_Destroy() 16:33:43 74.430428 T:1622782880 DEBUG: SECTION:UnloadDll(/storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.0) 16:33:43 74.430855 T:1622782880 INFO: ADDON: Dll Destroyed - InputStream SmoothStreamingMedia 16:33:43 74.430893 T:1622782880 DEBUG: ADDON: Dll Initializing - InputStream SmoothStreamingMedia 16:33:43 74.431038 T:1622782880 DEBUG: SECTION:LoadDLL(/storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.0) 16:33:43 74.431114 T:1622782880 DEBUG: Loading: /storage/.kodi/addons/inputstream.smoothstream/inputstream.smoothstream.so.1.2.0 16:33:43 74.456703 T:1622782880 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: ADDON_Create() 16:33:43 74.456879 T:1622782880 INFO: AddOnLog: InputStream SmoothStreamingMedia: SetVideoResolution (1920 x 1080) 16:33:43 74.457092 T:1622782880 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Open() 16:33:43 74.457161 T:1622782880 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_data: [not shown] 16:33:43 74.457199 T:1622782880 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_key: [not shown] 16:33:43 74.457230 T:1622782880 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: found inputstream.smoothstream.license_type: com.widevine.alpha 16:33:43 74.457825 T:1622782880 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MAXRESOLUTION' 16:33:43 74.458641 T:1622782880 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'DECRYPTERPATH' 16:33:43 74.459305 T:1622782880 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Searching for decrypters in: /storage/.kodi/cdm 16:33:43 74.459854 T:1622782880 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Supported URN: 16:33:43 74.460541 T:1622782880 DEBUG: CurlFile::Open(0x64dd5878) http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest 16:33:44 74.666405 T:1622782880 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Download http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest finished 16:33:44 74.667450 T:1622782880 INFO: AddOnLog: InputStream SmoothStreamingMedia: Successfully parsed .mpd file. Download speed: 0.0000 Bytes/s 16:33:44 74.667549 T:1622782880 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MINBANDWIDTH' 16:33:44 74.669060 T:1622782880 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream SmoothStreamingMedia' requests setting 'MAXBANDWIDTH' 16:33:44 74.672203 T:1622782880 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: GetStreamIds() 16:33:44 74.672340 T:1622782880 ERROR: CVideoPlayer::OpenInputStream - error opening [http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F30051199____100332001/F30051199____100332001.ism/Manifest] 16:33:44 74.672409 T:1622782880 NOTICE: CVideoPlayer::OnExit() 16:33:44 74.672485 T:1622782880 DEBUG: AddOnLog: InputStream SmoothStreamingMedia: Close() 16:33:44 74.672554 T:1622782880 INFO: ADDON: Dll Stopped - InputStream SmoothStreamingMedia 16:33:44 74.672676 T:1622782880 DEBUG: OnPlayBackStopped: play state was 1, starting 1 16:33:44 74.672775 T:1622782880 DEBUG: Thread VideoPlayer 1622782880 terminating 16:33:44 74.672882 T:1962463232 DEBUG: OnPlayBackStopped: play state was 3, starting 0 16:33:44 74.673424 T:1962463232 ERROR: Playlist Player: skipping unplayable item: 0, path [plugin://plugin.video.skygo.de/?action=playVod&vod_id=747654] 16:33:44 74.673531 T:1962463232 DEBUG: Playlist Player: no more playable items... aborting playback 16:33:44 74.674438 T:1622782880 DEBUG: Thread BackgroundLoader start, auto delete: false 16:33:44 74.674789 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:44 74.684532 T:1962463232 NOTICE: CVideoPlayer::CloseFile() 16:33:44 74.684654 T:1962463232 NOTICE: VideoPlayer: waiting for threads to exit 16:33:44 74.684692 T:1962463232 NOTICE: VideoPlayer: finished waiting 16:33:44 74.684753 T:1962463232 DEBUG: DeleteRenderer - deleting renderer 16:33:44 74.684784 T:1962463232 DEBUG: CMMALRenderer::~CMMALRenderer 16:33:44 74.684822 T:1962463232 DEBUG: CMMALRenderer::UnInitMMAL 16:33:44 74.684906 T:1639560096 DEBUG: CMMALRenderer::Run - stopping 16:33:44 74.684975 T:1639560096 DEBUG: Thread MMALProcess 1639560096 terminating 16:33:44 74.685051 T:1962463232 NOTICE: CVideoPlayer::CloseFile() 16:33:44 74.685089 T:1962463232 NOTICE: VideoPlayer: waiting for threads to exit 16:33:44 74.685120 T:1962463232 NOTICE: VideoPlayer: finished waiting 16:33:44 74.687691 T:1962463232 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 16:33:44 74.695107 T:1962455968 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 16:33:44 74.695374 T:1962455968 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 16:33:44 74.699127 T:1962463232 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 16:33:44 74.757500 T:1622782880 DEBUG: Thread BackgroundLoader 1622782880 terminating 16:33:46 77.471992 T:1962463232 DEBUG: Keyboard: scancode: 0x69, sym: 0x0114, unicode: 0x0000, modifier: 0x0 16:33:46 77.472237 T:1962463232 DEBUG: OnKey: left (0xf082) pressed, action is Left 16:33:47 77.673286 T:1962463232 DEBUG: Keyboard: scancode: 0x69, sym: 0x0114, unicode: 0x0000, modifier: 0x0 16:33:47 77.789009 T:1930425248 DEBUG: CAESinkPi:Deinitialize 16:33:47 77.789604 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 16:33:47 77.802879 T:1930425248 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x7270bf10 16:33:48 79.423347 T:1962463232 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 16:33:48 79.423637 T:1962463232 DEBUG: OnKey: right (0xf083) pressed, action is Right 16:33:49 79.606636 T:1962463232 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 16:33:50 80.659737 T:1962463232 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 16:33:50 80.660019 T:1962463232 DEBUG: OnKey: escape (0xf01b) pressed, action is PreviousMenu 16:33:50 80.660301 T:1962463232 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 16:33:50 80.981369 T:1962463232 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 16:33:50 80.990097 T:1962463232 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 16:33:50 80.990227 T:1962463232 DEBUG: ------ Window Init (Home.xml) ------ 16:33:50 81.005989 T:1962463232 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY 16:33:50 81.308197 T:1962463232 DEBUG: CDirectoryProvider[special://skin/playlists/inprogress_movies.xsp]: refreshing.. 16:33:50 81.310120 T:1962463232 DEBUG: CDirectoryProvider[videodb://recentlyaddedmovies/]: refreshing.. 16:33:50 81.310257 T:1962463232 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_movies.xsp]: refreshing.. 16:33:50 81.310333 T:1962463232 DEBUG: CDirectoryProvider[special://skin/playlists/random_movies.xsp]: refreshing.. 16:33:50 81.310677 T:1962463232 DEBUG: CDirectoryProvider[videodb://inprogresstvshows]: refreshing.. 16:33:50 81.310730 T:1962463232 DEBUG: CDirectoryProvider[videodb://recentlyaddedepisodes/]: refreshing.. 16:33:50 81.310783 T:1962463232 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_tvshows.xsp]: refreshing.. 16:33:50 81.310928 T:1962463232 DEBUG: CDirectoryProvider[musicdb://recentlyplayedalbums]: refreshing.. 16:33:50 81.310989 T:1962463232 DEBUG: CDirectoryProvider[musicdb://recentlyaddedalbums/]: refreshing.. 16:33:50 81.311043 T:1962463232 DEBUG: CDirectoryProvider[special://skin/playlists/random_albums.xsp]: refreshing.. 16:33:50 81.311096 T:1962463232 DEBUG: CDirectoryProvider[special://skin/playlists/random_artists.xsp]: refreshing.. 16:33:50 81.311142 T:1962463232 DEBUG: CDirectoryProvider[special://skin/playlists/unplayed_albums.xsp]: refreshing.. 16:33:50 81.311241 T:1962463232 DEBUG: CDirectoryProvider[special://skin/playlists/mostplayed_albums.xsp]: refreshing.. 16:33:50 81.311371 T:1962463232 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 16:33:50 81.311440 T:1962463232 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 16:33:50 81.311501 T:1962463232 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 16:33:50 81.311607 T:1962463232 DEBUG: CDirectoryProvider[-]: refreshing.. 16:33:50 81.311668 T:1962463232 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 16:33:50 81.311821 T:1962463232 DEBUG: CDirectoryProvider[sources://video/]: refreshing.. 16:33:50 81.311943 T:1962463232 DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing.. 16:33:50 81.312141 T:1962463232 DEBUG: CDirectoryProvider[pvr://channels/tv/All channels/]: refreshing.. 16:33:50 81.321182 T:1962463232 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 16:33:50 81.324265 T:1622782880 DEBUG: Thread JobWorker start, auto delete: true 16:33:50 81.334206 T:1779430304 DEBUG: RunQuery took 3 ms for 0 items query: select * from movie_view WHERE (movie_view.idFile IN (SELECT DISTINCT idFile FROM bookmark WHERE type = 1)) 16:33:50 81.334312 T:1771041696 DEBUG: RunQuery took 3 ms for 0 items query: select * from movie_view ORDER BY dateAdded desc, idMovie desc LIMIT 25 16:33:50 81.335152 T:1962463232 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x2db0570 16:33:50 81.335693 T:1962463232 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(263024), nBufferAlignmen(16) 16:33:50 81.340378 T:1962463232 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x2dd0d88 16:33:50 81.341446 T:1962463232 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x2d69af0 16:33:50 81.341995 T:1962463232 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 16:33:50 81.342903 T:1874850720 DEBUG: RunQuery took 4 ms for 0 items query: select * from movie_view WHERE ((movie_view.playCount IS NULL OR movie_view.playCount = 0)) 16:33:50 81.358742 T:1779430304 DEBUG: RunQuery took 3 ms for 0 items query: SELECT * FROM tvshow_view WHERE watchedCount != 0 AND totalCount != watchedCount ORDER BY c00 16:33:50 81.361763 T:1771041696 DEBUG: RunQuery took 2 ms for 0 items query: select * from movie_view 16:33:50 81.366806 T:1874850720 DEBUG: RunQuery took 3 ms for 0 items query: select * from episode_view ORDER BY dateAdded desc, idEpisode desc LIMIT 25 16:33:50 81.374199 T:1771041696 DEBUG: GetRecentlyPlayedAlbums query: SELECT albumview.*, albumartistview.* FROM (SELECT idAlbum FROM albumview WHERE albumview.lastplayed IS NOT NULL 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:33:50 81.380692 T:1874850720 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:33:50 81.390739 T:1771041696 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE albumview.strReleaseType = 'album' 16:33:50 81.391075 T:1779430304 DEBUG: RunQuery took 4 ms for 0 items query: SELECT * FROM tvshow_view WHERE ((CAST(tvshow_view.watchedcount as DECIMAL(5,1)) = 0)) AND ((CAST(tvshow_view.totalCount as DECIMAL(5,1)) > 0)) 16:33:50 81.391899 T:1771041696 DEBUG: GetAlbumsByWhere - query took 1 ms 16:33:50 81.398087 T:1874850720 DEBUG: GetArtistsByWhere query: SELECT artistview.* FROM artistview WHERE (artistview.idArtist IN (SELECT album_artist.idArtist FROM album_artist ) OR artistview.idArtist IN (SELECT song_artist.idArtist FROM song_artist WHERE song_artist.idRole = 1)) and artistview.strArtist != '' and artistview.strArtist <> 'Verschiedene Interpreten' 16:33:50 81.399536 T:1874850720 DEBUG: Time to retrieve artists from dataset = 5 16:33:50 81.408096 T:1779430304 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE (albumview.strReleaseType = 'album') AND (((CAST(albumview.iTimesPlayed as DECIMAL(5,1)) = 0))) 16:33:50 81.408928 T:1771041696 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE (albumview.strReleaseType = 'album') AND (((CAST(albumview.iTimesPlayed as DECIMAL(5,1)) > 0))) 16:33:50 81.409248 T:1779430304 DEBUG: GetAlbumsByWhere - query took 1 ms 16:33:50 81.412880 T:1874850720 DEBUG: Previous line repeats 1 times. 16:33:50 81.413071 T:1874850720 ERROR: GetDirectory - Error getting - 16:33:50 81.413681 T:1962463232 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x2db0570 16:33:50 81.414330 T:1962463232 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x2dd0d88 16:33:50 81.415062 T:1962463232 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x2d69af0 16:33:50 81.415222 T:1962463232 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/home-images/add-ons.jpg 927x540 16:33:50 81.426361 T:1779430304 DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3A%2F%2Fprofile%2Fplaylists%2Fvideo/special%3A%2F%2Fprofile%2Fplaylists%2Fmixed/) 16:33:50 81.426521 T:1779430304 DEBUG: Getting Directory (special://profile/playlists/video) 16:33:50 81.427269 T:1779430304 DEBUG: Getting Directory (special://profile/playlists/mixed) 16:33:50 81.427940 T:1779430304 DEBUG: CMultiPathDirectory::MergeItems, items = 0 16:33:50 81.428848 T:1779430304 DEBUG: CPVRDirectory::GetDirectory(pvr://channels/tv/All channels) 16:33:52 82.942749 T:1962463232 DEBUG: Keyboard: scancode: 0x2e, sym: 0x0063, unicode: 0x0063, modifier: 0x0 16:33:52 83.121681 T:1962463232 DEBUG: OnKey: c (0xf043) pressed, action is ContextMenu 16:33:52 83.147919 T:1962463232 INFO: Loading skin file: DialogContextMenu.xml, load type: KEEP_IN_MEMORY 16:33:52 83.159439 T:1962463232 DEBUG: ------ Window Init (DialogContextMenu.xml) ------ 16:33:53 84.198402 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:33:53 84.198647 T:1962463232 DEBUG: OnKey: down (0xf081) pressed, action is Down 16:33:53 84.340019 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:33:54 84.583862 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:54 84.715637 T:1962463232 DEBUG: OnKey: return (0xf00d) pressed, action is Select 16:33:54 84.715874 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:54 84.979172 T:1962463232 DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------ 16:33:54 84.990738 T:1962463232 DEBUG: ------ Window Init (DialogAddonSettings.xml) ------ 16:33:54 84.990883 T:1962463232 INFO: Loading skin file: DialogAddonSettings.xml, load type: KEEP_IN_MEMORY 16:33:56 87.000137 T:1962463232 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 16:33:56 87.000389 T:1962463232 DEBUG: OnKey: right (0xf083) pressed, action is Right 16:33:56 87.173332 T:1962463232 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 16:33:56 87.456680 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:33:56 87.456955 T:1962463232 DEBUG: OnKey: down (0xf081) pressed, action is Down 16:33:57 87.590027 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:33:57 87.773468 T:1962463232 DEBUG: Previous line repeats 1 times. 16:33:57 87.773636 T:1962463232 DEBUG: OnKey: down (0xf081) pressed, action is Down 16:33:57 87.906700 T:1962463232 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 16:33:58 89.006660 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:58 89.173409 T:1962463232 DEBUG: OnKey: return (0xf00d) pressed, action is Select 16:33:58 89.173660 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:33:59 89.806633 T:1962463232 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 16:33:59 89.806953 T:1962463232 DEBUG: OnKey: right (0xf083) pressed, action is Right 16:33:59 90.023346 T:1962463232 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 16:34:07 97.606636 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:34:07 97.806709 T:1962463232 DEBUG: OnKey: return (0xf00d) pressed, action is Select 16:34:07 97.811691 T:1962463232 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 16:34:07 98.050880 T:1962463232 DEBUG: ------ Window Deinit (DialogAddonSettings.xml) ------ 16:34:07 98.057007 T:1962463232 DEBUG: Keyboard: scancode: 0x2e, sym: 0x0063, unicode: 0x0063, modifier: 0x0 16:34:14 104.797897 T:1962463232 INFO: CheckIdle - Closing session to http://skywebvod-s.akamaihd.net (easy=0x338c5d8, multi=0x73c8a4c0) 16:34:21 111.498138 T:1771041696 DEBUG: Thread JobWorker 1771041696 terminating (autodelete) 16:34:21 111.498383 T:1874850720 DEBUG: Thread JobWorker 1874850720 terminating (autodelete) 16:34:21 111.498535 T:1622782880 DEBUG: Thread JobWorker 1622782880 terminating (autodelete) 16:34:21 111.498917 T:1779430304 DEBUG: Thread JobWorker 1779430304 terminating (autodelete) 16:35:25 176.201523 T:1962463232 NOTICE: Samba is idle. Closing the remaining connections 16:37:07 278.029083 T:1962455968 DEBUG: CAnnouncementManager - Announcement: OnScreensaverActivated from xbmc 16:37:07 278.029358 T:1962455968 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverActivated 16:37:07 278.034210 T:1962463232 DEBUG: ------ Window Init () ------ 16:37:40 311.429626 T:1566569376 DEBUG: CPVRTimers - Update - updating timers