I've attached two log files. upstream.log corresponds to failed playback using the Debian package with VAAPI is enabled. custom.log corresponds to the successful playback with my custom built pacakge, where xbmc is using its own internal libraries.
Note that the log shows Mesa version 8.0.3, however I later confirmed that the issue also exists with Mesa 8.0.4. -- Matt Horan m...@matthoran.com http://matthoran.com/
23:02:31 T:140008146835360 NOTICE: ----------------------------------------------------------------------- 23:02:31 T:140008146835360 NOTICE: Starting XBMC (11.0 Git:20120510-82388d5), Platform: Linux (Debian GNU/Linux testing (wheezy), 3.6.0-rc1+ x86_64). Built on Aug 9 2012 23:02:31 T:140008146835360 NOTICE: special://xbmc/ is mapped to: /usr/share/xbmc 23:02:31 T:140008146835360 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/xbmc 23:02:31 T:140008146835360 NOTICE: special://masterprofile/ is mapped to: /home/mhoran/.xbmc/userdata 23:02:31 T:140008146835360 NOTICE: special://home/ is mapped to: /home/mhoran/.xbmc 23:02:31 T:140008146835360 NOTICE: special://temp/ is mapped to: /home/mhoran/.xbmc/temp 23:02:31 T:140008146835360 NOTICE: The executable running is: /usr/lib/xbmc/xbmc.bin 23:02:31 T:140008146835360 NOTICE: Local hostname: challenger 23:02:31 T:140008146835360 NOTICE: Log File is located: /home/mhoran/.xbmc/temp/xbmc.log 23:02:31 T:140008146835360 NOTICE: ----------------------------------------------------------------------- 23:02:31 T:140008146835360 NOTICE: Setup SDL 23:02:32 T:140008146835360 NOTICE: load settings... 23:02:32 T:140008146835360 NOTICE: special://profile/ is mapped to: special://masterprofile/ 23:02:32 T:140008146835360 NOTICE: loading special://masterprofile/guisettings.xml 23:02:32 T:140008146835360 NOTICE: Getting hardware information now... 23:02:32 T:140008146835360 NOTICE: Checking resolution 12 23:02:32 T:140008146835360 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 23:02:32 T:140008146835360 NOTICE: Loaded playercorefactory configuration 23:02:32 T:140008146835360 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 23:02:32 T:140008146835360 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 23:02:32 T:140008146835360 NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml) 23:02:32 T:140008146835360 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 23:02:32 T:140008146835360 NOTICE: Default DVD Player: dvdplayer 23:02:32 T:140008146835360 NOTICE: Default Video Player: dvdplayer 23:02:32 T:140008146835360 NOTICE: Default Audio Player: paplayer 23:02:32 T:140008146835360 NOTICE: Disabled debug logging due to GUI setting. Level 0. 23:02:32 T:140008146835360 NOTICE: Log level changed to 0 23:02:32 T:140008146835360 NOTICE: Loading media sources from special://masterprofile/sources.xml 23:02:33 T:140008146835360 NOTICE: Using visual 0x22 23:02:33 T:140008146835360 NOTICE: GL_VENDOR = Tungsten Graphics, Inc 23:02:33 T:140008146835360 NOTICE: GL_RENDERER = Mesa DRI Intel(R) Sandybridge Desktop 23:02:33 T:140008146835360 NOTICE: GL_VERSION = 3.0 Mesa 8.0.4 23:02:33 T:140008146835360 NOTICE: GL_SHADING_LANGUAGE_VERSION = 1.30 23:02:33 T:140008146835360 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_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_NV_vertex_program 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_ATI_envmap_bumpmap GL_EXT_stencil_two_side GL_EXT_texture_cube_map GL_NV_depth_clamp GL_NV_vertex_program1_1 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_MESA_ycbcr_texture GL_ARB_depth_clamp GL_ARB_fragment_program_shadow GL_ARB_half_float_pixel 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_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_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_MESA_texture_array GL_ARB_copy_buffer GL_ARB_depth_buffer_float GL_ARB_half_float_vertex GL_ARB_map_buffer_range GL_ARB_texture_rg GL_ARB_texture_swizzle GL_ARB_vertex_array_bgra GL_EXT_separate_shader_objects GL_EXT_texture_swizzle GL_EXT_vertex_array_bgra GL_NV_conditional_render GL_ARB_ES2_compatibility GL_ARB_draw_elements_base_vertex GL_ARB_explicit_attrib_location GL_ARB_fragment_coord_conventions GL_ARB_provoking_vertex GL_ARB_sampler_objects GL_ARB_seamless_cube_map GL_ARB_shader_texture_lod GL_EXT_provoking_vertex GL_EXT_texture_snorm GL_MESA_texture_signed_rgba GL_ARB_robustness GL_EXT_transform_feedback 23:02:33 T:140008146835360 ERROR: GLX: Same window as before, refreshing context 23:02:33 T:140008146835360 NOTICE: UDisks: Added /mnt/storage 23:02:33 T:140008146835360 NOTICE: start dvd mediatype detection 23:02:33 T:140008146835360 NOTICE: initializing playlistplayer 23:02:33 T:140008146835360 NOTICE: DONE initializing playlistplayer 23:02:33 T:140008146835360 NOTICE: initialize done 23:02:33 T:140008146835360 NOTICE: Running the application... 23:02:33 T:140007757829888 NOTICE: -->Python Interpreter Initialized<-- 23:02:33 T:140007612344064 NOTICE: -->Python Interpreter Initialized<-- 23:02:33 T:140008146835360 NOTICE: ES: Starting event server 23:02:33 T:140007587165952 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777 23:02:33 T:140007587165952 NOTICE: UDP: Listening on port 9777 23:02:33 T:140008146835360 NOTICE: starting zeroconf publishing 23:02:33 T:140007757829888 NOTICE: Artwork Downloader: ## Service - Run at startup: False 23:02:33 T:140007757829888 NOTICE: Artwork Downloader: ## Service - Delayed startup: -- minutes 23:02:33 T:140007757829888 NOTICE: Artwork Downloader: ## Service - Run as service: False 23:02:33 T:140007757829888 NOTICE: Artwork Downloader: ## Service - Time: 00:00 23:02:33 T:140007612344064 NOTICE: StorageServer Module loaded RUN 23:02:33 T:140007612344064 NOTICE: StorageClient-1.1.0 Starting server 23:02:33 T:140007612344064 NOTICE: StorageServer-1.1.0 Storage Server starting /home/mhoran/.xbmc/userdata/Database/commoncache.db 23:02:33 T:140007570380544 NOTICE: -->Python Interpreter Initialized<-- 23:02:39 T:140007570380544 ERROR: GetDirectory - Error getting /mnt/storage/lost+found/ 23:03:03 T:140008146835360 ERROR: Previous line repeats 2 times. 23:03:03 T:140008146835360 NOTICE: DVDPlayer: Opening: /mnt/storage/Movies/American.Psycho.2000.576p.BluRay.x264-XTSF/!sample/!sample.mkv 23:03:03 T:140008146835360 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 23:03:03 T:140007766222592 NOTICE: Creating InputStream 23:03:03 T:140007766222592 NOTICE: Creating Demuxer 23:03:03 T:140007766222592 NOTICE: Opening video stream: 0 source: 256 23:03:03 T:140007766222592 NOTICE: Creating video codec with codec id: 28 23:03:03 T:140007766222592 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 23:03:03 T:140007766222592 NOTICE: Creating video thread 23:03:03 T:140007766222592 NOTICE: Opening audio stream: 1 source: 256 23:03:03 T:140007766222592 NOTICE: Finding audio codec for: 86019 23:03:03 T:140007630251776 NOTICE: running thread: video_thread 23:03:03 T:140007766222592 NOTICE: Creating audio thread 23:03:03 T:140007621859072 NOTICE: running thread: CDVDPlayerAudio::Process() 23:03:03 T:140007621859072 NOTICE: Creating audio device with codec id: 86019, channels: 2, sample rate: 48000, pass-through 23:03:03 T:140007630251776 NOTICE: fps: 23.976024, pwidth: 1024, pheight: 432, dwidth: 1024, dheight: 432 23:03:03 T:140007630251776 NOTICE: Display resolution DESKTOP : 1920x1080 @ 60.00 - Full Screen (12) 23:03:03 T:140008146835360 NOTICE: Using GL_TEXTURE_2D 23:03:03 T:140008146835360 NOTICE: GL: Using VAAPI render method 23:03:03 T:140008146835360 NOTICE: GL: NPOT texture support detected 23:03:03 T:140008146835360 NOTICE: GL: Using GL_ARB_pixel_buffer_object 23:04:08 T:140007621859072 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available 23:04:08 T:140007766222592 NOTICE: CDVDPlayer::OnExit() 23:04:08 T:140007766222592 NOTICE: DVDPlayer: eof, waiting for queues to empty 23:04:08 T:140007766222592 NOTICE: DVDPlayer: closing audio stream 23:04:08 T:140007766222592 NOTICE: Closing audio stream 23:04:08 T:140007766222592 NOTICE: CDVDMessageQueue(audio)::WaitUntilEmpty 23:04:08 T:140007766222592 NOTICE: Waiting for audio thread to exit 23:04:08 T:140007621859072 NOTICE: thread end: CDVDPlayerAudio::OnExit() 23:04:08 T:140007766222592 NOTICE: Closing audio device 23:04:08 T:140007766222592 NOTICE: Deleting audio codec 23:04:08 T:140007766222592 NOTICE: DVDPlayer: closing video stream 23:04:08 T:140007766222592 NOTICE: Closing video stream 23:04:08 T:140007766222592 NOTICE: CDVDMessageQueue(video)::WaitUntilEmpty 23:04:08 T:140007630251776 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available 23:04:08 T:140007766222592 NOTICE: waiting for video thread to exit 23:04:08 T:140007630251776 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true 23:04:08 T:140007630251776 NOTICE: thread end: video_thread 23:04:08 T:140007766222592 NOTICE: deleting video codec 23:04:08 T:140007766222592 NOTICE: CDVDPlayer::OnExit() deleting demuxer 23:04:08 T:140007766222592 NOTICE: CDVDPlayer::OnExit() deleting input stream 23:04:08 T:140008146835360 NOTICE: CDVDPlayer::CloseFile() 23:04:08 T:140008146835360 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 23:04:08 T:140008146835360 NOTICE: DVDPlayer: waiting for threads to exit 23:04:08 T:140008146835360 NOTICE: DVDPlayer: finished waiting
22:44:18 T:140653116098464 NOTICE: ----------------------------------------------------------------------- 22:44:19 T:140653116098464 NOTICE: Starting XBMC (11.0 Git:Unknown), Platform: Linux (Debian GNU/Linux testing (wheezy), 3.6.0-rc1+ x86_64). Built on Jun 15 2012 22:44:19 T:140653116098464 NOTICE: special://xbmc/ is mapped to: /usr/share/xbmc 22:44:19 T:140653116098464 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/xbmc 22:44:19 T:140653116098464 NOTICE: special://masterprofile/ is mapped to: /home/mhoran/.xbmc/userdata 22:44:19 T:140653116098464 NOTICE: special://home/ is mapped to: /home/mhoran/.xbmc 22:44:19 T:140653116098464 NOTICE: special://temp/ is mapped to: /home/mhoran/.xbmc/temp 22:44:19 T:140653116098464 NOTICE: The executable running is: /usr/lib/xbmc/xbmc.bin 22:44:19 T:140653116098464 NOTICE: Local hostname: challenger 22:44:19 T:140653116098464 NOTICE: Log File is located: /home/mhoran/.xbmc/temp/xbmc.log 22:44:19 T:140653116098464 NOTICE: ----------------------------------------------------------------------- 22:44:19 T:140653116098464 NOTICE: Setup SDL 22:44:19 T:140653116098464 NOTICE: load settings... 22:44:19 T:140653116098464 NOTICE: special://profile/ is mapped to: special://masterprofile/ 22:44:19 T:140653116098464 NOTICE: loading special://masterprofile/guisettings.xml 22:44:19 T:140653116098464 NOTICE: Getting hardware information now... 22:44:19 T:140653116098464 NOTICE: Checking resolution 12 22:44:19 T:140653116098464 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 22:44:19 T:140653116098464 NOTICE: Loaded playercorefactory configuration 22:44:19 T:140653116098464 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 22:44:19 T:140653116098464 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 22:44:19 T:140653116098464 NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml) 22:44:19 T:140653116098464 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 22:44:19 T:140653116098464 NOTICE: Default DVD Player: dvdplayer 22:44:19 T:140653116098464 NOTICE: Default Video Player: dvdplayer 22:44:19 T:140653116098464 NOTICE: Default Audio Player: paplayer 22:44:19 T:140653116098464 NOTICE: Disabled debug logging due to GUI setting. Level 0. 22:44:19 T:140653116098464 NOTICE: Log level changed to 0 22:44:19 T:140653116098464 NOTICE: Loading media sources from special://masterprofile/sources.xml 22:44:20 T:140653116098464 NOTICE: Using visual 0x22 22:44:20 T:140653116098464 NOTICE: GL_VENDOR = Tungsten Graphics, Inc 22:44:20 T:140653116098464 NOTICE: GL_RENDERER = Mesa DRI Intel(R) Sandybridge Desktop 22:44:20 T:140653116098464 NOTICE: GL_VERSION = 3.0 Mesa 8.0.4 22:44:20 T:140653116098464 NOTICE: GL_SHADING_LANGUAGE_VERSION = 1.30 22:44:20 T:140653116098464 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_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_NV_vertex_program 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_ATI_envmap_bumpmap GL_EXT_stencil_two_side GL_EXT_texture_cube_map GL_NV_depth_clamp GL_NV_vertex_program1_1 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_MESA_ycbcr_texture GL_ARB_depth_clamp GL_ARB_fragment_program_shadow GL_ARB_half_float_pixel 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_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_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_MESA_texture_array GL_ARB_copy_buffer GL_ARB_depth_buffer_float GL_ARB_half_float_vertex GL_ARB_map_buffer_range GL_ARB_texture_rg GL_ARB_texture_swizzle GL_ARB_vertex_array_bgra GL_EXT_separate_shader_objects GL_EXT_texture_swizzle GL_EXT_vertex_array_bgra GL_NV_conditional_render GL_ARB_ES2_compatibility GL_ARB_draw_elements_base_vertex GL_ARB_explicit_attrib_location GL_ARB_fragment_coord_conventions GL_ARB_provoking_vertex GL_ARB_sampler_objects GL_ARB_seamless_cube_map GL_ARB_shader_texture_lod GL_EXT_provoking_vertex GL_EXT_texture_snorm GL_MESA_texture_signed_rgba GL_ARB_robustness GL_EXT_transform_feedback 22:44:22 T:140653116098464 ERROR: GLX: Same window as before, refreshing context 22:44:22 T:140653116098464 NOTICE: UDisks: Added /mnt/storage 22:44:22 T:140653116098464 NOTICE: start dvd mediatype detection 22:44:22 T:140653116098464 NOTICE: initializing playlistplayer 22:44:22 T:140653116098464 NOTICE: DONE initializing playlistplayer 22:44:23 T:140653116098464 NOTICE: initialize done 22:44:23 T:140653116098464 NOTICE: Running the application... 22:44:23 T:140653116098464 NOTICE: ES: Starting event server 22:44:23 T:140652847290112 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777 22:44:23 T:140652847290112 NOTICE: UDP: Listening on port 9777 22:44:23 T:140653116098464 NOTICE: starting zeroconf publishing 22:44:23 T:140652956313344 NOTICE: -->Python Interpreter Initialized<-- 22:44:23 T:140652947920640 NOTICE: -->Python Interpreter Initialized<-- 22:44:23 T:140652956313344 NOTICE: Artwork Downloader: ## Service - Run at startup: False 22:44:23 T:140652956313344 NOTICE: Artwork Downloader: ## Service - Delayed startup: -- minutes 22:44:23 T:140652956313344 NOTICE: Artwork Downloader: ## Service - Run as service: False 22:44:23 T:140652956313344 NOTICE: Artwork Downloader: ## Service - Time: 00:00 22:44:23 T:140652809049856 NOTICE: -->Python Interpreter Initialized<-- 22:44:23 T:140652947920640 NOTICE: StorageServer Module loaded RUN 22:44:23 T:140652947920640 NOTICE: StorageClient-1.1.0 Starting server 22:44:23 T:140652947920640 NOTICE: StorageServer-1.1.0 Storage Server starting /home/mhoran/.xbmc/userdata/Database/commoncache.db 22:44:45 T:140652809049856 ERROR: GetDirectory - Error getting /mnt/storage/lost+found/ 22:44:50 T:140653116098464 NOTICE: DVDPlayer: Opening: /mnt/storage/Movies/American.Psycho.2000.576p.BluRay.x264-XTSF/!sample/!sample.mkv 22:44:50 T:140653116098464 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 22:44:50 T:140652964706048 NOTICE: Creating InputStream 22:44:50 T:140652964706048 NOTICE: Creating Demuxer 22:44:51 T:140652964706048 NOTICE: Opening video stream: 0 source: 256 22:44:51 T:140652964706048 NOTICE: Creating video codec with codec id: 28 22:44:51 T:140652964706048 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 22:44:51 T:140652964706048 NOTICE: Creating video thread 22:44:51 T:140652964706048 NOTICE: Opening audio stream: 1 source: 256 22:44:51 T:140653006640896 NOTICE: running thread: video_thread 22:44:51 T:140652964706048 NOTICE: Finding audio codec for: 86019 22:44:51 T:140652964706048 NOTICE: Creating audio thread 22:44:51 T:140652998248192 NOTICE: running thread: CDVDPlayerAudio::Process() 22:44:51 T:140652998248192 NOTICE: Creating audio device with codec id: 86019, channels: 2, sample rate: 48000, pass-through 22:44:51 T:140653006640896 NOTICE: fps: 23.976024, pwidth: 1024, pheight: 432, dwidth: 1024, dheight: 432 22:44:51 T:140653006640896 NOTICE: Display resolution DESKTOP : 1920x1080 @ 60.00 - Full Screen (12) 22:44:51 T:140652998248192 ERROR: PulseAudio: Waited for the stream but it failed 22:44:51 T:140652998248192 ERROR: Creating a Null Audio Renderer, Check your audio settings as this should not happen 22:44:51 T:140653116098464 NOTICE: Using GL_TEXTURE_2D 22:44:51 T:140653116098464 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader 22:44:51 T:140653116098464 NOTICE: GL: NPOT texture support detected 22:44:51 T:140653116098464 NOTICE: GL: Using GL_ARB_pixel_buffer_object 22:44:59 T:140653116098464 NOTICE: CDVDPlayer::CloseFile() 22:44:59 T:140653116098464 NOTICE: DVDPlayer: waiting for threads to exit 22:44:59 T:140652964706048 NOTICE: CDVDPlayer::OnExit() 22:44:59 T:140652964706048 NOTICE: DVDPlayer: closing audio stream 22:44:59 T:140652964706048 NOTICE: Closing audio stream 22:44:59 T:140652964706048 NOTICE: Waiting for audio thread to exit 22:44:59 T:140652998248192 NOTICE: thread end: CDVDPlayerAudio::OnExit() 22:44:59 T:140652964706048 NOTICE: Closing audio device 22:44:59 T:140652964706048 NOTICE: Deleting audio codec 22:44:59 T:140652964706048 NOTICE: DVDPlayer: closing video stream 22:44:59 T:140652964706048 NOTICE: Closing video stream 22:44:59 T:140652964706048 NOTICE: waiting for video thread to exit 22:44:59 T:140653006640896 NOTICE: thread end: video_thread 22:44:59 T:140652964706048 NOTICE: deleting video codec 22:44:59 T:140652964706048 NOTICE: CDVDPlayer::OnExit() deleting demuxer 22:44:59 T:140652964706048 NOTICE: CDVDPlayer::OnExit() deleting input stream 22:44:59 T:140653116098464 NOTICE: DVDPlayer: finished waiting 22:45:00 T:140653116098464 NOTICE: CDVDPlayer::CloseFile() 22:45:00 T:140653116098464 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 22:45:00 T:140653116098464 NOTICE: DVDPlayer: waiting for threads to exit 22:45:00 T:140653116098464 NOTICE: DVDPlayer: finished waiting 22:45:11 T:140653116098464 NOTICE: DVDPlayer: Opening: /mnt/storage/Movies/American.Psycho.2000.576p.BluRay.x264-XTSF/!sample/!sample.mkv 22:45:11 T:140653116098464 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 22:45:11 T:140652998248192 NOTICE: Creating InputStream 22:45:11 T:140652998248192 NOTICE: Creating Demuxer 22:45:11 T:140652998248192 NOTICE: Opening video stream: 0 source: 256 22:45:11 T:140652998248192 NOTICE: Creating video codec with codec id: 28 22:45:11 T:140652998248192 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 22:45:11 T:140652998248192 NOTICE: Creating video thread 22:45:11 T:140652998248192 NOTICE: Opening audio stream: 1 source: 256 22:45:11 T:140652989855488 NOTICE: running thread: video_thread 22:45:11 T:140652998248192 NOTICE: Finding audio codec for: 86019 22:45:11 T:140652998248192 NOTICE: Creating audio thread 22:45:11 T:140652981462784 NOTICE: running thread: CDVDPlayerAudio::Process() 22:45:11 T:140652981462784 NOTICE: Creating audio device with codec id: 86019, channels: 2, sample rate: 48000, pass-through 22:45:11 T:140652989855488 NOTICE: fps: 23.976024, pwidth: 1024, pheight: 432, dwidth: 1024, dheight: 432 22:45:11 T:140652989855488 WARNING: CRenderManager::Configure - timeout waiting for previous frame 22:45:11 T:140652989855488 NOTICE: Display resolution DESKTOP : 1920x1080 @ 60.00 - Full Screen (12) 22:45:11 T:140653116098464 NOTICE: Using GL_TEXTURE_2D 22:45:11 T:140653116098464 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader 22:45:11 T:140653116098464 NOTICE: GL: NPOT texture support detected 22:45:11 T:140653116098464 NOTICE: GL: Using GL_ARB_pixel_buffer_object 22:45:17 T:140653116098464 NOTICE: CDVDPlayer::CloseFile() 22:45:17 T:140653116098464 NOTICE: DVDPlayer: waiting for threads to exit 22:45:17 T:140652998248192 NOTICE: CDVDPlayer::OnExit() 22:45:17 T:140652998248192 NOTICE: DVDPlayer: closing audio stream 22:45:17 T:140652998248192 NOTICE: Closing audio stream 22:45:17 T:140652998248192 NOTICE: Waiting for audio thread to exit 22:45:17 T:140652981462784 ERROR: AddPackets - failed to add leftover bytes to render 22:45:17 T:140652981462784 NOTICE: thread end: CDVDPlayerAudio::OnExit() 22:45:17 T:140652998248192 NOTICE: Closing audio device 22:45:17 T:140652998248192 NOTICE: Deleting audio codec 22:45:17 T:140652998248192 NOTICE: DVDPlayer: closing video stream 22:45:17 T:140652998248192 NOTICE: Closing video stream 22:45:17 T:140652998248192 NOTICE: waiting for video thread to exit 22:45:17 T:140652989855488 NOTICE: thread end: video_thread 22:45:17 T:140652998248192 NOTICE: deleting video codec 22:45:17 T:140652998248192 NOTICE: CDVDPlayer::OnExit() deleting demuxer 22:45:17 T:140652998248192 NOTICE: CDVDPlayer::OnExit() deleting input stream 22:45:17 T:140653116098464 NOTICE: DVDPlayer: finished waiting 22:45:17 T:140653116098464 NOTICE: CDVDPlayer::CloseFile() 22:45:17 T:140653116098464 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 22:45:17 T:140653116098464 NOTICE: DVDPlayer: waiting for threads to exit 22:45:17 T:140653116098464 NOTICE: DVDPlayer: finished waiting 22:45:42 T:140652809049856 ERROR: GetDirectory - Error getting /mnt/storage/lost+found/ 22:45:49 T:140653116098464 NOTICE: DVDPlayer: Opening: /mnt/storage/Movies/American.Psycho.2000.576p.BluRay.x264-XTSF/!sample/!sample.mkv 22:45:49 T:140653116098464 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 22:45:49 T:140652956313344 NOTICE: Creating InputStream 22:45:49 T:140652956313344 NOTICE: Creating Demuxer 22:45:49 T:140652956313344 NOTICE: Opening video stream: 0 source: 256 22:45:49 T:140652956313344 NOTICE: Creating video codec with codec id: 28 22:45:49 T:140652956313344 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 22:45:49 T:140652956313344 NOTICE: Creating video thread 22:45:49 T:140652956313344 NOTICE: Opening audio stream: 1 source: 256 22:45:49 T:140652724287232 NOTICE: running thread: video_thread 22:45:49 T:140652956313344 NOTICE: Finding audio codec for: 86019 22:45:49 T:140652956313344 NOTICE: Creating audio thread 22:45:49 T:140652705003264 NOTICE: running thread: CDVDPlayerAudio::Process() 22:45:49 T:140652705003264 NOTICE: Creating audio device with codec id: 86019, channels: 2, sample rate: 48000, pass-through 22:45:56 T:140652705003264 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
