All pastes #1729225 Raw Edit

Stuff

public text v1 · immutable
#1729225 ·published 2009-12-28 07:21 UTC
rendered paste body
23:16:56 T:6560 M:1151512576  NOTICE: -----------------------------------------------------------------------
23:16:56 T:6560 M:1151512576  NOTICE: Starting XBMC, Platform: Windows  build 7600.  Built on Dec 23 2009 (SVN:26017, compiler 1500)
23:16:56 T:6560 M:1151512576  NOTICE: AMD Athlon(tm) 64 Processor 3800+
23:16:56 T:6560 M:1151512576  NOTICE: Desktop Resolution: 1280x768 32Bit at 60Hz
23:16:56 T:6560 M:1151512576  NOTICE: Running with restricted rights
23:16:56 T:6560 M:1151512576  NOTICE: special://xbmc/ is mapped to: C:\Program Files\XBMC
23:16:56 T:6560 M:1151512576  NOTICE: special://masterprofile/ is mapped to: C:\Users\Tim\AppData\Roaming\XBMC\userdata
23:16:56 T:6560 M:1151512576  NOTICE: special://home/ is mapped to: C:\Users\Tim\AppData\Roaming\XBMC
23:16:56 T:6560 M:1151512576  NOTICE: special://temp/ is mapped to: C:\Users\Tim\AppData\Roaming\XBMC\cache
23:16:56 T:6560 M:1151512576  NOTICE: The executable running is: C:\Program Files\XBMC\XBMC.exe
23:16:56 T:6560 M:1151512576  NOTICE: Log File is located: C:\Users\Tim\AppData\Roaming\XBMC\xbmc.log
23:16:56 T:6560 M:1151512576  NOTICE: -----------------------------------------------------------------------
23:16:56 T:6560 M:1151488000  NOTICE: Setup SDL
23:16:56 T:6560 M:1150717952  NOTICE: Found mode: 640x480 @ 59.94 - Full Screen
23:16:56 T:6560 M:1150648320  NOTICE: Found mode: 640x480 @ 60.00 - Full Screen
23:16:56 T:6560 M:1150717952  NOTICE: Found mode: 640x480 @ 73.00 - Full Screen
23:16:56 T:6560 M:1150787584  NOTICE: Found mode: 640x480 @ 75.00 - Full Screen
23:16:56 T:6560 M:1150717952  NOTICE: Found mode: 720x480 @ 60.00 - Full Screen
23:16:56 T:6560 M:1150648320  NOTICE: Found mode: 720x480 @ 75.00 - Full Screen
23:16:56 T:6560 M:1150857216  NOTICE: Found mode: 800x480 @ 70.00 - Full Screen
23:16:56 T:6560 M:1150717952  NOTICE: Found mode: 800x600 @ 56.00 - Full Screen
23:16:56 T:6560 M:1150717952  NOTICE: Found mode: 800x600 @ 60.00 - Full Screen
23:16:56 T:6560 M:1150648320  NOTICE: Found mode: 800x600 @ 70.00 - Full Screen
23:16:56 T:6560 M:1150717952  NOTICE: Found mode: 800x600 @ 72.00 - Full Screen
23:16:56 T:6560 M:1150787584  NOTICE: Found mode: 800x600 @ 75.00 - Full Screen
23:16:56 T:6560 M:1150717952  NOTICE: Found mode: 848x480 @ 60.00 - Full Screen
23:16:56 T:6560 M:1150648320  NOTICE: Found mode: 848x480 @ 75.00 - Full Screen
23:16:56 T:6560 M:1150717952  NOTICE: Found mode: 1024x768 @ 60.00 - Full Screen
23:16:56 T:6560 M:1150787584  NOTICE: Found mode: 1024x768 @ 70.00 - Full Screen
23:16:56 T:6560 M:1150857216  NOTICE: Found mode: 1024x768 @ 72.00 - Full Screen
23:16:56 T:6560 M:1150926848  NOTICE: Found mode: 1024x768 @ 75.00 - Full Screen
23:16:56 T:6560 M:1150717952  NOTICE: Found mode: 1280x768 @ 60.00 - Full Screen
23:16:56 T:6560 M:1150869504  NOTICE: load settings...
23:16:56 T:6560 M:1150861312  NOTICE: special://profile/ is mapped to: special://masterprofile/
23:16:56 T:6560 M:1150861312  NOTICE: loading special://masterprofile/guisettings.xml
23:16:56 T:6560 M:1149935616  NOTICE: Getting hardware information now...
23:16:56 T:6560 M:1149935616  NOTICE: Checking resolution 11
23:16:56 T:6560 M:1149714432  NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
23:16:56 T:6560 M:1149706240  NOTICE: Loaded playercorefactory configuration
23:16:56 T:6560 M:1149706240  NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
23:16:56 T:6560 M:1149706240  NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
23:16:56 T:6560 M:1149706240  NOTICE: No advancedsettings.xml to load (special://masterprofile/advancedsettings.xml)
23:16:56 T:6560 M:1149706240  NOTICE: Default DVD Player: dvdplayer
23:16:56 T:6560 M:1149706240  NOTICE: Default Video Player: dvdplayer
23:16:56 T:6560 M:1149706240  NOTICE: Default Audio Player: paplayer
23:16:56 T:6560 M:1149706240  NOTICE: Enabled debug logging due to GUI setting (2)
23:16:56 T:6560 M:1150189568  NOTICE: special://masterprofile/sources.xml
23:16:56 T:6560 M:1150009344   DEBUG: CWinEventsWin32::WndProcWindow is active
23:16:56 T:6368 M:1150005248   DEBUG: thread start, auto delete: 0
23:16:57 T:6560 M:1148469248   DEBUG: CWinEventsWin32::WndProcWindow gained focus
23:16:57 T:6560 M:1148481536   DEBUG: CWinSystemWin32::ResizeInternal - resizing due to size change (0,0,1276,706)->(-6,1,1286,745)
23:16:57 T:6560 M:1143750656   DEBUG: CRenderSystemDX::CreateDevice on adapter 0
23:16:57 T:6560 M:1140207616    INFO: load language info file: special://xbmc/language/English/langinfo.xml
23:16:57 T:6560 M:1140047872   DEBUG: Win32DllLoader::Load(special://xbmc/system/ImageLib.dll)
23:16:57 T:6560 M:1139236864   DEBUG: LoadLibraryA('MSVCR71.dll')
23:16:57 T:6560 M:1139236864   DEBUG: Win32DllLoader::Load(MSVCR71.dll)
23:16:57 T:6560 M:1139232768   DEBUG: LoadLibrary('MSVCR71.dll') returning: 022B06A0
23:16:57 T:6560 M:1139232768   DEBUG: LoadLibraryA('MSVCP71.dll')
23:16:57 T:6560 M:1139232768   DEBUG: Win32DllLoader::Load(MSVCP71.dll)
23:16:57 T:6560 M:1139232768   DEBUG: LoadLibraryA('MSVCR71.dll')
23:16:57 T:6560 M:1139232768   DEBUG: LoadLibrary('MSVCR71.dll') returning: 022B06A0
23:16:57 T:6560 M:1139232768   DEBUG: LoadLibrary('MSVCP71.dll') returning: 022B0740
23:16:57 T:6560 M:1133293568    INFO: load language file:special://xbmc/language/English/strings.xml
23:16:57 T:6560 M:1132990464    INFO: load keymapping
23:16:57 T:6560 M:1132933120    INFO: Loading special://xbmc/system/keymaps/gamepad.xml
23:16:57 T:6560 M:1132883968    INFO: Loading special://xbmc/system/keymaps/joystick.AppleRemote.xml
23:16:57 T:6560 M:1132863488    INFO: Loading special://xbmc/system/keymaps/joystick.Harmony.xml
23:16:57 T:6560 M:1132838912    INFO: Loading special://xbmc/system/keymaps/joystick.Logitech.RumblePad.2.xml
23:16:57 T:6560 M:1132802048    INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.Controller.S.xml
23:16:57 T:6560 M:1132777472    INFO: Loading special://xbmc/system/keymaps/joystick.WiiRemote.xml
23:16:57 T:6560 M:1132765184    INFO: Loading special://xbmc/system/keymaps/keyboard.xml
23:16:57 T:6560 M:1132744704    INFO: Loading special://xbmc/system/keymaps/remote.xml
23:16:57 T:6560 M:1132716032    INFO: Loading special://xbmc/system/IRSSmap.xml
23:16:57 T:6560 M:1132711936   DEBUG: CButtonTranslator::Load - no userdata IRSSmap.xml found, skipping
23:16:57 T:6560 M:1132711936    INFO: Checking skin version of: Confluence
23:16:57 T:6560 M:1132703744    INFO: Skin version is: 2.11 (2.110000)
23:16:57 T:6560 M:1132703744    INFO: GUI format 1276x706 Windowed
23:16:57 T:6560 M:1132699648    INFO: creating subdirectories
23:16:57 T:6560 M:1132699648    INFO: userdata folder: special://masterprofile/
23:16:57 T:6560 M:1132699648    INFO: recording folder:C:\Users\Tim\XBMC Stuff\Recordings\
23:16:57 T:6560 M:1132699648    INFO: screenshots folder:C:\Users\Tim\XBMC Stuff\Screenshots\
23:16:57 T:6560 M:1132699648    INFO: thumbnails folder: special://masterprofile/Thumbnails
23:16:57 T:6560 M:1132695552  NOTICE: initializing playlistplayer
23:16:57 T:6560 M:1132691456  NOTICE: DONE initializing playlistplayer
23:16:57 T:6560 M:1132691456   DEBUG: DPMS: supported power-saving modes: OFF STANDBY
23:16:57 T:6560 M:1132683264  NOTICE: load default skin:[Confluence]
23:16:57 T:6560 M:1132679168    INFO:   load skin from:special://xbmc/skin/Confluence
23:16:57 T:6560 M:1132679168    INFO:   delete old skin...
23:16:57 T:6560 M:1132658688   DEBUG: ------ Window Deinit (Pointer.xml) ------
23:16:57 T:6560 M:1132650496   DEBUG: ------ Window Deinit (DialogMuteBug.xml) ------
23:16:57 T:6560 M:1132638208    INFO: Default 4:3 resolution directory is special://xbmc/skin/Confluence/720p
23:16:57 T:6560 M:1132638208    INFO: Default 16:9 resolution directory is special://xbmc/skin/Confluence/720p
23:16:57 T:6560 M:1132638208    INFO: Skin version is: 2.11
23:16:57 T:6560 M:1132625920    INFO: Loading skin includes from C:\Program Files\XBMC\skin\Confluence\720p\includes.xml
23:16:57 T:6560 M:1130594304    INFO:   load fonts for skin...
23:16:57 T:6560 M:1130512384    INFO: Loading fonts from special://xbmc/skin/Confluence/720p/Font.xml
23:16:57 T:6560 M:1126219776    INFO:   load new skin...
23:16:57 T:6560 M:1126219776    INFO: Skin version is: 2.11 (2.110000)
23:16:57 T:6560 M:1126219776    INFO: Loading skin file: Home.xml
23:16:57 T:6560 M:1124888576   DEBUG: Load Home.xml: 42.21ms
23:16:57 T:6560 M:1124884480    INFO: Loading user windows, path special://xbmc/skin/Confluence/720p
23:16:57 T:6560 M:1124884480    INFO: Loading skin file: special://xbmc/skin/Confluence/720p/custom_DiscDialog_1113.xml
23:16:57 T:6560 M:1124876288    INFO: Loading skin file: special://xbmc/skin/Confluence/720p/custom_SkinSetting_1111.xml
23:16:57 T:6560 M:1124261888    INFO: Loading user windows, path special://xbmc/skin/Confluence/720p
23:16:57 T:6560 M:1124261888    INFO: Loading skin file: special://xbmc/skin/Confluence/720p/custom_DiscDialog_1113.xml
23:16:57 T:6560 M:1124261888    INFO: Loading skin file: special://xbmc/skin/Confluence/720p/custom_SkinSetting_1111.xml
23:16:57 T:6560 M:1124241408    INFO: Loading user windows, path special://xbmc/skin/Confluence/720p
23:16:57 T:6560 M:1124241408    INFO: Loading skin file: special://xbmc/skin/Confluence/720p/custom_DiscDialog_1113.xml
23:16:57 T:6560 M:1124241408    INFO: Loading skin file: special://xbmc/skin/Confluence/720p/custom_SkinSetting_1111.xml
23:16:57 T:6560 M:1124167680   DEBUG: Load Skin XML: 78.18ms
23:16:57 T:6560 M:1124167680    INFO:   initialize new skin...
23:16:57 T:6560 M:1124167680    INFO: Loading skin file: Pointer.xml
23:16:57 T:6560 M:1124163584   DEBUG: Load Pointer.xml: 1.16ms
23:16:57 T:6560 M:1124073472   DEBUG: Alloc resources: 5.86ms (1.20 ms skin load)
23:16:57 T:6560 M:1124073472    INFO: Loading skin file: DialogVolumeBar.xml
23:16:57 T:6560 M:1124061184   DEBUG: Load DialogVolumeBar.xml: 1.73ms
23:16:57 T:6560 M:1124052992   DEBUG: Alloc resources: 1.95ms (1.79 ms skin load)
23:16:57 T:6560 M:1124052992    INFO: Loading skin file: DialogSeekBar.xml
23:16:57 T:6560 M:1124007936   DEBUG: Load DialogSeekBar.xml: 6.47ms
23:16:57 T:6560 M:1123999744   DEBUG: Alloc resources: 7.19ms (6.98 ms skin load)
23:16:57 T:6560 M:1123999744    INFO: Loading skin file: DialogKaiToast.xml
23:16:57 T:6560 M:1123975168   DEBUG: Load DialogKaiToast.xml: 2.98ms
23:16:57 T:6560 M:1123975168   DEBUG: Alloc resources: 3.04ms (3.04 ms skin load)
23:16:57 T:6560 M:1123975168    INFO: Loading skin file: DialogMuteBug.xml
23:16:57 T:6560 M:1123971072   DEBUG: Load DialogMuteBug.xml: 1.21ms
23:16:57 T:6560 M:1123971072   DEBUG: Alloc resources: 1.26ms (1.25 ms skin load)
23:16:57 T:6560 M:1123971072   DEBUG: CGUIAudioManager::Initialize
23:16:57 T:6560 M:1123971072   DEBUG: CAudioContext::SetActiveDevice - SetActiveDevice from 1 to 2
23:16:57 T:6560 M:1123971072   DEBUG: CAudioContext::RemoveActiveDevice - Removing device 1
23:16:57 T:6560 M:1123901440   DEBUG: CWDSound::direct_sound_enumerator_member_callback - found Device: Primary Sound Driver
23:16:57 T:6560 M:1123901440   DEBUG: CWDSound::direct_sound_enumerator_member_callback - found Device: Speakers (Realtek AC'97 Audio)
23:16:57 T:6560 M:1123901440   DEBUG: CWDSound::direct_sound_enumerator_member_callback - found Device: Realtek Digital Output (Realtek AC'97 Audio)
23:16:57 T:6560 M:1123524608    INFO: Loading special://xbmc/skin/Confluence/sounds/sounds.xml
23:16:57 T:6560 M:1123508224    INFO:   skin loaded...
23:16:57 T:6560 M:1123037184   DEBUG: Win32DllLoader::Load(special://xbmc/system/libcurl.dll)
23:16:57 T:6560 M:1123004416   DEBUG: LoadLibraryA('MSVCR71.dll')
23:16:57 T:6560 M:1123004416   DEBUG: LoadLibrary('MSVCR71.dll') returning: 022B06A0
23:16:57 T:6560 M:1122832384   DEBUG: Activating window ID: 12999
23:16:57 T:6560 M:1122828288   DEBUG: Checking if window ID 12999 is locked.
23:16:57 T:6560 M:1122820096   DEBUG: ------ Window Init (Startup.xml) ------
23:16:57 T:6560 M:1122820096    INFO: Loading skin file: Startup.xml
23:16:57 T:6560 M:1122816000   DEBUG: Load Startup.xml: 2.23ms
23:16:57 T:6560 M:1122816000   DEBUG: Alloc resources: 2.30ms (2.30 ms skin load)
23:16:57 T:6560 M:1122816000    INFO: removing tempfiles
23:16:57 T:6560 M:1122807808  NOTICE: initialize done
23:16:57 T:6560 M:1122807808  NOTICE: Running the application...
23:16:57 T:6560 M:1122807808   DEBUG: CApplication::ExecuteXBMCAction : Translating SetFocus(10)
23:16:57 T:6560 M:1122807808   DEBUG: CApplication::ExecuteXBMCAction : To SetFocus(10)
23:16:57 T:6560 M:1122803712   DEBUG: XBPython::Process - no user autoexec.py (C:\Users\Tim\AppData\Roaming\XBMC\scripts\autoexec.py) found, skipping
23:16:57 T:6560 M:1122803712   DEBUG: XBPython::Process - no system autoexec.py (C:\Program Files\XBMC\scripts\autoexec.py) found, skipping
23:16:57 T:6560 M:1122799616   DEBUG: CNetwork::NetworkMessage - Starting network services
23:16:57 T:6560 M:1122795520  NOTICE: ES: Starting event server
23:16:57 T:6560 M:1122787328   DEBUG: CLastfmScrobbler: Clearing session.
23:16:57 T:6560 M:1122783232   DEBUG: CLastfmScrobbler: Clearing session.
23:16:57 T:6560 M:1122770944   DEBUG: CLastfmScrobbler: Journal loaded with 0 entries.
23:16:57 T:6560 M:1122770944   DEBUG: CLibrefmScrobbler: Clearing session.
23:16:57 T:4108 M:1121058816   DEBUG: thread start, auto delete: 0
23:16:57 T:4108 M:1121058816  NOTICE: ES: Starting UDP Event server on 127.0.0.1:9777
23:16:57 T:4108 M:1121058816  NOTICE: UDP: Listening on port 9777
23:16:57 T:7168 M:1121054720   DEBUG: thread start, auto delete: 0
23:16:57 T:7168 M:1121054720   DEBUG: CLastfmScrobbler: Thread started.
23:16:57 T:512 M:1121054720   DEBUG: thread start, auto delete: 1
23:16:57 T:6560 M:1122291712   DEBUG: CApplication::ExecuteXBMCAction : Translating ReplaceWindow(Home)
23:16:57 T:6560 M:1122291712   DEBUG: CApplication::ExecuteXBMCAction : To ReplaceWindow(Home)
23:16:57 T:6560 M:1122291712   DEBUG: Activating window ID: 10000
23:16:57 T:6560 M:1122291712   DEBUG: Checking if window ID 10000 is locked.
23:16:57 T:6560 M:1122291712   DEBUG: ------ Window Deinit (Startup.xml) ------
23:16:57 T:6560 M:1122291712   DEBUG: ------ Window Init (Home.xml) ------
23:16:57 T:6560 M:1122242560   DEBUG: Alloc resources: 1.36ms (0.00 ms skin load)
23:16:58 T:6560 M:1113468928   DEBUG: CApplication::ExecuteXBMCAction : Translating SetFocus(9000)
23:16:58 T:6560 M:1113468928   DEBUG: CApplication::ExecuteXBMCAction : To SetFocus(9000)
23:16:58 T:3452 M:1113440256   DEBUG: thread start, auto delete: 0
23:16:58 T:3452 M:1113423872   DEBUG: FileCurl::Open(0834FD38) http://feeds.feedburner.com/xbmc
23:16:58 T:3452 M:1113419776    INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://feeds.feedburner.com
23:16:58 T:3452 M:1113370624   DEBUG: FileCurl::Close(0834FD38) http://feeds.feedburner.com/xbmc
23:16:58 T:3452 M:1113370624   DEBUG: Got rss feed: http://feeds.feedburner.com/xbmc
23:16:58 T:3452 M:1113370624   DEBUG: RSS feed encoding: ISO-8859-1
23:16:58 T:3452 M:1113362432   DEBUG: Parsed rss feed: http://feeds.feedburner.com/xbmc
23:16:58 T:3452 M:1113354240   DEBUG: Thread 3452 terminating
23:16:58 T:512 M:1110769664   DEBUG: CImageLoader::DoWork - took 533 ms to load C:\Users\Tim\XBMC Stuff\XBMC Wallpapers\Videos\zorro1080.jpg
23:16:58 T:512 M:1110769664    INFO: WEATHER: Downloading weather
23:16:58 T:512 M:1110769664   DEBUG: FileCurl::Open(0824FD28) http://xoap.weather.com/weather/local/USWA0395?cc=*&unit=m&dayf=4&prod=xoap&link=xoap&par=1004124588&key=079f24145f208494
23:16:58 T:512 M:1110769664    INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://xoap.weather.com
23:16:58 T:6560 M:1109323776   DEBUG: SDLKeyboard: scancode: 72, sym: 273, unicode: 0, modifier: 0
23:16:58 T:6560 M:1109323776   DEBUG: CApplication::OnKey: 61478 pressed, action is 3
23:16:59 T:5848 M:1103208448   DEBUG: thread start, auto delete: 1
23:16:59 T:6560 M:1101377536   DEBUG: SDLKeyboard: scancode: 72, sym: 273, unicode: 0, modifier: 0
23:16:59 T:6560 M:1101377536   DEBUG: CApplication::OnKey: 61478 pressed, action is 3
23:16:59 T:6560 M:1101377536   ERROR: DIRECTORY::CDirectory::GetDirectory - Error getting C:\Users\Tim\XBMC Stuff\XBMC Wallpapers\weather\na\
23:16:59 T:512 M:1099145216   DEBUG: FileCurl::Close(0824FD28) http://xoap.weather.com/weather/local/USWA0395?cc=*&unit=m&dayf=4&prod=xoap&link=xoap&par=1004124588&key=079f24145f208494
23:16:59 T:512 M:1099145216    INFO: WEATHER: Weather download successful
23:16:59 T:6560 M:1093959680   DEBUG: SDLKeyboard: scancode: 72, sym: 273, unicode: 0, modifier: 0
23:16:59 T:6560 M:1093959680   DEBUG: CApplication::OnKey: 61478 pressed, action is 3
23:16:59 T:2324 M:1093095424   DEBUG: thread start, auto delete: 1
23:16:59 T:6560 M:1090723840   DEBUG: SDLKeyboard: scancode: 28, sym: 13, unicode: 13, modifier: 0
23:16:59 T:6560 M:1090723840   DEBUG: CApplication::OnKey: 61453 pressed, action is 7
23:16:59 T:6560 M:1090711552   DEBUG: CApplication::ExecuteXBMCAction : Translating ActivateWindow(Scripts)
23:16:59 T:6560 M:1090711552   DEBUG: CApplication::ExecuteXBMCAction : To ActivateWindow(Scripts)
23:16:59 T:6560 M:1090711552   DEBUG: Activating window ID: 10020
23:16:59 T:6560 M:1090711552   DEBUG: Checking if window ID 10020 is locked.
23:16:59 T:6560 M:1090711552   DEBUG: ------ Window Deinit (Home.xml) ------
23:16:59 T:5848 M:1093758976   DEBUG: CImageLoader::DoWork - took 952 ms to load C:\Users\Tim\XBMC Stuff\XBMC Wallpapers\pictures\svensauer1080.jpg
23:17:00 T:2324 M:1098506240   DEBUG: CImageLoader::DoWork - took 507 ms to load special://skin/backgrounds/scripts.jpg
23:17:00 T:6560 M:1097678848   DEBUG: ------ Window Init (MyScripts.xml) ------
23:17:00 T:6560 M:1097678848    INFO: Loading skin file: MyScripts.xml
23:17:00 T:6560 M:1097646080   DEBUG: Load MyScripts.xml: 20.81ms
23:17:00 T:6560 M:1097535488   DEBUG: Alloc resources: 23.54ms (20.89 ms skin load)
23:17:00 T:6560 M:1097531392   DEBUG: CGUIMediaWindow::GetDirectory (special://home/scripts)
23:17:00 T:6560 M:1097531392   DEBUG:   ParentPath = []
23:17:01 T:6560 M:1098461184   DEBUG: SDLKeyboard: scancode: 80, sym: 274, unicode: 0, modifier: 0
23:17:01 T:6560 M:1098461184   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
23:17:01 T:512 M:1098448896   DEBUG: CImageLoader::DoWork - took 6 ms to load special://masterprofile/Thumbnails/Programs/a729f677.tbn
23:17:01 T:6560 M:1098399744   DEBUG: SDLKeyboard: scancode: 80, sym: 274, unicode: 0, modifier: 0
23:17:01 T:6560 M:1098399744   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
23:17:01 T:5848 M:1098407936   DEBUG: CImageLoader::DoWork - took 6 ms to load special://masterprofile/Thumbnails/Programs/a2e56d1b.tbn
23:17:01 T:6560 M:1098235904   DEBUG: SDLKeyboard: scancode: 80, sym: 274, unicode: 0, modifier: 0
23:17:01 T:6560 M:1098235904   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
23:17:01 T:2324 M:1097699328   DEBUG: CImageLoader::DoWork - took 31 ms to load special://masterprofile/Thumbnails/Programs/30d1cb6e.tbn
23:17:03 T:6560 M:1102090240   DEBUG: SDLKeyboard: scancode: 93, sym: 319, unicode: 0, modifier: 0
23:17:03 T:6560 M:1102090240   DEBUG: CApplication::OnKey: 61533 pressed, action is 117
23:17:03 T:6560 M:1102090240   DEBUG: CFavourites::Load - no system favourites found, skipping
23:17:03 T:6560 M:1102090240   DEBUG: CFavourites::Load - no userdata favourites found, skipping
23:17:03 T:6560 M:1102077952    INFO: Loading skin file: DialogContextMenu.xml
23:17:03 T:6560 M:1102073856   DEBUG: Load DialogContextMenu.xml: 1.73ms
23:17:03 T:6560 M:1102069760   DEBUG: ------ Window Init (DialogContextMenu.xml) ------
23:17:03 T:6560 M:1102082048   DEBUG: Alloc resources: 0.28ms (0.00 ms skin load)
23:17:04 T:6560 M:1102041088   DEBUG: SDLKeyboard: scancode: 72, sym: 273, unicode: 0, modifier: 0
23:17:04 T:6560 M:1102041088   DEBUG: CApplication::OnKey: 61478 pressed, action is 3
23:17:04 T:6560 M:1102569472   DEBUG: SDLKeyboard: scancode: 72, sym: 273, unicode: 0, modifier: 0
23:17:04 T:6560 M:1102569472   DEBUG: CApplication::OnKey: 61478 pressed, action is 3
23:17:04 T:6560 M:1102565376   DEBUG: SDLKeyboard: scancode: 28, sym: 13, unicode: 13, modifier: 0
23:17:04 T:6560 M:1102565376   DEBUG: CApplication::OnKey: 61453 pressed, action is 7
23:17:04 T:6560 M:1102553088   DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------
23:17:04 T:6560 M:1103007744   DEBUG: ------ Window Init (DialogScriptInfo.xml) ------
23:17:04 T:6560 M:1103007744    INFO: Loading skin file: DialogScriptInfo.xml
23:17:04 T:6560 M:1102999552   DEBUG: Load DialogScriptInfo.xml: 2.54ms
23:17:04 T:6560 M:1102999552   DEBUG: Alloc resources: 2.86ms (2.60 ms skin load)
23:17:09 T:6560 M:1101492224   DEBUG: SDLKeyboard: scancode: 1, sym: 27, unicode: 27, modifier: 0
23:17:09 T:6560 M:1101492224   DEBUG: CApplication::OnKey: 61467 pressed, action is 10
23:17:09 T:6560 M:1101479936   DEBUG: ------ Window Deinit (DialogScriptInfo.xml) ------
23:17:09 T:6560 M:1101463552   DEBUG: SDLKeyboard: scancode: 93, sym: 319, unicode: 0, modifier: 0
23:17:09 T:6560 M:1101463552   DEBUG: CApplication::OnKey: 61533 pressed, action is 117
23:17:09 T:6560 M:1101463552   DEBUG: CFavourites::Load - no system favourites found, skipping
23:17:09 T:6560 M:1101463552   DEBUG: CFavourites::Load - no userdata favourites found, skipping
23:17:09 T:6560 M:1101455360    INFO: Loading skin file: DialogContextMenu.xml
23:17:09 T:6560 M:1101451264   DEBUG: Load DialogContextMenu.xml: 1.69ms
23:17:09 T:6560 M:1101451264   DEBUG: ------ Window Init (DialogContextMenu.xml) ------
23:17:09 T:6560 M:1101451264   DEBUG: Alloc resources: 0.25ms (0.00 ms skin load)
23:17:10 T:6560 M:1101832192   DEBUG: SDLKeyboard: scancode: 80, sym: 274, unicode: 0, modifier: 0
23:17:10 T:6560 M:1101832192   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
23:17:10 T:6560 M:1101828096   DEBUG: SDLKeyboard: scancode: 28, sym: 13, unicode: 13, modifier: 0
23:17:10 T:6560 M:1101828096   DEBUG: CApplication::OnKey: 61453 pressed, action is 7
23:17:10 T:6560 M:1101815808   DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------
23:17:10 T:6560 M:1101795328   DEBUG: ------ Window Init (DialogPluginSettings.xml) ------
23:17:10 T:6560 M:1101795328    INFO: Loading skin file: DialogPluginSettings.xml
23:17:10 T:6560 M:1101778944   DEBUG: Load DialogPluginSettings.xml: 3.47ms
23:17:10 T:6560 M:1101770752   DEBUG: Alloc resources: 4.43ms (3.54 ms skin load)
23:17:11 T:6560 M:1101090816   DEBUG: SDLKeyboard: scancode: 72, sym: 273, unicode: 0, modifier: 0
23:17:11 T:6560 M:1101090816   DEBUG: CApplication::OnKey: 61478 pressed, action is 3
23:17:12 T:6560 M:1101393920   DEBUG: SDLKeyboard: scancode: 72, sym: 273, unicode: 0, modifier: 0
23:17:12 T:6560 M:1101393920   DEBUG: CApplication::OnKey: 61478 pressed, action is 3
23:17:14 T:6560 M:1101619200   DEBUG: SDLKeyboard: scancode: 72, sym: 273, unicode: 0, modifier: 0
23:17:14 T:6560 M:1101619200   DEBUG: CApplication::OnKey: 61478 pressed, action is 3
23:17:15 T:6560 M:1102729216   DEBUG: SDLKeyboard: scancode: 80, sym: 274, unicode: 0, modifier: 0
23:17:15 T:6560 M:1102729216   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
23:17:16 T:6560 M:1102958592   DEBUG: SDLKeyboard: scancode: 28, sym: 13, unicode: 13, modifier: 0
23:17:16 T:6560 M:1102958592   DEBUG: CApplication::OnKey: 61453 pressed, action is 7
23:17:16 T:6560 M:1102946304    INFO: initializing python engine.
23:17:16 T:6560 M:1102946304   DEBUG: Win32DllLoader::Load(special://xbmc/system/python/python24.dll)
23:17:16 T:6560 M:1102913536   DEBUG: LoadLibraryA('MSVCR71.dll')
23:17:16 T:6560 M:1102913536   DEBUG: LoadLibrary('MSVCR71.dll') returning: 022B06A0
23:17:16 T:6560 M:1102401536   DEBUG: LoadLibraryExA called with flags: 
                                             - LOAD_WITH_ALTERED_SEARCH_PATH
23:17:16 T:6560 M:1102401536   DEBUG: LoadLibraryA('zlib.pyd')
23:17:16 T:6560 M:1102401536   DEBUG: Win32DllLoader::Load(special://xbmc/system/python/DLLs\zlib.pyd)
23:17:16 T:6560 M:1102389248   DEBUG: LoadLibraryA('python24.dll')
23:17:16 T:6560 M:1102389248   DEBUG: LoadLibrary('python24.dll') returning: 06F4DC58
23:17:16 T:6560 M:1102389248   DEBUG: LoadLibraryA('MSVCR71.dll')
23:17:16 T:6560 M:1102389248   DEBUG: LoadLibrary('MSVCR71.dll') returning: 022B06A0
23:17:16 T:6560 M:1102389248   DEBUG: LoadLibrary('zlib.pyd') returning: 06F4DD48
23:17:17 T:6560 M:1101127680   DEBUG:   msg: 'import site' failed; use -v for traceback
23:17:17 T:6560 M:1100984320   DEBUG: new python thread created. id=1
23:17:17 T:6560 M:1100984320   DEBUG: CGUIMediaWindow::GetDirectory (special://home/scripts)
23:17:17 T:6560 M:1100984320   DEBUG:   ParentPath = [special://home/scripts]
23:17:17 T:6700 M:1100984320   DEBUG: thread start, auto delete: 0
23:17:17 T:6700 M:1100984320   DEBUG: Python thread: start processing
23:17:17 T:6700 M:1100619776   DEBUG:   msg: 'import site' failed; use -v for traceback
23:17:17 T:6700 M:1100611584  NOTICE: -->Python Interpreter Initialized<--
23:17:17 T:6700 M:1100611584   DEBUG: XBPyThread::Process - The source file to load is special://home/scripts/Home Theater Experience/default.py
23:17:17 T:6700 M:1100541952   DEBUG: XBPyThread::Process - Setting the Python path to C:\Users\Tim\AppData\Roaming\XBMC\scripts\Home Theater Experience;special://xbmc/system/python/python24.zlib;special://xbmc/system/python/DLLs;special://xbmc/system/python/Lib;special://xbmc/system/python/spyce
23:17:17 T:6700 M:1100541952   DEBUG: XBPyThread::Process - Entering source directory C:\Users\Tim\AppData\Roaming\XBMC\scripts\Home Theater Experience
23:17:17 T:6700 M:1100537856  NOTICE: [SCRIPT] 'Home Theater Experience: Version - 1.5-r1541' initialized!
23:17:17 T:6700 M:1100529664  NOTICE:      ** Required XBMC Revision: r21010 **
23:17:17 T:6700 M:1100529664  NOTICE:      ** Found XBMC Revision: r26017 [Compatible] **
23:17:20 T:6700 M:1105694720    INFO: Loading skin file: DialogProgress.xml
23:17:20 T:6700 M:1105690624   DEBUG: Load DialogProgress.xml: 2.39ms
23:17:20 T:6700 M:1105690624   DEBUG: ------ Window Init (DialogProgress.xml) ------
23:17:20 T:6700 M:1105690624   DEBUG: Alloc resources: 0.04ms (0.00 ms skin load)
23:17:22 T:6700 M:1104461824   DEBUG: LoadLibraryExA called with flags: 
                                             - LOAD_WITH_ALTERED_SEARCH_PATH
23:17:22 T:6700 M:1104461824   DEBUG: LoadLibraryA('_socket.pyd')
23:17:22 T:6700 M:1104461824   DEBUG: Win32DllLoader::Load(special://xbmc/system/python/DLLs\_socket.pyd)
23:17:22 T:6700 M:1104445440   DEBUG: LoadLibraryA('python24.dll')
23:17:22 T:6700 M:1104445440   DEBUG: LoadLibrary('python24.dll') returning: 06F4DC58
23:17:22 T:6700 M:1104445440   DEBUG: LoadLibraryA('MSVCR71.dll')
23:17:22 T:6700 M:1104445440   DEBUG: LoadLibrary('MSVCR71.dll') returning: 022B06A0
23:17:22 T:6700 M:1104445440   DEBUG: LoadLibrary('_socket.pyd') returning: 06F4FA58
23:17:22 T:6700 M:1104441344   DEBUG: LoadLibraryExA called with flags: 
                                             - LOAD_WITH_ALTERED_SEARCH_PATH
23:17:22 T:6700 M:1104441344   DEBUG: LoadLibraryA('_ssl.pyd')
23:17:22 T:6700 M:1104441344   DEBUG: Win32DllLoader::Load(special://xbmc/system/python/DLLs\_ssl.pyd)
23:17:22 T:6700 M:1104412672   DEBUG: LoadLibraryA('python24.dll')
23:17:22 T:6700 M:1104412672   DEBUG: LoadLibrary('python24.dll') returning: 06F4DC58
23:17:22 T:6700 M:1104412672   DEBUG: LoadLibraryA('MSVCR71.dll')
23:17:22 T:6700 M:1104412672   DEBUG: LoadLibrary('MSVCR71.dll') returning: 022B06A0
23:17:22 T:6700 M:1104412672   DEBUG: LoadLibrary('_ssl.pyd') returning: 06F4D1B8
23:17:22 T:6700 M:1104228352   DEBUG: LoadLibraryExA called with flags: 
                                             - LOAD_WITH_ALTERED_SEARCH_PATH
23:17:22 T:6700 M:1104228352   DEBUG: LoadLibraryA('_sqlite.pyd')
23:17:22 T:6700 M:1104228352   DEBUG: Win32DllLoader::Load(C:\Users\Tim\AppData\Roaming\XBMC\scripts\Home Theater Experience\resources\platform_libraries\win32\pysqlite2\_sqlite.pyd)
23:17:22 T:6700 M:1104211968   DEBUG: LoadLibrary('_sqlite.pyd') returning: 06F51CB8
23:17:22 T:6700 M:1104355328  NOTICE: Traceback (most recent call last):
23:17:22 T:6700 M:1104355328  NOTICE:   File "C:\Users\Tim\AppData\Roaming\XBMC\scripts\Home Theater Experience\resources\lib\xbmcscript_player.py", line 45, in __init__
23:17:22 T:6700 M:1104330752  NOTICE:     self._clear_watched_items( sys.argv[ 1 ] )
23:17:22 T:6700 M:1104330752  NOTICE:   File "C:\Users\Tim\AppData\Roaming\XBMC\scripts\Home Theater Experience\resources\lib\xbmcscript_player.py", line 67, in _clear_watched_items
23:17:22 T:6700 M:1104330752  NOTICE:     Scraper = scraper.Main( settings=self.settings )
23:17:22 T:6700 M:1104330752  NOTICE: AttributeError: Main instance has no attribute 'settings'
23:17:22 T:6368 M:1104326656   DEBUG: Thread 6368 terminating
23:17:23 T:6700 M:1104314368  NOTICE: Movie:
23:17:23 T:6700 M:1104314368  NOTICE: Genre:
23:17:23 T:6700 M:1104314368  NOTICE: MPAA:
23:17:23 T:6700 M:1104314368  NOTICE: Audio:
23:17:23 T:6700 M:1104314368  NOTICE: Audio path: C:\Users\Tim\XBMC Stuff\Home Theater Stuff\Audio Intros\DTS\
23:17:23 T:6700 M:1104293888   DEBUG: xbmcHttpShim starts
23:17:23 T:6560 M:1104281600   DEBUG: HttpApi Start command: GetDirectory  paras: GetDirectory; C:\Users\Tim\XBMC Stuff\Home Theater Stuff\Audio Intros\DTS\
23:17:25 T:6560 M:1104293888   DEBUG: HttpApi Start command: FileExists  paras: FileExists; C:\Users\Tim\XBMC Stuff\Home Theater Stuff\Movie Ratings\.avi
23:17:25 T:6560 M:1104285696   DEBUG: HttpApi Start command: GetDirectory  paras: GetDirectory; C:\Users\Tim\XBMC Stuff\Home Theater Stuff\Short Films\
23:17:27 T:6560 M:1098035200   DEBUG: CWinEventsWin32::WndProcWindow is active
23:17:27 T:6560 M:1098035200   DEBUG: CWinEventsWin32::WndProcWindow lost focus
23:17:27 T:6560 M:1098027008    INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://movies.apple.com
23:17:28 T:6560 M:1097969664   DEBUG: CPlayerCoreFactory::GetPlayers(http://movies.apple.com/movies/independent/44inchchest/44inchchest_h480p.mov?|User-Agent=QuickTime%2F7.2+%28qtver%3D7.2%3Bos%3DWindows+NT+5.1Service+Pack+3%29)
23:17:28 T:6560 M:1097969664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
23:17:28 T:6560 M:1097969664   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
23:17:28 T:6560 M:1097969664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
23:17:28 T:6560 M:1097969664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/rtmp/mms/udp
23:17:28 T:6560 M:1097969664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
23:17:28 T:6560 M:1097969664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
23:17:28 T:6560 M:1097969664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
23:17:28 T:6560 M:1097969664   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams
23:17:28 T:6560 M:1097969664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: flv/aacp/sdp
23:17:28 T:6560 M:1097969664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2
23:17:28 T:6560 M:1097969664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
23:17:28 T:6560 M:1097969664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdfile
23:17:28 T:6560 M:1097969664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
23:17:28 T:6560 M:1097969664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
23:17:28 T:6560 M:1097969664   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
23:17:28 T:6560 M:1097969664   DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
23:17:28 T:6560 M:1097945088   DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
23:17:28 T:6560 M:1097945088   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
23:17:28 T:6560 M:1097945088   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
23:17:28 T:6560 M:1097945088   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
23:17:28 T:6560 M:1097945088   DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
23:17:28 T:6560 M:1096769536  NOTICE: DVDPlayer: Opening: http://movies.apple.com/movies/independent/44inchchest/44inchchest_h480p.mov?|User-Agent=QuickTime%2F7.2+%28qtver%3D7.2%3Bos%3DWindows+NT+5.1Service+Pack+3%29
23:17:28 T:6560 M:1096769536   DEBUG: ------ Window Init (DialogProgress.xml) ------
23:17:28 T:6560 M:1096769536   DEBUG: Alloc resources: 0.03ms (0.00 ms skin load)
23:17:28 T:6560 M:1101078528 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
23:17:28 T:6640 M:1101078528   DEBUG: thread start, auto delete: 1
23:17:28 T:4704 M:1101078528   DEBUG: thread start, auto delete: 0
23:17:28 T:4704 M:1101074432  NOTICE: Creating InputStream
23:17:28 T:4704 M:1085190144   DEBUG: CFileCache::Open - opening <movies/independent/44inchchest/44inchchest_h480p.mov> using cache
23:17:28 T:4704 M:1085108224   DEBUG: FileCurl::Open(06D1B078) http://movies.apple.com/movies/independent/44inchchest/44inchchest_h480p.mov?
23:17:28 T:4704 M:1084948480    INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles
23:17:28 T:4704 M:1084944384   DEBUG: CUtil::CacheSubtitles: START
23:17:28 T:4704 M:1084940288    INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles done
23:17:28 T:4704 M:1084940288  NOTICE: Creating Demuxer
23:17:28 T:4704 M:1084923904   DEBUG: Win32DllLoader::Load(special://xbmc/system/players/dvdplayer/avutil-50.dll)
23:17:28 T:4704 M:1084899328   DEBUG: Win32DllLoader::Load(special://xbmc/system/players/dvdplayer/avcodec-52.dll)
23:17:28 T:4704 M:1082544128   DEBUG: LoadLibraryA('libfaad.dll')
23:17:28 T:4704 M:1082544128   DEBUG: Win32DllLoader::Load(special://xbmc/system/players/dvdplayer/libfaad.dll)
23:17:28 T:4704 M:1082544128   DEBUG: LoadLibrary('libfaad.dll') returning: 06F50A98
23:17:28 T:4704 M:1082544128   DEBUG: LoadLibraryA('avutil-50.dll')
23:17:28 T:4704 M:1082544128   DEBUG: LoadLibrary('avutil-50.dll') returning: 06F4D258
23:17:28 T:4704 M:1082527744   DEBUG: Win32DllLoader::Load(special://xbmc/system/players/dvdplayer/avformat-52.dll)
23:17:28 T:4704 M:1082486784   DEBUG: LoadLibraryA('avcodec-52.dll')
23:17:28 T:4704 M:1082486784   DEBUG: LoadLibrary('avcodec-52.dll') returning: 06F51A38
23:17:28 T:4704 M:1082486784   DEBUG: LoadLibraryA('avutil-50.dll')
23:17:28 T:4704 M:1082486784   DEBUG: LoadLibrary('avutil-50.dll') returning: 06F4D258
23:17:28 T:3512 M:1082437632   DEBUG: thread start, auto delete: 0
23:17:28 T:3512 M:1082437632   DEBUG: XFILE::CFileCache::Process, request seek on source to 0
23:17:28 T:3512 M:1082437632    INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://movies.apple.com
23:17:29 T:4704 M:1081663488   DEBUG: CDVDDemuxFFmpeg::Open - probing detected format [mov,mp4,m4a,3gp,3g2,mj2]
23:17:29 T:3512 M:1081581568   DEBUG: XFILE::CFileCache::Process, request seek on source to 27216532
23:17:30 T:3512 M:1081597952   DEBUG: XFILE::CFileCurl::CReadState::FillBuffer: curl failed with code 33
23:17:30 T:3512 M:1081597952   ERROR: CFileCurl::CReadState::Open, didn't get any data from stream.
23:17:30 T:3512 M:1081597952    INFO: CFileCache::Process - Hit eof.
23:17:30 T:4704 M:1081597952   DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info starting
23:17:30 T:3512 M:1081036800   DEBUG: XFILE::CFileCache::Process, request seek on source to 175975
23:17:30 T:3512 M:1081032704   DEBUG: XFILE::CFileCache::Process, request seek on source to 73386
23:17:31 T:512 M:1081008128   DEBUG: Thread 512 terminating (autodelete)
23:17:31 T:5848 M:1081008128   DEBUG: Thread 5848 terminating (autodelete)
23:17:31 T:2324 M:1081081856   DEBUG: Thread 2324 terminating (autodelete)
23:17:32 T:4704 M:1079525376   DEBUG: ffmpeg[1260]: [mov,mp4,m4a,3gp,3g2,mj2] max_analyze_duration reached
23:17:32 T:4704 M:1080823808   DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished
23:17:32 T:4704 M:1080823808    INFO: ffmpeg[1260]: Input #0, mov,mp4,m4a,3gp,3g2,mj2, from 'http://movies.apple.com/movies/independent/44inchchest/44inchchest_h480p.mov?|User-Agent=QuickTime%2F7.2+%28qtver%3D7.2%3Bos%3DWindows+NT+5.1Service+Pack+3%29':
23:17:32 T:4704 M:1080823808    INFO: ffmpeg[1260]:   Duration: 00:01:52.43, start: -1.-209583, bitrate: 1936 kb/s
23:17:32 T:4704 M:1080823808    INFO: ffmpeg[1260]:     Stream #0.0(eng): Video: h264, yuv420p, 848x448, 24 tbr, 2400 tbn, 4800 tbc
23:17:32 T:4704 M:1080823808    INFO: ffmpeg[1260]:     Stream #0.1(eng): Audio: aac, 44100 Hz, 2 channels, s16
23:17:32 T:4704 M:1080823808    INFO: ffmpeg[1260]:     Stream #0.2(eng): Data: tmcd / 0x64636D74
23:17:32 T:4704 M:1080823808    INFO: ffmpeg[1260]:   Metadata
23:17:32 T:4704 M:1080823808    INFO: ffmpeg[1260]:     major_brand     : qt
23:17:32 T:4704 M:1080823808    INFO: ffmpeg[1260]:     minor_version   : 537199360
23:17:32 T:4704 M:1080823808    INFO: ffmpeg[1260]:     compatible_brands: qt
23:17:32 T:4704 M:1080823808    INFO: ffmpeg[1260]:     comment         : Encoded and delivered by apple.com/trailers/
23:17:32 T:4704 M:1080823808    INFO: ffmpeg[1260]:     comment-eng     : Encoded and delivered by apple.com/trailers/
23:17:32 T:4704 M:1080823808    INFO: ffmpeg[1260]:     copyright       :  2009 All Rights Reserved
23:17:32 T:4704 M:1080823808    INFO: ffmpeg[1260]:     copyright-eng   :  2009 All Rights Reserved
23:17:32 T:4704 M:1080823808    INFO: ffmpeg[1260]:     title           : 44 Inch Chest
23:17:32 T:4704 M:1080823808    INFO: ffmpeg[1260]:     title-eng       : 44 Inch Chest
23:17:32 T:4704 M:1080795136  NOTICE: Opening video stream: 0 source: 256
23:17:32 T:4704 M:1080791040  NOTICE: Creating video codec with codec id: 28
23:17:32 T:4704 M:1080786944   DEBUG: FactoryCodec - Video:  - Opening
23:17:32 T:4704 M:1080786944   DEBUG: Win32DllLoader::Load(special://xbmc/system/players/dvdplayer/swscale-0.6.1.dll)
23:17:32 T:4704 M:1080770560   DEBUG: LoadLibraryA('avutil-50.dll')
23:17:32 T:4704 M:1080770560   DEBUG: LoadLibrary('avutil-50.dll') returning: 06F4D258
23:17:32 T:4704 M:1080758272  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
23:17:32 T:4704 M:1080758272   DEBUG: FactoryCodec - Video: ff-h264 - Opened
23:17:32 T:4704 M:1080754176  NOTICE: Creating video thread
23:17:32 T:4704 M:1080754176  NOTICE: Opening audio stream: 1 source: 256
23:17:32 T:4704 M:1080754176  NOTICE: Finding audio codec for: 86018
23:17:32 T:4704 M:1080745984   DEBUG: FactoryCodec - Audio: passthrough - Opening
23:17:32 T:4704 M:1080741888   DEBUG: FactoryCodec - Audio: passthrough - Failed
23:17:32 T:4704 M:1080741888   DEBUG: FactoryCodec - Audio: libfaad - Opening
23:17:32 T:4704 M:1080737792   DEBUG: FactoryCodec - Audio: libfaad - Opened
23:17:32 T:4704 M:1080737792  NOTICE: Creating audio thread
23:17:32 T:2652 M:1081163776   DEBUG: thread start, auto delete: 0
23:17:32 T:2652 M:1081163776  NOTICE: running thread: CDVDPlayerAudio::Process()
23:17:32 T:2652 M:1081163776   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(1207428.804989, 1)
23:17:32 T:2652 M:1081135104  NOTICE: Creating audio device with codec id: 86018, channels: 2, sample rate: 44100, no pass-through
23:17:32 T:2652 M:1081126912    INFO: AudioRendererFactory:  not a explicit device, trying to autodetect.
23:17:32 T:2652 M:1081118720   DEBUG: CWin32DirectSound::Initialize: Packet Size = 12384. Avg Bytes Per Second = 176400.
23:17:32 T:2652 M:1081118720   DEBUG: CWin32DirectSound::Initialize: Couldn't create secondary buffer (DSERR_UNSUPPORTED). Trying without LOCHARDWARE.
23:17:32 T:2652 M:1081118720   DEBUG: CWin32DirectSound::Initialize: secondary buffer created
23:17:32 T:2652 M:1081118720   DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback
23:17:32 T:2652 M:1081118720   DEBUG: CDVDPlayerAudio:: Discontinuty - was:1210114.900568, should be:1207428.804989, error:-2686.095579
23:17:32 T:2652 M:1080561664   DEBUG: CWin32DirectSound::CheckPlayStatus: Resuming Playback
23:17:32 T:6560 M:1080492032   DEBUG: CGUIAudioManager::DeInitialize
23:17:32 T:6560 M:1080492032   DEBUG: CApplication::OnPlayBackStarted - Playback has started
23:17:32 T:6700 M:1080492032    INFO: Scriptresult: Success
23:17:32 T:6560 M:1080492032   DEBUG: CGUIInfoManager::SetCurrentMovie(http://movies.apple.com/movies/independent/44inchchest/44inchchest_h480p.mov?|User-Agent=QuickTime%2F7.2+%28qtver%3D7.2%3Bos%3DWindows+NT+5.1Service+Pack+3%29)
23:17:32 T:6560 M:1080483840   DEBUG: SECTION:UnloadDelayed(DLL: special://xbmc/system/ImageLib.dll)
23:17:32 T:6560 M:1080483840   DEBUG: Win32DllLoader::Unload ImageLib.dll
23:17:32 T:6560 M:1080483840   DEBUG: FreeLibrary(MSVCR71.dll) -> 022B06A0
23:17:32 T:6560 M:1080483840   DEBUG: FreeLibrary(MSVCP71.dll) -> 022B0740
23:17:32 T:6560 M:1080483840   DEBUG: Win32DllLoader::Unload MSVCP71.dll
23:17:32 T:6560 M:1080483840   DEBUG: FreeLibrary(MSVCR71.dll) -> 022B06A0
23:17:32 T:6560 M:1081434112    INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://feeds.feedburner.com (easy=05A50048, multi=03DBEAB0)
23:17:32 T:6560 M:1081434112    INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://xoap.weather.com (easy=05A5E6D8, multi=03DBE910)
23:17:32 T:6560 M:1081434112   DEBUG: Win32DllLoader::Load(special://xbmc/system/ImageLib.dll)
23:17:32 T:6560 M:1081294848   DEBUG: LoadLibraryA('MSVCR71.dll')
23:17:32 T:6560 M:1081294848   DEBUG: LoadLibrary('MSVCR71.dll') returning: 022B06A0
23:17:32 T:6560 M:1081294848   DEBUG: LoadLibraryA('MSVCP71.dll')
23:17:32 T:6560 M:1081294848   DEBUG: Win32DllLoader::Load(MSVCP71.dll)
23:17:32 T:6560 M:1081294848   DEBUG: LoadLibraryA('MSVCR71.dll')
23:17:32 T:6560 M:1081294848   DEBUG: LoadLibrary('MSVCR71.dll') returning: 022B06A0
23:17:32 T:6560 M:1081294848   DEBUG: LoadLibrary('MSVCP71.dll') returning: 06F51088
23:17:32 T:6884 M:1078861824   DEBUG: thread start, auto delete: 0
23:17:32 T:6884 M:1076649984  NOTICE: running thread: video_thread
23:17:32 T:6884 M:1076645888   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
23:17:32 T:6884 M:1076645888   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(958333.000000, 0)
23:17:32 T:6884 M:1074974720  NOTICE:  fps: 24.000000, pwidth: 848, pheight: 448, dwidth: 848, dheight: 448
23:17:32 T:6884 M:1074974720   DEBUG: CDVDPlayerVideo::OutputPicture - change configuration. 848x448. framerate: 24.00
23:17:32 T:6884 M:1074974720  NOTICE: Display resolution DESKTOP : 1280x768 @ 60.00 - Full Screen (12)
23:17:32 T:6560 M:1073291264   DEBUG: Activating window ID: 12005
23:17:32 T:6560 M:1073291264   DEBUG: Checking if window ID 12005 is locked.
23:17:32 T:6560 M:1073291264   DEBUG: ------ Window Deinit (MyScripts.xml) ------
23:17:32 T:6560 M:1073291264   DEBUG: ------ Window Init (VideoFullScreen.xml) ------
23:17:32 T:6560 M:1073291264    INFO: Loading skin file: VideoFullScreen.xml
23:17:32 T:6560 M:1073287168   DEBUG: Load VideoFullScreen.xml: 1.31ms
23:17:32 T:6560 M:1073287168   DEBUG: Alloc resources: 1.36ms (1.36 ms skin load)
23:17:32 T:6560 M:1073287168    INFO: Loading skin file: VideoOSD.xml
23:17:32 T:6560 M:1073278976   DEBUG: Load VideoOSD.xml: 3.74ms
23:17:32 T:6560 M:1073180672   DEBUG: Alloc resources: 2.94ms (0.00 ms skin load)
23:17:32 T:6560 M:1073180672    INFO: Loading skin file: VideoOSDSettings.xml
23:17:32 T:6560 M:1073172480   DEBUG: Load VideoOSDSettings.xml: 3.89ms
23:17:32 T:6560 M:1073172480   DEBUG: Alloc resources: 0.70ms (0.00 ms skin load)
23:17:32 T:6560 M:1073172480    INFO: Loading skin file: VideoOSDSettings.xml
23:17:32 T:6560 M:1073172480   DEBUG: Load VideoOSDSettings.xml: 3.07ms
23:17:32 T:6560 M:1073172480   DEBUG: Alloc resources: 0.19ms (0.00 ms skin load)
23:17:32 T:6640 M:1072619520   DEBUG: Thread 6640 terminating (autodelete)
23:17:32 T:6560 M:1072074752   DEBUG: created yv12 texture 0
23:17:32 T:6560 M:1070960640   DEBUG: created yv12 texture 1
23:17:32 T:6560 M:1070100480   DEBUG: ------ Window Deinit (DialogProgress.xml) ------
23:17:32 T:6700 M:1075818496    INFO: Python script stopped
23:17:32 T:6700 M:1075818496   DEBUG: Thread 6700 terminating
23:17:32 T:6560 M:1075863552   DEBUG: python thread 1 destructed
23:17:32 T:6560 M:1075863552    INFO: Python, unloading python24.dll because no scripts are running anymore
23:17:32 T:6560 M:1076256768   DEBUG: XBPython::UnloadExtensionLibs, clearing python extension libraries
23:17:32 T:6560 M:1076256768   DEBUG: Win32DllLoader::Unload DLLs\zlib.pyd
23:17:32 T:6560 M:1076256768   DEBUG: FreeLibrary(python24.dll) -> 06F4DC58
23:17:32 T:6560 M:1076256768   DEBUG: FreeLibrary(MSVCR71.dll) -> 022B06A0
23:17:32 T:6560 M:1076318208   DEBUG: Win32DllLoader::Unload DLLs\_socket.pyd
23:17:32 T:6560 M:1076318208   DEBUG: FreeLibrary(python24.dll) -> 06F4DC58
23:17:32 T:6560 M:1076318208   DEBUG: FreeLibrary(MSVCR71.dll) -> 022B06A0
23:17:32 T:6560 M:1076350976   DEBUG: Win32DllLoader::Unload DLLs\_ssl.pyd
23:17:32 T:6560 M:1076350976   DEBUG: FreeLibrary(python24.dll) -> 06F4DC58
23:17:32 T:6560 M:1076350976   DEBUG: FreeLibrary(MSVCR71.dll) -> 022B06A0
23:17:32 T:6560 M:1076776960   DEBUG: Win32DllLoader::Unload C:\Users\Tim\AppData\Roaming\XBMC\scripts\Home Theater Experience\resources\platform_libraries\win32\pysqlite2\_sqlite.pyd
23:17:32 T:6560 M:1077059584   DEBUG: Win32DllLoader::Unload python24.dll
23:17:32 T:6560 M:1077059584   DEBUG: FreeLibrary(MSVCR71.dll) -> 022B06A0
23:17:34 T:2652 M:1078394880   DEBUG: CDVDPlayerAudio:: Discontinuty - was:3283042.325701, should be:3263058.690210, error:-19983.635491
23:17:36 T:6884 M:1082572800   DEBUG: CPullupCorrection: detected pattern of length 1: 41666.67
23:17:54 T:2652 M:1081905152 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
23:17:54 T:6560 M:1081921536   DEBUG: CWinEventsWin32::WndProcWindow is active
23:17:54 T:6560 M:1081921536   DEBUG: CWinEventsWin32::WndProcWindow gained focus
23:17:55 T:6884 M:1081896960 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:55 T:6884 M:1081905152 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:55 T:6884 M:1081913344 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:55 T:6884 M:1081888768 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:55 T:6884 M:1081888768 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:55 T:6884 M:1081888768 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:56 T:6884 M:1081905152 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:56 T:6884 M:1081925632 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:56 T:6884 M:1081925632 WARNING: CDVDVideoCodecFFmpeg::Decode - avcodec_decode_video didn't consume the full packet. size: 902, consumed: 0
23:17:56 T:6884 M:1081925632 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:56 T:6884 M:1081925632 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:57 T:6884 M:1081925632    INFO: ffmpeg[1AE4]: [h264] concealing 1188 DC, 1188 AC, 1188 MV errors
23:17:57 T:6884 M:1081913344    INFO: ffmpeg[1AE4]: [h264] concealing 1188 DC, 1188 AC, 1188 MV errors
23:17:57 T:6884 M:1081905152 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:57 T:6884 M:1081905152 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:57 T:6884 M:1081905152 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:57 T:6884 M:1081905152 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:57 T:6884 M:1081921536 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:58 T:6884 M:1081925632 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:58 T:6884 M:1081888768 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:58 T:6884 M:1081888768 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:58 T:6884 M:1081888768 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:58 T:2652 M:1081884672   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27824115.472567, should be:27608517.240363, error:-215598.232204
23:17:58 T:6884 M:1081884672 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:59 T:2652 M:1081884672   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27757946.008544, should be:27608517.240363, error:-149428.768181
23:17:59 T:2652 M:1081884672 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
23:17:59 T:6884 M:1081884672 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:59 T:2652 M:1081884672   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27765265.374553, should be:27608517.240363, error:-156748.134190
23:17:59 T:6884 M:1081884672 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:17:59 T:6884 M:1081884672 WARNING: CDVDVideoCodecFFmpeg::Decode - avcodec_decode_video didn't consume the full packet. size: 100, consumed: 0
23:17:59 T:6560 M:1081884672   DEBUG: ------ Window Deinit (DialogPluginSettings.xml) ------
23:17:59 T:2652 M:1081884672   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27732543.897382, should be:27608517.240363, error:-124026.657019
23:17:59 T:2652 M:1081884672   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27747673.473906, should be:27608517.240363, error:-139156.233544
23:17:59 T:2652 M:1081905152   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27748662.705778, should be:27608517.240363, error:-140145.465415
23:17:59 T:2652 M:1081905152 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
23:17:59 T:2652 M:1081913344   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27988951.345815, should be:27789745.897689, error:-199205.448125
23:18:00 T:2652 M:1081913344 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
23:18:00 T:6884 M:1081917440 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:18:00 T:6884 M:1081917440 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:18:00 T:6884 M:1081946112 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:18:00 T:6884 M:1081946112 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:18:00 T:6884 M:1081946112 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:18:01 T:6560 M:1081925632    INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://movies.apple.com (easy=09AD4FE8, multi=05B2F700)
23:18:01 T:6884 M:1081925632    INFO: ffmpeg[1AE4]: [h264] concealing 1188 DC, 1188 AC, 1188 MV errors
23:18:02 T:4704 M:1081311232   DEBUG: CDVDPlayer::SetCaching - started caching
23:18:02 T:6560 M:1081311232   DEBUG: ------ Window Init (DialogSeekBar.xml) ------
23:18:02 T:6560 M:1081311232   DEBUG: Alloc resources: 0.02ms (0.00 ms skin load)
23:18:02 T:6560 M:1081294848   DEBUG: SECTION:UnloadDelayed(SECTION: LCODE)
23:18:02 T:6560 M:1081294848   DEBUG: SECTION:UnloadDelayed(DLL: special://xbmc/system/ImageLib.dll)
23:18:02 T:6560 M:1081294848   DEBUG: Win32DllLoader::Unload ImageLib.dll
23:18:02 T:6560 M:1081294848   DEBUG: FreeLibrary(MSVCR71.dll) -> 022B06A0
23:18:02 T:6560 M:1081294848   DEBUG: FreeLibrary(MSVCP71.dll) -> 06F51088
23:18:02 T:6560 M:1081294848   DEBUG: Win32DllLoader::Unload MSVCP71.dll
23:18:02 T:6560 M:1081294848   DEBUG: FreeLibrary(MSVCR71.dll) -> 022B06A0
23:18:03 T:6560 M:1082126336   DEBUG: SDLKeyboard: scancode: 57, sym: 32, unicode: 32, modifier: 0
23:18:03 T:6560 M:1082126336   DEBUG: CApplication::OnKey: 61472 pressed, action is 12
23:18:03 T:6560 M:1082126336   DEBUG: CDVDPlayer::SetCaching - stopped caching
23:18:03 T:2652 M:1082126336   DEBUG: CDVDPlayerAudio:: Discontinuty - was:30500538.191123, should be:29406876.216773, error:-1093661.974350
23:18:03 T:2652 M:1082126336 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
23:18:03 T:6884 M:1082126336 WARNING: CDVDVideoCodecFFmpeg::Decode - avcodec_decode_video didn't consume the full packet. size: 1796, consumed: 0
23:18:03 T:6560 M:1082126336   DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
23:18:03 T:6884 M:1082126336 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:18:03 T:6884 M:1082130432    INFO: ffmpeg[1AE4]: [h264] concealing 1188 DC, 1188 AC, 1188 MV errors
23:18:04 T:6884 M:1082134528 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:18:04 T:6884 M:1082150912 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:18:04 T:6560 M:1082130432   DEBUG: SDLKeyboard: scancode: 57, sym: 32, unicode: 32, modifier: 0
23:18:04 T:6560 M:1082130432   DEBUG: CApplication::OnKey: 61472 pressed, action is 12
23:18:04 T:6560 M:1082130432   DEBUG: CApplication::OnPlayBackPaused - Playback was paused
23:18:04 T:6560 M:1082130432   DEBUG: ------ Window Init (DialogSeekBar.xml) ------
23:18:04 T:6560 M:1082130432   DEBUG: Alloc resources: 0.15ms (0.00 ms skin load)
23:18:08 T:6560 M:1082290176   DEBUG: SDLKeyboard: scancode: 57, sym: 32, unicode: 32, modifier: 0
23:18:08 T:6560 M:1082290176   DEBUG: CApplication::OnKey: 61472 pressed, action is 12
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:30923220.053769, should be:30950094.777832, error:26874.724063
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.224669, should be:30950605.457262, error:3506665.232592
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30951021.990648, error:3507081.486614
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.783400, should be:30951453.609750, error:3507512.826351
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30951860.924088, error:3507920.420053
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30952852.390880, error:3508911.886846
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.224669, should be:30953334.854434, error:3509394.629764
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30953732.949722, error:3509792.445688
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.783400, should be:30954147.527553, error:3510206.744153
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.783400, should be:30954536.962523, error:3510596.179123
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30954948.187972, error:3511007.683937
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30955370.308661, error:3511429.804626
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30955753.876963, error:3511813.372929
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.783400, should be:30956271.540521, error:3512330.757121
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30956682.207240, error:3512741.703205
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.783400, should be:30957095.667610, error:3513154.884210
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.783400, should be:30957489.293057, error:3513548.509657
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.783400, should be:30957910.855015, error:3513970.071615
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30958292.467762, error:3514351.963727
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.783400, should be:30958786.944015, error:3514846.160615
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.783400, should be:30959319.972654, error:3515379.189255
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.783400, should be:30959694.601273, error:3515753.817874
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30960087.388625, error:3516146.884590
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.783400, should be:30960490.233120, error:3516549.449721
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30960886.093488, error:3516945.589453
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30961274.969728, error:3517334.465693
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.783400, should be:30961673.903112, error:3517733.119712
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30962620.112756, error:3518679.608721
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.224669, should be:30963107.046151, error:3519166.821481
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30963523.300172, error:3519582.796138
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.783400, should be:30963924.189112, error:3519983.405712
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30964354.690754, error:3520414.186719
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30964783.516205, error:3520843.012171
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30965202.284512, error:3521261.780478
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30965593.395673, error:3521652.891638
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.783400, should be:30966002.106836, error:3522061.323436
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30966392.659267, error:3522452.155232
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30966800.532334, error:3522860.028300
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30967210.081593, error:3523269.577558
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30967603.427674, error:3523662.923640
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.783400, should be:30967996.773756, error:3524055.990356
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30968401.853172, error:3524461.349138
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.504035, should be:30968799.669096, error:3524859.165061
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27443940.783400, should be:30969193.015178, error:3525252.231778
23:18:08 T:6560 M:1082290176   DEBUG: CApplication::OnPlayBackResumed - Playback was resumed
23:18:08 T:6560 M:1082290176   DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
23:18:08 T:2652 M:1082290176   DEBUG: CDVDPlayerAudio:: Discontinuty - was:27455114.829263, should be:31024509.542837, error:3569394.713574
23:18:08 T:6884 M:1082290176 WARNING: CDVDVideoCodecFFmpeg::Decode - avcodec_decode_video didn't consume the full packet. size: 5373, consumed: 0
23:18:12 T:6884 M:1082327040   DEBUG: CPullupCorrection: detected pattern of length 1: 41666.67
23:18:13 T:2652 M:1082327040 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
23:18:13 T:2652 M:1082306560 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
23:18:13 T:2652 M:1082306560 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
23:18:14 T:2652 M:1082306560 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
23:18:14 T:6884 M:1082310656 WARNING: CDVDMessageQueue(video)::Get - retrieved last data packet of queue
23:18:14 T:6884 M:1082314752    INFO: ffmpeg[1AE4]: [h264] concealing 1188 DC, 1188 AC, 1188 MV errors
23:18:14 T:6884 M:1082314752    INFO: ffmpeg[1AE4]: [h264] concealing 1188 DC, 1188 AC, 1188 MV errors
23:18:15 T:4704 M:1082314752   DEBUG: CDVDPlayer::SetCaching - started caching
23:18:15 T:6560 M:1082314752   DEBUG: ------ Window Init (DialogSeekBar.xml) ------
23:18:15 T:6560 M:1082314752   DEBUG: Alloc resources: 0.28ms (0.00 ms skin load)
23:18:16 T:6560 M:1082490880   DEBUG: SDLKeyboard: scancode: 57, sym: 32, unicode: 32, modifier: 0
23:18:16 T:6560 M:1082490880   DEBUG: CApplication::OnKey: 61472 pressed, action is 12
23:18:16 T:6560 M:1082490880   DEBUG: CDVDPlayer::SetCaching - stopped caching
23:18:16 T:2652 M:1082490880 WARNING: CWin32DirectSound::GetSpace - buffer underrun - W:151656, P:146364, O:148608.
23:18:16 T:2652 M:1082490880   DEBUG: CDVDPlayerAudio:: Discontinuty - was:38027659.943237, should be:38026036.944080, error:-1622.999157
23:18:16 T:2652 M:1082490880   DEBUG: CWin32DirectSound::CheckPlayStatus: Resuming Playback
23:18:16 T:2652 M:1082490880 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
23:18:16 T:6884 M:1082490880 WARNING: CDVDVideoCodecFFmpeg::Decode - avcodec_decode_video didn't consume the full packet. size: 4802, consumed: 0
23:18:16 T:6560 M:1082490880   DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
23:18:17 T:2652 M:1082490880 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
23:18:17 T:2652 M:1082490880 WARNING: CDVDMessageQueue(audio)::Get - retrieved last data packet of queue
23:18:17 T:6560 M:1082490880   DEBUG: SDLKeyboard: scancode: 45, sym: 120, unicode: 120, modifier: 0
23:18:17 T:6560 M:1082490880   DEBUG: CApplication::OnKey: 61528 pressed, action is 13
23:18:17 T:6560 M:1082490880  NOTICE: CDVDPlayer::CloseFile()
23:18:17 T:4704 M:1082490880   DEBUG: CApplication::OnPlayBackSpeedChanged - Playback speed changed
23:18:17 T:6560 M:1082490880  NOTICE: DVDPlayer: waiting for threads to exit
23:18:17 T:4704 M:1082490880  NOTICE: CDVDPlayer::OnExit()
23:18:17 T:4704 M:1082490880  NOTICE: DVDPlayer: closing audio stream
23:18:17 T:4704 M:1082490880  NOTICE: Closing audio stream
23:18:17 T:2652 M:1082490880   DEBUG: CDVDPlayerAudio::Process - Abort received, exiting thread
23:18:17 T:2652 M:1082490880  NOTICE: thread end: CDVDPlayerAudio::OnExit()
23:18:17 T:2652 M:1082490880   DEBUG: Thread 2652 terminating
23:18:17 T:4704 M:1082544128  NOTICE: Waiting for audio thread to exit
23:18:17 T:4704 M:1082544128  NOTICE: Closing audio device
23:18:17 T:4704 M:1082544128   DEBUG: CWin32DirectSound::Deinitialize: Cleaning up
23:18:17 T:4704 M:1082544128  NOTICE: Deleting audio codec
23:18:17 T:4704 M:1082544128  NOTICE: DVDPlayer: closing video stream
23:18:17 T:4704 M:1082544128  NOTICE: Closing video stream
23:18:17 T:4704 M:1082544128  NOTICE: waiting for video thread to exit
23:18:17 T:6884 M:1082544128  NOTICE: thread end: video_thread
23:18:17 T:6884 M:1082544128   DEBUG: Thread 6884 terminating
23:18:17 T:4704 M:1082580992  NOTICE: deleting video codec
23:18:17 T:4704 M:1085698048  NOTICE: CDVDPlayer::OnExit() deleting demuxer
23:18:17 T:4704 M:1086521344  NOTICE: CDVDPlayer::OnExit() deleting input stream
23:18:17 T:3512 M:1086521344   DEBUG: Thread 3512 terminating
23:18:17 T:4704 M:1086566400   DEBUG: FileCurl::Close(06D1B078) http://movies.apple.com/movies/independent/44inchchest/44inchchest_h480p.mov?
23:18:17 T:4704 M:1102336000   DEBUG: CApplication::OnPlayBackStopped - Playback was stopped
23:18:17 T:4704 M:1102336000   DEBUG: Thread 4704 terminating
23:18:17 T:7168 M:1102413824   DEBUG: FileCurl::Open(06E88350) http://post.audioscrobbler.com/?hs=true&p=1.2.1&c=xbm&v=0.2&u=timdog82001&t=1261984697&a=caeb7cfe545e41be161bb58e392298b6
23:18:17 T:7168 M:1102413824    INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://post.audioscrobbler.com
23:18:17 T:6560 M:1102413824  NOTICE: DVDPlayer: finished waiting
23:18:17 T:6560 M:1105707008  NOTICE: CDVDPlayer::CloseFile()
23:18:17 T:6560 M:1105707008 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
23:18:17 T:6560 M:1105707008  NOTICE: DVDPlayer: waiting for threads to exit
23:18:17 T:6560 M:1105707008  NOTICE: DVDPlayer: finished waiting
23:18:17 T:6560 M:1106952192   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
23:18:17 T:6560 M:1106952192   DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------
23:18:17 T:6560 M:1106391040   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
23:18:17 T:6560 M:1106391040   DEBUG: ------ Window Init (MyScripts.xml) ------
23:18:17 T:6560 M:1106391040    INFO: Loading skin file: MyScripts.xml
23:18:17 T:6560 M:1106366464   DEBUG: Load MyScripts.xml: 16.72ms
23:18:17 T:6560 M:1106337792   DEBUG: Alloc resources: 19.58ms (16.80 ms skin load)
23:18:17 T:6560 M:1106337792   DEBUG: CGUIMediaWindow::GetDirectory (special://home/scripts)
23:18:17 T:6560 M:1106337792   DEBUG:   ParentPath = [special://home/scripts]
23:18:17 T:6560 M:1106337792   DEBUG: CGUIMediaWindow::GetDirectory (special://home/scripts)
23:18:17 T:6560 M:1106337792   DEBUG:   ParentPath = [special://home/scripts]
23:18:17 T:6560 M:1105379328   DEBUG: CGUIAudioManager::Initialize
23:18:17 T:3752 M:1105379328   DEBUG: thread start, auto delete: 1
23:18:17 T:3752 M:1105391616   DEBUG: Win32DllLoader::Load(special://xbmc/system/ImageLib.dll)
23:18:17 T:3752 M:1105252352   DEBUG: LoadLibraryA('MSVCR71.dll')
23:18:17 T:3752 M:1105252352   DEBUG: LoadLibrary('MSVCR71.dll') returning: 022B06A0
23:18:17 T:3752 M:1105252352   DEBUG: LoadLibraryA('MSVCP71.dll')
23:18:17 T:3752 M:1105252352   DEBUG: Win32DllLoader::Load(MSVCP71.dll)
23:18:17 T:3752 M:1105252352   DEBUG: LoadLibraryA('MSVCR71.dll')
23:18:17 T:3752 M:1105252352   DEBUG: LoadLibrary('MSVCR71.dll') returning: 022B06A0
23:18:17 T:3752 M:1105252352   DEBUG: LoadLibrary('MSVCP71.dll') returning: 06F44608
23:18:17 T:6560 M:1101934592   DEBUG: CApplication::SaveFileState - Saving file state for video item http://movies.apple.com/movies/independent/44inchchest/44inchchest_h480p.mov?|User-Agent=QuickTime%2F7.2+%28qtver%3D7.2%3Bos%3DWindows+NT+5.1Service+Pack+3%29
23:18:17 T:3752 M:1100075008   DEBUG: CImageLoader::DoWork - took 310 ms to load special://skin/backgrounds/scripts.jpg
23:18:17 T:3752 M:1099821056   DEBUG: CImageLoader::DoWork - took 43 ms to load special://masterprofile/Thumbnails/Programs/30d1cb6e.tbn
23:18:18 T:7168 M:1100357632   DEBUG: FileCurl::Close(06E88350) http://post.audioscrobbler.com/?hs=true&p=1.2.1&c=xbm&v=0.2&u=timdog82001&t=1261984697&a=caeb7cfe545e41be161bb58e392298b6
23:18:18 T:7168 M:1100357632   DEBUG: CLastfmScrobbler: Handshake succeeded!
23:18:18 T:7168 M:1100357632   DEBUG: CLastfmScrobbler: SessionID is b6c95b4af41945339697d96a40dde6dd
23:18:18 T:7168 M:1100357632   DEBUG: CLastfmScrobbler: NP URL is http://post.audioscrobbler.com:80/np_1.2
23:18:18 T:7168 M:1100357632   DEBUG: CLastfmScrobbler: Submit URL is http://post2.audioscrobbler.com:80/protocol_1.2
23:18:20 T:6560 M:1099124736   DEBUG: SDLKeyboard: scancode: 1, sym: 27, unicode: 27, modifier: 0
23:18:20 T:6560 M:1099124736   DEBUG: CApplication::OnKey: 61467 pressed, action is 10
23:18:20 T:6560 M:1099116544   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
23:18:20 T:6560 M:1099116544   DEBUG: ------ Window Deinit (MyScripts.xml) ------
23:18:20 T:6560 M:1099116544   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
23:18:20 T:6560 M:1099116544   DEBUG: ------ Window Init (Home.xml) ------
23:18:20 T:6560 M:1099116544    INFO: Loading skin file: Home.xml
23:18:20 T:6560 M:1099071488   DEBUG: Load Home.xml: 23.12ms
23:18:20 T:6560 M:1099026432   DEBUG: Alloc resources: 24.63ms (23.22 ms skin load)
23:18:20 T:6560 M:1094803456   DEBUG: CApplication::ExecuteXBMCAction : Translating SetFocus(9000)
23:18:20 T:6560 M:1094803456   DEBUG: CApplication::ExecuteXBMCAction : To SetFocus(9000)
23:18:21 T:6560 M:1094840320   DEBUG: SDLKeyboard: scancode: 80, sym: 274, unicode: 0, modifier: 0
23:18:21 T:6560 M:1094840320   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
23:18:22 T:6560 M:1089785856   DEBUG: SDLKeyboard: scancode: 80, sym: 274, unicode: 0, modifier: 0
23:18:22 T:6560 M:1089785856   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
23:18:22 T:6608 M:1089646592   DEBUG: thread start, auto delete: 1
23:18:22 T:6560 M:1087668224   DEBUG: SDLKeyboard: scancode: 80, sym: 274, unicode: 0, modifier: 0
23:18:22 T:6560 M:1087668224   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
23:18:22 T:3884 M:1084878848   DEBUG: thread start, auto delete: 1
23:18:22 T:3752 M:1087258624   DEBUG: CImageLoader::DoWork - took 558 ms to load C:\Users\Tim\XBMC Stuff\XBMC Wallpapers\weather\33\2147059000_101aba5cb3_o.jpg
23:18:22 T:6560 M:1089015808   DEBUG: SDLKeyboard: scancode: 28, sym: 13, unicode: 13, modifier: 0
23:18:22 T:6560 M:1089015808   DEBUG: CApplication::OnKey: 61453 pressed, action is 7
23:18:22 T:6560 M:1089003520   DEBUG: CApplication::ExecuteXBMCAction : Translating ActivateWindow(Videos)
23:18:22 T:6560 M:1089003520   DEBUG: CApplication::ExecuteXBMCAction : To ActivateWindow(Videos)
23:18:22 T:6560 M:1089003520   DEBUG: Activating window ID: 10025
23:18:22 T:6560 M:1089003520   DEBUG: Checking if window ID 10024 is locked.
23:18:22 T:6560 M:1089003520   DEBUG: ------ Window Deinit (Home.xml) ------
23:18:22 T:6560 M:1083203584    INFO: Attempting to default to:
23:18:22 T:6560 M:1083138048   DEBUG: ------ Window Init (MyVideoNav.xml) ------
23:18:22 T:6560 M:1083138048    INFO: Loading skin file: MyVideoNav.xml
23:18:23 T:6560 M:1081925632   DEBUG: Load MyVideoNav.xml: 85.69ms
23:18:23 T:6560 M:1081888768   DEBUG: Alloc resources: 89.80ms (85.78 ms skin load)
23:18:23 T:6560 M:1081880576   DEBUG: CGUIMediaWindow::GetDirectory ()
23:18:23 T:6560 M:1081880576   DEBUG:   ParentPath = []
23:18:23 T:2732 M:1077968896   DEBUG: thread start, auto delete: 0
23:18:23 T:2732 M:1077964800   DEBUG: Thread 2732 terminating
23:18:23 T:6608 M:1080520704   DEBUG: CImageLoader::DoWork - took 1174 ms to load C:\Users\Tim\XBMC Stuff\XBMC Wallpapers\pictures\01702_antwerpcentralstation_1920x1080.jpg
23:18:23 T:3884 M:1084239872   DEBUG: CImageLoader::DoWork - took 784 ms to load C:\Users\Tim\XBMC Stuff\XBMC Wallpapers\Videos\panslabyrinthb1080.jpg
23:18:23 T:3752 M:1086214144   DEBUG: CImageLoader::DoWork - took 1387 ms to load C:\Users\Tim\XBMC Stuff\XBMC Wallpapers\Videos\sonoframbow1080.jpg
23:18:23 T:6560 M:1089245184   DEBUG: SDLKeyboard: scancode: 93, sym: 319, unicode: 0, modifier: 0
23:18:23 T:6560 M:1089245184   DEBUG: CApplication::OnKey: 61533 pressed, action is 117
23:18:23 T:6560 M:1089458176   DEBUG: CFavourites::Load - no system favourites found, skipping
23:18:23 T:6560 M:1089458176   DEBUG: CFavourites::Load - no userdata favourites found, skipping
23:18:23 T:6560 M:1089454080    INFO: Loading skin file: DialogContextMenu.xml
23:18:23 T:6560 M:1089449984   DEBUG: Load DialogContextMenu.xml: 1.83ms
23:18:23 T:6560 M:1089449984   DEBUG: ------ Window Init (DialogContextMenu.xml) ------
23:18:23 T:6560 M:1089462272   DEBUG: Alloc resources: 0.30ms (0.00 ms skin load)
23:18:24 T:6560 M:1091375104   DEBUG: SDLKeyboard: scancode: 72, sym: 273, unicode: 0, modifier: 0
23:18:24 T:6560 M:1091375104   DEBUG: CApplication::OnKey: 61478 pressed, action is 3
23:18:25 T:6560 M:1091371008   DEBUG: SDLKeyboard: scancode: 72, sym: 273, unicode: 0, modifier: 0
23:18:25 T:6560 M:1091371008   DEBUG: CApplication::OnKey: 61478 pressed, action is 3
23:18:25 T:6560 M:1094909952   DEBUG: SDLKeyboard: scancode: 28, sym: 13, unicode: 13, modifier: 0
23:18:25 T:6560 M:1094909952   DEBUG: CApplication::OnKey: 61453 pressed, action is 7
23:18:25 T:6560 M:1094897664   DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------
23:18:25 T:6560 M:1094905856   DEBUG: Activating window ID: 10028
23:18:25 T:6560 M:1094905856   DEBUG: Checking if window ID 10028 is locked.
23:18:25 T:6560 M:1094905856   DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
23:18:25 T:6560 M:1094856704   DEBUG: ------ Window Init (MyVideoPlaylist.xml) ------
23:18:25 T:6560 M:1094856704    INFO: Loading skin file: MyVideoPlaylist.xml
23:18:25 T:6560 M:1094832128   DEBUG: Load MyVideoPlaylist.xml: 17.70ms
23:18:25 T:6560 M:1094795264   DEBUG: Alloc resources: 20.30ms (17.78 ms skin load)
23:18:25 T:6560 M:1094795264   DEBUG: CGUIMediaWindow::GetDirectory (playlistvideo://)
23:18:25 T:6560 M:1094795264   DEBUG:   ParentPath = []
23:18:25 T:3884 M:1095487488   DEBUG: CImageLoader::DoWork - took 28 ms to load C:\Users\Tim\AppData\Roaming\XBMC\userdata\script_data\Apple Movie Trailers\.cache\e\ea46689cc15800e8f847c1576e546379.jpg
23:18:26 T:6484 M:1091596288   DEBUG: thread start, auto delete: 0
23:18:26 T:3752 M:1091641344   DEBUG: CThumbExtractor::DoWork - trying to extract thumb from video file C:\Users\Tim\XBMC Stuff\Home Theater Stuff\Short Films\The.Cathedral.Poland-pp.avi
23:18:26 T:3752 M:1091108864   DEBUG: CDVDDemuxFFmpeg::Open - probing detected format [avi]
23:18:26 T:3752 M:1090686976   DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info starting
23:18:26 T:3752 M:1090109440   DEBUG: ffmpeg[EA8]: [NULL] Invalid and inefficient vfw-avi packed B frames detected
23:18:26 T:3752 M:1089552384   DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished
23:18:26 T:3752 M:1089552384    INFO: ffmpeg[EA8]: Input #0, avi, from 'C:\Users\Tim\XBMC Stuff\Home Theater Stuff\Short Films\The.Cathedral.Poland-pp.avi':
23:18:26 T:3752 M:1089552384    INFO: ffmpeg[EA8]:   Duration: 00:07:01.88, start: 0.000000, bitrate: 1009 kb/s
23:18:26 T:3752 M:1089552384    INFO: ffmpeg[EA8]:     Stream #0.0: Video: mpeg4, yuv420p, 560x288 [PAR 1:1 DAR 35:18], 23.98 tbr, 23.98 tbn, 23.98 tbc
23:18:26 T:3752 M:1089552384    INFO: ffmpeg[EA8]:     Stream #0.1: Audio: mp3, 32000 Hz, 2 channels, s16, 73 kb/s
23:18:26 T:3752 M:1089552384   DEBUG: FactoryCodec - Video:  - Opening
23:18:26 T:3752 M:1089552384  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-4 part 2
23:18:26 T:3752 M:1089552384   DEBUG: FactoryCodec - Video: ff-mpeg4 - Opened
23:18:26 T:3752 M:1089552384   DEBUG: CDVDFileInfo::ExtractThumb - seeking to pos 140628ms (total: 421884ms) in C:\Users\Tim\XBMC Stuff\Home Theater Stuff\Short Films\The.Cathedral.Poland-pp.avi
23:18:26 T:3752 M:1089552384   DEBUG: CDVDDemuxFFmpeg::SeekTime - unknown position after seek
23:18:26 T:6484 M:1089605632   DEBUG: Thread 6484 terminating
23:18:26 T:3752 M:1089630208   DEBUG: ffmpeg[EA8]: [NULL] Invalid and inefficient vfw-avi packed B frames detected
23:18:26 T:3752 M:1089212416   DEBUG: ffmpeg[EA8]: [mpeg4] Invalid and inefficient vfw-avi packed B frames detected
23:18:26 T:3752 M:1090830336   DEBUG: CDVDFileInfo::ExtractThumb - measured 83 ms to extract thumb from file <C:\Users\Tim\XBMC Stuff\Home Theater Stuff\Short Films\The.Cathedral.Poland-pp.avi>
23:18:26 T:6608 M:1091194880   DEBUG: CImageLoader::DoWork - took 555 ms to load C:\Users\Tim\XBMC Stuff\XBMC Wallpapers\Videos\panslabyrinth1080.jpg
23:18:35 T:6560 M:1095536640   DEBUG: SDLKeyboard: scancode: 80, sym: 274, unicode: 0, modifier: 0
23:18:35 T:6560 M:1095536640   DEBUG: CApplication::OnKey: 61480 pressed, action is 4
23:18:35 T:3884 M:1094385664   DEBUG: CImageLoader::DoWork - took 20 ms to load special://masterprofile/Thumbnails/Video/f/auto-f7c68dff.tbn
23:18:36 T:6560 M:1094197248   DEBUG: SDLKeyboard: scancode: 72, sym: 273, unicode: 0, modifier: 0
23:18:36 T:6560 M:1094197248   DEBUG: CApplication::OnKey: 61478 pressed, action is 3
23:18:37 T:3752 M:1090572288   DEBUG: CImageLoader::DoWork - took 387 ms to load C:\Users\Tim\XBMC Stuff\XBMC Wallpapers\Videos\explorers1080.jpg
23:18:38 T:6560 M:1090674688   DEBUG: SDLKeyboard: scancode: 31, sym: 115, unicode: 115, modifier: 0
23:18:38 T:6560 M:1090674688   DEBUG: CApplication::OnKey: 61523 pressed, action is 122
23:18:38 T:6560 M:1090674688   DEBUG: Activating window ID: 10111
23:18:38 T:6560 M:1090674688   DEBUG: Checking if window ID 10111 is locked.
23:18:38 T:6560 M:1090674688   DEBUG: ------ Window Init (DialogButtonMenu.xml) ------
23:18:38 T:6560 M:1090674688    INFO: Loading skin file: DialogButtonMenu.xml
23:18:38 T:6560 M:1090662400   DEBUG: Load DialogButtonMenu.xml: 4.95ms
23:18:38 T:6560 M:1090420736   DEBUG: Alloc resources: 8.87ms (5.02 ms skin load)
23:18:39 T:6560 M:1090318336   DEBUG: SDLKeyboard: scancode: 75, sym: 276, unicode: 0, modifier: 0
23:18:39 T:6560 M:1090318336   DEBUG: CApplication::OnKey: 61477 pressed, action is 1
23:18:39 T:6560 M:1090314240   DEBUG: SDLKeyboard: scancode: 28, sym: 13, unicode: 13, modifier: 0
23:18:39 T:6560 M:1090314240   DEBUG: CApplication::OnKey: 61453 pressed, action is 7
23:18:39 T:6560 M:1090301952   DEBUG: CApplication::ExecuteXBMCAction : Translating XBMC.Quit()
23:18:39 T:6560 M:1090301952   DEBUG: CApplication::ExecuteXBMCAction : To XBMC.Quit()
23:18:39 T:6608 M:1090301952   DEBUG: Thread 6608 terminating (autodelete)
23:18:39 T:3884 M:1090420736   DEBUG: Thread 3884 terminating (autodelete)
23:18:39 T:3752 M:1090461696   DEBUG: Thread 3752 terminating (autodelete)
23:18:39 T:6560 M:1090621440  NOTICE: Storing total System Uptime
23:18:39 T:6560 M:1090621440  NOTICE: Saving settings
23:18:39 T:6560 M:1090621440  NOTICE: stop all
23:18:39 T:6560 M:1090621440   DEBUG: CNetwork::NetworkMessage - Signaling network services to stop
23:18:39 T:6560 M:1090621440  NOTICE: ES: Stopping event server
23:18:39 T:6560 M:1090621440   DEBUG: CNetwork::NetworkMessage - Waiting for network services to stop
23:18:39 T:7168 M:1090621440   DEBUG: CLastfmScrobbler: Thread ended.
23:18:39 T:7168 M:1090621440   DEBUG: Thread 7168 terminating
23:18:39 T:6560 M:1090621440   DEBUG: CLastfmScrobbler: Journal with 0 entries saved to special://masterprofile/LastfmScrobbler.xml
23:18:39 T:6560 M:1090617344   DEBUG: CLibrefmScrobbler: Journal with 0 entries saved to special://masterprofile/LibrefmScrobbler.xml
23:18:40 T:4108 M:1090781184  NOTICE: ES: UDP Event server stopped
23:18:40 T:4108 M:1090781184   DEBUG: Thread 4108 terminating
23:18:40 T:6560 M:1090781184  NOTICE: stop sap announcement listener
23:18:40 T:6560 M:1090781184  NOTICE: clean cached files!
23:18:40 T:6560 M:1090772992  NOTICE: unload skin
23:18:40 T:6560 M:1090772992   DEBUG: CGUIAudioManager::DeInitialize
23:18:40 T:6560 M:1090772992   DEBUG: ------ Window Deinit (MyVideoPlaylist.xml) ------
23:18:40 T:6560 M:1090772992   DEBUG: ------ Window Deinit (Pointer.xml) ------
23:18:40 T:6560 M:1090772992   DEBUG: ------ Window Deinit (DialogMuteBug.xml) ------
23:18:40 T:6560 M:1102970880  NOTICE: stop python
23:18:40 T:6560 M:1102970880  NOTICE: stopped
23:18:40 T:6560 M:1102970880  NOTICE: destroy
23:18:40 T:6560 M:1102934016  NOTICE: unload sections
23:18:40 T:6560 M:1102934016   DEBUG: SECTION:UnloadAll(SECTION: LIBHTTP)
23:18:40 T:6560 M:1102934016   DEBUG: SECTION:UnloadAll(DLL: special://xbmc/system/libcurl.dll)
23:18:40 T:6560 M:1102934016   DEBUG: Win32DllLoader::Unload libcurl.dll
23:18:40 T:6560 M:1102934016   DEBUG: FreeLibrary(MSVCR71.dll) -> 022B06A0
23:18:40 T:6560 M:1103499264   DEBUG: SECTION:UnloadAll(DLL: special://xbmc/system/players/dvdplayer/avutil-50.dll)
23:18:40 T:6560 M:1103499264   DEBUG: SECTION:UnloadAll(DLL: special://xbmc/system/players/dvdplayer/avcodec-52.dll)
23:18:40 T:6560 M:1103499264   DEBUG: SECTION:UnloadAll(DLL: special://xbmc/system/players/dvdplayer/avformat-52.dll)
23:18:40 T:6560 M:1103499264   DEBUG: Win32DllLoader::Unload avformat-52.dll
23:18:40 T:6560 M:1103499264   DEBUG: FreeLibrary(avcodec-52.dll) -> 06F51A38
23:18:40 T:6560 M:1103499264   DEBUG: Win32DllLoader::Unload avcodec-52.dll
23:18:40 T:6560 M:1103499264   DEBUG: FreeLibrary(libfaad.dll) -> 06F50A98
23:18:40 T:6560 M:1103499264   DEBUG: FreeLibrary(avutil-50.dll) -> 06F4D258
23:18:40 T:6560 M:1103499264   DEBUG: FreeLibrary(avutil-50.dll) -> 06F4D258
23:18:40 T:6560 M:1107382272   DEBUG: SECTION:UnloadAll(DLL: special://xbmc/system/players/dvdplayer/swscale-0.6.1.dll)
23:18:40 T:6560 M:1107382272   DEBUG: Win32DllLoader::Unload swscale-0.6.1.dll
23:18:40 T:6560 M:1107382272   DEBUG: FreeLibrary(avutil-50.dll) -> 06F4D258
23:18:40 T:6560 M:1107382272   DEBUG: Win32DllLoader::Unload avutil-50.dll
23:18:40 T:6560 M:1107566592   DEBUG: SECTION:UnloadAll(DLL: special://xbmc/system/players/dvdplayer/libfaad.dll)
23:18:40 T:6560 M:1107566592   DEBUG: Win32DllLoader::Unload libfaad.dll
23:18:40 T:6560 M:1107931136   DEBUG: SECTION:UnloadAll(DLL: special://xbmc/system/ImageLib.dll)
23:18:40 T:6560 M:1107931136   DEBUG: Win32DllLoader::Unload ImageLib.dll
23:18:40 T:6560 M:1107931136   DEBUG: FreeLibrary(MSVCR71.dll) -> 022B06A0
23:18:40 T:6560 M:1107931136   DEBUG: FreeLibrary(MSVCP71.dll) -> 06F44608
23:18:40 T:6560 M:1107931136   DEBUG: Win32DllLoader::Unload MSVCP71.dll
23:18:40 T:6560 M:1107931136   DEBUG: FreeLibrary(MSVCR71.dll) -> 022B06A0
23:18:40 T:6560 M:1107931136   DEBUG: Win32DllLoader::Unload MSVCR71.dll
23:18:40 T:6560 M:1114796032   DEBUG: CLastfmScrobbler: Journal with 0 entries saved to special://masterprofile/LastfmScrobbler.xml
23:18:40 T:6560 M:1114796032   DEBUG: CLibrefmScrobbler: Journal with 0 entries saved to special://masterprofile/LibrefmScrobbler.xml
23:18:40 T:6560 M:1114796032    INFO: lastfm destroyed