All pastes #1508192 Raw Edit

Digital Audio Problems

public text v1 · immutable
#1508192 ·published 2009-07-27 01:02 UTC
rendered paste body
20:30:07 T:3548 M:1822765056  NOTICE: -----------------------------------------------------------------------
20:30:07 T:3548 M:1822728192  NOTICE: Starting XBMC, Platform: Windows XP Professional Service Pack 3 build 2600.  Built on Jun  2 2009 (SVN:20672, compiler 1500)
20:30:07 T:3548 M:1822728192  NOTICE:                   Intel(R) Xeon(TM) CPU 2.66GHz
20:30:07 T:3548 M:1822728192  NOTICE: Desktop Resolution: 1864x1048 32Bit at 60Hz
20:30:07 T:3548 M:1822728192  NOTICE: special://xbmc/ is mapped to: C:\Program Files\XBMC
20:30:07 T:3548 M:1822728192  NOTICE: special://masterprofile/ is mapped to: C:\Documents and Settings\Administrator\Application Data\XBMC\userdata
20:30:07 T:3548 M:1822728192  NOTICE: special://home/ is mapped to: C:\Documents and Settings\Administrator\Application Data\XBMC
20:30:07 T:3548 M:1822728192  NOTICE: special://temp/ is mapped to: C:\Documents and Settings\Administrator\Application Data\XBMC\cache
20:30:07 T:3548 M:1822728192  NOTICE: The executable running is: C:\Program Files\XBMC\XBMC.exe
20:30:07 T:3548 M:1822728192  NOTICE: Log File is located: C:\Documents and Settings\Administrator\Application Data\XBMC\xbmc.log
20:30:07 T:3548 M:1822728192  NOTICE: -----------------------------------------------------------------------
20:30:07 T:3548 M:1822707712  NOTICE: Setup SDL
20:30:07 T:3548 M:1821999104  NOTICE: load settings...
20:30:07 T:3548 M:1821966336  NOTICE: special://profile/ is mapped to: special://masterprofile/
20:30:07 T:3548 M:1821958144  NOTICE: loading special://masterprofile/guisettings.xml
20:30:07 T:3548 M:1821536256  NOTICE: Getting hardware information now...
20:30:07 T:3548 M:1821532160  NOTICE: Checking resolution 10
20:30:07 T:3548 M:1821532160  NOTICE: Setting autoresolution mode 12
20:30:07 T:3548 M:1821507584  NOTICE: No advancedsettings.xml to load (special://masterprofile/advancedsettings.xml)
20:30:07 T:3548 M:1821503488  NOTICE: Default DVD Player: dvdplayer
20:30:07 T:3548 M:1821503488  NOTICE: Default Video Player: dvdplayer
20:30:07 T:3548 M:1821503488  NOTICE: Default Audio Player: paplayer
20:30:07 T:3548 M:1821548544  NOTICE: special://masterprofile/sources.xml
20:30:07 T:3548 M:1808535552  NOTICE: GL_VENDOR = NVIDIA Corporation
20:30:07 T:3548 M:1808535552  NOTICE: GL_RENDERER = GeForce 6200/AGP/SSE2
20:30:07 T:3548 M:1808535552  NOTICE: GL_VERSION = 2.1.2
20:30:07 T:3548 M:1808535552  NOTICE: GL_EXTENSIONS = GL_ARB_color_buffer_float GL_ARB_depth_texture GL_ARB_draw_buffers GL_ARB_fragment_program GL_ARB_fragment_program_shadow GL_ARB_fragment_shader GL_ARB_half_float_pixel GL_ARB_half_float_vertex GL_ARB_framebuffer_object GL_ARB_imaging GL_ARB_multisample GL_ARB_multitexture GL_ARB_occlusion_query GL_ARB_pixel_buffer_object GL_ARB_point_parameters GL_ARB_point_sprite GL_ARB_shadow GL_ARB_shader_objects GL_ARB_shading_language_100 GL_ARB_texture_border_clamp GL_ARB_texture_compression GL_ARB_texture_cube_map GL_ARB_texture_env_add GL_ARB_texture_env_combine GL_ARB_texture_env_dot3 GL_ARB_texture_float GL_ARB_texture_mirrored_repeat GL_ARB_texture_non_power_of_two GL_ARB_texture_rectangle GL_ARB_transpose_matrix GL_ARB_vertex_array_object GL_ARB_vertex_buffer_object GL_ARB_vertex_program GL_ARB_vertex_shader GL_ARB_window_pos GL_ATI_draw_buffers GL_ATI_texture_float GL_ATI_texture_mirror_once GL_S3_s3tc GL_EXT_texture_env_add GL_EXT_abgr GL_EXT_bgra GL_EXT_blend_color GL_EXT_blend_equation_separate GL_EXT_blend_func_separate GL_EXT_blend_minmax GL_EXT_blend_subtract GL_EXT_compiled_vertex_array GL_EXT_Cg_shader GL_EXT_depth_bounds_test GL_EXT_direct_state_access GL_EXT_draw_range_elements GL_EXT_fog_coord GL_EXT_framebuffer_blit GL_EXT_framebuffer_multisample GL_EXT_framebuffer_object GL_EXT_gpu_program_parameters GL_EXT_multi_draw_arrays GL_EXT_packed_depth_stencil GL_EXT_packed_pixels GL_EXT_pixel_buffer_object GL_EXT_point_parameters GL_EXT_rescale_normal GL_EXT_secondary_color GL_EXT_separate_specular_color GL_EXT_shadow_funcs GL_EXT_stencil_two_side GL_EXT_stencil_wrap GL_EXT_texture3D GL_EXT_texture_compression_s3tc GL_EXT_texture_cube_map GL_EXT_texture_edge_clamp GL_EXT_texture_env_combine GL_EXT_texture_env_dot3 GL_EXT_texture_filter_anisotropic GL_EXT_texture_lod GL_EXT_texture_lod_bias GL_EXT_texture_mirror_clamp GL_EXT_texture_object GL_EXT_texture_sRGB GL_EXT_timer_query GL_EXT_vertex_array GL_EXT_vertex_array_bgra GL_IBM_rasterpos_clip GL_IBM_texture_mirrored_repeat GL_KTX_buffer_region GL_NV_blend_square GL_NV_copy_depth_to_color GL_NV_depth_clamp GL_NV_fence GL_NV_float_buffer GL_NV_fog_distance GL_NV_fragment_program GL_NV_fragment_program_option GL_NV_fragment_program2 GL_NV_framebuffer_multisample_coverage GL_NV_half_float GL_NV_light_max_exponent GL_NV_multisample_filter_hint GL_NV_occlusion_query GL_NV_packed_depth_stencil GL_NV_pixel_data_range GL_NV_point_sprite GL_NV_primitive_restart GL_NV_register_combiners GL_NV_register_combiners2 GL_NV_texgen_reflection GL_NV_texture_compression_vtc GL_NV_texture_env_combine4 GL_NV_texture_expand_normal GL_NV_texture_rectangle GL_NV_texture_shader GL_NV_texture_shader2 GL_NV_texture_shader3 GL_NV_vertex_array_range GL_NV_vertex_array_range2 GL_NV_vertex_program GL_NV_vertex_program1_1 GL_NV_vertex_program2 GL_NV_vertex_program2_option GL_NV_vertex_program3 GL_NVX_conditional_render GL_SGIS_generate_mipmap GL_SGIS_texture_lod GL_SGIX_depth_texture GL_SGIX_shadow GL_SUN_slice_accum GL_WIN_swap_hint WGL_EXT_swap_control
20:30:08 T:3548 M:1805385728  NOTICE: start dvd mediatype detection
20:30:08 T:3548 M:1805369344  NOTICE: initializing playlistplayer
20:30:08 T:3548 M:1805361152  NOTICE: DONE initializing playlistplayer
20:30:08 T:3548 M:1805324288  NOTICE: load default skin:[MediaStream]
20:30:08 T:3548 M:1790578688   ERROR: Window Translator: Can't find window settingscategory
20:30:08 T:3548 M:1790554112   ERROR: Error evaluating boolean expression !Window.Previous(0) + !Window.Previous(SettingsCategory) + !Window.Previous(1001) + !Window.Previous(130) + !Window.Previous(34)
20:30:09 T:3548 M:1779789824  NOTICE: initialize done
20:30:09 T:3548 M:1780240384  NOTICE: Running the application...
20:30:09 T:3548 M:1780023296  NOTICE: Webserver: Starting...
20:30:09 T:3656 M:1779646464  NOTICE: Webserver: Started
20:30:09 T:3548 M:1779593216  NOTICE: ES: Starting event server
20:30:09 T:3664 M:1779499008  NOTICE: ES: Starting UDP Event server on 127.0.0.1:9777
20:30:09 T:3664 M:1779478528  NOTICE: UDP: Listening on port 9777
20:30:36 T:3548 M:1770971136  NOTICE: Enabled debug logging due to GUI setting
20:30:39 T:3548 M:1771806720   DEBUG: SDLKeyboard: scancode: 0, sym: 8, unicode: 8, modifier: 0
20:30:39 T:3548 M:1771806720   DEBUG: CApplication::OnKey: 61448 pressed, action is 10
20:30:39 T:3548 M:1773088768   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
20:30:39 T:3548 M:1779363840   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
20:30:39 T:3548 M:1779363840    INFO: Loading skin file: Home.xml
20:30:39 T:3548 M:1779351552   DEBUG: Load Home.xml: 82.47ms
20:30:39 T:3548 M:1779343360   DEBUG: Alloc resources: 82.84ms (82.71 ms skin load, 0.09 ms preload)
20:30:40 T:3548 M:1768374272    INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://xoap.weather.com (easy=034C3B90, multi=034C2540)
20:30:40 T:3548 M:1768366080    INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://www.google.com (easy=05233630, multi=00000000)
20:30:40 T:3548 M:1768054784    INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://feeds.feedburner.com (easy=0523E978, multi=05232390)
20:30:42 T:3548 M:1768529920   DEBUG: SDLKeyboard: scancode: 0, sym: 273, unicode: 0, modifier: 0
20:30:42 T:3548 M:1768529920   DEBUG: CApplication::OnKey: 61478 pressed, action is 3
20:30:43 T:3548 M:1765720064   DEBUG: SDLKeyboard: scancode: 0, sym: 273, unicode: 0, modifier: 0
20:30:43 T:3548 M:1765720064   DEBUG: CApplication::OnKey: 61478 pressed, action is 3
20:30:43 T:3548 M:1763037184   DEBUG: SDLKeyboard: scancode: 0, sym: 273, unicode: 0, modifier: 0
20:30:43 T:3548 M:1763037184   DEBUG: CApplication::OnKey: 61478 pressed, action is 3
20:30:44 T:3548 M:1759862784   DEBUG: SDLKeyboard: scancode: 0, sym: 273, unicode: 0, modifier: 0
20:30:44 T:3548 M:1759862784   DEBUG: CApplication::OnKey: 61478 pressed, action is 3
20:30:45 T:3548 M:1755385856   DEBUG: SDLKeyboard: scancode: 0, sym: 273, unicode: 0, modifier: 0
20:30:45 T:3548 M:1755385856   DEBUG: CApplication::OnKey: 61478 pressed, action is 3
20:30:46 T:3548 M:1752379392   DEBUG: SDLKeyboard: scancode: 0, sym: 273, unicode: 0, modifier: 0
20:30:46 T:3548 M:1752379392   DEBUG: CApplication::OnKey: 61478 pressed, action is 3
20:30:48 T:3548 M:1747787776   DEBUG: SDLKeyboard: scancode: 0, sym: 13, unicode: 13, modifier: 0
20:30:48 T:3548 M:1747787776   DEBUG: CApplication::OnKey: 61453 pressed, action is 7
20:30:48 T:3548 M:1747951616   DEBUG: CApplication::OnMessage : Translating XBMC.ActivateWindow(MyVideoLibrary,movietitles,return)
20:30:48 T:3548 M:1747951616   DEBUG: CApplication::OnMessage : To XBMC.ActivateWindow(MyVideoLibrary,movietitles,return)
20:30:48 T:3548 M:1747951616   DEBUG: Activating window ID: 10025
20:30:48 T:3548 M:1747951616   DEBUG: Checking if window ID 10024 is locked.
20:30:49 T:3548 M:1775767552    INFO: Attempting to return to: movietitles
20:30:49 T:3548 M:1775173632    INFO: Loading skin file: MyVideoNav.xml
20:30:49 T:3548 M:1767972864   DEBUG: Load MyVideoNav.xml: 716.68ms
20:30:49 T:3548 M:1767919616   DEBUG: Alloc resources: 779.21ms (716.82 ms skin load, 3.03 ms preload)
20:30:49 T:3548 M:1767911424   DEBUG: CGUIMediaWindow::GetDirectory (videodb://1/2/)
20:30:49 T:3548 M:1767911424   DEBUG:   ParentPath = [videodb://1/2/]
20:30:49 T:3548 M:1767899136   DEBUG: CVideoDatabase::GetMoviesByWhere query: select * from movieview
20:30:49 T:3548 M:1767612416   DEBUG: Time for actual SQL query = 10
20:30:50 T:3548 M:1767591936   DEBUG: Time to retrieve movies from dataset = 102
20:30:50 T:3548 M:1767546880   DEBUG: CFileItemList::Sort, sorting took 0 millis
20:30:50 T:3548 M:1767546880   DEBUG: Saving fileitems [videodb://1/2/]
20:30:50 T:3548 M:1767288832   DEBUG:   -- items: 144, sort method: 2, ascending: true
20:30:50 T:3740 M:1766981632   DEBUG: thread start, auto delete: 0
20:30:50 T:3748 M:1766948864   DEBUG: thread start, auto delete: 0
20:30:50 T:3736 M:1766936576   DEBUG: thread start, auto delete: 0
20:30:50 T:3744 M:1766924288   DEBUG: thread start, auto delete: 0
20:30:50 T:3752 M:1766895616   DEBUG: thread start, auto delete: 0
20:30:50 T:3740 M:1762267136   DEBUG: Thread 3740 terminating
20:30:50 T:3748 M:1761796096   DEBUG: Thread 3748 terminating
20:30:50 T:3752 M:1763127296   DEBUG: Thread 3752 terminating
20:30:50 T:3736 M:1763352576   DEBUG: Thread 3736 terminating
20:30:50 T:3744 M:1763385344   DEBUG: Thread 3744 terminating
20:30:50 T:3764 M:1757765632   DEBUG: thread start, auto delete: 0
20:30:50 T:3764 M:1757761536   DEBUG: Win32DllLoader::Load(special://xbmc/system/ImageLib.dll)
20:30:50 T:3764 M:1756831744   DEBUG: LoadLibraryA('MSVCR71.dll')
20:30:50 T:3764 M:1756831744   DEBUG: LoadLibrary('MSVCR71.dll') returning: 04A990E0
20:30:50 T:3764 M:1756831744   DEBUG: LoadLibraryA('MSVCP71.dll')
20:30:50 T:3764 M:1756753920   DEBUG: Win32DllLoader::Load(MSVCP71.dll)
20:30:50 T:3764 M:1756753920   DEBUG: LoadLibraryA('MSVCR71.dll')
20:30:50 T:3764 M:1756749824   DEBUG: LoadLibrary('MSVCR71.dll') returning: 04A990E0
20:30:50 T:3764 M:1756749824   DEBUG: LoadLibrary('MSVCP71.dll') returning: 04AC9ED0
20:30:51 T:3764 M:1747415040   DEBUG: PICTURE: loaded image and created texture. height: 1048, width: 1864
20:30:51 T:3764 M:1753280512   DEBUG: Thread 3764 terminating
20:30:52 T:3548 M:1753780224   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:30:52 T:3548 M:1753780224   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:30:52 T:3772 M:1753743360   DEBUG: thread start, auto delete: 0
20:30:52 T:3548 M:1746452480   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:30:52 T:3548 M:1746452480   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:30:53 T:3772 M:1740431360   DEBUG: PICTURE: loaded image and created texture. height: 1048, width: 1864
20:30:53 T:3548 M:1749643264   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:30:53 T:3548 M:1749643264   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:30:54 T:3772 M:1740357632   DEBUG: PICTURE: loaded image and created texture. height: 1048, width: 1864
20:30:54 T:3772 M:1747443712   DEBUG: PICTURE: loaded image and created texture. height: 720, width: 1280
20:30:54 T:3548 M:1746583552   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:30:54 T:3548 M:1746583552   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:30:54 T:3772 M:1746558976   DEBUG: Thread 3772 terminating
20:30:54 T:3548 M:1747484672   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:30:54 T:3548 M:1747484672   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:30:55 T:3776 M:1747472384   DEBUG: thread start, auto delete: 0
20:30:55 T:3548 M:1744756736   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:30:55 T:3548 M:1744752640   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:30:55 T:3776 M:1740959744   DEBUG: PICTURE: loaded image and created texture. height: 1048, width: 1864
20:30:56 T:3548 M:1747730432   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:30:56 T:3548 M:1747722240   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:30:56 T:3776 M:1741680640   DEBUG: PICTURE: loaded image and created texture. height: 1048, width: 1864
20:30:57 T:3548 M:1747787776   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:30:57 T:3548 M:1747787776   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:30:57 T:3776 M:1745457152   DEBUG: PICTURE: loaded image and created texture. height: 1048, width: 1864
20:30:57 T:3548 M:1750257664   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:30:57 T:3548 M:1750253568   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:30:58 T:3776 M:1745362944   DEBUG: PICTURE: loaded image and created texture. height: 1048, width: 1864
20:30:58 T:3776 M:1745805312   DEBUG: PICTURE: loaded image and created texture. height: 1048, width: 1864
20:30:58 T:3548 M:1744850944   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:30:58 T:3548 M:1744437248   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:30:58 T:3776 M:1751646208   DEBUG: Thread 3776 terminating
20:30:58 T:3784 M:1751756800   DEBUG: thread start, auto delete: 0
20:30:59 T:3548 M:1741668352   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:30:59 T:3548 M:1741668352   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:30:59 T:3784 M:1738399744   DEBUG: PICTURE: loaded image and created texture. height: 1048, width: 1864
20:31:00 T:3548 M:1746173952   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:31:00 T:3548 M:1746173952   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:31:00 T:3784 M:1742856192   DEBUG: PICTURE: loaded image and created texture. height: 1048, width: 1864
20:31:00 T:3548 M:1751044096   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:31:00 T:3548 M:1751044096   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:31:01 T:3784 M:1744105472   DEBUG: PICTURE: loaded image and created texture. height: 1048, width: 1864
20:31:01 T:3784 M:1749962752   DEBUG: Thread 3784 terminating
20:31:01 T:3548 M:1757908992   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:31:01 T:3548 M:1757908992   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:31:01 T:3788 M:1757900800   DEBUG: thread start, auto delete: 0
20:31:01 T:3788 M:1751527424   DEBUG: PICTURE: loaded image and created texture. height: 719, width: 1280
20:31:01 T:3788 M:1754292224   DEBUG: Thread 3788 terminating
20:31:02 T:3548 M:1753858048   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:31:02 T:3548 M:1753858048   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:31:02 T:3800 M:1754030080   DEBUG: thread start, auto delete: 0
20:31:02 T:3800 M:1747394560   DEBUG: PICTURE: loaded image and created texture. height: 720, width: 1280
20:31:02 T:3800 M:1750085632   DEBUG: Thread 3800 terminating
20:31:02 T:3548 M:1748451328   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:31:02 T:3548 M:1748451328   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:31:02 T:3804 M:1748414464   DEBUG: thread start, auto delete: 0
20:31:03 T:3804 M:1741545472   DEBUG: PICTURE: loaded image and created texture. height: 720, width: 1280
20:31:03 T:3804 M:1744396288   DEBUG: Thread 3804 terminating
20:31:03 T:3548 M:1750487040   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:31:03 T:3548 M:1750487040   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:31:03 T:3808 M:1750454272   DEBUG: thread start, auto delete: 0
20:31:03 T:3808 M:1743437824   DEBUG: PICTURE: loaded image and created texture. height: 720, width: 1280
20:31:03 T:3808 M:1746210816   DEBUG: Thread 3808 terminating
20:31:05 T:3548 M:1753219072   DEBUG: SDLKeyboard: scancode: 0, sym: 13, unicode: 13, modifier: 0
20:31:05 T:3548 M:1753219072   DEBUG: CApplication::OnKey: 61453 pressed, action is 7
20:31:05 T:3548 M:1753042944    INFO: Loading skin file: DialogContextMenu.xml
20:31:05 T:3548 M:1753038848   DEBUG: Load DialogContextMenu.xml: 8.37ms
20:31:05 T:3548 M:1753038848   DEBUG: Alloc resources: 0.26ms (0.00 ms skin load, 0.20 ms preload)
20:31:05 T:3548 M:1753038848   DEBUG: CApplication::OnMessage : Translating -
20:31:05 T:3548 M:1753038848   DEBUG: CApplication::OnMessage : To -
20:31:05 T:3548 M:1753038848   ERROR: Keymapping error: no such action '-' defined
20:31:07 T:3548 M:1756893184   DEBUG: SDLKeyboard: scancode: 0, sym: 13, unicode: 13, modifier: 0
20:31:07 T:3548 M:1756893184   DEBUG: CApplication::OnKey: 61453 pressed, action is 7
20:31:07 T:3548 M:1756786688   DEBUG: CPlayerCoreFactory::GetPlayers(smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img)
20:31:07 T:3548 M:1756729344  NOTICE: DVDPlayer: Opening: smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img
20:31:07 T:3548 M:1756708864 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
20:31:07 T:3816 M:1756708864   DEBUG: thread start, auto delete: 1
20:31:07 T:3820 M:1756696576   DEBUG: thread start, auto delete: 0
20:31:07 T:3820 M:1756688384  NOTICE: Creating InputStream
20:31:07 T:3820 M:1756676096   DEBUG: Win32DllLoader::Load(special://xbmc/system/players/dvdplayer/libdvdnav.dll)
20:31:07 T:3820 M:1756602368   DEBUG: LoadLibraryA('libdvdcss-2.dll')
20:31:07 T:3820 M:1756602368   DEBUG: Win32DllLoader::Load(special://xbmc/system/players/dvdplayer/libdvdcss-2.dll)
20:31:07 T:3820 M:1756598272   DEBUG: LoadLibrary('libdvdcss-2.dll') returning: 04DCEA68
20:31:07 T:3820 M:1756581888    INFO:   msg: libdvdnav: Using dvdnav version SVN-r19116
20:31:07 T:3820 M:1756565504    INFO:   msg: libdvdread: Using libdvdcss version 1.2.10 for DVD access
20:31:07 T:3820 M:1756536832 WARNING: WARNING: File is larger than 32bit stat can handle, file size will be reported as 0 bytes
20:31:07 T:3820 M:1756508160   DEBUG: libdvdcss debug:
20:31:07 T:3820 M:1756508160    INFO:   msg: opening target `smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img'
20:31:07 T:3820 M:1756508160   DEBUG:   msg:
20:31:07 T:3820 M:1756508160   DEBUG: libdvdcss debug:
20:31:07 T:3820 M:1756508160   DEBUG: using libc for access
20:31:07 T:3820 M:1756508160   DEBUG:   msg:
20:31:07 T:3820 M:1756696576    INFO:   msg: libdvdcss error: failed creating cache directory
20:31:07 T:3820 M:1756688384    INFO:   msg: libdvdnav: vm: DVD Title: BATMAN_THE_DARK_KNIGHT
20:31:07 T:3820 M:1756684288   DEBUG: libdvdnav: Unable to find home directory
20:31:07 T:3820 M:1756590080    INFO:   msg: libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions:
20:31:07 T:3820 M:1756590080    INFO:   msg:  1
20:31:07 T:3820 M:1756585984    INFO:   msg:  2
20:31:07 T:3820 M:1756585984    INFO:   msg:  3
20:31:07 T:3820 M:1756585984    INFO:   msg:  4
20:31:07 T:3820 M:1756585984    INFO:   msg:  5
20:31:07 T:3820 M:1756585984    INFO:   msg:  6
20:31:07 T:3820 M:1756585984    INFO:   msg:  7
20:31:07 T:3820 M:1756585984    INFO:   msg:  8
20:31:07 T:3820 M:1756585984   DEBUG:   msg:
20:31:07 T:3820 M:1756561408   DEBUG: CDVDInputStreamNavigator::Open - Setting region mask ff
20:31:07 T:3820 M:1756561408  NOTICE: DVDPlayer: playing a dvd with menu's
20:31:07 T:3820 M:1756553216 WARNING: CDVDInputStreamNavigator::SetNavigatorState - Failed to set state (Virtual DVD machine not started.), retrying after read
20:31:07 T:3820 M:1756418048    INFO:   msg: libdvdnav: Language 'en' not found, using 'ÿÿ' instead
20:31:07 T:3820 M:1756418048   DEBUG: libdvdnav: Menu Languages available:
20:31:07 T:3820 M:1756418048    INFO:   msg: ÿÿ
20:31:07 T:3820 M:1756418048   DEBUG:   msg:
20:31:07 T:3820 M:1756176384   DEBUG: DVDNAV_HIGHLIGHT: Highlight button 1
20:31:07 T:3820 M:1756176384   DEBUG:  - DVDNAV_VTS_CHANGE (HOLDING)
20:31:07 T:3820 M:1756172288  NOTICE: Creating Demuxer
20:31:07 T:3820 M:1756160000   DEBUG: Win32DllLoader::Load(special://xbmc/system/players/dvdplayer/avutil-49.dll)
20:31:07 T:3820 M:1756241920   DEBUG: Win32DllLoader::Load(special://xbmc/system/players/dvdplayer/avcodec-52.dll)
20:31:07 T:3820 M:1755897856   DEBUG: LoadLibraryA('avutil-49.dll')
20:31:07 T:3820 M:1755897856   DEBUG: LoadLibrary('avutil-49.dll') returning: 04CA7918
20:31:07 T:3820 M:1755885568   DEBUG: Win32DllLoader::Load(special://xbmc/system/players/dvdplayer/avformat-52.dll)
20:31:07 T:3820 M:1755787264   DEBUG: LoadLibraryA('avutil-49.dll')
20:31:07 T:3820 M:1755787264   DEBUG: LoadLibrary('avutil-49.dll') returning: 04CA7918
20:31:07 T:3820 M:1755787264   DEBUG: LoadLibraryA('avcodec-52.dll')
20:31:07 T:3820 M:1755787264   DEBUG: LoadLibrary('avcodec-52.dll') returning: 04CB5640
20:31:07 T:3820 M:1755619328    INFO: ffmpeg: Input #0, mpeg, from 'smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img':
20:31:07 T:3820 M:1755619328    INFO: ffmpeg:   Duration: N/A, bitrate: N/A
20:31:07 T:3820 M:1755607040  NOTICE: Opening audio stream: 0 source: 512
20:31:07 T:3820 M:1755594752    INFO: Loading skin file: DialogProgress.xml
20:31:07 T:3548 M:1755594752   DEBUG: Playback has started
20:31:07 T:3548 M:1755594752    INFO: Loading skin file: VideoOverlay.xml
20:31:07 T:3548 M:1755586560   DEBUG: Load VideoOverlay.xml: 1.49ms
20:31:07 T:3548 M:1755586560   DEBUG: Alloc resources: 1.61ms (1.61 ms skin load, 0.00 ms preload)
20:31:07 T:3548 M:1755586560   DEBUG: CGUIInfoManager::SetCurrentMovie(smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img)
20:31:07 T:3820 M:1755586560   DEBUG: Load DialogProgress.xml: 10.79ms
20:31:07 T:3820 M:1755574272   DEBUG: DVDNAV_VTS_CHANGE
20:31:07 T:3820 M:1755574272    INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
20:31:07 T:3816 M:1755570176   DEBUG: Thread 3816 terminating (autodelete)
20:31:07 T:3820 M:1755602944   DEBUG: DVDNAV_HOP_CHANNEL
20:31:07 T:3820 M:1755602944    INFO: ffmpeg: Input #0, mpeg, from 'smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img':
20:31:07 T:3820 M:1755602944    INFO: ffmpeg:   Duration: N/A, bitrate: N/A
20:31:07 T:3820 M:1755602944 WARNING: CDVDMessageQueue(audio)::Put MSGQ_NOT_INITIALIZED
20:31:07 T:3820 M:1755602944 WARNING: CDVDMessageQueue(video)::Put MSGQ_NOT_INITIALIZED
20:31:07 T:3820 M:1755602944   DEBUG: DVDNAV_VTS_CHANGE
20:31:07 T:3820 M:1755602944    INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
20:31:07 T:3820 M:1755602944   DEBUG: CDVDInputStreamNavigator::ProcessBlock - Cell change: Title 1, Chapter 7
20:31:07 T:3820 M:1755602944   DEBUG: CDVDInputStreamNavigator::ProcessBlock - At position 17% inside the feature
20:31:07 T:3820 M:1755602944   DEBUG: DVDNAV_CELL_CHANGE
20:31:07 T:3820 M:1755598848   DEBUG: DVDNAV_SPU_CLUT_CHANGE
20:31:07 T:3820 M:1755598848   DEBUG: DVDNAV_SPU_STREAM_CHANGE
20:31:07 T:3820 M:1755598848   DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
20:31:07 T:3820 M:1755586560   DEBUG: libdvdcss debug:
20:31:07 T:3820 M:1755586560    INFO:   msg: cracking title key at block 44460
20:31:07 T:3820 M:1755582464   DEBUG:   msg:
20:31:09 T:3820 M:1755414528   DEBUG: libdvdcss debug:
20:31:09 T:3820 M:1755414528   DEBUG: end of title reached
20:31:09 T:3820 M:1755414528   DEBUG:   msg:
20:31:09 T:3820 M:1755414528   DEBUG: libdvdcss debug:
20:31:09 T:3820 M:1755414528    INFO:   msg: successful attempts 0/0, scrambled blocks 0/2000
20:31:09 T:3820 M:1755414528   DEBUG:   msg:
20:31:09 T:3820 M:1755414528   DEBUG: libdvdcss debug:
20:31:09 T:3820 M:1755414528   DEBUG: no scrambled sectors found
20:31:09 T:3820 M:1755414528   DEBUG:   msg:
20:31:09 T:3820 M:1755414528   DEBUG: libdvdcss debug:
20:31:09 T:3820 M:1755414528    INFO:   msg: title key is 00:00:00:00:00
20:31:09 T:3820 M:1755414528   DEBUG:   msg:
20:31:09 T:3820 M:1755414528   DEBUG: libdvdcss debug:
20:31:09 T:3820 M:1755414528   DEBUG: unencrypted title
20:31:09 T:3820 M:1755414528   DEBUG:   msg:
20:31:09 T:3820 M:1755574272   DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:0 TO:1596717333 DIFF:1596717333
20:31:09 T:3820 M:1755549696    INFO: ffmpeg: Input #0, mpeg, from 'smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img':
20:31:09 T:3820 M:1755549696    INFO: ffmpeg:   Duration: N/A, bitrate: N/A
20:31:09 T:3820 M:1754808320  NOTICE: Opening audio stream: 1 source: 256
20:31:09 T:3820 M:1754804224  NOTICE: Finding audio codec for: 86019
20:31:09 T:3820 M:1754796032   DEBUG: FactoryCodec - Audio: passthrough - Opening
20:31:09 T:3820 M:1754796032   DEBUG: Win32DllLoader::Load(special://xbmc/system/players/dvdplayer/liba52.dll)
20:31:09 T:3820 M:1754836992   DEBUG: LoadLibraryA('MSVCR71.dll')
20:31:09 T:3820 M:1754836992   DEBUG: LoadLibrary('MSVCR71.dll') returning: 04A990E0
20:31:09 T:3820 M:1754828800   DEBUG: FactoryCodec - Audio: passthrough - Opened
20:31:09 T:3820 M:1754824704  NOTICE: Creating audio thread
20:31:09 T:3824 M:1754775552   DEBUG: thread start, auto delete: 0
20:31:09 T:3820 M:1754767360  NOTICE: Opening video stream: 0 source: 256
20:31:09 T:3824 M:1754767360  NOTICE: running thread: CDVDPlayerAudio::Process()
20:31:09 T:3820 M:1754767360    INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
20:31:09 T:3824 M:1754767360   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(-44688.888889, 1)
20:31:09 T:3820 M:1754767360  NOTICE: Creating video codec with codec id: 2
20:31:09 T:3820 M:1754755072   DEBUG: FactoryCodec - Video: libmpeg2 - Opening
20:31:09 T:3820 M:1754755072   DEBUG: Win32DllLoader::Load(special://xbmc/system/players/dvdplayer/libmpeg2.dll)
20:31:09 T:3820 M:1754693632   DEBUG: FactoryCodec - Video: libmpeg2 - Opened
20:31:09 T:3820 M:1754693632  NOTICE: Creating video thread
20:31:09 T:3828 M:1754685440   DEBUG: thread start, auto delete: 0
20:31:09 T:3824 M:1754673152   DEBUG: CDVDAudioCodecPassthrough::ParseFrame - source flags changed flags:17 sr:48000 br:384000
20:31:09 T:3824 M:1754673152  NOTICE: Creating audio device with codec id: 86019, channels: 2, sample rate: 48000, pass-through
20:31:09 T:3824 M:1754570752   DEBUG: CWDSound::direct_sound_enumerator_member_callback - found Device: Primary Sound Driver
20:31:09 T:3824 M:1754632192   DEBUG: CWDSound::direct_sound_enumerator_member_callback - found Device: Turtle Beach Riviera Wave
20:31:09 T:3824 M:1754632192   DEBUG: CAudioContext::SetActiveDevice - selecting Turtle Beach Riviera Wave as output devices
20:31:09 T:3828 M:1754554368   DEBUG: Win32DllLoader::Load(special://xbmc/system/players/dvdplayer/swscale-0.6.1.dll)
20:31:09 T:3828 M:1754517504   DEBUG: LoadLibraryA('avutil-49.dll')
20:31:09 T:3828 M:1754517504   DEBUG: LoadLibrary('avutil-49.dll') returning: 04CA7918
20:31:09 T:3828 M:1754509312  NOTICE: running thread: video_thread
20:31:09 T:3828 M:1754509312   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_DELAY(11311.111111)
20:31:09 T:3824 M:1754476544   DEBUG: CWin32DirectSound::Initialize: Packet Size = 12384. Avg Bytes Per Second = 192000.
20:31:09 T:3824 M:1754726400   DEBUG: CWin32DirectSound::Initialize: Couldn't create secondary buffer (DSERR_UNSUPPORTED). Trying without LOCHARDWARE.
20:31:09 T:3824 M:1754726400   DEBUG: CWin32DirectSound::Initialize: Couldn't create secondary buffer (DSERR_INVALIDPARAM). Trying without CTRLVOLUME.
20:31:09 T:3828 M:1754537984   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(-33377.777778, 0)
20:31:09 T:3824 M:1754718208   ERROR: CWin32DirectSound::Initialize: cannot create secondary buffer (DSERR_INVALIDPARAM)
20:31:09 T:3824 M:1754607616   ERROR: Creating a Null Audio Renderer, Check your audio settings as this should not happen
20:31:09 T:3824 M:1753665536   DEBUG: CWDSound::direct_sound_enumerator_member_callback - found Device: Primary Sound Driver
20:31:09 T:3824 M:1753657344   DEBUG: CWDSound::direct_sound_enumerator_member_callback - found Device: Turtle Beach Riviera Wave
20:31:09 T:3824 M:1753657344   DEBUG: CAudioContext::SetActiveDevice - selecting Turtle Beach Riviera Wave as output devices
20:31:09 T:3820 M:1753640960  NOTICE: Opening Subtitle stream: 7 source: 256
20:31:09 T:3820 M:1753628672   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:09 T:3824 M:1752895488   DEBUG: CDVDPlayerAudio:: Discontinuty - was:5311.111111, should be:-12688.886683, error:-17999.997795
20:31:09 T:3824 M:1752895488 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:09 T:3548 M:1752895488   DEBUG: Alloc resources: 0.01ms (0.00 ms skin load, 0.00 ms preload)
20:31:09 T:3828 M:1752895488  NOTICE:  fps: 25.000000, pwidth: 720, pheight: 480, dwidth: 853, dheight: 480
20:31:09 T:3828 M:1752895488   DEBUG: CDVDPlayerVideo::OutputPicture - change configuration. 720x480. framerate: 25.00
20:31:09 T:3828 M:1752895488  NOTICE: Display resolution AUTO : 1864x1048 @ 60.00Hz (Full Screen) (12)
20:31:09 T:3828 M:1752891392 WARNING: Upscale: selected algorithm 1
20:31:09 T:3548 M:1752825856  NOTICE: Using GL_TEXTURE_2D
20:31:09 T:3548 M:1752825856   DEBUG: GL: Requested render method: 0
20:31:09 T:3548 M:1752813568  NOTICE: GL: Selecting YUV 2 RGB Progressive Shader
20:31:09 T:3548 M:1752178688   DEBUG: GL: Shader compilation log:
20:31:09 T:3548 M:1752170496   DEBUG: 
20:31:09 T:3548 M:1752141824   DEBUG: GL: Shader compilation log:
20:31:09 T:3548 M:1752141824   DEBUG: 
20:31:09 T:3548 M:1751969792  NOTICE: GL: NPOT texture support detected
20:31:09 T:3548 M:1751941120   DEBUG: GL: Creating Y NPOT texture of size 720 x 480
20:31:09 T:3548 M:1751941120   DEBUG: GL: Creating U NPOT texture of size 360 x 240
20:31:09 T:3548 M:1751941120   DEBUG: GL: Creating V NPOT texture of size 360 x 240
20:31:09 T:3548 M:1751941120   DEBUG: GL: Creating Y NPOT texture of size 720 x 480
20:31:09 T:3548 M:1751941120   DEBUG: GL: Creating U NPOT texture of size 360 x 120
20:31:09 T:3548 M:1751932928   DEBUG: GL: Creating V NPOT texture of size 360 x 120
20:31:09 T:3548 M:1751924736   DEBUG: GL: Creating Y NPOT texture of size 720 x 480
20:31:09 T:3548 M:1751924736   DEBUG: GL: Creating U NPOT texture of size 360 x 120
20:31:09 T:3548 M:1751916544   DEBUG: GL: Creating V NPOT texture of size 360 x 120
20:31:09 T:3548 M:1751887872   DEBUG: GL: Creating Y NPOT texture of size 720 x 480
20:31:09 T:3548 M:1751814144   DEBUG: GL: Creating U NPOT texture of size 360 x 240
20:31:09 T:3548 M:1751814144   DEBUG: GL: Creating V NPOT texture of size 360 x 240
20:31:09 T:3548 M:1751814144   DEBUG: GL: Creating Y NPOT texture of size 720 x 480
20:31:09 T:3548 M:1751814144   DEBUG: GL: Creating U NPOT texture of size 360 x 120
20:31:09 T:3548 M:1751805952   DEBUG: GL: Creating V NPOT texture of size 360 x 120
20:31:09 T:3548 M:1751797760   DEBUG: GL: Creating Y NPOT texture of size 720 x 480
20:31:09 T:3548 M:1751793664   DEBUG: GL: Creating U NPOT texture of size 360 x 120
20:31:09 T:3548 M:1751785472   DEBUG: GL: Creating V NPOT texture of size 360 x 120
20:31:09 T:3548 M:1750355968   DEBUG: Activating window ID: 12005
20:31:09 T:3548 M:1750351872   DEBUG: Checking if window ID 12005 is locked.
20:31:09 T:3824 M:1751359488 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:09 T:3824 M:1751486464 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:09 T:3548 M:1753186304    INFO: Loading skin file: VideoFullScreen.xml
20:31:09 T:3548 M:1753915392   DEBUG: Load VideoFullScreen.xml: 22.91ms
20:31:09 T:3548 M:1753845760   DEBUG: Alloc resources: 29.43ms (29.40 ms skin load, 0.02 ms preload)
20:31:09 T:3548 M:1753845760    INFO: Loading skin file: VideoOSD.xml
20:31:09 T:3548 M:1754345472   DEBUG: Load VideoOSD.xml: 6.49ms
20:31:09 T:3820 M:1754275840   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:09 T:3824 M:1753862144 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:09 T:3548 M:1753534464   DEBUG: Alloc resources: 47.53ms (0.00 ms skin load, 0.89 ms preload)
20:31:09 T:3548 M:1753624576    INFO: Loading skin file: VideoOSDSettings.xml
20:31:09 T:3548 M:1753456640   DEBUG: Load VideoOSDSettings.xml: 4.33ms
20:31:09 T:3824 M:1752948736 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:09 T:3824 M:1752944640 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:09 T:3548 M:1752514560   DEBUG: Alloc resources: 83.76ms (0.00 ms skin load, 0.91 ms preload)
20:31:09 T:3548 M:1752514560    INFO: Loading skin file: VideoOSDSettings.xml
20:31:09 T:3548 M:1752440832   DEBUG: Load VideoOSDSettings.xml: 4.10ms
20:31:09 T:3548 M:1752440832   DEBUG: Alloc resources: 0.52ms (0.00 ms skin load, 0.21 ms preload)
20:31:09 T:3548 M:1752018944    INFO: GL: ARB Imaging extension supported
20:31:09 T:3824 M:1751519232 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:09 T:3820 M:1751482368   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:09 T:3824 M:1750859776 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:09 T:3828 M:1750577152   DEBUG: CDVDVideoCodecLibMpeg2::m_bFilm = true
20:31:09 T:3824 M:1750192128 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:09 T:3824 M:1750528000 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:09 T:3824 M:1750315008 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:09 T:3824 M:1750069248 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:09 T:3820 M:1749053440   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:10 T:3820 M:1748553728   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:10 T:3824 M:1748979712 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:11 T:3824 M:1749196800 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:11 T:3824 M:1749237760 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:11 T:3824 M:1752395776 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:11 T:3824 M:1752412160 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:13 T:3824 M:1752178688 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:14 T:3824 M:1752543232 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:14 T:3824 M:1752510464 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:14 T:3824 M:1752403968 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:14 T:3820 M:1752395776   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:14 T:3824 M:1752416256 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:15 T:3824 M:1752514560 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:16 T:3824 M:1752350720 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:16 T:3824 M:1752739840 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:16 T:3824 M:1752739840 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:17 T:3824 M:1752653824 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:17 T:3820 M:1752584192   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:17 T:3824 M:1752580096 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:17 T:3824 M:1752514560 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:17 T:3824 M:1752350720 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:18 T:3824 M:1752395776 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:18 T:3548 M:1752739840   DEBUG: SDLKeyboard: scancode: 0, sym: 308, unicode: 0, modifier: 0
20:31:18 T:3548 M:1752764416   DEBUG: SDLKeyboard: scancode: 0, sym: 13, unicode: 13, modifier: 100
20:31:18 T:3548 M:1752764416   DEBUG: CApplication::OnKey: 61453 pressed, action is 24
20:31:18 T:3548 M:1752764416   DEBUG: Alloc resources: 24.88ms (0.00 ms skin load, 0.80 ms preload)
20:31:18 T:3820 M:1750249472   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:18 T:3824 M:1750249472 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:19 T:3548 M:1754267648   DEBUG: SDLKeyboard: scancode: 0, sym: 275, unicode: 0, modifier: 0
20:31:19 T:3548 M:1754267648   DEBUG: CApplication::OnKey: 61479 pressed, action is 2
20:31:19 T:3824 M:1754243072 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:19 T:3824 M:1758969856 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:19 T:3824 M:1758900224 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:19 T:3548 M:1758822400   DEBUG: SDLKeyboard: scancode: 0, sym: 275, unicode: 0, modifier: 0
20:31:19 T:3548 M:1758822400   DEBUG: CApplication::OnKey: 61479 pressed, action is 2
20:31:20 T:3824 M:1758658560 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:20 T:3820 M:1758658560   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:20 T:3824 M:1758654464 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:20 T:3824 M:1758584832 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:20 T:3824 M:1759039488 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:20 T:3548 M:1759031296   DEBUG: SDLKeyboard: scancode: 0, sym: 276, unicode: 0, modifier: 0
20:31:20 T:3548 M:1759031296   DEBUG: CApplication::OnKey: 61477 pressed, action is 1
20:31:21 T:3824 M:1759031296 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:21 T:3820 M:1758859264   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:21 T:3824 M:1758756864 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:21 T:3548 M:1758752768   DEBUG: SDLKeyboard: scancode: 0, sym: 13, unicode: 13, modifier: 0
20:31:21 T:3548 M:1758752768   DEBUG: CApplication::OnKey: 61453 pressed, action is 7
20:31:21 T:3548 M:1758752768   DEBUG: CApplication::OnMessage : Translating XBMC.ActivateWindow(124)
20:31:21 T:3548 M:1758752768   DEBUG: CApplication::OnMessage : To XBMC.ActivateWindow(124)
20:31:21 T:3548 M:1758752768   DEBUG: Activating window ID: 10124
20:31:21 T:3548 M:1758752768   DEBUG: Checking if window ID 10124 is locked.
20:31:21 T:3824 M:1758707712 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:22 T:3824 M:1758875648 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:22 T:3824 M:1758715904 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:22 T:3824 M:1758646272 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:23 T:3548 M:1758642176   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:31:23 T:3548 M:1758642176   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:31:23 T:3820 M:1759219712   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:23 T:3824 M:1759219712 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:23 T:3548 M:1759023104   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:31:23 T:3548 M:1759023104   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:31:23 T:3824 M:1759129600 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:24 T:3824 M:1758969856 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:24 T:3548 M:1759330304   DEBUG: SDLKeyboard: scancode: 0, sym: 13, unicode: 13, modifier: 0
20:31:24 T:3548 M:1759330304   DEBUG: CApplication::OnKey: 61453 pressed, action is 7
20:31:25 T:3824 M:1759125504 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:25 T:3824 M:1759465472 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:25 T:3824 M:1759506432 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:25 T:3824 M:1759346688 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:26 T:3824 M:1759346688 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:26 T:3820 M:1759305728   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:26 T:3824 M:1759784960 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:27 T:3548 M:1759748096   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:31:27 T:3548 M:1759748096   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:31:27 T:3824 M:1759772672 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:27 T:3820 M:1759809536   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:27 T:3548 M:1759809536   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:31:27 T:3548 M:1759809536   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:31:27 T:3824 M:1759809536 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:28 T:3548 M:1759326208   DEBUG: SDLKeyboard: scancode: 0, sym: 13, unicode: 13, modifier: 0
20:31:28 T:3548 M:1759326208   DEBUG: CApplication::OnKey: 61453 pressed, action is 7
20:31:28 T:3548 M:1759322112  NOTICE: DVDPlayer: Opening: smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img
20:31:28 T:3548 M:1759322112  NOTICE: CDVDPlayer::CloseFile()
20:31:28 T:3548 M:1759322112  NOTICE: DVDPlayer: waiting for threads to exit
20:31:28 T:3820 M:1759322112  NOTICE: CDVDPlayer::OnExit()
20:31:28 T:3820 M:1759322112  NOTICE: DVDPlayer: closing audio stream
20:31:28 T:3820 M:1759322112  NOTICE: Closing audio stream
20:31:28 T:3820 M:1759322112  NOTICE: Waiting for audio thread to exit
20:31:28 T:3824 M:1759322112   DEBUG: CDVDPlayerAudio::Process - Abort received, exiting thread
20:31:28 T:3824 M:1759322112  NOTICE: thread end: CDVDPlayerAudio::OnExit()
20:31:28 T:3824 M:1759322112   DEBUG: Thread 3824 terminating
20:31:28 T:3820 M:1759363072  NOTICE: Closing audio device
20:31:28 T:3820 M:1759358976  NOTICE: Deleting audio codec
20:31:28 T:3820 M:1759358976  NOTICE: DVDPlayer: closing video stream
20:31:28 T:3820 M:1759358976  NOTICE: Closing video stream
20:31:28 T:3820 M:1759358976  NOTICE: waiting for video thread to exit
20:31:29 T:3828 M:1759367168  NOTICE: thread end: video_thread
20:31:29 T:3828 M:1759367168   DEBUG: Thread 3828 terminating
20:31:29 T:3820 M:1763139584  NOTICE: deleting video codec
20:31:29 T:3820 M:1765257216  NOTICE: DVDPlayer: closing video stream
20:31:29 T:3820 M:1765257216  NOTICE: Closing subtitle stream
20:31:29 T:3820 M:1765646336  NOTICE: CDVDPlayer::OnExit() deleting demuxer
20:31:29 T:3820 M:1765748736  NOTICE: CDVDPlayer::OnExit() deleting input stream
20:31:29 T:3820 M:1767268352   DEBUG: Thread 3820 terminating
20:31:29 T:3548 M:1767321600  NOTICE: DVDPlayer: finished waiting
20:31:29 T:3548 M:1767317504 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
20:31:29 T:3884 M:1767317504   DEBUG: thread start, auto delete: 1
20:31:29 T:3888 M:1767305216   DEBUG: thread start, auto delete: 0
20:31:29 T:3888 M:1767301120  NOTICE: Creating InputStream
20:31:29 T:3888 M:1767301120    INFO:   msg: libdvdnav: Using dvdnav version SVN-r19116
20:31:29 T:3888 M:1767297024    INFO:   msg: libdvdread: Using libdvdcss version 1.2.10 for DVD access
20:31:29 T:3888 M:1767264256 WARNING: WARNING: File is larger than 32bit stat can handle, file size will be reported as 0 bytes
20:31:29 T:3888 M:1767239680   DEBUG: libdvdcss debug:
20:31:29 T:3888 M:1767239680    INFO:   msg: opening target `smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img'
20:31:29 T:3888 M:1767239680   DEBUG:   msg:
20:31:29 T:3888 M:1767239680   DEBUG: libdvdcss debug:
20:31:29 T:3888 M:1767239680   DEBUG: using libc for access
20:31:29 T:3888 M:1767239680   DEBUG:   msg:
20:31:29 T:3888 M:1767223296    INFO:   msg: libdvdcss error: failed creating cache directory
20:31:29 T:3888 M:1767223296    INFO:   msg: libdvdnav: vm: DVD Title: BATMAN_THE_DARK_KNIGHT
20:31:29 T:3888 M:1767215104   DEBUG: libdvdnav: Unable to find home directory
20:31:29 T:3888 M:1767129088    INFO:   msg: libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions:
20:31:29 T:3888 M:1767129088    INFO:   msg:  1
20:31:29 T:3888 M:1767129088    INFO:   msg:  2
20:31:29 T:3888 M:1767129088    INFO:   msg:  3
20:31:29 T:3888 M:1767129088    INFO:   msg:  4
20:31:29 T:3888 M:1767129088    INFO:   msg:  5
20:31:29 T:3888 M:1767129088    INFO:   msg:  6
20:31:29 T:3888 M:1767129088    INFO:   msg:  7
20:31:29 T:3888 M:1767129088    INFO:   msg:  8
20:31:29 T:3888 M:1767129088   DEBUG:   msg:
20:31:29 T:3888 M:1767124992   DEBUG: CDVDInputStreamNavigator::Open - Setting region mask ff
20:31:29 T:3888 M:1767124992  NOTICE: DVDPlayer: playing a dvd with menu's
20:31:29 T:3888 M:1767124992  NOTICE: Creating Demuxer
20:31:29 T:3888 M:1767092224    INFO:   msg: libdvdnav: Language 'en' not found, using 'ÿÿ' instead
20:31:29 T:3888 M:1767092224   DEBUG: libdvdnav: Menu Languages available:
20:31:29 T:3888 M:1767092224    INFO:   msg: ÿÿ
20:31:29 T:3888 M:1767092224   DEBUG:   msg:
20:31:29 T:3888 M:1766920192   DEBUG: DVDNAV_HIGHLIGHT: Highlight button 1
20:31:29 T:3888 M:1766920192   DEBUG:  - DVDNAV_VTS_CHANGE (HOLDING)
20:31:29 T:3888 M:1766920192    INFO: ffmpeg: Input #0, mpeg, from 'smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img':
20:31:29 T:3888 M:1766920192    INFO: ffmpeg:   Duration: N/A, bitrate: N/A
20:31:29 T:3888 M:1766920192  NOTICE: Opening audio stream: 0 source: 512
20:31:29 T:3888 M:1766920192   DEBUG: DVDNAV_VTS_CHANGE
20:31:29 T:3548 M:1766920192   DEBUG: Playback has started
20:31:29 T:3888 M:1766920192    INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 1
20:31:29 T:3884 M:1766920192   DEBUG: Thread 3884 terminating (autodelete)
20:31:29 T:3548 M:1766932480   DEBUG: CGUIInfoManager::SetCurrentMovie(smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img)
20:31:29 T:3888 M:1766961152   DEBUG: CDVDInputStreamNavigator::ProcessBlock - Cell change: Title 0, Chapter 3
20:31:29 T:3888 M:1766961152   DEBUG: CDVDInputStreamNavigator::ProcessBlock - At position 0% inside the feature
20:31:29 T:3888 M:1766961152   DEBUG: DVDNAV_CELL_CHANGE
20:31:29 T:3888 M:1766961152   DEBUG: DVDNAV_SPU_CLUT_CHANGE
20:31:29 T:3888 M:1766961152   DEBUG: DVDNAV_SPU_STREAM_CHANGE
20:31:29 T:3888 M:1766961152   DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
20:31:29 T:3888 M:1766957056   DEBUG: libdvdcss debug:
20:31:29 T:3888 M:1766957056    INFO:   msg: cracking title key at block 378
20:31:29 T:3888 M:1766957056   DEBUG:   msg:
20:31:30 T:3888 M:1767018496   DEBUG: libdvdcss debug:
20:31:30 T:3888 M:1767018496   DEBUG: end of title reached
20:31:30 T:3888 M:1767018496   DEBUG:   msg:
20:31:30 T:3888 M:1767018496   DEBUG: libdvdcss debug:
20:31:30 T:3888 M:1767018496    INFO:   msg: successful attempts 0/0, scrambled blocks 0/2000
20:31:30 T:3888 M:1767018496   DEBUG:   msg:
20:31:30 T:3888 M:1767018496   DEBUG: libdvdcss debug:
20:31:30 T:3888 M:1767018496   DEBUG: no scrambled sectors found
20:31:30 T:3888 M:1767018496   DEBUG:   msg:
20:31:30 T:3888 M:1767018496   DEBUG: libdvdcss debug:
20:31:30 T:3888 M:1767018496    INFO:   msg: title key is 00:00:00:00:00
20:31:30 T:3888 M:1767018496   DEBUG:   msg:
20:31:30 T:3888 M:1767018496   DEBUG: libdvdcss debug:
20:31:30 T:3888 M:1767018496   DEBUG: unencrypted title
20:31:30 T:3888 M:1767018496   DEBUG:   msg:
20:31:30 T:3888 M:1767010304   DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:0 TO:45500 DIFF:45500
20:31:30 T:3888 M:1766993920    INFO: ffmpeg: Input #0, mpeg, from 'smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img':
20:31:30 T:3888 M:1766993920    INFO: ffmpeg:   Duration: N/A, bitrate: N/A
20:31:30 T:3888 M:1766993920   DEBUG: DVDNAV_HOP_CHANNEL
20:31:30 T:3888 M:1766993920  NOTICE: Opening video stream: 0 source: 256
20:31:30 T:3888 M:1766993920    INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
20:31:30 T:3888 M:1766993920  NOTICE: Creating video codec with codec id: 2
20:31:30 T:3888 M:1766993920   DEBUG: FactoryCodec - Video: libmpeg2 - Opening
20:31:30 T:3888 M:1766981632   DEBUG: FactoryCodec - Video: libmpeg2 - Opened
20:31:30 T:3888 M:1766981632  NOTICE: Creating video thread
20:31:30 T:3888 M:1766973440 WARNING: CDVDMessageQueue(audio)::Put MSGQ_NOT_INITIALIZED
20:31:30 T:3888 M:1766973440   DEBUG:  - DVDNAV_VTS_CHANGE (HOLDING)
20:31:30 T:3892 M:1766973440   DEBUG: thread start, auto delete: 0
20:31:30 T:3888 M:1766969344   DEBUG: DVDNAV_VTS_CHANGE
20:31:30 T:3892 M:1766969344  NOTICE: running thread: video_thread
20:31:30 T:3888 M:1766969344    INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
20:31:30 T:3892 M:1766969344   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(-33366.666667, 1)
20:31:30 T:3892 M:1766969344   DEBUG: (CDVDVideoCodecLibMpeg2::Reset)
20:31:30 T:3888 M:1766903808   DEBUG: CDVDInputStreamNavigator::ProcessBlock - Cell change: Title 1, Chapter 7
20:31:30 T:3888 M:1766903808   DEBUG: CDVDInputStreamNavigator::ProcessBlock - At position 17% inside the feature
20:31:30 T:3888 M:1766903808   DEBUG: DVDNAV_CELL_CHANGE
20:31:30 T:3888 M:1766903808   DEBUG: DVDNAV_SPU_CLUT_CHANGE
20:31:30 T:3888 M:1767309312   DEBUG: DVDNAV_SPU_STREAM_CHANGE
20:31:30 T:3888 M:1767309312   DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
20:31:30 T:3888 M:1767309312   DEBUG: libdvdcss debug:
20:31:30 T:3888 M:1767309312    INFO:   msg: cracking title key at block 44460
20:31:30 T:3888 M:1767309312   DEBUG:   msg:
20:31:30 T:3888 M:1767063552   DEBUG: libdvdcss debug:
20:31:30 T:3888 M:1767055360   DEBUG: end of title reached
20:31:30 T:3888 M:1767055360   DEBUG:   msg:
20:31:30 T:3888 M:1767055360   DEBUG: libdvdcss debug:
20:31:30 T:3888 M:1767055360    INFO:   msg: successful attempts 0/0, scrambled blocks 0/2000
20:31:30 T:3888 M:1767055360   DEBUG:   msg:
20:31:30 T:3888 M:1767059456   DEBUG: libdvdcss debug:
20:31:30 T:3888 M:1767059456   DEBUG: no scrambled sectors found
20:31:30 T:3888 M:1767055360   DEBUG:   msg:
20:31:30 T:3888 M:1767055360   DEBUG: libdvdcss debug:
20:31:30 T:3888 M:1767055360    INFO:   msg: title key is 00:00:00:00:00
20:31:30 T:3888 M:1767059456   DEBUG:   msg:
20:31:30 T:3888 M:1767059456   DEBUG: libdvdcss debug:
20:31:30 T:3888 M:1767055360   DEBUG: unencrypted title
20:31:30 T:3888 M:1767055360   DEBUG:   msg:
20:31:30 T:3888 M:1767051264   DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:546000 TO:1635205777 DIFF:1634659777
20:31:30 T:3888 M:1767043072    INFO: ffmpeg: Input #0, mpeg, from 'smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img':
20:31:30 T:3888 M:1767043072    INFO: ffmpeg:   Duration: N/A, bitrate: N/A
20:31:30 T:3888 M:1766678528  NOTICE: Closing video stream
20:31:30 T:3888 M:1766678528  NOTICE: CDVDMessageQueue(video)::WaitUntilEmpty
20:31:30 T:3892 M:1766678528   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
20:31:30 T:3888 M:1766760448  NOTICE: waiting for video thread to exit
20:31:30 T:3892 M:1766760448   ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true
20:31:30 T:3892 M:1766760448  NOTICE: thread end: video_thread
20:31:30 T:3892 M:1766760448   DEBUG: Thread 3892 terminating
20:31:30 T:3888 M:1766768640  NOTICE: deleting video codec
20:31:30 T:3888 M:1766780928  NOTICE: Opening audio stream: 1 source: 256
20:31:30 T:3888 M:1766780928  NOTICE: Finding audio codec for: 86019
20:31:30 T:3888 M:1766768640   DEBUG: FactoryCodec - Audio: passthrough - Opening
20:31:30 T:3888 M:1766768640   DEBUG: FactoryCodec - Audio: passthrough - Failed
20:31:30 T:3888 M:1766768640   DEBUG: FactoryCodec - Audio: liba52 - Opening
20:31:30 T:3888 M:1766768640   DEBUG: FactoryCodec - Audio: liba52 - Opened
20:31:30 T:3888 M:1766768640  NOTICE: Creating audio thread
20:31:30 T:3896 M:1766731776   DEBUG: thread start, auto delete: 0
20:31:30 T:3896 M:1766744064  NOTICE: running thread: CDVDPlayerAudio::Process()
20:31:30 T:3896 M:1766727680   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(463366.666667, 1)
20:31:30 T:3888 M:1766641664  NOTICE: Opening video stream: 0 source: 256
20:31:30 T:3888 M:1766633472    INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
20:31:30 T:3888 M:1766633472  NOTICE: Creating video codec with codec id: 2
20:31:30 T:3888 M:1766633472   DEBUG: FactoryCodec - Video: libmpeg2 - Opening
20:31:30 T:3888 M:1766617088   DEBUG: FactoryCodec - Video: libmpeg2 - Opened
20:31:30 T:3896 M:1766612992  NOTICE: Creating audio device with codec id: 86019, channels: 6, sample rate: 48000, no pass-through
20:31:30 T:3888 M:1766612992  NOTICE: Creating video thread
20:31:30 T:3896 M:1766584320   DEBUG: CWin32DirectSound::Initialize: Packet Size = 37152. Avg Bytes Per Second = 576000.
20:31:30 T:3896 M:1765986304   DEBUG: CWin32DirectSound::Initialize: secondary buffer created
20:31:30 T:3888 M:1765961728  NOTICE: Opening Subtitle stream: 5 source: 256
20:31:30 T:3888 M:1765924864   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:30 T:3896 M:1765896192   DEBUG: CWin32DirectSound::CheckPlayStatus: Resuming Playback
20:31:30 T:3900 M:1764843520   DEBUG: thread start, auto delete: 0
20:31:30 T:3900 M:1764831232  NOTICE: running thread: video_thread
20:31:30 T:3900 M:1764831232   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_DELAY(3766.666667)
20:31:30 T:3900 M:1764831232   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(467133.333333, 0)
20:31:30 T:3896 M:1762766848 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:30 T:3888 M:1762025472   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:30 T:3900 M:1761734656   DEBUG: CDVDVideoCodecLibMpeg2::m_bFilm = true
20:31:30 T:3888 M:1760186368   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:30 T:3888 M:1759485952   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:31 T:3896 M:1758814208   DEBUG: CDVDPlayerAudio:: Discontinuty - was:1569366.666667, should be:1584116.660945, error:14749.994278
20:31:33 T:3888 M:1758670848   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:33 T:3548 M:1758666752   DEBUG: SECTION:UnloadDelayed(DLL: special://xbmc/system/ImageLib.dll)
20:31:33 T:3548 M:1758666752   DEBUG: Win32DllLoader::Unload ImageLib.dll
20:31:33 T:3548 M:1758662656   DEBUG: FreeLibrary(MSVCR71.dll) -> 04A990E0
20:31:33 T:3548 M:1758662656   DEBUG: FreeLibrary(MSVCP71.dll) -> 04AC9ED0
20:31:33 T:3548 M:1758658560   DEBUG: Win32DllLoader::Unload MSVCP71.dll
20:31:33 T:3548 M:1758658560   DEBUG: FreeLibrary(MSVCR71.dll) -> 04A990E0
20:31:36 T:3548 M:1759105024   DEBUG: SDLKeyboard: scancode: 0, sym: 275, unicode: 0, modifier: 0
20:31:36 T:3548 M:1759105024   DEBUG: CApplication::OnKey: 61479 pressed, action is 2
20:31:38 T:3548 M:1759391744   DEBUG: SDLKeyboard: scancode: 0, sym: 13, unicode: 13, modifier: 0
20:31:38 T:3548 M:1759391744   DEBUG: CApplication::OnKey: 61453 pressed, action is 7
20:31:38 T:3548 M:1759391744  NOTICE: DVDPlayer: Opening: smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img
20:31:38 T:3548 M:1759391744  NOTICE: CDVDPlayer::CloseFile()
20:31:38 T:3548 M:1759391744  NOTICE: DVDPlayer: waiting for threads to exit
20:31:38 T:3888 M:1759391744  NOTICE: CDVDPlayer::OnExit()
20:31:38 T:3888 M:1759391744  NOTICE: DVDPlayer: closing audio stream
20:31:38 T:3888 M:1759391744  NOTICE: Closing audio stream
20:31:38 T:3888 M:1759391744  NOTICE: Waiting for audio thread to exit
20:31:38 T:3896 M:1759391744   ERROR: CDVDAudio::AddPackets - failed to add leftover bytes to render
20:31:38 T:3896 M:1759391744  NOTICE: thread end: CDVDPlayerAudio::OnExit()
20:31:38 T:3896 M:1759391744   DEBUG: Thread 3896 terminating
20:31:38 T:3888 M:1759453184  NOTICE: Closing audio device
20:31:38 T:3888 M:1759453184   DEBUG: CWin32DirectSound::Deinitialize: Cleaning up
20:31:38 T:3888 M:1760063488  NOTICE: Deleting audio codec
20:31:38 T:3888 M:1760063488  NOTICE: DVDPlayer: closing video stream
20:31:38 T:3888 M:1760063488  NOTICE: Closing video stream
20:31:38 T:3888 M:1760063488  NOTICE: waiting for video thread to exit
20:31:38 T:3900 M:1760063488  NOTICE: thread end: video_thread
20:31:38 T:3900 M:1760063488   DEBUG: Thread 3900 terminating
20:31:38 T:3888 M:1764315136  NOTICE: deleting video codec
20:31:38 T:3888 M:1766309888  NOTICE: DVDPlayer: closing video stream
20:31:38 T:3888 M:1766309888  NOTICE: Closing subtitle stream
20:31:38 T:3888 M:1766375424  NOTICE: CDVDPlayer::OnExit() deleting demuxer
20:31:38 T:3888 M:1766445056  NOTICE: CDVDPlayer::OnExit() deleting input stream
20:31:38 T:3888 M:1767895040   DEBUG: Thread 3888 terminating
20:31:38 T:3548 M:1767976960  NOTICE: DVDPlayer: finished waiting
20:31:38 T:3548 M:1767972864 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
20:31:38 T:3912 M:1767968768   DEBUG: thread start, auto delete: 1
20:31:38 T:3916 M:1767956480   DEBUG: thread start, auto delete: 0
20:31:38 T:3916 M:1767952384  NOTICE: Creating InputStream
20:31:38 T:3916 M:1767952384    INFO:   msg: libdvdnav: Using dvdnav version SVN-r19116
20:31:38 T:3916 M:1767948288    INFO:   msg: libdvdread: Using libdvdcss version 1.2.10 for DVD access
20:31:38 T:3916 M:1767919616 WARNING: WARNING: File is larger than 32bit stat can handle, file size will be reported as 0 bytes
20:31:38 T:3916 M:1767895040   DEBUG: libdvdcss debug:
20:31:38 T:3916 M:1767895040    INFO:   msg: opening target `smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img'
20:31:38 T:3916 M:1767895040   DEBUG:   msg:
20:31:38 T:3916 M:1767895040   DEBUG: libdvdcss debug:
20:31:38 T:3916 M:1767895040   DEBUG: using libc for access
20:31:38 T:3916 M:1767895040   DEBUG:   msg:
20:31:38 T:3916 M:1767907328    INFO:   msg: libdvdcss error: failed creating cache directory
20:31:38 T:3916 M:1767907328    INFO:   msg: libdvdnav: vm: DVD Title: BATMAN_THE_DARK_KNIGHT
20:31:38 T:3916 M:1767899136   DEBUG: libdvdnav: Unable to find home directory
20:31:38 T:3916 M:1767813120    INFO:   msg: libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions:
20:31:38 T:3916 M:1767813120    INFO:   msg:  1
20:31:38 T:3916 M:1767813120    INFO:   msg:  2
20:31:38 T:3916 M:1767813120    INFO:   msg:  3
20:31:38 T:3916 M:1767813120    INFO:   msg:  4
20:31:38 T:3916 M:1767813120    INFO:   msg:  5
20:31:38 T:3916 M:1767813120    INFO:   msg:  6
20:31:38 T:3916 M:1767813120    INFO:   msg:  7
20:31:38 T:3916 M:1767809024    INFO:   msg:  8
20:31:38 T:3916 M:1767809024   DEBUG:   msg:
20:31:38 T:3916 M:1767804928   DEBUG: CDVDInputStreamNavigator::Open - Setting region mask ff
20:31:38 T:3916 M:1767804928  NOTICE: DVDPlayer: playing a dvd with menu's
20:31:38 T:3916 M:1767804928  NOTICE: Creating Demuxer
20:31:38 T:3916 M:1767772160    INFO:   msg: libdvdnav: Language 'en' not found, using 'ÿÿ' instead
20:31:38 T:3916 M:1767772160   DEBUG: libdvdnav: Menu Languages available:
20:31:38 T:3916 M:1767772160    INFO:   msg: ÿÿ
20:31:38 T:3916 M:1767772160   DEBUG:   msg:
20:31:38 T:3916 M:1767604224   DEBUG: DVDNAV_HIGHLIGHT: Highlight button 1
20:31:38 T:3916 M:1767600128   DEBUG:  - DVDNAV_VTS_CHANGE (HOLDING)
20:31:38 T:3916 M:1767600128    INFO: ffmpeg: Input #0, mpeg, from 'smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img':
20:31:38 T:3916 M:1767600128    INFO: ffmpeg:   Duration: N/A, bitrate: N/A
20:31:38 T:3916 M:1767600128  NOTICE: Opening audio stream: 0 source: 512
20:31:38 T:3916 M:1767600128   DEBUG: DVDNAV_VTS_CHANGE
20:31:38 T:3916 M:1767600128    INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 1
20:31:38 T:3548 M:1767600128   DEBUG: Playback has started
20:31:38 T:3912 M:1767600128   DEBUG: Thread 3912 terminating (autodelete)
20:31:38 T:3548 M:1767612416   DEBUG: CGUIInfoManager::SetCurrentMovie(smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img)
20:31:38 T:3916 M:1767612416   DEBUG: CDVDInputStreamNavigator::ProcessBlock - Cell change: Title 0, Chapter 3
20:31:38 T:3916 M:1767612416   DEBUG: CDVDInputStreamNavigator::ProcessBlock - At position 0% inside the feature
20:31:38 T:3916 M:1767612416   DEBUG: DVDNAV_CELL_CHANGE
20:31:38 T:3916 M:1767612416   DEBUG: DVDNAV_SPU_CLUT_CHANGE
20:31:38 T:3916 M:1767612416   DEBUG: DVDNAV_SPU_STREAM_CHANGE
20:31:38 T:3916 M:1767612416   DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
20:31:38 T:3916 M:1767612416   DEBUG: libdvdcss debug:
20:31:38 T:3916 M:1767612416    INFO:   msg: cracking title key at block 378
20:31:38 T:3916 M:1767612416   DEBUG:   msg:
20:31:38 T:3916 M:1767649280   DEBUG: libdvdcss debug:
20:31:38 T:3916 M:1767649280   DEBUG: end of title reached
20:31:38 T:3916 M:1767649280   DEBUG:   msg:
20:31:38 T:3916 M:1767649280   DEBUG: libdvdcss debug:
20:31:38 T:3916 M:1767649280    INFO:   msg: successful attempts 0/0, scrambled blocks 0/2000
20:31:38 T:3916 M:1767649280   DEBUG:   msg:
20:31:38 T:3916 M:1767649280   DEBUG: libdvdcss debug:
20:31:38 T:3916 M:1767649280   DEBUG: no scrambled sectors found
20:31:38 T:3916 M:1767649280   DEBUG:   msg:
20:31:38 T:3916 M:1767649280   DEBUG: libdvdcss debug:
20:31:38 T:3916 M:1767649280    INFO:   msg: title key is 00:00:00:00:00
20:31:38 T:3916 M:1767649280   DEBUG:   msg:
20:31:38 T:3916 M:1767649280   DEBUG: libdvdcss debug:
20:31:38 T:3916 M:1767649280   DEBUG: unencrypted title
20:31:38 T:3916 M:1767649280   DEBUG:   msg:
20:31:38 T:3916 M:1767641088   DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:0 TO:45500 DIFF:45500
20:31:38 T:3916 M:1767624704    INFO: ffmpeg: Input #0, mpeg, from 'smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img':
20:31:38 T:3916 M:1767624704    INFO: ffmpeg:   Duration: N/A, bitrate: N/A
20:31:38 T:3916 M:1767624704   DEBUG: DVDNAV_HOP_CHANNEL
20:31:38 T:3916 M:1767624704  NOTICE: Opening video stream: 0 source: 256
20:31:38 T:3916 M:1767624704    INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
20:31:38 T:3916 M:1767624704  NOTICE: Creating video codec with codec id: 2
20:31:38 T:3916 M:1767624704   DEBUG: FactoryCodec - Video: libmpeg2 - Opening
20:31:38 T:3916 M:1767612416   DEBUG: FactoryCodec - Video: libmpeg2 - Opened
20:31:38 T:3916 M:1767612416  NOTICE: Creating video thread
20:31:38 T:3916 M:1767604224 WARNING: CDVDMessageQueue(audio)::Put MSGQ_NOT_INITIALIZED
20:31:38 T:3916 M:1767604224   DEBUG:  - DVDNAV_VTS_CHANGE (HOLDING)
20:31:38 T:3928 M:1767600128   DEBUG: thread start, auto delete: 0
20:31:38 T:3916 M:1767596032   DEBUG: DVDNAV_VTS_CHANGE
20:31:38 T:3928 M:1767596032  NOTICE: running thread: video_thread
20:31:38 T:3916 M:1767596032    INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
20:31:38 T:3928 M:1767596032   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(-33366.666667, 1)
20:31:38 T:3928 M:1767596032   DEBUG: (CDVDVideoCodecLibMpeg2::Reset)
20:31:38 T:3916 M:1767596032   DEBUG: CDVDInputStreamNavigator::ProcessBlock - Cell change: Title 1, Chapter 7
20:31:38 T:3916 M:1767596032   DEBUG: CDVDInputStreamNavigator::ProcessBlock - At position 17% inside the feature
20:31:38 T:3916 M:1767596032   DEBUG: DVDNAV_CELL_CHANGE
20:31:38 T:3916 M:1767596032   DEBUG: DVDNAV_SPU_CLUT_CHANGE
20:31:38 T:3916 M:1767596032   DEBUG: DVDNAV_SPU_STREAM_CHANGE
20:31:38 T:3916 M:1767596032   DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
20:31:38 T:3916 M:1767596032   DEBUG: libdvdcss debug:
20:31:38 T:3916 M:1767596032    INFO:   msg: cracking title key at block 44460
20:31:38 T:3916 M:1767596032   DEBUG:   msg:
20:31:38 T:3916 M:1767342080   DEBUG: libdvdcss debug:
20:31:38 T:3916 M:1767342080   DEBUG: end of title reached
20:31:38 T:3916 M:1767342080   DEBUG:   msg:
20:31:38 T:3916 M:1767342080   DEBUG: libdvdcss debug:
20:31:38 T:3916 M:1767342080    INFO:   msg: successful attempts 0/0, scrambled blocks 0/2000
20:31:38 T:3916 M:1767342080   DEBUG:   msg:
20:31:38 T:3916 M:1767342080   DEBUG: libdvdcss debug:
20:31:38 T:3916 M:1767342080   DEBUG: no scrambled sectors found
20:31:38 T:3916 M:1767342080   DEBUG:   msg:
20:31:38 T:3916 M:1767342080   DEBUG: libdvdcss debug:
20:31:38 T:3916 M:1767342080    INFO:   msg: title key is 00:00:00:00:00
20:31:38 T:3916 M:1767342080   DEBUG:   msg:
20:31:38 T:3916 M:1767342080   DEBUG: libdvdcss debug:
20:31:38 T:3916 M:1767342080   DEBUG: unencrypted title
20:31:38 T:3916 M:1767342080   DEBUG:   msg:
20:31:38 T:3916 M:1767337984   DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:546000 TO:1653941155 DIFF:1653395155
20:31:38 T:3916 M:1767329792    INFO: ffmpeg: Input #0, mpeg, from 'smb://192.168.0.4/f$/Video/Movies/The Dark Knight (2008)/bd-tdknight-dvdr.img':
20:31:38 T:3916 M:1767329792    INFO: ffmpeg:   Duration: N/A, bitrate: N/A
20:31:38 T:3916 M:1766871040  NOTICE: Closing video stream
20:31:38 T:3916 M:1766871040  NOTICE: CDVDMessageQueue(video)::WaitUntilEmpty
20:31:38 T:3928 M:1766871040   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
20:31:38 T:3916 M:1766871040  NOTICE: waiting for video thread to exit
20:31:38 T:3928 M:1766871040   ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true
20:31:38 T:3928 M:1766871040  NOTICE: thread end: video_thread
20:31:38 T:3928 M:1766871040   DEBUG: Thread 3928 terminating
20:31:38 T:3916 M:1766883328  NOTICE: deleting video codec
20:31:38 T:3916 M:1766887424  NOTICE: Opening audio stream: 1 source: 256
20:31:38 T:3916 M:1766887424  NOTICE: Finding audio codec for: 86019
20:31:38 T:3916 M:1766875136   DEBUG: FactoryCodec - Audio: passthrough - Opening
20:31:38 T:3916 M:1766875136   DEBUG: FactoryCodec - Audio: passthrough - Opened
20:31:38 T:3916 M:1766875136  NOTICE: Creating audio thread
20:31:38 T:3932 M:1766789120   DEBUG: thread start, auto delete: 0
20:31:38 T:3932 M:1766723584  NOTICE: running thread: CDVDPlayerAudio::Process()
20:31:38 T:3932 M:1766727680   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(447988.888889, 1)
20:31:38 T:3932 M:1766735872 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:38 T:3932 M:1766707200   DEBUG: CDVDAudioCodecPassthrough::ParseFrame - source flags changed flags:17 sr:48000 br:384000
20:31:38 T:3932 M:1766715392  NOTICE: Creating audio device with codec id: 86019, channels: 2, sample rate: 48000, pass-through
20:31:38 T:3916 M:1766711296  NOTICE: Opening video stream: 0 source: 256
20:31:38 T:3916 M:1766711296    INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
20:31:38 T:3916 M:1766707200  NOTICE: Creating video codec with codec id: 2
20:31:38 T:3916 M:1766707200   DEBUG: FactoryCodec - Video: libmpeg2 - Opening
20:31:38 T:3916 M:1766703104   DEBUG: FactoryCodec - Video: libmpeg2 - Opened
20:31:38 T:3916 M:1766703104  NOTICE: Creating video thread
20:31:38 T:3940 M:1766338560   DEBUG: thread start, auto delete: 0
20:31:38 T:3940 M:1766326272  NOTICE: running thread: video_thread
20:31:38 T:3940 M:1766326272   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_DELAY(19155.555556)
20:31:38 T:3932 M:1766301696   DEBUG: CWDSound::direct_sound_enumerator_member_callback - found Device: Primary Sound Driver
20:31:38 T:3932 M:1766297600   DEBUG: CWDSound::direct_sound_enumerator_member_callback - found Device: Turtle Beach Riviera Wave
20:31:38 T:3932 M:1766297600   DEBUG: CAudioContext::SetActiveDevice - selecting Turtle Beach Riviera Wave as output devices
20:31:38 T:3916 M:1766281216  NOTICE: Opening Subtitle stream: 7 source: 256
20:31:38 T:3916 M:1766268928   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:38 T:3932 M:1765969920   DEBUG: CWin32DirectSound::Initialize: Packet Size = 12384. Avg Bytes Per Second = 192000.
20:31:38 T:3932 M:1765969920   DEBUG: CWin32DirectSound::Initialize: Couldn't create secondary buffer (DSERR_UNSUPPORTED). Trying without LOCHARDWARE.
20:31:38 T:3932 M:1765965824   DEBUG: CWin32DirectSound::Initialize: Couldn't create secondary buffer (DSERR_INVALIDPARAM). Trying without CTRLVOLUME.
20:31:38 T:3932 M:1765900288   ERROR: CWin32DirectSound::Initialize: cannot create secondary buffer (DSERR_INVALIDPARAM)
20:31:38 T:3932 M:1765904384   ERROR: Creating a Null Audio Renderer, Check your audio settings as this should not happen
20:31:38 T:3940 M:1765867520   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(467144.444444, 0)
20:31:38 T:3932 M:1764311040   DEBUG: CWDSound::direct_sound_enumerator_member_callback - found Device: Primary Sound Driver
20:31:38 T:3932 M:1764360192   DEBUG: CWDSound::direct_sound_enumerator_member_callback - found Device: Turtle Beach Riviera Wave
20:31:38 T:3932 M:1764360192   DEBUG: CAudioContext::SetActiveDevice - selecting Turtle Beach Riviera Wave as output devices
20:31:38 T:3932 M:1764327424 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:38 T:3932 M:1763684352 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:38 T:3548 M:1763446784   DEBUG: Alloc resources: 0.01ms (0.00 ms skin load, 0.01 ms preload)
20:31:38 T:3916 M:1763180544   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:39 T:3940 M:1762803712   DEBUG: CDVDVideoCodecLibMpeg2::m_bFilm = true
20:31:39 T:3916 M:1761693696   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:39 T:3932 M:1761320960 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:39 T:3916 M:1761333248   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:39 T:3932 M:1760616448 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:39 T:3932 M:1760657408 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:39 T:3932 M:1760571392 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:40 T:3916 M:1760587776   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:40 T:3932 M:1760509952 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:40 T:3932 M:1760337920 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:41 T:3932 M:1760346112 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:42 T:3932 M:1760108544 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:42 T:3932 M:1760481280 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:42 T:3916 M:1760301056   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:43 T:3932 M:1760387072 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:44 T:3548 M:1760268288   DEBUG: SDLKeyboard: scancode: 0, sym: 8, unicode: 8, modifier: 0
20:31:44 T:3548 M:1760268288   DEBUG: CApplication::OnKey: 61448 pressed, action is 51
20:31:44 T:3916 M:1760022528   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:44 T:3932 M:1760104448 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:45 T:3932 M:1760358400 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:45 T:3548 M:1760198656   DEBUG: SDLKeyboard: scancode: 0, sym: 8, unicode: 8, modifier: 0
20:31:45 T:3548 M:1760198656   DEBUG: CApplication::OnKey: 61448 pressed, action is 51
20:31:45 T:3932 M:1760178176 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:45 T:3932 M:1760210944 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:46 T:3932 M:1760329728 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:47 T:3932 M:1760112640 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:47 T:3916 M:1760620544   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:47 T:3932 M:1760620544 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:47 T:3932 M:1760411648 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:47 T:3548 M:1760411648   DEBUG: SDLKeyboard: scancode: 0, sym: 308, unicode: 0, modifier: 0
20:31:48 T:3548 M:1760411648   DEBUG: SDLKeyboard: scancode: 0, sym: 13, unicode: 13, modifier: 100
20:31:48 T:3548 M:1760411648   DEBUG: CApplication::OnKey: 61453 pressed, action is 24
20:31:48 T:3548 M:1760149504   DEBUG: Alloc resources: 23.71ms (0.00 ms skin load, 0.36 ms preload)
20:31:48 T:3932 M:1760149504 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:48 T:3932 M:1760075776 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:49 T:3932 M:1760010240 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:49 T:3548 M:1760292864   DEBUG: SDLKeyboard: scancode: 0, sym: 276, unicode: 0, modifier: 0
20:31:49 T:3548 M:1760317440   DEBUG: CApplication::OnKey: 61477 pressed, action is 1
20:31:50 T:3932 M:1760256000 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:50 T:3932 M:1760268288 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:50 T:3932 M:1760194560 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:50 T:3548 M:1760034816   DEBUG: SDLKeyboard: scancode: 0, sym: 276, unicode: 0, modifier: 0
20:31:50 T:3548 M:1760034816   DEBUG: CApplication::OnKey: 61477 pressed, action is 1
20:31:50 T:3916 M:1760034816   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:51 T:3548 M:1760358400   DEBUG: SDLKeyboard: scancode: 0, sym: 276, unicode: 0, modifier: 0
20:31:51 T:3548 M:1760354304   DEBUG: CApplication::OnKey: 61477 pressed, action is 1
20:31:52 T:3932 M:1759895552 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:52 T:3932 M:1760219136 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:52 T:3548 M:1760219136   DEBUG: SDLKeyboard: scancode: 0, sym: 276, unicode: 0, modifier: 0
20:31:52 T:3548 M:1760219136   DEBUG: CApplication::OnKey: 61477 pressed, action is 1
20:31:52 T:3932 M:1760223232 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
20:31:53 T:3548 M:1759961088   DEBUG: SDLKeyboard: scancode: 0, sym: 276, unicode: 0, modifier: 0
20:31:53 T:3548 M:1759961088   DEBUG: CApplication::OnKey: 61477 pressed, action is 1
20:31:54 T:3916 M:1760235520   DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
20:31:54 T:3932 M:1760010240   DEBUG: CDVDPlayerAudio:: Discontinuty - was:15896988.888889, should be:15886988.797336, error:-10000.091553
20:31:54 T:3548 M:1760010240   DEBUG: SDLKeyboard: scancode: 0, sym: 13, unicode: 13, modifier: 0
20:31:54 T:3548 M:1760006144   DEBUG: CApplication::OnKey: 61453 pressed, action is 7
20:31:54 T:3548 M:1760006144   DEBUG: CApplication::OnMessage : Translating XBMC.PlayerControl(Stop)
20:31:54 T:3548 M:1760006144   DEBUG: CApplication::OnMessage : To XBMC.PlayerControl(Stop)
20:31:54 T:3548 M:1759776768  NOTICE: CDVDPlayer::CloseFile()
20:31:54 T:3548 M:1759776768  NOTICE: DVDPlayer: waiting for threads to exit
20:31:54 T:3916 M:1759776768  NOTICE: CDVDPlayer::OnExit()
20:31:54 T:3916 M:1759776768  NOTICE: DVDPlayer: closing audio stream
20:31:54 T:3916 M:1759776768  NOTICE: Closing audio stream
20:31:54 T:3916 M:1759776768  NOTICE: Waiting for audio thread to exit
20:31:54 T:3932 M:1759776768   DEBUG: CDVDPlayerAudio::Process - Abort received, exiting thread
20:31:54 T:3932 M:1759776768  NOTICE: thread end: CDVDPlayerAudio::OnExit()
20:31:54 T:3932 M:1759776768   DEBUG: Thread 3932 terminating
20:31:54 T:3916 M:1759821824  NOTICE: Closing audio device
20:31:54 T:3916 M:1759825920  NOTICE: Deleting audio codec
20:31:54 T:3916 M:1759825920  NOTICE: DVDPlayer: closing video stream
20:31:54 T:3916 M:1759825920  NOTICE: Closing video stream
20:31:54 T:3916 M:1759825920  NOTICE: waiting for video thread to exit
20:31:54 T:3940 M:1759825920  NOTICE: thread end: video_thread
20:31:54 T:3940 M:1759825920   DEBUG: Thread 3940 terminating
20:31:54 T:3916 M:1764114432  NOTICE: deleting video codec
20:31:54 T:3916 M:1766199296  NOTICE: DVDPlayer: closing video stream
20:31:54 T:3916 M:1766195200  NOTICE: Closing subtitle stream
20:31:54 T:3916 M:1766416384  NOTICE: CDVDPlayer::OnExit() deleting demuxer
20:31:54 T:3916 M:1766477824  NOTICE: CDVDPlayer::OnExit() deleting input stream
20:31:54 T:3916 M:1768071168   DEBUG: Playback was stopped
20:31:54 T:3916 M:1768071168   DEBUG: Thread 3916 terminating
20:31:54 T:3548 M:1768140800  NOTICE: DVDPlayer: finished waiting
20:31:54 T:3548 M:1768148992  NOTICE: CDVDPlayer::CloseFile()
20:31:54 T:3548 M:1768148992 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
20:31:54 T:3548 M:1768148992  NOTICE: DVDPlayer: waiting for threads to exit
20:31:54 T:3548 M:1768148992  NOTICE: DVDPlayer: finished waiting
20:31:54 T:3548 M:1768288256  NOTICE: CDVDPlayerVideo::~CDVDPlayerVideo - uninitting video device
20:31:54 T:3548 M:1768296448   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
20:31:54 T:3548 M:1770962944   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
20:31:54 T:3548 M:1770962944    INFO: Loading skin file: MyVideoNav.xml
20:31:55 T:3548 M:1767755776   DEBUG: Load MyVideoNav.xml: 1090.72ms
20:31:55 T:3548 M:1767673856   DEBUG: Alloc resources: 1153.00ms (1090.87 ms skin load, 2.78 ms preload)
20:31:55 T:3548 M:1767673856   DEBUG: CGUIMediaWindow::GetDirectory (videodb://1/2/)
20:31:55 T:3548 M:1767673856   DEBUG:   ParentPath = [videodb://1/2/]
20:31:55 T:3548 M:1767673856   DEBUG: Loading fileitems [videodb://1/2/]
20:31:55 T:3548 M:1767419904   DEBUG:   -- items: 144, directory: videodb://1/2/ sort method: 2, ascending: true
20:31:55 T:3548 M:1767358464   DEBUG: CFileItemList::Sort, sorting took 0 millis
20:31:55 T:3548 M:1767424000   DEBUG: Saving fileitems [videodb://1/2/]
20:31:55 T:3548 M:1767424000   DEBUG:   -- items: 144, sort method: 2, ascending: true
20:31:55 T:3980 M:1767411712   DEBUG: thread start, auto delete: 0
20:31:55 T:3984 M:1767399424   DEBUG: thread start, auto delete: 0
20:31:55 T:3988 M:1767387136   DEBUG: thread start, auto delete: 0
20:31:55 T:3992 M:1767362560   DEBUG: thread start, auto delete: 0
20:31:55 T:3996 M:1767346176   DEBUG: thread start, auto delete: 0
20:31:56 T:4000 M:1768300544   DEBUG: thread start, auto delete: 0
20:31:56 T:4000 M:1768226816   DEBUG: Win32DllLoader::Load(special://xbmc/system/ImageLib.dll)
20:31:56 T:4000 M:1767346176   DEBUG: LoadLibraryA('MSVCR71.dll')
20:31:56 T:4000 M:1767346176   DEBUG: LoadLibrary('MSVCR71.dll') returning: 04A990E0
20:31:56 T:4000 M:1767346176   DEBUG: LoadLibraryA('MSVCP71.dll')
20:31:56 T:4000 M:1766219776   DEBUG: Win32DllLoader::Load(MSVCP71.dll)
20:31:56 T:4000 M:1766047744   DEBUG: LoadLibraryA('MSVCR71.dll')
20:31:56 T:4000 M:1765986304   DEBUG: LoadLibrary('MSVCR71.dll') returning: 04A990E0
20:31:56 T:4000 M:1765810176   DEBUG: LoadLibrary('MSVCP71.dll') returning: 04AC8A90
20:31:56 T:3980 M:1759039488   DEBUG: Thread 3980 terminating
20:31:56 T:3996 M:1757720576   DEBUG: Thread 3996 terminating
20:31:56 T:3984 M:1757589504   DEBUG: Thread 3984 terminating
20:31:56 T:3988 M:1757556736   DEBUG: Thread 3988 terminating
20:31:56 T:3992 M:1756418048   DEBUG: Thread 3992 terminating
20:31:56 T:4000 M:1755152384   DEBUG: PICTURE: loaded image and created texture. height: 720, width: 1280
20:31:56 T:4000 M:1757667328   DEBUG: Thread 4000 terminating
20:31:57 T:3548 M:1759416320   DEBUG: SDLKeyboard: scancode: 0, sym: 8, unicode: 8, modifier: 0
20:31:57 T:3548 M:1759416320   DEBUG: CApplication::OnKey: 61448 pressed, action is 9
20:31:57 T:3548 M:1759399936   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
20:31:58 T:3548 M:1767694336   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
20:31:58 T:3548 M:1767694336    INFO: Loading skin file: Home.xml
20:31:58 T:3548 M:1767641088   DEBUG: Load Home.xml: 82.81ms
20:31:58 T:3548 M:1767641088   DEBUG: Alloc resources: 83.60ms (83.31 ms skin load, 0.18 ms preload)
20:32:01 T:3548 M:1760129024   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:32:01 T:3548 M:1760129024   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:32:01 T:3548 M:1755193344   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:32:01 T:3548 M:1755193344   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:32:02 T:3548 M:1752068096   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:32:02 T:3548 M:1752068096   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:32:03 T:3548 M:1747099648   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:32:03 T:3548 M:1747099648   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:32:03 T:3548 M:1744113664   DEBUG: SDLKeyboard: scancode: 0, sym: 274, unicode: 0, modifier: 0
20:32:03 T:3548 M:1744113664   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
20:32:05 T:3548 M:1739730944   DEBUG: SDLKeyboard: scancode: 0, sym: 275, unicode: 0, modifier: 0
20:32:05 T:3548 M:1739730944   DEBUG: CApplication::OnKey: 61479 pressed, action is 2
20:32:06 T:3548 M:1740201984   DEBUG: SDLKeyboard: scancode: 0, sym: 13, unicode: 13, modifier: 0
20:32:06 T:3548 M:1740201984   DEBUG: CApplication::OnKey: 61453 pressed, action is 7
20:32:06 T:3548 M:1740189696   DEBUG: CApplication::OnMessage : Translating XBMC.Shutdown()
20:32:06 T:3548 M:1740189696   DEBUG: CApplication::OnMessage : To XBMC.Shutdown()
20:32:06 T:3548 M:1740201984  NOTICE: Storing total System Uptime
20:32:06 T:3548 M:1740201984  NOTICE: Saving settings
20:32:06 T:3548 M:1740144640  NOTICE: stop all
20:32:06 T:3548 M:1740144640   DEBUG: CNetwork::NetworkMessage - Stopping network services
20:32:06 T:3548 M:1740144640  NOTICE: Webserver: Stopping...
20:32:06 T:3656 M:1740144640   DEBUG: WebServer:Exiting thread sockReady=0, sockSelect=0.
20:32:06 T:3656 M:1740144640   DEBUG: WebServer:OnExit - Exit web server.
20:32:06 T:3656 M:1740156928   DEBUG: Thread 3656 terminating
20:32:06 T:3548 M:1740169216   DEBUG: xbmcHttpShim ends
20:32:06 T:3548 M:1740169216   DEBUG: xbmcHttp ends
20:32:06 T:3548 M:1740169216  NOTICE: Webserver: Stopped...
20:32:06 T:3548 M:1740169216  NOTICE: ES: Stopping event server
20:32:07 T:3664 M:1741119488  NOTICE: ES: UDP Event server stopped
20:32:07 T:3664 M:1741119488   DEBUG: Thread 3664 terminating
20:32:07 T:3548 M:1741139968  NOTICE: stop dvd detect media
20:32:07 T:3604 M:1741139968   DEBUG: Thread 3604 terminating
20:32:07 T:3548 M:1741164544  NOTICE: stop sap announcement listener
20:32:07 T:3548 M:1741164544  NOTICE: clean cached files!
20:32:07 T:3548 M:1741160448  NOTICE: unload skin
20:32:07 T:3548 M:1773142016  NOTICE: stop python
20:32:07 T:3548 M:1773142016  NOTICE: stopped
20:32:07 T:3548 M:1773142016  NOTICE: destroy
20:32:07 T:3548 M:1773146112  NOTICE: unload sections
20:32:07 T:3548 M:1773146112   DEBUG: SECTION:UnloadAll(SECTION: LIBHTTP)
20:32:07 T:3548 M:1773146112   DEBUG: SECTION:UnloadAll(SECTION: LCODE)
20:32:07 T:3548 M:1773146112   DEBUG: SECTION:UnloadAll(DLL: special://xbmc/system/libcurl.dll)
20:32:07 T:3548 M:1773146112   DEBUG: Win32DllLoader::Unload libcurl.dll
20:32:07 T:3548 M:1773146112   DEBUG: FreeLibrary(MSVCR71.dll) -> 04A990E0
20:32:07 T:3548 M:1773711360   DEBUG: SECTION:UnloadAll(DLL: special://xbmc/system/players/dvdplayer/libdvdnav.dll)
20:32:07 T:3548 M:1773711360   DEBUG: Win32DllLoader::Unload libdvdnav.dll
20:32:07 T:3548 M:1773715456   DEBUG: FreeLibrary(libdvdcss-2.dll) -> 04DCEA68
20:32:07 T:3548 M:1773711360   DEBUG: Win32DllLoader::Unload libdvdcss-2.dll
20:32:07 T:3548 M:1773948928   DEBUG: SECTION:UnloadAll(DLL: special://xbmc/system/players/dvdplayer/avutil-49.dll)
20:32:07 T:3548 M:1773948928   DEBUG: SECTION:UnloadAll(DLL: special://xbmc/system/players/dvdplayer/avcodec-52.dll)
20:32:07 T:3548 M:1773948928   DEBUG: SECTION:UnloadAll(DLL: special://xbmc/system/players/dvdplayer/avformat-52.dll)
20:32:07 T:3548 M:1773948928   DEBUG: Win32DllLoader::Unload avformat-52.dll
20:32:07 T:3548 M:1773953024   DEBUG: FreeLibrary(avutil-49.dll) -> 04CA7918
20:32:07 T:3548 M:1773948928   DEBUG: FreeLibrary(avcodec-52.dll) -> 04CB5640
20:32:07 T:3548 M:1773948928   DEBUG: Win32DllLoader::Unload avcodec-52.dll
20:32:07 T:3548 M:1773948928   DEBUG: FreeLibrary(avutil-49.dll) -> 04CA7918
20:32:07 T:3548 M:1774837760   DEBUG: SECTION:UnloadAll(DLL: special://xbmc/system/players/dvdplayer/liba52.dll)
20:32:07 T:3548 M:1774837760   DEBUG: Win32DllLoader::Unload liba52.dll
20:32:07 T:3548 M:1774837760   DEBUG: FreeLibrary(MSVCR71.dll) -> 04A990E0
20:32:07 T:3548 M:1774907392   DEBUG: SECTION:UnloadAll(DLL: special://xbmc/system/players/dvdplayer/libmpeg2.dll)
20:32:07 T:3548 M:1774907392   DEBUG: Win32DllLoader::Unload libmpeg2.dll
20:32:07 T:3548 M:1775001600   DEBUG: SECTION:UnloadAll(DLL: special://xbmc/system/players/dvdplayer/swscale-0.6.1.dll)
20:32:07 T:3548 M:1775001600   DEBUG: Win32DllLoader::Unload swscale-0.6.1.dll
20:32:07 T:3548 M:1775001600   DEBUG: FreeLibrary(avutil-49.dll) -> 04CA7918
20:32:07 T:3548 M:1775001600   DEBUG: Win32DllLoader::Unload avutil-49.dll
20:32:07 T:3548 M:1775099904   DEBUG: SECTION:UnloadAll(DLL: special://xbmc/system/ImageLib.dll)
20:32:07 T:3548 M:1775099904   DEBUG: Win32DllLoader::Unload ImageLib.dll
20:32:07 T:3548 M:1775099904   DEBUG: FreeLibrary(MSVCR71.dll) -> 04A990E0
20:32:07 T:3548 M:1775099904   DEBUG: FreeLibrary(MSVCP71.dll) -> 04AC8A90
20:32:07 T:3548 M:1775099904   DEBUG: Win32DllLoader::Unload MSVCP71.dll
20:32:07 T:3548 M:1775099904   DEBUG: FreeLibrary(MSVCR71.dll) -> 04A990E0
20:32:07 T:3548 M:1775099904   DEBUG: Win32DllLoader::Unload MSVCR71.dll
20:32:07 T:3668 M:1777463296   DEBUG: Audioscrobbler worker thread stopping
20:32:07 T:3668 M:1777451008   DEBUG: Thread 3668 terminating
20:32:07 T:3548 M:1777475584    INFO: lastfm destroyed