19:40:55 320.459747 T:140177224669248 NOTICE: special://profile/ is mapped to: special://masterprofile/ 19:40:55 320.459778 T:140177224669248 NOTICE: ----------------------------------------------------------------------- 19:40:55 320.459808 T:140177224669248 NOTICE: Starting Kodi (17.0-ALPHA2 Git:08ec69b). Platform: Linux x86 64-bit 19:40:55 320.459839 T:140177224669248 NOTICE: Using Release Kodi x64 build 19:40:55 320.459869 T:140177224669248 NOTICE: Kodi compiled Jun 19 2016 by GCC 5.3.0 for Linux x86 64-bit version 4.6.2 (263682) 19:40:55 320.460052 T:140177224669248 NOTICE: Running on LibreELEC (Milhouse) - Version: devel-20160619212021-#0619-gc6c222d [Build #0619] 8.0, kernel: Linux x86 64-bit version 4.6.2 19:40:55 320.460052 T:140177224669248 NOTICE: FFmpeg version: 3.0.1 19:40:55 320.460083 T:140177224669248 NOTICE: WARNING: unsupported ffmpeg version detected 19:40:55 320.460114 T:140177224669248 NOTICE: Host CPU: Intel(R) Celeron(R) CPU N3050 @ 1.60GHz, 2 cores available 19:40:55 320.460144 T:140177224669248 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi 19:40:55 320.460144 T:140177224669248 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi 19:40:55 320.460175 T:140177224669248 NOTICE: special://masterprofile/ is mapped to: /storage/.kodi/userdata 19:40:55 320.460205 T:140177224669248 NOTICE: special://home/ is mapped to: /storage/.kodi 19:40:55 320.460205 T:140177224669248 NOTICE: special://temp/ is mapped to: /storage/.kodi/temp 19:40:55 320.460236 T:140177224669248 NOTICE: special://logpath/ is mapped to: /storage/.kodi/temp 19:40:55 320.460266 T:140177224669248 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin 19:40:55 320.460327 T:140177224669248 NOTICE: Local hostname: OpenELEC_NUC 19:40:55 320.460358 T:140177224669248 NOTICE: Log File is located: /storage/.kodi/temp//kodi.log 19:40:55 320.460388 T:140177224669248 NOTICE: ----------------------------------------------------------------------- 19:40:55 320.475372 T:140177224669248 ERROR: DBus: Error org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files 19:40:55 320.505493 T:140177224669248 NOTICE: load settings... 19:40:55 320.638306 T:140177224669248 NOTICE: Found 2 Lists of Devices 19:40:55 320.638336 T:140177224669248 NOTICE: Enumerated ALSA devices: 19:40:55 320.638367 T:140177224669248 NOTICE: Device 1 19:40:55 320.638580 T:140177224669248 NOTICE: m_deviceName : @:CARD=PCH,DEV=0 19:40:55 320.638580 T:140177224669248 NOTICE: m_displayName : HDA Intel PCH 19:40:55 320.638611 T:140177224669248 NOTICE: m_displayNameExtra: ALC283 Analog 19:40:55 320.638641 T:140177224669248 NOTICE: m_deviceType : AE_DEVTYPE_PCM 19:40:55 320.638672 T:140177224669248 NOTICE: m_channels : FL,FR,BL,BR 19:40:55 320.638672 T:140177224669248 NOTICE: m_sampleRates : 48000 19:40:55 320.638702 T:140177224669248 NOTICE: m_dataFormats : AE_FMT_S32NE 19:40:55 320.638733 T:140177224669248 NOTICE: m_streamTypes : No passthrough capabilities 19:40:55 320.638763 T:140177224669248 NOTICE: Device 2 19:40:55 320.638794 T:140177224669248 NOTICE: m_deviceName : iec958:CARD=PCH,DEV=0 19:40:55 320.638824 T:140177224669248 NOTICE: m_displayName : HDA Intel PCH 19:40:55 320.638824 T:140177224669248 NOTICE: m_displayNameExtra: ALC283 Digital S/PDIF 19:40:55 320.638855 T:140177224669248 NOTICE: m_deviceType : AE_DEVTYPE_IEC958 19:40:55 320.638885 T:140177224669248 NOTICE: m_channels : FL,FR 19:40:55 320.638916 T:140177224669248 NOTICE: m_sampleRates : 44100,48000,88200,96000,192000 19:40:55 320.638916 T:140177224669248 NOTICE: m_dataFormats : AE_FMT_RAW,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE 19:40:55 320.638947 T:140177224669248 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512 19:40:55 320.638977 T:140177224669248 NOTICE: Device 3 19:40:55 320.639038 T:140177224669248 NOTICE: m_deviceName : hdmi:CARD=PCH,DEV=0 19:40:55 320.639069 T:140177224669248 NOTICE: m_displayName : HDA Intel PCH 19:40:55 320.639069 T:140177224669248 NOTICE: m_displayNameExtra: MJI marantz-AVR on HDMI 19:40:55 320.639099 T:140177224669248 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 19:40:55 320.639130 T:140177224669248 NOTICE: m_channels : FL,FR,LFE,FC,BL,BR,BC,BLOC,BROC 19:40:55 320.639130 T:140177224669248 NOTICE: m_sampleRates : 32000,44100,48000,88200,96000,176400,192000 19:40:55 320.639160 T:140177224669248 NOTICE: m_dataFormats : AE_FMT_RAW,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW 19:40:55 320.639191 T:140177224669248 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 19:40:55 320.639221 T:140177224669248 NOTICE: Enumerated PULSE devices: 19:40:55 320.639221 T:140177224669248 NOTICE: Device 1 19:40:55 320.639282 T:140177224669248 NOTICE: m_deviceName : Default 19:40:55 320.639282 T:140177224669248 NOTICE: m_displayName : Default 19:40:55 320.639313 T:140177224669248 NOTICE: m_displayNameExtra: Bluetooth Audio (PULSEAUDIO) 19:40:55 320.639343 T:140177224669248 NOTICE: m_deviceType : AE_DEVTYPE_PCM 19:40:55 320.639343 T:140177224669248 NOTICE: m_channels : FL,FR 19:40:55 320.639374 T:140177224669248 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000 19:40:55 320.639404 T:140177224669248 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT 19:40:55 320.639435 T:140177224669248 NOTICE: m_streamTypes : No passthrough capabilities 19:40:55 320.648651 T:140177224669248 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml 19:40:55 320.648834 T:140177224669248 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are... false cputemp gputemp 30 19:40:55 320.649506 T:140177224669248 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 19:40:55 320.649536 T:140177224669248 NOTICE: Default Video Player: VideoPlayer 19:40:55 320.649567 T:140177224669248 NOTICE: Default Audio Player: paplayer 19:40:55 320.649597 T:140177224669248 NOTICE: Disabled debug logging due to GUI setting. Level 0. 19:40:55 320.649628 T:140177224669248 NOTICE: Log level changed to "LOG_LEVEL_NORMAL" 19:40:55 320.649719 T:140177224669248 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml 19:40:55 320.651215 T:140177224669248 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 19:40:55 320.651672 T:140177224669248 NOTICE: Loaded playercorefactory configuration 19:40:55 320.651794 T:140177224669248 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 19:40:55 320.651886 T:140177224669248 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 17:40:55 320.672272 T:140177224669248 NOTICE: Old database found - updating from version 23 to 26 17:40:56 320.839813 T:140177224669248 NOTICE: Attempting to update the database Addons26 from version 23 to 26 17:40:56 320.999115 T:140177224669248 NOTICE: ADDONS: Using repository repository.kodi.game 17:40:56 320.999176 T:140177224669248 NOTICE: ADDONS: Using repository repository.xbmc.org 17:40:56 320.999207 T:140177224669248 NOTICE: ADDONS: Using repository repository.libreelec.tv 17:40:56 321.319244 T:140177224669248 NOTICE: Checking resolution 16 17:40:56 321.422485 T:140177224669248 NOTICE: Using visual 0x20 17:40:56 321.433624 T:140177224669248 NOTICE: GL_VENDOR = Intel Open Source Technology Center 17:40:56 321.433685 T:140177224669248 NOTICE: GL_RENDERER = Mesa DRI Intel(R) HD Graphics 400 (Braswell) 17:40:56 321.433716 T:140177224669248 NOTICE: GL_VERSION = 3.0 Mesa 12.0.0-rc2 (git-a7649ab) 17:40:56 321.433716 T:140177224669248 NOTICE: GL_SHADING_LANGUAGE_VERSION = 1.30 17:40:56 321.433899 T:140177224669248 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_shader_precision 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_compute_shader 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_robust_buffer_access_behavior 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_KHR_robustness GL_ARB_buffer_storage GL_ARB_clear_texture GL_ARB_internalformat_query2 GL_ARB_multi_bind GL_ARB_query_buffer_object GL_ARB_seamless_cubemap_per_texture GL_ARB_shader_draw_parameters GL_ARB_texture_mirror_clamp_to_edge GL_ARB_texture_stencil8 GL_ARB_vertex_type_10f_11f_11f_rev GL_EXT_shader_integer_mix GL_ARB_clip_control GL_ARB_conditional_render_inverted GL_ARB_cull_distance 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_KHR_robust_buffer_access_behavior GL_ARB_shader_clock GL_EXT_shader_samples_identical 17:40:56 321.557892 T:140177224669248 ERROR: GL: Vertical Blank Syncing unsupported 17:40:57 321.821503 T:140177224669248 NOTICE: Running database version Addons26 17:40:57 321.826996 T:140177224669248 NOTICE: Running database version ViewModes6 17:40:57 321.830719 T:140177224669248 NOTICE: Running database version Textures13 17:40:57 321.836426 T:140177224669248 NOTICE: Running database version MyMusic60 17:40:57 321.846222 T:140177224669248 NOTICE: Old database found - updating from version 104 to 106 17:40:57 321.920502 T:140177224669248 NOTICE: Attempting to update the database MyVideos106 from version 104 to 106 17:40:57 322.042603 T:140176860903168 NOTICE: Register - new cec device registered on cec->/dev/ttyACM0: CEC Adapter (2548:1002) 17:40:57 322.047974 T:140177224669248 NOTICE: Running database version TV29 17:40:57 322.050110 T:140177224669248 NOTICE: Running database version Epg11 17:40:57 322.051575 T:140177224669248 NOTICE: start dvd mediatype detection 17:40:57 322.245209 T:140177224669248 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 17:40:57 322.512604 T:140177224669248 NOTICE: initialize done 17:40:57 322.512665 T:140177224669248 NOTICE: Running the application... 17:40:57 322.527710 T:140177224669248 NOTICE: starting zeroconf publishing 17:40:57 322.528168 T:140177224669248 NOTICE: CWebServer[8080]: Started 17:40:57 322.528229 T:140177224669248 NOTICE: starting upnp client 17:40:57 322.551697 T:140175912986368 NOTICE: ES: Starting UDP Event server on 127.0.0.1:9777 17:40:57 322.551788 T:140175912986368 NOTICE: UDP: Listening on port 9777 17:40:57 322.587982 T:140176357570304 ERROR: GetDirectory - Error getting - 17:40:58 322.821625 T:140176055596800 WARNING: CSkinInfo: failed to load skin settings 17:41:04 329.409729 T:140177224669248 ERROR: Window Translator: Can't find window musicsettings 17:41:05 329.759766 T:140176357570304 ERROR: GetDirectory - Error getting - 17:41:52 377.303070 T:140177224669248 ERROR: Window Translator: Can't find window musicsettings 17:42:28 413.295959 T:140177224669248 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 17:42:28 413.296051 T:140177224669248 NOTICE: Enabled debug logging due to GUI setting. Level 2. 17:42:28 413.296753 T:140177224669248 DEBUG: ------ Window Init () ------ 17:42:28 413.561981 T:140176835725056 DEBUG: PushCecKeypress - received key b duration 279 17:42:30 415.483032 T:140176835725056 DEBUG: PushCecKeypress - received key fd duration 0 17:42:30 415.493378 T:140177224669248 DEBUG: OnKey: 253 (0xfd, obc2) pressed, action is ActivateWindow(MyMusic) 17:42:30 415.493469 T:140177224669248 DEBUG: Activating window ID: 10502 17:42:31 415.810394 T:140176835725056 DEBUG: PushCecKeypress - received key fd duration 328 17:42:31 415.836578 T:140177224669248 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------ 17:42:31 415.843994 T:140177224669248 DEBUG: ------ Window Init (MyMusicNav.xml) ------ 17:42:31 415.844086 T:140177224669248 INFO: Loading skin file: MyMusicNav.xml, load type: KEEP_IN_MEMORY 17:42:31 415.966614 T:140177224669248 DEBUG: CGUIMediaWindow::GetDirectory () 17:42:31 415.966675 T:140177224669248 DEBUG: ParentPath = [] 17:42:31 415.978210 T:140177224669248 DEBUG: RetrieveMusicInfo() took 0 msec 17:42:31 415.982269 T:140175812273920 DEBUG: Thread BackgroundLoader start, auto delete: false 17:42:31 415.995178 T:140175812273920 DEBUG: Thread BackgroundLoader 140175812273920 terminating 17:42:35 420.231934 T:140176835725056 DEBUG: PushCecKeypress - received key fc duration 0 17:42:35 420.234650 T:140177224669248 DEBUG: OnKey: 252 (0xfc, obc3) pressed, action is ActivateWindow(MyVideos) 17:42:35 420.234833 T:140177224669248 DEBUG: Activating window ID: 10025 17:42:35 420.509094 T:140176835725056 DEBUG: PushCecKeypress - received key fc duration 277 17:42:35 420.551331 T:140177224669248 DEBUG: ------ Window Deinit (MyMusicNav.xml) ------ 17:42:35 420.556671 T:140177224669248 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 17:42:35 420.556732 T:140177224669248 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 17:42:35 420.672943 T:140175812273920 DEBUG: Thread JobWorker start, auto delete: true 17:42:35 420.673279 T:140177224669248 DEBUG: CGUIMediaWindow::GetDirectory () 17:42:35 420.673370 T:140177224669248 DEBUG: ParentPath = [] 17:42:35 420.673431 T:140175812273920 ERROR: GetDirectory - Error getting 17:42:35 420.682892 T:140176357570304 ERROR: Previous line repeats 1 times. 17:42:35 420.683075 T:140176357570304 DEBUG: Thread BackgroundLoader start, auto delete: false 17:42:35 420.700134 T:140176357570304 DEBUG: Thread BackgroundLoader 140176357570304 terminating 17:42:37 422.732574 T:140176835725056 DEBUG: PushCecKeypress - received key b duration 0 17:42:37 422.733093 T:140177224669248 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:42:37 422.734039 T:140177224669248 DEBUG: CGUIMediaWindow::GetDirectory (library://video/files.xml/) 17:42:37 422.734070 T:140177224669248 DEBUG: ParentPath = [] 17:42:38 422.782135 T:140176357570304 DEBUG: Thread BackgroundLoader start, auto delete: false 17:42:38 422.789551 T:140175812273920 DEBUG: GetImageHash - unable to stat url 17:42:38 422.791260 T:140176357570304 DEBUG: Thread BackgroundLoader 140176357570304 terminating 17:42:38 422.837311 T:140175812273920 DEBUG: GetImageHash - unable to stat url 17:42:38 423.009552 T:140176835725056 DEBUG: Previous line repeats 4 times. 17:42:38 423.009613 T:140176835725056 DEBUG: PushCecKeypress - received key b duration 277 17:42:38 423.037628 T:140175812273920 DEBUG: GetImageHash - unable to stat url 17:42:39 423.784515 T:140176835725056 DEBUG: Previous line repeats 18 times. 17:42:39 423.784576 T:140176835725056 DEBUG: PushCecKeypress - received key a7 duration 0 17:42:39 423.798279 T:140177224669248 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:42:39 423.799347 T:140175812273920 DEBUG: GetImageHash - unable to stat url 17:42:39 424.057434 T:140176835725056 DEBUG: Previous line repeats 6 times. 17:42:39 424.057495 T:140176835725056 DEBUG: PushCecKeypress - received key a7 duration 273 17:42:39 424.077148 T:140175812273920 DEBUG: GetImageHash - unable to stat url 17:42:39 424.183624 T:140176835725056 DEBUG: Previous line repeats 2 times. 17:42:39 424.183655 T:140176835725056 DEBUG: PushCecKeypress - received key a7 duration 0 17:42:39 424.195465 T:140177224669248 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:42:39 424.196503 T:140175812273920 DEBUG: GetImageHash - unable to stat url 17:42:39 424.411530 T:140176835725056 DEBUG: Previous line repeats 5 times. 17:42:39 424.411591 T:140176835725056 DEBUG: PushCecKeypress - received key a7 duration 228 17:42:39 424.438141 T:140175812273920 DEBUG: GetImageHash - unable to stat url 17:42:40 424.786957 T:140176835725056 DEBUG: Previous line repeats 13 times. 17:42:40 424.787079 T:140176835725056 DEBUG: PushCecKeypress - received key b duration 0 17:42:40 424.795868 T:140177224669248 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:42:40 424.796600 T:140177224669248 DEBUG: CGUIMediaWindow::GetDirectory (/storage/mediathek/Videos/HD/) 17:42:40 424.796661 T:140177224669248 DEBUG: ParentPath = [sources://video/] 17:42:40 424.813965 T:140176357570304 DEBUG: Thread BackgroundLoader start, auto delete: false 17:42:40 424.817474 T:140175812273920 DEBUG: GetImageHash - unable to stat url 17:42:40 424.856171 T:140177224669248 NOTICE: Samba is idle. Closing the remaining connections 17:42:40 424.860474 T:140176357570304 DEBUG: Thread BackgroundLoader 140176357570304 terminating 17:42:40 425.059326 T:140176835725056 DEBUG: PushCecKeypress - received key b duration 273 17:42:40 425.683258 T:140176835725056 DEBUG: PushCecKeypress - received key a7 duration 0 17:42:40 425.684937 T:140177224669248 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:42:40 425.687073 T:140175812273920 DEBUG: GetImageHash - unable to stat url 17:42:41 425.961884 T:140176835725056 DEBUG: PushCecKeypress - received key a7 duration 279 17:42:41 426.382538 T:140176835725056 DEBUG: PushCecKeypress - received key b duration 0 17:42:41 426.386444 T:140177224669248 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:42:41 426.388428 T:140177224669248 DEBUG: CGUIMediaWindow::GetDirectory (/storage/mediathek/Videos/HD/3D/) 17:42:41 426.388580 T:140177224669248 DEBUG: ParentPath = [/storage/mediathek/Videos/HD/] 17:42:41 426.475189 T:140177224669248 DEBUG: RunQuery took 1 ms for 59 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=2 17:42:41 426.480927 T:140176357570304 DEBUG: Thread BackgroundLoader start, auto delete: false 17:42:41 426.488495 T:140175812273920 DEBUG: GetImageHash - unable to stat url 17:42:41 426.637482 T:140176357570304 DEBUG: Thread BackgroundLoader 140176357570304 terminating 17:42:41 426.658722 T:140176835725056 DEBUG: PushCecKeypress - received key b duration 276 17:42:42 427.284119 T:140176835725056 DEBUG: PushCecKeypress - received key a7 duration 0 17:42:42 427.298126 T:140177224669248 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:42:42 427.300385 T:140175812273920 DEBUG: GetImageHash - unable to stat url 17:42:42 427.559082 T:140176835725056 DEBUG: PushCecKeypress - received key a7 duration 275 17:42:43 428.235016 T:140176835725056 DEBUG: PushCecKeypress - received key b duration 0 17:42:43 428.236359 T:140177224669248 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:42:43 428.255463 T:140177224669248 DEBUG: OnPlayMedia /storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv 17:42:43 428.274597 T:140177224669248 DEBUG: Loading settings for /storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv 17:42:43 428.277069 T:140177224660736 DEBUG: GetMovieId (/storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv), query = select idMovie from movie where idFile=9 17:42:43 428.277588 T:140177224660736 DEBUG: GetEpisodeId (/storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv), query = select idEpisode from episode where idFile=9 17:42:43 428.278046 T:140177224660736 DEBUG: GetMusicVideoId (/storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv), query = select idMVideo from musicvideo where idFile=9 17:42:43 428.280548 T:140177224660736 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 17:42:43 428.280640 T:140177224660736 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 17:42:43 428.281952 T:140177224669248 DEBUG: CPlayerCoreFactory::GetPlayers(/storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv) 17:42:43 428.282013 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 17:42:43 428.282043 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 17:42:43 428.282074 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 17:42:43 428.282135 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 17:42:43 428.282166 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 17:42:43 428.282196 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 17:42:43 428.282227 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 17:42:43 428.282257 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 17:42:43 428.282288 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 17:42:43 428.282318 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 17:42:43 428.282349 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 17:42:43 428.282379 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 17:42:43 428.282440 T:140177224669248 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 17:42:43 428.282471 T:140177224669248 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 17:42:43 428.282471 T:140177224669248 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 17:42:43 428.282501 T:140177224669248 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 17:42:43 428.282532 T:140177224669248 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 17:42:43 428.284851 T:140177224669248 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 17:42:43 428.284973 T:140177224669248 NOTICE: VideoPlayer: Opening: /storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv 17:42:43 428.285004 T:140177224669248 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 17:42:43 428.285126 T:140177224669248 DEBUG: LinuxRendererGL: Cleaning up GL resources 17:42:43 428.286163 T:140177224669248 DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16 17:42:43 428.286377 T:140176349177600 DEBUG: Thread VideoPlayer start, auto delete: false 17:42:43 428.286560 T:140176349177600 NOTICE: Creating InputStream 17:42:43 428.295746 T:140176349177600 DEBUG: ScanForExternalSubtitles: Searching for subtitles... 17:42:43 428.298645 T:140176349177600 DEBUG: ScanForExternalSubtitles: END (total time: 3 ms) 17:42:43 428.298706 T:140176349177600 NOTICE: Creating Demuxer 17:42:43 428.299194 T:140176349177600 DEBUG: Open - probing detected format [matroska,webm] 17:42:43 428.299866 T:140176349177600 DEBUG: Open - avformat_find_stream_info starting 17:42:43 428.314636 T:140176349177600 DEBUG: Open - av_find_stream_info finished 17:42:43 428.314758 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Input #0, matroska,webm, /storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mk': 17:42:43 428.314819 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Metadata: 17:42:43 428.314880 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: encoder : libebml v1.3.0 + libmatroska v1.4.1 17:42:43 428.314911 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: creation_time : 2014-06-07 20:18:01 17:42:43 428.314972 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Duration: 01:42:36.73, start: 0.000000, bitrate: 14228 kb/s 17:42:43 428.315002 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Chapter #0:0: start 0.000000, end 626.376000 17:42:43 428.315033 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Metadata: 17:42:43 428.315063 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: title : 00:00:00.000 17:42:43 428.315094 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Chapter #0:1: start 626.376000, end 1254.628000 17:42:43 428.315125 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Metadata: 17:42:43 428.315155 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: title : 00:10:26.376 17:42:43 428.315308 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Chapter #0:2: start 1254.628000, end 1875.290000 17:42:43 428.315338 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Metadata: 17:42:43 428.315369 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: title : 00:20:54.628 17:42:43 428.315399 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Chapter #0:3: start 1875.290000, end 2458.498000 17:42:43 428.315430 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Metadata: 17:42:43 428.315460 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: title : 00:31:15.290 17:42:43 428.315491 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Chapter #0:4: start 2458.498000, end 3050.714000 17:42:43 428.315491 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Metadata: 17:42:43 428.315521 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: title : 00:40:58.498 17:42:43 428.315582 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Chapter #0:5: start 3050.714000, end 3605.435000 17:42:43 428.315582 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Metadata: 17:42:43 428.315613 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: title : 00:50:50.714 17:42:43 428.315674 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Chapter #0:6: start 3605.435000, end 4191.813000 17:42:43 428.315674 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Metadata: 17:42:43 428.315704 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: title : 01:00:05.435 17:42:43 428.315765 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Chapter #0:7: start 4191.813000, end 4791.245000 17:42:43 428.315765 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Metadata: 17:42:43 428.315796 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: title : 01:09:51.813 17:42:43 428.315826 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Chapter #0:8: start 4791.245000, end 5467.295000 17:42:43 428.315887 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Metadata: 17:42:43 428.315918 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: title : 01:19:51.245 17:42:43 428.315948 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Chapter #0:9: start 5467.295000, end 5637.131000 17:42:43 428.315979 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Metadata: 17:42:43 428.316010 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: title : 01:31:07.295 17:42:43 428.316040 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Chapter #0:10: start 5637.131000, end 6156.726000 17:42:43 428.316071 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Metadata: 17:42:43 428.316101 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: title : 01:33:57.131 17:42:43 428.316345 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: 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:42:43 428.316376 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Metadata: 17:42:43 428.316406 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: title : 300.Rise.Of.An.Empire.2014.3D.1080p.Bluray.HOU.X264.DL.GER.DTSD-zman 17:42:43 428.316437 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: stereo_mode : top_bottom 17:42:43 428.316467 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Side data: 17:42:43 428.316498 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: stereo3d: top and bottom 17:42:43 428.316589 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Stream #0:1(ger): Audio: dts (DTS), 48000 Hz, 5.1(side), fltp, 1536 kb/s (default) 17:42:43 428.316620 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Metadata: 17:42:43 428.316681 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: title : DTS Dubbed by Der Schuft, Center: Line THX @ TwixX 17:42:43 428.316742 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Stream #0:2(eng): Audio: dts (DTS), 48000 Hz, 5.1(side), fltp, 1536 kb/s 17:42:43 428.316803 T:140176349177600 INFO: ffmpeg[7F7D597FA700]: Stream #0:3(eng): Subtitle: dvd_subtitle, 1920x1080 (default) 17:42:43 428.316864 T:140176349177600 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0 17:42:43 428.316895 T:140176349177600 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1 17:42:43 428.316925 T:140176349177600 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 2 17:42:43 428.316925 T:140176349177600 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 3 17:42:43 428.317108 T:140176349177600 NOTICE: Opening stream: 0 source: 256 17:42:43 428.317200 T:140176349177600 NOTICE: Creating video codec with codec id: 28 17:42:43 428.317230 T:140176349177600 DEBUG: FactoryCodec - Video: - Opening 17:42:43 428.317261 T:140176349177600 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 17:42:43 428.317566 T:140176349177600 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264 17:42:43 428.317627 T:140176349177600 DEBUG: FactoryCodec - Video: ff-h264 - Opened 17:42:43 428.317627 T:140176349177600 DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 28 17:42:43 428.317688 T:140176349177600 NOTICE: Creating video thread 17:42:43 428.317780 T:140176349177600 NOTICE: Opening stream: 1 source: 256 17:42:43 428.317810 T:140176349177600 NOTICE: Finding audio codec for: 86020 17:42:43 428.317871 T:140176349177600 DEBUG: FactoryCodec - Audio: passthrough - Opening 17:42:43 428.317932 T:140176349177600 DEBUG: FactoryCodec - Audio: passthrough - Opened 17:42:43 428.317963 T:140176349177600 NOTICE: Creating audio thread 17:42:43 428.318024 T:140176349177600 NOTICE: Opening stream: 3 source: 256 17:42:43 428.318054 T:140176349177600 DEBUG: FactoryCodec - Overlay: FFmpeg Subtitle Decoder - Opening 17:42:43 428.318146 T:140176349177600 DEBUG: Open - parsed extradata: size: 1920 x 1080 17:42:43 428.318207 T:140176349177600 DEBUG: FactoryCodec - Overlay: FFmpeg Subtitle Decoder - Opened 17:42:43 428.318268 T:140176349177600 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:42:43 428.318481 T:140176349177600 DEBUG: OnPlayBackStarted: play state was 1, starting 1 17:42:43 428.318512 T:140176349177600 DEBUG: CVideoPlayer::SetCaching - caching state 2 17:42:43 428.318604 T:140176349177600 NOTICE: CDVDMessageQueue::GetLevel() - can't determine level 17:42:43 428.319244 T:140177224669248 NOTICE: Previous line repeats 8 times. 17:42:43 428.319336 T:140177224669248 DEBUG: PlayFile: OpenFile succeed, play state 2 17:42:43 428.319397 T:140177224669248 DEBUG: OnPlayBackStarted: play state was 2, starting 0 17:42:43 428.324646 T:140176340784896 DEBUG: Thread VideoPlayerAudio start, auto delete: false 17:42:43 428.324707 T:140176340784896 NOTICE: running thread: CVideoPlayerAudio::Process() 17:42:43 428.324738 T:140176340784896 DEBUG: CDVDAudio::Pause - pausing audio stream 17:42:43 428.324982 T:140176340784896 INFO: CAEStreamParser::SyncDTS - dts stream detected (6 channels, 48000Hz, 16bit BE, period: 512) 17:42:43 428.325012 T:140176340784896 NOTICE: Creating audio stream (codec id: 86020, channels: 6, sample rate: 48000, pass-through) 17:42:43 428.326965 T:140176340784896 DEBUG: CVideoPlayerAudio:: synctype set to 0: clock feedback 17:42:43 428.327454 T:140176357570304 DEBUG: Thread VideoPlayerVideo start, auto delete: false 17:42:43 428.327637 T:140176357570304 NOTICE: running thread: video_thread 17:42:43 428.327759 T:140176357570304 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 17:42:43 428.327850 T:140176357570304 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:43 428.328156 T:140176357570304 DEBUG: VAAPI - open decoder 17:42:43 428.339691 T:140176357570304 DEBUG: VAAPI - initialize version 0.39 17:42:43 428.339813 T:140176357570304 DEBUG: VAAPI - driver in use: Intel i965 driver for Intel(R) CherryView - 1.7.0 17:42:43 428.339905 T:140176357570304 DEBUG: VAAPI - attrib 0 (get/set) min -100 max 100 value 0x0 17:42:43 428.339935 T:140176357570304 DEBUG: VAAPI - attrib 1 (get/set) min 0 max 100 value 0x32 17:42:43 428.340027 T:140176357570304 DEBUG: VAAPI - attrib 2 (get/set) min -180 max 180 value 0x0 17:42:43 428.340057 T:140176357570304 DEBUG: VAAPI - attrib 3 (get/set) min 0 max 100 value 0x32 17:42:43 428.340118 T:140176357570304 DEBUG: VAAPI - attrib 6 (get/set) min 0 max 3 value 0x0 17:42:43 428.340240 T:140176357570304 DEBUG: VAAPI - profile 0 17:42:43 428.340271 T:140176357570304 DEBUG: VAAPI - profile 1 17:42:43 428.340302 T:140176357570304 DEBUG: VAAPI - profile 13 17:42:43 428.340363 T:140176357570304 DEBUG: VAAPI - profile 6 17:42:43 428.340393 T:140176357570304 DEBUG: VAAPI - profile 7 17:42:43 428.340424 T:140176357570304 DEBUG: VAAPI - profile 15 17:42:43 428.340485 T:140176357570304 DEBUG: VAAPI - profile 16 17:42:43 428.340515 T:140176357570304 DEBUG: VAAPI - profile 8 17:42:43 428.340546 T:140176357570304 DEBUG: VAAPI - profile 9 17:42:43 428.340607 T:140176357570304 DEBUG: VAAPI - profile 10 17:42:43 428.340637 T:140176357570304 DEBUG: VAAPI - profile -1 17:42:43 428.340668 T:140176357570304 DEBUG: VAAPI - profile 12 17:42:43 428.340729 T:140176357570304 DEBUG: VAAPI - profile 14 17:42:43 428.340759 T:140176357570304 DEBUG: VAAPI - profile 17 17:42:43 428.345215 T:140175837452032 DEBUG: Thread Vaapi-Output start, auto delete: false 17:42:43 428.345367 T:140175837452032 NOTICE: COutput::OnStartup: Output Thread created 17:42:43 428.358856 T:140175837452032 DEBUG: VAAPI::COutput::CreateEGLContext - created context 17:42:43 428.359161 T:140175837452032 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libsse4-x86_64-linux.so) 17:42:43 428.359436 T:140175837452032 DEBUG: Loading: /usr/lib/kodi/system/libsse4-x86_64-linux.so 17:42:43 428.366730 T:140176994285312 INFO: CActiveAESink::OpenSink - initialize sink 17:42:43 428.378052 T:140175837452032 DEBUG: VAAPI::COutput::InitBufferPool - Surfaces created 17:42:43 428.378265 T:140176357570304 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264-vaapi 17:42:43 428.383484 T:140175812273920 DEBUG: CGUIInfoManager::SetCurrentMovie(/storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv) 17:42:43 428.384674 T:140177224669248 DEBUG: StereoscopicsManager: autodetected stereo mode for movie mode top_bottom is: split_horizontal 17:42:43 428.384735 T:140177224669248 DEBUG: Previous line repeats 1 times. 17:42:43 428.384766 T:140177224669248 DEBUG: StereoscopicsManager: stereo mode setting changed to split_horizontal 17:42:43 428.384796 T:140177224669248 DEBUG: StereoscopicsManager::ApplyStereoMode: trying to apply stereo mode. Current: off | Target: split_horizontal 17:42:43 428.384796 T:140177224669248 DEBUG: StereoscopicsManager: stereo mode changed to split_horizontal 17:42:43 428.385040 T:140177224669248 DEBUG: ------ Window Init (DialogNotification.xml) ------ 17:42:43 428.389130 T:140175812273920 DEBUG: GetMovieId (/storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv), query = select idMovie from movie where idFile=9 17:42:43 428.389435 T:140175812273920 DEBUG: GetEpisodeId (/storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv), query = select idEpisode from episode where idFile=9 17:42:43 428.389679 T:140175812273920 DEBUG: GetMusicVideoId (/storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv), query = select idMVideo from musicvideo where idFile=9 17:42:43 428.390106 T:140177224660736 DEBUG: GetMovieId (/storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv), query = select idMovie from movie where idFile=9 17:42:43 428.390564 T:140177224660736 DEBUG: GetEpisodeId (/storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv), query = select idEpisode from episode where idFile=9 17:42:43 428.390869 T:140177224660736 DEBUG: GetMusicVideoId (/storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv), query = select idMVideo from musicvideo where idFile=9 17:42:43 428.391998 T:140177224660736 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 17:42:43 428.392059 T:140177224660736 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 17:42:43 428.394012 T:140176357570304 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:43 428.411987 T:140176357570304 DEBUG: Previous line repeats 3 times. 17:42:43 428.412048 T:140176357570304 DEBUG: CRenderManager::Configure - change configuration. 1920x1080. display: 960x1080. framerate: 23.98. format: VAAPI 17:42:43 428.424744 T:140177224669248 INFO: GL: Maximum texture width: 8192 17:42:43 428.453735 T:140177224669248 DEBUG: DeleteRenderer - deleting renderer 17:42:43 428.453766 T:140177224669248 DEBUG: LinuxRendererGL: Cleaning up GL resources 17:42:43 428.453857 T:140177224669248 DEBUG: Previous line repeats 1 times. 17:42:43 428.453888 T:140177224669248 DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16 17:42:43 428.453949 T:140177224669248 DEBUG: GL: Requested render method: 0 17:42:43 428.454132 T:140177224669248 DEBUG: GL: BaseYUV2RGBGLSLShader: defines: #define XBMC_DITHER #define XBMC_texture_rectangle 0 #define XBMC_texture_rectangle_hack 0 #define XBMC_STRETCH 0 #define XBMC_NV12_RRG 17:42:43 428.454315 T:140177224669248 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader 17:42:43 428.462891 T:140177224669248 DEBUG: GL: Vertex Shader compilation log: 17:42:43 428.462982 T:140177224669248 DEBUG: GL: Vertex Shader compiled successfully 17:42:43 428.465790 T:140177224669248 DEBUG: GL: Pixel Shader compilation log: 17:42:43 428.465851 T:140177224669248 DEBUG: GL: Fragment Shader compiled successfully 17:42:43 428.489105 T:140177224669248 DEBUG: GL: ConvolutionFilterShader: using convolution-4x4.glsl defines: #define HAS_FLOAT_TEXTURE 1 #define XBMC_STRETCH 0 #define XBMC_DITHER #define USE1DTEXTURE 1 17:42:43 428.491180 T:140177224669248 DEBUG: GL: Vertex Shader compilation log: 17:42:43 428.491241 T:140177224669248 DEBUG: GL: Vertex Shader compiled successfully 17:42:43 428.495667 T:140177224669248 DEBUG: GL: Pixel Shader compilation log: 17:42:43 428.495728 T:140177224669248 DEBUG: GL: Fragment Shader compiled successfully 17:42:43 428.507935 T:140176835725056 DEBUG: PushCecKeypress - received key b duration 273 17:42:43 428.546661 T:140177224669248 NOTICE: GL: NPOT texture support detected 17:42:43 428.546722 T:140177224669248 NOTICE: GL: Using GL_ARB_pixel_buffer_object 17:42:43 428.546722 T:140177224669248 NOTICE: Using GL_TEXTURE_2D 17:42:43 428.546753 T:140177224669248 DEBUG: CRenderManager::Configure - 4 17:42:43 428.552521 T:140177224669248 DEBUG: GL: Requested render method: 0 17:42:43 428.552734 T:140177224669248 DEBUG: GL: BaseYUV2RGBGLSLShader: defines: #define XBMC_texture_rectangle 0 #define XBMC_texture_rectangle_hack 0 #define XBMC_STRETCH 0 #define XBMC_NV12_RRG 17:42:43 428.552887 T:140177224669248 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader 17:42:43 428.554352 T:140177224669248 DEBUG: GL: Vertex Shader compilation log: 17:42:43 428.554382 T:140177224669248 DEBUG: GL: Vertex Shader compiled successfully 17:42:43 428.556427 T:140177224669248 DEBUG: GL: Pixel Shader compilation log: 17:42:43 428.556458 T:140177224669248 DEBUG: GL: Fragment Shader compiled successfully 17:42:43 428.557129 T:140176349177600 DEBUG: CVideoPlayer::HandleMessages - player started 2 17:42:43 428.567078 T:140176994285312 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0 17:42:43 428.567261 T:140176994285312 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0" 17:42:43 428.574554 T:140177224669248 NOTICE: GL: NPOT texture support detected 17:42:43 428.574615 T:140177224669248 NOTICE: GL: Using GL_ARB_pixel_buffer_object 17:42:43 428.583252 T:140176994285312 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x06,AES1=0x82,AES2=0x00,AES3=0x02" 17:42:43 428.583923 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2400, bufferSize 9600 17:42:43 428.590302 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2400, bufferSize 9600 17:42:43 428.590454 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms 17:42:43 428.591431 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 17:42:43 428.591492 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: RAW,RAW 17:42:43 428.591553 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: RAW,RAW (ALSA: none) 17:42:43 428.591583 T:140176994285312 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 17:42:43 428.591644 T:140176994285312 DEBUG: Output Device : HDA Intel PCH 17:42:43 428.591705 T:140176994285312 DEBUG: Sample Rate : 48000 17:42:43 428.591736 T:140176994285312 DEBUG: Sample Format : AE_FMT_S16NE 17:42:43 428.591797 T:140176994285312 DEBUG: Channel Count : 2 17:42:43 428.591827 T:140176994285312 DEBUG: Channel Layout: RAW,RAW 17:42:43 428.591888 T:140176994285312 DEBUG: Frames : 2400 17:42:43 428.591949 T:140176994285312 DEBUG: Frame Size : 4 17:42:43 428.607574 T:140177205733120 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 17:42:43 428.615997 T:140176349177600 DEBUG: Previous line repeats 1 times. 17:42:43 428.616058 T:140176349177600 DEBUG: CVideoPlayer::HandleMessages - player started 1 17:42:43 428.616089 T:140176349177600 DEBUG: CVideoPlayer::SetCaching - caching state 3 17:42:43 428.616180 T:140176349177600 DEBUG: CVideoPlayer::SetCaching - caching state 0 17:42:43 428.616241 T:140176349177600 DEBUG: VideoPlayer::Sync - Audio - pts: 116000.000000, cache: 309471.426449, totalcache: 600000.023842 17:42:43 428.616272 T:140176349177600 DEBUG: VideoPlayer::Sync - Video - pts: 0.000000, cache: 50000.000000, totalcache: 100000.000000 17:42:43 428.616394 T:140176357570304 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(-193471.426449) 17:42:43 428.616455 T:140176357570304 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:43 428.626312 T:140176340784896 DEBUG: Previous line repeats 1 times. 17:42:43 428.626404 T:140176340784896 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(-193471.426449) 17:42:43 428.626434 T:140176340784896 DEBUG: CDVDAudio::Resume - resume audio stream 17:42:43 428.629700 T:140177205733120 DEBUG: ActiveAE - start sync of audio stream 17:42:43 428.677704 T:140177224669248 DEBUG: Activating window ID: 12005 17:42:43 428.678253 T:140177224669248 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 17:42:43 428.678925 T:140177224669248 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 17:42:43 428.678986 T:140177224669248 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY 17:42:43 428.689575 T:140177224669248 NOTICE: Display resolution ADJUST : HDMI2: 1920x1080 @ 23.98Hz (24) (weight: 0.000) 17:42:43 428.689636 T:140177224669248 NOTICE: CWinSystemX11::SetFullScreen - calling xrandr 17:42:43 428.689758 T:140177224669248 DEBUG: OnLostDevice - notify display change event 17:42:43 428.689789 T:140177224669248 DEBUG: Flush - flushing renderer 17:42:44 428.902100 T:140177224669248 NOTICE: VideoPlayer: OnLostDisplay received 17:42:44 428.902344 T:140177224669248 INFO: XRANDR: /usr/lib/kodi/kodi-xrandr --screen 0 --output HDMI2 --mode 0x10b 17:42:44 429.146484 T:140176357570304 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: 1 17:42:44 429.182831 T:140177216268032 DEBUG: CALSAHControlMonitor - Monitored ALSA hctl value changed 17:42:44 429.269775 T:140176940537600 DEBUG: GetMappingForDevice - device (2548:1002) mapped to Pulse-Eight CEC Adapter (type = cec) 17:42:44 429.370941 T:140177216268032 DEBUG: CALSAHControlMonitor - Monitored ALSA hctl value changed 17:42:44 429.379486 T:140176940537600 DEBUG: GetMappingForDevice - device (2548:1002) mapped to Pulse-Eight CEC Adapter (type = cec) 17:42:44 429.423462 T:140177224669248 INFO: GL: Maximum texture width: 8192 17:42:44 429.429474 T:140177224669248 DEBUG: GL: Requested render method: 0 17:42:44 429.430359 T:140177224669248 DEBUG: GL: BaseYUV2RGBGLSLShader: defines: #define XBMC_texture_rectangle 0 #define XBMC_texture_rectangle_hack 0 #define XBMC_STRETCH 0 #define XBMC_NV12_RRG 17:42:44 429.430939 T:140177224669248 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader 17:42:44 429.435577 T:140177224669248 DEBUG: GL: Vertex Shader compilation log: 17:42:44 429.435669 T:140177224669248 DEBUG: GL: Vertex Shader compiled successfully 17:42:44 429.441162 T:140177224669248 DEBUG: GL: Pixel Shader compilation log: 17:42:44 429.441254 T:140177224669248 DEBUG: GL: Fragment Shader compiled successfully 17:42:44 429.465424 T:140177224669248 DEBUG: GL: ConvolutionFilterShader: using convolution-4x4.glsl defines: #define HAS_FLOAT_TEXTURE 1 #define XBMC_STRETCH 0 #define XBMC_DITHER #define USE1DTEXTURE 1 17:42:44 429.466919 T:140177224669248 DEBUG: GL: Vertex Shader compilation log: 17:42:44 429.466949 T:140177224669248 DEBUG: GL: Vertex Shader compiled successfully 17:42:44 429.471497 T:140177224669248 DEBUG: GL: Pixel Shader compilation log: 17:42:44 429.471588 T:140177224669248 DEBUG: GL: Fragment Shader compiled successfully 17:42:44 429.522278 T:140177224669248 NOTICE: GL: NPOT texture support detected 17:42:44 429.522339 T:140177224669248 NOTICE: GL: Using GL_ARB_pixel_buffer_object 17:42:44 429.522369 T:140177224669248 NOTICE: Using GL_TEXTURE_2D 17:42:44 429.527893 T:140177224669248 DEBUG: NotifyXRREvent - notify display reset event 17:42:44 429.547241 T:140177224669248 DEBUG: RecreateWindow - current output: HDMI2, mode: 0x10b, refresh: 23.976 17:42:44 429.547333 T:140177224669248 DEBUG: OnLostDevice - notify display change event 17:42:44 429.547363 T:140177224669248 DEBUG: Flush - flushing renderer 17:42:44 429.548462 T:140177224669248 NOTICE: VideoPlayer: OnLostDisplay received 17:42:44 429.548981 T:140176357570304 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: 1 17:42:44 429.554382 T:140177224669248 DEBUG: Window Manager Name: Fluxbox 17:42:44 429.581604 T:140177224669248 DEBUG: CWinSystemX11::RefreshEGLContext: refreshing context 17:42:44 429.583557 T:140177224669248 NOTICE: VideoPlayer: OnResetDisplay received 17:42:44 429.583618 T:140177224669248 INFO: GL: Maximum texture width: 8192 17:42:44 429.583923 T:140176357570304 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: 0 17:42:44 429.584137 T:140176357570304 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:42:44 429.586426 T:140177224669248 DEBUG: Previous line repeats 1 times. 17:42:44 429.586487 T:140177224669248 DEBUG: GL: Requested render method: 0 17:42:44 429.586578 T:140177205733120 DEBUG: CActiveAE - display reset event 17:42:44 429.586823 T:140177224669248 DEBUG: GL: BaseYUV2RGBGLSLShader: defines: #define XBMC_texture_rectangle 0 #define XBMC_texture_rectangle_hack 0 #define XBMC_STRETCH 0 #define XBMC_NV12_RRG 17:42:44 429.587006 T:140177224669248 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader 17:42:44 429.587158 T:140176994285312 INFO: CActiveAESink::OpenSink - initialize sink 17:42:44 429.587372 T:140176994285312 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0 17:42:44 429.587494 T:140176994285312 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0" 17:42:44 429.588776 T:140177224669248 DEBUG: GL: Vertex Shader compilation log: 17:42:44 429.588806 T:140177224669248 DEBUG: GL: Vertex Shader compiled successfully 17:42:44 429.590973 T:140177224669248 DEBUG: GL: Pixel Shader compilation log: 17:42:44 429.591034 T:140177224669248 DEBUG: GL: Fragment Shader compiled successfully 17:42:44 429.602783 T:140176994285312 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x06,AES1=0x82,AES2=0x00,AES3=0x02" 17:42:44 429.603577 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2400, bufferSize 9600 17:42:44 429.610107 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2400, bufferSize 9600 17:42:44 429.610168 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms 17:42:44 429.611084 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 17:42:44 429.611115 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: RAW,RAW 17:42:44 429.611176 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: RAW,RAW (ALSA: none) 17:42:44 429.611206 T:140176994285312 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 17:42:44 429.611237 T:140176994285312 DEBUG: Output Device : HDA Intel PCH 17:42:44 429.611267 T:140176994285312 DEBUG: Sample Rate : 48000 17:42:44 429.611298 T:140176994285312 DEBUG: Sample Format : AE_FMT_S16NE 17:42:44 429.611328 T:140176994285312 DEBUG: Channel Count : 2 17:42:44 429.611359 T:140176994285312 DEBUG: Channel Layout: RAW,RAW 17:42:44 429.611389 T:140176994285312 DEBUG: Frames : 2400 17:42:44 429.611450 T:140176994285312 DEBUG: Frame Size : 4 17:42:44 429.611786 T:140177224669248 DEBUG: GL: ConvolutionFilterShader: using convolution-4x4.glsl defines: #define HAS_FLOAT_TEXTURE 1 #define XBMC_STRETCH 0 #define XBMC_DITHER #define USE1DTEXTURE 1 17:42:44 429.613373 T:140177224669248 DEBUG: GL: Vertex Shader compilation log: 17:42:44 429.613434 T:140177224669248 DEBUG: GL: Vertex Shader compiled successfully 17:42:44 429.618103 T:140177205733120 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 17:42:44 429.618195 T:140177224669248 DEBUG: GL: Pixel Shader compilation log: 17:42:44 429.618256 T:140177224669248 DEBUG: GL: Fragment Shader compiled successfully 17:42:44 429.619293 T:140177205733120 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 17:42:44 429.619537 T:140176340784896 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_PAUSE: 1 17:42:44 429.619598 T:140176340784896 DEBUG: Previous line repeats 1 times. 17:42:44 429.619598 T:140176340784896 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_PAUSE: 0 17:42:44 429.619659 T:140177205733120 DEBUG: ActiveAE::SyncStream - average error of 31.621691, start adjusting 17:42:44 429.619720 T:140177205733120 DEBUG: ActiveAE::SyncStream - average error 21.621691 below threshold of 30.000000 17:42:44 429.672821 T:140177224669248 NOTICE: GL: NPOT texture support detected 17:42:44 429.672943 T:140177224669248 NOTICE: GL: Using GL_ARB_pixel_buffer_object 17:42:44 429.672974 T:140177224669248 NOTICE: Using GL_TEXTURE_2D 17:42:44 429.673248 T:140176357570304 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1 17:42:44 429.679657 T:140177224669248 DEBUG: Previous line repeats 2 times. 17:42:44 429.679718 T:140177224669248 INFO: GL: Enabling VSYNC 17:42:44 429.679749 T:140177224669248 ERROR: GL: Vertical Blank Syncing unsupported 17:42:44 429.700897 T:140177224669248 DEBUG: GL: Requested render method: 0 17:42:44 429.702179 T:140177224669248 DEBUG: GL: BaseYUV2RGBGLSLShader: defines: #define XBMC_texture_rectangle 0 #define XBMC_texture_rectangle_hack 0 #define XBMC_STRETCH 0 #define XBMC_NV12_RRG 17:42:44 429.702545 T:140177224669248 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader 17:42:44 429.705536 T:140177224669248 DEBUG: GL: Vertex Shader compilation log: 17:42:44 429.705597 T:140177224669248 DEBUG: GL: Vertex Shader compiled successfully 17:42:44 429.710297 T:140177224669248 DEBUG: GL: Pixel Shader compilation log: 17:42:44 429.710358 T:140177224669248 DEBUG: GL: Fragment Shader compiled successfully 17:42:44 429.732727 T:140177224669248 NOTICE: GL: NPOT texture support detected 17:42:44 429.732788 T:140177224669248 NOTICE: GL: Using GL_ARB_pixel_buffer_object 17:42:45 429.746460 T:140176357570304 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1 17:42:45 430.620972 T:140177205733120 DEBUG: Previous line repeats 5 times. 17:42:45 430.621094 T:140177205733120 DEBUG: ActiveAE::SyncStream - average error 321.125713 above threshold of 100.000000 17:42:46 430.919556 T:140177205733120 DEBUG: ActiveAE::SyncStream - average error 21.125713, last average error: 321.125713 17:42:46 431.019257 T:140177205733120 DEBUG: ActiveAE::SyncStream - average error of 11.387206, start adjusting 17:42:46 431.019348 T:140177205733120 DEBUG: ActiveAE::SyncStream - average error 1.387206 below threshold of 30.000000 17:42:49 434.014313 T:140177224669248 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 17:42:49 434.264496 T:140176357570304 DEBUG: CPullupCorrection: detected pattern of length 1: 41708.33, frameduration: 41708.333333 17:42:57 441.785431 T:140176835725056 DEBUG: PushCecKeypress - received key e0 duration 1001 17:42:57 441.808319 T:140177224669248 DEBUG: OnKey: guide (0xe0) pressed, action is Stop 17:42:57 441.808533 T:140177224669248 NOTICE: CVideoPlayer::CloseFile() 17:42:57 441.808594 T:140177224669248 NOTICE: VideoPlayer: waiting for threads to exit 17:42:57 441.810333 T:140176349177600 NOTICE: CVideoPlayer::OnExit() 17:42:57 441.810577 T:140176349177600 NOTICE: Closing stream player 1 17:42:57 441.810669 T:140176349177600 NOTICE: Waiting for audio thread to exit 17:42:57 441.820526 T:140176340784896 NOTICE: thread end: CVideoPlayerAudio::OnExit() 17:42:57 441.820740 T:140176340784896 DEBUG: Thread VideoPlayerAudio 140176340784896 terminating 17:42:57 441.821198 T:140176349177600 NOTICE: Closing audio device 17:42:57 441.870483 T:140176349177600 DEBUG: CDVDAudio::Flush - flush audio stream 17:42:57 441.870728 T:140177205733120 DEBUG: CActiveAE::DiscardStream - audio stream deleted 17:42:57 441.871124 T:140177205733120 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 17:42:57 441.871826 T:140176994285312 DEBUG: Previous line repeats 1 times. 17:42:57 441.871918 T:140176994285312 INFO: CActiveAESink::OpenSink - initialize sink 17:42:57 441.873810 T:140176349177600 NOTICE: Deleting audio codec 17:42:57 441.874573 T:140176349177600 NOTICE: Closing stream player 2 17:42:57 441.874695 T:140176349177600 NOTICE: waiting for video thread to exit 17:42:57 441.906311 T:140176357570304 NOTICE: thread end: video_thread 17:42:57 441.906525 T:140176357570304 DEBUG: Thread VideoPlayerVideo 140176357570304 terminating 17:42:57 441.907623 T:140176349177600 NOTICE: deleting video codec 17:42:57 441.908295 T:140176349177600 DEBUG: VAAPI::Release pre-cleanup 17:42:57 441.921387 T:140176349177600 NOTICE: Closing stream player 3 17:42:57 441.921936 T:140176349177600 DEBUG: OnPlayBackStopped: play state was 2, starting 0 17:42:57 441.930054 T:140176349177600 DEBUG: Thread VideoPlayer 140176349177600 terminating 17:42:57 441.930328 T:140177224669248 NOTICE: VideoPlayer: finished waiting 17:42:57 441.930511 T:140177224669248 DEBUG: DeleteRenderer - deleting renderer 17:42:57 441.930664 T:140177224669248 NOTICE: VAAPI::Close 17:42:57 441.931763 T:140175837452032 NOTICE: COutput::OnExit: Output Thread terminated 17:42:57 441.931885 T:140175837452032 DEBUG: Thread Vaapi-Output 140175837452032 terminating 17:42:57 441.932068 T:140177224669248 DEBUG: VAAPI::FiniVAAPIOutput destroying 5 video surfaces 17:42:57 441.932739 T:140177224660736 DEBUG: GetMovieId (/storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv), query = select idMovie from movie where idFile=9 17:42:57 441.933990 T:140177224660736 DEBUG: GetEpisodeId (/storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv), query = select idEpisode from episode where idFile=9 17:42:57 441.935272 T:140177224660736 DEBUG: GetMusicVideoId (/storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv), query = select idMVideo from musicvideo where idFile=9 17:42:57 441.936890 T:140177224669248 NOTICE: VAAPI::Close - closing decoder context 17:42:57 441.940002 T:140177224660736 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 17:42:57 441.940247 T:140177224660736 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 17:42:57 441.941772 T:140177224669248 DEBUG: LinuxRendererGL: Cleaning up GL resources 17:42:57 441.941864 T:140177224669248 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 17:42:57 441.941925 T:140177224669248 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 17:42:57 441.948608 T:140177224669248 NOTICE: CWinSystemX11::SetFullScreen - calling xrandr 17:42:57 441.948822 T:140177224669248 DEBUG: OnLostDevice - notify display change event 17:42:57 442.071808 T:140176994285312 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0 17:42:57 442.071991 T:140176994285312 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0" 17:42:57 442.088562 T:140176994285312 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00" 17:42:57 442.089600 T:140176994285312 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 17:42:57 442.089691 T:140176994285312 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 17:42:57 442.089722 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2205, bufferSize 8820 17:42:57 442.097076 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2205, bufferSize 8820 17:42:57 442.097168 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms 17:42:57 442.098694 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 17:42:57 442.098755 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR 17:42:57 442.098816 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR) 17:42:57 442.098877 T:140176994285312 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 17:42:57 442.098938 T:140176994285312 DEBUG: Output Device : HDA Intel PCH 17:42:57 442.098969 T:140176994285312 DEBUG: Sample Rate : 44100 17:42:57 442.099030 T:140176994285312 DEBUG: Sample Format : AE_FMT_S32NE 17:42:57 442.099091 T:140176994285312 DEBUG: Channel Count : 2 17:42:57 442.099152 T:140176994285312 DEBUG: Channel Layout: FL,FR 17:42:57 442.099213 T:140176994285312 DEBUG: Frames : 2205 17:42:57 442.100220 T:140176994285312 DEBUG: Frame Size : 8 17:42:57 442.104980 T:140177205733120 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 17:42:57 442.106750 T:140177224669248 DEBUG: Previous line repeats 1 times. 17:42:57 442.106812 T:140177224669248 NOTICE: VideoPlayer: OnLostDisplay received 17:42:57 442.106873 T:140177224669248 WARNING: CDVDMessageQueue(audio)::Put MSGQ_NOT_INITIALIZED 17:42:57 442.106934 T:140177224669248 WARNING: CDVDMessageQueue(video)::Put MSGQ_NOT_INITIALIZED 17:42:57 442.107056 T:140177224669248 INFO: XRANDR: /usr/lib/kodi/kodi-xrandr --screen 0 --output HDMI2 --mode 0x49 17:42:57 442.173096 T:140177216268032 DEBUG: CALSAHControlMonitor - Monitored ALSA hctl value changed 17:42:57 442.462341 T:140177224669248 DEBUG: Previous line repeats 1 times. 17:42:57 442.462494 T:140177224669248 INFO: GL: Maximum texture width: 8192 17:42:57 442.468109 T:140177224669248 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 17:42:57 442.477600 T:140177224669248 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 17:42:57 442.480255 T:140177224669248 DEBUG: CGUIMediaWindow::GetDirectory (/storage/mediathek/Videos/HD/3D/) 17:42:57 442.480316 T:140177224669248 DEBUG: ParentPath = [/storage/mediathek/Videos/HD/3D/] 17:42:57 442.557739 T:140177224669248 DEBUG: RunQuery took 1 ms for 59 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=2 17:42:57 442.564728 T:140175837452032 DEBUG: Thread BackgroundLoader start, auto delete: false 17:42:57 442.579590 T:140175812273920 DEBUG: GetImageHash - unable to stat url 17:42:57 442.626953 T:140177224669248 NOTICE: CVideoPlayer::CloseFile() 17:42:57 442.627014 T:140177224669248 NOTICE: VideoPlayer: waiting for threads to exit 17:42:57 442.627045 T:140177224669248 NOTICE: VideoPlayer: finished waiting 17:42:57 442.627075 T:140177224669248 NOTICE: CVideoPlayer::CloseFile() 17:42:57 442.627106 T:140177224669248 NOTICE: VideoPlayer: waiting for threads to exit 17:42:57 442.627136 T:140177224669248 NOTICE: VideoPlayer: finished waiting 17:42:57 442.630798 T:140177224669248 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 17:42:57 442.631195 T:140177224669248 DEBUG: StereoscopicsManager: stereo mode setting changed to off 17:42:57 442.631226 T:140177224669248 DEBUG: StereoscopicsManager::ApplyStereoMode: trying to apply stereo mode. Current: split_horizontal | Target: off 17:42:57 442.631287 T:140177224669248 DEBUG: StereoscopicsManager: stereo mode changed to off 17:42:57 442.631592 T:140175812273920 DEBUG: DoWork - Saving file state for video item /storage/mediathek/Videos/HD/3D/300 Rise of an Empire (2014).mkv 17:42:57 442.636627 T:140177224669248 DEBUG: ------ Window Init (DialogNotification.xml) ------ 17:42:57 442.636841 T:140177224669248 DEBUG: NotifyXRREvent - notify display reset event 17:42:57 442.661987 T:140177224669248 DEBUG: RecreateWindow - current output: HDMI2, mode: 0x49, refresh: 50.000 17:42:57 442.662079 T:140177224669248 DEBUG: OnLostDevice - notify display change event 17:42:57 442.666107 T:140177224669248 DEBUG: Window Manager Name: Fluxbox 17:42:57 442.675690 T:140177224669248 DEBUG: CWinSystemX11::RefreshEGLContext: refreshing context 17:42:57 442.677582 T:140177224669248 DEBUG: OnLostDevice - notify display change event 17:42:57 442.684906 T:140177224669248 DEBUG: Window Manager Name: Fluxbox 17:42:57 442.700409 T:140177224669248 DEBUG: CWinSystemX11::RefreshEGLContext: refreshing context 17:42:57 442.701233 T:140177205733120 DEBUG: CActiveAE - display reset event 17:42:57 442.701385 T:140177224669248 INFO: GL: Maximum texture width: 8192 17:42:57 442.701660 T:140176994285312 INFO: CActiveAESink::OpenSink - initialize sink 17:42:57 442.701752 T:140176994285312 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0 17:42:57 442.701782 T:140176994285312 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0" 17:42:57 442.706726 T:140176994285312 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00" 17:42:57 442.708496 T:140176994285312 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 17:42:57 442.709351 T:140176994285312 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 17:42:57 442.709381 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2205, bufferSize 8820 17:42:57 442.717255 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2205, bufferSize 8820 17:42:57 442.717346 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms 17:42:57 442.718323 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 17:42:57 442.718353 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR 17:42:57 442.718353 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR) 17:42:57 442.718384 T:140176994285312 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 17:42:57 442.718414 T:140176994285312 DEBUG: Output Device : HDA Intel PCH 17:42:57 442.718445 T:140176994285312 DEBUG: Sample Rate : 44100 17:42:57 442.718445 T:140176994285312 DEBUG: Sample Format : AE_FMT_S32NE 17:42:57 442.718475 T:140176994285312 DEBUG: Channel Count : 2 17:42:57 442.718506 T:140176994285312 DEBUG: Channel Layout: FL,FR 17:42:57 442.718506 T:140176994285312 DEBUG: Frames : 2205 17:42:57 442.718536 T:140176994285312 DEBUG: Frame Size : 8 17:42:57 442.720612 T:140177205733120 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 17:42:57 442.732819 T:140177224669248 INFO: GL: Maximum texture width: 8192 17:42:58 442.784180 T:140177224669248 INFO: GL: Enabling VSYNC 17:42:58 442.784241 T:140177224669248 ERROR: GL: Vertical Blank Syncing unsupported 17:42:58 442.784637 T:140175837452032 DEBUG: Thread BackgroundLoader 140175837452032 terminating 17:42:58 442.791138 T:140175812273920 DEBUG: GetImageHash - unable to stat url 17:43:03 448.034363 T:140176835725056 DEBUG: PushCecKeypress - received key a7 duration 0 17:43:03 448.047119 T:140177224669248 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:43:03 448.364319 T:140176835725056 DEBUG: PushCecKeypress - received key a7 duration 330 17:43:03 448.462372 T:140177224669248 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 17:43:03 448.533997 T:140176835725056 DEBUG: PushCecKeypress - received key a7 duration 0 17:43:03 448.564789 T:140177224669248 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:43:04 448.811462 T:140176835725056 DEBUG: PushCecKeypress - received key a7 duration 278 17:43:04 449.036560 T:140176835725056 DEBUG: PushCecKeypress - received key a7 duration 0 17:43:04 449.045258 T:140177224669248 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 17:43:04 449.260376 T:140176835725056 DEBUG: PushCecKeypress - received key a7 duration 224 17:43:05 450.488708 T:140176835725056 DEBUG: PushCecKeypress - received key b duration 0 17:43:05 450.509888 T:140177224669248 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:43:05 450.527832 T:140177224669248 DEBUG: OnPlayMedia /storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv 17:43:05 450.528717 T:140177224660736 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 17:43:05 450.528992 T:140177224660736 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 17:43:05 450.545746 T:140177224669248 DEBUG: Loading settings for /storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv 17:43:05 450.552063 T:140177224660736 DEBUG: GetMovieId (/storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv), query = select idMovie from movie where idFile=10 17:43:05 450.552765 T:140177224660736 DEBUG: GetEpisodeId (/storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv), query = select idEpisode from episode where idFile=10 17:43:05 450.553192 T:140177224660736 DEBUG: GetMusicVideoId (/storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv), query = select idMVideo from musicvideo where idFile=10 17:43:05 450.554138 T:140177224669248 DEBUG: CPlayerCoreFactory::GetPlayers(/storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv) 17:43:05 450.554199 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 17:43:05 450.554230 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 17:43:05 450.554260 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 17:43:05 450.554321 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 17:43:05 450.554352 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 17:43:05 450.554382 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 17:43:05 450.554443 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 17:43:05 450.554474 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 17:43:05 450.554504 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 17:43:05 450.554535 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 17:43:05 450.554565 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 17:43:05 450.554596 T:140177224669248 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 17:43:05 450.554626 T:140177224669248 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 17:43:05 450.554657 T:140177224669248 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 17:43:05 450.554688 T:140177224669248 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 17:43:05 450.554718 T:140177224669248 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 17:43:05 450.554749 T:140177224669248 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 17:43:05 450.554779 T:140177224660736 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 17:43:05 450.554871 T:140177224660736 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 17:43:05 450.557770 T:140177224669248 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 17:43:05 450.557861 T:140177224669248 NOTICE: VideoPlayer: Opening: /storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv 17:43:05 450.557922 T:140177224669248 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 17:43:05 450.558014 T:140177224669248 DEBUG: LinuxRendererGL: Cleaning up GL resources 17:43:05 450.558075 T:140177224669248 DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16 17:43:05 450.558441 T:140175837452032 DEBUG: Thread VideoPlayer start, auto delete: false 17:43:05 450.558624 T:140175837452032 NOTICE: Creating InputStream 17:43:05 450.568085 T:140175837452032 DEBUG: ScanForExternalSubtitles: Searching for subtitles... 17:43:05 450.571320 T:140175837452032 DEBUG: ScanForExternalSubtitles: END (total time: 4 ms) 17:43:05 450.571411 T:140175837452032 NOTICE: Creating Demuxer 17:43:05 450.597778 T:140175837452032 DEBUG: Open - probing detected format [matroska,webm] 17:43:05 450.599487 T:140175837452032 DEBUG: Open - avformat_find_stream_info starting 17:43:05 450.624664 T:140175837452032 DEBUG: Open - av_find_stream_info finished 17:43:05 450.624786 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Input #0, matroska,webm, /storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mk': 17:43:05 450.624847 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.624878 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: encoder : libebml v1.2.3 + libmatroska v1.3.0 17:43:05 450.624939 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: creation_time : 2013-05-14 22:08:35 17:43:05 450.625183 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Duration: 01:21:00.02, start: 0.000000, bitrate: 12576 kb/s 17:43:05 450.625244 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Chapter #0:0: start 0.000000, end 365.824000 17:43:05 450.625275 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.625336 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: title : 00:00:00.000 17:43:05 450.625397 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Chapter #0:1: start 365.824000, end 683.892000 17:43:05 450.625427 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.625458 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: title : 00:06:05.824 17:43:05 450.625519 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Chapter #0:2: start 683.892000, end 849.432000 17:43:05 450.625580 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.625641 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: title : 00:11:23.892 17:43:05 450.625671 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Chapter #0:3: start 849.432000, end 1228.769000 17:43:05 450.625732 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.625763 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: title : 00:14:09.432 17:43:05 450.625824 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Chapter #0:4: start 1228.769000, end 1586.126000 17:43:05 450.625854 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.625916 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: title : 00:20:28.769 17:43:05 450.625977 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Chapter #0:5: start 1586.126000, end 2021.728000 17:43:05 450.626221 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.626282 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: title : 00:26:26.126 17:43:05 450.626343 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Chapter #0:6: start 2021.728000, end 2324.155000 17:43:05 450.626373 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.626434 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: title : 00:33:41.728 17:43:05 450.626465 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Chapter #0:7: start 2324.155000, end 2563.770000 17:43:05 450.626526 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.626556 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: title : 00:38:44.155 17:43:05 450.626678 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Chapter #0:8: start 2563.770000, end 2754.961000 17:43:05 450.626709 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.626770 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: title : 00:42:43.770 17:43:05 450.626923 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Chapter #0:9: start 2754.961000, end 2982.354000 17:43:05 450.626953 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.627014 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: title : 00:45:54.961 17:43:05 450.627045 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Chapter #0:10: start 2982.354000, end 3241.989000 17:43:05 450.627106 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.627136 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: title : 00:49:42.354 17:43:05 450.627197 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Chapter #0:11: start 3241.989000, end 3642.305000 17:43:05 450.627228 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.627289 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: title : 00:54:01.989 17:43:05 450.627350 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Chapter #0:12: start 3642.305000, end 3926.339000 17:43:05 450.627380 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.627441 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: title : 01:00:42.305 17:43:05 450.627502 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Chapter #0:13: start 3926.339000, end 4218.881000 17:43:05 450.627533 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.627563 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: title : 01:05:26.339 17:43:05 450.627625 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Chapter #0:14: start 4218.881000, end 4340.920000 17:43:05 450.627686 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.627716 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: title : 01:10:18.881 17:43:05 450.627808 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Chapter #0:15: start 4340.920000, end 4860.022000 17:43:05 450.627869 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.627930 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: title : 01:12:20.920 17:43:05 450.628021 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: 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:43:05 450.628052 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.628082 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: stereo_mode : left_right 17:43:05 450.628113 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Side data: 17:43:05 450.628143 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: stereo3d: side by side 17:43:05 450.628204 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Stream #0:1(ger): Audio: dts (DTS), 48000 Hz, 5.1(side), fltp, 1536 kb/s (default) 17:43:05 450.628235 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.628265 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: title : DTS 17:43:05 450.628326 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Stream #0:2(eng): Audio: dts (DTS), 48000 Hz, 5.1(side), fltp, 1536 kb/s 17:43:05 450.628357 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: Metadata: 17:43:05 450.628387 T:140175837452032 INFO: ffmpeg[7F7D3AFF5700]: title : DTS 17:43:05 450.628418 T:140175837452032 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0 17:43:05 450.628448 T:140175837452032 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1 17:43:05 450.628479 T:140175837452032 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 2 17:43:05 450.628601 T:140175837452032 NOTICE: Opening stream: 0 source: 256 17:43:05 450.628662 T:140175837452032 NOTICE: Creating video codec with codec id: 28 17:43:05 450.628693 T:140175837452032 DEBUG: FactoryCodec - Video: - Opening 17:43:05 450.628723 T:140175837452032 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 17:43:05 450.629089 T:140175837452032 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264 17:43:05 450.629120 T:140175837452032 DEBUG: FactoryCodec - Video: ff-h264 - Opened 17:43:05 450.629150 T:140175837452032 DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 28 17:43:05 450.629181 T:140175837452032 NOTICE: Creating video thread 17:43:05 450.629303 T:140175837452032 NOTICE: Opening stream: 1 source: 256 17:43:05 450.629333 T:140175837452032 NOTICE: Finding audio codec for: 86020 17:43:05 450.629395 T:140175837452032 DEBUG: FactoryCodec - Audio: passthrough - Opening 17:43:05 450.629456 T:140175837452032 DEBUG: FactoryCodec - Audio: passthrough - Opened 17:43:05 450.629486 T:140175837452032 NOTICE: Creating audio thread 17:43:05 450.629578 T:140176349177600 DEBUG: Thread VideoPlayerVideo start, auto delete: false 17:43:05 450.629700 T:140175837452032 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:43:05 450.629913 T:140176357570304 DEBUG: Thread VideoPlayerAudio start, auto delete: false 17:43:05 450.630005 T:140176349177600 NOTICE: running thread: video_thread 17:43:05 450.630127 T:140175837452032 DEBUG: OnPlayBackStarted: play state was 1, starting 1 17:43:05 450.630219 T:140176357570304 NOTICE: running thread: CVideoPlayerAudio::Process() 17:43:05 450.630249 T:140175837452032 DEBUG: CVideoPlayer::SetCaching - caching state 2 17:43:05 450.630402 T:140177224669248 DEBUG: PlayFile: OpenFile succeed, play state 2 17:43:05 450.630463 T:140175837452032 NOTICE: CDVDMessageQueue::GetLevel() - can't determine level 17:43:05 450.630615 T:140176349177600 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 17:43:05 450.630829 T:140177224669248 DEBUG: OnPlayBackStarted: play state was 2, starting 0 17:43:05 450.632935 T:140175837452032 NOTICE: CDVDMessageQueue::GetLevel() - can't determine level 17:43:05 450.633331 T:140176349177600 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:43:05 450.633606 T:140176349177600 DEBUG: VAAPI - open decoder 17:43:05 450.633728 T:140175837452032 NOTICE: CDVDMessageQueue::GetLevel() - can't determine level 17:43:05 450.633850 T:140176357570304 DEBUG: CDVDAudio::Pause - pausing audio stream 17:43:05 450.633911 T:140175837452032 NOTICE: CDVDMessageQueue::GetLevel() - can't determine level 17:43:05 450.634125 T:140176357570304 NOTICE: Previous line repeats 6 times. 17:43:05 450.634155 T:140176357570304 INFO: CAEStreamParser::SyncDTS - dts stream detected (6 channels, 48000Hz, 16bit BE, period: 512) 17:43:05 450.634247 T:140176357570304 NOTICE: Creating audio stream (codec id: 86020, channels: 6, sample rate: 48000, pass-through) 17:43:05 450.634705 T:140176357570304 DEBUG: CVideoPlayerAudio:: synctype set to 0: clock feedback 17:43:05 450.641235 T:140176349177600 DEBUG: VAAPI - initialize version 0.39 17:43:05 450.641357 T:140176349177600 DEBUG: VAAPI - driver in use: Intel i965 driver for Intel(R) CherryView - 1.7.0 17:43:05 450.641418 T:140176349177600 DEBUG: VAAPI - attrib 0 (get/set) min -100 max 100 value 0x0 17:43:05 450.641479 T:140176349177600 DEBUG: VAAPI - attrib 1 (get/set) min 0 max 100 value 0x32 17:43:05 450.641541 T:140176349177600 DEBUG: VAAPI - attrib 2 (get/set) min -180 max 180 value 0x0 17:43:05 450.641602 T:140176349177600 DEBUG: VAAPI - attrib 3 (get/set) min 0 max 100 value 0x32 17:43:05 450.641663 T:140176349177600 DEBUG: VAAPI - attrib 6 (get/set) min 0 max 3 value 0x0 17:43:05 450.641724 T:140176349177600 DEBUG: VAAPI - profile 0 17:43:05 450.641785 T:140176349177600 DEBUG: VAAPI - profile 1 17:43:05 450.641846 T:140176349177600 DEBUG: VAAPI - profile 13 17:43:05 450.642151 T:140176349177600 DEBUG: VAAPI - profile 6 17:43:05 450.642242 T:140176349177600 DEBUG: VAAPI - profile 7 17:43:05 450.642426 T:140176349177600 DEBUG: VAAPI - profile 15 17:43:05 450.642609 T:140176349177600 DEBUG: VAAPI - profile 16 17:43:05 450.642639 T:140176349177600 DEBUG: VAAPI - profile 8 17:43:05 450.642700 T:140176349177600 DEBUG: VAAPI - profile 9 17:43:05 450.642761 T:140176349177600 DEBUG: VAAPI - profile 10 17:43:05 450.642822 T:140176349177600 DEBUG: VAAPI - profile -1 17:43:05 450.642914 T:140176349177600 DEBUG: VAAPI - profile 12 17:43:05 450.642975 T:140176349177600 DEBUG: VAAPI - profile 14 17:43:05 450.643005 T:140176349177600 DEBUG: VAAPI - profile 17 17:43:05 450.643707 T:140176340784896 DEBUG: Thread Vaapi-Output start, auto delete: false 17:43:05 450.643799 T:140176340784896 NOTICE: COutput::OnStartup: Output Thread created 17:43:05 450.655396 T:140176340784896 DEBUG: VAAPI::COutput::CreateEGLContext - created context 17:43:05 450.677643 T:140176994285312 INFO: CActiveAESink::OpenSink - initialize sink 17:43:05 450.678345 T:140176340784896 DEBUG: VAAPI::COutput::InitBufferPool - Surfaces created 17:43:05 450.678436 T:140176349177600 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264-vaapi 17:43:05 450.685608 T:140176349177600 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:43:05 450.715393 T:140176349177600 DEBUG: Previous line repeats 5 times. 17:43:05 450.715454 T:140176349177600 DEBUG: CRenderManager::Configure - change configuration. 1920x1080. display: 3840x1080. framerate: 23.98. format: VAAPI 17:43:05 450.721771 T:140177224669248 DEBUG: StereoscopicsManager: autodetected stereo mode for movie mode left_right is: split_vertical 17:43:05 450.721893 T:140177224669248 DEBUG: Previous line repeats 1 times. 17:43:05 450.721985 T:140177224669248 DEBUG: StereoscopicsManager: stereo mode setting changed to split_vertical 17:43:05 450.722015 T:140175812273920 DEBUG: CGUIInfoManager::SetCurrentMovie(/storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv) 17:43:05 450.722656 T:140177224669248 DEBUG: StereoscopicsManager::ApplyStereoMode: trying to apply stereo mode. Current: off | Target: split_vertical 17:43:05 450.722687 T:140177224669248 DEBUG: StereoscopicsManager: stereo mode changed to split_vertical 17:43:05 450.722931 T:140177224669248 DEBUG: ------ Window Init (DialogNotification.xml) ------ 17:43:05 450.725830 T:140177224660736 DEBUG: GetMovieId (/storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv), query = select idMovie from movie where idFile=10 17:43:05 450.726227 T:140177224660736 DEBUG: GetEpisodeId (/storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv), query = select idEpisode from episode where idFile=10 17:43:05 450.726532 T:140177224660736 DEBUG: GetMusicVideoId (/storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv), query = select idMVideo from musicvideo where idFile=10 17:43:05 450.727600 T:140177224660736 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 17:43:05 450.727661 T:140177224660736 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 17:43:05 450.730225 T:140177224669248 DEBUG: DeleteRenderer - deleting renderer 17:43:05 450.730316 T:140177224669248 DEBUG: LinuxRendererGL: Cleaning up GL resources 17:43:05 450.730469 T:140177224669248 DEBUG: Previous line repeats 1 times. 17:43:05 450.730499 T:140177224669248 DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16 17:43:05 450.730591 T:140177224669248 DEBUG: GL: Requested render method: 0 17:43:05 450.730774 T:140177224669248 DEBUG: GL: BaseYUV2RGBGLSLShader: defines: #define XBMC_DITHER #define XBMC_texture_rectangle 0 #define XBMC_texture_rectangle_hack 0 #define XBMC_STRETCH 0 #define XBMC_NV12_RRG 17:43:05 450.730988 T:140177224669248 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader 17:43:05 450.732178 T:140175812273920 DEBUG: GetMovieId (/storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv), query = select idMovie from movie where idFile=10 17:43:05 450.732513 T:140177224669248 DEBUG: GL: Vertex Shader compilation log: 17:43:05 450.732574 T:140177224669248 DEBUG: GL: Vertex Shader compiled successfully 17:43:05 450.732971 T:140175812273920 DEBUG: GetEpisodeId (/storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv), query = select idEpisode from episode where idFile=10 17:43:05 450.733948 T:140175812273920 DEBUG: GetMusicVideoId (/storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv), query = select idMVideo from musicvideo where idFile=10 17:43:05 450.735596 T:140177224669248 DEBUG: GL: Pixel Shader compilation log: 17:43:05 450.735748 T:140177224669248 DEBUG: GL: Fragment Shader compiled successfully 17:43:06 450.758423 T:140176835725056 DEBUG: PushCecKeypress - received key b duration 270 17:43:06 450.762421 T:140177224669248 DEBUG: GL: ConvolutionFilterShader: using convolution-4x4.glsl defines: #define HAS_FLOAT_TEXTURE 1 #define XBMC_STRETCH 0 #define XBMC_DITHER #define USE1DTEXTURE 1 17:43:06 450.763947 T:140177224669248 DEBUG: GL: Vertex Shader compilation log: 17:43:06 450.764008 T:140177224669248 DEBUG: GL: Vertex Shader compiled successfully 17:43:06 450.769745 T:140177224669248 DEBUG: GL: Pixel Shader compilation log: 17:43:06 450.769836 T:140177224669248 DEBUG: GL: Fragment Shader compiled successfully 17:43:06 450.830444 T:140177224669248 NOTICE: GL: NPOT texture support detected 17:43:06 450.830505 T:140177224669248 NOTICE: GL: Using GL_ARB_pixel_buffer_object 17:43:06 450.830536 T:140177224669248 NOTICE: Using GL_TEXTURE_2D 17:43:06 450.830536 T:140177224669248 DEBUG: CRenderManager::Configure - 4 17:43:06 450.830719 T:140175837452032 DEBUG: CVideoPlayer::HandleMessages - player started 2 17:43:06 450.831635 T:140177224669248 DEBUG: GL: Requested render method: 0 17:43:06 450.831879 T:140177224669248 DEBUG: GL: BaseYUV2RGBGLSLShader: defines: #define XBMC_texture_rectangle 0 #define XBMC_texture_rectangle_hack 0 #define XBMC_STRETCH 0 #define XBMC_NV12_RRG 17:43:06 450.832031 T:140177224669248 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader 17:43:06 450.833771 T:140177224669248 DEBUG: GL: Vertex Shader compilation log: 17:43:06 450.833832 T:140177224669248 DEBUG: GL: Vertex Shader compiled successfully 17:43:06 450.836548 T:140177224669248 DEBUG: GL: Pixel Shader compilation log: 17:43:06 450.836609 T:140177224669248 DEBUG: GL: Fragment Shader compiled successfully 17:43:06 450.855072 T:140177224669248 NOTICE: GL: NPOT texture support detected 17:43:06 450.855133 T:140177224669248 NOTICE: GL: Using GL_ARB_pixel_buffer_object 17:43:06 450.878998 T:140176994285312 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0 17:43:06 450.879181 T:140176994285312 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0" 17:43:06 450.895325 T:140177224669248 INFO: GL: Maximum texture width: 8192 17:43:06 450.895874 T:140176994285312 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x06,AES1=0x82,AES2=0x00,AES3=0x02" 17:43:06 450.896454 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2400, bufferSize 9600 17:43:06 450.903625 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2400, bufferSize 9600 17:43:06 450.903717 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms 17:43:06 450.904724 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 17:43:06 450.904816 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: RAW,RAW 17:43:06 450.904846 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: RAW,RAW (ALSA: none) 17:43:06 450.904907 T:140176994285312 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 17:43:06 450.904938 T:140176994285312 DEBUG: Output Device : HDA Intel PCH 17:43:06 450.904999 T:140176994285312 DEBUG: Sample Rate : 48000 17:43:06 450.905029 T:140176994285312 DEBUG: Sample Format : AE_FMT_S16NE 17:43:06 450.905060 T:140176994285312 DEBUG: Channel Count : 2 17:43:06 450.905121 T:140176994285312 DEBUG: Channel Layout: RAW,RAW 17:43:06 450.905151 T:140176994285312 DEBUG: Frames : 2400 17:43:06 450.905212 T:140176994285312 DEBUG: Frame Size : 4 17:43:06 450.914764 T:140177224669248 DEBUG: Activating window ID: 12005 17:43:06 450.915253 T:140177224669248 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 17:43:06 450.915588 T:140177205733120 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 17:43:06 450.915985 T:140177224669248 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 17:43:06 450.917603 T:140177205733120 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 17:43:06 450.920776 T:140177224669248 NOTICE: Display resolution ADJUST : HDMI2: 1920x1080 @ 23.98Hz (24) (weight: 0.000) 17:43:06 450.920837 T:140177224669248 NOTICE: CWinSystemX11::SetFullScreen - calling xrandr 17:43:06 450.921143 T:140177224669248 DEBUG: OnLostDevice - notify display change event 17:43:06 450.921173 T:140177224669248 DEBUG: Flush - flushing renderer 17:43:06 450.924927 T:140175837452032 DEBUG: CVideoPlayer::HandleMessages - player started 1 17:43:06 450.924957 T:140175837452032 DEBUG: CVideoPlayer::SetCaching - caching state 3 17:43:06 450.924988 T:140175837452032 DEBUG: CVideoPlayer::SetCaching - caching state 0 17:43:06 450.925018 T:140175837452032 DEBUG: VideoPlayer::Sync - Audio - pts: 181000.000000, cache: 317369.222155, totalcache: 600000.023842 17:43:06 450.925049 T:140175837452032 DEBUG: VideoPlayer::Sync - Video - pts: 0.000000, cache: 50000.000000, totalcache: 100000.000000 17:43:06 450.925568 T:140176349177600 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(-136369.222155) 17:43:06 450.925598 T:140176349177600 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:43:06 450.927032 T:140176357570304 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(-136369.222155) 17:43:06 450.927216 T:140176357570304 DEBUG: CDVDAudio::Resume - resume audio stream 17:43:06 450.927368 T:140176349177600 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:43:06 450.937592 T:140176340784896 DEBUG: Previous line repeats 1 times. 17:43:06 450.937653 T:140176340784896 WARNING: COutput::QueueReturnPicture - pic not found 17:43:06 451.165039 T:140177224669248 NOTICE: VideoPlayer: OnLostDisplay received 17:43:06 451.165344 T:140177224669248 INFO: XRANDR: /usr/lib/kodi/kodi-xrandr --screen 0 --output HDMI2 --mode 0x10b 17:43:06 451.409943 T:140177216268032 DEBUG: CALSAHControlMonitor - Monitored ALSA hctl value changed 17:43:06 451.438934 T:140176349177600 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: 1 17:43:06 451.643585 T:140177216268032 DEBUG: CALSAHControlMonitor - Monitored ALSA hctl value changed 17:43:06 451.694000 T:140177224669248 INFO: GL: Maximum texture width: 8192 17:43:06 451.699951 T:140177224669248 DEBUG: GL: Requested render method: 0 17:43:06 451.700989 T:140177224669248 DEBUG: GL: BaseYUV2RGBGLSLShader: defines: #define XBMC_texture_rectangle 0 #define XBMC_texture_rectangle_hack 0 #define XBMC_STRETCH 0 #define XBMC_NV12_RRG 17:43:06 451.702179 T:140177224669248 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader 17:43:06 451.710114 T:140177224669248 DEBUG: GL: Vertex Shader compilation log: 17:43:06 451.710266 T:140177224669248 DEBUG: GL: Vertex Shader compiled successfully 17:43:06 451.715851 T:140177224669248 DEBUG: GL: Pixel Shader compilation log: 17:43:06 451.715942 T:140177224669248 DEBUG: GL: Fragment Shader compiled successfully 17:43:07 451.740143 T:140177224669248 DEBUG: GL: ConvolutionFilterShader: using convolution-4x4.glsl defines: #define HAS_FLOAT_TEXTURE 1 #define XBMC_STRETCH 0 #define XBMC_DITHER #define USE1DTEXTURE 1 17:43:07 451.741669 T:140177224669248 DEBUG: GL: Vertex Shader compilation log: 17:43:07 451.741699 T:140177224669248 DEBUG: GL: Vertex Shader compiled successfully 17:43:07 451.746277 T:140177224669248 DEBUG: GL: Pixel Shader compilation log: 17:43:07 451.746307 T:140177224669248 DEBUG: GL: Fragment Shader compiled successfully 17:43:07 451.796661 T:140177224669248 NOTICE: GL: NPOT texture support detected 17:43:07 451.796722 T:140177224669248 NOTICE: GL: Using GL_ARB_pixel_buffer_object 17:43:07 451.796753 T:140177224669248 NOTICE: Using GL_TEXTURE_2D 17:43:07 451.817291 T:140177224669248 DEBUG: NotifyXRREvent - notify display reset event 17:43:07 451.854706 T:140177224669248 DEBUG: RecreateWindow - current output: HDMI2, mode: 0x10b, refresh: 23.976 17:43:07 451.854919 T:140177224669248 DEBUG: OnLostDevice - notify display change event 17:43:07 451.855011 T:140177224669248 DEBUG: Flush - flushing renderer 17:43:07 451.856415 T:140177224669248 NOTICE: VideoPlayer: OnLostDisplay received 17:43:07 451.856628 T:140176349177600 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: 1 17:43:07 451.867188 T:140177224669248 DEBUG: Window Manager Name: Fluxbox 17:43:07 451.892639 T:140177224669248 DEBUG: CWinSystemX11::RefreshEGLContext: refreshing context 17:43:07 451.894196 T:140177224669248 NOTICE: VideoPlayer: OnResetDisplay received 17:43:07 451.894348 T:140177205733120 DEBUG: CActiveAE - display reset event 17:43:07 451.894806 T:140176349177600 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: 0 17:43:07 451.894928 T:140176994285312 INFO: CActiveAESink::OpenSink - initialize sink 17:43:07 451.895111 T:140177224669248 INFO: GL: Maximum texture width: 8192 17:43:07 451.895233 T:140176994285312 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0 17:43:07 451.895325 T:140176349177600 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:43:07 451.895386 T:140176994285312 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0" 17:43:07 451.900116 T:140176349177600 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0 17:43:07 451.914459 T:140177224669248 DEBUG: Previous line repeats 1 times. 17:43:07 451.914520 T:140177224669248 DEBUG: GL: Requested render method: 0 17:43:07 451.914673 T:140177224669248 DEBUG: GL: BaseYUV2RGBGLSLShader: defines: #define XBMC_texture_rectangle 0 #define XBMC_texture_rectangle_hack 0 #define XBMC_STRETCH 0 #define XBMC_NV12_RRG 17:43:07 451.914856 T:140177224669248 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader 17:43:07 451.916718 T:140176994285312 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x06,AES1=0x82,AES2=0x00,AES3=0x02" 17:43:07 451.917145 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2400, bufferSize 9600 17:43:07 451.917572 T:140177224669248 DEBUG: GL: Vertex Shader compilation log: 17:43:07 451.917633 T:140177224669248 DEBUG: GL: Vertex Shader compiled successfully 17:43:07 451.923462 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2400, bufferSize 9600 17:43:07 451.923523 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms 17:43:07 451.924408 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 17:43:07 451.924469 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: RAW,RAW 17:43:07 451.924500 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: RAW,RAW (ALSA: none) 17:43:07 451.924530 T:140177224669248 DEBUG: GL: Pixel Shader compilation log: 17:43:07 451.925171 T:140176994285312 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 17:43:07 451.925201 T:140176994285312 DEBUG: Output Device : HDA Intel PCH 17:43:07 451.925293 T:140176994285312 DEBUG: Sample Rate : 48000 17:43:07 451.925323 T:140176994285312 DEBUG: Sample Format : AE_FMT_S16NE 17:43:07 451.925354 T:140177224669248 DEBUG: GL: Fragment Shader compiled successfully 17:43:07 451.925476 T:140176994285312 DEBUG: Channel Count : 2 17:43:07 451.925507 T:140176994285312 DEBUG: Channel Layout: RAW,RAW 17:43:07 451.925537 T:140176994285312 DEBUG: Frames : 2400 17:43:07 451.925537 T:140176994285312 DEBUG: Frame Size : 4 17:43:07 451.929321 T:140177205733120 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 17:43:07 451.929688 T:140176357570304 DEBUG: Previous line repeats 1 times. 17:43:07 451.929718 T:140176357570304 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_PAUSE: 1 17:43:07 451.929749 T:140176357570304 DEBUG: Previous line repeats 1 times. 17:43:07 451.929779 T:140176357570304 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_PAUSE: 0 17:43:07 451.930756 T:140177205733120 DEBUG: ActiveAE - start sync of audio stream 17:43:07 451.947723 T:140177224669248 DEBUG: GL: ConvolutionFilterShader: using convolution-4x4.glsl defines: #define HAS_FLOAT_TEXTURE 1 #define XBMC_STRETCH 0 #define XBMC_DITHER #define USE1DTEXTURE 1 17:43:07 451.949280 T:140177224669248 DEBUG: GL: Vertex Shader compilation log: 17:43:07 451.949310 T:140177224669248 DEBUG: GL: Vertex Shader compiled successfully 17:43:07 451.954132 T:140177224669248 DEBUG: GL: Pixel Shader compilation log: 17:43:07 451.954224 T:140177224669248 DEBUG: GL: Fragment Shader compiled successfully 17:43:07 452.005493 T:140177224669248 NOTICE: GL: NPOT texture support detected 17:43:07 452.005554 T:140177224669248 NOTICE: GL: Using GL_ARB_pixel_buffer_object 17:43:07 452.005585 T:140177224669248 NOTICE: Using GL_TEXTURE_2D 17:43:07 452.006012 T:140176349177600 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1 17:43:07 452.030334 T:140177224669248 INFO: GL: Enabling VSYNC 17:43:07 452.030426 T:140177224669248 ERROR: GL: Vertical Blank Syncing unsupported 17:43:07 452.032288 T:140177205733120 DEBUG: ActiveAE::SyncStream - average error of 61.782621, start adjusting 17:43:07 452.032593 T:140177205733120 DEBUG: ActiveAE::SyncStream - average error 21.782621 below threshold of 30.000000 17:43:07 452.056152 T:140177224669248 DEBUG: GL: Requested render method: 0 17:43:07 452.056793 T:140177224669248 DEBUG: GL: BaseYUV2RGBGLSLShader: defines: #define XBMC_texture_rectangle 0 #define XBMC_texture_rectangle_hack 0 #define XBMC_STRETCH 0 #define XBMC_NV12_RRG 17:43:07 452.057526 T:140177224669248 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader 17:43:07 452.063965 T:140177224669248 DEBUG: GL: Vertex Shader compilation log: 17:43:07 452.064117 T:140177224669248 DEBUG: GL: Vertex Shader compiled successfully 17:43:07 452.069733 T:140177224669248 DEBUG: GL: Pixel Shader compilation log: 17:43:07 452.069824 T:140177224669248 DEBUG: GL: Fragment Shader compiled successfully 17:43:07 452.094849 T:140177224669248 NOTICE: GL: NPOT texture support detected 17:43:07 452.094910 T:140177224669248 NOTICE: GL: Using GL_ARB_pixel_buffer_object 17:43:07 452.109833 T:140176349177600 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1 17:43:08 453.081696 T:140176357570304 DEBUG: Previous line repeats 10 times. 17:43:08 453.081757 T:140176357570304 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:39260.418166, adjusted:39260.418166 17:43:11 456.244843 T:140177224669248 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 17:43:11 456.416107 T:140176349177600 DEBUG: CPullupCorrection: detected pattern of length 1: 41708.33, frameduration: 41708.333333 17:43:32 476.788422 T:140176835725056 DEBUG: PushCecKeypress - received key e0 duration 1001 17:43:32 476.799652 T:140177224669248 DEBUG: OnKey: guide (0xe0) pressed, action is Stop 17:43:32 476.799866 T:140177224669248 NOTICE: CVideoPlayer::CloseFile() 17:43:32 476.799927 T:140177224669248 NOTICE: VideoPlayer: waiting for threads to exit 17:43:32 476.805237 T:140175837452032 NOTICE: CVideoPlayer::OnExit() 17:43:32 476.805420 T:140175837452032 NOTICE: Closing stream player 1 17:43:32 476.805511 T:140175837452032 NOTICE: Waiting for audio thread to exit 17:43:32 476.832764 T:140176357570304 NOTICE: thread end: CVideoPlayerAudio::OnExit() 17:43:32 476.833008 T:140176357570304 DEBUG: Thread VideoPlayerAudio 140176357570304 terminating 17:43:32 476.833221 T:140175837452032 NOTICE: Closing audio device 17:43:32 476.882141 T:140175837452032 DEBUG: CDVDAudio::Flush - flush audio stream 17:43:32 476.882599 T:140177205733120 DEBUG: CActiveAE::DiscardStream - audio stream deleted 17:43:32 476.883026 T:140177205733120 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 17:43:32 476.883881 T:140176994285312 DEBUG: Previous line repeats 1 times. 17:43:32 476.884033 T:140176994285312 INFO: CActiveAESink::OpenSink - initialize sink 17:43:32 476.886475 T:140175837452032 NOTICE: Deleting audio codec 17:43:32 476.886841 T:140175837452032 NOTICE: Closing stream player 2 17:43:32 476.887024 T:140175837452032 NOTICE: waiting for video thread to exit 17:43:32 476.898834 T:140176349177600 NOTICE: thread end: video_thread 17:43:32 476.899048 T:140176349177600 DEBUG: Thread VideoPlayerVideo 140176349177600 terminating 17:43:32 476.900513 T:140175837452032 NOTICE: deleting video codec 17:43:32 476.901184 T:140175837452032 DEBUG: VAAPI::Release pre-cleanup 17:43:32 476.915497 T:140175837452032 DEBUG: OnPlayBackStopped: play state was 2, starting 0 17:43:32 476.917114 T:140175837452032 DEBUG: Thread VideoPlayer 140175837452032 terminating 17:43:32 476.917511 T:140177224669248 NOTICE: VideoPlayer: finished waiting 17:43:32 476.917664 T:140177224669248 DEBUG: DeleteRenderer - deleting renderer 17:43:32 476.917847 T:140177224669248 NOTICE: VAAPI::Close 17:43:32 476.919464 T:140176340784896 NOTICE: COutput::OnExit: Output Thread terminated 17:43:32 476.919617 T:140176340784896 DEBUG: Thread Vaapi-Output 140176340784896 terminating 17:43:32 476.920074 T:140177224669248 DEBUG: VAAPI::FiniVAAPIOutput destroying 5 video surfaces 17:43:32 476.925171 T:140177224669248 NOTICE: VAAPI::Close - closing decoder context 17:43:32 476.930328 T:140177224669248 DEBUG: LinuxRendererGL: Cleaning up GL resources 17:43:32 476.930450 T:140177224669248 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 17:43:32 476.930511 T:140177224669248 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 17:43:32 476.931885 T:140177224660736 DEBUG: GetMovieId (/storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv), query = select idMovie from movie where idFile=10 17:43:32 476.932678 T:140177224660736 DEBUG: GetEpisodeId (/storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv), query = select idEpisode from episode where idFile=10 17:43:32 476.933502 T:140177224660736 DEBUG: GetMusicVideoId (/storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv), query = select idMVideo from musicvideo where idFile=10 17:43:32 476.936279 T:140177224660736 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 17:43:32 476.936371 T:140177224660736 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 17:43:32 476.937866 T:140177224669248 NOTICE: CWinSystemX11::SetFullScreen - calling xrandr 17:43:32 476.938629 T:140177224669248 DEBUG: OnLostDevice - notify display change event 17:43:32 477.083679 T:140176994285312 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0 17:43:32 477.083862 T:140176994285312 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0" 17:43:32 477.097351 T:140176994285312 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00" 17:43:32 477.098297 T:140176994285312 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 17:43:32 477.098389 T:140176994285312 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 17:43:32 477.098450 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2205, bufferSize 8820 17:43:32 477.107086 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2205, bufferSize 8820 17:43:32 477.107208 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms 17:43:32 477.108551 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 17:43:32 477.108612 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR 17:43:32 477.108673 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR) 17:43:32 477.108734 T:140176994285312 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 17:43:32 477.108765 T:140176994285312 DEBUG: Output Device : HDA Intel PCH 17:43:32 477.108826 T:140176994285312 DEBUG: Sample Rate : 44100 17:43:32 477.108856 T:140176994285312 DEBUG: Sample Format : AE_FMT_S32NE 17:43:32 477.108917 T:140176994285312 DEBUG: Channel Count : 2 17:43:32 477.108978 T:140176994285312 DEBUG: Channel Layout: FL,FR 17:43:32 477.109009 T:140176994285312 DEBUG: Frames : 2205 17:43:32 477.109070 T:140176994285312 DEBUG: Frame Size : 8 17:43:32 477.114014 T:140177205733120 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 17:43:32 477.266357 T:140177224669248 DEBUG: Previous line repeats 1 times. 17:43:32 477.266479 T:140177224669248 NOTICE: VideoPlayer: OnLostDisplay received 17:43:32 477.266602 T:140177224669248 WARNING: CDVDMessageQueue(audio)::Put MSGQ_NOT_INITIALIZED 17:43:32 477.266785 T:140177224669248 WARNING: CDVDMessageQueue(video)::Put MSGQ_NOT_INITIALIZED 17:43:32 477.266968 T:140177224669248 INFO: XRANDR: /usr/lib/kodi/kodi-xrandr --screen 0 --output HDMI2 --mode 0x49 17:43:32 477.581635 T:140177216268032 DEBUG: CALSAHControlMonitor - Monitored ALSA hctl value changed 17:43:32 477.638672 T:140176940537600 DEBUG: GetMappingForDevice - device (2548:1002) mapped to Pulse-Eight CEC Adapter (type = cec) 17:43:33 477.811859 T:140177216268032 DEBUG: Previous line repeats 1 times. 17:43:33 477.811981 T:140177216268032 DEBUG: CALSAHControlMonitor - Monitored ALSA hctl value changed 17:43:33 477.841949 T:140177224669248 INFO: GL: Maximum texture width: 8192 17:43:33 477.847595 T:140177224669248 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 17:43:33 477.862000 T:140177224669248 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 17:43:33 477.864868 T:140177224669248 DEBUG: CGUIMediaWindow::GetDirectory (/storage/mediathek/Videos/HD/3D/) 17:43:33 477.864960 T:140177224669248 DEBUG: ParentPath = [/storage/mediathek/Videos/HD/3D/] 17:43:33 477.944855 T:140177224669248 DEBUG: RunQuery took 0 ms for 59 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=2 17:43:33 477.952454 T:140176340784896 DEBUG: Thread BackgroundLoader start, auto delete: false 17:43:33 477.969147 T:140175812273920 DEBUG: GetImageHash - unable to stat url 17:43:33 478.037659 T:140177224669248 NOTICE: CVideoPlayer::CloseFile() 17:43:33 478.037750 T:140177224669248 NOTICE: VideoPlayer: waiting for threads to exit 17:43:33 478.037781 T:140177224669248 NOTICE: VideoPlayer: finished waiting 17:43:33 478.037811 T:140177224669248 NOTICE: CVideoPlayer::CloseFile() 17:43:33 478.037842 T:140177224669248 NOTICE: VideoPlayer: waiting for threads to exit 17:43:33 478.037842 T:140177224669248 NOTICE: VideoPlayer: finished waiting 17:43:33 478.044983 T:140177224669248 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 17:43:33 478.045349 T:140177224669248 DEBUG: StereoscopicsManager: stereo mode setting changed to off 17:43:33 478.045380 T:140177224669248 DEBUG: StereoscopicsManager::ApplyStereoMode: trying to apply stereo mode. Current: split_vertical | Target: off 17:43:33 478.045410 T:140177224669248 DEBUG: StereoscopicsManager: stereo mode changed to off 17:43:33 478.045685 T:140175812273920 DEBUG: DoWork - Saving file state for video item /storage/mediathek/Videos/HD/3D/The Art of Flight (2011).mkv 17:43:33 478.046143 T:140177224669248 DEBUG: ------ Window Init (DialogNotification.xml) ------ 17:43:33 478.046448 T:140177224669248 DEBUG: NotifyXRREvent - notify display reset event 17:43:33 478.073181 T:140177224669248 DEBUG: RecreateWindow - current output: HDMI2, mode: 0x49, refresh: 50.000 17:43:33 478.073456 T:140177224669248 DEBUG: OnLostDevice - notify display change event 17:43:33 478.079437 T:140177224669248 DEBUG: Window Manager Name: Fluxbox 17:43:33 478.088989 T:140177224669248 DEBUG: CWinSystemX11::RefreshEGLContext: refreshing context 17:43:33 478.091522 T:140177224669248 DEBUG: OnLostDevice - notify display change event 17:43:33 478.094604 T:140177224669248 DEBUG: Window Manager Name: Fluxbox 17:43:33 478.110840 T:140177224669248 DEBUG: CWinSystemX11::RefreshEGLContext: refreshing context 17:43:33 478.112701 T:140177224669248 INFO: GL: Maximum texture width: 8192 17:43:33 478.113129 T:140177205733120 DEBUG: CActiveAE - display reset event 17:43:33 478.113525 T:140176994285312 INFO: CActiveAESink::OpenSink - initialize sink 17:43:33 478.113586 T:140176994285312 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=0 17:43:33 478.113617 T:140176994285312 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=0" 17:43:33 478.118286 T:140176994285312 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00" 17:43:33 478.118774 T:140176994285312 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 17:43:33 478.118805 T:140176994285312 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 17:43:33 478.118835 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2205, bufferSize 8820 17:43:33 478.123352 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2205, bufferSize 8820 17:43:33 478.123413 T:140176994285312 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms 17:43:33 478.124390 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 17:43:33 478.124390 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR 17:43:33 478.124420 T:140176994285312 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR) 17:43:33 478.124451 T:140176994285312 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 17:43:33 478.124481 T:140176994285312 DEBUG: Output Device : HDA Intel PCH 17:43:33 478.124481 T:140176994285312 DEBUG: Sample Rate : 44100 17:43:33 478.124512 T:140176994285312 DEBUG: Sample Format : AE_FMT_S32NE 17:43:33 478.124542 T:140176994285312 DEBUG: Channel Count : 2 17:43:33 478.124542 T:140176994285312 DEBUG: Channel Layout: FL,FR 17:43:33 478.124573 T:140176994285312 DEBUG: Frames : 2205 17:43:33 478.124603 T:140176994285312 DEBUG: Frame Size : 8 17:43:33 478.126770 T:140177205733120 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 17:43:33 478.152527 T:140177224669248 INFO: GL: Maximum texture width: 8192 17:43:33 478.155609 T:140176340784896 DEBUG: Thread BackgroundLoader 140176340784896 terminating 17:43:33 478.194672 T:140177224669248 INFO: GL: Enabling VSYNC 17:43:33 478.194733 T:140177224669248 ERROR: GL: Vertical Blank Syncing unsupported 17:43:36 481.160919 T:140177224669248 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/libsse4-x86_64-linux.so) 17:43:39 483.947021 T:140177224669248 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 17:43:42 487.139069 T:140176835725056 DEBUG: PushCecKeypress - received key d8 duration 0 17:43:42 487.168274 T:140177224669248 DEBUG: OnKey: menu (0xd8) pressed, action is Back 17:43:42 487.168793 T:140177224669248 DEBUG: CGUIMediaWindow::GetDirectory (/storage/mediathek/Videos/HD/) 17:43:42 487.168976 T:140177224669248 DEBUG: ParentPath = [sources://video/] 17:43:42 487.202148 T:140175837452032 DEBUG: Thread BackgroundLoader start, auto delete: false 17:43:42 487.207672 T:140175812273920 DEBUG: GetImageHash - unable to stat url 17:43:42 487.244873 T:140175837452032 DEBUG: Thread BackgroundLoader 140175837452032 terminating 17:43:42 487.410400 T:140176835725056 DEBUG: PushCecKeypress - received key d8 duration 272 17:43:43 487.983063 T:140176835725056 DEBUG: PushCecKeypress - received key d8 duration 0 17:43:43 488.018372 T:140177224669248 DEBUG: OnKey: menu (0xd8) pressed, action is Back 17:43:43 488.018951 T:140177224669248 DEBUG: CGUIMediaWindow::GetDirectory (sources://video/) 17:43:43 488.019073 T:140177224669248 DEBUG: ParentPath = [] 17:43:43 488.063690 T:140175837452032 DEBUG: Thread BackgroundLoader start, auto delete: false 17:43:43 488.069489 T:140175812273920 DEBUG: GetImageHash - unable to stat url 17:43:43 488.074768 T:140175837452032 DEBUG: Thread BackgroundLoader 140175837452032 terminating 17:43:43 488.121735 T:140175812273920 DEBUG: GetImageHash - unable to stat url 17:43:43 488.261353 T:140176835725056 DEBUG: Previous line repeats 7 times. 17:43:43 488.261475 T:140176835725056 DEBUG: PushCecKeypress - received key d8 duration 279 17:43:43 488.279663 T:140175812273920 DEBUG: GetImageHash - unable to stat url 17:43:44 488.835388 T:140176835725056 DEBUG: Previous line repeats 16 times. 17:43:44 488.835510 T:140176835725056 DEBUG: PushCecKeypress - received key d8 duration 0 17:43:44 488.839355 T:140177224669248 DEBUG: OnKey: menu (0xd8) pressed, action is Back 17:43:44 488.839783 T:140177224669248 DEBUG: CGUIMediaWindow::GetDirectory () 17:43:44 488.839874 T:140177224669248 DEBUG: ParentPath = [] 17:43:44 488.846649 T:140175837452032 DEBUG: Thread BackgroundLoader start, auto delete: false 17:43:44 488.868683 T:140175837452032 DEBUG: Thread BackgroundLoader 140175837452032 terminating 17:43:44 489.112732 T:140176835725056 DEBUG: PushCecKeypress - received key d8 duration 277 17:43:44 489.635956 T:140176835725056 DEBUG: PushCecKeypress - received key d8 duration 0 17:43:44 489.638367 T:140177224669248 DEBUG: OnKey: menu (0xd8) pressed, action is Back 17:43:44 489.638489 T:140177224669248 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 17:43:45 489.913361 T:140176835725056 DEBUG: PushCecKeypress - received key d8 duration 278 17:43:45 489.941528 T:140177224669248 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 17:43:45 489.944427 T:140177224669248 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 17:43:45 489.955719 T:140177224669248 DEBUG: ------ Window Init (MyMusicNav.xml) ------ 17:43:45 489.974274 T:140177224669248 DEBUG: CGUIMediaWindow::GetDirectory () 17:43:45 489.974365 T:140177224669248 DEBUG: ParentPath = [] 17:43:45 489.985962 T:140177224669248 DEBUG: RetrieveMusicInfo() took 0 msec 17:43:45 489.990417 T:140175837452032 DEBUG: Thread BackgroundLoader start, auto delete: false 17:43:45 490.004883 T:140175837452032 DEBUG: Thread BackgroundLoader 140175837452032 terminating 17:43:46 491.137421 T:140176835725056 DEBUG: PushCecKeypress - received key d8 duration 0 17:43:46 491.144592 T:140177224669248 DEBUG: OnKey: menu (0xd8) pressed, action is Back 17:43:46 491.148346 T:140177224669248 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 17:43:46 491.411072 T:140176835725056 DEBUG: PushCecKeypress - received key d8 duration 273 17:43:46 491.454956 T:140177224669248 DEBUG: ------ Window Deinit (MyMusicNav.xml) ------ 17:43:46 491.456238 T:140177224669248 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 17:43:46 491.456329 T:140177224669248 DEBUG: ------ Window Init (SettingsCategory.xml) ------ 17:43:48 493.037140 T:140176835725056 DEBUG: PushCecKeypress - received key b duration 0 17:43:48 493.039642 T:140177224669248 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 17:43:48 493.039764 T:140177224669248 NOTICE: Disabled debug logging due to GUI setting. Level 0. 17:43:48 493.039795 T:140177224669248 NOTICE: Log level changed to "LOG_LEVEL_NORMAL"