13:51:40.765 T:3042155408 NOTICE: special://profile/ is mapped to: special://masterprofile/ 13:51:40.765 T:3042155408 NOTICE: ----------------------------------------------------------------------- 13:51:40.765 T:3042155408 NOTICE: Starting Kodi (17.3 Git:2017-06-07-147cec4-dirty). Platform: Linux ARM 32-bit 13:51:40.765 T:3042155408 NOTICE: Using Release Kodi x32 build 13:51:40.765 T:3042155408 NOTICE: Kodi compiled Jun 7 2017 by GCC 6.3.0 for Linux ARM 32-bit version 4.10.0 (264704) 13:51:40.765 T:3042155408 NOTICE: Running on openatv 6.0, kernel: Linux ARM 32-bit version 4.10.12 13:51:40.769 T:3042155408 NOTICE: FFmpeg version/source: ffmpeg-3.1-kodi 13:51:40.769 T:3042155408 NOTICE: Host CPU: ARMv7 Processor rev 3 (v7l), 2 cores available 13:51:40.769 T:3042155408 NOTICE: ARM Features: Neon enabled 13:51:40.769 T:3042155408 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi 13:51:40.769 T:3042155408 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi 13:51:40.769 T:3042155408 NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons 13:51:40.769 T:3042155408 NOTICE: special://masterprofile/ is mapped to: /media/hdd/.kodi/userdata 13:51:40.769 T:3042155408 NOTICE: special://envhome/ is mapped to: /media/hdd 13:51:40.769 T:3042155408 NOTICE: special://home/ is mapped to: /media/hdd/.kodi 13:51:40.769 T:3042155408 NOTICE: special://temp/ is mapped to: /tmp/kodi 13:51:40.769 T:3042155408 NOTICE: special://logpath/ is mapped to: /tmp/kodi 13:51:40.769 T:3042155408 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin 13:51:40.769 T:3042155408 NOTICE: Local hostname: ax51 13:51:40.769 T:3042155408 NOTICE: Log File is located: /tmp/kodi//kodi.log 13:51:40.769 T:3042155408 NOTICE: ----------------------------------------------------------------------- 13:51:40.811 T:3042155408 NOTICE: load settings... 13:51:40.844 T:3042155408 WARNING: CSettingInt: unknown options filler "audiocdactions" of "audiocds.autoaction" 13:51:40.905 T:3042155408 NOTICE: Found 1 Lists of Devices 13:51:40.905 T:3042155408 NOTICE: Enumerated ALSA devices: 13:51:40.905 T:3042155408 NOTICE: Device 1 13:51:40.906 T:3042155408 NOTICE: m_deviceName : @ 13:51:40.906 T:3042155408 NOTICE: m_displayName : Default (bcm Analog) 13:51:40.906 T:3042155408 NOTICE: m_displayNameExtra: 13:51:40.906 T:3042155408 NOTICE: m_deviceType : AE_DEVTYPE_PCM 13:51:40.906 T:3042155408 NOTICE: m_channels : FL,FR 13:51:40.906 T:3042155408 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000 13:51:40.906 T:3042155408 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE 13:51:40.906 T:3042155408 NOTICE: m_streamTypes : No passthrough capabilities 13:51:40.943 T:3042155408 NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml) 13:51:40.943 T:3042155408 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 13:51:40.943 T:3042155408 NOTICE: Default Video Player: VideoPlayer 13:51:40.943 T:3042155408 NOTICE: Default Audio Player: paplayer 13:51:40.943 T:3042155408 NOTICE: Enabled debug logging due to GUI setting (2) 13:51:40.943 T:3042155408 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 13:51:40.943 T:3042155408 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 13:51:40.945 T:3042155408 DEBUG: CPlayerCoreConfig::: created player VideoPlayer 13:51:40.945 T:3042155408 DEBUG: CPlayerCoreConfig::: created player PAPlayer 13:51:40.946 T:3042155408 WARNING: CPlayerCoreFactory::GetPlayer(E2Player): no such player: E2Player 13:51:40.946 T:3042155408 DEBUG: CPlayerCoreConfig::: created player E2Player 13:51:40.946 T:3042155408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: un-named 13:51:40.946 T:3042155408 DEBUG: Previous line repeats 1 times. 13:51:40.946 T:3042155408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules 13:51:40.946 T:3042155408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mms/udp 13:51:40.946 T:3042155408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout 13:51:40.946 T:3042155408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp 13:51:40.946 T:3042155408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp 13:51:40.946 T:3042155408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams 13:51:40.946 T:3042155408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp 13:51:40.946 T:3042155408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2 13:51:40.946 T:3042155408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd 13:51:40.946 T:3042155408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage 13:51:40.946 T:3042155408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf 13:51:40.946 T:3042155408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv 13:51:40.946 T:3042155408 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio 13:51:40.946 T:3042155408 NOTICE: Loaded playercorefactory configuration 13:51:40.946 T:3042155408 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 13:51:40.946 T:3042155408 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 13:51:40.986 T:3042155408 INFO: creating subdirectories 13:51:40.986 T:3042155408 INFO: userdata folder: special://masterprofile/ 13:51:40.986 T:3042155408 INFO: recording folder: 13:51:40.986 T:3042155408 INFO: screenshots folder: 13:51:41.261 T:3042155408 NOTICE: Running database version Addons27 13:51:41.262 T:3042155408 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcpluff-arm.so) 13:51:41.265 T:3042155408 DEBUG: Loading: /usr/lib/kodi/system/libcpluff-arm.so 13:51:41.985 T:3042155408 INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/kodi/addons: No such file or directory' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been installed.' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in resource.images.weathericons.default has been installed.' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in xbmc.audioencoder has been installed.' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in kodi.audiodecoder has been installed.' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in script.module.cryptopy has been installed.' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in kodi.peripheral has been installed.' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in kodi.guilib has been installed.' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.wma has been installed.' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in kodi.adsp has been installed.' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in repository.kodinerds has been installed.' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in script.module.pydes has been installed.' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in game.controller.default has been installed.' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in repository.kodinerds_RPi2 has been installed.' 13:51:41.985 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in kodi.game has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in service.xbmc.versioncheck has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in kodi.resource has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in script.common.plugin.cache has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in inputstream.adaptive has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in skin.estouchy has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in script.module.requests has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in kodi.inputstream has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.aac has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in script.module.routing has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in resource.language.en_gb has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.skygo.de has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in metadata.local has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in xbmc.webinterface has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in resource.uisounds.kodi has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in resource.language.de_de has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in xbmc.codec has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Plug-in skin.estuary has been installed.' 13:51:41.986 T:3042155408 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.' 13:51:42.090 T:3021992944 DEBUG: Thread JobWorker start, auto delete: true 13:51:42.098 T:3042155408 NOTICE: ADDONS: Using repository repository.xbmc.org 13:51:42.098 T:3042155408 NOTICE: ADDONS: Using repository repository.kodinerds 13:51:42.098 T:3042155408 NOTICE: ADDONS: Using repository repository.kodinerds_RPi2 13:51:42.101 T:3042155408 DEBUG: ADDON: Dll Initializing - InputStream Adaptive 13:51:42.101 T:3042155408 DEBUG: SECTION:LoadDLL(/media/hdd/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.2.0.18) 13:51:42.101 T:3042155408 DEBUG: Loading: /media/hdd/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.2.0.18 13:51:42.138 T:3042155408 DEBUG: AddOnLog: InputStream Adaptive: libXBMC_addon successfully loaded 13:51:42.139 T:3042155408 DEBUG: AddOnLog: InputStream Adaptive: ADDON_Create() 13:51:42.139 T:3042155408 DEBUG: AddOnLog: InputStream Adaptive: ADDON_Destroy() 13:51:42.140 T:3042155408 DEBUG: SECTION:UnloadDll(/media/hdd/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.2.0.18) 13:51:42.140 T:3042155408 INFO: ADDON: Dll Destroyed - InputStream Adaptive 13:51:42.142 T:3012555760 DEBUG: Thread ActiveAE start, auto delete: false 13:51:42.142 T:3004167152 DEBUG: Thread AESink start, auto delete: false 13:51:42.142 T:3004167152 INFO: CActiveAESink::OpenSink - initialize sink 13:51:42.142 T:3004167152 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:@ 13:51:42.143 T:3004167152 INFO: CAESinkALSA::Initialize - Attempting to open device "@" 13:51:42.147 T:3004167152 INFO: CAESinkALSA::Initialize - Opened device "sysdefault" 13:51:42.148 T:3004167152 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 13:51:42.148 T:3004167152 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 13:51:42.148 T:3004167152 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 512, bufferSize 8820 13:51:42.148 T:3004167152 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 275, bufferSize 8820 13:51:42.148 T:3004167152 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms 13:51:42.149 T:3004167152 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 13:51:42.149 T:3004167152 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR 13:51:42.149 T:3004167152 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: none) 13:51:42.149 T:3004167152 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 13:51:42.149 T:3004167152 DEBUG: Output Device : Default (bcm Analog) 13:51:42.149 T:3004167152 DEBUG: Sample Rate : 44100 13:51:42.149 T:3004167152 DEBUG: Sample Format : AE_FMT_S32NE 13:51:42.149 T:3004167152 DEBUG: Channel Count : 2 13:51:42.149 T:3004167152 DEBUG: Channel Layout: FL,FR 13:51:42.149 T:3004167152 DEBUG: Frames : 275 13:51:42.149 T:3004167152 DEBUG: Frame Size : 8 13:51:42.158 T:3004167152 ERROR: CAESinkALSA - snd_pcm_writei(-32) Broken pipe - trying to recover 13:51:42.160 T:3042155408 INFO: CKeyboardLayoutManager: loading keyboard layouts from special://xbmc/system/keyboardlayouts... 13:51:42.169 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Portuguese (Portugal) QWERTY" successfully loaded 13:51:42.170 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian ЙЦУКЕН" successfully loaded 13:51:42.170 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian АБВ" successfully loaded 13:51:42.171 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BasePY" successfully loaded 13:51:42.172 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BaiduPY" successfully loaded 13:51:42.173 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Danish QWERTY" successfully loaded 13:51:42.173 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Polish QWERTY" successfully loaded 13:51:42.174 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian AZERTY" successfully loaded 13:51:42.174 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian QWERTY" successfully loaded 13:51:42.175 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Arabic QWERTY" successfully loaded 13:51:42.176 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian ЙЦУКЕН" successfully loaded 13:51:42.176 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian АБВ" successfully loaded 13:51:42.177 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Czech QWERTZ" successfully loaded 13:51:42.178 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "English QWERTY" successfully loaded 13:51:42.178 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "English AZERTY" successfully loaded 13:51:42.179 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "English ABC" successfully loaded 13:51:42.179 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Korean ㄱㄴㄷ" successfully loaded 13:51:42.180 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Romanian QWERTY" successfully loaded 13:51:42.181 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Silesian QWERTY" successfully loaded 13:51:42.182 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Croatian QWERTY" successfully loaded 13:51:42.182 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew QWERTY" successfully loaded 13:51:42.183 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew ABC" successfully loaded 13:51:42.184 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTZ" successfully loaded 13:51:42.184 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTY" successfully loaded 13:51:42.184 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak ABC" successfully loaded 13:51:42.185 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Greek QWERTY" successfully loaded 13:51:42.186 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Hungarian QWERTZ" successfully loaded 13:51:42.187 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Swedish QWERTY" successfully loaded 13:51:42.188 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Norwegian QWERTY" successfully loaded 13:51:42.189 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Turkish QWERTY" successfully loaded 13:51:42.189 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Spanish QWERTY" successfully loaded 13:51:42.190 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "French AZERTY" successfully loaded 13:51:42.191 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Italian QWERTY" successfully loaded 13:51:42.192 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "German QWERTZ" successfully loaded 13:51:42.192 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "German ABC" successfully loaded 13:51:42.193 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian ЯВЕРТЪ" successfully loaded 13:51:42.193 T:3042155408 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian АБВ" successfully loaded 13:51:42.193 T:3042155408 DEBUG: Selected UDev as storage provider 13:51:42.194 T:3042155408 NOTICE: InitWindowSystem: Using EGL Implementation: V3D 13:51:42.214 T:3042155408 DEBUG: EGL initial desktop resolution 1280x720 @ 50.00 - Full Screen 13:51:42.214 T:3042155408 DEBUG: EGL initial desktop resolution 1280x720 @ 50.00 - Full Screen 3DSBS 13:51:42.214 T:3042155408 DEBUG: EGL initial desktop resolution 1280x720 @ 50.00 - Full Screen 3DTB 13:51:42.214 T:3042155408 DEBUG: EGL initial desktop resolution 1920x1080 @ 50.00 - Full Screen 13:51:42.214 T:3042155408 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 50.000000 Hz 13:51:42.214 T:3042155408 NOTICE: Previous line repeats 2 times. 13:51:42.214 T:3042155408 NOTICE: Found resolution 1280 x 720 for display 0 with 1920 x 1080 @ 50.000000 Hz 13:51:42.214 T:3042155408 NOTICE: Found (1280x720@50.000000) at 16, setting to RES_DESKTOP at 16 13:51:42.214 T:3042155408 NOTICE: Checking resolution 19 13:51:42.215 T:3042155408 DEBUG: CreateWindow: Created surface of size 1280x720 13:51:42.216 T:3042155408 NOTICE: GL_VENDOR = Broadcom 13:51:42.216 T:3042155408 NOTICE: GL_RENDERER = VideoCore V HW (V3D-530) 13:51:42.216 T:3042155408 NOTICE: GL_VERSION = OpenGL ES 3.1 13:51:42.216 T:3042155408 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 3.10 13:51:42.216 T:3042155408 DEBUG: GLES: Extension Support Test - GL_NVX_gpu_memory_info NO 13:51:42.216 T:3042155408 NOTICE: GL_EXTENSIONS = GL_OES_compressed_ETC1_RGB8_texture GL_OES_compressed_paletted_texture GL_OES_texture_npot GL_OES_vertex_half_float GL_OES_EGL_image GL_OES_EGL_image_external GL_EXT_discard_framebuffer GL_OES_rgb8_rgba8 GL_OES_depth24 GL_OES_mapbuffer GL_OES_vertex_array_object GL_OES_packed_depth_stencil GL_OES_EGL_sync GL_OES_standard_derivatives GL_OES_surfaceless_context GL_EXT_shader_texture_lod GL_EXT_draw_elements_base_vertex GL_EXT_multisampled_render_to_texture GL_KHR_debug GL_OES_texture_stencil8 GL_EXT_shader_integer_mix GL_OES_texture_storage_multisample_2d_array GL_EXT_texture_format_BGRA8888 GL_EXT_debug_marker GL_KHR_texture_compression_astc_ldr GL_BRCM_multi_draw_indirect GL_BRCM_base_instance GL_EXT_robustness 13:51:42.216 T:3042155408 DEBUG: GLES: Extension Support Test - GL_EXT_texture_format_BGRA8888 YES 13:51:42.216 T:3042155408 DEBUG: GLES: Extension Support Test - GL_IMG_texture_format_BGRA8888 NO 13:51:42.216 T:3042155408 DEBUG: GLES: Extension Support Test - GL_APPLE_texture_format_BGRA8888 NO 13:51:42.222 T:3042155408 DEBUG: GL: Vertex Shader compilation log: 13:51:42.222 T:3042155408 DEBUG: GL: Vertex Shader compiled successfully 13:51:42.223 T:3042155408 DEBUG: GL: Pixel Shader compilation log: 13:51:42.223 T:3042155408 DEBUG: GL: Fragment Shader compiled successfully 13:51:42.223 T:3042155408 DEBUG: GUI Shader [guishader_frag_default.glsl]- Initialise successful : 0x27c7148 13:51:42.226 T:3042155408 DEBUG: GL: Vertex Shader compilation log: 13:51:42.226 T:3042155408 DEBUG: GL: Vertex Shader compiled successfully 13:51:42.227 T:3042155408 DEBUG: GL: Pixel Shader compilation log: 13:51:42.227 T:3042155408 DEBUG: GL: Fragment Shader compiled successfully 13:51:42.227 T:3042155408 DEBUG: GUI Shader [guishader_frag_texture.glsl]- Initialise successful : 0x27fd578 13:51:42.229 T:3042155408 DEBUG: GL: Vertex Shader compilation log: 13:51:42.229 T:3042155408 DEBUG: GL: Vertex Shader compiled successfully 13:51:42.230 T:3042155408 DEBUG: GL: Pixel Shader compilation log: 13:51:42.230 T:3042155408 DEBUG: GL: Fragment Shader compiled successfully 13:51:42.230 T:3042155408 DEBUG: GUI Shader [guishader_frag_multi.glsl]- Initialise successful : 0x2807c50 13:51:42.232 T:3042155408 DEBUG: GL: Vertex Shader compilation log: 13:51:42.232 T:3042155408 DEBUG: GL: Vertex Shader compiled successfully 13:51:42.233 T:3042155408 DEBUG: GL: Pixel Shader compilation log: 13:51:42.233 T:3042155408 DEBUG: GL: Fragment Shader compiled successfully 13:51:42.233 T:3042155408 DEBUG: GUI Shader [guishader_frag_fonts.glsl]- Initialise successful : 0x2861400 13:51:42.234 T:3042155408 DEBUG: GL: Vertex Shader compilation log: 13:51:42.235 T:3042155408 DEBUG: GL: Vertex Shader compiled successfully 13:51:42.235 T:3042155408 DEBUG: GL: Pixel Shader compilation log: 13:51:42.235 T:3042155408 DEBUG: GL: Fragment Shader compiled successfully 13:51:42.235 T:3042155408 DEBUG: GUI Shader [guishader_frag_texture_noblend.glsl]- Initialise successful : 0x2860120 13:51:42.237 T:3042155408 DEBUG: GL: Vertex Shader compilation log: 13:51:42.237 T:3042155408 DEBUG: GL: Vertex Shader compiled successfully 13:51:42.238 T:3042155408 DEBUG: GL: Pixel Shader compilation log: 13:51:42.238 T:3042155408 DEBUG: GL: Fragment Shader compiled successfully 13:51:42.238 T:3042155408 DEBUG: GUI Shader [guishader_frag_multi_blendcolor.glsl]- Initialise successful : 0x2813b68 13:51:42.240 T:3042155408 DEBUG: GL: Vertex Shader compilation log: 13:51:42.240 T:3042155408 DEBUG: GL: Vertex Shader compiled successfully 13:51:42.241 T:3042155408 DEBUG: GL: Pixel Shader compilation log: 13:51:42.241 T:3042155408 DEBUG: GL: Fragment Shader compiled successfully 13:51:42.241 T:3042155408 DEBUG: GUI Shader [guishader_frag_rgba.glsl]- Initialise successful : 0x2867af0 13:51:42.241 T:3042155408 DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external YES 13:51:42.243 T:3042155408 DEBUG: GL: Vertex Shader compilation log: 13:51:42.243 T:3042155408 DEBUG: GL: Vertex Shader compiled successfully 13:51:42.243 T:3042155408 DEBUG: GL: Pixel Shader compilation log: 13:51:42.243 T:3042155408 DEBUG: GL: Fragment Shader compiled successfully 13:51:42.244 T:3042155408 DEBUG: GUI Shader [guishader_frag_rgba_oes.glsl]- Initialise successful : 0x2881c18 13:51:42.246 T:3042155408 DEBUG: GL: Vertex Shader compilation log: 13:51:42.246 T:3042155408 DEBUG: GL: Vertex Shader compiled successfully 13:51:42.246 T:3042155408 DEBUG: GL: Pixel Shader compilation log: 13:51:42.247 T:3042155408 DEBUG: GL: Fragment Shader compiled successfully 13:51:42.247 T:3042155408 DEBUG: GUI Shader [guishader_frag_rgba_blendcolor.glsl]- Initialise successful : 0x2854718 13:51:42.249 T:3042155408 DEBUG: GL: Vertex Shader compilation log: 13:51:42.249 T:3042155408 DEBUG: GL: Vertex Shader compiled successfully 13:51:42.250 T:3042155408 DEBUG: GL: Pixel Shader compilation log: 13:51:42.250 T:3042155408 DEBUG: GL: Fragment Shader compiled successfully 13:51:42.250 T:3042155408 DEBUG: GUI Shader [guishader_frag_rgba_bob.glsl]- Initialise successful : 0x2878f88 13:51:42.250 T:3042155408 DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external YES 13:51:42.252 T:3042155408 DEBUG: GL: Vertex Shader compilation log: 13:51:42.252 T:3042155408 DEBUG: GL: Vertex Shader compiled successfully 13:51:42.254 T:3042155408 DEBUG: GL: Pixel Shader compilation log: 13:51:42.254 T:3042155408 DEBUG: GL: Fragment Shader compiled successfully 13:51:42.254 T:3042155408 DEBUG: GUI Shader [guishader_frag_rgba_bob_oes.glsl]- Initialise successful : 0x2876330 13:51:42.254 T:3042155408 DEBUG: CWinSystemEGL::CreateNewWindow: No need to create a new window 13:51:42.254 T:3042155408 INFO: GLES: Maximum texture width: 4096 13:51:42.531 T:3042155408 INFO: GLES: Enabling VSYNC 13:51:42.531 T:3042155408 INFO: GLES: Selected vsync mode 10 13:51:42.531 T:3042155408 INFO: load keymapping 13:51:42.537 T:3042155408 INFO: Loading special://xbmc/system/keymaps/appcommand.xml 13:51:42.537 T:3042155408 INFO: Loading special://xbmc/system/keymaps/customcontroller.AppleRemote.xml 13:51:42.540 T:3042155408 INFO: Loading special://xbmc/system/keymaps/customcontroller.Harmony.xml 13:51:42.544 T:3042155408 INFO: Loading special://xbmc/system/keymaps/gamepad.xml 13:51:42.548 T:3042155408 INFO: Loading special://xbmc/system/keymaps/joystick.xml 13:51:42.552 T:3042155408 INFO: Loading special://xbmc/system/keymaps/keyboard.xml 13:51:42.565 T:3042155408 INFO: Loading special://xbmc/system/keymaps/mouse.xml 13:51:42.567 T:3042155408 INFO: Loading special://xbmc/system/keymaps/remote.xml 13:51:42.574 T:3042155408 INFO: Loading special://xbmc/system/keymaps/touchscreen.xml 13:51:42.595 T:3042155408 INFO: GUI format 1280x720, Display 1920x1080 @ 50.00 - Full Screen 13:51:42.595 T:3042155408 DEBUG: guilib: Fill viewport on change for solving rendering passes 13:51:42.595 T:3042155408 INFO: CLangInfo: loading resource.language.de_de language information... 13:51:42.611 T:3042155408 DEBUG: trying to set locale to de_DE.UTF-8 13:51:42.623 T:3042155408 INFO: global locale set to C 13:51:42.623 T:3042155408 INFO: CLangInfo: loading resource.language.de_de language strings... 13:51:42.665 T:3042155408 DEBUG: LocalizeStrings: loaded 3768 strings from file resource://resource.language.de_de/strings.po 13:51:42.762 T:3042155408 DEBUG: LocalizeStrings: loaded 5 strings from file resource://resource.language.en_gb/strings.po 13:51:42.778 T:3042155408 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.xbmc.builtin.aac/resources/language/English/strings.po 13:51:42.788 T:3042155408 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.xbmc.builtin.wma/resources/language/English/strings.po 13:51:42.792 T:3042155408 DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/game.controller.default/resources/language/resource.language.en_gb/strings.po 13:51:42.865 T:3042155408 DEBUG: LocalizeStrings: loaded 11 strings from file /media/hdd/.kodi/addons/metadata.album.universal/resources/language/German/strings.po 13:51:42.912 T:3042155408 DEBUG: LocalizeStrings: loaded 2 strings from file /media/hdd/.kodi/addons/metadata.album.universal/resources/language/English/strings.po 13:51:42.977 T:3042155408 DEBUG: LocalizeStrings: loaded 23 strings from file /media/hdd/.kodi/addons/metadata.artists.universal/resources/language/German/strings.po 13:51:43.023 T:3042155408 DEBUG: LocalizeStrings: loaded 3 strings from file /media/hdd/.kodi/addons/metadata.artists.universal/resources/language/English/strings.po 13:51:43.102 T:3042155408 DEBUG: LocalizeStrings: loaded 7 strings from file /media/hdd/.kodi/addons/metadata.themoviedb.org/resources/language/German/strings.po 13:51:43.141 T:3042155408 DEBUG: LocalizeStrings: loaded 0 strings from file /media/hdd/.kodi/addons/metadata.themoviedb.org/resources/language/English/strings.po 13:51:43.224 T:3042155408 DEBUG: LocalizeStrings: loaded 5 strings from file /media/hdd/.kodi/addons/metadata.tvdb.com/resources/language/German/strings.po 13:51:43.262 T:3042155408 DEBUG: LocalizeStrings: loaded 2 strings from file /media/hdd/.kodi/addons/metadata.tvdb.com/resources/language/English/strings.po 13:51:43.278 T:3042155408 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.de_de/strings.po 13:51:43.279 T:3042155408 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.en_gb/strings.po 13:51:43.353 T:3042155408 DEBUG: LocalizeStrings: loaded 21 strings from file /media/hdd/.kodi/addons/service.xbmc.versioncheck/resources/language/German/strings.po 13:51:43.397 T:3042155408 DEBUG: LocalizeStrings: loaded 0 strings from file /media/hdd/.kodi/addons/service.xbmc.versioncheck/resources/language/English/strings.po 13:51:43.425 T:3042155408 DEBUG: LocalizeStrings: loaded 7 strings from file /media/hdd/.kodi/addons/script.common.plugin.cache/resources/language/English/strings.xml 13:51:43.464 T:3042155408 DEBUG: LocalizeStrings: loaded 10 strings from file /media/hdd/.kodi/addons/inputstream.adaptive/resources/language/resource.language.en_gb/strings.po 13:51:43.467 T:3042155408 DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid" 13:51:43.467 T:3042155408 DEBUG: LoadMappings - loaded node "CEC Adapter" 13:51:43.467 T:3042155408 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter" 13:51:43.467 T:3042155408 DEBUG: LoadMappings - loaded node "iMON HID device" 13:51:43.467 T:3042155408 DEBUG: LoadMappings - loaded node "WETEK Play remote" 13:51:43.468 T:3042155408 DEBUG: LoadMappings - loaded node "" 13:51:43.468 T:3042155408 DEBUG: CPeripheralBusUSB - initialised udev monitor 13:51:43.470 T:2663379952 DEBUG: Thread PeripBusUSBUdev start, auto delete: false 13:51:43.471 T:2654991344 DEBUG: Thread PeripBusAddon start, auto delete: false 13:51:43.471 T:3042155408 DEBUG: SECTION:LoadDLL(libcurl.so.4) 13:51:43.472 T:2646602736 DEBUG: Thread PeripEventScanner start, auto delete: false 13:51:43.473 T:3042155408 DEBUG: Loading: libcurl.so.4 13:51:43.484 T:3021992944 NOTICE: Running database version Addons27 13:51:43.484 T:3021992944 DEBUG: Initialize, updating databases... 13:51:43.517 T:3021992944 NOTICE: Running database version ViewModes6 13:51:43.696 T:3021992944 NOTICE: Running database version Textures13 13:51:43.799 T:3021992944 NOTICE: Running database version MyMusic60 13:51:43.825 T:3021992944 NOTICE: Running database version MyVideos107 13:51:43.870 T:3021992944 NOTICE: Running database version TV29 13:51:43.874 T:3021992944 NOTICE: Running database version Epg11 13:51:43.877 T:3021992944 DEBUG: Initialize, updating databases... DONE 13:51:43.878 T:3042155408 INFO: DPMS: not supported on this platform 13:51:43.934 T:3042141168 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 13:51:43.935 T:3042141168 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 13:51:43.947 T:3042155408 INFO: Unloading old skin ... 13:51:44.017 T:3042155408 INFO: load skin from: /usr/share/kodi/addons/skin.estuary (version: 1.9.16) 13:51:44.017 T:3042155408 INFO: load fonts for skin... 13:51:44.020 T:3042155408 INFO: Loading fonts from /usr/share/kodi/addons/skin.estuary/xml/Font.xml 13:51:44.067 T:3042155408 DEBUG: LocalizeStrings: loaded 132 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.de_de/strings.po 13:51:44.069 T:3042155408 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.en_gb/strings.po 13:51:44.070 T:3042155408 INFO: Loading skin includes from /usr/share/kodi/addons/skin.estuary/xml/Includes.xml 13:51:44.146 T:3042155408 INFO: load new skin... 13:51:44.146 T:3042155408 INFO: Loading user windows, path /usr/share/kodi/addons/skin.estuary/xml 13:51:44.160 T:3042155408 DEBUG: Load Skin XML: 13.70ms 13:51:44.160 T:3042155408 INFO: initialize new skin... 13:51:44.160 T:3042155408 DEBUG: guilib: Fill viewport on change for solving rendering passes 13:51:44.160 T:3042155408 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT 13:51:44.169 T:3042155408 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT 13:51:44.180 T:3042155408 INFO: Loading skin file: DialogNotification.xml, load type: LOAD_ON_GUI_INIT 13:51:44.183 T:3042155408 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT 13:51:44.200 T:3042155408 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT 13:51:44.203 T:3042155408 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT 13:51:44.209 T:3042155408 INFO: Loading resource://resource.uisounds.kodi/sounds.xml 13:51:44.296 T:3042155408 INFO: skin loaded... 13:51:44.296 T:3042155408 DEBUG: Activating window ID: 12997 13:51:44.296 T:3042155408 DEBUG: ------ Window Init () ------ 13:51:44.296 T:3042155408 INFO: load splash image: /usr/share/kodi/media/Splash.png 13:51:44.329 T:3042155408 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting 13:51:44.329 T:3042155408 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 13:51:44.329 T:3042155408 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting") 13:51:44.330 T:3042155408 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting 13:51:44.382 T:3042155408 INFO: JSONRPC v8.0.0: Successfully initialized 13:51:44.382 T:3042155408 DEBUG: ADDON: Starting service addons. 13:51:44.385 T:2630579184 DEBUG: Thread LanguageInvoker start, auto delete: false 13:51:44.385 T:3042155408 DEBUG: Activating window ID: 12999 13:51:44.385 T:3042155408 DEBUG: ------ Window Init (Startup.xml) ------ 13:51:44.385 T:3042155408 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME 13:51:44.386 T:2630579184 INFO: initializing python engine. 13:51:44.387 T:3042155408 DEBUG: Activating window ID: 10000 13:51:44.387 T:3042155408 DEBUG: ------ Window Deinit (Startup.xml) ------ 13:51:44.387 T:3042155408 DEBUG: ------ Window Init (Home.xml) ------ 13:51:44.387 T:3042155408 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY 13:51:44.480 T:2630579184 DEBUG: CPythonInvoker(0, /media/hdd/.kodi/addons/service.xbmc.versioncheck/service.py): start processing 13:51:44.543 T:2630579184 DEBUG: -->Python Interpreter Initialized<-- 13:51:44.543 T:2630579184 DEBUG: CPythonInvoker(0, /media/hdd/.kodi/addons/service.xbmc.versioncheck/service.py): the source file to load is "/media/hdd/.kodi/addons/service.xbmc.versioncheck/service.py" 13:51:44.543 T:2630579184 DEBUG: CPythonInvoker(0, /media/hdd/.kodi/addons/service.xbmc.versioncheck/service.py): setting the Python path to /media/hdd/.kodi/addons/service.xbmc.versioncheck:/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/PIL:/usr/lib/python2.7/site-packages/setuptools-31.0.0-py2.7.egg 13:51:44.543 T:2630579184 DEBUG: CPythonInvoker(0, /media/hdd/.kodi/addons/service.xbmc.versioncheck/service.py): entering source directory /media/hdd/.kodi/addons/service.xbmc.versioncheck 13:51:44.543 T:2630579184 DEBUG: CPythonInvoker(0, /media/hdd/.kodi/addons/service.xbmc.versioncheck/service.py): instantiating addon using automatically obtained id of "service.xbmc.versioncheck" dependent on version 2.1.0 of the xbmc.python api 13:51:44.582 T:3042155408 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 13:51:44.582 T:3042155408 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 13:51:44.582 T:3042155408 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 13:51:44.582 T:3042155408 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 13:51:44.583 T:3042155408 DEBUG: CDirectoryProvider[library://video/]: refreshing.. 13:51:44.583 T:3042155408 DEBUG: CDirectoryProvider[sources://video/]: refreshing.. 13:51:44.583 T:3042155408 DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing.. 13:51:44.583 T:3042155408 DEBUG: CDirectoryProvider[favourites://]: refreshing.. 13:51:44.583 T:3042155408 DEBUG: CDirectoryProvider[sources://pictures/]: refreshing.. 13:51:44.594 T:2620445680 DEBUG: Thread JobWorker start, auto delete: true 13:51:44.628 T:3042155408 DEBUG: Previous line repeats 1 times. 13:51:44.628 T:3042155408 DEBUG: ContextMenuManager: addon menus reloaded. 13:51:44.628 T:3042155408 INFO: removing tempfiles 13:51:44.630 T:3042155408 DEBUG: ADDON: Starting service addons. 13:51:44.642 T:2603242480 DEBUG: Thread LanguageInvoker start, auto delete: false 13:51:44.642 T:2603242480 INFO: initializing python engine. 13:51:44.642 T:2603242480 DEBUG: CPythonInvoker(1, /media/hdd/.kodi/addons/script.common.plugin.cache/default.py): start processing 13:51:44.654 T:2611631088 DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3a%2f%2fprofile%2fplaylists%2fvideo/special%3a%2f%2fprofile%2fplaylists%2fmixed/) 13:51:44.654 T:2611631088 DEBUG: Getting Directory (special://profile/playlists/video) 13:51:44.656 T:3042155408 DEBUG: CRepositoryUpdater: previous update at 09.09.2017 23:49:16, next at 10.09.2017 23:49:16 13:51:44.657 T:3042155408 NOTICE: initialize done 13:51:44.657 T:3042155408 NOTICE: Running the application... 13:51:44.658 T:3042155408 DEBUG: no profile autoexec.py (/media/hdd/.kodi/userdata/autoexec.py) found, skipping 13:51:44.658 T:3042155408 DEBUG: NetworkMessage - Starting network services 13:51:44.659 T:2620445680 DEBUG: CFavourites::Load - no system favourites found, skipping 13:51:44.660 T:2620445680 DEBUG: CFavourites::Load - no userdata favourites found, skipping 13:51:44.662 T:2594001904 DEBUG: Thread Timer start, auto delete: false 13:51:44.668 T:3042155408 DEBUG: CZeroconfAvahi::clientCallback: client is up and running 13:51:44.668 T:3042155408 NOTICE: starting zeroconf publishing 13:51:44.668 T:3042155408 NOTICE: starting upnp client 13:51:44.675 T:2611631088 DEBUG: Getting Directory (special://profile/playlists/mixed) 13:51:44.676 T:2611631088 DEBUG: CMultiPathDirectory::MergeItems, items = 0 13:51:44.676 T:2611631088 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update 13:51:44.692 T:3042155408 INFO: JSONRPC Server: Successfully initialized 13:51:44.697 T:2620445680 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:Kodi (ax51) port:9090 13:51:44.697 T:2620445680 DEBUG: CZeroconfAvahi::addService() named: Kodi (ax51) type: _xbmc-jsonrpc._tcp port:9090 13:51:44.700 T:2534429680 DEBUG: Thread TCPServer start, auto delete: false 13:51:44.701 T:3042155408 INFO: Found input device /dev/input/event0 13:51:44.701 T:3042155408 INFO: opened device 'dreambox remote control (native)' (file name /dev/input/event0), m_bSkipNonKeyEvents 0 13:51:44.703 T:2542818288 DEBUG: Thread EventServer start, auto delete: false 13:51:44.703 T:2542818288 NOTICE: ES: Starting UDP Event server on port 9777 13:51:44.703 T:2542818288 NOTICE: UDP: Listening on port 9777 (ipv6 : false) 13:51:44.704 T:2611631088 DEBUG: GetRecentlyAddedAlbumSongs() query: SELECT songview.*, songartistview.* FROM (SELECT idAlbum FROM album ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN songview ON songview.idAlbum = recentalbums.idAlbum JOIN songartistview ON songview.idSong = songartistview.idSong ORDER BY songview.idAlbum DESC, songview.idSong, songartistview.idRole, songartistview.iOrder 13:51:44.704 T:2620445680 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:Kodi (ax51) port:9777 13:51:44.704 T:2620445680 DEBUG: CZeroconfAvahi::addService() named: Kodi (ax51) type: _xbmc-events._udp port:9777 13:51:44.706 T:3042155408 INFO: Found input device /dev/input/event1 13:51:44.707 T:3042155408 INFO: opened device 'dreambox advanced remote control (native)' (file name /dev/input/event1), m_bSkipNonKeyEvents 0 13:51:44.711 T:2611631088 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 13:51:44.712 T:3042155408 INFO: Found input device /dev/input/event2 13:51:44.712 T:3042155408 INFO: opened device 'front panel' (file name /dev/input/event2), m_bSkipNonKeyEvents 0 13:51:44.717 T:2611631088 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update 13:51:44.718 T:3042155408 INFO: Found input device /dev/input/event3 13:51:44.719 T:3042155408 INFO: opened device 'RC for hdmi_cec' (file name /dev/input/event3), m_bSkipNonKeyEvents 0 13:51:44.719 T:2509263856 DEBUG: Thread CLinuxInputDevicesCheckHotplugged start, auto delete: false 13:51:44.746 T:2611631088 DEBUG: RunQuery took 4 ms for 0 items query: select * from movie_view ORDER BY dateAdded desc, idMovie desc LIMIT 10 13:51:44.755 T:2630579184 DEBUG: Version Check: Version 0.3.24 started 13:51:44.764 T:2611631088 DEBUG: RunQuery took 17 ms for 0 items query: select * from episode_view ORDER BY dateAdded desc, idEpisode desc LIMIT 10 13:51:44.773 T:2611631088 DEBUG: RunQuery took 7 ms for 0 items query: select * from musicvideo_view ORDER BY dateAdded desc, idMVideo desc LIMIT 10 13:51:44.812 T:2603242480 DEBUG: -->Python Interpreter Initialized<-- 13:51:44.812 T:2603242480 DEBUG: CPythonInvoker(1, /media/hdd/.kodi/addons/script.common.plugin.cache/default.py): the source file to load is "/media/hdd/.kodi/addons/script.common.plugin.cache/default.py" 13:51:44.812 T:2603242480 DEBUG: CPythonInvoker(1, /media/hdd/.kodi/addons/script.common.plugin.cache/default.py): setting the Python path to /media/hdd/.kodi/addons/script.common.plugin.cache:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/PIL:/usr/lib/python2.7/site-packages/setuptools-31.0.0-py2.7.egg 13:51:44.812 T:2603242480 DEBUG: CPythonInvoker(1, /media/hdd/.kodi/addons/script.common.plugin.cache/default.py): entering source directory /media/hdd/.kodi/addons/script.common.plugin.cache 13:51:44.812 T:2603242480 DEBUG: CPythonInvoker(1, /media/hdd/.kodi/addons/script.common.plugin.cache/default.py): instantiating addon using automatically obtained id of "script.common.plugin.cache" dependent on version 2.24.0 of the xbmc.python api 13:51:45.013 T:2603242480 DEBUG: StorageServer Module loaded RUN 13:51:45.014 T:2603242480 DEBUG: StorageClient-2.5.4 Starting server 13:51:45.074 T:3042155408 DEBUG: ------ Window Init () ------ 13:51:45.078 T:3042155408 DEBUG: ------ Window Init (Pointer.xml) ------ 13:51:45.078 T:2611631088 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 13:51:45.101 T:2611631088 DEBUG: GetArtistsByWhere query: SELECT COUNT(DISTINCT artistview.idArtist) FROM artistview WHERE ((EXISTS (SELECT 1 FROM song_artist WHERE song_artist.idArtist = artistview.idArtist AND song_artist.idRole = 1) OR EXISTS (SELECT 1 FROM album_artist WHERE album_artist.idArtist = artistview.idArtist)) AND (artistview.strArtist != '')) AND (artistview.strArtist <> 'Verschiedene Interpreten') 13:51:45.252 T:3042155408 DEBUG: ------ Window Deinit (Pointer.xml) ------ 13:51:45.494 T:2585613296 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 13:51:49.892 T:2630579184 DEBUG: Previous line repeats 1 times. 13:51:49.893 T:2630579184 DEBUG: Version Check: Version installed {u'major': 17, u'tag': u'stable', u'minor': 3, u'revision': u'2017-06-07-147cec4-dirty'} 13:51:49.893 T:2630579184 DEBUG: Version Check: Version available {u'major': u'17', u'extrainfo': u'final', u'tagversion': u'', u'tag': u'stable', u'addon_support': u'yes', u'minor': u'4', u'revision': u'20170822-7fc6da0'} 13:51:49.893 T:2630579184 DEBUG: Version Check: You are running an older minor version 13:51:59.897 T:2630579184 DEBUG: Version Check: Already notified one time for upgrading. 13:51:59.897 T:2630579184 INFO: CPythonInvoker(0, /media/hdd/.kodi/addons/service.xbmc.versioncheck/service.py): script successfully run 13:51:59.919 T:2630579184 INFO: Python script stopped 13:51:59.919 T:2630579184 DEBUG: Thread LanguageInvoker 2630579184 terminating 13:52:15.197 T:2620445680 DEBUG: Thread JobWorker 2620445680 terminating (autodelete) 13:52:15.197 T:2611631088 DEBUG: Thread JobWorker 2611631088 terminating (autodelete) 13:52:15.199 T:3021992944 DEBUG: Thread JobWorker 3021992944 terminating (autodelete) 13:54:44.809 T:3042141168 DEBUG: CAnnouncementManager - Announcement: OnScreensaverActivated from xbmc 13:54:44.809 T:3042141168 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverActivated 13:54:44.824 T:3042155408 DEBUG: ------ Window Init () ------ 14:21:45.210 T:2611631088 DEBUG: Thread JobWorker start, auto delete: true 14:22:15.210 T:2611631088 DEBUG: Thread JobWorker 2611631088 terminating (autodelete) 14:51:45.261 T:2611631088 DEBUG: Thread JobWorker start, auto delete: true 14:52:15.262 T:2611631088 DEBUG: Thread JobWorker 2611631088 terminating (autodelete) 15:21:45.272 T:2611631088 DEBUG: Thread JobWorker start, auto delete: true 15:22:15.272 T:2611631088 DEBUG: Thread JobWorker 2611631088 terminating (autodelete) 15:51:45.310 T:2611631088 DEBUG: Thread JobWorker start, auto delete: true 15:52:15.310 T:2611631088 DEBUG: Thread JobWorker 2611631088 terminating (autodelete) 16:21:45.331 T:2611631088 DEBUG: Thread JobWorker start, auto delete: true 16:22:15.331 T:2611631088 DEBUG: Thread JobWorker 2611631088 terminating (autodelete) 16:51:45.366 T:2611631088 DEBUG: Thread JobWorker start, auto delete: true 16:52:15.366 T:2611631088 DEBUG: Thread JobWorker 2611631088 terminating (autodelete) 17:21:45.382 T:2611631088 DEBUG: Thread JobWorker start, auto delete: true 17:22:15.382 T:2611631088 DEBUG: Thread JobWorker 2611631088 terminating (autodelete) 17:51:45.406 T:3021992944 DEBUG: Thread JobWorker start, auto delete: true 17:52:15.407 T:3021992944 DEBUG: Thread JobWorker 3021992944 terminating (autodelete) 18:21:45.429 T:2611631088 DEBUG: Thread JobWorker start, auto delete: true 18:22:15.429 T:2611631088 DEBUG: Thread JobWorker 2611631088 terminating (autodelete) 18:51:45.465 T:3021992944 DEBUG: Thread JobWorker start, auto delete: true 18:52:15.465 T:3021992944 DEBUG: Thread JobWorker 3021992944 terminating (autodelete) 19:21:45.486 T:3021992944 DEBUG: Thread JobWorker start, auto delete: true 19:22:15.486 T:3021992944 DEBUG: Thread JobWorker 3021992944 terminating (autodelete) 19:51:45.513 T:2620445680 DEBUG: Thread JobWorker start, auto delete: true 19:52:15.513 T:2620445680 DEBUG: Thread JobWorker 2620445680 terminating (autodelete) 20:12:40.889 T:3042155408 DEBUG: Keyboard: scancode: 0x72, sym: 0x00ae, unicode: 0x00ae, modifier: 0x0 20:12:40.889 T:3042155408 DEBUG: OnKey: volume_down (0xf0b8) pressed, screen saver/dpms woken up 20:12:40.889 T:3042141168 DEBUG: CAnnouncementManager - Announcement: OnScreensaverDeactivated from xbmc 20:12:40.889 T:3042141168 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverDeactivated 20:12:41.202 T:3042155408 DEBUG: Keyboard: scancode: 0x72, sym: 0x00ae, unicode: 0x00ae, modifier: 0x0 20:12:41.400 T:3042155408 DEBUG: Keyboard: scancode: 0x73, sym: 0x00af, unicode: 0x00af, modifier: 0x0 20:12:41.400 T:3042155408 DEBUG: OnKey: volume_up (0xf0b9) pressed, action is VolumeUp 20:12:41.400 T:3042155408 DEBUG: ------ Window Init (DialogVolumeBar.xml) ------ 20:12:41.400 T:3042141168 DEBUG: CAnnouncementManager - Announcement: OnVolumeChanged from xbmc 20:12:41.401 T:3042141168 DEBUG: GOT ANNOUNCEMENT, type: 64, from xbmc, message OnVolumeChanged 20:12:41.722 T:3042155408 DEBUG: Keyboard: scancode: 0x73, sym: 0x00af, unicode: 0x00af, modifier: 0x0 20:12:41.909 T:3042155408 DEBUG: ------ Window Deinit () ------ 20:12:42.176 T:3042155408 DEBUG: Keyboard: scancode: 0x93, sym: 0x0119, unicode: 0x0119, modifier: 0x0 20:12:42.176 T:3042155408 DEBUG: OnKey: pagedown (0xf085) pressed, action is PageDown 20:12:42.499 T:3042155408 DEBUG: Keyboard: scancode: 0x93, sym: 0x0119, unicode: 0x0119, modifier: 0x0 20:12:42.590 T:3042155408 DEBUG: ------ Window Deinit (DialogVolumeBar.xml) ------ 20:12:43.295 T:3042155408 DEBUG: Keyboard: scancode: 0x74, sym: 0x0140, unicode: 0x0140, modifier: 0x0 20:12:43.295 T:3042155408 DEBUG: OnKey: power (0xf0de) pressed, action is ActivateWindow(ShutdownMenu) 20:12:43.295 T:3042155408 DEBUG: Activating window ID: 10111 20:12:43.295 T:3042155408 DEBUG: ------ Window Init (DialogButtonMenu.xml) ------ 20:12:43.295 T:3042155408 INFO: Loading skin file: DialogButtonMenu.xml, load type: KEEP_IN_MEMORY 20:12:43.600 T:3042155408 DEBUG: Keyboard: scancode: 0x74, sym: 0x0140, unicode: 0x0140, modifier: 0x0 20:12:46.270 T:3042155408 DEBUG: Keyboard: scancode: 0x72, sym: 0x00ae, unicode: 0x00ae, modifier: 0x0 20:12:46.270 T:3042155408 DEBUG: OnKey: volume_down (0xf0b8) pressed, action is VolumeDown 20:12:46.500 T:3042155408 DEBUG: Keyboard: scancode: 0x72, sym: 0x00ae, unicode: 0x00ae, modifier: 0x0 20:12:46.530 T:3042155408 DEBUG: ------ Window Deinit (DialogButtonMenu.xml) ------ 20:13:08.835 T:3042155408 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0111, modifier: 0x0 20:13:08.835 T:3042155408 DEBUG: OnKey: up (0xf080) pressed, action is Up 20:13:08.835 T:3004167152 INFO: CActiveAESink::OpenSink - initialize sink 20:13:08.835 T:3004167152 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:@ 20:13:08.835 T:3004167152 INFO: CAESinkALSA::Initialize - Attempting to open device "@" 20:13:08.861 T:3004167152 INFO: CAESinkALSA::Initialize - Opened device "sysdefault" 20:13:08.862 T:3004167152 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 20:13:08.863 T:3004167152 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 20:13:08.863 T:3004167152 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 512, bufferSize 8820 20:13:08.863 T:3004167152 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 275, bufferSize 8820 20:13:08.863 T:3004167152 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms 20:13:08.863 T:3004167152 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 20:13:08.863 T:3004167152 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR 20:13:08.863 T:3004167152 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: none) 20:13:08.863 T:3004167152 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 20:13:08.863 T:3004167152 DEBUG: Output Device : Default (bcm Analog) 20:13:08.863 T:3004167152 DEBUG: Sample Rate : 44100 20:13:08.863 T:3004167152 DEBUG: Sample Format : AE_FMT_S32NE 20:13:08.863 T:3004167152 DEBUG: Channel Count : 2 20:13:08.863 T:3004167152 DEBUG: Channel Layout: FL,FR 20:13:08.863 T:3004167152 DEBUG: Frames : 275 20:13:08.863 T:3004167152 DEBUG: Frame Size : 8 20:13:08.883 T:3004167152 ERROR: CAESinkALSA - snd_pcm_writei(-32) Broken pipe - trying to recover 20:13:09.019 T:3042155408 ERROR: Previous line repeats 13 times. 20:13:09.019 T:3042155408 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0111, modifier: 0x0 20:13:09.181 T:3042155408 DEBUG: Previous line repeats 1 times. 20:13:09.181 T:3042155408 DEBUG: OnKey: up (0xf080) pressed, action is Up 20:13:09.382 T:3042155408 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0111, modifier: 0x0 20:13:09.420 T:3042155408 DEBUG: Previous line repeats 1 times. 20:13:09.420 T:3042155408 DEBUG: OnKey: up (0xf080) pressed, action is Up 20:13:09.821 T:3042155408 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0111, modifier: 0x0 20:13:09.884 T:3042155408 DEBUG: Previous line repeats 1 times. 20:13:09.884 T:3042155408 DEBUG: OnKey: up (0xf080) pressed, action is Up 20:13:09.888 T:2611631088 DEBUG: Thread JobWorker start, auto delete: true 20:13:10.074 T:3042155408 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0111, modifier: 0x0 20:13:10.107 T:3042155408 DEBUG: Previous line repeats 1 times. 20:13:10.107 T:3042155408 DEBUG: OnKey: up (0xf080) pressed, action is Up 20:13:10.311 T:3042155408 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0111, modifier: 0x0 20:13:11.537 T:2611631088 DEBUG: DoWork - took 1648 ms to load special://masterprofile/Thumbnails/d/d24cdc5c.png 20:13:13.640 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:13:13.640 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:13:13.839 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:13:16.611 T:3042155408 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0113, modifier: 0x0 20:13:16.611 T:3042155408 DEBUG: OnKey: right (0xf083) pressed, action is Right 20:13:16.936 T:3042155408 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0113, modifier: 0x0 20:13:17.440 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:13:17.440 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:13:17.763 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:13:21.468 T:3042155408 DEBUG: Keyboard: scancode: 0x69, sym: 0x0114, unicode: 0x0114, modifier: 0x0 20:13:21.468 T:3042155408 DEBUG: OnKey: left (0xf082) pressed, action is Left 20:13:21.761 T:3042155408 DEBUG: Keyboard: scancode: 0x69, sym: 0x0114, unicode: 0x0114, modifier: 0x0 20:13:23.266 T:3042155408 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0113, modifier: 0x0 20:13:23.266 T:3042155408 DEBUG: OnKey: right (0xf083) pressed, action is Right 20:13:23.580 T:3042155408 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0113, modifier: 0x0 20:13:24.197 T:3042155408 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0111, modifier: 0x0 20:13:24.197 T:3042155408 DEBUG: OnKey: up (0xf080) pressed, action is Up 20:13:24.518 T:3042155408 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0111, modifier: 0x0 20:13:24.950 T:3042155408 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0113, modifier: 0x0 20:13:24.951 T:3042155408 DEBUG: OnKey: right (0xf083) pressed, action is Right 20:13:25.280 T:3042155408 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0113, modifier: 0x0 20:13:27.767 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:13:28.077 T:3042155408 DEBUG: OnKey: return (0xf00d) pressed, action is Select 20:13:28.077 T:3042155408 DEBUG: Activating window ID: 10040 20:13:28.389 T:3042155408 DEBUG: ------ Window Deinit (Home.xml) ------ 20:13:28.414 T:3042155408 DEBUG: ------ Window Init (AddonBrowser.xml) ------ 20:13:28.414 T:3042155408 INFO: Loading skin file: AddonBrowser.xml, load type: KEEP_IN_MEMORY 20:13:28.474 T:3042155408 DEBUG: CDirectoryProvider[]: refreshing.. 20:13:28.474 T:2611631088 DEBUG: Previous line repeats 1 times. 20:13:28.474 T:2611631088 ERROR: GetDirectory - Error getting 20:13:28.474 T:3042155408 DEBUG: CDirectoryProvider[]: refreshing.. 20:13:28.475 T:2611631088 ERROR: GetDirectory - Error getting 20:13:28.475 T:2630579184 ERROR: Previous line repeats 1 times. 20:13:28.475 T:2630579184 DEBUG: Thread JobWorker start, auto delete: true 20:13:28.486 T:3042155408 DEBUG: CGUIMediaWindow::GetDirectory (addons://outdated/) 20:13:28.486 T:3042155408 DEBUG: ParentPath = [addons://outdated/] 20:13:28.892 T:3042155408 DEBUG: CAddonMgr::GetAvailableUpdates took 406 ms 20:13:28.911 T:3042155408 DEBUG: CAddonMgr::GetAvailableUpdates took 19 ms 20:13:28.918 T:2620445680 DEBUG: Thread BackgroundLoader start, auto delete: false 20:13:28.922 T:2620445680 DEBUG: Thread BackgroundLoader 2620445680 terminating 20:13:28.934 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:13:31.422 T:3042155408 DEBUG: Previous line repeats 1 times. 20:13:31.422 T:3042155408 DEBUG: OnKey: return (0xf00d) pressed, action is Select 20:13:31.422 T:3042155408 DEBUG: CGUIMediaWindow::GetDirectory (addons://) 20:13:31.422 T:3042155408 DEBUG: ParentPath = [] 20:13:31.440 T:2630579184 DEBUG: CAddonMgr::GetAvailableUpdates took 18 ms 20:13:31.457 T:2620445680 DEBUG: Thread BackgroundLoader start, auto delete: false 20:13:31.457 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:13:31.462 T:2620445680 DEBUG: Thread BackgroundLoader 2620445680 terminating 20:13:33.621 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:13:33.621 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:13:33.939 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:13:34.321 T:3042155408 DEBUG: Previous line repeats 1 times. 20:13:34.321 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:13:34.524 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:13:41.481 T:3042155408 DEBUG: Keyboard: scancode: 0xae, sym: 0x001b, unicode: 0x001b, modifier: 0x0 20:13:41.780 T:3042155408 DEBUG: OnKey: escape (0xf01b) pressed, action is PreviousMenu 20:13:41.780 T:3042155408 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 20:13:42.091 T:3042155408 DEBUG: ------ Window Deinit (AddonBrowser.xml) ------ 20:13:42.100 T:3042155408 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 20:13:42.101 T:3042155408 DEBUG: ------ Window Init (Home.xml) ------ 20:13:42.113 T:3042155408 DEBUG: Keyboard: scancode: 0xae, sym: 0x001b, unicode: 0x001b, modifier: 0x0 20:13:43.968 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:13:43.968 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:13:44.287 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:13:49.040 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:13:49.374 T:3042155408 DEBUG: OnKey: return (0xf00d) pressed, action is Select 20:13:49.375 T:3042155408 DEBUG: Activating window ID: 10025 20:13:49.684 T:3042155408 DEBUG: ------ Window Deinit (Home.xml) ------ 20:13:49.699 T:3042155408 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 20:13:49.699 T:3042155408 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 20:13:49.839 T:3042155408 DEBUG: CDirectoryProvider[]: refreshing.. 20:13:49.840 T:2611631088 ERROR: GetDirectory - Error getting 20:13:49.840 T:3042155408 DEBUG: CDirectoryProvider[]: refreshing.. 20:13:49.840 T:2630579184 ERROR: GetDirectory - Error getting 20:13:49.840 T:3042155408 DEBUG: CDirectoryProvider[]: refreshing.. 20:13:49.840 T:2611631088 ERROR: GetDirectory - Error getting 20:13:49.840 T:3042155408 DEBUG: CDirectoryProvider[]: refreshing.. 20:13:49.840 T:2630579184 ERROR: GetDirectory - Error getting 20:13:49.840 T:3042155408 DEBUG: CDirectoryProvider[]: refreshing.. 20:13:49.840 T:2611631088 ERROR: GetDirectory - Error getting 20:13:49.840 T:3042155408 DEBUG: CDirectoryProvider[]: refreshing.. 20:13:49.840 T:2630579184 DEBUG: Previous line repeats 1 times. 20:13:49.840 T:2630579184 ERROR: GetDirectory - Error getting 20:13:49.859 T:3042155408 ERROR: Previous line repeats 1 times. 20:13:49.859 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:13:49.907 T:3042155408 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/) 20:13:49.908 T:3042155408 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 20:13:50.330 T:2630579184 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 422 ms 20:13:50.331 T:2611631088 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','1','') 20:13:50.331 T:2620445680 DEBUG: Thread JobWorker start, auto delete: true 20:13:50.331 T:2526041072 DEBUG: Thread LanguageInvoker start, auto delete: false 20:13:50.331 T:2526041072 INFO: initializing python engine. 20:13:50.331 T:2526041072 DEBUG: CPythonInvoker(2, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): start processing 20:13:50.366 T:2526041072 DEBUG: -->Python Interpreter Initialized<-- 20:13:50.366 T:2526041072 DEBUG: CPythonInvoker(2, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/media/hdd/.kodi/addons/plugin.video.skygo.de/default.py" 20:13:50.367 T:2526041072 DEBUG: CPythonInvoker(2, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /media/hdd/.kodi/addons/plugin.video.skygo.de:/media/hdd/.kodi/addons/script.common.plugin.cache/lib:/media/hdd/.kodi/addons/script.module.cryptopy/lib:/media/hdd/.kodi/addons/script.module.pydes/lib:/media/hdd/.kodi/addons/script.module.requests/lib:/media/hdd/.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/PIL:/usr/lib/python2.7/site-packages/setuptools-31.0.0-py2.7.egg 20:13:50.368 T:2526041072 DEBUG: CPythonInvoker(2, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /media/hdd/.kodi/addons/plugin.video.skygo.de 20:13:50.368 T:2526041072 DEBUG: CPythonInvoker(2, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): instantiating addon using automatically obtained id of "plugin.video.skygo.de" dependent on version 2.1.0 of the xbmc.python api 20:13:50.409 T:3042155408 DEBUG: ------ Window Init (DialogBusy.xml) ------ 20:13:52.841 T:2526041072 DEBUG: false 20:13:53.139 T:2526041072 DEBUG: ['plugin://plugin.video.skygo.de/', '1', ''] 20:13:53.410 T:2526041072 INFO: CPythonInvoker(2, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 20:13:53.426 T:3042155408 DEBUG: Saving fileitems [plugin://plugin.video.skygo.de/] 20:13:53.426 T:3042155408 DEBUG: -- items: 10, sort method: 0, ascending: false 20:13:53.455 T:3021992944 DEBUG: Thread BackgroundLoader start, auto delete: false 20:13:53.551 T:3021992944 DEBUG: Thread BackgroundLoader 3021992944 terminating 20:13:53.555 T:2526041072 INFO: Python script stopped 20:13:53.555 T:2526041072 DEBUG: Thread LanguageInvoker 2526041072 terminating 20:13:53.672 T:3042155408 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 20:13:54.882 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:13:54.882 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:13:55.082 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:13:55.222 T:3042155408 DEBUG: Previous line repeats 1 times. 20:13:55.222 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:13:55.622 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:13:55.663 T:3042155408 DEBUG: Previous line repeats 1 times. 20:13:55.663 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:13:55.879 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:13:55.919 T:3042155408 DEBUG: Previous line repeats 1 times. 20:13:55.919 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:13:56.322 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:13:56.359 T:3042155408 DEBUG: Previous line repeats 1 times. 20:13:56.360 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:13:56.562 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:13:58.319 T:3042155408 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0111, modifier: 0x0 20:13:58.319 T:3042155408 DEBUG: OnKey: up (0xf080) pressed, action is Up 20:13:58.619 T:3042155408 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0111, modifier: 0x0 20:13:58.739 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:13:59.059 T:3042155408 DEBUG: OnKey: return (0xf00d) pressed, action is Select 20:13:59.061 T:3042155408 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listPage&id=4) 20:13:59.061 T:3042155408 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 20:13:59.223 T:2611631088 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 162 ms 20:13:59.226 T:2630579184 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','2','?action=listPage&id=4') 20:13:59.226 T:3021992944 DEBUG: Thread LanguageInvoker start, auto delete: false 20:13:59.226 T:3021992944 INFO: initializing python engine. 20:13:59.226 T:3021992944 DEBUG: CPythonInvoker(3, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): start processing 20:13:59.260 T:3021992944 DEBUG: -->Python Interpreter Initialized<-- 20:13:59.260 T:3021992944 DEBUG: CPythonInvoker(3, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/media/hdd/.kodi/addons/plugin.video.skygo.de/default.py" 20:13:59.261 T:3021992944 DEBUG: CPythonInvoker(3, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /media/hdd/.kodi/addons/plugin.video.skygo.de:/media/hdd/.kodi/addons/script.common.plugin.cache/lib:/media/hdd/.kodi/addons/script.module.cryptopy/lib:/media/hdd/.kodi/addons/script.module.pydes/lib:/media/hdd/.kodi/addons/script.module.requests/lib:/media/hdd/.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/PIL:/usr/lib/python2.7/site-packages/setuptools-31.0.0-py2.7.egg 20:13:59.261 T:3021992944 DEBUG: CPythonInvoker(3, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /media/hdd/.kodi/addons/plugin.video.skygo.de 20:13:59.261 T:3021992944 DEBUG: CPythonInvoker(3, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): instantiating addon using automatically obtained id of "plugin.video.skygo.de" dependent on version 2.1.0 of the xbmc.python api 20:13:59.563 T:3042155408 DEBUG: ------ Window Init (DialogBusy.xml) ------ 20:14:01.146 T:3021992944 DEBUG: false 20:14:01.254 T:3021992944 DEBUG: {'action': 'listPage', 'id': '4'} 20:14:01.523 T:3021992944 INFO: CPythonInvoker(3, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 20:14:01.540 T:3042155408 DEBUG: Saving fileitems [plugin://plugin.video.skygo.de/?action=listPage&id=4] 20:14:01.541 T:3042155408 DEBUG: -- items: 21, sort method: 0, ascending: false 20:14:01.564 T:2526041072 DEBUG: Thread BackgroundLoader start, auto delete: false 20:14:01.576 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:14:01.638 T:2526041072 DEBUG: Thread BackgroundLoader 2526041072 terminating 20:14:01.762 T:3021992944 INFO: Python script stopped 20:14:01.762 T:3021992944 DEBUG: Thread LanguageInvoker 3021992944 terminating 20:14:01.796 T:3042155408 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 20:14:02.742 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:02.742 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:03.062 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:03.123 T:3042155408 DEBUG: Previous line repeats 1 times. 20:14:03.123 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:03.326 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:03.442 T:3042155408 DEBUG: Previous line repeats 1 times. 20:14:03.442 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:03.642 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:03.723 T:3042155408 DEBUG: Previous line repeats 1 times. 20:14:03.723 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:03.923 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:04.022 T:3042155408 DEBUG: Previous line repeats 1 times. 20:14:04.022 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:04.182 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:06.525 T:3042155408 DEBUG: Previous line repeats 1 times. 20:14:06.525 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:06.715 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:06.813 T:3042155408 DEBUG: Previous line repeats 1 times. 20:14:06.813 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:07.025 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:07.025 T:3042155408 DEBUG: Previous line repeats 1 times. 20:14:07.025 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:07.230 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:07.438 T:3042155408 DEBUG: Previous line repeats 1 times. 20:14:07.438 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:07.656 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:07.949 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:14:08.131 T:3042155408 DEBUG: OnKey: return (0xf00d) pressed, action is Select 20:14:08.132 T:3042155408 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listPage&path=%2fsg%2fmultiplatform%2fipad%2fjson%2flandingpage%2f267.json) 20:14:08.132 T:3042155408 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/?action=listPage&id=4] 20:14:08.291 T:2630579184 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 159 ms 20:14:08.292 T:2611631088 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','3','?action=listPage&path=%2fsg%2fmultiplatform%2fipad%2fjson%2flandingpage%2f267.json') 20:14:08.292 T:3021992944 DEBUG: Thread LanguageInvoker start, auto delete: false 20:14:08.292 T:3021992944 INFO: initializing python engine. 20:14:08.292 T:3021992944 DEBUG: CPythonInvoker(4, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): start processing 20:14:08.325 T:3021992944 DEBUG: -->Python Interpreter Initialized<-- 20:14:08.325 T:3021992944 DEBUG: CPythonInvoker(4, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/media/hdd/.kodi/addons/plugin.video.skygo.de/default.py" 20:14:08.326 T:3021992944 DEBUG: CPythonInvoker(4, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /media/hdd/.kodi/addons/plugin.video.skygo.de:/media/hdd/.kodi/addons/script.common.plugin.cache/lib:/media/hdd/.kodi/addons/script.module.cryptopy/lib:/media/hdd/.kodi/addons/script.module.pydes/lib:/media/hdd/.kodi/addons/script.module.requests/lib:/media/hdd/.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/PIL:/usr/lib/python2.7/site-packages/setuptools-31.0.0-py2.7.egg 20:14:08.326 T:3021992944 DEBUG: CPythonInvoker(4, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /media/hdd/.kodi/addons/plugin.video.skygo.de 20:14:08.326 T:3021992944 DEBUG: CPythonInvoker(4, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): instantiating addon using automatically obtained id of "plugin.video.skygo.de" dependent on version 2.1.0 of the xbmc.python api 20:14:08.635 T:3042155408 DEBUG: ------ Window Init (DialogBusy.xml) ------ 20:14:09.763 T:3021992944 DEBUG: false 20:14:09.860 T:3021992944 DEBUG: {'action': 'listPage', 'path': '/sg/multiplatform/ipad/json/landingpage/267.json'} 20:14:10.556 T:3021992944 WARNING: Attempt to use invalid handle 3 20:14:10.557 T:3021992944 WARNING: Previous line repeats 5 times. 20:14:10.557 T:3021992944 INFO: CPythonInvoker(4, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 20:14:10.570 T:3042155408 DEBUG: Saving fileitems [plugin://plugin.video.skygo.de/?action=listPage&path=%2fsg%2fmultiplatform%2fipad%2fjson%2flandingpage%2f267.json] 20:14:10.570 T:3042155408 DEBUG: -- items: 1, sort method: 0, ascending: false 20:14:10.579 T:2526041072 DEBUG: Thread BackgroundLoader start, auto delete: false 20:14:10.586 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:14:10.616 T:2526041072 DEBUG: Thread BackgroundLoader 2526041072 terminating 20:14:10.787 T:3021992944 INFO: Python script stopped 20:14:10.787 T:3021992944 DEBUG: Thread LanguageInvoker 3021992944 terminating 20:14:10.814 T:3042155408 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 20:14:11.780 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:11.780 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:11.982 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:12.359 T:3042155408 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0111, modifier: 0x0 20:14:12.360 T:3042155408 DEBUG: OnKey: up (0xf080) pressed, action is Up 20:14:12.580 T:3042155408 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0111, modifier: 0x0 20:14:12.760 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:14:13.080 T:3042155408 DEBUG: OnKey: return (0xf00d) pressed, action is Select 20:14:13.080 T:3042155408 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listPage&id=4) 20:14:13.080 T:3042155408 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 20:14:13.083 T:3042155408 DEBUG: Loading items: 21, directory: plugin://plugin.video.skygo.de/?action=listPage&id=4 sort method: 0, ascending: false 20:14:13.247 T:2611631088 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 166 ms 20:14:13.255 T:3021992944 DEBUG: Thread BackgroundLoader start, auto delete: false 20:14:13.263 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:14:13.287 T:3021992944 DEBUG: Thread BackgroundLoader 3021992944 terminating 20:14:14.360 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:14.360 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:14.564 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:14.656 T:3042155408 DEBUG: Previous line repeats 1 times. 20:14:14.656 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:14.880 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:14.900 T:3042155408 DEBUG: Previous line repeats 1 times. 20:14:14.900 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:15.058 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:15.100 T:3042155408 DEBUG: Previous line repeats 1 times. 20:14:15.100 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:15.255 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:15.309 T:3042155408 DEBUG: Previous line repeats 1 times. 20:14:15.309 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:15.491 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:15.819 T:3042155408 DEBUG: Previous line repeats 1 times. 20:14:15.819 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:16.024 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:16.075 T:3042155408 DEBUG: Previous line repeats 1 times. 20:14:16.075 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:16.286 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:16.286 T:3042155408 DEBUG: Previous line repeats 1 times. 20:14:16.286 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:16.497 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:16.669 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:14:16.894 T:3042155408 DEBUG: OnKey: return (0xf00d) pressed, action is Select 20:14:16.895 T:3042155408 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listPage&path=%2fsg%2fmultiplatform%2fipad%2fjson%2flandingpage%2f263.json) 20:14:16.895 T:3042155408 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/?action=listPage&id=4] 20:14:17.047 T:2620445680 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 151 ms 20:14:17.048 T:2611631088 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','4','?action=listPage&path=%2fsg%2fmultiplatform%2fipad%2fjson%2flandingpage%2f263.json') 20:14:17.048 T:3021992944 DEBUG: Thread LanguageInvoker start, auto delete: false 20:14:17.048 T:3021992944 INFO: initializing python engine. 20:14:17.048 T:3021992944 DEBUG: CPythonInvoker(5, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): start processing 20:14:17.079 T:3021992944 DEBUG: -->Python Interpreter Initialized<-- 20:14:17.079 T:3021992944 DEBUG: CPythonInvoker(5, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/media/hdd/.kodi/addons/plugin.video.skygo.de/default.py" 20:14:17.080 T:3021992944 DEBUG: CPythonInvoker(5, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /media/hdd/.kodi/addons/plugin.video.skygo.de:/media/hdd/.kodi/addons/script.common.plugin.cache/lib:/media/hdd/.kodi/addons/script.module.cryptopy/lib:/media/hdd/.kodi/addons/script.module.pydes/lib:/media/hdd/.kodi/addons/script.module.requests/lib:/media/hdd/.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/PIL:/usr/lib/python2.7/site-packages/setuptools-31.0.0-py2.7.egg 20:14:17.080 T:3021992944 DEBUG: CPythonInvoker(5, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /media/hdd/.kodi/addons/plugin.video.skygo.de 20:14:17.080 T:3021992944 DEBUG: CPythonInvoker(5, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): instantiating addon using automatically obtained id of "plugin.video.skygo.de" dependent on version 2.1.0 of the xbmc.python api 20:14:17.398 T:3042155408 DEBUG: ------ Window Init (DialogBusy.xml) ------ 20:14:18.869 T:3021992944 DEBUG: false 20:14:18.970 T:3021992944 DEBUG: {'action': 'listPage', 'path': '/sg/multiplatform/ipad/json/landingpage/263.json'} 20:14:19.720 T:3021992944 INFO: CPythonInvoker(5, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 20:14:19.759 T:3042155408 DEBUG: Saving fileitems [plugin://plugin.video.skygo.de/?action=listPage&path=%2fsg%2fmultiplatform%2fipad%2fjson%2flandingpage%2f263.json] 20:14:19.760 T:3042155408 DEBUG: -- items: 7, sort method: 0, ascending: false 20:14:19.779 T:2526041072 DEBUG: Thread BackgroundLoader start, auto delete: false 20:14:19.795 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:14:19.857 T:2526041072 DEBUG: Thread BackgroundLoader 2526041072 terminating 20:14:19.963 T:3021992944 INFO: Python script stopped 20:14:19.963 T:3021992944 DEBUG: Thread LanguageInvoker 3021992944 terminating 20:14:20.009 T:3042155408 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 20:14:21.845 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:21.845 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:22.161 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:22.392 T:3042155408 DEBUG: Previous line repeats 1 times. 20:14:22.392 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:22.487 T:2630579184 INFO: easy_aquire - Created session to https://www.skygo.sky.de 20:14:22.596 T:3042155408 INFO: Previous line repeats 1 times. 20:14:22.596 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:22.702 T:3042155408 DEBUG: Previous line repeats 1 times. 20:14:22.702 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:22.704 T:3021992944 DEBUG: Thread JobWorker start, auto delete: true 20:14:22.850 T:2630579184 DEBUG: CCurlFile::GetMimeType - https://www.skygo.sky.de/bin/Picture/344/C_1_Picture_189010_hero_img.jpg -> image/jpeg 20:14:22.851 T:2630579184 DEBUG: CurlFile::Open(0xb4c0b2b0) https://www.skygo.sky.de/bin/Picture/344/C_1_Picture_189010_hero_img.jpg 20:14:22.866 T:2620445680 DEBUG: CCurlFile::GetMimeType - https://www.skygo.sky.de/sg/bin/Asset/web/series/dvd_cover_75527.jpg -> image/jpeg 20:14:22.867 T:2620445680 DEBUG: CurlFile::Open(0xb4cac7e8) https://www.skygo.sky.de/sg/bin/Asset/web/series/dvd_cover_75527.jpg 20:14:22.894 T:2611631088 DEBUG: ffmpeg[9BAA53F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 20:14:22.896 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:22.976 T:2611631088 DEBUG: DoWork - took 258 ms to load special://masterprofile/Thumbnails/e/ed60edcb.jpg 20:14:23.236 T:2620445680 DEBUG: Caching image 'https://www.skygo.sky.de/sg/bin/Asset/web/series/dvd_cover_75527.jpg' to 'a/a05279fc.jpg': 20:14:23.236 T:2620445680 DEBUG: cached image 'special://masterprofile/Thumbnails/a/a05279fc.jpg' size 126x187 20:14:23.447 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:14:23.750 T:3042155408 DEBUG: OnKey: return (0xf00d) pressed, action is Select 20:14:23.756 T:3042155408 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listSeries&id=74561&infolabels=%7b%27plot%27%3a%20%27%27%2c%20%27title%27%3a%20u%27Dark%20Matter%27%2c%20%27originaltitle%27%3a%20u%27Dark%20Matter%27%2c%20%27cast%27%3a%20%5b%5d%2c%20%27year%27%3a%200%2c%20%27duration%27%3a%200%2c%20%27genre%27%3a%20%27%27%7d&parental_rating=1) 20:14:23.756 T:3042155408 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/?action=listPage&path=%2fsg%2fmultiplatform%2fipad%2fjson%2flandingpage%2f263.json] 20:14:23.820 T:3021992944 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 64 ms 20:14:23.821 T:2611631088 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','5','?action=listSeries&id=74561&infolabels=%7b%27plot%27%3a%20%27%27%2c%20%27title%27%3a%20u%27Dark%20Matter%27%2c%20%27originaltitle%27%3a%20u%27Dark%20Matter%27%2c%20%27cast%27%3a%20%5b%5d%2c%20%27year%27%3a%200%2c%20%27duration%27%3a%200%2c%20%27genre%27%3a%20%27%27%7d&parental_rating=1') 20:14:23.822 T:2526041072 DEBUG: Thread LanguageInvoker start, auto delete: false 20:14:23.822 T:2526041072 INFO: initializing python engine. 20:14:23.822 T:2526041072 DEBUG: CPythonInvoker(6, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): start processing 20:14:23.838 T:2630579184 DEBUG: Caching image 'https://www.skygo.sky.de/bin/Picture/344/C_1_Picture_189010_hero_img.jpg' to '1/128293fc.jpg': 20:14:23.868 T:2526041072 DEBUG: -->Python Interpreter Initialized<-- 20:14:23.868 T:2526041072 DEBUG: CPythonInvoker(6, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/media/hdd/.kodi/addons/plugin.video.skygo.de/default.py" 20:14:23.869 T:2526041072 DEBUG: CPythonInvoker(6, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /media/hdd/.kodi/addons/plugin.video.skygo.de:/media/hdd/.kodi/addons/script.common.plugin.cache/lib:/media/hdd/.kodi/addons/script.module.cryptopy/lib:/media/hdd/.kodi/addons/script.module.pydes/lib:/media/hdd/.kodi/addons/script.module.requests/lib:/media/hdd/.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/PIL:/usr/lib/python2.7/site-packages/setuptools-31.0.0-py2.7.egg 20:14:23.869 T:2526041072 DEBUG: CPythonInvoker(6, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /media/hdd/.kodi/addons/plugin.video.skygo.de 20:14:23.869 T:2526041072 DEBUG: CPythonInvoker(6, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): instantiating addon using automatically obtained id of "plugin.video.skygo.de" dependent on version 2.1.0 of the xbmc.python api 20:14:24.263 T:3042155408 DEBUG: ------ Window Init (DialogBusy.xml) ------ 20:14:24.316 T:2630579184 DEBUG: cached image 'special://masterprofile/Thumbnails/1/128293fc.jpg' size 1920x1080 20:14:25.705 T:2526041072 DEBUG: false 20:14:25.790 T:2526041072 DEBUG: {'action': 'listSeries', 'parental_rating': '1', 'infolabels': "{'plot': '', 'title': u'Dark Matter', 'originaltitle': u'Dark Matter', 'cast': [], 'year': 0, 'duration': 0, 'genre': ''}", 'id': '74561'} 20:14:26.251 T:2526041072 INFO: CPythonInvoker(6, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 20:14:26.277 T:3042155408 DEBUG: Saving fileitems [plugin://plugin.video.skygo.de/?action=listSeries&id=74561&infolabels=%7b%27plot%27%3a%20%27%27%2c%20%27title%27%3a%20u%27Dark%20Matter%27%2c%20%27originaltitle%27%3a%20u%27Dark%20Matter%27%2c%20%27cast%27%3a%20%5b%5d%2c%20%27year%27%3a%200%2c%20%27duration%27%3a%200%2c%20%27genre%27%3a%20%27%27%7d&parental_rating=1] 20:14:26.278 T:3042155408 DEBUG: -- items: 3, sort method: 0, ascending: false 20:14:26.291 T:2463101936 DEBUG: Thread BackgroundLoader start, auto delete: false 20:14:26.303 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:14:26.362 T:2463101936 DEBUG: Thread BackgroundLoader 2463101936 terminating 20:14:26.501 T:2526041072 INFO: Python script stopped 20:14:26.501 T:2526041072 DEBUG: Thread LanguageInvoker 2526041072 terminating 20:14:26.516 T:3042155408 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 20:14:27.408 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:27.408 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:27.520 T:2620445680 DEBUG: CCurlFile::GetMimeType - https://www.skygo.sky.de/sg/bin/Asset/web/season/dvd_cover_69396.jpg -> image/jpeg 20:14:27.520 T:2620445680 DEBUG: CurlFile::Open(0x924f1230) https://www.skygo.sky.de/sg/bin/Asset/web/season/dvd_cover_69396.jpg 20:14:27.608 T:2620445680 DEBUG: Caching image 'https://www.skygo.sky.de/sg/bin/Asset/web/season/dvd_cover_69396.jpg' to 'c/cc3bab87.jpg': 20:14:27.608 T:2620445680 DEBUG: cached image 'special://masterprofile/Thumbnails/c/cc3bab87.jpg' size 126x187 20:14:27.724 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:27.849 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:14:28.147 T:3042155408 DEBUG: OnKey: return (0xf00d) pressed, action is Select 20:14:28.149 T:3042155408 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listSeason&id=69396&series_id=74561) 20:14:28.149 T:3042155408 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/?action=listSeries&id=74561&infolabels=%7b%27plot%27%3a%20%27%27%2c%20%27title%27%3a%20u%27Dark%20Matter%27%2c%20%27originaltitle%27%3a%20u%27Dark%20Matter%27%2c%20%27cast%27%3a%20%5b%5d%2c%20%27year%27%3a%200%2c%20%27duration%27%3a%200%2c%20%27genre%27%3a%20%27%27%7d&parental_rating=1] 20:14:28.218 T:2611631088 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 70 ms 20:14:28.219 T:3021992944 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','6','?action=listSeason&id=69396&series_id=74561') 20:14:28.219 T:2526041072 DEBUG: Thread LanguageInvoker start, auto delete: false 20:14:28.219 T:2526041072 INFO: initializing python engine. 20:14:28.219 T:2526041072 DEBUG: CPythonInvoker(7, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): start processing 20:14:28.254 T:2526041072 DEBUG: -->Python Interpreter Initialized<-- 20:14:28.254 T:2526041072 DEBUG: CPythonInvoker(7, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/media/hdd/.kodi/addons/plugin.video.skygo.de/default.py" 20:14:28.255 T:2526041072 DEBUG: CPythonInvoker(7, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /media/hdd/.kodi/addons/plugin.video.skygo.de:/media/hdd/.kodi/addons/script.common.plugin.cache/lib:/media/hdd/.kodi/addons/script.module.cryptopy/lib:/media/hdd/.kodi/addons/script.module.pydes/lib:/media/hdd/.kodi/addons/script.module.requests/lib:/media/hdd/.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/PIL:/usr/lib/python2.7/site-packages/setuptools-31.0.0-py2.7.egg 20:14:28.255 T:2526041072 DEBUG: CPythonInvoker(7, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /media/hdd/.kodi/addons/plugin.video.skygo.de 20:14:28.255 T:2526041072 DEBUG: CPythonInvoker(7, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): instantiating addon using automatically obtained id of "plugin.video.skygo.de" dependent on version 2.1.0 of the xbmc.python api 20:14:28.653 T:3042155408 DEBUG: ------ Window Init (DialogBusy.xml) ------ 20:14:29.822 T:2526041072 DEBUG: false 20:14:29.924 T:2526041072 DEBUG: {'action': 'listSeason', 'series_id': '74561', 'id': '69396'} 20:14:30.399 T:2526041072 INFO: CPythonInvoker(7, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 20:14:30.443 T:3042155408 DEBUG: Saving fileitems [plugin://plugin.video.skygo.de/?action=listSeason&id=69396&series_id=74561] 20:14:30.444 T:3042155408 DEBUG: -- items: 13, sort method: 0, ascending: false 20:14:30.458 T:3042155408 DEBUG: RunQuery took 4 ms for 11 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=1 20:14:30.472 T:2463101936 DEBUG: Thread BackgroundLoader start, auto delete: false 20:14:30.487 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:14:30.584 T:2463101936 DEBUG: Thread BackgroundLoader 2463101936 terminating 20:14:30.635 T:2526041072 INFO: Python script stopped 20:14:30.635 T:2526041072 DEBUG: Thread LanguageInvoker 2526041072 terminating 20:14:30.685 T:3042155408 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 20:14:31.633 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:31.633 T:3042155408 DEBUG: OnKey: down (0xf081) pressed, action is Down 20:14:31.692 T:2620445680 DEBUG: CCurlFile::GetMimeType - https://www.skygo.sky.de/bin/Picture/986/C_1_Picture_131121_content_4.jpg -> image/jpeg 20:14:31.692 T:2620445680 DEBUG: CurlFile::Open(0x90ba4dd8) https://www.skygo.sky.de/bin/Picture/986/C_1_Picture_131121_content_4.jpg 20:14:31.772 T:2620445680 DEBUG: Caching image 'https://www.skygo.sky.de/bin/Picture/986/C_1_Picture_131121_content_4.jpg' to 'c/c03b0ed3.jpg': 20:14:31.772 T:2620445680 DEBUG: cached image 'special://masterprofile/Thumbnails/c/c03b0ed3.jpg' size 680x383 20:14:31.933 T:3042155408 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 20:14:32.422 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:14:32.718 T:3042155408 DEBUG: OnKey: return (0xf00d) pressed, action is Select 20:14:32.729 T:3042155408 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?action=playVod&parental_rating=12&vod_id=132459&infolabels=%7B%27plot%27%3A+%27%27%2C+%27episode%27%3A+1%2C+%27title%27%3A+u%27Episode+Eins%27%2C+%27season%27%3A+1%2C+%27tvshowtitle%27%3A+u%27Dark+Matter%27%2C+%27mediatype%27%3A+%27episode%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+2580%2C+%27genre%27%3A+%27%27%7D 20:14:32.732 T:3042155408 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','7','?action=playVod&parental_rating=12&vod_id=132459&infolabels=%7B%27plot%27%3A+%27%27%2C+%27episode%27%3A+1%2C+%27title%27%3A+u%27Episode+Eins%27%2C+%27season%27%3A+1%2C+%27tvshowtitle%27%3A+u%27Dark+Matter%27%2C+%27mediatype%27%3A+%27episode%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+2580%2C+%27genre%27%3A+%27%27%7D') 20:14:32.733 T:2526041072 DEBUG: Thread LanguageInvoker start, auto delete: false 20:14:32.733 T:2526041072 INFO: initializing python engine. 20:14:32.733 T:2526041072 DEBUG: CPythonInvoker(8, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): start processing 20:14:32.745 T:3042141168 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 20:14:32.745 T:3042141168 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 20:14:32.753 T:2463101936 DEBUG: Thread scriptobs start, auto delete: false 20:14:32.773 T:2526041072 DEBUG: -->Python Interpreter Initialized<-- 20:14:32.773 T:2526041072 DEBUG: CPythonInvoker(8, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/media/hdd/.kodi/addons/plugin.video.skygo.de/default.py" 20:14:32.774 T:2526041072 DEBUG: CPythonInvoker(8, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /media/hdd/.kodi/addons/plugin.video.skygo.de:/media/hdd/.kodi/addons/script.common.plugin.cache/lib:/media/hdd/.kodi/addons/script.module.cryptopy/lib:/media/hdd/.kodi/addons/script.module.pydes/lib:/media/hdd/.kodi/addons/script.module.requests/lib:/media/hdd/.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/PIL:/usr/lib/python2.7/site-packages/setuptools-31.0.0-py2.7.egg 20:14:32.774 T:2526041072 DEBUG: CPythonInvoker(8, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /media/hdd/.kodi/addons/plugin.video.skygo.de 20:14:32.774 T:2526041072 DEBUG: CPythonInvoker(8, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): instantiating addon using automatically obtained id of "plugin.video.skygo.de" dependent on version 2.1.0 of the xbmc.python api 20:14:32.953 T:3042155408 DEBUG: ------ Window Init (DialogBusy.xml) ------ 20:14:34.414 T:2526041072 DEBUG: false 20:14:34.501 T:2526041072 DEBUG: {'action': 'playVod', 'parental_rating': '12', 'vod_id': '132459', 'infolabels': "{'plot': '', 'episode': 1, 'title': u'Episode Eins', 'season': 1, 'tvshowtitle': u'Dark Matter', 'mediatype': 'episode', 'originaltitle': '', 'cast': [], 'duration': 2580, 'genre': ''}"} 20:14:35.537 T:2526041072 DEBUG: {u'resultCode': u'S_218', u'resultMessage': u'KO'} 20:14:35.537 T:2526041072 DEBUG: User not logged in or Session on other device 20:14:35.537 T:2526041072 DEBUG: Session invalid - Customer Code not found in SilkCache 20:14:35.722 T:2526041072 DEBUG: {u'tcFlag': u'Y', u'birthDate': u'##########', u'email': u'#####@gmx.de', u'customerCode': u'##########', u'resultCode': u'T_100', u'privacyFlag': u'Y', u'extraCustFlag': u'Y', u'bookmarkFlag': u'Y', u'skygoSessionId': u'SG-fb8a0908-95a8-4269-b032-c804ae5ff4c1', u'entitlements': [u'KIDS', u'OFBP', u'OFBS', u'OFEH', u'OFES', u'OOFH', u'OOHD', u'OOSF', u'OOSP', u'OOSW', u'OOWE', u'OSFH', u'OSPS', u'OWEH', u'OWES', u'OWFS', u'OWHE'], u'presentation': u'HERR', u'cancellationDate': u'2017/12/31', u'accountCreated': u'2010/02/05', u'flagTEF': u'N', u'tcExtraFlag': u'Y', u'mktgFlag': u'N', u'firstName': u'THOMAS', u'country': u'DE', u'age': u'35', u'lastName': u'BERTHOLD', u'resultMessage': u'OK', u'cableSubFlag': u'N', u'gender': u'M'} 20:14:35.811 T:2526041072 DEBUG: {u'tcFlag': u'Y', u'birthDate': u'##########', u'email': u'#####@gmx.de', u'customerCode': u'##########', u'bookmarkFlag': u'Y', u'privacyFlag': u'Y', u'extraCustFlag': u'Y', u'skygoSessionId': u'SG-fb8a0908-95a8-4269-b032-c804ae5ff4c1', u'entitlements': [u'KIDS', u'OFBP', u'OFBS', u'OFEH', u'OFES', u'OOFH', u'OOHD', u'OOSF', u'OOSP', u'OOSW', u'OOWE', u'OSFH', u'OSPS', u'OWEH', u'OWES', u'OWFS', u'OWHE'], u'presentation': u'HERR', u'cancellationDate': u'2017/12/31', u'accountCreated': u'2010/02/05', u'flagTEF': u'N', u'doubleOptInFlag': u'N', u'tcExtraFlag': u'Y', u'mktgFlag': u'N', u'firstName': u'THOMAS', u'country': u'DE', u'age': u'35', u'lastName': u'BERTHOLD', u'resultMessage': u'OK', u'cableSubFlag': u'N', u'resultCode': u'S_100', u'gender': u'M'} 20:14:35.811 T:2526041072 DEBUG: User still logged in 20:14:35.818 T:2526041072 INFO: CPythonInvoker(8, /media/hdd/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 20:14:35.864 T:2463101936 DEBUG: Thread scriptobs 2463101936 terminating 20:14:35.865 T:3042155408 INFO: easy_aquire - Created session to http://skywebvod-s.akamaihd.net 20:14:35.958 T:3042155408 DEBUG: CCurlFile::GetMimeType - http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/145530332001/145530332001.ism/Manifest -> text/xml 20:14:35.979 T:3042155408 DEBUG: Loading settings for http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/145530332001/145530332001.ism/Manifest 20:14:36.013 T:3042155408 DEBUG: CPlayerCoreFactory::GetPlayers(http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/145530332001/145530332001.ism/Manifest) 20:14:36.013 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: un-named 20:14:36.014 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: un-named 20:14:36.014 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: un-named 20:14:36.014 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: un-named 20:14:36.014 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: adding player: E2Player for rule: un-named 20:14:36.014 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 20:14:36.014 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 20:14:36.014 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 20:14:36.014 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 20:14:36.014 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 20:14:36.014 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 20:14:36.014 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 20:14:36.014 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams 20:14:36.014 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp 20:14:36.014 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2 20:14:36.015 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 20:14:36.015 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 20:14:36.015 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 20:14:36.015 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 20:14:36.015 T:3042155408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 20:14:36.015 T:3042155408 DEBUG: CPlayerCoreFactory::GetPlayers: matched 1 rules with players 20:14:36.015 T:3042155408 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 20:14:36.015 T:3042155408 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 20:14:36.015 T:3042155408 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 20:14:36.015 T:3042155408 DEBUG: CPlayerCoreFactory::GetPlayers: added 2 players 20:14:36.015 T:3042155408 NOTICE: ExternalPlayer Filename: kodiext 20:14:36.015 T:3042155408 WARNING: ExternalPlayer: invalid value for warpcursor: none 20:14:36.015 T:3042155408 NOTICE: ExternalPlayer Tweaks: hideconsole (true), hidexbmc (true), islauncher (false), warpcursor (none) 20:14:36.015 T:3042155408 NOTICE: OpenFile: http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/145530332001/145530332001.ism/Manifest 20:14:36.016 T:3042155408 DEBUG: PlayFile: OpenFile succeed, play state 1 20:14:36.017 T:3042155408 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 20:14:36.020 T:2463101936 DEBUG: Thread ExternalPlayer start, auto delete: false 20:14:36.020 T:2463101936 NOTICE: Process: Player : kodiext 20:14:36.020 T:2463101936 NOTICE: Process: File : http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/145530332001/145530332001.ism/Manifest 20:14:36.020 T:2463101936 NOTICE: Process: Content: 20:14:36.020 T:2463101936 NOTICE: Process: Args : -U "{1}" -S "{3}" -P "$PPID" 20:14:36.020 T:2463101936 NOTICE: Process: Start 20:14:36.020 T:2463101936 NOTICE: Process: Hiding Kodi window 20:14:36.053 T:2526041072 INFO: Python script stopped 20:14:36.053 T:2526041072 DEBUG: Thread LanguageInvoker 2526041072 terminating 20:14:36.065 T:3042155408 DEBUG: Percentage is 0.000000 20:14:36.115 T:3042155408 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 20:14:36.271 T:2463101936 DEBUG: OnPlayBackStarted: play state was 1, starting 0 20:14:36.271 T:2463101936 NOTICE: ExecuteAppLinux: "kodiext" -U "http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/145530332001/145530332001.ism/Manifest" -S "{3}" -P "$PPID" 20:14:36.322 T:3021992944 DEBUG: CGUIInfoManager::SetCurrentMovie(http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/145530332001/145530332001.ism/Manifest) 20:14:36.366 T:3042141168 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 20:14:36.366 T:3042141168 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 20:14:36.568 T:3042155408 DEBUG: Percentage is 0.000000 20:14:47.443 T:3042155408 DEBUG: Previous line repeats 20 times. 20:14:47.443 T:3042155408 DEBUG: Percentage is 100.000000 20:14:53.579 T:3042155408 DEBUG: Previous line repeats 12 times. 20:14:53.579 T:3042155408 INFO: CheckIdle - Closing session to https://www.skygo.sky.de (easy=0xb4c0ba70, multi=0x9318b6e8) 20:14:54.121 T:3042155408 DEBUG: Percentage is 100.000000 20:15:01.904 T:3042155408 DEBUG: Previous line repeats 15 times. 20:15:01.904 T:3042155408 INFO: CheckIdle - Closing session to https://www.skygo.sky.de (easy=0xb4c180a0, multi=0xb4c22a60) 20:15:02.441 T:3042155408 DEBUG: Percentage is 100.000000 20:15:06.130 T:3042155408 DEBUG: Previous line repeats 7 times. 20:15:06.130 T:3042155408 INFO: CheckIdle - Closing session to http://skywebvod-s.akamaihd.net (easy=0x3835540, multi=(nil)) 20:15:06.324 T:2611631088 DEBUG: Thread JobWorker 2611631088 terminating (autodelete) 20:15:06.330 T:2630579184 DEBUG: Thread JobWorker 2630579184 terminating (autodelete) 20:15:06.331 T:2620445680 DEBUG: Thread JobWorker 2620445680 terminating (autodelete) 20:15:06.367 T:3021992944 DEBUG: Thread JobWorker 3021992944 terminating (autodelete) 20:15:06.642 T:3042155408 DEBUG: Percentage is 100.000000 20:15:42.779 T:2463101936 DEBUG: Previous line repeats 69 times. 20:15:42.779 T:2463101936 NOTICE: Process: Stop 20:15:42.779 T:2463101936 NOTICE: Process: Showing Kodi window 20:15:42.785 T:3012555760 INFO: CAESinkALSA - Unable to open device "surround71" for playback 20:15:42.786 T:3012555760 INFO: CAESinkALSA - Unable to open device "surround51" for playback 20:15:42.786 T:3012555760 INFO: CAESinkALSA - Unable to open device "surround71" for playback 20:15:42.787 T:3012555760 INFO: CAESinkALSA - Unable to open device "surround40" for playback 20:15:42.787 T:3012555760 INFO: CAESinkALSA - Unable to open device "surround51" for playback 20:15:42.787 T:3012555760 INFO: CAESinkALSA - Unable to open device "surround71" for playback 20:15:42.816 T:3012555760 NOTICE: Found 1 Lists of Devices 20:15:42.816 T:3012555760 NOTICE: Enumerated ALSA devices: 20:15:42.816 T:3012555760 NOTICE: Device 1 20:15:42.816 T:3012555760 NOTICE: m_deviceName : @ 20:15:42.816 T:3012555760 NOTICE: m_displayName : Default (bcm Analog) 20:15:42.816 T:3012555760 NOTICE: m_displayNameExtra: 20:15:42.816 T:3012555760 NOTICE: m_deviceType : AE_DEVTYPE_PCM 20:15:42.816 T:3012555760 NOTICE: m_channels : FL,FR 20:15:42.816 T:3012555760 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000 20:15:42.816 T:3012555760 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE 20:15:42.816 T:3012555760 NOTICE: m_streamTypes : No passthrough capabilities 20:15:42.817 T:3004167152 INFO: CActiveAESink::OpenSink - initialize sink 20:15:42.817 T:3004167152 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:@ 20:15:42.817 T:3004167152 INFO: CAESinkALSA::Initialize - Attempting to open device "@" 20:15:42.826 T:3004167152 INFO: CAESinkALSA::Initialize - Opened device "sysdefault" 20:15:42.828 T:3004167152 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 20:15:42.828 T:3004167152 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 20:15:42.828 T:3004167152 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 512, bufferSize 8820 20:15:42.828 T:3004167152 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 275, bufferSize 8820 20:15:42.828 T:3004167152 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms 20:15:42.828 T:3004167152 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 20:15:42.828 T:3004167152 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR 20:15:42.828 T:3004167152 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: none) 20:15:42.828 T:3004167152 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 20:15:42.828 T:3004167152 DEBUG: Output Device : Default (bcm Analog) 20:15:42.828 T:3004167152 DEBUG: Sample Rate : 44100 20:15:42.828 T:3004167152 DEBUG: Sample Format : AE_FMT_S32NE 20:15:42.828 T:3004167152 DEBUG: Channel Count : 2 20:15:42.828 T:3004167152 DEBUG: Channel Layout: FL,FR 20:15:42.829 T:3004167152 DEBUG: Frames : 275 20:15:42.829 T:3004167152 DEBUG: Frame Size : 8 20:15:42.830 T:3012555760 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 20:15:42.830 T:2463101936 DEBUG: OnPlayBackEnded: play state was 2, starting 0 20:15:42.830 T:2463101936 DEBUG: Thread ExternalPlayer 2463101936 terminating 20:15:42.848 T:3004167152 ERROR: CAESinkALSA - snd_pcm_writei(-32) Broken pipe - trying to recover 20:15:42.851 T:3042141168 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 20:15:42.851 T:3042141168 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 20:15:42.860 T:3004167152 ERROR: CAESinkALSA - snd_pcm_writei(-32) Broken pipe - trying to recover 20:15:42.977 T:3042155408 DEBUG: Keyboard: scancode: 0xae, sym: 0x001b, unicode: 0x001b, modifier: 0x0 20:15:42.977 T:3042155408 DEBUG: OnKey: escape (0xf01b) pressed, action is PreviousMenu 20:15:42.977 T:3042155408 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 20:15:43.301 T:3042155408 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 20:15:43.305 T:3042155408 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 20:15:43.305 T:3042155408 DEBUG: ------ Window Init (Home.xml) ------ 20:15:43.309 T:3042155408 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 20:15:43.309 T:3042155408 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 20:15:43.309 T:2463101936 DEBUG: Thread JobWorker start, auto delete: true 20:15:43.309 T:3042155408 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 20:15:43.310 T:3042155408 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 20:15:43.320 T:3042155408 DEBUG: Keyboard: scancode: 0xae, sym: 0x001b, unicode: 0x001b, modifier: 0x0 20:15:43.321 T:3021992944 DEBUG: Thread JobWorker start, auto delete: true 20:15:43.362 T:2463101936 DEBUG: DoWork - Saving file state for video item plugin://plugin.video.skygo.de/?action=playVod&parental_rating=12&vod_id=132459&infolabels=%7B%27plot%27%3A+%27%27%2C+%27episode%27%3A+1%2C+%27title%27%3A+u%27Episode+Eins%27%2C+%27season%27%3A+1%2C+%27tvshowtitle%27%3A+u%27Dark+Matter%27%2C+%27mediatype%27%3A+%27episode%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+2580%2C+%27genre%27%3A+%27%27%7D 20:15:43.378 T:2463101936 DEBUG: DoWork - Marking video item plugin://plugin.video.skygo.de/?action=playVod&parental_rating=12&vod_id=132459&infolabels=%7B%27plot%27%3A+%27%27%2C+%27episode%27%3A+1%2C+%27title%27%3A+u%27Episode+Eins%27%2C+%27season%27%3A+1%2C+%27tvshowtitle%27%3A+u%27Dark+Matter%27%2C+%27mediatype%27%3A+%27episode%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+2580%2C+%27genre%27%3A+%27%27%7D as watched 20:15:43.860 T:3042141168 DEBUG: CAnnouncementManager - Announcement: OnUpdate from xbmc 20:15:43.861 T:3042141168 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnUpdate 20:15:45.209 T:3042155408 DEBUG: Keyboard: scancode: 0xae, sym: 0x001b, unicode: 0x001b, modifier: 0x0 20:15:45.428 T:3042155408 DEBUG: OnKey: escape (0xf01b) pressed, action is PreviousMenu 20:15:45.428 T:3042155408 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 20:15:45.428 T:3042155408 DEBUG: Keyboard: scancode: 0xae, sym: 0x001b, unicode: 0x001b, modifier: 0x0