17:33:04.801 T:140678954788864 NOTICE: special://profile/ is mapped to: special://masterprofile/ 17:33:04.801 T:140678954788864 NOTICE: ----------------------------------------------------------------------- 17:33:04.801 T:140678954788864 NOTICE: Starting Kodi (17.4 Git:20170822-nogitfound). Platform: Linux x86 64-bit 17:33:04.801 T:140678954788864 NOTICE: Using Release Kodi x64 build 17:33:04.801 T:140678954788864 NOTICE: Kodi compiled Aug 22 2017 by GCC 4.8.4 for Linux x86 64-bit version 3.13.11 (199947) 17:33:04.801 T:140678954788864 NOTICE: Running on Ubuntu 14.04.5 LTS, kernel: Linux x86 64-bit version 4.4.0-45-generic 17:33:04.801 T:140678954788864 NOTICE: FFmpeg version/source: ffmpeg-3.1-kodi 17:33:04.801 T:140678954788864 NOTICE: Host CPU: Intel(R) Core(TM) i5-4670T CPU @ 2.30GHz, 4 cores available 17:33:04.801 T:140678954788864 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi 17:33:04.801 T:140678954788864 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/x86_64-linux-gnu/kodi 17:33:04.801 T:140678954788864 NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/x86_64-linux-gnu/kodi/addons 17:33:04.801 T:140678954788864 NOTICE: special://masterprofile/ is mapped to: /var/lib/vdr/.kodi/userdata 17:33:04.801 T:140678954788864 NOTICE: special://envhome/ is mapped to: /var/lib/vdr 17:33:04.801 T:140678954788864 NOTICE: special://home/ is mapped to: /var/lib/vdr/.kodi 17:33:04.801 T:140678954788864 NOTICE: special://temp/ is mapped to: /var/lib/vdr/.kodi/temp 17:33:04.801 T:140678954788864 NOTICE: special://logpath/ is mapped to: /var/lib/vdr/.kodi/temp 17:33:04.801 T:140678954788864 NOTICE: The executable running is: /usr/lib/x86_64-linux-gnu/kodi/kodi.bin 17:33:04.801 T:140678954788864 NOTICE: Local hostname: easyVDR 17:33:04.801 T:140678954788864 NOTICE: Log File is located: /var/lib/vdr/.kodi/temp//kodi.log 17:33:04.801 T:140678954788864 NOTICE: ----------------------------------------------------------------------- 17:33:04.912 T:140678954788864 NOTICE: load settings... 17:33:04.926 T:140678954788864 ERROR: PulseAudio: Failed to connect context 17:33:04.926 T:140678954788864 NOTICE: PulseAudio might not be running. Context was not created. 17:33:04.975 T:140678954788864 NOTICE: Found 1 Lists of Devices 17:33:04.975 T:140678954788864 NOTICE: Enumerated ALSA devices: 17:33:04.975 T:140678954788864 NOTICE: Device 1 17:33:04.975 T:140678954788864 NOTICE: m_deviceName : @ 17:33:04.975 T:140678954788864 NOTICE: m_displayName : Default (HDA Intel PCH ALC892 Analog) 17:33:04.975 T:140678954788864 NOTICE: m_displayNameExtra: 17:33:04.975 T:140678954788864 NOTICE: m_deviceType : AE_DEVTYPE_PCM 17:33:04.975 T:140678954788864 NOTICE: m_channels : FL,FR,BL,BR,FC,LFE,SL,SR 17:33:04.975 T:140678954788864 NOTICE: m_sampleRates : 48000 17:33:04.975 T:140678954788864 NOTICE: m_dataFormats : AE_FMT_S32NE 17:33:04.975 T:140678954788864 NOTICE: m_streamTypes : No passthrough capabilities 17:33:04.975 T:140678954788864 NOTICE: Device 2 17:33:04.975 T:140678954788864 NOTICE: m_deviceName : multi 17:33:04.975 T:140678954788864 NOTICE: m_displayName : HDA NVidia 17:33:04.975 T:140678954788864 NOTICE: m_displayNameExtra: HDMI 1 17:33:04.975 T:140678954788864 NOTICE: m_deviceType : AE_DEVTYPE_PCM 17:33:04.975 T:140678954788864 NOTICE: m_channels : FL,FR 17:33:04.975 T:140678954788864 NOTICE: m_sampleRates : 32000,44100,48000 17:33:04.975 T:140678954788864 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE 17:33:04.975 T:140678954788864 NOTICE: m_streamTypes : No passthrough capabilities 17:33:04.975 T:140678954788864 NOTICE: Device 3 17:33:04.975 T:140678954788864 NOTICE: m_deviceName : @:CARD=PCH,DEV=0 17:33:04.975 T:140678954788864 NOTICE: m_displayName : HDA Intel PCH 17:33:04.975 T:140678954788864 NOTICE: m_displayNameExtra: ALC892 Analog 17:33:04.975 T:140678954788864 NOTICE: m_deviceType : AE_DEVTYPE_PCM 17:33:04.975 T:140678954788864 NOTICE: m_channels : FL,FR,BL,BR,FC,LFE,SL,SR 17:33:04.975 T:140678954788864 NOTICE: m_sampleRates : 48000 17:33:04.975 T:140678954788864 NOTICE: m_dataFormats : AE_FMT_S32NE 17:33:04.975 T:140678954788864 NOTICE: m_streamTypes : No passthrough capabilities 17:33:04.975 T:140678954788864 NOTICE: Device 4 17:33:04.975 T:140678954788864 NOTICE: m_deviceName : iec958:CARD=PCH,DEV=0 17:33:04.975 T:140678954788864 NOTICE: m_displayName : HDA Intel PCH 17:33:04.975 T:140678954788864 NOTICE: m_displayNameExtra: ALC892 Digital S/PDIF 17:33:04.975 T:140678954788864 NOTICE: m_deviceType : AE_DEVTYPE_IEC958 17:33:04.975 T:140678954788864 NOTICE: m_channels : FL,FR 17:33:04.975 T:140678954788864 NOTICE: m_sampleRates : 32000,44100,48000,88200,96000,192000 17:33:04.975 T:140678954788864 NOTICE: m_dataFormats : AE_FMT_RAW,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE 17:33:04.975 T:140678954788864 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512 17:33:04.975 T:140678954788864 NOTICE: Device 5 17:33:04.975 T:140678954788864 NOTICE: m_deviceName : hdmi:CARD=NVidia,DEV=0 17:33:04.975 T:140678954788864 NOTICE: m_displayName : HDA NVidia 17:33:04.975 T:140678954788864 NOTICE: m_displayNameExtra: HDMI 17:33:04.975 T:140678954788864 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 17:33:04.975 T:140678954788864 NOTICE: m_channels : FL,FR,BL,BR,FC,LFE,SL,SR 17:33:04.975 T:140678954788864 NOTICE: m_sampleRates : 32000,44100,48000,88200,96000,176400,192000 17:33:04.975 T:140678954788864 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW 17:33:04.975 T:140678954788864 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD 17:33:04.975 T:140678954788864 NOTICE: Device 6 17:33:04.975 T:140678954788864 NOTICE: m_deviceName : hdmi:CARD=NVidia,DEV=1 17:33:04.975 T:140678954788864 NOTICE: m_displayName : HDA NVidia 17:33:04.975 T:140678954788864 NOTICE: m_displayNameExtra: SAM SAMSUNG on HDMI 17:33:04.975 T:140678954788864 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 17:33:04.975 T:140678954788864 NOTICE: m_channels : FL,FR,BL,BR,FC,LFE 17:33:04.975 T:140678954788864 NOTICE: m_sampleRates : 32000,44100,48000 17:33:04.975 T:140678954788864 NOTICE: m_dataFormats : AE_FMT_RAW,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW 17:33:04.975 T:140678954788864 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD 17:33:04.981 T:140678954788864 NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml) 17:33:04.981 T:140678954788864 ERROR: Error loading special://profile/advancedsettings.xml, Line 0 Error document empty. 17:33:04.981 T:140678954788864 NOTICE: Default Video Player: VideoPlayer 17:33:04.981 T:140678954788864 NOTICE: Default Audio Player: paplayer 17:33:04.981 T:140678954788864 NOTICE: Disabled debug logging due to GUI setting. Level 0. 17:33:04.981 T:140678954788864 NOTICE: Log level changed to "LOG_LEVEL_NORMAL" 17:33:04.981 T:140678954788864 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 17:33:04.981 T:140678954788864 NOTICE: Loaded playercorefactory configuration 17:33:04.981 T:140678954788864 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 17:33:04.981 T:140678954788864 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 17:33:04.988 T:140678954788864 NOTICE: Running database version Addons27 17:33:05.042 T:140678954788864 NOTICE: ADDONS: Using repository repository.xbmc.org 17:33:05.042 T:140678954788864 NOTICE: ADDONS: Using repository repository.kodinerds_Generic_x68_64 17:33:05.042 T:140678954788864 NOTICE: ADDONS: Using repository repository.kodinerds 17:33:05.042 T:140678954788864 NOTICE: ADDONS: Using repository repository.sandmann79.plugins 17:33:05.158 T:140678954788864 NOTICE: Checking resolution 16 17:33:05.341 T:140678954788864 ERROR: Failed to determine egl config for visual info 17:33:05.341 T:140678954788864 WARNING: Visual 0x27 of the window is not suitable, looking for another one... 17:33:05.341 T:140678954788864 NOTICE: Using visual 0x21 17:33:05.358 T:140678954788864 NOTICE: Using visual 0x27 17:33:05.416 T:140678954788864 NOTICE: GL_VENDOR = NVIDIA Corporation 17:33:05.416 T:140678954788864 NOTICE: GL_RENDERER = GeForce GT 630/PCIe/SSE2 17:33:05.416 T:140678954788864 NOTICE: GL_VERSION = 4.5.0 NVIDIA 370.28 17:33:05.416 T:140678954788864 NOTICE: GL_SHADING_LANGUAGE_VERSION = 4.50 NVIDIA 17:33:05.417 T:140678954788864 NOTICE: GL_GPU_MEMORY_INFO_TOTAL_AVAILABLE_MEMORY_NVX = 2097152 17:33:05.417 T:140678954788864 NOTICE: GL_GPU_MEMORY_INFO_DEDICATED_VIDMEM_NVX = 2097152 17:33:05.417 T:140678954788864 NOTICE: GL_EXTENSIONS = GL_AMD_multi_draw_indirect GL_AMD_seamless_cubemap_per_texture GL_ARB_arrays_of_arrays GL_ARB_base_instance GL_ARB_bindless_texture GL_ARB_blend_func_extended GL_ARB_buffer_storage GL_ARB_clear_buffer_object GL_ARB_clear_texture GL_ARB_clip_control GL_ARB_color_buffer_float GL_ARB_compatibility GL_ARB_compressed_texture_pixel_storage GL_ARB_conservative_depth GL_ARB_compute_shader GL_ARB_compute_variable_group_size GL_ARB_conditional_render_inverted GL_ARB_copy_buffer GL_ARB_copy_image GL_ARB_cull_distance GL_ARB_debug_output GL_ARB_depth_buffer_float GL_ARB_depth_clamp GL_ARB_depth_texture GL_ARB_derivative_control GL_ARB_direct_state_access GL_ARB_draw_buffers GL_ARB_draw_buffers_blend GL_ARB_draw_indirect GL_ARB_draw_elements_base_vertex GL_ARB_draw_instanced GL_ARB_enhanced_layouts GL_ARB_ES2_compatibility GL_ARB_ES3_compatibility GL_ARB_ES3_1_compatibility GL_ARB_ES3_2_compatibility GL_ARB_explicit_attrib_location GL_ARB_explicit_uniform_location GL_ARB_fragment_coord_conventions GL_ARB_fragment_layer_viewport GL_ARB_fragment_program GL_ARB_fragment_program_shadow GL_ARB_fragment_shader GL_ARB_framebuffer_no_attachments GL_ARB_framebuffer_object GL_ARB_framebuffer_sRGB GL_ARB_geometry_shader4 GL_ARB_get_program_binary GL_ARB_get_texture_sub_image GL_ARB_gl_spirv GL_ARB_gpu_shader5 GL_ARB_gpu_shader_fp64 GL_ARB_gpu_shader_int64 GL_ARB_half_float_pixel GL_ARB_half_float_vertex GL_ARB_imaging GL_ARB_indirect_parameters GL_ARB_instanced_arrays GL_ARB_internalformat_query GL_ARB_internalformat_query2 GL_ARB_invalidate_subdata GL_ARB_map_buffer_alignment GL_ARB_map_buffer_range GL_ARB_multi_bind GL_ARB_multi_draw_indirect GL_ARB_multisample GL_ARB_multitexture GL_ARB_occlusion_query GL_ARB_occlusion_query2 GL_ARB_parallel_shader_compile GL_ARB_pipeline_statistics_query GL_ARB_pixel_buffer_object GL_ARB_point_parameters GL_ARB_point_sprite GL_ARB_program_interface_query GL_ARB_provoking_vertex GL_ARB_query_buffer_object GL_ARB_robust_buffer_access_behavior GL_ARB_robustness GL_ARB_sample_shading GL_ARB_sampler_objects GL_ARB_seamless_cube_map GL_ARB_seamless_cubemap_per_texture GL_ARB_separate_shader_objects GL_ARB_shader_atomic_counter_ops GL_ARB_shader_atomic_counters GL_ARB_shader_ballot GL_ARB_shader_bit_encoding GL_ARB_shader_clock GL_ARB_shader_draw_parameters GL_ARB_shader_group_vote GL_ARB_shader_image_load_store GL_ARB_shader_image_size GL_ARB_shader_objects GL_ARB_shader_precision GL_ARB_shader_storage_buffer_object GL_ARB_shader_subroutine GL_ARB_shader_texture_image_samples GL_ARB_shader_texture_lod GL_ARB_shading_language_100 GL_ARB_shading_language_420pack GL_ARB_shading_language_include GL_ARB_shading_language_packing GL_ARB_shadow GL_ARB_sparse_buffer GL_ARB_sparse_texture GL_ARB_stencil_texturing GL_ARB_sync GL_ARB_tessellation_shader GL_ARB_texture_barrier GL_ARB_texture_border_clamp GL_ARB_texture_buffer_object GL_ARB_texture_buffer_object_rgb32 GL_ARB_texture_buffer_range GL_ARB_texture_compression GL_ARB_texture_compression_bptc GL_ARB_texture_compression_rgtc GL_ARB_texture_cube_map GL_ARB_texture_cube_map_array GL_ARB_texture_env_add GL_ARB_texture_env_combine GL_ARB_texture_env_crossbar GL_ARB_texture_env_dot3 GL_ARB_texture_float GL_ARB_texture_gather GL_ARB_texture_mirror_clamp_to_edge GL_ARB_texture_mirrored_repeat GL_ARB_texture_multisample GL_ARB_texture_non_power_of_two GL_ARB_texture_query_levels GL_ARB_texture_query_lod GL_ARB_texture_rectangle GL_ARB_texture_rg GL_ARB_texture_rgb10_a2ui GL_ARB_texture_stencil8 GL_ARB_texture_storage GL_ARB_texture_storage_multisample GL_ARB_texture_swizzle GL_ARB_texture_view GL_ARB_timer_query GL_ARB_transform_feedback2 GL_ARB_transform_feedback3 GL_ARB_transform_feedback_instanced GL_ARB_transform_feedback_overflow_query GL_ARB_transpose_matrix GL_ARB_uniform_buffer_object GL_ARB_vertex_array_bgra GL_ARB_vertex_array_object GL_ARB_vertex_attrib_64bit GL_ARB_vertex_attrib_binding GL_ARB_vertex_buffer_object GL_ARB_vertex_program GL_ARB_vertex_shader GL_ARB_vertex_type_10f_11f_11f_rev GL_ARB_vertex_type_2_10_10_10_rev GL_ARB_viewport_array GL_ARB_window_pos GL_ATI_draw_buffers GL_ATI_texture_float GL_ATI_texture_mirror_once GL_S3_s3tc GL_EXT_texture_env_add GL_EXT_abgr GL_EXT_bgra GL_EXT_bindable_uniform GL_EXT_blend_color GL_EXT_blend_equation_separate GL_EXT_blend_func_separate GL_EXT_blend_minmax GL_EXT_blend_subtract GL_EXT_compiled_vertex_array GL_EXT_Cg_shader GL_EXT_depth_bounds_test GL_EXT_direct_state_access GL_EXT_draw_buffers2 GL_EXT_draw_instanced GL_EXT_draw_range_elements GL_EXT_fog_coord GL_EXT_framebuffer_blit GL_EXT_framebuffer_multisample GL_EXTX_framebuffer_mixed_formats GL_EXT_framebuffer_multisample_blit_scaled GL_EXT_framebuffer_object GL_EXT_framebuffer_sRGB GL_EXT_geometry_shader4 GL_EXT_gpu_program_parameters GL_EXT_gpu_shader4 GL_EXT_multi_draw_arrays GL_EXT_packed_depth_stencil GL_EXT_packed_float GL_EXT_packed_pixels GL_EXT_pixel_buffer_object GL_EXT_point_parameters GL_EXT_polygon_offset_clamp GL_EXT_provoking_vertex GL_EXT_rescale_normal GL_EXT_secondary_color GL_EXT_separate_shader_objects GL_EXT_separate_specular_color GL_EXT_shader_image_load_store GL_EXT_shader_integer_mix GL_EXT_shadow_funcs GL_EXT_stencil_two_side GL_EXT_stencil_wrap GL_EXT_texture3D GL_EXT_texture_array GL_EXT_texture_buffer_object GL_EXT_texture_compression_dxt1 GL_EXT_texture_compression_latc GL_EXT_texture_compression_rgtc GL_EXT_texture_compression_s3tc GL_EXT_texture_cube_map GL_EXT_texture_edge_clamp GL_EXT_texture_env_combine GL_EXT_texture_env_dot3 GL_EXT_texture_filter_anisotropic GL_EXT_texture_integer GL_EXT_texture_lod GL_EXT_texture_lod_bias GL_EXT_texture_mirror_clamp GL_EXT_texture_object GL_EXT_texture_shared_exponent GL_EXT_texture_sRGB GL_EXT_texture_sRGB_decode GL_EXT_texture_storage GL_EXT_texture_swizzle GL_EXT_timer_query GL_EXT_transform_feedback2 GL_EXT_vertex_array GL_EXT_vertex_array_bgra GL_EXT_vertex_attrib_64bit GL_EXT_window_rectangles GL_EXT_x11_sync_object GL_EXT_import_sync_object GL_NV_robustness_video_memory_purge GL_IBM_rasterpos_clip GL_IBM_texture_mirrored_repeat GL_KHR_context_flush_control GL_KHR_debug GL_KHR_no_error GL_KHR_robust_buffer_access_behavior GL_KHR_robustness GL_KTX_buffer_region GL_NV_alpha_to_coverage_dither_control GL_NV_bindless_multi_draw_indirect GL_NV_bindless_multi_draw_indirect_count GL_NV_bindless_texture GL_NV_blend_equation_advanced GL_NV_blend_square GL_NV_command_list GL_NV_compute_program5 GL_NV_conditional_render GL_NV_copy_depth_to_color GL_NV_copy_image GL_NV_depth_buffer_float GL_NV_depth_clamp GL_NV_draw_texture GL_NV_draw_vulkan_image GL_NV_ES1_1_compatibility GL_NV_ES3_1_compatibility GL_NV_explicit_multisample GL_NV_fence GL_NV_float_buffer GL_NV_fog_distance GL_NV_fragment_program GL_NV_fragment_program_option GL_NV_fragment_program2 GL_NV_framebuffer_multisample_coverage GL_NV_geometry_shader4 GL_NV_gpu_program4 GL_NV_internalformat_sample_query GL_NV_gpu_program4_1 GL_NV_gpu_program5 GL_NV_gpu_program5_mem_extended GL_NV_gpu_program_fp64 GL_NV_gpu_shader5 GL_NV_half_float GL_NV_light_max_exponent GL_NV_multisample_coverage GL_NV_multisample_filter_hint GL_NV_occlusion_query GL_NV_packed_depth_stencil GL_NV_parameter_buffer_object GL_NV_parameter_buffer_object2 GL_NV_path_rendering GL_NV_pixel_data_range GL_NV_point_sprite GL_NV_primitive_restart GL_NV_register_combiners GL_NV_register_combiners2 GL_NV_shader_atomic_counters GL_NV_shader_atomic_float GL_NV_shader_atomic_int64 GL_NV_shader_buffer_load GL_NV_shader_storage_buffer_object GL_NV_texgen_reflection GL_NV_texture_barrier GL_NV_texture_compression_vtc GL_NV_texture_env_combine4 GL_NV_texture_multisample GL_NV_texture_rectangle GL_NV_texture_shader GL_NV_texture_shader2 GL_NV_texture_shader3 GL_NV_transform_feedback GL_NV_transform_feedback2 GL_NV_uniform_buffer_unified_memory GL_NV_vdpau_interop GL_NV_vertex_array_range GL_NV_vertex_array_range2 GL_NV_vertex_attrib_integer_64bit GL_NV_vertex_buffer_unified_memory GL_NV_vertex_program GL_NV_vertex_program1_1 GL_NV_vertex_program2 GL_NV_vertex_program2_option GL_NV_vertex_program3 GL_NVX_conditional_render GL_NVX_gpu_memory_info GL_NVX_nvenc_interop GL_NV_shader_thread_group GL_NV_shader_thread_shuffle GL_KHR_blend_equation_advanced GL_SGIS_generate_mipmap GL_SGIS_texture_lod GL_SGIX_depth_texture GL_SGIX_shadow GL_SUN_slice_accum 17:33:05.536 T:140678365439744 NOTICE: Running database version Addons27 17:33:05.537 T:140678365439744 NOTICE: Running database version ViewModes6 17:33:05.538 T:140678365439744 NOTICE: Running database version Textures13 17:33:05.540 T:140678365439744 NOTICE: Running database version MyMusic60 17:33:05.542 T:140678365439744 NOTICE: Running database version MyVideos107 17:33:05.543 T:140678365439744 NOTICE: Running database version TV29 17:33:05.544 T:140678365439744 NOTICE: Running database version Epg11 17:33:05.545 T:140678954788864 NOTICE: start dvd mediatype detection 17:33:05.619 T:140678954788864 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 17:33:05.667 T:140678954788864 NOTICE: initialize done 17:33:05.667 T:140678954788864 NOTICE: Running the application... 17:33:05.669 T:140678954788864 NOTICE: starting zeroconf publishing 17:33:05.669 T:140678954788864 NOTICE: starting upnp client 17:33:05.672 T:140677115520768 NOTICE: ES: Starting UDP Event server on port 9777 17:33:05.672 T:140677115520768 NOTICE: UDP: Listening on port 9777 (ipv6 : false) 17:33:23.703 T:140677719676672 ERROR: GetDirectory - Error getting 17:33:47.916 T:140678954788864 ERROR: Previous line repeats 2 times. 17:33:47.916 T:140678954788864 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 17:33:47.916 T:140678954788864 NOTICE: Enabled debug logging due to GUI setting. Level 2. 17:33:47.917 T:140678954788864 DEBUG: ------ Window Init () ------ 17:33:52.619 T:140678954788864 DEBUG: LIRC: Update - NEW at 47816:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:33:52.619 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:33:53.279 T:140678954788864 DEBUG: LIRC: Update - NEW at 48476:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:33:53.279 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:33:53.726 T:140678365439744 DEBUG: Thread JobWorker 140678365439744 terminating (autodelete) 17:33:53.726 T:140677728069376 DEBUG: Thread JobWorker 140677728069376 terminating (autodelete) 17:33:53.730 T:140677719676672 DEBUG: Thread JobWorker 140677719676672 terminating (autodelete) 17:33:54.219 T:140678954788864 DEBUG: LIRC: Update - NEW at 49416:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:33:54.219 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:33:54.219 T:140678954788864 DEBUG: ------ Window Init (DialogSelect.xml) ------ 17:33:54.219 T:140678954788864 INFO: Loading skin file: DialogSelect.xml, load type: KEEP_IN_MEMORY 17:33:59.925 T:140678954788864 DEBUG: LIRC: Update - NEW at 55119:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:33:59.925 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:34:01.966 T:140678954788864 DEBUG: LIRC: Update - NEW at 57159:0000000080010067 00 KEY_UP devinput (KEY_UP) 17:34:01.966 T:140678954788864 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 17:34:03.026 T:140678954788864 DEBUG: LIRC: Update - NEW at 58219:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:03.026 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:03.567 T:140678954788864 DEBUG: LIRC: Update - NEW at 58759:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:34:03.567 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:34:04.607 T:140678954788864 DEBUG: LIRC: Update - NEW at 59799:0000000080010067 00 KEY_UP devinput (KEY_UP) 17:34:04.607 T:140678954788864 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 17:34:06.808 T:140678954788864 DEBUG: Previous line repeats 3 times. 17:34:06.808 T:140678954788864 DEBUG: LIRC: Update - NEW at 61999:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:06.808 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:08.789 T:140678954788864 DEBUG: Previous line repeats 3 times. 17:34:08.789 T:140678954788864 DEBUG: LIRC: Update - NEW at 63979:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:08.789 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:09.189 T:140678954788864 DEBUG: LIRC: Update - NEW at 64379:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:09.189 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:09.469 T:140678954788864 DEBUG: LIRC: Update - NEW at 64659:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:09.469 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:09.730 T:140678954788864 DEBUG: LIRC: Update - NEW at 64919:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:09.730 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:10.070 T:140678954788864 DEBUG: LIRC: Update - NEW at 65259:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:10.070 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:11.330 T:140678954788864 DEBUG: LIRC: Update - NEW at 66519:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:11.330 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:12.471 T:140678954788864 DEBUG: LIRC: Update - NEW at 67659:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:12.471 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:13.792 T:140678954788864 DEBUG: LIRC: Update - NEW at 68979:000000008001006a 00 KEY_RIGHT devinput (KEY_RIGHT) 17:34:13.792 T:140678954788864 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 17:34:14.432 T:140678954788864 DEBUG: LIRC: Update - NEW at 69619:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:34:14.432 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:34:15.492 T:140678954788864 DEBUG: LIRC: Update - NEW at 70679:000000008001006a 00 KEY_RIGHT devinput (KEY_RIGHT) 17:34:15.492 T:140678954788864 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 17:34:16.373 T:140678954788864 DEBUG: LIRC: Update - NEW at 71559:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:34:16.373 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:34:16.613 T:140678954788864 DEBUG: ------ Window Deinit (DialogSelect.xml) ------ 17:34:17.971 T:140678954788864 DEBUG: LIRC: Update - NEW at 73156:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:17.971 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:18.791 T:140678954788864 DEBUG: LIRC: Update - NEW at 73976:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:18.791 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:19.792 T:140678954788864 DEBUG: LIRC: Update - NEW at 74976:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:19.792 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:21.192 T:140678954788864 DEBUG: LIRC: Update - NEW at 76376:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:21.192 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:22.813 T:140678954788864 DEBUG: LIRC: Update - NEW at 77996:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:34:22.813 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:34:22.813 T:140678954788864 DEBUG: Activating window ID: 10050 17:34:23.113 T:140678954788864 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------ 17:34:23.135 T:140678954788864 DEBUG: ------ Window Init (EventLog.xml) ------ 17:34:23.135 T:140678954788864 INFO: Loading skin file: EventLog.xml, load type: KEEP_IN_MEMORY 17:34:23.141 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (events://) 17:34:23.141 T:140678954788864 DEBUG: ParentPath = [] 17:34:28.094 T:140678954788864 DEBUG: LIRC: Update - NEW at 83274:0000000080010069 00 KEY_LEFT devinput (KEY_LEFT) 17:34:28.094 T:140678954788864 DEBUG: OnKey: 169 (0xa9, obc86) pressed, action is Left 17:34:28.999 T:140678954788864 DEBUG: LIRC: Update - NEW at 84179:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:28.999 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:29.668 T:140678954788864 DEBUG: LIRC: Update - NEW at 84847:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:34:29.668 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:34:29.671 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (events://) 17:34:29.672 T:140678954788864 DEBUG: ParentPath = [] 17:34:29.672 T:140677728069376 DEBUG: Thread JobWorker start, auto delete: true 17:34:31.117 T:140678954788864 DEBUG: LIRC: Update - NEW at 86296:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:34:31.117 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:34:31.119 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (events://) 17:34:31.119 T:140678954788864 DEBUG: ParentPath = [events://] 17:34:31.998 T:140678954788864 DEBUG: LIRC: Update - NEW at 87176:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:34:31.998 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:34:31.999 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (events://) 17:34:31.999 T:140678954788864 DEBUG: ParentPath = [events://] 17:34:33.053 T:140678954788864 DEBUG: LIRC: Update - NEW at 88231:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:34:33.053 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:34:33.055 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (events://) 17:34:33.055 T:140678954788864 DEBUG: ParentPath = [events://] 17:34:34.412 T:140678954788864 DEBUG: LIRC: Update - NEW at 89589:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:34:34.412 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:34:34.414 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (events://) 17:34:34.414 T:140678954788864 DEBUG: ParentPath = [events://] 17:34:36.449 T:140678954788864 DEBUG: LIRC: Update - NEW at 91625:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:36.449 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:36.853 T:140678954788864 DEBUG: LIRC: Update - NEW at 92029:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:36.853 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:37.520 T:140678954788864 DEBUG: LIRC: Update - NEW at 92696:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:34:37.520 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:34:37.520 T:140678954788864 DEBUG: Activating window ID: 10016 17:34:37.820 T:140678954788864 DEBUG: ------ Window Deinit (EventLog.xml) ------ 17:34:37.840 T:140678954788864 DEBUG: ------ Window Init (SettingsCategory.xml) ------ 17:34:40.270 T:140678954788864 DEBUG: LIRC: Update - NEW at 95444:0000000080010067 00 KEY_UP devinput (KEY_UP) 17:34:40.270 T:140678954788864 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 17:34:41.629 T:140678954788864 DEBUG: LIRC: Update - NEW at 96802:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:34:41.629 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:34:43.306 T:140678954788864 DEBUG: LIRC: Update - NEW at 98478:000000008001006a 00 KEY_RIGHT devinput (KEY_RIGHT) 17:34:43.306 T:140678954788864 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 17:34:44.143 T:140678954788864 DEBUG: LIRC: Update - NEW at 99315:00000000800100ae 00 KEY_EXIT devinput (KEY_EXIT) 17:34:44.143 T:140678954788864 DEBUG: OnKey: menu (0xd8) pressed, action is PreviousMenu 17:34:44.147 T:140678954788864 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 17:34:44.444 T:140678954788864 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------ 17:34:44.463 T:140678954788864 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 17:34:44.464 T:140678954788864 DEBUG: ------ Window Init (AddonBrowser.xml) ------ 17:34:44.465 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (addons://user/kodi.inputstream) 17:34:44.465 T:140678954788864 DEBUG: ParentPath = [addons://user/kodi.inputstream] 17:34:44.472 T:140678954788864 DEBUG: CAddonMgr::GetAvailableUpdates took 5 ms 17:34:44.473 T:140678365439744 DEBUG: Thread BackgroundLoader start, auto delete: false 17:34:44.474 T:140678365439744 DEBUG: Thread BackgroundLoader 140678365439744 terminating 17:34:45.931 T:140678954788864 DEBUG: LIRC: Update - NEW at 101102:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:45.931 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:48.177 T:140678954788864 DEBUG: LIRC: Update - NEW at 103347:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:34:48.177 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:34:48.177 T:140678954788864 DEBUG: ------ Window Init (DialogAddonInfo.xml) ------ 17:34:48.177 T:140678954788864 INFO: Loading skin file: DialogAddonInfo.xml, load type: KEEP_IN_MEMORY 17:34:52.046 T:140678954788864 DEBUG: LIRC: Update - NEW at 107214:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:34:52.046 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:34:52.046 T:140678954788864 DEBUG: ------ Window Init (DialogAddonSettings.xml) ------ 17:34:52.046 T:140678954788864 INFO: Loading skin file: DialogAddonSettings.xml, load type: KEEP_IN_MEMORY 17:34:56.036 T:140678954788864 DEBUG: LIRC: Update - NEW at 111202:000000008001006a 00 KEY_RIGHT devinput (KEY_RIGHT) 17:34:56.036 T:140678954788864 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 17:34:56.933 T:140678954788864 DEBUG: LIRC: Update - NEW at 112099:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:56.933 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:57.593 T:140678954788864 DEBUG: LIRC: Update - NEW at 112759:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:57.593 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:58.094 T:140678954788864 DEBUG: LIRC: Update - NEW at 113259:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:34:58.094 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:34:59.074 T:140678954788864 DEBUG: LIRC: Update - NEW at 114239:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:34:59.074 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:00.335 T:140678954788864 DEBUG: LIRC: Update - NEW at 115499:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:00.335 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:01.515 T:140678954788864 DEBUG: LIRC: Update - NEW at 116679:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:01.515 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:02.736 T:140678954788864 DEBUG: LIRC: Update - NEW at 117899:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:35:02.736 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:35:03.236 T:140678954788864 DEBUG: LIRC: Update - NEW at 118399:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:03.236 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:04.257 T:140678954788864 DEBUG: LIRC: Update - NEW at 119419:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:04.257 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:04.897 T:140678954788864 DEBUG: LIRC: Update - NEW at 120059:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:04.897 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:08.259 T:140678954788864 DEBUG: LIRC: Update - NEW at 123418:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:35:08.259 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:35:12.901 T:140678954788864 DEBUG: LIRC: Update - NEW at 128058:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:12.901 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:12.903 T:140678954788864 INFO: Loading skin file: FileBrowser.xml, load type: KEEP_IN_MEMORY 17:35:12.908 T:140678954788864 DEBUG: ------ Window Init (FileBrowser.xml) ------ 17:35:14.424 T:140678954788864 DEBUG: LIRC: Update - NEW at 129581:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:35:14.424 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:35:15.952 T:140677728069376 DEBUG: Thread JobWorker 140677728069376 terminating (autodelete) 17:35:16.485 T:140678954788864 DEBUG: LIRC: Update - NEW at 131641:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:16.485 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:17.766 T:140678954788864 DEBUG: LIRC: Update - NEW at 132921:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:17.766 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:18.566 T:140678954788864 DEBUG: LIRC: Update - NEW at 133721:0000000080010067 00 KEY_UP devinput (KEY_UP) 17:35:18.566 T:140678954788864 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 17:35:19.106 T:140678954788864 DEBUG: LIRC: Update - NEW at 134261:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:19.106 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:20.287 T:140678954788864 DEBUG: LIRC: Update - NEW at 135441:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:35:20.287 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:35:21.027 T:140678954788864 DEBUG: LIRC: Update - NEW at 136181:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:21.027 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:23.168 T:140678954788864 DEBUG: LIRC: Update - NEW at 138321:000000008001006a 00 KEY_RIGHT devinput (KEY_RIGHT) 17:35:23.168 T:140678954788864 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 17:35:24.709 T:140678954788864 DEBUG: LIRC: Update - NEW at 139861:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:24.709 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:24.969 T:140678954788864 DEBUG: ------ Window Deinit (FileBrowser.xml) ------ 17:35:26.867 T:140678954788864 DEBUG: LIRC: Update - NEW at 142018:000000008001006a 00 KEY_RIGHT devinput (KEY_RIGHT) 17:35:26.867 T:140678954788864 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 17:35:28.738 T:140677702891264 DEBUG: CRepositoryUpdater: running scheduled update 17:35:28.739 T:140677702891264 DEBUG: Thread Timer 140677702891264 terminating 17:35:28.739 T:140677728069376 DEBUG: Thread JobWorker start, auto delete: true 17:35:28.739 T:140677728069376 DEBUG: CRepositoryUpdateJob[repository.xbmc.org] checking for updates. 17:35:28.739 T:140677728069376 DEBUG: CFileCache::Open - opening using cache 17:35:28.739 T:140677728069376 DEBUG: CurlFile::Open(0x7ff1f8001ca0) http://mirrors.kodi.tv/addons/krypton/addons.xml.gz.md5 17:35:28.739 T:140677728069376 INFO: easy_aquire - Created session to http://mirrors.kodi.tv 17:35:28.938 T:140677702891264 DEBUG: Thread FileCache start, auto delete: false 17:35:28.938 T:140677702891264 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 17:35:28.988 T:140677702891264 DEBUG: Thread FileCache 140677702891264 terminating 17:35:28.998 T:140677728069376 DEBUG: CRepositoryUpdateJob[repository.xbmc.org] checksum not changed. 17:35:28.998 T:140677728069376 DEBUG: CRepositoryUpdateJob[repository.kodinerds_Generic_x68_64] checking for updates. 17:35:28.998 T:140677728069376 DEBUG: CFileCache::Open - opening using cache 17:35:28.998 T:140677728069376 DEBUG: CurlFile::Open(0x7ff1f8007d10) https://raw.githubusercontent.com/kodinerds/binary-repo/master/Generic_x68_64/addons.xml.md5 17:35:28.999 T:140677728069376 INFO: easy_aquire - Created session to https://raw.githubusercontent.com 17:35:29.230 T:140677702891264 DEBUG: Thread FileCache start, auto delete: false 17:35:29.230 T:140677702891264 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 17:35:29.280 T:140677702891264 DEBUG: Thread FileCache 140677702891264 terminating 17:35:29.286 T:140677728069376 DEBUG: CRepositoryUpdateJob[repository.kodinerds_Generic_x68_64] checksum not changed. 17:35:29.286 T:140677728069376 DEBUG: CRepositoryUpdateJob[repository.kodinerds] checking for updates. 17:35:29.287 T:140677728069376 DEBUG: CFileCache::Open - opening using cache 17:35:29.287 T:140677728069376 DEBUG: CurlFile::Open(0x7ff1f8002cf0) https://raw.githubusercontent.com/kodinerds/repo/master/addons.xml.md5 17:35:29.319 T:140677702891264 DEBUG: Thread FileCache start, auto delete: false 17:35:29.319 T:140677702891264 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 17:35:29.369 T:140677702891264 DEBUG: Thread FileCache 140677702891264 terminating 17:35:29.369 T:140677728069376 DEBUG: CurlFile::Open(0x7ff2160258d0) https://raw.githubusercontent.com/kodinerds/repo/master/addons.xml 17:35:29.496 T:140677728069376 DEBUG: CRepository: invalidating cached art for 'plugin.video.eurosportplayer' 17:35:29.568 T:140677728069376 DEBUG: CRepositoryUpdateJob[repository.sandmann79.plugins] checking for updates. 17:35:29.568 T:140677728069376 DEBUG: CFileCache::Open - opening using cache 17:35:29.568 T:140677728069376 DEBUG: CurlFile::Open(0x7ff1f808b8e0) https://raw.githubusercontent.com/Sandmann79/xbmc/master/packages/addons.xml.md5 17:35:29.600 T:140677702891264 DEBUG: Thread FileCache start, auto delete: false 17:35:29.601 T:140677702891264 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 17:35:29.651 T:140677702891264 DEBUG: Thread FileCache 140677702891264 terminating 17:35:29.651 T:140677728069376 DEBUG: CurlFile::Open(0x7ff2160258d0) https://raw.githubusercontent.com/Sandmann79/xbmc/master/packages/addons.xml 17:35:29.690 T:140677728069376 DEBUG: CRepository: invalidating cached art for 'plugin.video.amazon' 17:35:29.690 T:140677728069376 DEBUG: CRepository: invalidating cached art for 'plugin.video.amazon-test' 17:35:29.741 T:140677728069376 DEBUG: CRepositoryUpdater: done. 17:35:29.746 T:140677728069376 DEBUG: CAddonMgr::GetAvailableUpdates took 5 ms 17:35:29.750 T:140677728069376 DEBUG: CAddonMgr::GetAvailableUpdates took 4 ms 17:35:29.752 T:140677728069376 DEBUG: CRepositoryUpdater: previous update at 09/03/2017 5:35:28 PM, next at 09/04/2017 5:35:28 PM 17:35:29.752 T:140677702891264 DEBUG: Thread Timer start, auto delete: false 17:35:29.752 T:140678365439744 DEBUG: Thread JobWorker start, auto delete: true 17:35:29.770 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (addons://user/kodi.inputstream) 17:35:29.770 T:140678954788864 DEBUG: ParentPath = [addons://user/kodi.inputstream] 17:35:29.777 T:140677728069376 DEBUG: CAddonMgr::GetAvailableUpdates took 5 ms 17:35:29.778 T:140677719676672 DEBUG: Thread BackgroundLoader start, auto delete: false 17:35:29.778 T:140677719676672 DEBUG: Thread BackgroundLoader 140677719676672 terminating 17:35:30.169 T:140678954788864 DEBUG: LIRC: Update - NEW at 145318:0000000080010069 00 KEY_LEFT devinput (KEY_LEFT) 17:35:30.169 T:140678954788864 DEBUG: OnKey: 169 (0xa9, obc86) pressed, action is Left 17:35:30.729 T:140678954788864 DEBUG: LIRC: Update - NEW at 145878:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:35:30.729 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:35:31.650 T:140678954788864 DEBUG: LIRC: Update - NEW at 146798:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:35:31.650 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:35:32.230 T:140678954788864 DEBUG: LIRC: Update - NEW at 147378:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:35:32.230 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:35:32.870 T:140678954788864 DEBUG: LIRC: Update - NEW at 148018:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:32.870 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:33.811 T:140678954788864 DEBUG: LIRC: Update - NEW at 148958:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:33.811 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:35.832 T:140678954788864 DEBUG: LIRC: Update - NEW at 150978:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:35.832 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:36.272 T:140678954788864 DEBUG: LIRC: Update - NEW at 151418:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:36.272 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:36.952 T:140678954788864 DEBUG: LIRC: Update - NEW at 152098:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:36.952 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:37.332 T:140678954788864 DEBUG: LIRC: Update - NEW at 152478:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:37.332 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:39.313 T:140678954788864 DEBUG: LIRC: Update - NEW at 154458:000000008001006a 00 KEY_RIGHT devinput (KEY_RIGHT) 17:35:39.313 T:140678954788864 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 17:35:40.654 T:140678954788864 DEBUG: LIRC: Update - NEW at 155798:000000008001006a 00 KEY_RIGHT devinput (KEY_RIGHT) 17:35:40.654 T:140678954788864 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 17:35:42.275 T:140678954788864 DEBUG: LIRC: Update - NEW at 157418:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:42.275 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:42.275 T:140678954788864 DEBUG: ADDON: Dll Initializing - InputStream Adaptive 17:35:42.275 T:140678954788864 DEBUG: SECTION:LoadDLL(/var/lib/vdr/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.1.0.8) 17:35:42.275 T:140678954788864 DEBUG: Loading: /var/lib/vdr/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.1.0.8 17:35:42.280 T:140678954788864 DEBUG: AddOnLog: InputStream Adaptive: libXBMC_addon successfully loaded 17:35:42.280 T:140678954788864 DEBUG: AddOnLog: InputStream Adaptive: ADDON_Create() 17:35:42.280 T:140678954788864 DEBUG: AddOnLog: InputStream Adaptive: ADDON_Destroy() 17:35:42.280 T:140678954788864 DEBUG: SECTION:UnloadDll(/var/lib/vdr/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.1.0.8) 17:35:42.280 T:140678954788864 INFO: ADDON: Dll Destroyed - InputStream Adaptive 17:35:42.515 T:140678954788864 DEBUG: ------ Window Deinit (DialogAddonSettings.xml) ------ 17:35:44.835 T:140678954788864 DEBUG: LIRC: Update - NEW at 159977:00000000800100ae 00 KEY_EXIT devinput (KEY_EXIT) 17:35:44.835 T:140678954788864 DEBUG: OnKey: menu (0xd8) pressed, action is Close 17:35:45.134 T:140678954788864 DEBUG: ------ Window Deinit (DialogAddonInfo.xml) ------ 17:35:47.560 T:140678954788864 DEBUG: LIRC: Update - NEW at 162701:00000000800100ae 00 KEY_EXIT devinput (KEY_EXIT) 17:35:47.560 T:140678954788864 DEBUG: OnKey: menu (0xd8) pressed, action is Back 17:35:47.561 T:140678954788864 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 17:35:47.874 T:140678954788864 DEBUG: ------ Window Deinit (AddonBrowser.xml) ------ 17:35:47.893 T:140678954788864 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 17:35:47.893 T:140678954788864 DEBUG: ------ Window Init (Custom_1100_AddonLauncher.xml) ------ 17:35:51.799 T:140678954788864 DEBUG: LIRC: Update - NEW at 166938:00000000800100ae 00 KEY_EXIT devinput (KEY_EXIT) 17:35:51.799 T:140678954788864 DEBUG: OnKey: menu (0xd8) pressed, action is Back 17:35:51.799 T:140678954788864 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 17:35:52.097 T:140678954788864 DEBUG: ------ Window Deinit (Custom_1100_AddonLauncher.xml) ------ 17:35:52.116 T:140678954788864 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 17:35:52.116 T:140678954788864 DEBUG: ------ Window Init (Home.xml) ------ 17:35:53.251 T:140678954788864 DEBUG: LIRC: Update - NEW at 168389:000000008001006a 00 KEY_RIGHT devinput (KEY_RIGHT) 17:35:53.251 T:140678954788864 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 17:35:53.860 T:140678954788864 DEBUG: LIRC: Update - NEW at 168997:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:35:53.860 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:35:54.517 T:140678954788864 DEBUG: LIRC: Update - NEW at 169654:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:54.517 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:54.517 T:140678954788864 DEBUG: Activating window ID: 10025 17:35:54.818 T:140678954788864 DEBUG: ------ Window Deinit (Home.xml) ------ 17:35:54.840 T:140678954788864 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 17:35:54.840 T:140678954788864 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 17:35:54.871 T:140678954788864 DEBUG: CDirectoryProvider[]: refreshing.. 17:35:54.872 T:140677719676672 DEBUG: Previous line repeats 6 times. 17:35:54.872 T:140677719676672 DEBUG: Thread JobWorker start, auto delete: true 17:35:54.872 T:140677728069376 ERROR: GetDirectory - Error getting 17:35:54.877 T:140678954788864 ERROR: Previous line repeats 6 times. 17:35:54.877 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/) 17:35:54.877 T:140678954788864 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 17:35:54.891 T:140678365439744 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 14 ms 17:35:54.891 T:140677728069376 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','1','') 17:35:54.891 T:140677736462080 DEBUG: Thread LanguageInvoker start, auto delete: false 17:35:54.891 T:140677736462080 INFO: initializing python engine. 17:35:54.891 T:140677736462080 DEBUG: CPythonInvoker(2, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): start processing 17:35:54.922 T:140677736462080 DEBUG: -->Python Interpreter Initialized<-- 17:35:54.922 T:140677736462080 DEBUG: CPythonInvoker(2, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py" 17:35:54.922 T:140677736462080 DEBUG: CPythonInvoker(2, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /var/lib/vdr/.kodi/addons/plugin.video.skygo.de:/var/lib/vdr/.kodi/addons/script.common.plugin.cache/lib:/var/lib/vdr/.kodi/addons/script.module.cryptopy/lib:/var/lib/vdr/.kodi/addons/script.module.pydes/lib:/var/lib/vdr/.kodi/addons/script.module.requests/lib:/var/lib/vdr/.kodi/addons/script.module.routing/lib:/usr/lib/python2.7:/usr/lib/python2.7/plat-x86_64-linux-gnu:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat:/usr/lib/python2.7/dist-packages/gtk-2.0:/usr/lib/python2.7/dist-packages/ubuntu-sso-client 17:35:54.922 T:140677736462080 DEBUG: CPythonInvoker(2, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /var/lib/vdr/.kodi/addons/plugin.video.skygo.de 17:35:54.922 T:140677736462080 DEBUG: CPythonInvoker(2, /var/lib/vdr/.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 17:35:55.160 T:140677736462080 DEBUG: false 17:35:55.378 T:140678954788864 DEBUG: ------ Window Init (DialogBusy.xml) ------ 17:35:55.415 T:140677736462080 DEBUG: ['plugin://plugin.video.skygo.de/', '1', ''] 17:35:55.613 T:140677736462080 INFO: CPythonInvoker(2, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 17:35:55.621 T:140676736804608 DEBUG: Thread BackgroundLoader start, auto delete: false 17:35:55.623 T:140677736462080 INFO: Python script stopped 17:35:55.623 T:140677736462080 DEBUG: Thread LanguageInvoker 140677736462080 terminating 17:35:55.624 T:140676736804608 DEBUG: Thread BackgroundLoader 140676736804608 terminating 17:35:55.840 T:140678954788864 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 17:35:57.078 T:140678954788864 DEBUG: LIRC: Update - NEW at 172214:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:35:57.078 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:35:57.859 T:140678954788864 DEBUG: LIRC: Update - NEW at 172994:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:35:57.859 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:35:57.859 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listLiveTvChannelDirs) 17:35:57.859 T:140678954788864 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 17:35:57.864 T:140678365439744 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 5 ms 17:35:57.864 T:140677728069376 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','2','?action=listLiveTvChannelDirs') 17:35:57.864 T:140676736804608 DEBUG: Thread LanguageInvoker start, auto delete: false 17:35:57.864 T:140676736804608 INFO: initializing python engine. 17:35:57.864 T:140676736804608 DEBUG: CPythonInvoker(3, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): start processing 17:35:57.896 T:140676736804608 DEBUG: -->Python Interpreter Initialized<-- 17:35:57.896 T:140676736804608 DEBUG: CPythonInvoker(3, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py" 17:35:57.896 T:140676736804608 DEBUG: CPythonInvoker(3, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /var/lib/vdr/.kodi/addons/plugin.video.skygo.de:/var/lib/vdr/.kodi/addons/script.common.plugin.cache/lib:/var/lib/vdr/.kodi/addons/script.module.cryptopy/lib:/var/lib/vdr/.kodi/addons/script.module.pydes/lib:/var/lib/vdr/.kodi/addons/script.module.requests/lib:/var/lib/vdr/.kodi/addons/script.module.routing/lib:/usr/lib/python2.7:/usr/lib/python2.7/plat-x86_64-linux-gnu:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat:/usr/lib/python2.7/dist-packages/gtk-2.0:/usr/lib/python2.7/dist-packages/ubuntu-sso-client 17:35:57.896 T:140676736804608 DEBUG: CPythonInvoker(3, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /var/lib/vdr/.kodi/addons/plugin.video.skygo.de 17:35:57.896 T:140676736804608 DEBUG: CPythonInvoker(3, /var/lib/vdr/.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 17:35:58.096 T:140676736804608 DEBUG: false 17:35:58.359 T:140678954788864 DEBUG: ------ Window Init (DialogBusy.xml) ------ 17:35:58.394 T:140676736804608 DEBUG: {'action': 'listLiveTvChannelDirs'} 17:35:58.428 T:140676736804608 ERROR: /var/lib/vdr/.kodi/addons/script.module.requests/lib/requests/packages/urllib3/util/ssl_.py:334: SNIMissingWarning: An HTTPS request has been made, but the SNI (Subject Name Indication) extension to TLS is not available on this platform. This may cause the server to present an incorrect TLS certificate, which can cause validation failures. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings SNIMissingWarning 17:35:58.428 T:140676736804608 ERROR: /var/lib/vdr/.kodi/addons/script.module.requests/lib/requests/packages/urllib3/util/ssl_.py:132: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings InsecurePlatformWarning 17:35:58.748 T:140676736804608 INFO: CPythonInvoker(3, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 17:35:58.760 T:140676736804608 INFO: Python script stopped 17:35:58.760 T:140676736804608 DEBUG: Thread LanguageInvoker 140676736804608 terminating 17:35:58.762 T:140676736804608 DEBUG: Thread BackgroundLoader start, auto delete: false 17:35:58.764 T:140676736804608 DEBUG: Thread BackgroundLoader 140676736804608 terminating 17:35:59.142 T:140678954788864 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 17:35:59.399 T:140678954788864 INFO: CheckIdle - Closing session to http://mirrors.kodi.tv (easy=0x7ff1f801df00, multi=0x7ff1f80016b0) 17:35:59.860 T:140678954788864 DEBUG: LIRC: Update - NEW at 174994:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:35:59.860 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:35:59.920 T:140678954788864 INFO: CheckIdle - Closing session to https://raw.githubusercontent.com (easy=0x7ff1f803c8d0, multi=0x7ff1f801de30) 17:36:00.540 T:140678954788864 DEBUG: LIRC: Update - NEW at 175674:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:36:00.540 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:36:01.000 T:140678954788864 DEBUG: LIRC: Update - NEW at 176134:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:36:01.000 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:36:02.101 T:140678954788864 DEBUG: LIRC: Update - NEW at 177234:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:36:02.101 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:36:02.641 T:140678954788864 DEBUG: LIRC: Update - NEW at 177774:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:36:02.641 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:36:02.641 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listLiveTvChannels&channeldir_name=sport) 17:36:02.641 T:140678954788864 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/?action=listLiveTvChannelDirs] 17:36:02.648 T:140677719676672 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 6 ms 17:36:02.648 T:140678365439744 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','3','?action=listLiveTvChannels&channeldir_name=sport') 17:36:02.648 T:140676736804608 DEBUG: Thread LanguageInvoker start, auto delete: false 17:36:02.648 T:140676736804608 INFO: initializing python engine. 17:36:02.648 T:140676736804608 DEBUG: CPythonInvoker(4, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): start processing 17:36:02.683 T:140676736804608 DEBUG: -->Python Interpreter Initialized<-- 17:36:02.683 T:140676736804608 DEBUG: CPythonInvoker(4, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py" 17:36:02.683 T:140676736804608 DEBUG: CPythonInvoker(4, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /var/lib/vdr/.kodi/addons/plugin.video.skygo.de:/var/lib/vdr/.kodi/addons/script.common.plugin.cache/lib:/var/lib/vdr/.kodi/addons/script.module.cryptopy/lib:/var/lib/vdr/.kodi/addons/script.module.pydes/lib:/var/lib/vdr/.kodi/addons/script.module.requests/lib:/var/lib/vdr/.kodi/addons/script.module.routing/lib:/usr/lib/python2.7:/usr/lib/python2.7/plat-x86_64-linux-gnu:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat:/usr/lib/python2.7/dist-packages/gtk-2.0:/usr/lib/python2.7/dist-packages/ubuntu-sso-client 17:36:02.683 T:140676736804608 DEBUG: CPythonInvoker(4, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /var/lib/vdr/.kodi/addons/plugin.video.skygo.de 17:36:02.683 T:140676736804608 DEBUG: CPythonInvoker(4, /var/lib/vdr/.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 17:36:02.881 T:140676736804608 DEBUG: false 17:36:03.142 T:140678954788864 DEBUG: ------ Window Init (DialogBusy.xml) ------ 17:36:03.184 T:140676736804608 DEBUG: {'action': 'listLiveTvChannels', 'channeldir_name': 'sport'} 17:36:03.216 T:140676736804608 ERROR: /var/lib/vdr/.kodi/addons/script.module.requests/lib/requests/packages/urllib3/util/ssl_.py:334: SNIMissingWarning: An HTTPS request has been made, but the SNI (Subject Name Indication) extension to TLS is not available on this platform. This may cause the server to present an incorrect TLS certificate, which can cause validation failures. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings SNIMissingWarning 17:36:03.216 T:140676736804608 ERROR: /var/lib/vdr/.kodi/addons/script.module.requests/lib/requests/packages/urllib3/util/ssl_.py:132: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings InsecurePlatformWarning 17:36:03.785 T:140676736804608 ERROR: Previous line repeats 2 times. 17:36:03.785 T:140676736804608 INFO: CPythonInvoker(4, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 17:36:03.799 T:140676736804608 INFO: Python script stopped 17:36:03.799 T:140676736804608 DEBUG: Thread LanguageInvoker 140676736804608 terminating 17:36:03.804 T:140678954788864 DEBUG: Saving fileitems [plugin://plugin.video.skygo.de/?action=listLiveTvChannels&channeldir_name=sport] 17:36:03.804 T:140678954788864 DEBUG: -- items: 4, sort method: 0, ascending: false 17:36:03.805 T:140678954788864 DEBUG: RunQuery took 1 ms for 5 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=1 17:36:03.806 T:140676736804608 DEBUG: Thread BackgroundLoader start, auto delete: false 17:36:03.809 T:140676736804608 DEBUG: Thread BackgroundLoader 140676736804608 terminating 17:36:04.044 T:140678954788864 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 17:36:05.062 T:140678954788864 DEBUG: LIRC: Update - NEW at 180194:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:36:05.062 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:36:05.063 T:140677728069376 INFO: easy_aquire - Created session to https://www.skygo.sky.de 17:36:05.233 T:140677728069376 DEBUG: CCurlFile::GetMimeType - https://www.skygo.sky.de/sg/bin/EPGEvent/ipad/event_3490967.png -> image/png 17:36:05.233 T:140677728069376 DEBUG: CurlFile::Open(0x7ff1f81e25d0) https://www.skygo.sky.de/sg/bin/EPGEvent/ipad/event_3490967.png 17:36:05.573 T:140677728069376 DEBUG: Caching image 'https://www.skygo.sky.de/sg/bin/EPGEvent/ipad/event_3490967.png' to '9/96f91be3.jpg': 17:36:05.573 T:140677728069376 DEBUG: cached image 'special://masterprofile/Thumbnails/9/96f91be3.jpg' size 404x227 17:36:07.707 T:140678954788864 DEBUG: LIRC: Update - NEW at 182838:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:36:07.707 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:36:07.710 T:140678954788864 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242820_242821%2Fsporth01.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Formel+1%3A+Gro%5Cxdfer+Preis+von+Italien+Rennen+in+Monza%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+1+HD+%7C+%5B%2FCOLOR%5DFormel+1%3A+Gro%5Cxdfer+Preis+von+Italien+Rennen+in+Monza%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+0%2C+%27genre%27%3A+%27%27%7D 17:36:07.710 T:140678954788864 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','4','?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242820_242821%2Fsporth01.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Formel+1%3A+Gro%5Cxdfer+Preis+von+Italien+Rennen+in+Monza%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+1+HD+%7C+%5B%2FCOLOR%5DFormel+1%3A+Gro%5Cxdfer+Preis+von+Italien+Rennen+in+Monza%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+0%2C+%27genre%27%3A+%27%27%7D') 17:36:07.711 T:140676736804608 DEBUG: Thread LanguageInvoker start, auto delete: false 17:36:07.711 T:140676736804608 INFO: initializing python engine. 17:36:07.711 T:140676736804608 DEBUG: CPythonInvoker(5, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): start processing 17:36:07.712 T:140678526461696 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 17:36:07.712 T:140678526461696 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 17:36:07.730 T:140677736462080 DEBUG: Thread scriptobs start, auto delete: false 17:36:07.742 T:140676736804608 DEBUG: -->Python Interpreter Initialized<-- 17:36:07.742 T:140676736804608 DEBUG: CPythonInvoker(5, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py" 17:36:07.742 T:140676736804608 DEBUG: CPythonInvoker(5, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /var/lib/vdr/.kodi/addons/plugin.video.skygo.de:/var/lib/vdr/.kodi/addons/script.common.plugin.cache/lib:/var/lib/vdr/.kodi/addons/script.module.cryptopy/lib:/var/lib/vdr/.kodi/addons/script.module.pydes/lib:/var/lib/vdr/.kodi/addons/script.module.requests/lib:/var/lib/vdr/.kodi/addons/script.module.routing/lib:/usr/lib/python2.7:/usr/lib/python2.7/plat-x86_64-linux-gnu:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat:/usr/lib/python2.7/dist-packages/gtk-2.0:/usr/lib/python2.7/dist-packages/ubuntu-sso-client 17:36:07.742 T:140676736804608 DEBUG: CPythonInvoker(5, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /var/lib/vdr/.kodi/addons/plugin.video.skygo.de 17:36:07.742 T:140676736804608 DEBUG: CPythonInvoker(5, /var/lib/vdr/.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 17:36:07.930 T:140678954788864 DEBUG: ------ Window Init (DialogBusy.xml) ------ 17:36:07.941 T:140676736804608 DEBUG: false 17:36:07.973 T:140676736804608 DEBUG: {'action': 'playLive', 'manifest_url': 'http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest', 'parental_rating': '0', 'infolabels': "{'plot': u'Formel 1: Gro\\xdfer Preis von Italien Rennen in Monza', 'title': u'[COLOR blue]Sky Sport 1 HD | [/COLOR]Formel 1: Gro\\xdfer Preis von Italien Rennen in Monza', 'originaltitle': '', 'cast': [], 'duration': 0, 'genre': ''}", 'package_code': 'OSPS'} 17:36:08.006 T:140676736804608 ERROR: /var/lib/vdr/.kodi/addons/script.module.requests/lib/requests/packages/urllib3/util/ssl_.py:334: SNIMissingWarning: An HTTPS request has been made, but the SNI (Subject Name Indication) extension to TLS is not available on this platform. This may cause the server to present an incorrect TLS certificate, which can cause validation failures. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings SNIMissingWarning 17:36:08.006 T:140676736804608 ERROR: /var/lib/vdr/.kodi/addons/script.module.requests/lib/requests/packages/urllib3/util/ssl_.py:132: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings InsecurePlatformWarning 17:36:08.159 T:140676736804608 DEBUG: {u'resultCode': u'S_218', u'resultMessage': u'KO'} 17:36:08.159 T:140676736804608 DEBUG: User not logged in or Session on other device 17:36:08.159 T:140676736804608 DEBUG: Session invalid - Customer Code not found in SilkCache 17:36:08.279 T:140676736804608 DEBUG: {u'gender': u'F', u'tcFlag': u'Y', u'mktgFlag': u'Y', u'firstName': u'WIEBKE', u'country': u'DE', u'age': u'31', u'extraCustFlag': u'N', u'resultMessage': u'OK', u'birthDate': u'1986/01/20', u'privacyFlag': u'Y', u'resultCode': u'T_100', u'customerCode': u'5751652417', u'flagTEF': u'N', u'cableSubFlag': u'Y', u'skygoSessionId': u'SG-b22e8a52-6b88-4cc9-a428-504d0bf9ba8a', u'lastName': u'SCHEEL', u'entitlements': [u'KIDS', u'OOSP', u'OOSW', u'OSPS'], u'bookmarkFlag': u'Y', u'accountCreated': u'2017/09/02', u'presentation': u'FRAU', u'email': u'wiebke.scheel@gmx.de'} 17:36:08.353 T:140676736804608 DEBUG: {u'tcFlag': u'Y', u'birthDate': u'1986/01/20', u'email': u'wiebke.scheel@gmx.de', u'customerCode': u'5751652417', u'resultCode': u'S_100', u'privacyFlag': u'Y', u'extraCustFlag': u'N', u'bookmarkFlag': u'Y', u'skygoSessionId': u'SG-b22e8a52-6b88-4cc9-a428-504d0bf9ba8a', u'entitlements': [u'KIDS', u'OOSP', u'OOSW', u'OSPS'], u'presentation': u'FRAU', u'cableSubFlag': u'Y', u'flagTEF': u'N', u'doubleOptInFlag': u'Y', u'mktgFlag': u'Y', u'firstName': u'WIEBKE', u'gender': u'F', u'age': u'31', u'lastName': u'SCHEEL', u'resultMessage': u'OK', u'accountCreated': u'2017/09/02', u'country': u'DE'} 17:36:08.353 T:140676736804608 DEBUG: User still logged in 17:36:08.368 T:140676736804608 INFO: CPythonInvoker(5, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 17:36:08.385 T:140676736804608 INFO: Python script stopped 17:36:08.385 T:140676736804608 DEBUG: Thread LanguageInvoker 140676736804608 terminating 17:36:08.387 T:140677736462080 DEBUG: Thread scriptobs 140677736462080 terminating 17:36:08.387 T:140678954788864 INFO: easy_aquire - Created session to http://livemss1it-s.akamaihd.net 17:36:08.506 T:140678954788864 DEBUG: CCurlFile::GetMimeType - http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest -> text/xml 17:36:08.508 T:140678954788864 DEBUG: Loading settings for http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest 17:36:08.509 T:140678954788864 DEBUG: CPlayerCoreFactory::GetPlayers(http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest) 17:36:08.509 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 17:36:08.509 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 17:36:08.509 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 17:36:08.509 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 17:36:08.509 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 17:36:08.509 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 17:36:08.509 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 17:36:08.509 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams 17:36:08.509 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp 17:36:08.509 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2 17:36:08.509 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 17:36:08.509 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 17:36:08.509 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 17:36:08.509 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 17:36:08.509 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 17:36:08.509 T:140678954788864 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 17:36:08.509 T:140678954788864 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 17:36:08.509 T:140678954788864 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 17:36:08.509 T:140678954788864 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 17:36:08.509 T:140678954788864 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 17:36:08.510 T:140678954788864 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 17:36:08.510 T:140678954788864 NOTICE: VideoPlayer: Opening: http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest 17:36:08.510 T:140678954788864 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 17:36:08.534 T:140678954788864 DEBUG: CCurlFile::GetMimeType - http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest -> text/xml 17:36:08.534 T:140678954788864 DEBUG: LinuxRendererGL: Cleaning up GL resources 17:36:08.535 T:140678954788864 DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16 17:36:08.535 T:140677736462080 DEBUG: Thread VideoPlayer start, auto delete: false 17:36:08.535 T:140677736462080 NOTICE: Creating InputStream 17:36:08.535 T:140677736462080 DEBUG: ADDON: Dll Initializing - InputStream Adaptive 17:36:08.535 T:140677736462080 DEBUG: SECTION:LoadDLL(/var/lib/vdr/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.1.0.8) 17:36:08.535 T:140677736462080 DEBUG: Loading: /var/lib/vdr/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.1.0.8 17:36:08.540 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: libXBMC_addon successfully loaded 17:36:08.540 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: ADDON_Create() 17:36:08.540 T:140677736462080 INFO: AddOnLog: InputStream Adaptive: SetVideoResolution (1920 x 1080) 17:36:08.541 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Open() 17:36:08.541 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_data: [not shown] 17:36:08.541 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_key: [not shown] 17:36:08.541 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_type: com.widevine.alpha 17:36:08.541 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.manifest_type: ism 17:36:08.541 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Initial bandwidth: 4000000 17:36:08.541 T:140677736462080 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream Adaptive' requests setting 'MAXRESOLUTION' 17:36:08.541 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: MAXRESOLUTION selected: 0 17:36:08.541 T:140677736462080 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream Adaptive' requests setting 'STREAMSELECTION' 17:36:08.541 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: STREAMSELECTION selected: 1 17:36:08.541 T:140677736462080 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream Adaptive' requests setting 'MEDIATYPE' 17:36:08.541 T:140677736462080 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream Adaptive' requests setting 'DECRYPTERPATH' 17:36:08.541 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Searching for decrypters in: /var/lib/vdr/.kodi/cdm/ 17:36:08.548 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Found decrypter: /var/lib/vdr/.kodi/cdm/libssd_wv.so 17:36:08.548 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Supported URN: urn:uuid:EDEF8BA9-79D6-4ACE-A3C8-27DCD51D21ED 17:36:08.548 T:140677736462080 DEBUG: CurlFile::Open(0x7ff2082e8200) http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest 17:36:08.708 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest finished 17:36:08.708 T:140677736462080 INFO: AddOnLog: InputStream Adaptive: Successfully parsed .mpd file. #Streams: 2 Download speed: 0.0000 Bytes/s 17:36:08.708 T:140677736462080 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream Adaptive' requests setting 'MINBANDWIDTH' 17:36:08.708 T:140677736462080 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream Adaptive' requests setting 'MAXBANDWIDTH' 17:36:08.727 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 1 arrived! 17:36:08.727 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Content-Type: ' 17:36:08.727 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Expect: ' 17:36:08.727 T:140677736462080 DEBUG: CurlFile::Open(0x7ff2080876d0) https://wvguard.sky.de/WidevineLicenser/WidevineLicenser 17:36:08.727 T:140677736462080 INFO: easy_aquire - Created session to https://wvguard.sky.de 17:36:09.036 T:140678954788864 DEBUG: ------ Window Init (DialogBusy.xml) ------ 17:36:09.193 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 1 arrived! 17:36:09.193 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Content-Type: ' 17:36:09.193 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Expect: ' 17:36:09.193 T:140677736462080 DEBUG: CurlFile::Open(0x7ff2082793a0) https://wvguard.sky.de/WidevineLicenser/WidevineLicenser 17:36:09.496 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 2 arrived! 17:36:09.496 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 3 arrived! 17:36:09.496 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: License update successful 17:36:09.496 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetCapabilities() 17:36:09.496 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStreamIds() 17:36:09.496 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(1) 17:36:09.496 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(2) 17:36:09.496 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(3) 17:36:09.496 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(4) 17:36:09.496 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(5) 17:36:09.496 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(6) 17:36:09.496 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(7) 17:36:09.496 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(8) 17:36:09.496 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(9) 17:36:09.496 T:140677736462080 NOTICE: Creating Demuxer 17:36:09.496 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 1 with codec_id 28 17:36:09.496 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 2 with codec_id 28 17:36:09.496 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 3 with codec_id 28 17:36:09.496 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 4 with codec_id 28 17:36:09.496 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 5 with codec_id 28 17:36:09.496 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 6 with codec_id 28 17:36:09.496 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 7 with codec_id 28 17:36:09.496 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 8 with codec_id 86018 17:36:09.496 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 9 with codec_id 86018 17:36:09.496 T:140677736462080 NOTICE: Opening stream: 1 source: 256 17:36:09.496 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(1: true) 17:36:09.496 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Selecting stream with conditions: w: 1920, h: 1080, bw: 3600000 17:36:09.497 T:140677736462080 NOTICE: Creating video codec with codec id: 28 17:36:09.497 T:140677736462080 DEBUG: FactoryCodec - Video: - Opening 17:36:09.497 T:140677736462080 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 17:36:09.499 T:140677736462080 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264 17:36:09.499 T:140677736462080 DEBUG: FactoryCodec - Video: ff-h264 - Opened 17:36:09.499 T:140677736462080 DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 28 17:36:09.499 T:140677736462080 NOTICE: Creating video thread 17:36:09.499 T:140677736462080 NOTICE: Opening stream: 8 source: 256 17:36:09.499 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(8: true) 17:36:09.499 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Selecting stream with conditions: w: 0, h: 0, bw: 400000 17:36:09.499 T:140676736804608 DEBUG: Thread VideoPlayerVideo start, auto delete: false 17:36:09.499 T:140676736804608 NOTICE: running thread: video_thread 17:36:09.499 T:140677736462080 NOTICE: Finding audio codec for: 86018 17:36:09.499 T:140677736462080 DEBUG: FactoryCodec - Audio: passthrough - Opening 17:36:09.499 T:140677736462080 DEBUG: FactoryCodec - Audio: passthrough - Failed 17:36:09.499 T:140677736462080 DEBUG: FactoryCodec - Audio: FFmpeg - Opening 17:36:09.502 T:140677736462080 DEBUG: FactoryCodec - Audio: FFmpeg - Opened 17:36:09.502 T:140677736462080 NOTICE: Creating audio thread 17:36:09.502 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(2: false) 17:36:09.502 T:140676698240768 DEBUG: Thread VideoPlayerAudio start, auto delete: false 17:36:09.502 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(3: false) 17:36:09.502 T:140676698240768 NOTICE: running thread: CVideoPlayerAudio::Process() 17:36:09.502 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(4: false) 17:36:09.502 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(5: false) 17:36:09.502 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(6: false) 17:36:09.502 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(7: false) 17:36:09.502 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(9: false) 17:36:09.502 T:140677736462080 DEBUG: OnPlayBackStarted: play state was 1, starting 1 17:36:09.502 T:140677736462080 DEBUG: CVideoPlayer::SetCaching - caching state 2 17:36:09.502 T:140677736462080 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 17:36:09.502 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Connection: keep-alive' 17:36:09.502 T:140677736462080 DEBUG: CurlFile::Open(0x7ff208212490) http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(2249984)/Fragments(video=9815840000000) 17:36:09.507 T:140678954788864 DEBUG: PlayFile: OpenFile succeed, play state 2 17:36:09.507 T:140678954788864 DEBUG: OnPlayBackStarted: play state was 2, starting 0 17:36:09.512 T:140676698240768 DEBUG: CDVDAudio::Pause - pausing audio stream 17:36:09.527 T:140677719676672 DEBUG: CGUIInfoManager::SetCurrentMovie(http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/Manifest) 17:36:09.532 T:140678526461696 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 17:36:09.532 T:140678526461696 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 17:36:09.648 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(2249984)/Fragments(video=9815840000000) finished, average download speed: 2282368.9608 17:36:09.650 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.650 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Connection: keep-alive' 17:36:09.650 T:140677736462080 DEBUG: CurlFile::Open(0x7ff208213d40) http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9815886080000) 17:36:09.678 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9815886080000) finished, average download speed: 2248693.4804 17:36:09.679 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: DMX_SPECIALID_STREAMCHANGE 17:36:09.679 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStreamIds() 17:36:09.679 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(1) 17:36:09.680 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(2) 17:36:09.680 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(3) 17:36:09.680 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(4) 17:36:09.680 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(5) 17:36:09.680 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(6) 17:36:09.680 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(7) 17:36:09.680 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(8) 17:36:09.680 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(9) 17:36:09.680 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 1 with codec_id 28 17:36:09.680 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 2 with codec_id 28 17:36:09.680 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 3 with codec_id 28 17:36:09.680 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 4 with codec_id 28 17:36:09.680 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 5 with codec_id 28 17:36:09.680 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 6 with codec_id 28 17:36:09.680 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 7 with codec_id 28 17:36:09.680 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 8 with codec_id 86018 17:36:09.680 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 9 with codec_id 86018 17:36:09.680 T:140677736462080 NOTICE: Opening stream: 1 source: 256 17:36:09.680 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(1: true) 17:36:09.680 T:140677736462080 NOTICE: Opening stream: 8 source: 256 17:36:09.680 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(8: true) 17:36:09.680 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(2: false) 17:36:09.680 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(3: false) 17:36:09.680 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(4: false) 17:36:09.680 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(5: false) 17:36:09.680 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(6: false) 17:36:09.680 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(7: false) 17:36:09.680 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(9: false) 17:36:09.681 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.681 T:140676736804608 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 17:36:09.681 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.683 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.683 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.684 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.684 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.685 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.685 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.686 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.686 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.688 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.688 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.689 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.689 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.690 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.690 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.692 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.692 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.693 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.693 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.694 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.694 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.695 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.695 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.697 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.697 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.698 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.698 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.699 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.699 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.700 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.701 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.702 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.702 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.703 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.703 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.704 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.704 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.705 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.706 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.707 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.707 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.708 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.708 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.709 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.709 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.710 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.710 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.712 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.712 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.713 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.713 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.714 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.714 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.716 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.716 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.717 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.717 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.718 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.718 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.719 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.719 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.721 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.721 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.722 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.722 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.723 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.723 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.724 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.724 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.726 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.726 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.728 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.728 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.729 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.729 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.730 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.730 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.731 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.731 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.732 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.732 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.734 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.734 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.735 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.735 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.736 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.736 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.737 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.737 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.739 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.739 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.740 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.740 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.741 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.741 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.742 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.742 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.743 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Connection: keep-alive' 17:36:09.743 T:140677736462080 DEBUG: CurlFile::Open(0x7ff208212ed0) http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(2249984)/Fragments(video=9815860000000) 17:36:09.860 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(2249984)/Fragments(video=9815860000000) finished, average download speed: 3535806.9336 17:36:09.862 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:36:09.862 T:140676736804608 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:36:09.865 T:140676698240768 NOTICE: Creating audio stream (codec id: 86018, channels: 2, sample rate: 48000, no pass-through) 17:36:09.865 T:140676698240768 DEBUG: CVideoPlayerAudio:: synctype set to 0: clock feedback 17:36:09.873 T:140678346544896 INFO: CActiveAESink::OpenSink - initialize sink 17:36:09.947 T:140678954788864 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 17:36:09.968 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Connection: keep-alive' 17:36:09.968 T:140677736462080 DEBUG: CurlFile::Open(0x7ff208258df0) http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9815906133333) 17:36:09.995 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9815906133333) finished, average download speed: 3472866.0386 17:36:10.043 T:140678346544896 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:@ 17:36:10.043 T:140678346544896 INFO: CAESinkALSA::Initialize - Attempting to open device "@" 17:36:10.045 T:140678346544896 INFO: CAESinkALSA::Initialize - Opened device "sysdefault" 17:36:10.046 T:140678346544896 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 17:36:10.046 T:140678346544896 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 17:36:10.046 T:140678346544896 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 1024, bufferSize 8192 17:36:10.046 T:140678346544896 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 1024, bufferSize 8192 17:36:10.046 T:140678346544896 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 171 ms 17:36:10.046 T:140678346544896 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 17:36:10.046 T:140678346544896 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR 17:36:10.046 T:140678346544896 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR) 17:36:10.046 T:140678346544896 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 17:36:10.046 T:140678346544896 DEBUG: Output Device : Default (HDA Intel PCH ALC892 Analog) 17:36:10.046 T:140678346544896 DEBUG: Sample Rate : 48000 17:36:10.046 T:140678346544896 DEBUG: Sample Format : AE_FMT_S32NE 17:36:10.046 T:140678346544896 DEBUG: Channel Count : 2 17:36:10.046 T:140678346544896 DEBUG: Channel Layout: FL,FR 17:36:10.046 T:140678346544896 DEBUG: Frames : 1024 17:36:10.046 T:140678346544896 DEBUG: Frame Size : 8 17:36:10.046 T:140678354937600 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 17:36:10.047 T:140677736462080 DEBUG: CVideoPlayer::HandleMessages - player started 1 17:36:10.102 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Connection: keep-alive' 17:36:10.102 T:140677736462080 DEBUG: CurlFile::Open(0x7ff208262480) http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9815926186666) 17:36:10.131 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9815926186666) finished, average download speed: 3408970.2909 17:36:10.238 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Connection: keep-alive' 17:36:10.238 T:140677736462080 DEBUG: CurlFile::Open(0x7ff208263690) http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9815946240000) 17:36:10.263 T:140676736804608 INFO: CVideoPlayerVideo - Stillframe detected, switching to forced 25.000000 fps 17:36:10.266 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9815946240000) finished, average download speed: 3347855.4142 17:36:10.373 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Connection: keep-alive' 17:36:10.373 T:140677736462080 DEBUG: CurlFile::Open(0x7ff2081e0e30) http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9815966293333) 17:36:10.400 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9815966293333) finished, average download speed: 3289455.8336 17:36:10.410 T:140677736462080 WARNING: VideoPlayer::Sync - stream player video does not start, flushing buffers 17:36:10.410 T:140677736462080 DEBUG: CVideoPlayer::FlushBuffers - flushing buffers 17:36:10.429 T:140676698240768 DEBUG: CDVDAudio::Flush - flush audio stream 17:36:10.429 T:140676698240768 DEBUG: CDVDAudio::Pause - pausing audio stream 17:36:10.429 T:140676698240768 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 17:36:10.429 T:140676736804608 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 17:36:10.446 T:140677736462080 DEBUG: CVideoPlayer::HandleMessages - player started 1 17:36:10.453 T:140677736462080 DEBUG: VideoPlayer::Sync - Audio - pts: 301056000.000000, cache: 298666.685820, totalcache: 570666.670799 17:36:10.453 T:140677736462080 DEBUG: CVideoPlayer::SetCaching - caching state 0 17:36:10.453 T:140677736462080 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 17:36:10.453 T:140676736804608 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(300757333.314180) 17:36:10.453 T:140676698240768 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(300757333.314180) 17:36:10.453 T:140676698240768 DEBUG: CDVDAudio::Resume - resume audio stream 17:36:10.453 T:140678354937600 DEBUG: ActiveAE - start sync of audio stream 17:36:10.527 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Connection: keep-alive' 17:36:10.527 T:140677736462080 DEBUG: CurlFile::Open(0x7ff208284140) http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9815986346666) 17:36:10.556 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9815986346666) finished, average download speed: 3230753.1828 17:36:10.557 T:140678354937600 DEBUG: ActiveAE::SyncStream - average error of -132.852170, start adjusting 17:36:10.557 T:140678354937600 DEBUG: ActiveAE::SyncStream - average error -27.852170 below threshold of 30.000000 17:36:10.666 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Connection: keep-alive' 17:36:10.666 T:140677736462080 DEBUG: CurlFile::Open(0x7ff208133190) http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9816006400000) 17:36:10.696 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9816006400000) finished, average download speed: 3173384.9401 17:36:10.802 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Connection: keep-alive' 17:36:10.802 T:140677736462080 DEBUG: CurlFile::Open(0x7ff2080f6950) http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9816026453333) 17:36:10.897 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9816026453333) finished, average download speed: 3101700.5742 17:36:11.003 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Connection: keep-alive' 17:36:11.003 T:140677736462080 DEBUG: CurlFile::Open(0x7ff20816ee70) http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9816046506666) 17:36:11.171 T:140677736462080 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 412 17:36:11.171 T:140677736462080 ERROR: CCurlFile::Open failed with code 412 for http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9816046506666)|Connection=keep-alive&acceptencoding=gzip%2c%20deflate&seekable=0 17:36:11.171 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242820_242821/sporth01.isml/QualityLevels(96000)/Fragments(audio_deu=9816046506666) doesn't provide any data: invalid 17:36:11.582 T:140676698240768 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-41006.688791, adjusted:-41006.688791 17:36:13.348 T:140678954788864 DEBUG: LIRC: Update - NEW at 188476:0000000080010067 00 KEY_UP devinput (KEY_UP) 17:36:13.348 T:140678954788864 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 17:36:13.958 T:140678954788864 DEBUG: LIRC: Update - NEW at 189085:0000000080010067 00 KEY_UP devinput (KEY_UP) 17:36:13.958 T:140678954788864 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 17:36:14.024 T:140678365439744 DEBUG: CCurlFile::GetMimeType - https://www.skygo.sky.de/sg/bin/EPGEvent/ipad/event_3491052.png -> image/png 17:36:14.025 T:140678365439744 DEBUG: CurlFile::Open(0x7ff1fc16c7e0) https://www.skygo.sky.de/sg/bin/EPGEvent/ipad/event_3491052.png 17:36:14.092 T:140678365439744 DEBUG: Caching image 'https://www.skygo.sky.de/sg/bin/EPGEvent/ipad/event_3491052.png' to 'b/b5b72758.jpg': 17:36:14.092 T:140678365439744 DEBUG: cached image 'special://masterprofile/Thumbnails/b/b5b72758.jpg' size 404x227 17:36:15.828 T:140678954788864 DEBUG: LIRC: Update - NEW at 190954:0000000080010069 00 KEY_LEFT devinput (KEY_LEFT) 17:36:15.828 T:140678954788864 DEBUG: OnKey: 169 (0xa9, obc86) pressed, action is Left 17:36:17.623 T:140676698240768 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_EOF 17:36:17.678 T:140677736462080 INFO: Process - eof reading from demuxer 17:36:17.678 T:140677736462080 NOTICE: CVideoPlayer::OnExit() 17:36:17.678 T:140677736462080 NOTICE: VideoPlayer: eof, waiting for queues to empty 17:36:17.678 T:140677736462080 NOTICE: Closing stream player 1 17:36:17.678 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(8: false) 17:36:17.678 T:140677736462080 NOTICE: CDVDMessageQueue(audio)::WaitUntilEmpty 17:36:17.678 T:140676698240768 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 17:36:17.678 T:140677736462080 NOTICE: Waiting for audio thread to exit 17:36:17.678 T:140676698240768 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true 17:36:17.678 T:140676698240768 NOTICE: thread end: CVideoPlayerAudio::OnExit() 17:36:17.678 T:140677736462080 NOTICE: Closing audio device 17:36:17.678 T:140676698240768 DEBUG: Thread VideoPlayerAudio 140676698240768 terminating 17:36:18.028 T:140678354937600 DEBUG: CActiveAE::DiscardStream - audio stream deleted 17:36:18.028 T:140678354937600 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 17:36:18.028 T:140677736462080 DEBUG: Previous line repeats 2 times. 17:36:18.028 T:140677736462080 NOTICE: Deleting audio codec 17:36:18.028 T:140677736462080 NOTICE: Closing stream player 2 17:36:18.028 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(1: false) 17:36:18.028 T:140677736462080 NOTICE: CDVDMessageQueue(video)::WaitUntilEmpty 17:36:18.028 T:140676736804608 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 17:36:18.028 T:140676736804608 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true 17:36:18.028 T:140677736462080 NOTICE: waiting for video thread to exit 17:36:18.028 T:140676736804608 NOTICE: thread end: video_thread 17:36:18.028 T:140676736804608 DEBUG: Thread VideoPlayerVideo 140676736804608 terminating 17:36:18.028 T:140677736462080 NOTICE: deleting video codec 17:36:18.028 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Close() 17:36:18.029 T:140677736462080 INFO: ADDON: Dll Stopped - InputStream Adaptive 17:36:18.029 T:140677736462080 DEBUG: OnPlayBackEnded: play state was 2, starting 0 17:36:18.029 T:140677736462080 DEBUG: Thread VideoPlayer 140677736462080 terminating 17:36:18.030 T:140678526461696 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 17:36:18.030 T:140678526461696 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 17:36:18.051 T:140678954788864 NOTICE: CVideoPlayer::CloseFile() 17:36:18.051 T:140678954788864 NOTICE: VideoPlayer: waiting for threads to exit 17:36:18.051 T:140678954788864 NOTICE: VideoPlayer: finished waiting 17:36:18.051 T:140678954788864 DEBUG: DeleteRenderer - deleting renderer 17:36:18.051 T:140678954788864 DEBUG: LinuxRendererGL: Cleaning up GL resources 17:36:18.083 T:140678954788864 NOTICE: CVideoPlayer::CloseFile() 17:36:18.083 T:140678954788864 NOTICE: VideoPlayer: waiting for threads to exit 17:36:18.083 T:140678954788864 NOTICE: VideoPlayer: finished waiting 17:36:18.083 T:140678954788864 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 17:36:18.352 T:140677728069376 DEBUG: DoWork - Saving file state for video item plugin://plugin.video.skygo.de/?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242820_242821%2Fsporth01.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Formel+1%3A+Gro%5Cxdfer+Preis+von+Italien+Rennen+in+Monza%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+1+HD+%7C+%5B%2FCOLOR%5DFormel+1%3A+Gro%5Cxdfer+Preis+von+Italien+Rennen+in+Monza%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+0%2C+%27genre%27%3A+%27%27%7D 17:36:18.371 T:140678526461696 DEBUG: CAnnouncementManager - Announcement: OnUpdate from xbmc 17:36:18.371 T:140678526461696 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnUpdate 17:36:18.390 T:140678346544896 INFO: CActiveAESink::OpenSink - initialize sink 17:36:18.561 T:140678346544896 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:@ 17:36:18.561 T:140678346544896 INFO: CAESinkALSA::Initialize - Attempting to open device "@" 17:36:18.563 T:140678346544896 INFO: CAESinkALSA::Initialize - Opened device "sysdefault" 17:36:18.564 T:140678346544896 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 17:36:18.564 T:140678346544896 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 17:36:18.564 T:140678346544896 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 1024, bufferSize 8192 17:36:18.564 T:140678346544896 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 1024, bufferSize 8192 17:36:18.564 T:140678346544896 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 171 ms 17:36:18.564 T:140678346544896 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 17:36:18.564 T:140678346544896 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR 17:36:18.564 T:140678346544896 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR) 17:36:18.564 T:140678346544896 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 17:36:18.564 T:140678346544896 DEBUG: Output Device : Default (HDA Intel PCH ALC892 Analog) 17:36:18.564 T:140678346544896 DEBUG: Sample Rate : 48000 17:36:18.564 T:140678346544896 DEBUG: Sample Format : AE_FMT_S32NE 17:36:18.564 T:140678346544896 DEBUG: Channel Count : 2 17:36:18.564 T:140678346544896 DEBUG: Channel Layout: FL,FR 17:36:18.564 T:140678346544896 DEBUG: Frames : 1024 17:36:18.564 T:140678346544896 DEBUG: Frame Size : 8 17:36:18.564 T:140678354937600 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 17:36:20.013 T:140678954788864 DEBUG: LIRC: Update - NEW at 195137:000000008001006a 00 KEY_RIGHT devinput (KEY_RIGHT) 17:36:20.013 T:140678954788864 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 17:36:39.620 T:140678954788864 INFO: CheckIdle - Closing session to https://wvguard.sky.de (easy=0x7ff208191a60, multi=0x7ff2081c3b40) 17:36:41.701 T:140678954788864 INFO: CheckIdle - Closing session to http://livemss1it-s.akamaihd.net (easy=0x5365830, multi=0x7ff2080959b0) 17:36:44.303 T:140678954788864 INFO: CheckIdle - Closing session to https://www.skygo.sky.de (easy=0x7ff1f8193090, multi=0x7ff1f81fc840) 17:36:48.367 T:140678365439744 DEBUG: Thread JobWorker 140678365439744 terminating (autodelete) 17:36:48.368 T:140677719676672 DEBUG: Thread JobWorker 140677719676672 terminating (autodelete) 17:36:48.400 T:140677728069376 DEBUG: Thread JobWorker 140677728069376 terminating (autodelete) 17:39:20.337 T:140678526461696 DEBUG: CAnnouncementManager - Announcement: OnScreensaverActivated from xbmc 17:39:20.337 T:140678526461696 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverActivated 17:39:20.338 T:140678954788864 DEBUG: ------ Window Init () ------ 17:41:25.149 T:140678954788864 DEBUG: LIRC: Update - NEW at 500170:00000000800100ae 00 KEY_EXIT devinput (KEY_EXIT) 17:41:25.149 T:140678954788864 DEBUG: OnKey: menu (0xd8) pressed, screen saver/dpms woken up 17:41:25.149 T:140678526461696 DEBUG: CAnnouncementManager - Announcement: OnScreensaverDeactivated from xbmc 17:41:25.149 T:140678526461696 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverDeactivated 17:41:26.149 T:140678954788864 DEBUG: ------ Window Deinit () ------ 17:41:26.727 T:140678954788864 DEBUG: LIRC: Update - NEW at 501749:0000000080010069 00 KEY_LEFT devinput (KEY_LEFT) 17:41:26.727 T:140678954788864 DEBUG: OnKey: 169 (0xa9, obc86) pressed, action is Left 17:41:26.727 T:140678346544896 INFO: CActiveAESink::OpenSink - initialize sink 17:41:26.727 T:140678346544896 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:@ 17:41:26.727 T:140678346544896 INFO: CAESinkALSA::Initialize - Attempting to open device "@" 17:41:26.729 T:140678346544896 INFO: CAESinkALSA::Initialize - Opened device "sysdefault" 17:41:26.729 T:140678346544896 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 17:41:26.729 T:140678346544896 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 17:41:26.729 T:140678346544896 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 1024, bufferSize 8192 17:41:26.729 T:140678346544896 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 1024, bufferSize 8192 17:41:26.729 T:140678346544896 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 171 ms 17:41:26.729 T:140678346544896 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 17:41:26.729 T:140678346544896 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR 17:41:26.729 T:140678346544896 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR) 17:41:26.729 T:140678346544896 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 17:41:26.729 T:140678346544896 DEBUG: Output Device : Default (HDA Intel PCH ALC892 Analog) 17:41:26.729 T:140678346544896 DEBUG: Sample Rate : 48000 17:41:26.729 T:140678346544896 DEBUG: Sample Format : AE_FMT_S32NE 17:41:26.729 T:140678346544896 DEBUG: Channel Count : 2 17:41:26.729 T:140678346544896 DEBUG: Channel Layout: FL,FR 17:41:26.729 T:140678346544896 DEBUG: Frames : 1024 17:41:26.729 T:140678346544896 DEBUG: Frame Size : 8 17:41:28.029 T:140678954788864 DEBUG: LIRC: Update - NEW at 503051:0000000080010067 00 KEY_UP devinput (KEY_UP) 17:41:28.029 T:140678954788864 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 17:41:30.589 T:140678954788864 DEBUG: LIRC: Update - NEW at 505611:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:41:30.589 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:41:30.589 T:140678954788864 DEBUG: ------ Window Init (DialogAddonSettings.xml) ------ 17:41:35.830 T:140678954788864 DEBUG: LIRC: Update - NEW at 510852:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:41:35.830 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:41:40.110 T:140678954788864 DEBUG: LIRC: Update - NEW at 515132:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:41:40.110 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:41:47.610 T:140678954788864 DEBUG: LIRC: Update - NEW at 522632:00000000800100ae 00 KEY_EXIT devinput (KEY_EXIT) 17:41:47.610 T:140678954788864 DEBUG: OnKey: menu (0xd8) pressed, action is Close 17:41:47.852 T:140678954788864 DEBUG: ------ Window Deinit (DialogAddonSettings.xml) ------ 17:41:48.909 T:140678954788864 DEBUG: LIRC: Update - NEW at 523930:00000000800100ae 00 KEY_EXIT devinput (KEY_EXIT) 17:41:48.909 T:140678954788864 DEBUG: OnKey: menu (0xd8) pressed, action is Back 17:41:50.088 T:140678954788864 DEBUG: LIRC: Update - NEW at 525110:00000000800100ae 00 KEY_EXIT devinput (KEY_EXIT) 17:41:50.088 T:140678954788864 DEBUG: OnKey: menu (0xd8) pressed, action is Back 17:41:50.088 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listLiveTvChannelDirs) 17:41:50.088 T:140678954788864 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 17:41:50.088 T:140677728069376 DEBUG: Thread JobWorker start, auto delete: true 17:41:50.094 T:140677728069376 DEBUG: Previous line repeats 1 times. 17:41:50.094 T:140677728069376 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 5 ms 17:41:50.094 T:140678365439744 DEBUG: Thread JobWorker start, auto delete: true 17:41:50.094 T:140677719676672 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','5','?action=listLiveTvChannelDirs') 17:41:50.094 T:140677736462080 DEBUG: Thread LanguageInvoker start, auto delete: false 17:41:50.094 T:140677736462080 INFO: initializing python engine. 17:41:50.094 T:140677736462080 DEBUG: CPythonInvoker(6, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): start processing 17:41:50.125 T:140677736462080 DEBUG: -->Python Interpreter Initialized<-- 17:41:50.125 T:140677736462080 DEBUG: CPythonInvoker(6, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py" 17:41:50.125 T:140677736462080 DEBUG: CPythonInvoker(6, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /var/lib/vdr/.kodi/addons/plugin.video.skygo.de:/var/lib/vdr/.kodi/addons/script.common.plugin.cache/lib:/var/lib/vdr/.kodi/addons/script.module.cryptopy/lib:/var/lib/vdr/.kodi/addons/script.module.pydes/lib:/var/lib/vdr/.kodi/addons/script.module.requests/lib:/var/lib/vdr/.kodi/addons/script.module.routing/lib:/usr/lib/python2.7:/usr/lib/python2.7/plat-x86_64-linux-gnu:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat:/usr/lib/python2.7/dist-packages/gtk-2.0:/usr/lib/python2.7/dist-packages/ubuntu-sso-client 17:41:50.125 T:140677736462080 DEBUG: CPythonInvoker(6, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /var/lib/vdr/.kodi/addons/plugin.video.skygo.de 17:41:50.125 T:140677736462080 DEBUG: CPythonInvoker(6, /var/lib/vdr/.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 17:41:50.328 T:140677736462080 DEBUG: false 17:41:50.588 T:140678954788864 DEBUG: ------ Window Init (DialogBusy.xml) ------ 17:41:50.623 T:140677736462080 DEBUG: {'action': 'listLiveTvChannelDirs'} 17:41:50.679 T:140677736462080 ERROR: /var/lib/vdr/.kodi/addons/script.module.requests/lib/requests/packages/urllib3/util/ssl_.py:334: SNIMissingWarning: An HTTPS request has been made, but the SNI (Subject Name Indication) extension to TLS is not available on this platform. This may cause the server to present an incorrect TLS certificate, which can cause validation failures. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings SNIMissingWarning 17:41:50.679 T:140677736462080 ERROR: /var/lib/vdr/.kodi/addons/script.module.requests/lib/requests/packages/urllib3/util/ssl_.py:132: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings InsecurePlatformWarning 17:41:50.832 T:140677736462080 INFO: CPythonInvoker(6, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 17:41:50.845 T:140677736462080 INFO: Python script stopped 17:41:50.845 T:140677736462080 DEBUG: Thread LanguageInvoker 140677736462080 terminating 17:41:50.849 T:140677736462080 DEBUG: Thread BackgroundLoader start, auto delete: false 17:41:50.852 T:140677736462080 DEBUG: Thread BackgroundLoader 140677736462080 terminating 17:41:51.089 T:140678954788864 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 17:41:53.285 T:140678954788864 DEBUG: LIRC: Update - NEW at 528307:00000000800100ae 00 KEY_EXIT devinput (KEY_EXIT) 17:41:53.285 T:140678954788864 DEBUG: OnKey: menu (0xd8) pressed, action is Back 17:41:53.285 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/) 17:41:53.285 T:140678954788864 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 17:41:53.290 T:140677728069376 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 5 ms 17:41:53.290 T:140678365439744 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','6','') 17:41:53.290 T:140677736462080 DEBUG: Thread LanguageInvoker start, auto delete: false 17:41:53.290 T:140677736462080 INFO: initializing python engine. 17:41:53.290 T:140677736462080 DEBUG: CPythonInvoker(7, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): start processing 17:41:53.335 T:140677736462080 DEBUG: -->Python Interpreter Initialized<-- 17:41:53.335 T:140677736462080 DEBUG: CPythonInvoker(7, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py" 17:41:53.335 T:140677736462080 DEBUG: CPythonInvoker(7, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /var/lib/vdr/.kodi/addons/plugin.video.skygo.de:/var/lib/vdr/.kodi/addons/script.common.plugin.cache/lib:/var/lib/vdr/.kodi/addons/script.module.cryptopy/lib:/var/lib/vdr/.kodi/addons/script.module.pydes/lib:/var/lib/vdr/.kodi/addons/script.module.requests/lib:/var/lib/vdr/.kodi/addons/script.module.routing/lib:/usr/lib/python2.7:/usr/lib/python2.7/plat-x86_64-linux-gnu:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat:/usr/lib/python2.7/dist-packages/gtk-2.0:/usr/lib/python2.7/dist-packages/ubuntu-sso-client 17:41:53.335 T:140677736462080 DEBUG: CPythonInvoker(7, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /var/lib/vdr/.kodi/addons/plugin.video.skygo.de 17:41:53.335 T:140677736462080 DEBUG: CPythonInvoker(7, /var/lib/vdr/.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 17:41:53.536 T:140677736462080 DEBUG: false 17:41:53.786 T:140678954788864 DEBUG: ------ Window Init (DialogBusy.xml) ------ 17:41:53.818 T:140677736462080 DEBUG: ['plugin://plugin.video.skygo.de/', '6', ''] 17:41:53.975 T:140677736462080 INFO: CPythonInvoker(7, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 17:41:53.987 T:140676698240768 DEBUG: Thread BackgroundLoader start, auto delete: false 17:41:53.988 T:140677736462080 INFO: Python script stopped 17:41:53.988 T:140677736462080 DEBUG: Thread LanguageInvoker 140677736462080 terminating 17:41:53.990 T:140676698240768 DEBUG: Thread BackgroundLoader 140676698240768 terminating 17:41:54.167 T:140678954788864 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 17:41:54.865 T:140678954788864 DEBUG: LIRC: Update - NEW at 529886:00000000800100ae 00 KEY_EXIT devinput (KEY_EXIT) 17:41:54.865 T:140678954788864 DEBUG: OnKey: menu (0xd8) pressed, action is Back 17:41:54.865 T:140678954788864 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 17:41:55.166 T:140678954788864 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 17:41:55.184 T:140678954788864 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 17:41:55.184 T:140678954788864 DEBUG: ------ Window Init (Home.xml) ------ 17:41:55.184 T:140678954788864 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 17:41:55.184 T:140678954788864 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 17:41:55.184 T:140678954788864 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 17:41:55.184 T:140678954788864 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 17:41:57.375 T:140678954788864 DEBUG: LIRC: Update - NEW at 532397:0000000080010067 00 KEY_UP devinput (KEY_UP) 17:41:57.375 T:140678954788864 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 17:41:58.199 T:140678954788864 DEBUG: LIRC: Update - NEW at 533221:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:41:58.199 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:41:58.199 T:140678954788864 DEBUG: Activating window ID: 10040 17:41:58.505 T:140678954788864 DEBUG: ------ Window Deinit (Home.xml) ------ 17:41:58.528 T:140678954788864 DEBUG: ------ Window Init (AddonBrowser.xml) ------ 17:41:58.528 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (addons://user/) 17:41:58.528 T:140678954788864 DEBUG: ParentPath = [addons://user/] 17:41:58.532 T:140676698240768 DEBUG: Thread BackgroundLoader start, auto delete: false 17:41:58.532 T:140676698240768 DEBUG: Thread BackgroundLoader 140676698240768 terminating 17:42:01.424 T:140678954788864 DEBUG: LIRC: Update - NEW at 536446:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:42:01.425 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:42:01.425 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (addons://user/kodi.inputstream) 17:42:01.425 T:140678954788864 DEBUG: ParentPath = [addons://user/] 17:42:01.431 T:140677719676672 DEBUG: CAddonMgr::GetAvailableUpdates took 4 ms 17:42:01.433 T:140676698240768 DEBUG: Thread BackgroundLoader start, auto delete: false 17:42:01.433 T:140676698240768 DEBUG: Thread BackgroundLoader 140676698240768 terminating 17:42:03.299 T:140678954788864 DEBUG: LIRC: Update - NEW at 538321:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:42:03.299 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:42:03.299 T:140678954788864 DEBUG: ------ Window Init (DialogAddonInfo.xml) ------ 17:42:04.772 T:140678954788864 DEBUG: LIRC: Update - NEW at 539794:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:42:04.772 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:42:04.772 T:140678954788864 DEBUG: ------ Window Init (DialogAddonSettings.xml) ------ 17:42:06.332 T:140678954788864 DEBUG: LIRC: Update - NEW at 541354:000000008001006a 00 KEY_RIGHT devinput (KEY_RIGHT) 17:42:06.332 T:140678954788864 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 17:42:06.748 T:140678954788864 DEBUG: LIRC: Update - NEW at 541770:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:42:06.748 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:42:07.848 T:140678954788864 DEBUG: LIRC: Update - NEW at 542870:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:42:07.848 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:42:08.368 T:140678954788864 DEBUG: LIRC: Update - NEW at 543390:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:42:08.368 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:42:08.948 T:140678954788864 DEBUG: LIRC: Update - NEW at 543970:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:42:08.948 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:42:09.528 T:140678954788864 DEBUG: LIRC: Update - NEW at 544550:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:42:09.528 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:42:11.268 T:140678954788864 DEBUG: LIRC: Update - NEW at 546290:000000008001006a 00 KEY_RIGHT devinput (KEY_RIGHT) 17:42:11.268 T:140678954788864 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 17:42:12.628 T:140678954788864 DEBUG: LIRC: Update - NEW at 547650:000000008001006a 00 KEY_RIGHT devinput (KEY_RIGHT) 17:42:12.628 T:140678954788864 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 17:42:14.408 T:140678954788864 DEBUG: LIRC: Update - NEW at 549430:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:42:14.408 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:42:14.408 T:140678954788864 DEBUG: ADDON: Dll Initializing - InputStream Adaptive 17:42:14.409 T:140678954788864 DEBUG: AddOnLog: InputStream Adaptive: libXBMC_addon successfully loaded 17:42:14.409 T:140678954788864 DEBUG: AddOnLog: InputStream Adaptive: ADDON_Create() 17:42:14.409 T:140678954788864 DEBUG: AddOnLog: InputStream Adaptive: ADDON_Destroy() 17:42:14.409 T:140678954788864 INFO: ADDON: Dll Destroyed - InputStream Adaptive 17:42:14.648 T:140678954788864 DEBUG: ------ Window Deinit (DialogAddonSettings.xml) ------ 17:42:17.562 T:140678954788864 DEBUG: LIRC: Update - NEW at 552583:00000000800100ae 00 KEY_EXIT devinput (KEY_EXIT) 17:42:17.562 T:140678954788864 DEBUG: OnKey: menu (0xd8) pressed, action is Close 17:42:17.866 T:140678954788864 DEBUG: ------ Window Deinit (DialogAddonInfo.xml) ------ 17:42:18.747 T:140678954788864 DEBUG: LIRC: Update - NEW at 553768:00000000800100ae 00 KEY_EXIT devinput (KEY_EXIT) 17:42:18.747 T:140678954788864 DEBUG: OnKey: menu (0xd8) pressed, action is Back 17:42:18.747 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (addons://user/) 17:42:18.747 T:140678954788864 DEBUG: ParentPath = [] 17:42:18.753 T:140676698240768 DEBUG: Thread BackgroundLoader start, auto delete: false 17:42:18.754 T:140676698240768 DEBUG: Thread BackgroundLoader 140676698240768 terminating 17:42:19.584 T:140678954788864 DEBUG: LIRC: Update - NEW at 554606:00000000800100ae 00 KEY_EXIT devinput (KEY_EXIT) 17:42:19.584 T:140678954788864 DEBUG: OnKey: menu (0xd8) pressed, action is Back 17:42:19.584 T:140678954788864 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 17:42:19.885 T:140678954788864 DEBUG: ------ Window Deinit (AddonBrowser.xml) ------ 17:42:19.904 T:140678954788864 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 17:42:19.904 T:140678954788864 DEBUG: ------ Window Init (Home.xml) ------ 17:42:21.036 T:140678954788864 DEBUG: LIRC: Update - NEW at 556058:000000008001006c 00 KEY_DOWN devinput (KEY_DOWN) 17:42:21.036 T:140678954788864 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:42:21.806 T:140678954788864 DEBUG: LIRC: Update - NEW at 556828:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:42:21.806 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:42:21.806 T:140678954788864 DEBUG: Activating window ID: 10025 17:42:22.106 T:140678954788864 DEBUG: ------ Window Deinit (Home.xml) ------ 17:42:22.124 T:140678954788864 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 17:42:22.128 T:140678954788864 ERROR: Control 55 in window 10025 has been asked to focus, but it can't 17:42:22.144 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/) 17:42:22.144 T:140678954788864 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 17:42:22.154 T:140677719676672 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 9 ms 17:42:22.154 T:140678365439744 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','7','') 17:42:22.154 T:140676698240768 DEBUG: Thread LanguageInvoker start, auto delete: false 17:42:22.154 T:140676698240768 INFO: initializing python engine. 17:42:22.154 T:140676698240768 DEBUG: CPythonInvoker(8, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): start processing 17:42:22.189 T:140676698240768 DEBUG: -->Python Interpreter Initialized<-- 17:42:22.189 T:140676698240768 DEBUG: CPythonInvoker(8, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py" 17:42:22.190 T:140676698240768 DEBUG: CPythonInvoker(8, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /var/lib/vdr/.kodi/addons/plugin.video.skygo.de:/var/lib/vdr/.kodi/addons/script.common.plugin.cache/lib:/var/lib/vdr/.kodi/addons/script.module.cryptopy/lib:/var/lib/vdr/.kodi/addons/script.module.pydes/lib:/var/lib/vdr/.kodi/addons/script.module.requests/lib:/var/lib/vdr/.kodi/addons/script.module.routing/lib:/usr/lib/python2.7:/usr/lib/python2.7/plat-x86_64-linux-gnu:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat:/usr/lib/python2.7/dist-packages/gtk-2.0:/usr/lib/python2.7/dist-packages/ubuntu-sso-client 17:42:22.190 T:140676698240768 DEBUG: CPythonInvoker(8, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /var/lib/vdr/.kodi/addons/plugin.video.skygo.de 17:42:22.190 T:140676698240768 DEBUG: CPythonInvoker(8, /var/lib/vdr/.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 17:42:22.390 T:140676698240768 DEBUG: false 17:42:22.644 T:140678954788864 DEBUG: ------ Window Init (DialogBusy.xml) ------ 17:42:22.678 T:140676698240768 DEBUG: ['plugin://plugin.video.skygo.de/', '7', ''] 17:42:22.850 T:140676698240768 INFO: CPythonInvoker(8, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 17:42:22.862 T:140676698240768 INFO: Python script stopped 17:42:22.862 T:140676698240768 DEBUG: Thread LanguageInvoker 140676698240768 terminating 17:42:22.867 T:140676698240768 DEBUG: Thread BackgroundLoader start, auto delete: false 17:42:22.870 T:140676698240768 DEBUG: Thread BackgroundLoader 140676698240768 terminating 17:42:23.067 T:140678954788864 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 17:42:24.664 T:140678954788864 DEBUG: LIRC: Update - NEW at 559686:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:42:24.664 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:42:24.665 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listLiveTvChannelDirs) 17:42:24.665 T:140678954788864 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/] 17:42:24.675 T:140677719676672 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 10 ms 17:42:24.676 T:140677728069376 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','8','?action=listLiveTvChannelDirs') 17:42:24.676 T:140677736462080 DEBUG: Thread LanguageInvoker start, auto delete: false 17:42:24.676 T:140677736462080 INFO: initializing python engine. 17:42:24.676 T:140677736462080 DEBUG: CPythonInvoker(9, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): start processing 17:42:24.739 T:140677736462080 DEBUG: -->Python Interpreter Initialized<-- 17:42:24.739 T:140677736462080 DEBUG: CPythonInvoker(9, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py" 17:42:24.740 T:140677736462080 DEBUG: CPythonInvoker(9, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /var/lib/vdr/.kodi/addons/plugin.video.skygo.de:/var/lib/vdr/.kodi/addons/script.common.plugin.cache/lib:/var/lib/vdr/.kodi/addons/script.module.cryptopy/lib:/var/lib/vdr/.kodi/addons/script.module.pydes/lib:/var/lib/vdr/.kodi/addons/script.module.requests/lib:/var/lib/vdr/.kodi/addons/script.module.routing/lib:/usr/lib/python2.7:/usr/lib/python2.7/plat-x86_64-linux-gnu:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat:/usr/lib/python2.7/dist-packages/gtk-2.0:/usr/lib/python2.7/dist-packages/ubuntu-sso-client 17:42:24.740 T:140677736462080 DEBUG: CPythonInvoker(9, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /var/lib/vdr/.kodi/addons/plugin.video.skygo.de 17:42:24.740 T:140677736462080 DEBUG: CPythonInvoker(9, /var/lib/vdr/.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 17:42:24.953 T:140677736462080 DEBUG: false 17:42:25.166 T:140678954788864 DEBUG: ------ Window Init (DialogBusy.xml) ------ 17:42:25.197 T:140677736462080 DEBUG: {'action': 'listLiveTvChannelDirs'} 17:42:25.230 T:140677736462080 ERROR: /var/lib/vdr/.kodi/addons/script.module.requests/lib/requests/packages/urllib3/util/ssl_.py:334: SNIMissingWarning: An HTTPS request has been made, but the SNI (Subject Name Indication) extension to TLS is not available on this platform. This may cause the server to present an incorrect TLS certificate, which can cause validation failures. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings SNIMissingWarning 17:42:25.230 T:140677736462080 ERROR: /var/lib/vdr/.kodi/addons/script.module.requests/lib/requests/packages/urllib3/util/ssl_.py:132: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings InsecurePlatformWarning 17:42:25.392 T:140677736462080 INFO: CPythonInvoker(9, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 17:42:25.406 T:140677736462080 INFO: Python script stopped 17:42:25.406 T:140677736462080 DEBUG: Thread LanguageInvoker 140677736462080 terminating 17:42:25.407 T:140677736462080 DEBUG: Thread BackgroundLoader start, auto delete: false 17:42:25.409 T:140677736462080 DEBUG: Thread BackgroundLoader 140677736462080 terminating 17:42:25.626 T:140678954788864 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 17:42:26.724 T:140678954788864 DEBUG: LIRC: Update - NEW at 561746:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:42:26.724 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:42:26.724 T:140678954788864 DEBUG: Clearing cached fileitems [plugin://plugin.video.skygo.de/?action=listLiveTvChannels&channeldir_name=sport] 17:42:26.724 T:140678954788864 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.skygo.de/?action=listLiveTvChannels&channeldir_name=sport) 17:42:26.724 T:140678954788864 DEBUG: ParentPath = [plugin://plugin.video.skygo.de/?action=listLiveTvChannelDirs] 17:42:26.729 T:140678365439744 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.skygo.de] took 5 ms 17:42:26.729 T:140677719676672 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','9','?action=listLiveTvChannels&channeldir_name=sport') 17:42:26.729 T:140677736462080 DEBUG: Thread LanguageInvoker start, auto delete: false 17:42:26.729 T:140677736462080 INFO: initializing python engine. 17:42:26.729 T:140677736462080 DEBUG: CPythonInvoker(10, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): start processing 17:42:26.761 T:140677736462080 DEBUG: -->Python Interpreter Initialized<-- 17:42:26.761 T:140677736462080 DEBUG: CPythonInvoker(10, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py" 17:42:26.761 T:140677736462080 DEBUG: CPythonInvoker(10, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /var/lib/vdr/.kodi/addons/plugin.video.skygo.de:/var/lib/vdr/.kodi/addons/script.common.plugin.cache/lib:/var/lib/vdr/.kodi/addons/script.module.cryptopy/lib:/var/lib/vdr/.kodi/addons/script.module.pydes/lib:/var/lib/vdr/.kodi/addons/script.module.requests/lib:/var/lib/vdr/.kodi/addons/script.module.routing/lib:/usr/lib/python2.7:/usr/lib/python2.7/plat-x86_64-linux-gnu:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat:/usr/lib/python2.7/dist-packages/gtk-2.0:/usr/lib/python2.7/dist-packages/ubuntu-sso-client 17:42:26.761 T:140677736462080 DEBUG: CPythonInvoker(10, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /var/lib/vdr/.kodi/addons/plugin.video.skygo.de 17:42:26.761 T:140677736462080 DEBUG: CPythonInvoker(10, /var/lib/vdr/.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 17:42:26.962 T:140677736462080 DEBUG: false 17:42:27.225 T:140678954788864 DEBUG: ------ Window Init (DialogBusy.xml) ------ 17:42:27.259 T:140677736462080 DEBUG: {'action': 'listLiveTvChannels', 'channeldir_name': 'sport'} 17:42:27.314 T:140677736462080 ERROR: /var/lib/vdr/.kodi/addons/script.module.requests/lib/requests/packages/urllib3/util/ssl_.py:334: SNIMissingWarning: An HTTPS request has been made, but the SNI (Subject Name Indication) extension to TLS is not available on this platform. This may cause the server to present an incorrect TLS certificate, which can cause validation failures. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings SNIMissingWarning 17:42:27.314 T:140677736462080 ERROR: /var/lib/vdr/.kodi/addons/script.module.requests/lib/requests/packages/urllib3/util/ssl_.py:132: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings InsecurePlatformWarning 17:42:27.768 T:140677736462080 ERROR: Previous line repeats 1 times. 17:42:27.768 T:140677736462080 INFO: CPythonInvoker(10, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 17:42:27.782 T:140677736462080 INFO: Python script stopped 17:42:27.782 T:140677736462080 DEBUG: Thread LanguageInvoker 140677736462080 terminating 17:42:27.786 T:140678954788864 DEBUG: Saving fileitems [plugin://plugin.video.skygo.de/?action=listLiveTvChannels&channeldir_name=sport] 17:42:27.787 T:140678954788864 DEBUG: -- items: 4, sort method: 0, ascending: false 17:42:27.787 T:140678954788864 DEBUG: RunQuery took 0 ms for 6 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 17:42:27.788 T:140677736462080 DEBUG: Thread BackgroundLoader start, auto delete: false 17:42:27.791 T:140677736462080 DEBUG: Thread BackgroundLoader 140677736462080 terminating 17:42:28.328 T:140678954788864 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 17:42:32.625 T:140678954788864 DEBUG: LIRC: Update - NEW at 567647:0000000080010067 00 KEY_UP devinput (KEY_UP) 17:42:32.625 T:140678954788864 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 17:42:32.626 T:140678365439744 INFO: easy_aquire - Created session to https://www.skygo.sky.de 17:42:32.776 T:140678365439744 DEBUG: CCurlFile::GetMimeType - https://www.skygo.sky.de/sg/bin/EPGEvent/ipad/event_3490315.png -> image/png 17:42:32.776 T:140678365439744 DEBUG: CurlFile::Open(0x7ff1fc005b00) https://www.skygo.sky.de/sg/bin/EPGEvent/ipad/event_3490315.png 17:42:33.103 T:140678365439744 DEBUG: Caching image 'https://www.skygo.sky.de/sg/bin/EPGEvent/ipad/event_3490315.png' to 'a/a8ac5d55.jpg': 17:42:33.103 T:140678365439744 DEBUG: cached image 'special://masterprofile/Thumbnails/a/a8ac5d55.jpg' size 404x227 17:42:33.207 T:140678954788864 DEBUG: LIRC: Update - NEW at 568229:0000000080010067 00 KEY_UP devinput (KEY_UP) 17:42:33.207 T:140678954788864 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 17:42:33.274 T:140677719676672 DEBUG: CCurlFile::GetMimeType - https://www.skygo.sky.de/sg/bin/EPGEvent/ipad/event_3491039.png -> image/png 17:42:33.274 T:140677719676672 DEBUG: CurlFile::Open(0x7ff228023be0) https://www.skygo.sky.de/sg/bin/EPGEvent/ipad/event_3491039.png 17:42:33.339 T:140677719676672 DEBUG: Caching image 'https://www.skygo.sky.de/sg/bin/EPGEvent/ipad/event_3491039.png' to '7/75b9a7d9.jpg': 17:42:33.339 T:140677719676672 DEBUG: cached image 'special://masterprofile/Thumbnails/7/75b9a7d9.jpg' size 404x227 17:42:42.205 T:140678954788864 DEBUG: LIRC: Update - NEW at 577227:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:42:42.205 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:42:42.208 T:140678954788864 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242822_242823%2Fsporth02.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Handball%3A+DKB+Bundesliga+Konferenz+I%2C+3.+Spieltag%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+2+HD+%7C+%5B%2FCOLOR%5DHandball%3A+DKB+Bundesliga+Konferenz+I%2C+3.+Spieltag%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+0%2C+%27genre%27%3A+%27%27%7D 17:42:42.208 T:140678526461696 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 17:42:42.208 T:140678526461696 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 17:42:42.208 T:140678954788864 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','10','?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242822_242823%2Fsporth02.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Handball%3A+DKB+Bundesliga+Konferenz+I%2C+3.+Spieltag%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+2+HD+%7C+%5B%2FCOLOR%5DHandball%3A+DKB+Bundesliga+Konferenz+I%2C+3.+Spieltag%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+0%2C+%27genre%27%3A+%27%27%7D') 17:42:42.208 T:140677736462080 DEBUG: Thread LanguageInvoker start, auto delete: false 17:42:42.208 T:140677736462080 INFO: initializing python engine. 17:42:42.208 T:140677736462080 DEBUG: CPythonInvoker(11, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): start processing 17:42:42.210 T:140678526461696 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 17:42:42.210 T:140678526461696 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 17:42:42.228 T:140676698240768 DEBUG: Thread scriptobs start, auto delete: false 17:42:42.240 T:140677736462080 DEBUG: -->Python Interpreter Initialized<-- 17:42:42.241 T:140677736462080 DEBUG: CPythonInvoker(11, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py" 17:42:42.241 T:140677736462080 DEBUG: CPythonInvoker(11, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /var/lib/vdr/.kodi/addons/plugin.video.skygo.de:/var/lib/vdr/.kodi/addons/script.common.plugin.cache/lib:/var/lib/vdr/.kodi/addons/script.module.cryptopy/lib:/var/lib/vdr/.kodi/addons/script.module.pydes/lib:/var/lib/vdr/.kodi/addons/script.module.requests/lib:/var/lib/vdr/.kodi/addons/script.module.routing/lib:/usr/lib/python2.7:/usr/lib/python2.7/plat-x86_64-linux-gnu:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat:/usr/lib/python2.7/dist-packages/gtk-2.0:/usr/lib/python2.7/dist-packages/ubuntu-sso-client 17:42:42.241 T:140677736462080 DEBUG: CPythonInvoker(11, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /var/lib/vdr/.kodi/addons/plugin.video.skygo.de 17:42:42.241 T:140677736462080 DEBUG: CPythonInvoker(11, /var/lib/vdr/.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 17:42:42.429 T:140678954788864 DEBUG: ------ Window Init (DialogBusy.xml) ------ 17:42:42.446 T:140677736462080 DEBUG: false 17:42:42.478 T:140677736462080 DEBUG: {'action': 'playLive', 'manifest_url': 'http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/Manifest', 'parental_rating': '0', 'infolabels': "{'plot': u'Handball: DKB Bundesliga Konferenz I, 3. Spieltag', 'title': u'[COLOR blue]Sky Sport 2 HD | [/COLOR]Handball: DKB Bundesliga Konferenz I, 3. Spieltag', 'originaltitle': '', 'cast': [], 'duration': 0, 'genre': ''}", 'package_code': 'OSPS'} 17:42:42.511 T:140677736462080 ERROR: /var/lib/vdr/.kodi/addons/script.module.requests/lib/requests/packages/urllib3/util/ssl_.py:334: SNIMissingWarning: An HTTPS request has been made, but the SNI (Subject Name Indication) extension to TLS is not available on this platform. This may cause the server to present an incorrect TLS certificate, which can cause validation failures. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings SNIMissingWarning 17:42:42.511 T:140677736462080 ERROR: /var/lib/vdr/.kodi/addons/script.module.requests/lib/requests/packages/urllib3/util/ssl_.py:132: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings InsecurePlatformWarning 17:42:42.651 T:140677736462080 DEBUG: {u'resultCode': u'S_218', u'resultMessage': u'KO'} 17:42:42.651 T:140677736462080 DEBUG: User not logged in or Session on other device 17:42:42.651 T:140677736462080 DEBUG: Session invalid - Customer Code not found in SilkCache 17:42:42.751 T:140677736462080 DEBUG: {u'resultCode': u'T_206', u'resultMessage': u'KO', u'skygoSessionId': u'SG-9ce391a1-2d54-4b16-ad60-a8d042617beb'} 17:42:42.768 T:140678954788864 DEBUG: ------ Window Init (DialogConfirm.xml) ------ 17:42:42.768 T:140678954788864 INFO: Loading skin file: DialogConfirm.xml, load type: KEEP_IN_MEMORY 17:42:46.187 T:140678954788864 DEBUG: LIRC: Update - NEW at 581209:0000000080010069 00 KEY_LEFT devinput (KEY_LEFT) 17:42:46.187 T:140678954788864 DEBUG: OnKey: 169 (0xa9, obc86) pressed, action is Left 17:42:47.107 T:140678954788864 DEBUG: LIRC: Update - NEW at 582129:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:42:47.107 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:42:47.347 T:140678954788864 DEBUG: ------ Window Deinit (DialogConfirm.xml) ------ 17:42:47.556 T:140677736462080 DEBUG: {u'gender': u'F', u'tcFlag': u'Y', u'mktgFlag': u'Y', u'firstName': u'WIEBKE', u'country': u'DE', u'age': u'31', u'extraCustFlag': u'N', u'resultMessage': u'OK', u'birthDate': u'1986/01/20', u'privacyFlag': u'Y', u'resultCode': u'T_100', u'customerCode': u'5751652417', u'flagTEF': u'N', u'cableSubFlag': u'Y', u'skygoSessionId': u'SG-4c7197c1-cb56-4105-8ff5-9a569bbe3b73', u'lastName': u'SCHEEL', u'entitlements': [u'KIDS', u'OOSP', u'OOSW', u'OSPS'], u'bookmarkFlag': u'Y', u'accountCreated': u'2017/09/02', u'presentation': u'FRAU', u'email': u'wiebke.scheel@gmx.de'} 17:42:47.628 T:140677736462080 DEBUG: {u'tcFlag': u'Y', u'birthDate': u'1986/01/20', u'email': u'wiebke.scheel@gmx.de', u'customerCode': u'5751652417', u'resultCode': u'S_100', u'privacyFlag': u'Y', u'extraCustFlag': u'N', u'bookmarkFlag': u'Y', u'skygoSessionId': u'SG-4c7197c1-cb56-4105-8ff5-9a569bbe3b73', u'entitlements': [u'KIDS', u'OOSP', u'OOSW', u'OSPS'], u'presentation': u'FRAU', u'cableSubFlag': u'Y', u'flagTEF': u'N', u'doubleOptInFlag': u'Y', u'mktgFlag': u'Y', u'firstName': u'WIEBKE', u'gender': u'F', u'age': u'31', u'lastName': u'SCHEEL', u'resultMessage': u'OK', u'accountCreated': u'2017/09/02', u'country': u'DE'} 17:42:47.628 T:140677736462080 DEBUG: User still logged in 17:42:47.648 T:140677736462080 INFO: CPythonInvoker(11, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 17:42:47.665 T:140677736462080 INFO: Python script stopped 17:42:47.665 T:140677736462080 DEBUG: Thread LanguageInvoker 140677736462080 terminating 17:42:47.667 T:140676698240768 DEBUG: Thread scriptobs 140676698240768 terminating 17:42:47.667 T:140678954788864 INFO: easy_aquire - Created session to http://livemss1it-s.akamaihd.net 17:42:47.752 T:140678954788864 DEBUG: CCurlFile::GetMimeType - http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/Manifest -> text/xml 17:42:47.754 T:140678954788864 DEBUG: Loading settings for http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/Manifest 17:42:47.755 T:140678954788864 DEBUG: CPlayerCoreFactory::GetPlayers(http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/Manifest) 17:42:47.755 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 17:42:47.755 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 17:42:47.755 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 17:42:47.755 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 17:42:47.755 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 17:42:47.755 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 17:42:47.755 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 17:42:47.755 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams 17:42:47.755 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp 17:42:47.755 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2 17:42:47.755 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 17:42:47.755 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 17:42:47.755 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 17:42:47.755 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 17:42:47.755 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 17:42:47.756 T:140678954788864 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 17:42:47.756 T:140678954788864 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 17:42:47.756 T:140678954788864 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 17:42:47.756 T:140678954788864 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 17:42:47.756 T:140678954788864 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 17:42:47.757 T:140678954788864 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 17:42:47.757 T:140678954788864 NOTICE: VideoPlayer: Opening: http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/Manifest 17:42:47.757 T:140678954788864 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 17:42:47.781 T:140678954788864 DEBUG: CCurlFile::GetMimeType - http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/Manifest -> text/xml 17:42:47.781 T:140678954788864 DEBUG: LinuxRendererGL: Cleaning up GL resources 17:42:47.781 T:140678954788864 DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16 17:42:47.781 T:140676698240768 DEBUG: Thread VideoPlayer start, auto delete: false 17:42:47.781 T:140676698240768 NOTICE: Creating InputStream 17:42:47.781 T:140676698240768 DEBUG: SECTION:UnloadDll(/var/lib/vdr/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.1.0.8) 17:42:47.781 T:140676698240768 INFO: ADDON: Dll Destroyed - InputStream Adaptive 17:42:47.781 T:140676698240768 DEBUG: ADDON: Dll Initializing - InputStream Adaptive 17:42:47.781 T:140676698240768 DEBUG: SECTION:LoadDLL(/var/lib/vdr/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.1.0.8) 17:42:47.781 T:140676698240768 DEBUG: Loading: /var/lib/vdr/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.1.0.8 17:42:47.786 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: libXBMC_addon successfully loaded 17:42:47.786 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: ADDON_Create() 17:42:47.786 T:140676698240768 INFO: AddOnLog: InputStream Adaptive: SetVideoResolution (1920 x 1080) 17:42:47.786 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: Open() 17:42:47.786 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_data: [not shown] 17:42:47.786 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_key: [not shown] 17:42:47.786 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_type: com.widevine.alpha 17:42:47.786 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.manifest_type: ism 17:42:47.786 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: Initial bandwidth: 22823443 17:42:47.786 T:140676698240768 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream Adaptive' requests setting 'MAXRESOLUTION' 17:42:47.786 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: MAXRESOLUTION selected: 0 17:42:47.786 T:140676698240768 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream Adaptive' requests setting 'STREAMSELECTION' 17:42:47.786 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: STREAMSELECTION selected: 1 17:42:47.786 T:140676698240768 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream Adaptive' requests setting 'MEDIATYPE' 17:42:47.786 T:140676698240768 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream Adaptive' requests setting 'DECRYPTERPATH' 17:42:47.787 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: Searching for decrypters in: /var/lib/vdr/.kodi/cdm/ 17:42:47.790 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: Found decrypter: /var/lib/vdr/.kodi/cdm/libssd_wv.so 17:42:47.790 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: Supported URN: urn:uuid:EDEF8BA9-79D6-4ACE-A3C8-27DCD51D21ED 17:42:47.790 T:140676698240768 DEBUG: CurlFile::Open(0x7ff208214f10) http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/Manifest 17:42:47.955 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/Manifest finished 17:42:47.955 T:140676698240768 INFO: AddOnLog: InputStream Adaptive: Successfully parsed .mpd file. #Streams: 2 Download speed: 2852930.3899 Bytes/s 17:42:47.955 T:140676698240768 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream Adaptive' requests setting 'MINBANDWIDTH' 17:42:47.955 T:140676698240768 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream Adaptive' requests setting 'MAXBANDWIDTH' 17:42:47.956 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 1 arrived! 17:42:47.956 T:140676698240768 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Content-Type: ' 17:42:47.956 T:140676698240768 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Expect: ' 17:42:47.956 T:140676698240768 DEBUG: CurlFile::Open(0x7ff2082792e0) https://wvguard.sky.de/WidevineLicenser/WidevineLicenser 17:42:47.956 T:140676698240768 INFO: easy_aquire - Created session to https://wvguard.sky.de 17:42:48.281 T:140678954788864 DEBUG: ------ Window Init (DialogBusy.xml) ------ 17:42:48.473 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 1 arrived! 17:42:48.473 T:140676698240768 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Content-Type: ' 17:42:48.473 T:140676698240768 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Expect: ' 17:42:48.473 T:140676698240768 DEBUG: CurlFile::Open(0x7ff2082792e0) https://wvguard.sky.de/WidevineLicenser/WidevineLicenser 17:42:49.027 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 2 arrived! 17:42:49.027 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 3 arrived! 17:42:49.027 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: License update successful 17:42:49.027 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: GetCapabilities() 17:42:49.027 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: GetStreamIds() 17:42:49.027 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: GetStream(1) 17:42:49.027 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: GetStream(2) 17:42:49.027 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: GetStream(3) 17:42:49.027 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: GetStream(4) 17:42:49.027 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: GetStream(5) 17:42:49.027 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: GetStream(6) 17:42:49.027 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: GetStream(7) 17:42:49.027 T:140676698240768 NOTICE: Creating Demuxer 17:42:49.027 T:140676698240768 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 1 with codec_id 28 17:42:49.027 T:140676698240768 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 2 with codec_id 28 17:42:49.027 T:140676698240768 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 3 with codec_id 28 17:42:49.027 T:140676698240768 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 4 with codec_id 28 17:42:49.027 T:140676698240768 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 5 with codec_id 28 17:42:49.027 T:140676698240768 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 6 with codec_id 28 17:42:49.027 T:140676698240768 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 7 with codec_id 28 17:42:49.027 T:140676698240768 NOTICE: Opening stream: 1 source: 256 17:42:49.027 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(1: true) 17:42:49.027 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: Selecting stream with conditions: w: 1920, h: 1080, bw: 20541098 17:42:49.028 T:140676698240768 NOTICE: Creating video codec with codec id: 28 17:42:49.028 T:140676698240768 DEBUG: FactoryCodec - Video: - Opening 17:42:49.028 T:140676698240768 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 17:42:49.028 T:140676698240768 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264 17:42:49.028 T:140676698240768 DEBUG: FactoryCodec - Video: ff-h264 - Opened 17:42:49.028 T:140676698240768 DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 28 17:42:49.028 T:140676698240768 NOTICE: Creating video thread 17:42:49.028 T:140677736462080 DEBUG: Thread VideoPlayerVideo start, auto delete: false 17:42:49.028 T:140677736462080 NOTICE: running thread: video_thread 17:42:49.028 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(2: false) 17:42:49.028 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(3: false) 17:42:49.028 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(4: false) 17:42:49.028 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(5: false) 17:42:49.028 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(6: false) 17:42:49.028 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(7: false) 17:42:49.028 T:140676698240768 DEBUG: OnPlayBackStarted: play state was 1, starting 1 17:42:49.028 T:140676698240768 DEBUG: CVideoPlayer::SetCaching - caching state 2 17:42:49.028 T:140676698240768 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 17:42:49.028 T:140676698240768 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Connection: keep-alive' 17:42:49.028 T:140676698240768 DEBUG: CurlFile::Open(0x7ff2080ddd60) http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/QualityLevels(750000)/Fragments(video=33952900000000) 17:42:49.047 T:140678954788864 DEBUG: PlayFile: OpenFile succeed, play state 2 17:42:49.047 T:140678954788864 DEBUG: OnPlayBackStarted: play state was 2, starting 0 17:42:49.067 T:140677728069376 DEBUG: CGUIInfoManager::SetCurrentMovie(http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/Manifest) 17:42:49.070 T:140678526461696 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 17:42:49.070 T:140678526461696 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 17:42:49.132 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/QualityLevels(750000)/Fragments(video=33952900000000) finished, average download speed: 2664343.7127 17:42:49.134 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.134 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: DMX_SPECIALID_STREAMCHANGE 17:42:49.134 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: GetStreamIds() 17:42:49.134 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: GetStream(1) 17:42:49.134 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: GetStream(2) 17:42:49.134 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: GetStream(3) 17:42:49.134 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: GetStream(4) 17:42:49.134 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: GetStream(5) 17:42:49.134 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: GetStream(6) 17:42:49.134 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: GetStream(7) 17:42:49.134 T:140676698240768 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 1 with codec_id 28 17:42:49.134 T:140676698240768 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 2 with codec_id 28 17:42:49.134 T:140676698240768 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 3 with codec_id 28 17:42:49.134 T:140676698240768 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 4 with codec_id 28 17:42:49.134 T:140676698240768 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 5 with codec_id 28 17:42:49.134 T:140676698240768 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 6 with codec_id 28 17:42:49.134 T:140676698240768 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 7 with codec_id 28 17:42:49.134 T:140676698240768 NOTICE: Opening stream: 1 source: 256 17:42:49.134 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(1: true) 17:42:49.134 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(2: false) 17:42:49.134 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(3: false) 17:42:49.134 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(4: false) 17:42:49.134 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(5: false) 17:42:49.134 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(6: false) 17:42:49.134 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(7: false) 17:42:49.135 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.135 T:140677736462080 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 17:42:49.135 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.136 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.136 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.138 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.138 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.139 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.139 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.140 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.140 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.141 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.141 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.142 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.142 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.143 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.143 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.145 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.145 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.146 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.146 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.147 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.147 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.148 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.148 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.149 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.149 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.150 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.150 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.152 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.152 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.153 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.153 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.154 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.154 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.155 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.155 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.156 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.156 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.157 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.157 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.159 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.159 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.160 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.160 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.161 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.161 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.162 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.162 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.163 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.163 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.164 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.164 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.166 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.166 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.167 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.167 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.168 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.168 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.169 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.169 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.170 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.170 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.172 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.172 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.173 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.173 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.174 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.174 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.175 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.175 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.176 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.176 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.177 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.178 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.179 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.179 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.180 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.180 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.181 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.181 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.182 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.182 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.183 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.183 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.185 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.185 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.186 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.186 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.187 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.187 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.188 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.188 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.189 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.189 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.191 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.191 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.192 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.192 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.192 T:140676698240768 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Connection: keep-alive' 17:42:49.192 T:140676698240768 DEBUG: CurlFile::Open(0x7ff2080f52d0) http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/QualityLevels(750000)/Fragments(video=33952920000000) 17:42:49.283 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/QualityLevels(750000)/Fragments(video=33952920000000) finished, average download speed: 2635409.0235 17:42:49.285 T:140676698240768 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:49.285 T:140676698240768 DEBUG: CVideoPlayer::SetCaching - caching state 0 17:42:49.285 T:140676698240768 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 17:42:49.285 T:140677736462080 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:49.285 T:140676698240768 INFO: Process - eof reading from demuxer 17:42:49.285 T:140676698240768 NOTICE: CVideoPlayer::OnExit() 17:42:49.285 T:140676698240768 NOTICE: VideoPlayer: eof, waiting for queues to empty 17:42:49.285 T:140676698240768 NOTICE: Closing stream player 2 17:42:49.285 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(1: false) 17:42:49.285 T:140676698240768 NOTICE: waiting for video thread to exit 17:42:49.285 T:140677736462080 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true 17:42:49.285 T:140677736462080 NOTICE: thread end: video_thread 17:42:49.285 T:140677736462080 DEBUG: Thread VideoPlayerVideo 140677736462080 terminating 17:42:49.285 T:140676698240768 NOTICE: deleting video codec 17:42:49.285 T:140676698240768 DEBUG: AddOnLog: InputStream Adaptive: Close() 17:42:49.286 T:140676698240768 INFO: ADDON: Dll Stopped - InputStream Adaptive 17:42:49.286 T:140676698240768 DEBUG: OnPlayBackEnded: play state was 2, starting 0 17:42:49.286 T:140676698240768 DEBUG: Thread VideoPlayer 140676698240768 terminating 17:42:49.288 T:140678526461696 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 17:42:49.288 T:140678526461696 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 17:42:49.288 T:140678954788864 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 17:42:49.307 T:140678954788864 NOTICE: CVideoPlayer::CloseFile() 17:42:49.307 T:140678954788864 NOTICE: VideoPlayer: waiting for threads to exit 17:42:49.307 T:140678954788864 NOTICE: VideoPlayer: finished waiting 17:42:49.307 T:140678954788864 DEBUG: DeleteRenderer - deleting renderer 17:42:49.307 T:140678954788864 DEBUG: LinuxRendererGL: Cleaning up GL resources 17:42:49.338 T:140678954788864 NOTICE: CVideoPlayer::CloseFile() 17:42:49.338 T:140678954788864 NOTICE: VideoPlayer: waiting for threads to exit 17:42:49.338 T:140678954788864 NOTICE: VideoPlayer: finished waiting 17:42:49.338 T:140678954788864 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 17:42:49.339 T:140678365439744 DEBUG: DoWork - Saving file state for video item plugin://plugin.video.skygo.de/?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242822_242823%2Fsporth02.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Handball%3A+DKB+Bundesliga+Konferenz+I%2C+3.+Spieltag%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+2+HD+%7C+%5B%2FCOLOR%5DHandball%3A+DKB+Bundesliga+Konferenz+I%2C+3.+Spieltag%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+0%2C+%27genre%27%3A+%27%27%7D 17:42:49.350 T:140678526461696 DEBUG: CAnnouncementManager - Announcement: OnUpdate from xbmc 17:42:49.350 T:140678526461696 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnUpdate 17:42:54.045 T:140678954788864 DEBUG: LIRC: Update - NEW at 589067:0000000080010160 00 KEY_OK devinput (KEY_OK) 17:42:54.045 T:140678954788864 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:42:54.048 T:140678954788864 DEBUG: OnPlayMedia plugin://plugin.video.skygo.de/?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242822_242823%2Fsporth02.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Handball%3A+DKB+Bundesliga+Konferenz+I%2C+3.+Spieltag%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+2+HD+%7C+%5B%2FCOLOR%5DHandball%3A+DKB+Bundesliga+Konferenz+I%2C+3.+Spieltag%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+0%2C+%27genre%27%3A+%27%27%7D 17:42:54.048 T:140678526461696 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 17:42:54.048 T:140678526461696 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 17:42:54.048 T:140678954788864 DEBUG: StartScript - calling plugin Sky Go('plugin://plugin.video.skygo.de/','11','?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242822_242823%2Fsporth02.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Handball%3A+DKB+Bundesliga+Konferenz+I%2C+3.+Spieltag%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+2+HD+%7C+%5B%2FCOLOR%5DHandball%3A+DKB+Bundesliga+Konferenz+I%2C+3.+Spieltag%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+0%2C+%27genre%27%3A+%27%27%7D') 17:42:54.048 T:140676698240768 DEBUG: Thread LanguageInvoker start, auto delete: false 17:42:54.048 T:140676698240768 INFO: initializing python engine. 17:42:54.048 T:140676698240768 DEBUG: CPythonInvoker(12, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): start processing 17:42:54.049 T:140678526461696 DEBUG: GetMovieId (plugin://plugin.video.skygo.de/?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242822_242823%2Fsporth02.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Handball%3A+DKB+Bundesliga+Konferenz+I%2C+3.+Spieltag%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+2+HD+%7C+%5B%2FCOLOR%5DHandball%3A+DKB+Bundesliga+Konferenz+I%2C+3.+Spieltag%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+0%2C+%27genre%27%3A+%27%27%7D), query = select idMovie from movie where idFile=7 17:42:54.049 T:140678526461696 DEBUG: GetEpisodeId (plugin://plugin.video.skygo.de/?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242822_242823%2Fsporth02.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Handball%3A+DKB+Bundesliga+Konferenz+I%2C+3.+Spieltag%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+2+HD+%7C+%5B%2FCOLOR%5DHandball%3A+DKB+Bundesliga+Konferenz+I%2C+3.+Spieltag%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+0%2C+%27genre%27%3A+%27%27%7D), query = select idEpisode from episode where idFile=7 17:42:54.050 T:140678526461696 DEBUG: GetMusicVideoId (plugin://plugin.video.skygo.de/?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242822_242823%2Fsporth02.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Handball%3A+DKB+Bundesliga+Konferenz+I%2C+3.+Spieltag%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+2+HD+%7C+%5B%2FCOLOR%5DHandball%3A+DKB+Bundesliga+Konferenz+I%2C+3.+Spieltag%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+0%2C+%27genre%27%3A+%27%27%7D), query = select idMVideo from musicvideo where idFile=7 17:42:54.050 T:140678526461696 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 17:42:54.050 T:140678526461696 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 17:42:54.068 T:140677736462080 DEBUG: Thread scriptobs start, auto delete: false 17:42:54.078 T:140676698240768 DEBUG: -->Python Interpreter Initialized<-- 17:42:54.078 T:140676698240768 DEBUG: CPythonInvoker(12, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): the source file to load is "/var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py" 17:42:54.078 T:140676698240768 DEBUG: CPythonInvoker(12, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): setting the Python path to /var/lib/vdr/.kodi/addons/plugin.video.skygo.de:/var/lib/vdr/.kodi/addons/script.common.plugin.cache/lib:/var/lib/vdr/.kodi/addons/script.module.cryptopy/lib:/var/lib/vdr/.kodi/addons/script.module.pydes/lib:/var/lib/vdr/.kodi/addons/script.module.requests/lib:/var/lib/vdr/.kodi/addons/script.module.routing/lib:/usr/lib/python2.7:/usr/lib/python2.7/plat-x86_64-linux-gnu:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat:/usr/lib/python2.7/dist-packages/gtk-2.0:/usr/lib/python2.7/dist-packages/ubuntu-sso-client 17:42:54.078 T:140676698240768 DEBUG: CPythonInvoker(12, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): entering source directory /var/lib/vdr/.kodi/addons/plugin.video.skygo.de 17:42:54.078 T:140676698240768 DEBUG: CPythonInvoker(12, /var/lib/vdr/.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 17:42:54.269 T:140678954788864 DEBUG: ------ Window Init (DialogBusy.xml) ------ 17:42:54.277 T:140676698240768 DEBUG: false 17:42:54.310 T:140676698240768 DEBUG: {'action': 'playLive', 'manifest_url': 'http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/Manifest', 'parental_rating': '0', 'infolabels': "{'plot': u'Handball: DKB Bundesliga Konferenz I, 3. Spieltag', 'title': u'[COLOR blue]Sky Sport 2 HD | [/COLOR]Handball: DKB Bundesliga Konferenz I, 3. Spieltag', 'originaltitle': '', 'cast': [], 'duration': 0, 'genre': ''}", 'package_code': 'OSPS'} 17:42:54.365 T:140676698240768 ERROR: /var/lib/vdr/.kodi/addons/script.module.requests/lib/requests/packages/urllib3/util/ssl_.py:334: SNIMissingWarning: An HTTPS request has been made, but the SNI (Subject Name Indication) extension to TLS is not available on this platform. This may cause the server to present an incorrect TLS certificate, which can cause validation failures. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings SNIMissingWarning 17:42:54.365 T:140676698240768 ERROR: /var/lib/vdr/.kodi/addons/script.module.requests/lib/requests/packages/urllib3/util/ssl_.py:132: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings InsecurePlatformWarning 17:42:54.506 T:140676698240768 DEBUG: {u'tcFlag': u'Y', u'birthDate': u'1986/01/20', u'email': u'wiebke.scheel@gmx.de', u'customerCode': u'5751652417', u'resultCode': u'S_100', u'privacyFlag': u'Y', u'extraCustFlag': u'N', u'bookmarkFlag': u'Y', u'skygoSessionId': u'SG-4c7197c1-cb56-4105-8ff5-9a569bbe3b73', u'entitlements': [u'KIDS', u'OOSP', u'OOSW', u'OSPS'], u'presentation': u'FRAU', u'cableSubFlag': u'Y', u'flagTEF': u'N', u'doubleOptInFlag': u'Y', u'mktgFlag': u'Y', u'firstName': u'WIEBKE', u'gender': u'F', u'age': u'31', u'lastName': u'SCHEEL', u'resultMessage': u'OK', u'accountCreated': u'2017/09/02', u'country': u'DE'} 17:42:54.506 T:140676698240768 DEBUG: User still logged in 17:42:54.508 T:140676698240768 INFO: CPythonInvoker(12, /var/lib/vdr/.kodi/addons/plugin.video.skygo.de/default.py): script successfully run 17:42:54.523 T:140676698240768 INFO: Python script stopped 17:42:54.523 T:140676698240768 DEBUG: Thread LanguageInvoker 140676698240768 terminating 17:42:54.527 T:140677736462080 DEBUG: Thread scriptobs 140677736462080 terminating 17:42:54.561 T:140678954788864 DEBUG: CCurlFile::GetMimeType - http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/Manifest -> text/xml 17:42:54.562 T:140678954788864 DEBUG: Loading settings for http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/Manifest 17:42:54.564 T:140678954788864 DEBUG: CPlayerCoreFactory::GetPlayers(http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/Manifest) 17:42:54.564 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 17:42:54.564 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 17:42:54.564 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 17:42:54.564 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 17:42:54.564 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 17:42:54.564 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 17:42:54.564 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 17:42:54.564 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams 17:42:54.564 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp 17:42:54.564 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2 17:42:54.564 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 17:42:54.564 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 17:42:54.564 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 17:42:54.564 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 17:42:54.564 T:140678954788864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 17:42:54.564 T:140678954788864 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 17:42:54.564 T:140678954788864 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 17:42:54.564 T:140678954788864 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 17:42:54.564 T:140678954788864 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 17:42:54.564 T:140678954788864 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 17:42:54.565 T:140678954788864 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 17:42:54.565 T:140678954788864 NOTICE: VideoPlayer: Opening: http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/Manifest 17:42:54.565 T:140678954788864 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 17:42:54.589 T:140678954788864 DEBUG: CCurlFile::GetMimeType - http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/Manifest -> text/xml 17:42:54.589 T:140678954788864 DEBUG: LinuxRendererGL: Cleaning up GL resources 17:42:54.589 T:140678954788864 DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16 17:42:54.589 T:140677736462080 DEBUG: Thread VideoPlayer start, auto delete: false 17:42:54.589 T:140677736462080 NOTICE: Creating InputStream 17:42:54.589 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: ADDON_Destroy() 17:42:54.589 T:140677736462080 DEBUG: SECTION:UnloadDll(/var/lib/vdr/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.1.0.8) 17:42:54.590 T:140677736462080 INFO: ADDON: Dll Destroyed - InputStream Adaptive 17:42:54.590 T:140677736462080 DEBUG: ADDON: Dll Initializing - InputStream Adaptive 17:42:54.590 T:140677736462080 DEBUG: SECTION:LoadDLL(/var/lib/vdr/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.1.0.8) 17:42:54.590 T:140677736462080 DEBUG: Loading: /var/lib/vdr/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.1.0.8 17:42:54.594 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: libXBMC_addon successfully loaded 17:42:54.594 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: ADDON_Create() 17:42:54.594 T:140677736462080 INFO: AddOnLog: InputStream Adaptive: SetVideoResolution (1920 x 1080) 17:42:54.594 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Open() 17:42:54.594 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_data: [not shown] 17:42:54.594 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_key: [not shown] 17:42:54.594 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_type: com.widevine.alpha 17:42:54.594 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.manifest_type: ism 17:42:54.594 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Initial bandwidth: 22513643 17:42:54.594 T:140677736462080 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream Adaptive' requests setting 'MAXRESOLUTION' 17:42:54.595 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: MAXRESOLUTION selected: 0 17:42:54.595 T:140677736462080 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream Adaptive' requests setting 'STREAMSELECTION' 17:42:54.595 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: STREAMSELECTION selected: 1 17:42:54.595 T:140677736462080 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream Adaptive' requests setting 'MEDIATYPE' 17:42:54.595 T:140677736462080 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream Adaptive' requests setting 'DECRYPTERPATH' 17:42:54.595 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Searching for decrypters in: /var/lib/vdr/.kodi/cdm/ 17:42:54.599 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Found decrypter: /var/lib/vdr/.kodi/cdm/libssd_wv.so 17:42:54.599 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Supported URN: urn:uuid:EDEF8BA9-79D6-4ACE-A3C8-27DCD51D21ED 17:42:54.599 T:140677736462080 DEBUG: CurlFile::Open(0x7ff1c83205f0) http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/Manifest 17:42:54.636 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/Manifest finished 17:42:54.636 T:140677736462080 INFO: AddOnLog: InputStream Adaptive: Successfully parsed .mpd file. #Streams: 2 Download speed: 2814205.4523 Bytes/s 17:42:54.636 T:140677736462080 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream Adaptive' requests setting 'MINBANDWIDTH' 17:42:54.637 T:140677736462080 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream Adaptive' requests setting 'MAXBANDWIDTH' 17:42:54.638 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 1 arrived! 17:42:54.638 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Content-Type: ' 17:42:54.638 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Expect: ' 17:42:54.638 T:140677736462080 DEBUG: CurlFile::Open(0x7ff1c82f8120) https://wvguard.sky.de/WidevineLicenser/WidevineLicenser 17:42:54.788 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 1 arrived! 17:42:54.788 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Content-Type: ' 17:42:54.788 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Expect: ' 17:42:54.788 T:140677736462080 DEBUG: CurlFile::Open(0x7ff1c80ff870) https://wvguard.sky.de/WidevineLicenser/WidevineLicenser 17:42:55.078 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 2 arrived! 17:42:55.078 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 3 arrived! 17:42:55.078 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: License update successful 17:42:55.078 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetCapabilities() 17:42:55.078 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStreamIds() 17:42:55.078 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(1) 17:42:55.078 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(2) 17:42:55.078 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(3) 17:42:55.078 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(4) 17:42:55.078 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(5) 17:42:55.078 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(6) 17:42:55.078 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(7) 17:42:55.078 T:140677736462080 NOTICE: Creating Demuxer 17:42:55.078 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 1 with codec_id 28 17:42:55.078 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 2 with codec_id 28 17:42:55.078 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 3 with codec_id 28 17:42:55.078 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 4 with codec_id 28 17:42:55.078 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 5 with codec_id 28 17:42:55.078 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 6 with codec_id 28 17:42:55.078 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 7 with codec_id 28 17:42:55.078 T:140677736462080 NOTICE: Opening stream: 1 source: 256 17:42:55.078 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(1: true) 17:42:55.078 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Selecting stream with conditions: w: 1920, h: 1080, bw: 20262278 17:42:55.079 T:140677736462080 NOTICE: Creating video codec with codec id: 28 17:42:55.079 T:140677736462080 DEBUG: FactoryCodec - Video: - Opening 17:42:55.079 T:140677736462080 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 17:42:55.079 T:140677736462080 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264 17:42:55.079 T:140677736462080 DEBUG: FactoryCodec - Video: ff-h264 - Opened 17:42:55.079 T:140677736462080 DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 28 17:42:55.079 T:140677736462080 NOTICE: Creating video thread 17:42:55.079 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(2: false) 17:42:55.079 T:140676698240768 DEBUG: Thread VideoPlayerVideo start, auto delete: false 17:42:55.079 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(3: false) 17:42:55.079 T:140676698240768 NOTICE: running thread: video_thread 17:42:55.079 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(4: false) 17:42:55.079 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(5: false) 17:42:55.079 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(6: false) 17:42:55.079 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(7: false) 17:42:55.079 T:140677736462080 DEBUG: OnPlayBackStarted: play state was 1, starting 1 17:42:55.079 T:140677736462080 DEBUG: CVideoPlayer::SetCaching - caching state 2 17:42:55.079 T:140677736462080 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 17:42:55.079 T:140678954788864 DEBUG: PlayFile: OpenFile succeed, play state 2 17:42:55.079 T:140678954788864 DEBUG: OnPlayBackStarted: play state was 2, starting 0 17:42:55.079 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Connection: keep-alive' 17:42:55.079 T:140677736462080 DEBUG: CurlFile::Open(0x7ff1c80121f0) http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/QualityLevels(750000)/Fragments(video=33952980000000) 17:42:55.081 T:140677719676672 DEBUG: CGUIInfoManager::SetCurrentMovie(http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/Manifest) 17:42:55.082 T:140678954788864 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 17:42:55.084 T:140678526461696 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 17:42:55.084 T:140678526461696 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 17:42:55.169 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/QualityLevels(750000)/Fragments(video=33952980000000) finished, average download speed: 2780801.9978 17:42:55.171 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.171 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: DMX_SPECIALID_STREAMCHANGE 17:42:55.171 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStreamIds() 17:42:55.171 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(1) 17:42:55.171 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(2) 17:42:55.171 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(3) 17:42:55.171 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(4) 17:42:55.171 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(5) 17:42:55.171 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(6) 17:42:55.171 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: GetStream(7) 17:42:55.171 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 1 with codec_id 28 17:42:55.171 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 2 with codec_id 28 17:42:55.171 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 3 with codec_id 28 17:42:55.171 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 4 with codec_id 28 17:42:55.171 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 5 with codec_id 28 17:42:55.171 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 6 with codec_id 28 17:42:55.171 T:140677736462080 DEBUG: CDVDDemuxClient::RequestStreams(): added/updated stream 7 with codec_id 28 17:42:55.172 T:140677736462080 NOTICE: Opening stream: 1 source: 256 17:42:55.172 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(1: true) 17:42:55.172 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(2: false) 17:42:55.172 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(3: false) 17:42:55.172 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(4: false) 17:42:55.172 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(5: false) 17:42:55.172 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(6: false) 17:42:55.172 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(7: false) 17:42:55.173 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.173 T:140676698240768 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 17:42:55.173 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.174 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.174 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.175 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.175 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.176 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.176 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.177 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.178 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.179 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.179 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.180 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.180 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.181 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.181 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.182 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.182 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.183 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.183 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.185 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.185 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.186 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.186 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.187 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.187 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.188 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.188 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.189 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.189 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.191 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.191 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.192 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.192 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.193 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.193 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.194 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.194 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.196 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.196 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.197 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.197 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.198 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.198 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.199 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.199 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.201 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.201 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.202 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.202 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.203 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.203 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.204 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.204 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.205 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.206 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.207 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.207 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.208 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.208 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.209 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.209 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.210 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.210 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.211 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.211 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.213 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.213 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.214 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.214 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.215 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.215 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.216 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.216 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.217 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.217 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.219 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.219 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.220 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.220 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.221 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.221 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.222 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.222 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.223 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.223 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.224 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.225 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.226 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.226 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.227 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.227 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.228 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.228 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.229 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.229 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.230 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.230 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.231 T:140677736462080 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Connection: keep-alive' 17:42:55.231 T:140677736462080 DEBUG: CurlFile::Open(0x7ff1c8004e50) http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/QualityLevels(750000)/Fragments(video=33953000000000) 17:42:55.325 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Download http://livemss1it-s.akamaihd.net/live/242822_242823/sporth02.isml/QualityLevels(750000)/Fragments(video=33953000000000) finished, average download speed: 2631791.9156 17:42:55.326 T:140677736462080 ERROR: AddOnLog: InputStream Adaptive: Decrypt Sample returns failure! 17:42:55.326 T:140677736462080 DEBUG: CVideoPlayer::SetCaching - caching state 0 17:42:55.326 T:140676698240768 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:55.326 T:140677736462080 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 17:42:55.326 T:140677736462080 INFO: Process - eof reading from demuxer 17:42:55.326 T:140677736462080 NOTICE: CVideoPlayer::OnExit() 17:42:55.326 T:140677736462080 NOTICE: VideoPlayer: eof, waiting for queues to empty 17:42:55.326 T:140677736462080 NOTICE: Closing stream player 2 17:42:55.326 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(1: false) 17:42:55.326 T:140677736462080 NOTICE: waiting for video thread to exit 17:42:55.326 T:140676698240768 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true 17:42:55.326 T:140676698240768 NOTICE: thread end: video_thread 17:42:55.326 T:140676698240768 DEBUG: Thread VideoPlayerVideo 140676698240768 terminating 17:42:55.326 T:140677736462080 NOTICE: deleting video codec 17:42:55.326 T:140677736462080 DEBUG: AddOnLog: InputStream Adaptive: Close() 17:42:55.327 T:140677736462080 INFO: ADDON: Dll Stopped - InputStream Adaptive 17:42:55.327 T:140677736462080 DEBUG: OnPlayBackEnded: play state was 2, starting 0 17:42:55.327 T:140677736462080 DEBUG: Thread VideoPlayer 140677736462080 terminating 17:42:55.329 T:140678526461696 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 17:42:55.329 T:140678526461696 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 17:42:55.347 T:140678954788864 NOTICE: CVideoPlayer::CloseFile() 17:42:55.347 T:140678954788864 NOTICE: VideoPlayer: waiting for threads to exit 17:42:55.347 T:140678954788864 NOTICE: VideoPlayer: finished waiting 17:42:55.347 T:140678954788864 DEBUG: DeleteRenderer - deleting renderer 17:42:55.347 T:140678954788864 DEBUG: LinuxRendererGL: Cleaning up GL resources 17:42:55.354 T:140678954788864 NOTICE: CVideoPlayer::CloseFile() 17:42:55.354 T:140678954788864 NOTICE: VideoPlayer: waiting for threads to exit 17:42:55.354 T:140678954788864 NOTICE: VideoPlayer: finished waiting 17:42:55.355 T:140678954788864 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 17:42:55.585 T:140677728069376 DEBUG: DoWork - Saving file state for video item plugin://plugin.video.skygo.de/?action=playLive&manifest_url=http%3A%2F%2Flivemss1it-s.akamaihd.net%2Flive%2F242822_242823%2Fsporth02.isml%2FManifest&package_code=OSPS&parental_rating=0&infolabels=%7B%27plot%27%3A+u%27Handball%3A+DKB+Bundesliga+Konferenz+I%2C+3.+Spieltag%27%2C+%27title%27%3A+u%27%5BCOLOR+blue%5DSky+Sport+2+HD+%7C+%5B%2FCOLOR%5DHandball%3A+DKB+Bundesliga+Konferenz+I%2C+3.+Spieltag%27%2C+%27originaltitle%27%3A+%27%27%2C+%27cast%27%3A+%5B%5D%2C+%27duration%27%3A+0%2C+%27genre%27%3A+%27%27%7D 17:42:55.593 T:140678526461696 DEBUG: CAnnouncementManager - Announcement: OnUpdate from xbmc 17:42:55.593 T:140678526461696 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnUpdate 17:43:03.430 T:140678954788864 INFO: CheckIdle - Closing session to https://www.skygo.sky.de (easy=0x7ff1fc25d130, multi=0x7ff1fc004cb0) 17:43:25.053 T:140678954788864 INFO: CheckIdle - Closing session to https://wvguard.sky.de (easy=0x7ff2081b9960, multi=0x7ff2080f9520) 17:43:25.585 T:140678365439744 DEBUG: Thread JobWorker 140678365439744 terminating (autodelete) 17:43:25.585 T:140677719676672 DEBUG: Thread JobWorker 140677719676672 terminating (autodelete) 17:43:25.587 T:140678954788864 INFO: CheckIdle - Closing session to http://livemss1it-s.akamaihd.net (easy=0x58ad8d0, multi=0x7ff2080ec250) 17:43:25.605 T:140677728069376 DEBUG: Thread JobWorker 140677728069376 terminating (autodelete) 17:45:55.553 T:140678526461696 DEBUG: CAnnouncementManager - Announcement: OnScreensaverActivated from xbmc 17:45:55.553 T:140678526461696 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverActivated 17:45:55.554 T:140678954788864 DEBUG: ------ Window Init () ------