17:15:17 19.365942 T:139829743949888 NOTICE: special://profile/ is mapped to: special://masterprofile/
17:15:17 19.366020 T:139829743949888 NOTICE: -----------------------------------------------------------------------
17:15:17 19.366049 T:139829743949888 NOTICE: Starting Kodi (17.0-ALPHA1 Git:0436322). Platform: Linux x86 64-bit
17:15:17 19.366072 T:139829743949888 NOTICE: Using Release Kodi x64 build
17:15:17 19.366095 T:139829743949888 NOTICE: Kodi compiled Apr 2 2016 by GCC 5.3.0 for Linux x86 64-bit version 4.4.6 (263174)
17:15:17 19.366245 T:139829743949888 NOTICE: Running on OpenELEC (Milhouse) - Version: devel-20160402015807-#0401-g0026734 [Build #0401] 8.0, kernel: Linux x86 64-bit version 4.4.6
17:15:17 19.366268 T:139829743949888 NOTICE: FFmpeg version: 3.0.1
17:15:17 19.366289 T:139829743949888 NOTICE: WARNING: unsupported ffmpeg version detected
17:15:17 19.366312 T:139829743949888 NOTICE: Host CPU: Intel(R) Celeron(R) CPU N3050 @ 1.60GHz, 2 cores available
17:15:17 19.366335 T:139829743949888 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi
17:15:17 19.366358 T:139829743949888 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi
17:15:17 19.366381 T:139829743949888 NOTICE: special://masterprofile/ is mapped to: /storage/.kodi/userdata
17:15:17 19.366404 T:139829743949888 NOTICE: special://home/ is mapped to: /storage/.kodi
17:15:17 19.366425 T:139829743949888 NOTICE: special://temp/ is mapped to: /storage/.kodi/temp
17:15:17 19.366447 T:139829743949888 NOTICE: special://logpath/ is mapped to: /storage/.kodi/temp
17:15:17 19.366489 T:139829743949888 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin
17:15:17 19.366539 T:139829743949888 NOTICE: Local hostname: OpenELEC_NUC
17:15:17 19.366577 T:139829743949888 NOTICE: Log File is located: /storage/.kodi/temp//kodi.log
17:15:17 19.366611 T:139829743949888 NOTICE: -----------------------------------------------------------------------
17:15:17 19.413864 T:139829743949888 ERROR: DBus: Error org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files
17:15:17 19.429672 T:139829743949888 NOTICE: load settings...
17:15:17 19.526581 T:139829743949888 NOTICE: Found 2 Lists of Devices
17:15:17 19.526638 T:139829743949888 NOTICE: Enumerated ALSA devices:
17:15:17 19.526661 T:139829743949888 NOTICE: Device 1
17:15:17 19.526897 T:139829743949888 NOTICE: m_deviceName : @
17:15:17 19.526922 T:139829743949888 NOTICE: m_displayName : Default (HDA Intel PCH ALC283 Analog)
17:15:17 19.526943 T:139829743949888 NOTICE: m_displayNameExtra:
17:15:17 19.526966 T:139829743949888 NOTICE: m_deviceType : AE_DEVTYPE_PCM
17:15:17 19.526987 T:139829743949888 NOTICE: m_channels : FL,FR,BL,BR
17:15:17 19.527008 T:139829743949888 NOTICE: m_sampleRates : 48000
17:15:17 19.527027 T:139829743949888 NOTICE: m_dataFormats : AE_FMT_S32NE
17:15:17 19.527050 T:139829743949888 NOTICE: m_streamTypes : No passthrough capabilities
17:15:17 19.527084 T:139829743949888 NOTICE: Device 2
17:15:17 19.527119 T:139829743949888 NOTICE: m_deviceName : @:CARD=PCH,DEV=0
17:15:17 19.527140 T:139829743949888 NOTICE: m_displayName : HDA Intel PCH
17:15:17 19.527163 T:139829743949888 NOTICE: m_displayNameExtra: ALC283 Analog
17:15:17 19.527184 T:139829743949888 NOTICE: m_deviceType : AE_DEVTYPE_PCM
17:15:17 19.527205 T:139829743949888 NOTICE: m_channels : FL,FR,BL,BR
17:15:17 19.527224 T:139829743949888 NOTICE: m_sampleRates : 48000
17:15:17 19.527245 T:139829743949888 NOTICE: m_dataFormats : AE_FMT_S32NE
17:15:17 19.527266 T:139829743949888 NOTICE: m_streamTypes : No passthrough capabilities
17:15:17 19.527287 T:139829743949888 NOTICE: Device 3
17:15:17 19.527325 T:139829743949888 NOTICE: m_deviceName : iec958:CARD=PCH,DEV=0
17:15:17 19.527346 T:139829743949888 NOTICE: m_displayName : HDA Intel PCH
17:15:17 19.527388 T:139829743949888 NOTICE: m_displayNameExtra: ALC283 Digital S/PDIF
17:15:17 19.527409 T:139829743949888 NOTICE: m_deviceType : AE_DEVTYPE_IEC958
17:15:17 19.527430 T:139829743949888 NOTICE: m_channels : FL,FR
17:15:17 19.527451 T:139829743949888 NOTICE: m_sampleRates : 44100,48000,88200,96000,192000
17:15:17 19.527473 T:139829743949888 NOTICE: m_dataFormats : AE_FMT_RAW,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE
17:15:17 19.527494 T:139829743949888 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512
17:15:17 19.527517 T:139829743949888 NOTICE: Device 4
17:15:17 19.527559 T:139829743949888 NOTICE: m_deviceName : hdmi:CARD=PCH,DEV=0
17:15:17 19.527582 T:139829743949888 NOTICE: m_displayName : HDA Intel PCH
17:15:17 19.527603 T:139829743949888 NOTICE: m_displayNameExtra: MJI marantz-AVR on HDMI
17:15:17 19.527624 T:139829743949888 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
17:15:17 19.527645 T:139829743949888 NOTICE: m_channels : FL,FR,LFE,FC,BL,BR,BC,BLOC,BROC
17:15:17 19.527666 T:139829743949888 NOTICE: m_sampleRates : 32000,44100,48000,88200,96000,176400,192000
17:15:17 19.527687 T:139829743949888 NOTICE: m_dataFormats : AE_FMT_RAW,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW
17:15:17 19.527712 T:139829743949888 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:15:17 19.527733 T:139829743949888 NOTICE: Enumerated PULSE devices:
17:15:17 19.527754 T:139829743949888 NOTICE: Device 1
17:15:17 19.527792 T:139829743949888 NOTICE: m_deviceName : Default
17:15:17 19.527813 T:139829743949888 NOTICE: m_displayName : Default
17:15:17 19.527834 T:139829743949888 NOTICE: m_displayNameExtra: Bluetooth Audio (PULSEAUDIO)
17:15:17 19.527855 T:139829743949888 NOTICE: m_deviceType : AE_DEVTYPE_PCM
17:15:17 19.527876 T:139829743949888 NOTICE: m_channels : FL,FR
17:15:17 19.527899 T:139829743949888 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000
17:15:17 19.527922 T:139829743949888 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT
17:15:17 19.527943 T:139829743949888 NOTICE: m_streamTypes : No passthrough capabilities
17:15:18 19.542194 T:139829743949888 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml
17:15:18 19.542368 T:139829743949888 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are...
false
cputemp
gputemp
30
4.0
17:15:18 19.544418 T:139829743949888 NOTICE: Loaded settings file from special://profile/advancedsettings.xml
17:15:18 19.544479 T:139829743949888 NOTICE: Contents of special://profile/advancedsettings.xml are...
bicubic
17:15:18 19.544899 T:139829743949888 NOTICE: Default Video Player: VideoPlayer
17:15:18 19.544922 T:139829743949888 NOTICE: Default Audio Player: paplayer
17:15:18 19.544947 T:139829743949888 NOTICE: Disabled debug logging due to GUI setting. Level 0.
17:15:18 19.544968 T:139829743949888 NOTICE: Log level changed to "LOG_LEVEL_NORMAL"
17:15:18 19.545088 T:139829743949888 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml
17:15:18 19.546921 T:139829743949888 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
17:15:18 19.547373 T:139829743949888 NOTICE: Loaded playercorefactory configuration
17:15:18 19.547503 T:139829743949888 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
17:15:18 19.547590 T:139829743949888 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
17:15:18 19.708416 T:139829743949888 NOTICE: Running database version Addons23
17:15:18 19.846798 T:139829743949888 NOTICE: ADDONS: Using repository repository.xbmc.org
17:15:18 19.846863 T:139829743949888 NOTICE: ADDONS: Using repository repository.unofficial.addon.pro
17:15:18 19.846884 T:139829743949888 NOTICE: ADDONS: Using repository repository.kodi.game
17:15:18 19.846903 T:139829743949888 NOTICE: ADDONS: Using repository repository.openelec.tv
17:15:18 19.885014 T:139829743949888 ERROR: CAddonCallbacksAddon - GetAddonSetting - can't find setting 'URL9' in 'InputStream MPEG DASH'
17:15:18 19.926891 T:139829743949888 NOTICE: Checking resolution 16
17:15:18 20.030849 T:139829743949888 NOTICE: Using visual 0x20
17:15:18 20.071461 T:139829743949888 NOTICE: GL_VENDOR = Intel Open Source Technology Center
17:15:18 20.071537 T:139829743949888 NOTICE: GL_RENDERER = Mesa DRI Intel(R) HD Graphics (Cherryview)
17:15:18 20.071566 T:139829743949888 NOTICE: GL_VERSION = 3.0 Mesa 11.2.0-rc4
17:15:18 20.071596 T:139829743949888 NOTICE: GL_SHADING_LANGUAGE_VERSION = 1.30
17:15:18 20.071802 T:139829743949888 NOTICE: GL_EXTENSIONS = GL_ARB_multisample GL_EXT_abgr GL_EXT_bgra GL_EXT_blend_color GL_EXT_blend_minmax GL_EXT_blend_subtract GL_EXT_copy_texture GL_EXT_polygon_offset GL_EXT_subtexture GL_EXT_texture_object GL_EXT_vertex_array GL_EXT_compiled_vertex_array GL_EXT_texture GL_EXT_texture3D GL_IBM_rasterpos_clip GL_ARB_point_parameters GL_EXT_draw_range_elements GL_EXT_packed_pixels GL_EXT_point_parameters GL_EXT_rescale_normal GL_EXT_separate_specular_color GL_EXT_texture_edge_clamp GL_SGIS_generate_mipmap GL_SGIS_texture_border_clamp GL_SGIS_texture_edge_clamp GL_SGIS_texture_lod GL_ARB_framebuffer_sRGB GL_ARB_multitexture GL_EXT_framebuffer_sRGB GL_IBM_multimode_draw_arrays GL_IBM_texture_mirrored_repeat GL_3DFX_texture_compression_FXT1 GL_ARB_texture_cube_map GL_ARB_texture_env_add GL_ARB_transpose_matrix GL_EXT_blend_func_separate GL_EXT_fog_coord GL_EXT_multi_draw_arrays GL_EXT_secondary_color GL_EXT_texture_env_add GL_EXT_texture_filter_anisotropic GL_EXT_texture_lod_bias GL_INGR_blend_func_separate GL_NV_blend_square GL_NV_light_max_exponent GL_NV_texgen_reflection GL_NV_texture_env_combine4 GL_S3_s3tc GL_SUN_multi_draw_arrays GL_ARB_texture_border_clamp GL_ARB_texture_compression GL_EXT_framebuffer_object GL_EXT_texture_env_combine GL_EXT_texture_env_dot3 GL_MESA_window_pos GL_NV_packed_depth_stencil GL_NV_texture_rectangle GL_ARB_depth_texture GL_ARB_occlusion_query GL_ARB_shadow GL_ARB_texture_env_combine GL_ARB_texture_env_crossbar GL_ARB_texture_env_dot3 GL_ARB_texture_mirrored_repeat GL_ARB_window_pos GL_EXT_stencil_two_side GL_EXT_texture_cube_map GL_NV_depth_clamp GL_APPLE_packed_pixels GL_APPLE_vertex_array_object GL_ARB_draw_buffers GL_ARB_fragment_program GL_ARB_fragment_shader GL_ARB_shader_objects GL_ARB_vertex_program GL_ARB_vertex_shader GL_ATI_draw_buffers GL_ATI_texture_env_combine3 GL_ATI_texture_float GL_EXT_shadow_funcs GL_EXT_stencil_wrap GL_MESA_pack_invert GL_NV_primitive_restart GL_ARB_depth_clamp GL_ARB_fragment_program_shadow GL_ARB_half_float_pixel GL_ARB_occlusion_query2 GL_ARB_point_sprite GL_ARB_shading_language_100 GL_ARB_sync GL_ARB_texture_non_power_of_two GL_ARB_vertex_buffer_object GL_ATI_blend_equation_separate GL_EXT_blend_equation_separate GL_OES_read_format GL_ARB_color_buffer_float GL_ARB_pixel_buffer_object GL_ARB_texture_compression_rgtc GL_ARB_texture_float GL_ARB_texture_rectangle GL_EXT_packed_float GL_EXT_pixel_buffer_object GL_EXT_texture_compression_dxt1 GL_EXT_texture_compression_rgtc GL_EXT_texture_rectangle GL_EXT_texture_sRGB GL_EXT_texture_shared_exponent GL_ARB_framebuffer_object GL_EXT_framebuffer_blit GL_EXT_framebuffer_multisample GL_EXT_packed_depth_stencil GL_APPLE_object_purgeable GL_ARB_vertex_array_object GL_ATI_separate_stencil GL_EXT_draw_buffers2 GL_EXT_draw_instanced GL_EXT_gpu_program_parameters GL_EXT_texture_array GL_EXT_texture_integer GL_EXT_texture_sRGB_decode GL_EXT_timer_query GL_OES_EGL_image GL_ARB_copy_buffer GL_ARB_depth_buffer_float GL_ARB_draw_instanced GL_ARB_half_float_vertex GL_ARB_instanced_arrays GL_ARB_map_buffer_range GL_ARB_texture_rg GL_ARB_texture_swizzle GL_ARB_vertex_array_bgra GL_EXT_texture_swizzle GL_EXT_vertex_array_bgra GL_NV_conditional_render GL_AMD_conservative_depth GL_AMD_draw_buffers_blend GL_AMD_seamless_cubemap_per_texture GL_ARB_ES2_compatibility GL_ARB_blend_func_extended GL_ARB_debug_output GL_ARB_draw_buffers_blend GL_ARB_draw_elements_base_vertex GL_ARB_explicit_attrib_location GL_ARB_fragment_coord_conventions GL_ARB_provoking_vertex GL_ARB_sample_shading GL_ARB_sampler_objects GL_ARB_seamless_cube_map GL_ARB_shader_texture_lod GL_ARB_texture_cube_map_array GL_ARB_texture_gather GL_ARB_texture_multisample GL_ARB_texture_query_lod GL_ARB_texture_rgb10_a2ui GL_ARB_uniform_buffer_object GL_ARB_vertex_type_2_10_10_10_rev GL_EXT_provoking_vertex GL_EXT_texture_snorm GL_MESA_texture_signed_rgba GL_NV_texture_barrier GL_ARB_get_program_binary GL_ARB_robustness GL_ARB_separate_shader_objects GL_ARB_shader_bit_encoding GL_ARB_texture_compression_bptc GL_ARB_timer_query GL_ARB_transform_feedback2 GL_ARB_transform_feedback3 GL_ANGLE_texture_compression_dxt3 GL_ANGLE_texture_compression_dxt5 GL_ARB_compressed_texture_pixel_storage GL_ARB_conservative_depth GL_ARB_internalformat_query GL_ARB_map_buffer_alignment GL_ARB_shader_atomic_counters GL_ARB_shader_image_load_store GL_ARB_shading_language_420pack GL_ARB_shading_language_packing GL_ARB_texture_storage GL_ARB_transform_feedback_instanced GL_EXT_framebuffer_multisample_blit_scaled GL_EXT_transform_feedback GL_AMD_shader_trinary_minmax GL_ARB_ES3_compatibility GL_ARB_arrays_of_arrays GL_ARB_clear_buffer_object GL_ARB_copy_image GL_ARB_explicit_uniform_location GL_ARB_framebuffer_no_attachments GL_ARB_invalidate_subdata GL_ARB_program_interface_query GL_ARB_shader_image_size GL_ARB_shader_storage_buffer_object GL_ARB_stencil_texturing GL_ARB_texture_query_levels GL_ARB_texture_storage_multisample GL_ARB_texture_view GL_ARB_vertex_attrib_binding GL_KHR_debug GL_ARB_buffer_storage GL_ARB_clear_texture GL_ARB_multi_bind GL_ARB_seamless_cubemap_per_texture GL_ARB_shader_draw_parameters GL_ARB_texture_mirror_clamp_to_edge GL_ARB_vertex_type_10f_11f_11f_rev GL_EXT_shader_integer_mix GL_ARB_clip_control GL_ARB_conditional_render_inverted GL_ARB_derivative_control GL_ARB_get_texture_sub_image GL_ARB_pipeline_statistics_query GL_ARB_shader_texture_image_samples GL_ARB_texture_barrier GL_EXT_polygon_offset_clamp GL_KHR_context_flush_control GL_ARB_shader_clock GL_EXT_shader_samples_identical
17:15:19 20.542589 T:139829743949888 NOTICE: Running database version Addons23
17:15:19 20.544941 T:139829743949888 NOTICE: Running database version ViewModes6
17:15:19 20.578201 T:139829743949888 NOTICE: Running database version Textures13
17:15:19 20.584595 T:139829743949888 NOTICE: Running database version MyMusic60
17:15:19 20.661970 T:139829743949888 NOTICE: Running database version MyVideos104
17:15:19 20.664507 T:139829743949888 NOTICE: Running database version TV29
17:15:19 20.666389 T:139829743949888 NOTICE: Running database version Epg11
17:15:19 20.667988 T:139829743949888 NOTICE: start dvd mediatype detection
17:15:19 20.719406 T:139829449705216 NOTICE: Register - new cec device registered on cec->/dev/ttyACM0: CEC Adapter (2548:1002)
17:15:19 20.905380 T:139829743949888 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList"
17:15:19 21.019131 T:139829743949888 ERROR: Misplaced [
17:15:19 21.019197 T:139829743949888 ERROR: Error parsing boolean expression $EXP[infodialog_active]
17:15:19 21.225063 T:139829743949888 NOTICE: ActiveAE DSP - starting
17:15:19 21.250992 T:139829743949888 NOTICE: initialize done
17:15:19 21.251047 T:139829743949888 NOTICE: Running the application...
17:15:19 21.264511 T:139829743949888 NOTICE: starting zeroconf publishing
17:15:19 21.264952 T:139829743949888 NOTICE: WebServer: Started the webserver
17:15:19 21.265003 T:139829743949888 NOTICE: starting upnp client
17:15:19 21.303728 T:139829743949888 NOTICE: starting upnp server
17:15:19 21.320105 T:139829743949888 NOTICE: starting upnp controller
17:15:19 21.322508 T:139829743949888 NOTICE: starting upnp renderer
17:15:19 21.340874 T:139828334388992 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777
17:15:19 21.344471 T:139828334388992 NOTICE: UDP: Listening on port 9777
17:15:34 36.340149 T:139829743949888 ERROR: Error parsing boolean expression $EXP[infodialog_active]
17:15:50 51.658020 T:139829743949888 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM"
17:15:50 51.658089 T:139829743949888 NOTICE: Enabled debug logging due to GUI setting. Level 2.
17:15:50 51.658546 T:139829743949888 DEBUG: ------ Window Init () ------
17:15:50 51.931786 T:139829287311104 DEBUG: PushCecKeypress - received key b duration 275
17:15:50 52.176769 T:139829743949888 INFO: CheckIdle - Closing session to http://feeds.openelec.tv (easy=0x7f2c900052e0, multi=0x7f2c9003a2a0)
17:15:51 52.696487 T:139829743949888 INFO: CheckIdle - Closing session to http://feeds.xbmc.org (easy=0x7f2c900404e0, multi=0x7f2c90061030)
17:15:52 54.461018 T:139829287311104 DEBUG: PushCecKeypress - received key fc duration 0
17:15:52 54.478020 T:139829743949888 DEBUG: OnKey: 252 (0xfc) pressed, action is ActivateWindow(MyVideos)
17:15:52 54.478107 T:139829743949888 DEBUG: Activating window ID: 10025
17:15:53 54.733307 T:139829287311104 DEBUG: PushCecKeypress - received key fc duration 273
17:15:53 54.795498 T:139829743949888 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------
17:15:53 54.802113 T:139829743949888 DEBUG: ------ Window Init (MyVideoNav.xml) ------
17:15:53 54.802174 T:139829743949888 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY
17:15:53 54.831741 T:139829743949888 ERROR: Misplaced [
17:15:53 54.831810 T:139829743949888 ERROR: Error parsing boolean expression $EXP[infodialog_active]
17:15:53 54.930153 T:139828926588672 ERROR: GetDirectory - Error getting
17:15:53 54.934330 T:139829743949888 ERROR: Previous line repeats 1 times.
17:15:53 54.934391 T:139829743949888 DEBUG: CGUIMediaWindow::GetDirectory ()
17:15:53 54.934414 T:139829743949888 DEBUG: ParentPath = []
17:15:53 54.941498 T:139828367959808 DEBUG: Thread BackgroundLoader start, auto delete: false
17:15:53 54.949474 T:139828367959808 DEBUG: Thread BackgroundLoader 139828367959808 terminating
17:15:56 57.709480 T:139829287311104 DEBUG: PushCecKeypress - received key a8 duration 0
17:15:56 57.709808 T:139829743949888 DEBUG: OnKey: 168 (0xa8) pressed, action is Right
17:15:56 57.985901 T:139829287311104 DEBUG: PushCecKeypress - received key a8 duration 276
17:15:56 58.161896 T:139829287311104 DEBUG: PushCecKeypress - received key a8 duration 0
17:15:56 58.189575 T:139829743949888 DEBUG: OnKey: 168 (0xa8) pressed, action is Right
17:15:56 58.433487 T:139829287311104 DEBUG: PushCecKeypress - received key a8 duration 272
17:15:58 60.157818 T:139829287311104 DEBUG: PushCecKeypress - received key b duration 0
17:15:58 60.193943 T:139829743949888 DEBUG: OnKey: 11 (0x0b) pressed, action is Select
17:15:58 60.195381 T:139829743949888 DEBUG: CGUIMediaWindow::GetDirectory (library://video/files.xml/)
17:15:58 60.195442 T:139829743949888 DEBUG: ParentPath = []
17:15:58 60.222637 T:139828367959808 DEBUG: Thread BackgroundLoader start, auto delete: false
17:15:58 60.229916 T:139828367959808 DEBUG: Thread BackgroundLoader 139828367959808 terminating
17:15:58 60.434490 T:139829287311104 DEBUG: PushCecKeypress - received key b duration 277
17:15:59 61.459698 T:139829287311104 DEBUG: PushCecKeypress - received key a8 duration 0
17:15:59 61.475784 T:139829743949888 DEBUG: OnKey: 168 (0xa8) pressed, action is Right
17:16:00 61.736477 T:139829287311104 DEBUG: PushCecKeypress - received key a8 duration 277
17:16:00 61.858780 T:139829287311104 DEBUG: PushCecKeypress - received key a8 duration 0
17:16:00 61.876324 T:139829743949888 DEBUG: OnKey: 168 (0xa8) pressed, action is Right
17:16:00 62.132557 T:139829287311104 DEBUG: PushCecKeypress - received key a8 duration 274
17:16:01 62.661907 T:139829287311104 DEBUG: PushCecKeypress - received key b duration 0
17:16:01 62.678062 T:139829743949888 DEBUG: OnKey: 11 (0x0b) pressed, action is Select
17:16:01 62.678799 T:139829743949888 DEBUG: CGUIMediaWindow::GetDirectory (/storage/mediathek/Videos/HD/)
17:16:01 62.678841 T:139829743949888 DEBUG: ParentPath = [sources://video/]
17:16:01 62.692726 T:139829743949888 DEBUG: RunQuery took 0 ms for 0 items query: select * from movie_view WHERE c23=51
17:16:01 62.693867 T:139828367959808 DEBUG: Thread BackgroundLoader start, auto delete: false
17:16:01 62.701557 T:139828926588672 DEBUG: GetImageHash - unable to stat url
17:16:01 62.790226 T:139828367959808 DEBUG: Thread BackgroundLoader 139828367959808 terminating
17:16:01 62.936081 T:139829287311104 DEBUG: PushCecKeypress - received key b duration 274
17:16:02 63.663002 T:139829287311104 DEBUG: PushCecKeypress - received key a7 duration 0
17:16:02 63.698524 T:139829743949888 DEBUG: OnKey: 167 (0xa7) pressed, action is Down
17:16:02 63.699459 T:139828498790144 DEBUG: GetImageHash - unable to stat url
17:16:02 63.934437 T:139829287311104 DEBUG: PushCecKeypress - received key a7 duration 272
17:16:02 64.510803 T:139829287311104 DEBUG: PushCecKeypress - received key b duration 0
17:16:02 64.519188 T:139829743949888 DEBUG: OnKey: 11 (0x0b) pressed, action is Select
17:16:02 64.519783 T:139829743949888 DEBUG: CGUIMediaWindow::GetDirectory (/storage/mediathek/Videos/HD/3D/)
17:16:02 64.519821 T:139829743949888 DEBUG: ParentPath = [/storage/mediathek/Videos/HD/]
17:16:03 64.545181 T:139829743949888 DEBUG: RunQuery took 3 ms for 59 items query: select * from movie_view WHERE c23=52
17:16:03 64.553902 T:139828367959808 DEBUG: Thread BackgroundLoader start, auto delete: false
17:16:03 64.558044 T:139828300818176 DEBUG: GetImageHash - unable to stat url
17:16:03 64.578934 T:139828367959808 DEBUG: Thread BackgroundLoader 139828367959808 terminating
17:16:03 64.788124 T:139829287311104 DEBUG: PushCecKeypress - received key b duration 278
17:16:03 65.357750 T:139829287311104 DEBUG: PushCecKeypress - received key a7 duration 0
17:16:03 65.358269 T:139829743949888 DEBUG: OnKey: 167 (0xa7) pressed, action is Down
17:16:03 65.359833 T:139828918195968 DEBUG: GetImageHash - unable to stat url
17:16:03 65.375122 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: [mjpeg] Changing bps to 8
17:16:03 65.378731 T:139828300818176 INFO: ffmpeg[7F2C50332700]: [mjpeg] Changing bps to 8
17:16:04 65.636223 T:139829287311104 DEBUG: PushCecKeypress - received key a7 duration 279
17:16:04 66.360565 T:139829287311104 DEBUG: PushCecKeypress - received key b duration 0
17:16:04 66.383873 T:139829743949888 DEBUG: OnKey: 11 (0x0b) pressed, action is Select
17:16:04 66.389435 T:139829743949888 DEBUG: OnPlayMedia /storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv
17:16:04 66.389656 T:139829743941376 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc
17:16:04 66.389732 T:139829743941376 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd
17:16:04 66.395020 T:139829743949888 DEBUG: Loading settings for /storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv
17:16:04 66.401337 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers(/storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv)
17:16:04 66.401398 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
17:16:04 66.401428 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
17:16:04 66.401451 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp
17:16:04 66.401497 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
17:16:04 66.401535 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
17:16:04 66.401566 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
17:16:04 66.401619 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
17:16:04 66.401657 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
17:16:04 66.401680 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
17:16:04 66.401703 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
17:16:04 66.401733 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
17:16:04 66.401772 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
17:16:04 66.401802 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
17:16:04 66.401833 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer)
17:16:04 66.401855 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
17:16:04 66.401871 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
17:16:04 66.401894 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: VIERA ST60 Series
17:16:04 66.401917 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: Marantz SR7010
17:16:04 66.401939 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: Kodi (OpenELEC-RPi2)
17:16:04 66.401955 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DMP-BDT500
17:16:04 66.401978 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers: added 5 players
17:16:04 66.404243 T:139829743949888 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData
17:16:04 66.404350 T:139829743949888 NOTICE: VideoPlayer: Opening: /storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv
17:16:04 66.404373 T:139829743949888 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
17:16:04 66.404465 T:139829743949888 DEBUG: LinuxRendererGL: Cleaning up GL resources
17:16:04 66.404549 T:139829743949888 DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16
17:16:04 66.404984 T:139828367959808 DEBUG: Thread VideoPlayer start, auto delete: false
17:16:04 66.405212 T:139828367959808 NOTICE: Creating InputStream
17:16:04 66.415108 T:139828367959808 DEBUG: ScanForExternalSubtitles: Searching for subtitles...
17:16:04 66.418724 T:139828367959808 DEBUG: ScanForExternalSubtitles: END (total time: 3 ms)
17:16:04 66.418808 T:139828367959808 NOTICE: Creating Demuxer
17:16:04 66.421333 T:139828367959808 DEBUG: Open - probing detected format [matroska,webm]
17:16:04 66.422012 T:139828367959808 DEBUG: Open - avformat_find_stream_info starting
17:16:04 66.450546 T:139828367959808 DEBUG: Open - av_find_stream_info finished
17:16:04 66.450661 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Input #0, matroska,webm, /storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mk':
17:16:04 66.450722 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Metadata:
17:16:04 66.451004 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: encoder : libebml v1.3.0 + libmatroska v1.4.1
17:16:04 66.451042 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: creation_time : 2014-06-07 20:18:01
17:16:04 66.451103 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Duration: 01:42:36.73, start: 0.000000, bitrate: 14228 kb/s
17:16:04 66.451141 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Chapter #0:0: start 0.000000, end 626.376000
17:16:04 66.451172 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Metadata:
17:16:04 66.451202 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: title : 00:00:00.000
17:16:04 66.451241 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Chapter #0:1: start 626.376000, end 1254.628000
17:16:04 66.451263 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Metadata:
17:16:04 66.451294 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: title : 00:10:26.376
17:16:04 66.451355 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Chapter #0:2: start 1254.628000, end 1875.290000
17:16:04 66.451378 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Metadata:
17:16:04 66.451408 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: title : 00:20:54.628
17:16:04 66.451447 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Chapter #0:3: start 1875.290000, end 2458.498000
17:16:04 66.451469 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Metadata:
17:16:04 66.451500 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: title : 00:31:15.290
17:16:04 66.451546 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Chapter #0:4: start 2458.498000, end 3050.714000
17:16:04 66.451576 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Metadata:
17:16:04 66.451607 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: title : 00:40:58.498
17:16:04 66.451637 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Chapter #0:5: start 3050.714000, end 3605.435000
17:16:04 66.451668 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Metadata:
17:16:04 66.451698 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: title : 00:50:50.714
17:16:04 66.451828 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Chapter #0:6: start 3605.435000, end 4191.813000
17:16:04 66.451851 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Metadata:
17:16:04 66.451881 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: title : 01:00:05.435
17:16:04 66.451920 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Chapter #0:7: start 4191.813000, end 4791.245000
17:16:04 66.451942 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Metadata:
17:16:04 66.451973 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: title : 01:09:51.813
17:16:04 66.452003 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Chapter #0:8: start 4791.245000, end 5467.295000
17:16:04 66.452034 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Metadata:
17:16:04 66.452065 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: title : 01:19:51.245
17:16:04 66.452095 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Chapter #0:9: start 5467.295000, end 5637.131000
17:16:04 66.452118 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Metadata:
17:16:04 66.452148 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: title : 01:31:07.295
17:16:04 66.452187 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Chapter #0:10: start 5637.131000, end 6156.726000
17:16:04 66.452209 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Metadata:
17:16:04 66.452240 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: title : 01:33:57.131
17:16:04 66.452507 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Stream #0:0: Video: h264 (High), yuv420p, 1920x1080, SAR 1:2 DAR 8:9, 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc (default)
17:16:04 66.452538 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Metadata:
17:16:04 66.452568 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: title : 300.Rise.Of.An.Empire.2014.3D.1080p.Bluray.HOU.X264.DL.GER.DTSD-zman
17:16:04 66.452599 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: stereo_mode : top_bottom
17:16:04 66.452675 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Side data:
17:16:04 66.452705 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: stereo3d: top and bottom
17:16:04 66.452812 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Stream #0:1(ger): Audio: dts (DTS), 48000 Hz, 5.1(side), fltp, 1536 kb/s (default)
17:16:04 66.452835 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Metadata:
17:16:04 66.452873 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: title : DTS Dubbed by Der Schuft, Center: Line THX @ TwixX
17:16:04 66.452927 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Stream #0:2(eng): Audio: dts (DTS), 48000 Hz, 5.1(side), fltp, 1536 kb/s
17:16:04 66.453011 T:139828367959808 INFO: ffmpeg[7F2C5433A700]: Stream #0:3(eng): Subtitle: dvd_subtitle, 1920x1080 (default)
17:16:04 66.453102 T:139828367959808 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0
17:16:04 66.453125 T:139828367959808 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1
17:16:04 66.453148 T:139828367959808 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 2
17:16:04 66.453171 T:139828367959808 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 3
17:16:04 66.453377 T:139828367959808 NOTICE: Opening stream: 0 source: 256
17:16:04 66.453445 T:139828367959808 NOTICE: Creating video codec with codec id: 28
17:16:04 66.453476 T:139828367959808 DEBUG: FactoryCodec - Video: - Opening
17:16:04 66.453499 T:139828367959808 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
17:16:04 66.453773 T:139828367959808 DEBUG: FactoryCodec - Video: ff-h264 - Opened
17:16:04 66.453819 T:139828367959808 DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 28
17:16:04 66.453850 T:139828367959808 NOTICE: Creating video thread
17:16:04 66.453972 T:139828367959808 NOTICE: Opening stream: 1 source: 256
17:16:04 66.453995 T:139828367959808 NOTICE: Finding audio codec for: 86020
17:16:04 66.454063 T:139828367959808 DEBUG: FactoryCodec - Audio: passthrough - Opening
17:16:04 66.454117 T:139828126009088 DEBUG: Thread VideoPlayerVideo start, auto delete: false
17:16:04 66.454269 T:139828367959808 DEBUG: FactoryCodec - Audio: passthrough - Opened
17:16:04 66.454315 T:139828126009088 NOTICE: running thread: video_thread
17:16:04 66.454430 T:139828367959808 NOTICE: Creating audio thread
17:16:04 66.454521 T:139828367959808 NOTICE: Opening stream: 3 source: 256
17:16:04 66.454544 T:139828098504448 DEBUG: Thread VideoPlayerAudio start, auto delete: false
17:16:04 66.454620 T:139828367959808 DEBUG: FactoryCodec - Overlay: FFmpeg Subtitle Decoder - Opening
17:16:04 66.454834 T:139828098504448 NOTICE: running thread: CVideoPlayerAudio::Process()
17:16:04 66.455154 T:139828367959808 DEBUG: Open - parsed extradata: size: 1920 x 1080
17:16:04 66.455269 T:139828367959808 DEBUG: FactoryCodec - Overlay: FFmpeg Subtitle Decoder - Opened
17:16:04 66.455353 T:139828367959808 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: /storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv
17:16:04 66.455521 T:139828367959808 DEBUG: OnPlayBackStarted: play state was 1, starting 1
17:16:04 66.455559 T:139828367959808 DEBUG: CVideoPlayer::SetCaching - caching state 2
17:16:04 66.455902 T:139829743949888 DEBUG: PlayFile: OpenFile succeed, play state 2
17:16:04 66.455978 T:139829743949888 DEBUG: OnPlayBackStarted: play state was 2, starting 0
17:16:04 66.458229 T:139828098504448 DEBUG: CDVDAudio::Pause - pausing audio stream
17:16:04 66.458679 T:139828098504448 INFO: CAEStreamParser::SyncDTS - dts stream detected (6 channels, 48000Hz, 16bit BE, period: 512)
17:16:04 66.458717 T:139828367959808 NOTICE: CDVDMessageQueue::GetLevel() - can't determine level
17:16:04 66.458778 T:139828098504448 NOTICE: Previous line repeats 1 times.
17:16:04 66.458794 T:139828098504448 NOTICE: Creating audio stream (codec id: 86020, channels: 6, sample rate: 48000, pass-through)
17:16:04 66.458839 T:139828367959808 NOTICE: CDVDMessageQueue::GetLevel() - can't determine level
17:16:04 66.459160 T:139828126009088 NOTICE: Previous line repeats 7 times.
17:16:04 66.459206 T:139828126009088 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback
17:16:04 66.459244 T:139828126009088 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
17:16:04 66.459373 T:139828126009088 DEBUG: VAAPI - open decoder
17:16:04 66.459915 T:139828098504448 DEBUG: CVideoPlayerAudio:: synctype set to 0: clock feedback
17:16:04 66.482658 T:139828126009088 DEBUG: VAAPI - initialize version 0.39
17:16:04 66.482903 T:139828126009088 DEBUG: VAAPI - driver in use: Intel i965 driver for Intel(R) CherryView - 1.7.0
17:16:04 66.482964 T:139828126009088 DEBUG: VAAPI - attrib 0 (get/set) min -100 max 100 value 0x0
17:16:04 66.483009 T:139828126009088 DEBUG: VAAPI - attrib 1 (get/set) min 0 max 100 value 0x32
17:16:04 66.483131 T:139828126009088 DEBUG: VAAPI - attrib 2 (get/set) min -180 max 180 value 0x0
17:16:04 66.483154 T:139828126009088 DEBUG: VAAPI - attrib 3 (get/set) min 0 max 100 value 0x32
17:16:04 66.483170 T:139828126009088 DEBUG: VAAPI - attrib 6 (get/set) min 0 max 3 value 0x0
17:16:04 66.483284 T:139828126009088 DEBUG: VAAPI - profile 0
17:16:04 66.483307 T:139828126009088 DEBUG: VAAPI - profile 1
17:16:04 66.483322 T:139828126009088 DEBUG: VAAPI - profile 13
17:16:04 66.483368 T:139828126009088 DEBUG: VAAPI - profile 6
17:16:04 66.483391 T:139828126009088 DEBUG: VAAPI - profile 7
17:16:04 66.483414 T:139828126009088 DEBUG: VAAPI - profile 15
17:16:04 66.483429 T:139828126009088 DEBUG: VAAPI - profile 16
17:16:04 66.483452 T:139828126009088 DEBUG: VAAPI - profile 8
17:16:04 66.483475 T:139828126009088 DEBUG: VAAPI - profile 9
17:16:04 66.483490 T:139828126009088 DEBUG: VAAPI - profile 10
17:16:04 66.483597 T:139828126009088 DEBUG: VAAPI - profile -1
17:16:04 66.483620 T:139828126009088 DEBUG: VAAPI - profile 12
17:16:04 66.483643 T:139828126009088 DEBUG: VAAPI - profile 14
17:16:04 66.483665 T:139828126009088 DEBUG: VAAPI - profile 17
17:16:04 66.488541 T:139829716621056 INFO: CActiveAESink::OpenSink - initialize sink
17:16:04 66.489685 T:139828081456896 DEBUG: Thread Vaapi-Output start, auto delete: false
17:16:04 66.489754 T:139828081456896 NOTICE: COutput::OnStartup: Output Thread created
17:16:04 66.505310 T:139828081456896 DEBUG: VAAPI::COutput::CreateEGLContext - created context
17:16:04 66.505470 T:139828081456896 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libsse4-x86_64-linux.so)
17:16:04 66.505547 T:139828081456896 DEBUG: Loading: /usr/lib/kodi/system/libsse4-x86_64-linux.so
17:16:04 66.527657 T:139828081456896 DEBUG: VAAPI::COutput::InitBufferPool - Surfaces created
17:16:05 66.536247 T:139829743949888 DEBUG: StereoscopicsManager: autodetected stereo mode for movie mode top_bottom is: split_horizontal
17:16:05 66.536362 T:139829743949888 DEBUG: Previous line repeats 1 times.
17:16:05 66.536377 T:139829743949888 DEBUG: StereoscopicsManager: stereo mode setting changed to split_horizontal
17:16:05 66.536400 T:139829743949888 DEBUG: StereoscopicsManager::ApplyStereoMode: trying to apply stereo mode. Current: off | Target: split_horizontal
17:16:05 66.536423 T:139829743949888 DEBUG: StereoscopicsManager: stereo mode changed to split_horizontal
17:16:05 66.536850 T:139828498790144 DEBUG: CGUIInfoManager::SetCurrentMovie(/storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv)
17:16:05 66.540092 T:139829743941376 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
17:16:05 66.540199 T:139829743941376 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
17:16:05 66.540337 T:139829743941376 DEBUG: UPnP: Building didl for object '/storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv'
17:16:05 66.542496 T:139829743949888 DEBUG: ------ Window Init (DialogNotification.xml) ------
17:16:05 66.542717 T:139828498790144 DEBUG: GetMovieId (/storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv), query = select idMovie from movie where idFile=258
17:16:05 66.545212 T:139828126009088 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
17:16:05 66.581421 T:139829743949888 DEBUG: Previous line repeats 4 times.
17:16:05 66.581505 T:139829743949888 INFO: GL: Maximum texture width: 8192
17:16:05 66.582405 T:139828126009088 DEBUG: CRenderManager::Configure - change configuration. 1920x1080. display: 960x1080. framerate: 23.98. format: VAAPI
17:16:05 66.628197 T:139829743949888 DEBUG: DeleteRenderer - deleting renderer
17:16:05 66.628296 T:139829743949888 DEBUG: LinuxRendererGL: Cleaning up GL resources
17:16:05 66.629715 T:139829743949888 DEBUG: Previous line repeats 1 times.
17:16:05 66.629791 T:139829743949888 DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16
17:16:05 66.629868 T:139829743949888 DEBUG: GL: Requested render method: 0
17:16:05 66.632660 T:139829743949888 DEBUG: GL: BaseYUV2RGBGLSLShader: defines:
#define XBMC_OUTPUT 1
#define XBMC_DITHER 1
#define XBMC_FULLRANGE 1
#define XBMC_texture_rectangle 0
#define XBMC_texture_rectangle_hack 0
#define XBMC_STRETCH 0
#define XBMC_NV12_RRG
17:16:05 66.633507 T:139829743949888 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader
17:16:05 66.634354 T:139829287311104 DEBUG: PushCecKeypress - received key b duration 274
17:16:05 66.645622 T:139829743949888 DEBUG: GL: Vertex Shader compilation log:
17:16:05 66.645706 T:139829743949888 DEBUG: GL: Vertex Shader compiled successfully
17:16:05 66.650925 T:139829743949888 DEBUG: GL: Pixel Shader compilation log:
17:16:05 66.651077 T:139829743949888 DEBUG: GL: Fragment Shader compiled successfully
17:16:05 66.678993 T:139829743949888 DEBUG: GL: Vertex Shader compilation log:
17:16:05 66.679054 T:139829743949888 DEBUG: GL: Vertex Shader compiled successfully
17:16:05 66.679863 T:139829743949888 DEBUG: GL: Pixel Shader compilation log:
17:16:05 66.679893 T:139829743949888 DEBUG: GL: Fragment Shader compiled successfully
17:16:05 66.689690 T:139829716621056 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0
17:16:05 66.689758 T:139829716621056 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0"
17:16:05 66.690529 T:139829743949888 NOTICE: GL: NPOT texture support detected
17:16:05 66.690590 T:139829743949888 NOTICE: GL: Using GL_ARB_pixel_buffer_object
17:16:05 66.690613 T:139829743949888 NOTICE: Using GL_TEXTURE_2D
17:16:05 66.690636 T:139829743949888 DEBUG: CRenderManager::Configure - 4
17:16:05 66.691223 T:139829743949888 DEBUG: GL: Requested render method: 0
17:16:05 66.691422 T:139829743949888 DEBUG: GL: BaseYUV2RGBGLSLShader: defines:
#define XBMC_OUTPUT 1
#define XBMC_DITHER 1
#define XBMC_FULLRANGE 1
#define XBMC_texture_rectangle 0
#define XBMC_texture_rectangle_hack 0
#define XBMC_STRETCH 0
#define XBMC_NV12_RRG
17:16:05 66.691582 T:139829743949888 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader
17:16:05 66.692291 T:139828367959808 DEBUG: CVideoPlayer::HandleMessages - player started 2
17:16:05 66.693169 T:139829743949888 DEBUG: GL: Vertex Shader compilation log:
17:16:05 66.693199 T:139829743949888 DEBUG: GL: Vertex Shader compiled successfully
17:16:05 66.693871 T:139829716621056 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x06,AES1=0x82,AES2=0x00,AES3=0x02"
17:16:05 66.694176 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2400, bufferSize 9600
17:16:05 66.696609 T:139829743949888 DEBUG: GL: Pixel Shader compilation log:
17:16:05 66.696693 T:139829743949888 DEBUG: GL: Fragment Shader compiled successfully
17:16:05 66.700203 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2400, bufferSize 9600
17:16:05 66.700241 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms
17:16:05 66.701111 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
17:16:05 66.701134 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: RAW,RAW
17:16:05 66.701157 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: RAW,RAW (ALSA: none)
17:16:05 66.701202 T:139829716621056 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
17:16:05 66.701225 T:139829716621056 DEBUG: Output Device : HDA Intel PCH
17:16:05 66.701241 T:139829716621056 DEBUG: Sample Rate : 48000
17:16:05 66.701263 T:139829716621056 DEBUG: Sample Format : AE_FMT_S16NE
17:16:05 66.701286 T:139829716621056 DEBUG: Channel Count : 2
17:16:05 66.701302 T:139829716621056 DEBUG: Channel Layout: RAW,RAW
17:16:05 66.701324 T:139829716621056 DEBUG: Frames : 2400
17:16:05 66.701347 T:139829716621056 DEBUG: Frame Size : 4
17:16:05 66.708359 T:139829725013760 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
17:16:05 66.708618 T:139828098504448 DEBUG: CDVDClock::Discontinuity - CVideoPlayerAudio::OutputPacket - was:253100.359000, should be:65.289000, error:-253035.070000
17:16:05 66.709435 T:139829725013760 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
17:16:05 66.712502 T:139828367959808 DEBUG: CVideoPlayer::HandleMessages - player started 1
17:16:05 66.712570 T:139828367959808 DEBUG: CVideoPlayer::SetCaching - caching state 3
17:16:05 66.712738 T:139828367959808 DEBUG: CVideoPlayer::SetCaching - caching state 0
17:16:05 66.712769 T:139828367959808 DEBUG: VideoPlayer::Sync - Audio - pts: 181000.000000, cache: 317986.313822, totalcache: 600000.023842
17:16:05 66.712791 T:139828367959808 DEBUG: VideoPlayer::Sync - Video - pts: 18442240474082181120.000000, cache: 50000.000000, totalcache: 100000.000000
17:16:05 66.713028 T:139828126009088 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(-136986.313822)
17:16:05 66.713051 T:139828126009088 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
17:16:05 66.716537 T:139828098504448 DEBUG: Previous line repeats 1 times.
17:16:05 66.716614 T:139828098504448 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(-136986.313822)
17:16:05 66.716698 T:139828098504448 DEBUG: CDVDAudio::Resume - resume audio stream
17:16:05 66.717056 T:139828126009088 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
17:16:05 66.718422 T:139829725013760 DEBUG: ActiveAE - start sync of audio stream
17:16:05 66.727608 T:139828126009088 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
17:16:05 66.734573 T:139829743949888 NOTICE: GL: NPOT texture support detected
17:16:05 66.734673 T:139829743949888 NOTICE: GL: Using GL_ARB_pixel_buffer_object
17:16:05 66.735619 T:139828126009088 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
17:16:05 66.806564 T:139829743949888 DEBUG: Previous line repeats 1 times.
17:16:05 66.806656 T:139829743949888 DEBUG: Activating window ID: 12005
17:16:05 66.807457 T:139829743949888 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
17:16:05 66.808121 T:139829743949888 DEBUG: ------ Window Init (VideoFullScreen.xml) ------
17:16:05 66.808167 T:139829743949888 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY
17:16:05 66.821243 T:139829743949888 NOTICE: Display resolution ADJUST : HDMI2: 1920x1080 @ 23.98Hz (24) (weight: 0.000)
17:16:05 66.821304 T:139829743949888 NOTICE: CWinSystemX11::SetFullScreen - calling xrandr
17:16:05 66.821472 T:139829743949888 DEBUG: OnLostDevice - notify display change event
17:16:05 66.821503 T:139829743949888 DEBUG: Flush - flushing renderer
17:16:05 67.056908 T:139829743949888 NOTICE: VideoPlayer: OnLostDisplay received
17:16:05 67.057037 T:139829743949888 INFO: XRANDR: /usr/lib/kodi/kodi-xrandr --screen 0 --output HDMI2 --mode 0x10c
17:16:05 67.305626 T:139829735548672 DEBUG: CALSAHControlMonitor - Monitored ALSA hctl value changed
17:16:05 67.394516 T:139829458097920 DEBUG: GetMappingForDevice - device (2548:1002) mapped to Pulse-Eight CEC Adapter (type = cec)
17:16:05 67.465965 T:139829735548672 DEBUG: CALSAHControlMonitor - Monitored ALSA hctl value changed
17:16:05 67.507339 T:139829458097920 DEBUG: GetMappingForDevice - device (2548:1002) mapped to Pulse-Eight CEC Adapter (type = cec)
17:16:05 67.512375 T:139829743949888 INFO: GL: Maximum texture width: 8192
17:16:05 67.513947 T:139829743949888 DEBUG: GL: Requested render method: 0
17:16:05 67.514267 T:139829743949888 DEBUG: GL: BaseYUV2RGBGLSLShader: defines:
#define XBMC_OUTPUT 1
#define XBMC_DITHER 1
#define XBMC_FULLRANGE 1
#define XBMC_texture_rectangle 0
#define XBMC_texture_rectangle_hack 0
#define XBMC_STRETCH 0
#define XBMC_NV12_RRG
17:16:05 67.514557 T:139829743949888 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader
17:16:05 67.516510 T:139829743949888 DEBUG: GL: Vertex Shader compilation log:
17:16:05 67.516563 T:139829743949888 DEBUG: GL: Vertex Shader compiled successfully
17:16:05 67.519249 T:139829743949888 DEBUG: GL: Pixel Shader compilation log:
17:16:05 67.519295 T:139829743949888 DEBUG: GL: Fragment Shader compiled successfully
17:16:06 67.539192 T:139828126009088 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
17:16:06 67.544754 T:139829743949888 DEBUG: Previous line repeats 3 times.
17:16:06 67.544823 T:139829743949888 DEBUG: GL: Vertex Shader compilation log:
17:16:06 67.544853 T:139829743949888 DEBUG: GL: Vertex Shader compiled successfully
17:16:06 67.545761 T:139829743949888 DEBUG: GL: Pixel Shader compilation log:
17:16:06 67.545792 T:139829743949888 DEBUG: GL: Fragment Shader compiled successfully
17:16:06 67.550766 T:139828126009088 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
17:16:06 67.555084 T:139829743949888 DEBUG: Previous line repeats 3 times.
17:16:06 67.555153 T:139829743949888 NOTICE: GL: NPOT texture support detected
17:16:06 67.555176 T:139829743949888 NOTICE: GL: Using GL_ARB_pixel_buffer_object
17:16:06 67.555199 T:139829743949888 NOTICE: Using GL_TEXTURE_2D
17:16:06 67.565849 T:139829743949888 DEBUG: NotifyXRREvent - notify display reset event
17:16:06 67.584145 T:139829743949888 DEBUG: RecreateWindow - current output: HDMI2, mode: 0x10c, refresh: 23.976
17:16:06 67.584229 T:139829743949888 DEBUG: OnLostDevice - notify display change event
17:16:06 67.584267 T:139829743949888 DEBUG: Flush - flushing renderer
17:16:06 67.585732 T:139829743949888 NOTICE: VideoPlayer: OnLostDisplay received
17:16:06 67.588837 T:139829743949888 DEBUG: Window Manager Name: Fluxbox
17:16:06 67.609978 T:139829743949888 DEBUG: CWinSystemX11::RefreshEGLContext: refreshing context
17:16:06 67.611320 T:139829743949888 NOTICE: VideoPlayer: OnResetDisplay received
17:16:06 67.611397 T:139829725013760 DEBUG: CActiveAE - display reset event
17:16:06 67.611549 T:139829743949888 INFO: GL: Maximum texture width: 8192
17:16:06 67.611656 T:139829716621056 INFO: CActiveAESink::OpenSink - initialize sink
17:16:06 67.611717 T:139829716621056 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0
17:16:06 67.611748 T:139829716621056 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0"
17:16:06 67.615868 T:139829716621056 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x06,AES1=0x82,AES2=0x00,AES3=0x02"
17:16:06 67.616173 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2400, bufferSize 9600
17:16:06 67.623405 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2400, bufferSize 9600
17:16:06 67.623466 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms
17:16:06 67.624687 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
17:16:06 67.624725 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: RAW,RAW
17:16:06 67.624748 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: RAW,RAW (ALSA: none)
17:16:06 67.624771 T:139829716621056 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
17:16:06 67.624794 T:139829716621056 DEBUG: Output Device : HDA Intel PCH
17:16:06 67.624809 T:139829716621056 DEBUG: Sample Rate : 48000
17:16:06 67.624832 T:139829716621056 DEBUG: Sample Format : AE_FMT_S16NE
17:16:06 67.624855 T:139829716621056 DEBUG: Channel Count : 2
17:16:06 67.624901 T:139829716621056 DEBUG: Channel Layout: RAW,RAW
17:16:06 67.624931 T:139829716621056 DEBUG: Frames : 2400
17:16:06 67.624954 T:139829716621056 DEBUG: Frame Size : 4
17:16:06 67.631279 T:139829743949888 DEBUG: GL: Requested render method: 0
17:16:06 67.631546 T:139829743949888 DEBUG: GL: BaseYUV2RGBGLSLShader: defines:
#define XBMC_OUTPUT 1
#define XBMC_DITHER 1
#define XBMC_FULLRANGE 1
#define XBMC_texture_rectangle 0
#define XBMC_texture_rectangle_hack 0
#define XBMC_STRETCH 0
#define XBMC_NV12_RRG
17:16:06 67.632332 T:139829743949888 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader
17:16:06 67.634941 T:139829725013760 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
17:16:06 67.637199 T:139829743949888 DEBUG: Previous line repeats 1 times.
17:16:06 67.637253 T:139829743949888 DEBUG: GL: Vertex Shader compilation log:
17:16:06 67.637276 T:139829743949888 DEBUG: GL: Vertex Shader compiled successfully
17:16:06 67.637344 T:139829725013760 DEBUG: ActiveAE::SyncStream - average error of -62.027605, start adjusting
17:16:06 67.637611 T:139829725013760 DEBUG: ActiveAE::SyncStream - average error -19.360939 below threshold of 30.000000
17:16:06 67.639969 T:139829743949888 DEBUG: GL: Pixel Shader compilation log:
17:16:06 67.640030 T:139829743949888 DEBUG: GL: Fragment Shader compiled successfully
17:16:06 67.670410 T:139829743949888 DEBUG: GL: Vertex Shader compilation log:
17:16:06 67.670471 T:139829743949888 DEBUG: GL: Vertex Shader compiled successfully
17:16:06 67.671318 T:139829743949888 DEBUG: GL: Pixel Shader compilation log:
17:16:06 67.671349 T:139829743949888 DEBUG: GL: Fragment Shader compiled successfully
17:16:06 67.679741 T:139829743949888 NOTICE: GL: NPOT texture support detected
17:16:06 67.679802 T:139829743949888 NOTICE: GL: Using GL_ARB_pixel_buffer_object
17:16:06 67.679825 T:139829743949888 NOTICE: Using GL_TEXTURE_2D
17:16:06 67.680275 T:139828126009088 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1
17:16:06 67.689201 T:139829743949888 DEBUG: Previous line repeats 1 times.
17:16:06 67.689255 T:139829743949888 WARNING: CRenderCaptureGL: GL_ARB_occlusion_query disabled, performance might suffer
17:16:06 67.689308 T:139828126009088 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1
17:16:06 67.689400 T:139829743949888 DEBUG: GL: Requested render method: 0
17:16:06 67.689590 T:139829743949888 DEBUG: GL: BaseYUV2RGBGLSLShader: defines:
#define XBMC_OUTPUT 1
#define XBMC_DITHER 1
#define XBMC_FULLRANGE 1
#define XBMC_texture_rectangle 0
#define XBMC_texture_rectangle_hack 0
#define XBMC_STRETCH 0
#define XBMC_NV12_RRG
17:16:06 67.689751 T:139828126009088 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1
17:16:06 67.689789 T:139829743949888 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader
17:16:06 67.691597 T:139829743949888 DEBUG: GL: Vertex Shader compilation log:
17:16:06 67.691650 T:139829743949888 DEBUG: GL: Vertex Shader compiled successfully
17:16:06 67.694374 T:139829743949888 DEBUG: GL: Pixel Shader compilation log:
17:16:06 67.694420 T:139829743949888 DEBUG: GL: Fragment Shader compiled successfully
17:16:06 67.720596 T:139829743949888 NOTICE: GL: NPOT texture support detected
17:16:06 67.720650 T:139829743949888 NOTICE: GL: Using GL_ARB_pixel_buffer_object
17:16:06 67.729286 T:139829743949888 WARNING: CRenderCaptureGL: GL_ARB_occlusion_query disabled, performance might suffer
17:16:06 67.742661 T:139828126009088 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1
17:16:06 67.760445 T:139828934981376 DEBUG: Previous line repeats 1 times.
17:16:06 67.768768 T:139828126009088 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1
17:16:06 67.883377 T:139828934981376 DEBUG: Previous line repeats 5 times.
17:16:06 67.890121 T:139828126009088 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1
17:16:06 68.008179 T:139828934981376 DEBUG: Previous line repeats 1 times.
17:16:07 68.676071 T:139829725013760 DEBUG: ActiveAE::SyncStream - average error -415.594724 above threshold of 100.000000.
17:16:07 68.877556 T:139829725013760 DEBUG: ActiveAE::SyncStream - average error -20.928057 below threshold of 30.000000
17:16:08 69.925743 T:139828098504448 DEBUG: CDVDClock::Discontinuity - CVideoPlayerAudio::OutputPacket - was:3075909.722178, should be:3050695.538796, error:-25214.183382
17:16:09 71.497902 T:139828126009088 DEBUG: CPullupCorrection: detected pattern of length 1: 41708.33, frameduration: 41708.333333
17:16:10 72.098129 T:139829743949888 DEBUG: ------ Window Deinit (DialogNotification.xml) ------
17:16:35 96.542503 T:139828918195968 DEBUG: Thread JobWorker 139828918195968 terminating (autodelete)
17:16:35 96.542686 T:139828926588672 DEBUG: Thread JobWorker 139828926588672 terminating (autodelete)
17:16:35 96.542908 T:139828300818176 DEBUG: Thread JobWorker 139828300818176 terminating (autodelete)
17:16:35 96.547020 T:139828498790144 DEBUG: Thread JobWorker 139828498790144 terminating (autodelete)
17:16:55 116.876488 T:139829743949888 NOTICE: Samba is idle. Closing the remaining connections
17:17:09 131.262466 T:139829287311104 DEBUG: PushCecKeypress - received key e0 duration 1000
17:17:09 131.265457 T:139829743949888 DEBUG: OnKey: guide (0xe0) pressed, action is Stop
17:17:09 131.265579 T:139829743949888 NOTICE: CVideoPlayer::CloseFile()
17:17:09 131.265610 T:139829743949888 NOTICE: VideoPlayer: waiting for threads to exit
17:17:09 131.269592 T:139828367959808 NOTICE: CVideoPlayer::OnExit()
17:17:09 131.269669 T:139828367959808 NOTICE: Closing stream player 1
17:17:09 131.269699 T:139828367959808 NOTICE: Waiting for audio thread to exit
17:17:09 131.278000 T:139828098504448 NOTICE: thread end: CVideoPlayerAudio::OnExit()
17:17:09 131.278091 T:139828098504448 DEBUG: Thread VideoPlayerAudio 139828098504448 terminating
17:17:09 131.278244 T:139828367959808 NOTICE: Closing audio device
17:17:09 131.327866 T:139828367959808 DEBUG: CDVDAudio::Flush - flush audio stream
17:17:09 131.328003 T:139829725013760 DEBUG: CActiveAE::DiscardStream - audio stream deleted
17:17:09 131.328125 T:139829725013760 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
17:17:09 131.329529 T:139828367959808 NOTICE: Deleting audio codec
17:17:09 131.329666 T:139828367959808 NOTICE: Closing stream player 2
17:17:09 131.329727 T:139828367959808 NOTICE: waiting for video thread to exit
17:17:09 131.329941 T:139829725013760 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
17:17:09 131.330231 T:139829716621056 INFO: CActiveAESink::OpenSink - initialize sink
17:17:09 131.365875 T:139828126009088 NOTICE: thread end: video_thread
17:17:09 131.365982 T:139828126009088 DEBUG: Thread VideoPlayerVideo 139828126009088 terminating
17:17:09 131.366562 T:139828367959808 NOTICE: deleting video codec
17:17:09 131.366882 T:139828367959808 DEBUG: VAAPI::Release pre-cleanup
17:17:09 131.372284 T:139828367959808 NOTICE: Closing stream player 3
17:17:09 131.372604 T:139828367959808 DEBUG: OnPlayBackStopped: play state was 2, starting 0
17:17:09 131.372757 T:139828367959808 DEBUG: Thread VideoPlayer 139828367959808 terminating
17:17:09 131.372879 T:139829743949888 NOTICE: VideoPlayer: finished waiting
17:17:09 131.372925 T:139829743949888 DEBUG: DeleteRenderer - deleting renderer
17:17:09 131.373215 T:139829743941376 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
17:17:09 131.373352 T:139829743941376 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
17:17:09 131.373657 T:139829743949888 NOTICE: VAAPI::Close
17:17:09 131.374359 T:139828081456896 NOTICE: COutput::OnExit: Output Thread terminated
17:17:09 131.374405 T:139828081456896 DEBUG: Thread Vaapi-Output 139828081456896 terminating
17:17:09 131.374863 T:139829743949888 DEBUG: VAAPI::FiniVAAPIOutput destroying 5 video surfaces
17:17:09 131.378067 T:139829743949888 NOTICE: VAAPI::Close - closing decoder context
17:17:09 131.381439 T:139829743949888 DEBUG: LinuxRendererGL: Cleaning up GL resources
17:17:09 131.381577 T:139829743949888 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
17:17:09 131.381622 T:139829743949888 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------
17:17:09 131.389267 T:139829743949888 NOTICE: CWinSystemX11::SetFullScreen - calling xrandr
17:17:09 131.389465 T:139829743949888 DEBUG: OnLostDevice - notify display change event
17:17:09 131.529480 T:139829716621056 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0
17:17:09 131.529556 T:139829716621056 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0"
17:17:10 131.537949 T:139829716621056 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00"
17:17:10 131.538956 T:139829716621056 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
17:17:10 131.539047 T:139829716621056 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
17:17:10 131.539093 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2205, bufferSize 8820
17:17:10 131.547073 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2205, bufferSize 8820
17:17:10 131.547165 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms
17:17:10 131.548386 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
17:17:10 131.548462 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
17:17:10 131.548492 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR)
17:17:10 131.548523 T:139829716621056 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
17:17:10 131.548553 T:139829716621056 DEBUG: Output Device : HDA Intel PCH
17:17:10 131.548584 T:139829716621056 DEBUG: Sample Rate : 44100
17:17:10 131.548615 T:139829716621056 DEBUG: Sample Format : AE_FMT_S32NE
17:17:10 131.548645 T:139829716621056 DEBUG: Channel Count : 2
17:17:10 131.548676 T:139829716621056 DEBUG: Channel Layout: FL,FR
17:17:10 131.548706 T:139829716621056 DEBUG: Frames : 2205
17:17:10 131.548737 T:139829716621056 DEBUG: Frame Size : 8
17:17:10 131.551880 T:139829725013760 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
17:17:10 131.703079 T:139829743949888 NOTICE: VideoPlayer: OnLostDisplay received
17:17:10 131.703156 T:139829743949888 INFO: XRANDR: /usr/lib/kodi/kodi-xrandr --screen 0 --output HDMI2 --mode 0x49
17:17:10 131.987488 T:139829735548672 DEBUG: CALSAHControlMonitor - Monitored ALSA hctl value changed
17:17:10 132.048203 T:139829458097920 DEBUG: GetMappingForDevice - device (2548:1002) mapped to Pulse-Eight CEC Adapter (type = cec)
17:17:10 132.229767 T:139829735548672 DEBUG: Previous line repeats 1 times.
17:17:10 132.229843 T:139829735548672 DEBUG: CALSAHControlMonitor - Monitored ALSA hctl value changed
17:17:10 132.255295 T:139829743949888 INFO: GL: Maximum texture width: 8192
17:17:10 132.256699 T:139829743949888 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
17:17:10 132.264130 T:139829743949888 DEBUG: ------ Window Init (MyVideoNav.xml) ------
17:17:10 132.266327 T:139829743949888 DEBUG: CGUIMediaWindow::GetDirectory (/storage/mediathek/Videos/HD/3D/)
17:17:10 132.266388 T:139829743949888 DEBUG: ParentPath = [/storage/mediathek/Videos/HD/3D/]
17:17:10 132.328796 T:139829743949888 DEBUG: RunQuery took 3 ms for 59 items query: select * from movie_view WHERE c23=52
17:17:10 132.337769 T:139828081456896 DEBUG: Thread BackgroundLoader start, auto delete: false
17:17:10 132.345993 T:139829743949888 INFO: ffmpeg[7F2CA6379840]: [mjpeg] Changing bps to 8
17:17:10 132.367447 T:139828081456896 DEBUG: Thread BackgroundLoader 139828081456896 terminating
17:17:10 132.393295 T:139828081456896 DEBUG: Thread JobWorker start, auto delete: true
17:17:10 132.393509 T:139828081456896 DEBUG: GetImageHash - unable to stat url
17:17:10 132.463196 T:139829743949888 NOTICE: CVideoPlayer::CloseFile()
17:17:10 132.463257 T:139829743949888 NOTICE: VideoPlayer: waiting for threads to exit
17:17:10 132.463287 T:139829743949888 NOTICE: VideoPlayer: finished waiting
17:17:10 132.463348 T:139829743949888 NOTICE: CVideoPlayer::CloseFile()
17:17:10 132.463379 T:139829743949888 NOTICE: VideoPlayer: waiting for threads to exit
17:17:10 132.463394 T:139829743949888 NOTICE: VideoPlayer: finished waiting
17:17:10 132.466324 T:139829743949888 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData
17:17:10 132.466736 T:139829743949888 DEBUG: StereoscopicsManager: stereo mode setting changed to off
17:17:10 132.466766 T:139829743949888 DEBUG: StereoscopicsManager::ApplyStereoMode: trying to apply stereo mode. Current: split_horizontal | Target: off
17:17:10 132.466782 T:139829743949888 DEBUG: StereoscopicsManager: stereo mode changed to off
17:17:10 132.467133 T:139829743949888 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/libsse4-x86_64-linux.so)
17:17:10 132.467316 T:139828081456896 DEBUG: DoWork - Saving file state for video item /storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv
17:17:10 132.467804 T:139829743949888 DEBUG: ------ Window Init (DialogNotification.xml) ------
17:17:10 132.467957 T:139829743949888 DEBUG: NotifyXRREvent - notify display reset event
17:17:10 132.494980 T:139829743941376 DEBUG: CAnnouncementManager - Announcement: OnUpdate from xbmc
17:17:10 132.495148 T:139829743941376 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnUpdate
17:17:10 132.498169 T:139829743949888 DEBUG: RecreateWindow - current output: HDMI2, mode: 0x49, refresh: 50.000
17:17:10 132.498230 T:139829743949888 DEBUG: OnLostDevice - notify display change event
17:17:10 132.503372 T:139829743949888 DEBUG: Window Manager Name: Fluxbox
17:17:10 132.513321 T:139829743949888 DEBUG: CWinSystemX11::RefreshEGLContext: refreshing context
17:17:10 132.515259 T:139829743949888 DEBUG: OnLostDevice - notify display change event
17:17:10 132.520142 T:139829743949888 DEBUG: Window Manager Name: Fluxbox
17:17:10 132.530746 T:139829743949888 DEBUG: CWinSystemX11::RefreshEGLContext: refreshing context
17:17:10 132.532410 T:139829743949888 INFO: GL: Maximum texture width: 8192
17:17:10 132.532532 T:139829725013760 DEBUG: CActiveAE - display reset event
17:17:10 132.533020 T:139829716621056 INFO: CActiveAESink::OpenSink - initialize sink
17:17:10 132.533203 T:139829716621056 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0
17:17:10 132.533234 T:139829716621056 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0"
17:17:11 132.538239 T:139829716621056 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00"
17:17:11 132.539536 T:139829716621056 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
17:17:11 132.539597 T:139829716621056 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
17:17:11 132.539612 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2205, bufferSize 8820
17:17:11 132.546814 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2205, bufferSize 8820
17:17:11 132.546875 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms
17:17:11 132.547836 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
17:17:11 132.547867 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
17:17:11 132.547882 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR)
17:17:11 132.547913 T:139829716621056 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
17:17:11 132.547943 T:139829716621056 DEBUG: Output Device : HDA Intel PCH
17:17:11 132.547958 T:139829716621056 DEBUG: Sample Rate : 44100
17:17:11 132.547974 T:139829716621056 DEBUG: Sample Format : AE_FMT_S32NE
17:17:11 132.548004 T:139829716621056 DEBUG: Channel Count : 2
17:17:11 132.548019 T:139829716621056 DEBUG: Channel Layout: FL,FR
17:17:11 132.548035 T:139829716621056 DEBUG: Frames : 2205
17:17:11 132.548065 T:139829716621056 DEBUG: Frame Size : 8
17:17:11 132.549866 T:139829725013760 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
17:17:11 132.569016 T:139829743949888 INFO: GL: Maximum texture width: 8192
17:17:11 132.589310 T:139829725013760 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
17:17:14 136.212830 T:139829287311104 DEBUG: PushCecKeypress - received key a7 duration 0
17:17:14 136.225235 T:139829743949888 DEBUG: OnKey: 167 (0xa7) pressed, action is Down
17:17:14 136.237717 T:139828081456896 INFO: ffmpeg[7F2C431FF700]: [mjpeg] Changing bps to 8
17:17:14 136.244568 T:139828918195968 DEBUG: Thread JobWorker start, auto delete: true
17:17:14 136.252747 T:139828918195968 INFO: ffmpeg[7F2C74FF9700]: [mjpeg] Changing bps to 8
17:17:14 136.486267 T:139829287311104 DEBUG: PushCecKeypress - received key a7 duration 274
17:17:15 136.612823 T:139829287311104 DEBUG: PushCecKeypress - received key a7 duration 0
17:17:15 136.644104 T:139829743949888 DEBUG: OnKey: 167 (0xa7) pressed, action is Down
17:17:15 136.652069 T:139828081456896 INFO: ffmpeg[7F2C431FF700]: [mjpeg] Changing bps to 8
17:17:15 136.661545 T:139828918195968 INFO: ffmpeg[7F2C74FF9700]: [mjpeg] Changing bps to 8
17:17:15 136.788803 T:139829287311104 DEBUG: PushCecKeypress - received key a7 duration 176
17:17:15 136.912552 T:139829287311104 DEBUG: PushCecKeypress - received key a7 duration 0
17:17:15 136.929047 T:139829743949888 DEBUG: OnKey: 167 (0xa7) pressed, action is Down
17:17:15 136.934067 T:139828081456896 INFO: ffmpeg[7F2C431FF700]: [mjpeg] Changing bps to 8
17:17:15 136.935837 T:139828918195968 INFO: ffmpeg[7F2C74FF9700]: [mjpeg] Changing bps to 8
17:17:15 137.088501 T:139829287311104 DEBUG: PushCecKeypress - received key a7 duration 176
17:17:15 137.259140 T:139829287311104 DEBUG: PushCecKeypress - received key a7 duration 0
17:17:15 137.259933 T:139829743949888 DEBUG: OnKey: 167 (0xa7) pressed, action is Down
17:17:15 137.271652 T:139828918195968 INFO: ffmpeg[7F2C74FF9700]: [mjpeg] Changing bps to 8
17:17:15 137.271805 T:139828081456896 INFO: ffmpeg[7F2C431FF700]: [mjpeg] Changing bps to 8
17:17:16 137.537018 T:139829287311104 DEBUG: PushCecKeypress - received key a7 duration 278
17:17:16 138.321289 T:139829743949888 DEBUG: ------ Window Deinit (DialogNotification.xml) ------
17:17:17 138.663101 T:139829287311104 DEBUG: PushCecKeypress - received key a6 duration 0
17:17:17 138.701035 T:139829743949888 DEBUG: OnKey: 166 (0xa6) pressed, action is Up
17:17:17 138.936829 T:139829287311104 DEBUG: PushCecKeypress - received key a6 duration 274
17:17:18 139.615219 T:139829287311104 DEBUG: PushCecKeypress - received key b duration 0
17:17:18 139.619965 T:139829743949888 DEBUG: OnKey: 11 (0x0b) pressed, action is Select
17:17:18 139.626099 T:139829743949888 DEBUG: OnPlayMedia /storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv
17:17:18 139.626312 T:139829743941376 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
17:17:18 139.626373 T:139829743941376 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
17:17:18 139.626480 T:139829743941376 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc
17:17:18 139.626511 T:139829743941376 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd
17:17:18 139.631943 T:139829743949888 DEBUG: Loading settings for /storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv
17:17:18 139.637360 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers(/storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv)
17:17:18 139.637436 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
17:17:18 139.637466 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
17:17:18 139.637482 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp
17:17:18 139.637527 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
17:17:18 139.637573 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
17:17:18 139.637604 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
17:17:18 139.637634 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
17:17:18 139.637665 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
17:17:18 139.637695 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
17:17:18 139.637711 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
17:17:18 139.637756 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
17:17:18 139.637787 T:139829743949888 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
17:17:18 139.637817 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
17:17:18 139.637848 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer)
17:17:18 139.637863 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
17:17:18 139.637894 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
17:17:18 139.637924 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: VIERA ST60 Series
17:17:18 139.637955 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: Marantz SR7010
17:17:18 139.637970 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: Kodi (OpenELEC-RPi2)
17:17:18 139.637985 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DMP-BDT500
17:17:18 139.638016 T:139829743949888 DEBUG: CPlayerCoreFactory::GetPlayers: added 5 players
17:17:18 139.640961 T:139829743949888 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData
17:17:18 139.641052 T:139829743949888 NOTICE: VideoPlayer: Opening: /storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv
17:17:18 139.641083 T:139829743949888 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
17:17:18 139.641190 T:139829743949888 DEBUG: LinuxRendererGL: Cleaning up GL resources
17:17:18 139.641266 T:139829743949888 DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16
17:17:18 139.641678 T:139828926588672 DEBUG: Thread VideoPlayer start, auto delete: false
17:17:18 139.641846 T:139828926588672 NOTICE: Creating InputStream
17:17:18 139.646576 T:139828926588672 DEBUG: ScanForExternalSubtitles: Searching for subtitles...
17:17:18 139.649673 T:139828926588672 DEBUG: ScanForExternalSubtitles: END (total time: 3 ms)
17:17:18 139.649734 T:139828926588672 NOTICE: Creating Demuxer
17:17:18 139.652115 T:139828926588672 DEBUG: Open - probing detected format [matroska,webm]
17:17:18 139.652435 T:139828926588672 DEBUG: Open - avformat_find_stream_info starting
17:17:18 139.665527 T:139828926588672 DEBUG: Open - av_find_stream_info finished
17:17:18 139.665619 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Input #0, matroska,webm, /storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mk':
17:17:18 139.665833 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.665863 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: encoder : libebml v1.2.3 + libmatroska v1.3.0
17:17:18 139.665939 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: creation_time : 2013-05-14 22:08:35
17:17:18 139.665970 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Duration: 01:21:00.02, start: 0.000000, bitrate: 12576 kb/s
17:17:18 139.666000 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Chapter #0:0: start 0.000000, end 365.824000
17:17:18 139.666031 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.666061 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: title : 00:00:00.000
17:17:18 139.666092 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Chapter #0:1: start 365.824000, end 683.892000
17:17:18 139.666122 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.666153 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: title : 00:06:05.824
17:17:18 139.666183 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Chapter #0:2: start 683.892000, end 849.432000
17:17:18 139.666214 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.666245 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: title : 00:11:23.892
17:17:18 139.666275 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Chapter #0:3: start 849.432000, end 1228.769000
17:17:18 139.666306 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.666336 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: title : 00:14:09.432
17:17:18 139.666382 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Chapter #0:4: start 1228.769000, end 1586.126000
17:17:18 139.666397 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.666428 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: title : 00:20:28.769
17:17:18 139.666473 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Chapter #0:5: start 1586.126000, end 2021.728000
17:17:18 139.666504 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.666550 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: title : 00:26:26.126
17:17:18 139.666580 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Chapter #0:6: start 2021.728000, end 2324.155000
17:17:18 139.666611 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.666641 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: title : 00:33:41.728
17:17:18 139.666702 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Chapter #0:7: start 2324.155000, end 2563.770000
17:17:18 139.666733 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.666763 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: title : 00:38:44.155
17:17:18 139.666794 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Chapter #0:8: start 2563.770000, end 2754.961000
17:17:18 139.666824 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.666855 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: title : 00:42:43.770
17:17:18 139.666885 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Chapter #0:9: start 2754.961000, end 2982.354000
17:17:18 139.666916 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.666946 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: title : 00:45:54.961
17:17:18 139.666977 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Chapter #0:10: start 2982.354000, end 3241.989000
17:17:18 139.667007 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.667038 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: title : 00:49:42.354
17:17:18 139.667068 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Chapter #0:11: start 3241.989000, end 3642.305000
17:17:18 139.667099 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.667130 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: title : 00:54:01.989
17:17:18 139.667160 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Chapter #0:12: start 3642.305000, end 3926.339000
17:17:18 139.667191 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.667206 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: title : 01:00:42.305
17:17:18 139.667252 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Chapter #0:13: start 3926.339000, end 4218.881000
17:17:18 139.667267 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.667297 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: title : 01:05:26.339
17:17:18 139.667343 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Chapter #0:14: start 4218.881000, end 4340.920000
17:17:18 139.667358 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.667389 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: title : 01:10:18.881
17:17:18 139.667419 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Chapter #0:15: start 4340.920000, end 4860.022000
17:17:18 139.667480 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.667511 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: title : 01:12:20.920
17:17:18 139.667725 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Stream #0:0: Video: h264 (High), yuv420p, 1920x1080, SAR 2:1 DAR 32:9, 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc (default)
17:17:18 139.667740 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.667786 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: stereo_mode : left_right
17:17:18 139.667816 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Side data:
17:17:18 139.667847 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: stereo3d: side by side
17:17:18 139.667908 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Stream #0:1(ger): Audio: dts (DTS), 48000 Hz, 5.1(side), fltp, 1536 kb/s (default)
17:17:18 139.667923 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.667953 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: title : DTS
17:17:18 139.668030 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Stream #0:2(eng): Audio: dts (DTS), 48000 Hz, 5.1(side), fltp, 1536 kb/s
17:17:18 139.668045 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: Metadata:
17:17:18 139.668076 T:139828926588672 INFO: ffmpeg[7F2C757FA700]: title : DTS
17:17:18 139.668121 T:139828926588672 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0
17:17:18 139.668137 T:139828926588672 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1
17:17:18 139.668167 T:139828926588672 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 2
17:17:18 139.668274 T:139828926588672 NOTICE: Opening stream: 0 source: 256
17:17:18 139.668320 T:139828926588672 NOTICE: Creating video codec with codec id: 28
17:17:18 139.668350 T:139828926588672 DEBUG: FactoryCodec - Video: - Opening
17:17:18 139.668365 T:139828926588672 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
17:17:18 139.668625 T:139828926588672 DEBUG: FactoryCodec - Video: ff-h264 - Opened
17:17:18 139.668671 T:139828926588672 DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 28
17:17:18 139.668701 T:139828926588672 NOTICE: Creating video thread
17:17:18 139.668823 T:139828926588672 NOTICE: Opening stream: 1 source: 256
17:17:18 139.668854 T:139828926588672 NOTICE: Finding audio codec for: 86020
17:17:18 139.668884 T:139828926588672 DEBUG: FactoryCodec - Audio: passthrough - Opening
17:17:18 139.668945 T:139828926588672 DEBUG: FactoryCodec - Audio: passthrough - Opened
17:17:18 139.668976 T:139828926588672 NOTICE: Creating audio thread
17:17:18 139.669037 T:139828106897152 DEBUG: Thread VideoPlayerVideo start, auto delete: false
17:17:18 139.669220 T:139828926588672 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: /storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv
17:17:18 139.669266 T:139828106897152 NOTICE: running thread: video_thread
17:17:18 139.669327 T:139828300818176 DEBUG: Thread VideoPlayerAudio start, auto delete: false
17:17:18 139.669373 T:139828300818176 NOTICE: running thread: CVideoPlayerAudio::Process()
17:17:18 139.669418 T:139828926588672 DEBUG: OnPlayBackStarted: play state was 1, starting 1
17:17:18 139.669449 T:139828926588672 DEBUG: CVideoPlayer::SetCaching - caching state 2
17:17:18 139.669571 T:139829743949888 DEBUG: PlayFile: OpenFile succeed, play state 2
17:17:18 139.669601 T:139829743949888 DEBUG: OnPlayBackStarted: play state was 2, starting 0
17:17:18 139.671127 T:139828300818176 DEBUG: CDVDAudio::Pause - pausing audio stream
17:17:18 139.671310 T:139828106897152 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback
17:17:18 139.671341 T:139828106897152 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
17:17:18 139.671494 T:139828106897152 DEBUG: VAAPI - open decoder
17:17:18 139.671677 T:139828300818176 INFO: CAEStreamParser::SyncDTS - dts stream detected (6 channels, 48000Hz, 16bit BE, period: 512)
17:17:18 139.671768 T:139828300818176 NOTICE: Creating audio stream (codec id: 86020, channels: 6, sample rate: 48000, pass-through)
17:17:18 139.671814 T:139828926588672 NOTICE: CDVDMessageQueue::GetLevel() - can't determine level
17:17:18 139.672668 T:139828300818176 NOTICE: Previous line repeats 8 times.
17:17:18 139.672729 T:139828300818176 DEBUG: CVideoPlayerAudio:: synctype set to 0: clock feedback
17:17:18 139.676926 T:139828106897152 DEBUG: VAAPI - initialize version 0.39
17:17:18 139.676987 T:139828106897152 DEBUG: VAAPI - driver in use: Intel i965 driver for Intel(R) CherryView - 1.7.0
17:17:18 139.677017 T:139828106897152 DEBUG: VAAPI - attrib 0 (get/set) min -100 max 100 value 0x0
17:17:18 139.677032 T:139828106897152 DEBUG: VAAPI - attrib 1 (get/set) min 0 max 100 value 0x32
17:17:18 139.677063 T:139828106897152 DEBUG: VAAPI - attrib 2 (get/set) min -180 max 180 value 0x0
17:17:18 139.677078 T:139828106897152 DEBUG: VAAPI - attrib 3 (get/set) min 0 max 100 value 0x32
17:17:18 139.677277 T:139828106897152 DEBUG: VAAPI - attrib 6 (get/set) min 0 max 3 value 0x0
17:17:18 139.677292 T:139828106897152 DEBUG: VAAPI - profile 0
17:17:18 139.677322 T:139828106897152 DEBUG: VAAPI - profile 1
17:17:18 139.677338 T:139828106897152 DEBUG: VAAPI - profile 13
17:17:18 139.677353 T:139828106897152 DEBUG: VAAPI - profile 6
17:17:18 139.677383 T:139828106897152 DEBUG: VAAPI - profile 7
17:17:18 139.677399 T:139828106897152 DEBUG: VAAPI - profile 15
17:17:18 139.677429 T:139828106897152 DEBUG: VAAPI - profile 16
17:17:18 139.677444 T:139828106897152 DEBUG: VAAPI - profile 8
17:17:18 139.677460 T:139828106897152 DEBUG: VAAPI - profile 9
17:17:18 139.677521 T:139828106897152 DEBUG: VAAPI - profile 10
17:17:18 139.677551 T:139828106897152 DEBUG: VAAPI - profile -1
17:17:18 139.677567 T:139828106897152 DEBUG: VAAPI - profile 12
17:17:18 139.677597 T:139828106897152 DEBUG: VAAPI - profile 14
17:17:18 139.677628 T:139828106897152 DEBUG: VAAPI - profile 17
17:17:18 139.677887 T:139828159842048 DEBUG: Thread Vaapi-Output start, auto delete: false
17:17:18 139.677917 T:139828159842048 NOTICE: COutput::OnStartup: Output Thread created
17:17:18 139.685242 T:139828159842048 DEBUG: VAAPI::COutput::CreateEGLContext - created context
17:17:18 139.685333 T:139828159842048 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libsse4-x86_64-linux.so)
17:17:18 139.685410 T:139828159842048 DEBUG: Loading: /usr/lib/kodi/system/libsse4-x86_64-linux.so
17:17:18 139.699783 T:139829716621056 INFO: CActiveAESink::OpenSink - initialize sink
17:17:18 139.703903 T:139828159842048 DEBUG: VAAPI::COutput::InitBufferPool - Surfaces created
17:17:18 139.710114 T:139828106897152 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
17:17:18 139.738174 T:139828106897152 DEBUG: Previous line repeats 3 times.
17:17:18 139.738312 T:139828106897152 DEBUG: CRenderManager::Configure - change configuration. 1920x1080. display: 3840x1080. framerate: 23.98. format: VAAPI
17:17:18 139.743088 T:139828081456896 DEBUG: CGUIInfoManager::SetCurrentMovie(/storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv)
17:17:18 139.743240 T:139829743941376 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
17:17:18 139.743378 T:139829743941376 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
17:17:18 139.743515 T:139829743941376 DEBUG: UPnP: Building didl for object '/storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv'
17:17:18 139.745682 T:139829743949888 DEBUG: StereoscopicsManager: autodetected stereo mode for movie mode left_right is: split_vertical
17:17:18 139.745758 T:139829743949888 DEBUG: Previous line repeats 1 times.
17:17:18 139.745880 T:139829743949888 DEBUG: StereoscopicsManager: stereo mode setting changed to split_vertical
17:17:18 139.745911 T:139829743949888 DEBUG: StereoscopicsManager::ApplyStereoMode: trying to apply stereo mode. Current: off | Target: split_vertical
17:17:18 139.745926 T:139829743949888 DEBUG: StereoscopicsManager: stereo mode changed to split_vertical
17:17:18 139.746902 T:139829743949888 DEBUG: ------ Window Init (DialogNotification.xml) ------
17:17:18 139.748932 T:139828081456896 DEBUG: GetMovieId (/storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv), query = select idMovie from movie where idFile=306
17:17:18 139.749664 T:139829743949888 DEBUG: DeleteRenderer - deleting renderer
17:17:18 139.749710 T:139829743949888 DEBUG: LinuxRendererGL: Cleaning up GL resources
17:17:18 139.749802 T:139829743949888 DEBUG: Previous line repeats 1 times.
17:17:18 139.749817 T:139829743949888 DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16
17:17:18 139.749878 T:139829743949888 DEBUG: GL: Requested render method: 0
17:17:18 139.750076 T:139829743949888 DEBUG: GL: BaseYUV2RGBGLSLShader: defines:
#define XBMC_OUTPUT 1
#define XBMC_DITHER 1
#define XBMC_FULLRANGE 1
#define XBMC_texture_rectangle 0
#define XBMC_texture_rectangle_hack 0
#define XBMC_STRETCH 0
#define XBMC_NV12_RRG
17:17:18 139.750259 T:139829743949888 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader
17:17:18 139.752350 T:139829743949888 DEBUG: GL: Vertex Shader compilation log:
17:17:18 139.752396 T:139829743949888 DEBUG: GL: Vertex Shader compiled successfully
17:17:18 139.755630 T:139829743949888 DEBUG: GL: Pixel Shader compilation log:
17:17:18 139.755875 T:139829743949888 DEBUG: GL: Fragment Shader compiled successfully
17:17:18 139.787155 T:139829743949888 DEBUG: GL: Vertex Shader compilation log:
17:17:18 139.787216 T:139829743949888 DEBUG: GL: Vertex Shader compiled successfully
17:17:18 139.788361 T:139829743949888 DEBUG: GL: Pixel Shader compilation log:
17:17:18 139.788498 T:139829743949888 DEBUG: GL: Fragment Shader compiled successfully
17:17:18 139.799149 T:139829743949888 NOTICE: GL: NPOT texture support detected
17:17:18 139.799210 T:139829743949888 NOTICE: GL: Using GL_ARB_pixel_buffer_object
17:17:18 139.799225 T:139829743949888 NOTICE: Using GL_TEXTURE_2D
17:17:18 139.799255 T:139829743949888 DEBUG: CRenderManager::Configure - 4
17:17:18 139.799362 T:139828926588672 DEBUG: CVideoPlayer::HandleMessages - player started 2
17:17:18 139.800018 T:139829743949888 DEBUG: GL: Requested render method: 0
17:17:18 139.800323 T:139829743949888 DEBUG: GL: BaseYUV2RGBGLSLShader: defines:
#define XBMC_OUTPUT 1
#define XBMC_DITHER 1
#define XBMC_FULLRANGE 1
#define XBMC_texture_rectangle 0
#define XBMC_texture_rectangle_hack 0
#define XBMC_STRETCH 0
#define XBMC_NV12_RRG
17:17:18 139.800568 T:139829743949888 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader
17:17:18 139.802109 T:139829743949888 DEBUG: GL: Vertex Shader compilation log:
17:17:18 139.802155 T:139829743949888 DEBUG: GL: Vertex Shader compiled successfully
17:17:18 139.805603 T:139829743949888 DEBUG: GL: Pixel Shader compilation log:
17:17:18 139.805679 T:139829743949888 DEBUG: GL: Fragment Shader compiled successfully
17:17:18 139.837173 T:139829743949888 NOTICE: GL: NPOT texture support detected
17:17:18 139.837311 T:139829743949888 NOTICE: GL: Using GL_ARB_pixel_buffer_object
17:17:18 139.858444 T:139829743949888 INFO: GL: Maximum texture width: 8192
17:17:18 139.880936 T:139829743949888 DEBUG: Activating window ID: 12005
17:17:18 139.881668 T:139829743949888 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
17:17:18 139.882507 T:139829743949888 DEBUG: ------ Window Init (VideoFullScreen.xml) ------
17:17:18 139.886047 T:139829287311104 DEBUG: PushCecKeypress - received key b duration 270
17:17:18 139.886581 T:139829743949888 NOTICE: Display resolution ADJUST : HDMI2: 1920x1080 @ 23.98Hz (24) (weight: 0.000)
17:17:18 139.886627 T:139829743949888 NOTICE: CWinSystemX11::SetFullScreen - calling xrandr
17:17:18 139.886810 T:139829743949888 DEBUG: OnLostDevice - notify display change event
17:17:18 139.886841 T:139829743949888 DEBUG: Flush - flushing renderer
17:17:18 139.901566 T:139829716621056 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0
17:17:18 139.901642 T:139829716621056 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0"
17:17:18 139.905670 T:139829716621056 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x06,AES1=0x82,AES2=0x00,AES3=0x02"
17:17:18 139.906036 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2400, bufferSize 9600
17:17:18 139.913467 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2400, bufferSize 9600
17:17:18 139.913544 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms
17:17:18 139.915009 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
17:17:18 139.915039 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: RAW,RAW
17:17:18 139.915070 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: RAW,RAW (ALSA: none)
17:17:18 139.915100 T:139829716621056 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
17:17:18 139.915131 T:139829716621056 DEBUG: Output Device : HDA Intel PCH
17:17:18 139.915161 T:139829716621056 DEBUG: Sample Rate : 48000
17:17:18 139.915192 T:139829716621056 DEBUG: Sample Format : AE_FMT_S16NE
17:17:18 139.915222 T:139829716621056 DEBUG: Channel Count : 2
17:17:18 139.915237 T:139829716621056 DEBUG: Channel Layout: RAW,RAW
17:17:18 139.915268 T:139829716621056 DEBUG: Frames : 2400
17:17:18 139.915298 T:139829716621056 DEBUG: Frame Size : 4
17:17:18 139.920975 T:139829725013760 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
17:17:18 140.168076 T:139829743949888 NOTICE: VideoPlayer: OnLostDisplay received
17:17:18 140.168259 T:139829743949888 INFO: XRANDR: /usr/lib/kodi/kodi-xrandr --screen 0 --output HDMI2 --mode 0x10c
17:17:19 141.082611 T:139828300818176 ERROR: CDVDAudio::AddPacketsRenderer - timeout adding data to renderer
17:17:19 141.082794 T:139828300818176 DEBUG: CDVDClock::Discontinuity - CVideoPlayerAudio::OutputPacket - was:1413383.135000, should be:72.990000, error:-1413310.145000
17:17:19 141.247803 T:139829735548672 DEBUG: CALSAHControlMonitor - Monitored ALSA hctl value changed
17:17:19 141.528458 T:139829743949888 DEBUG: Previous line repeats 1 times.
17:17:19 141.528549 T:139829743949888 INFO: GL: Maximum texture width: 8192
17:17:20 141.533508 T:139829743949888 DEBUG: GL: Requested render method: 0
17:17:20 141.549713 T:139829743949888 DEBUG: GL: BaseYUV2RGBGLSLShader: defines:
#define XBMC_OUTPUT 1
#define XBMC_DITHER 1
#define XBMC_FULLRANGE 1
#define XBMC_texture_rectangle 0
#define XBMC_texture_rectangle_hack 0
#define XBMC_STRETCH 0
#define XBMC_NV12_RRG
17:17:20 141.553665 T:139829743949888 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader
17:17:20 141.557556 T:139829743949888 DEBUG: GL: Vertex Shader compilation log:
17:17:20 141.557617 T:139829743949888 DEBUG: GL: Vertex Shader compiled successfully
17:17:20 141.561234 T:139829743949888 DEBUG: GL: Pixel Shader compilation log:
17:17:20 141.561295 T:139829743949888 DEBUG: GL: Fragment Shader compiled successfully
17:17:20 141.588226 T:139829743949888 DEBUG: GL: Vertex Shader compilation log:
17:17:20 141.588287 T:139829743949888 DEBUG: GL: Vertex Shader compiled successfully
17:17:20 141.590164 T:139829743949888 DEBUG: GL: Pixel Shader compilation log:
17:17:20 141.590210 T:139829743949888 DEBUG: GL: Fragment Shader compiled successfully
17:17:20 141.598099 T:139829743949888 NOTICE: GL: NPOT texture support detected
17:17:20 141.598145 T:139829743949888 NOTICE: GL: Using GL_ARB_pixel_buffer_object
17:17:20 141.598175 T:139829743949888 NOTICE: Using GL_TEXTURE_2D
17:17:20 141.615692 T:139829743949888 DEBUG: NotifyXRREvent - notify display reset event
17:17:20 141.648529 T:139829743949888 DEBUG: RecreateWindow - current output: HDMI2, mode: 0x10c, refresh: 23.976
17:17:20 141.648621 T:139829743949888 DEBUG: OnLostDevice - notify display change event
17:17:20 141.648651 T:139829743949888 DEBUG: Flush - flushing renderer
17:17:20 141.648865 T:139829743949888 NOTICE: VideoPlayer: OnLostDisplay received
17:17:20 141.653244 T:139829743949888 DEBUG: Window Manager Name: Fluxbox
17:17:20 141.665009 T:139829743949888 DEBUG: CWinSystemX11::RefreshEGLContext: refreshing context
17:17:20 141.668213 T:139829725013760 DEBUG: CActiveAE - display reset event
17:17:20 141.668320 T:139829743949888 NOTICE: VideoPlayer: OnResetDisplay received
17:17:20 141.668396 T:139829743949888 INFO: GL: Maximum texture width: 8192
17:17:20 141.668503 T:139829716621056 INFO: CActiveAESink::OpenSink - initialize sink
17:17:20 141.668610 T:139829716621056 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0
17:17:20 141.668640 T:139829716621056 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0"
17:17:20 141.671204 T:139829743949888 DEBUG: GL: Requested render method: 0
17:17:20 141.671448 T:139829743949888 DEBUG: GL: BaseYUV2RGBGLSLShader: defines:
#define XBMC_OUTPUT 1
#define XBMC_DITHER 1
#define XBMC_FULLRANGE 1
#define XBMC_texture_rectangle 0
#define XBMC_texture_rectangle_hack 0
#define XBMC_STRETCH 0
#define XBMC_NV12_RRG
17:17:20 141.671616 T:139829743949888 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader
17:17:20 141.673294 T:139829716621056 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x06,AES1=0x82,AES2=0x00,AES3=0x02"
17:17:20 141.673706 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2400, bufferSize 9600
17:17:20 141.674377 T:139829743949888 DEBUG: GL: Vertex Shader compilation log:
17:17:20 141.674438 T:139829743949888 DEBUG: GL: Vertex Shader compiled successfully
17:17:20 141.680099 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2400, bufferSize 9600
17:17:20 141.680176 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms
17:17:20 141.681061 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
17:17:20 141.681076 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: RAW,RAW
17:17:20 141.681107 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: RAW,RAW (ALSA: none)
17:17:20 141.681122 T:139829716621056 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
17:17:20 141.681152 T:139829716621056 DEBUG: Output Device : HDA Intel PCH
17:17:20 141.681168 T:139829716621056 DEBUG: Sample Rate : 48000
17:17:20 141.681198 T:139829716621056 DEBUG: Sample Format : AE_FMT_S16NE
17:17:20 141.681213 T:139829716621056 DEBUG: Channel Count : 2
17:17:20 141.681244 T:139829716621056 DEBUG: Channel Layout: RAW,RAW
17:17:20 141.681259 T:139829716621056 DEBUG: Frames : 2400
17:17:20 141.681274 T:139829716621056 DEBUG: Frame Size : 4
17:17:20 141.681702 T:139829743949888 DEBUG: GL: Pixel Shader compilation log:
17:17:20 141.681778 T:139829743949888 DEBUG: GL: Fragment Shader compiled successfully
17:17:20 141.688644 T:139829725013760 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
17:17:20 141.690826 T:139828300818176 DEBUG: CDVDClock::Discontinuity - CVideoPlayerAudio::OutputPacket - was:608094.596000, should be:72.990000, error:-608021.606000
17:17:20 141.692230 T:139829725013760 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
17:17:20 141.692307 T:139828926588672 DEBUG: CVideoPlayer::HandleMessages - player started 1
17:17:20 141.692398 T:139828926588672 DEBUG: CVideoPlayer::SetCaching - caching state 3
17:17:20 141.692551 T:139828926588672 DEBUG: CVideoPlayer::SetCaching - caching state 0
17:17:20 141.692581 T:139828926588672 DEBUG: VideoPlayer::Sync - Audio - pts: 127000.000000, cache: 307438.740115, totalcache: 600000.023842
17:17:20 141.692596 T:139828926588672 DEBUG: VideoPlayer::Sync - Video - pts: 18442240474082181120.000000, cache: 50000.000000, totalcache: 100000.000000
17:17:20 141.694916 T:139829725013760 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
17:17:20 141.695023 T:139828106897152 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(-180438.740115)
17:17:20 141.695084 T:139828106897152 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
17:17:20 141.702652 T:139828300818176 DEBUG: Previous line repeats 1 times.
17:17:20 141.702728 T:139828300818176 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(-180438.740115)
17:17:20 141.702774 T:139828300818176 DEBUG: CDVDAudio::Resume - resume audio stream
17:17:20 141.707382 T:139828106897152 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
17:17:20 141.707550 T:139829725013760 DEBUG: ActiveAE - start sync of audio stream
17:17:20 141.715546 T:139828106897152 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
17:17:20 141.731827 T:139828159842048 DEBUG: Previous line repeats 2 times.
17:17:20 141.731873 T:139828159842048 WARNING: COutput::QueueReturnPicture - pic not found
17:17:20 141.736420 T:139829743949888 DEBUG: GL: Vertex Shader compilation log:
17:17:20 141.736481 T:139829743949888 DEBUG: GL: Vertex Shader compiled successfully
17:17:20 141.737381 T:139829743949888 DEBUG: GL: Pixel Shader compilation log:
17:17:20 141.737427 T:139829743949888 DEBUG: GL: Fragment Shader compiled successfully
17:17:20 141.746552 T:139829743949888 NOTICE: GL: NPOT texture support detected
17:17:20 141.746613 T:139829743949888 NOTICE: GL: Using GL_ARB_pixel_buffer_object
17:17:20 141.746628 T:139829743949888 NOTICE: Using GL_TEXTURE_2D
17:17:20 141.747147 T:139828106897152 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1
17:17:20 141.762848 T:139829743949888 DEBUG: Previous line repeats 1 times.
17:17:20 141.762939 T:139829743949888 WARNING: CRenderCaptureGL: GL_ARB_occlusion_query disabled, performance might suffer
17:17:20 141.763046 T:139829743949888 DEBUG: GL: Requested render method: 0
17:17:20 141.763229 T:139829743949888 DEBUG: GL: BaseYUV2RGBGLSLShader: defines:
#define XBMC_OUTPUT 1
#define XBMC_DITHER 1
#define XBMC_FULLRANGE 1
#define XBMC_texture_rectangle 0
#define XBMC_texture_rectangle_hack 0
#define XBMC_STRETCH 0
#define XBMC_NV12_RRG
17:17:20 141.763443 T:139829743949888 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader
17:17:20 141.764908 T:139829743949888 DEBUG: GL: Vertex Shader compilation log:
17:17:20 141.764954 T:139829743949888 DEBUG: GL: Vertex Shader compiled successfully
17:17:20 141.767685 T:139829743949888 DEBUG: GL: Pixel Shader compilation log:
17:17:20 141.767731 T:139829743949888 DEBUG: GL: Fragment Shader compiled successfully
17:17:20 141.790695 T:139829743949888 NOTICE: GL: NPOT texture support detected
17:17:20 141.790756 T:139829743949888 NOTICE: GL: Using GL_ARB_pixel_buffer_object
17:17:20 141.792755 T:139829743949888 WARNING: CRenderCaptureGL: GL_ARB_occlusion_query disabled, performance might suffer
17:17:20 141.832932 T:139829725013760 DEBUG: ActiveAE::SyncStream - average error of 9.812969, start adjusting
17:17:20 141.833054 T:139829725013760 DEBUG: ActiveAE::SyncStream - average error 0.812969 below threshold of 30.000000
17:17:21 142.931778 T:139828300818176 DEBUG: CDVDClock::Discontinuity - CVideoPlayerAudio::OutputPacket - was:1058678.766885, should be:1068884.920832, error:10206.153947
17:17:23 145.195816 T:139829743949888 DEBUG: ------ Window Deinit (DialogNotification.xml) ------
17:17:24 146.488251 T:139828106897152 DEBUG: CPullupCorrection: detected pattern of length 1: 41708.33, frameduration: 41708.333333
17:17:48 169.743530 T:139828918195968 DEBUG: Thread JobWorker 139828918195968 terminating (autodelete)
17:17:48 169.761322 T:139828081456896 DEBUG: Thread JobWorker 139828081456896 terminating (autodelete)
17:18:19 201.515274 T:139829287311104 DEBUG: PushCecKeypress - received key e0 duration 1001
17:18:20 201.544525 T:139829743949888 DEBUG: OnKey: guide (0xe0) pressed, action is Stop
17:18:20 201.544662 T:139829743949888 NOTICE: CVideoPlayer::CloseFile()
17:18:20 201.544693 T:139829743949888 NOTICE: VideoPlayer: waiting for threads to exit
17:18:20 201.554276 T:139828926588672 NOTICE: CVideoPlayer::OnExit()
17:18:20 201.554352 T:139828926588672 NOTICE: Closing stream player 1
17:18:20 201.554382 T:139828926588672 NOTICE: Waiting for audio thread to exit
17:18:20 201.583664 T:139828300818176 NOTICE: thread end: CVideoPlayerAudio::OnExit()
17:18:20 201.583740 T:139828300818176 DEBUG: Thread VideoPlayerAudio 139828300818176 terminating
17:18:20 201.583847 T:139828926588672 NOTICE: Closing audio device
17:18:20 201.633362 T:139828926588672 DEBUG: CDVDAudio::Flush - flush audio stream
17:18:20 201.633469 T:139829725013760 DEBUG: CActiveAE::DiscardStream - audio stream deleted
17:18:20 201.633591 T:139829725013760 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
17:18:20 201.634598 T:139828926588672 NOTICE: Deleting audio codec
17:18:20 201.634689 T:139828926588672 NOTICE: Closing stream player 2
17:18:20 201.634720 T:139828926588672 NOTICE: waiting for video thread to exit
17:18:20 201.634857 T:139829725013760 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
17:18:20 201.634949 T:139829716621056 INFO: CActiveAESink::OpenSink - initialize sink
17:18:20 201.644653 T:139828106897152 NOTICE: thread end: video_thread
17:18:20 201.644775 T:139828106897152 DEBUG: Thread VideoPlayerVideo 139828106897152 terminating
17:18:20 201.645294 T:139828926588672 NOTICE: deleting video codec
17:18:20 201.645584 T:139828926588672 DEBUG: VAAPI::Release pre-cleanup
17:18:20 201.649750 T:139828926588672 DEBUG: OnPlayBackStopped: play state was 2, starting 0
17:18:20 201.649933 T:139829743941376 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
17:18:20 201.650009 T:139829743941376 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
17:18:20 201.650116 T:139828926588672 DEBUG: Thread VideoPlayer 139828926588672 terminating
17:18:20 201.650421 T:139829743949888 NOTICE: VideoPlayer: finished waiting
17:18:20 201.650513 T:139829743949888 DEBUG: DeleteRenderer - deleting renderer
17:18:20 201.650787 T:139829743949888 NOTICE: VAAPI::Close
17:18:20 201.651276 T:139828159842048 NOTICE: COutput::OnExit: Output Thread terminated
17:18:20 201.651321 T:139828159842048 DEBUG: Thread Vaapi-Output 139828159842048 terminating
17:18:20 201.651489 T:139829743949888 DEBUG: VAAPI::FiniVAAPIOutput destroying 5 video surfaces
17:18:20 201.654678 T:139829743949888 NOTICE: VAAPI::Close - closing decoder context
17:18:20 201.657761 T:139829743949888 DEBUG: LinuxRendererGL: Cleaning up GL resources
17:18:20 201.657913 T:139829743949888 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
17:18:20 201.657959 T:139829743949888 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------
17:18:20 201.665756 T:139829743949888 NOTICE: CWinSystemX11::SetFullScreen - calling xrandr
17:18:20 201.666306 T:139829743949888 DEBUG: OnLostDevice - notify display change event
17:18:20 201.835114 T:139829716621056 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0
17:18:20 201.835190 T:139829716621056 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0"
17:18:20 201.842743 T:139829716621056 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00"
17:18:20 201.843918 T:139829716621056 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
17:18:20 201.844009 T:139829716621056 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
17:18:20 201.844055 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2205, bufferSize 8820
17:18:20 201.850647 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2205, bufferSize 8820
17:18:20 201.850723 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms
17:18:20 201.851807 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
17:18:20 201.851837 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
17:18:20 201.851868 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR)
17:18:20 201.851913 T:139829716621056 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
17:18:20 201.851944 T:139829716621056 DEBUG: Output Device : HDA Intel PCH
17:18:20 201.851974 T:139829716621056 DEBUG: Sample Rate : 44100
17:18:20 201.852005 T:139829716621056 DEBUG: Sample Format : AE_FMT_S32NE
17:18:20 201.852036 T:139829716621056 DEBUG: Channel Count : 2
17:18:20 201.852097 T:139829716621056 DEBUG: Channel Layout: FL,FR
17:18:20 201.852127 T:139829716621056 DEBUG: Frames : 2205
17:18:20 201.852158 T:139829716621056 DEBUG: Frame Size : 8
17:18:20 201.854797 T:139829725013760 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
17:18:20 201.856003 T:139829743949888 NOTICE: VideoPlayer: OnLostDisplay received
17:18:20 201.856125 T:139829743949888 INFO: XRANDR: /usr/lib/kodi/kodi-xrandr --screen 0 --output HDMI2 --mode 0x49
17:18:20 202.161835 T:139829735548672 DEBUG: CALSAHControlMonitor - Monitored ALSA hctl value changed
17:18:20 202.196304 T:139829458097920 DEBUG: GetMappingForDevice - device (2548:1002) mapped to Pulse-Eight CEC Adapter (type = cec)
17:18:20 202.412628 T:139829735548672 DEBUG: Previous line repeats 1 times.
17:18:20 202.412704 T:139829735548672 DEBUG: CALSAHControlMonitor - Monitored ALSA hctl value changed
17:18:20 202.440094 T:139829743949888 INFO: GL: Maximum texture width: 8192
17:18:20 202.442184 T:139829743949888 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
17:18:20 202.451202 T:139829743949888 DEBUG: ------ Window Init (MyVideoNav.xml) ------
17:18:20 202.453094 T:139829743949888 DEBUG: CGUIMediaWindow::GetDirectory (/storage/mediathek/Videos/HD/3D/)
17:18:20 202.453156 T:139829743949888 DEBUG: ParentPath = [/storage/mediathek/Videos/HD/3D/]
17:18:20 202.511902 T:139829743949888 DEBUG: RunQuery took 2 ms for 59 items query: select * from movie_view WHERE c23=52
17:18:20 202.520233 T:139828159842048 DEBUG: Thread BackgroundLoader start, auto delete: false
17:18:20 202.526047 T:139829743949888 INFO: ffmpeg[7F2CA6379840]: [mjpeg] Changing bps to 8
17:18:21 202.547852 T:139828159842048 DEBUG: Thread BackgroundLoader 139828159842048 terminating
17:18:21 202.566757 T:139828159842048 DEBUG: Thread JobWorker start, auto delete: true
17:18:21 202.566956 T:139828159842048 DEBUG: GetImageHash - unable to stat url
17:18:21 202.647766 T:139829743949888 NOTICE: CVideoPlayer::CloseFile()
17:18:21 202.647888 T:139829743949888 NOTICE: VideoPlayer: waiting for threads to exit
17:18:21 202.647903 T:139829743949888 NOTICE: VideoPlayer: finished waiting
17:18:21 202.647949 T:139829743949888 NOTICE: CVideoPlayer::CloseFile()
17:18:21 202.647964 T:139829743949888 NOTICE: VideoPlayer: waiting for threads to exit
17:18:21 202.647995 T:139829743949888 NOTICE: VideoPlayer: finished waiting
17:18:21 202.651062 T:139829743949888 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData
17:18:21 202.651443 T:139829743949888 DEBUG: StereoscopicsManager: stereo mode setting changed to off
17:18:21 202.651474 T:139829743949888 DEBUG: StereoscopicsManager::ApplyStereoMode: trying to apply stereo mode. Current: split_vertical | Target: off
17:18:21 202.651489 T:139829743949888 DEBUG: StereoscopicsManager: stereo mode changed to off
17:18:21 202.651764 T:139829743949888 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/libsse4-x86_64-linux.so)
17:18:21 202.652039 T:139828159842048 DEBUG: DoWork - Saving file state for video item /storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv
17:18:21 202.652512 T:139829743949888 DEBUG: ------ Window Init (DialogNotification.xml) ------
17:18:21 202.652725 T:139829743949888 DEBUG: NotifyXRREvent - notify display reset event
17:18:21 202.677277 T:139829743949888 DEBUG: RecreateWindow - current output: HDMI2, mode: 0x49, refresh: 50.000
17:18:21 202.677353 T:139829743949888 DEBUG: OnLostDevice - notify display change event
17:18:21 202.682236 T:139829743949888 DEBUG: Window Manager Name: Fluxbox
17:18:21 202.682404 T:139829743941376 DEBUG: CAnnouncementManager - Announcement: OnUpdate from xbmc
17:18:21 202.682510 T:139829743941376 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnUpdate
17:18:21 202.692078 T:139829743949888 DEBUG: CWinSystemX11::RefreshEGLContext: refreshing context
17:18:21 202.695099 T:139829743949888 DEBUG: OnLostDevice - notify display change event
17:18:21 202.698746 T:139829743949888 DEBUG: Window Manager Name: Fluxbox
17:18:21 202.710327 T:139829743949888 DEBUG: CWinSystemX11::RefreshEGLContext: refreshing context
17:18:21 202.712143 T:139829725013760 DEBUG: CActiveAE - display reset event
17:18:21 202.712769 T:139829716621056 INFO: CActiveAESink::OpenSink - initialize sink
17:18:21 202.712845 T:139829716621056 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0
17:18:21 202.712875 T:139829716621056 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0"
17:18:21 202.716873 T:139829716621056 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00"
17:18:21 202.718231 T:139829716621056 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
17:18:21 202.718292 T:139829716621056 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
17:18:21 202.718307 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2205, bufferSize 8820
17:18:21 202.721115 T:139829743949888 INFO: GL: Maximum texture width: 8192
17:18:21 202.726852 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2205, bufferSize 8820
17:18:21 202.726913 T:139829716621056 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms
17:18:21 202.727905 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
17:18:21 202.727921 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
17:18:21 202.727951 T:139829716621056 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR)
17:18:21 202.727982 T:139829716621056 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
17:18:21 202.727997 T:139829716621056 DEBUG: Output Device : HDA Intel PCH
17:18:21 202.728012 T:139829716621056 DEBUG: Sample Rate : 44100
17:18:21 202.728043 T:139829716621056 DEBUG: Sample Format : AE_FMT_S32NE
17:18:21 202.728058 T:139829716621056 DEBUG: Channel Count : 2
17:18:21 202.728073 T:139829716621056 DEBUG: Channel Layout: FL,FR
17:18:21 202.728104 T:139829716621056 DEBUG: Frames : 2205
17:18:21 202.728119 T:139829716621056 DEBUG: Frame Size : 8
17:18:21 202.729752 T:139829725013760 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
17:18:21 202.752243 T:139829743949888 INFO: GL: Maximum texture width: 8192
17:18:21 202.766907 T:139829725013760 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
17:18:24 206.068604 T:139829287311104 DEBUG: PushCecKeypress - received key d8 duration 0
17:18:24 206.107178 T:139829743949888 DEBUG: OnKey: menu (0xd8) pressed, action is Back
17:18:24 206.107437 T:139829743949888 DEBUG: CGUIMediaWindow::GetDirectory (/storage/mediathek/Videos/HD/)
17:18:24 206.107529 T:139829743949888 DEBUG: ParentPath = [sources://video/]
17:18:24 206.134872 T:139829743949888 DEBUG: RunQuery took 1 ms for 0 items query: select * from movie_view WHERE c23=51
17:18:24 206.140182 T:139828081456896 DEBUG: Thread BackgroundLoader start, auto delete: false
17:18:24 206.144272 T:139828159842048 DEBUG: GetImageHash - unable to stat url
17:18:24 206.171814 T:139828081456896 DEBUG: Thread BackgroundLoader 139828081456896 terminating
17:18:24 206.339279 T:139829287311104 DEBUG: PushCecKeypress - received key d8 duration 270
17:18:25 207.022537 T:139829287311104 DEBUG: PushCecKeypress - received key d8 duration 0
17:18:25 207.043060 T:139829743949888 DEBUG: OnKey: menu (0xd8) pressed, action is Back
17:18:25 207.043930 T:139829743949888 DEBUG: CGUIMediaWindow::GetDirectory (sources://video/)
17:18:25 207.044037 T:139829743949888 DEBUG: ParentPath = []
17:18:25 207.067612 T:139828106897152 DEBUG: Thread BackgroundLoader start, auto delete: false
17:18:25 207.074448 T:139828106897152 DEBUG: Thread BackgroundLoader 139828106897152 terminating
17:18:25 207.289459 T:139829287311104 DEBUG: PushCecKeypress - received key d8 duration 267
17:18:26 208.478348 T:139829743949888 DEBUG: ------ Window Deinit (DialogNotification.xml) ------
17:18:27 209.460663 T:139829287311104 DEBUG: PushCecKeypress - received key d8 duration 0
17:18:27 209.473984 T:139829743949888 DEBUG: OnKey: menu (0xd8) pressed, action is Back
17:18:27 209.474579 T:139829743949888 DEBUG: CGUIMediaWindow::GetDirectory ()
17:18:27 209.474655 T:139829743949888 DEBUG: ParentPath = []
17:18:27 209.487381 T:139828106897152 DEBUG: Thread BackgroundLoader start, auto delete: false
17:18:27 209.503006 T:139828106897152 DEBUG: Thread BackgroundLoader 139828106897152 terminating
17:18:28 209.738464 T:139829287311104 DEBUG: PushCecKeypress - received key d8 duration 278
17:18:28 210.363831 T:139829287311104 DEBUG: PushCecKeypress - received key d8 duration 0
17:18:28 210.371872 T:139829743949888 DEBUG: OnKey: menu (0xd8) pressed, action is Back
17:18:28 210.372101 T:139829743949888 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
17:18:29 210.636032 T:139829287311104 DEBUG: PushCecKeypress - received key d8 duration 272
17:18:29 210.692215 T:139829743949888 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
17:18:29 210.694061 T:139829743949888 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
17:18:29 210.694199 T:139829743949888 DEBUG: ------ Window Init (SettingsCategory.xml) ------
17:18:31 212.562714 T:139829287311104 DEBUG: PushCecKeypress - received key b duration 0
17:18:31 212.578079 T:139829743949888 DEBUG: OnKey: 11 (0x0b) pressed, action is Select
17:18:31 212.578171 T:139829743949888 NOTICE: Disabled debug logging due to GUI setting. Level 0.
17:18:31 212.578201 T:139829743949888 NOTICE: Log level changed to "LOG_LEVEL_NORMAL"