All pastes #521668 Raw Edit

Debug Log

public text v1 · immutable
#521668 ·published 2007-05-30 07:29 UTC
rendered paste body
22:38:41 M: 54480896  NOTICE: -----------------------------------------------------------------------
22:38:41 M: 54460416  NOTICE: Starting XBoxMediaCenter.  Built on May 27 2007
22:38:41 M: 54460416  NOTICE: Q is mapped to: E:\apps\xbmc
22:38:41 M: 54460416  NOTICE: The executeable running is: E:\apps\xbmc\default.xbe
22:38:41 M: 54460416  NOTICE: Log File is located: Q:\xbmc.log
22:38:41 M: 54460416  NOTICE: -----------------------------------------------------------------------
22:38:41 M: 54460416  NOTICE: Unmapped drive T
22:38:41 M: 54460416  NOTICE: Mapping drive T to Harddisk0\Partition1\apps\xbmc\userdata
22:38:41 M: 54460416  NOTICE: Setup DirectX
22:38:42 M: 54439936  NOTICE: Mapping drive C to Harddisk0\Partition2
22:38:42 M: 54439936  NOTICE: Mapping drive E to Harddisk0\Partition1
22:38:42 M: 54439936  NOTICE: Unmapped drive D
22:38:42 M: 54439936  NOTICE: Mapping drive D to Cdrom0
22:38:43 M: 54439936  NOTICE: Mapping drive F to Harddisk0\Partition6
22:38:43 M: 54439936  NOTICE: Mapping drive X to Harddisk0\Partition3
22:38:43 M: 54439936  NOTICE: Mapping drive Y to Harddisk0\Partition4
22:38:43 M: 54439936  NOTICE: Unmapped drive Z
22:38:43 M: 54439936  NOTICE: Mapping drive Z to Harddisk0\Partition5
22:38:43 M: 54439936  NOTICE: load settings...
22:38:43 M: 54439936  NOTICE: Mapping drive P to Harddisk0\Partition1\apps\xbmc\userdata
22:38:43 M: 54439936  NOTICE: loading T:\guisettings.xml
22:38:43 M: 54292480  NOTICE: Getting hardware information now...
22:38:43 M: 54292480  NOTICE: Checking resolution 10
22:38:43 M: 54292480  NOTICE: Setting autoresolution mode 1
22:38:43 M: 54292480  NOTICE: Getting hardware information now...
22:38:43 M: 54272000  NOTICE: Checking resolution 10
22:38:43 M: 54272000  NOTICE: Setting autoresolution mode 1
22:38:43 M: 54272000  NOTICE: Per AV pack settings are off
22:38:43 M: 54390784  NOTICE: q:\userdata\sources.xml
22:38:43 M: 54390784    INFO: Key combination detected for full debug logging (X+Y)
22:38:43 M: 54390784    INFO: Checking skinpath existance, and existence of keymap.xml:Q:\skin...
22:38:43 M: 54390784   DEBUG: We set resolution 4
22:38:44 M: 44650496    INFO: load language info file:Q:\language\english\langinfo.xml
22:38:44 M: 44126208    INFO: load language file:Q:\language\english\strings.xml
22:38:44 M: 42557440    INFO: load keymapping
22:38:44 M: 40472576    INFO: Loading P:\keymap.xml
22:38:44 M: 43880448    INFO: Checking skin version of: Vision
22:38:44 M: 43892736    INFO: Skin version is: 2.1
22:38:44 M: 43892736    INFO:  GUI format 1280x720 720p 16:9
22:38:44 M: 43892736    INFO: install unhandled exception filter
22:38:44 M: 43892736    INFO: creating subdirectories
22:38:44 M: 43892736    INFO: userdata folder: q:\userdata
22:38:44 M: 43892736    INFO:   recording folder:
22:38:44 M: 43892736    INFO:   screenshots folder:
22:38:44 M: 43892736    INFO:   thumbnails folder:q:\userdata\Thumbnails
22:38:44 M: 43880448  NOTICE: Checking the Date!
22:38:44 M: 43880448    INFO: - Current Date is: 29-5-2007
22:38:44 M: 43880448  NOTICE: start dvd mediatype detection
22:38:44 M: 43814912  NOTICE: initializing playlistplayer
22:38:44 M: 43814912  NOTICE: DONE initializing playlistplayer
22:38:44 M: 43814912    INFO: lcd not used
22:38:44 M: 43806720  NOTICE: load default skin:[Vision]
22:38:44 M: 43806720    INFO:   load skin from:Q:\skin\Vision
22:38:44 M: 43806720    INFO:   delete old skin...
22:38:44 M: 43806720    INFO: Default 4:3 resolution directory is Q:\skin\Vision\pal
22:38:44 M: 43806720    INFO: Default 16:9 resolution directory is Q:\skin\Vision\pal16x9
22:38:44 M: 43806720    INFO: Skin version is: 2.1
22:38:44 M: 43806720    INFO: Loading skin includes from Q:\skin\Vision\pal\includes.xml
22:38:44 M: 43290624    INFO:   load fonts for skin...
22:38:44 M: 43290624    INFO: Loading fonts from Q:\skin\Vision\720p\font.xml
22:38:44 M: 43253760   DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Vision\fonts\TCM.ttf (19): width = 24, height = 24
22:38:44 M: 43220992   DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Vision\fonts\TCM.ttf (20): width = 25, height = 25
22:38:44 M: 43184128   DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Vision\fonts\TCM.ttf (20): width = 25, height = 25
22:38:44 M: 43122688   DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Vision\fonts\TCM.ttf (23): width = 29, height = 29
22:38:44 M: 43081728   DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Vision\fonts\TCM.ttf (25): width = 31, height = 31
22:38:44 M: 43016192   DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Vision\fonts\TCM.ttf (28): width = 35, height = 35
22:38:44 M: 42967040   DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Vision\fonts\TCM.ttf (30): width = 38, height = 37
22:38:44 M: 42917888    INFO:   load new skin...
22:38:44 M: 42917888    INFO: Skin version is: 2.1
22:38:44 M: 42917888    INFO: Loading skin file: home.xml
22:38:44 M: 42774528    INFO: Loading user windows, path Q:\skin\Vision\pal16x9
22:38:44 M: 42774528    INFO: Loading user windows, path Q:\skin\Vision\pal
22:38:44 M: 42774528    INFO: Loading skin file: Q:\skin\Vision\pal\custom_SkinSetting_1112.xml
22:38:44 M: 42774528    INFO:   initialize new skin...
22:38:44 M: 42774528    INFO: Loading skin file: Pointer.xml
22:38:44 M: 42668032    INFO: Loading skin file: DialogVolumeBar.xml
22:38:44 M: 42635264    INFO: Loading skin file: DialogSeekbar.xml
22:38:44 M: 42598400    INFO: Loading skin file: DialogKaiToast.xml
22:38:44 M: 42602496    INFO: Loading skin file: DialogMuteBug.xml
22:38:44 M: 42217472    INFO: Loading Q:\skin\Vision\sounds\sounds.xml
22:38:44 M: 42217472    INFO:   skin loaded...
22:38:45 M: 42201088   DEBUG: Activating window ID: 12999
22:38:45 M: 42180608   DEBUG: Checking if window ID 12999 is locked.
22:38:45 M: 41627648    INFO: Loading skin file: Startup.xml
22:38:45 M: 41627648 WARNING: use dashboard
22:38:45 M: 40763392    INFO: removing tempfiles
22:38:45 M: 39624704  NOTICE: initialize done
22:38:45 M: 39624704    INFO: Key combination detected for full debug logging (X+Y)
22:38:45 M: 39624704  NOTICE: Running the application...
22:38:45 M: 39624704   DEBUG: CApplication::OnMessage : Translating ReplaceWindow(Home)
22:38:45 M: 39624704   DEBUG: CApplication::OnMessage : To ReplaceWindow(Home)
22:38:45 M: 39624704   DEBUG: Activating window ID: 10000
22:38:45 M: 39624704   DEBUG: Checking if window ID 10000 is locked.
22:38:45 M: 37666816   DEBUG: FreeVisualisation() started
22:38:45 M: 37666816   DEBUG: FreeVisualisation() done
22:38:45 M: 35409920    INFO: CNetwork::LogState - Link: full duplex
22:38:45 M: 35409920    INFO: CNetwork::LogState - Link: 100 mbps
22:38:45 M: 35409920    INFO: CNetwork::LogState - State: dns
22:38:45 M: 35409920    INFO: CNetwork::LogState - State: static
22:38:45 M: 35409920    INFO: CNetwork::LogState - ip: 10.10.10.195
22:38:45 M: 35409920   DEBUG: CNetwork::NetworkMessage - Starting network services
22:38:45 M: 35409920    INFO: CNetwork::LogState - subnet: 255.255.255.0
22:38:45 M: 35409920  NOTICE: start timeserver client
22:38:45 M: 35344384    INFO: CNetwork::LogState - gateway: 10.10.10.1
22:38:45 M: 35344384  NOTICE: XBFileZilla: Starting...
22:38:45 M: 34754560    INFO: CNetwork::LogState - dns: 10.10.10.250, x.x.x.x
22:38:45 M: 34754560    INFO: Get URL: http://feeds.feedburner.com/XboxScene
22:38:46 M: 34754560   DEBUG: CApplication::OnKey: 168 pressed, action is 2
22:38:47 M: 34676736    INFO: ------------------- BIOS Detection Log ------------------
22:38:47 M: 34676736    INFO: 256k BIOSES: Checksums are (256)
22:38:47 M: 34672640    INFO:   1.Bios > Unknown
22:38:47 M: 34672640    INFO:   Add this to BiosIDs.ini: (256)BiosNameHere = 8E255BE39CC47970E7C1F05CE05039A4
22:38:47 M: 34672640    INFO: ---------------------------------------------------------
22:38:47 M: 35811328   DEBUG: CApplication::OnKey: 11 pressed, action is 7
22:38:47 M: 28696576   DEBUG: CApplication::OnMessage : Translating XBMC.ActivateWindow(MyVideos)
22:38:47 M: 28667904   DEBUG: CApplication::OnMessage : To XBMC.ActivateWindow(MyVideos)
22:38:47 M: 28667904   DEBUG: Activating window ID: 10024
22:38:47 M: 28667904   DEBUG: Checking if window ID 10024 is locked.
22:38:47 M: 35729408   DEBUG: - XBOX Kernel Qfe= 1
22:38:47 M: 35708928   DEBUG: - XBOX Kernel Drive FG result= 1
22:38:47 M: 39309312    INFO: Attempting to default to:
22:38:47 M: 39321600  NOTICE: XBFileZilla: Started
22:38:47 M: 39321600    INFO: Loading skin file: MyVideo.xml
22:38:47 M: 38711296   DEBUG: CGUIMediaWindow::GetDirectory ()
22:38:47 M: 38772736   DEBUG:   ParentPath = []
22:38:47 M: 38772736   DEBUG: CURL::CURL - Url has no protocol .tbn, empty CURL created
22:38:47 M: 38772736   DEBUG: CURL::CURL - Url has no protocol \folder.jpg, empty CURL created
22:38:47 M: 35622912    INFO: WEATHER: Downloading weather
22:38:47 M: 36147200    INFO: Get URL: http://xoap.weather.com/weather/local/85234?cc=*&unit=m&dayf=4&prod=xoap&par=1004124588&key=079f24145f208494
22:38:47 M: 34013184   DEBUG: - CPU Speed: 731.098627MHz
22:38:47 M: 34013184   DEBUG: Video Encoder: CONNEXANT
22:38:47 M: 34013184   DEBUG: - XBOX production info: Country: Mexico, LineNumber: 2, Week 22, Year 2002
22:38:48 M: 28569600   DEBUG: Got rss feed: http://feeds.feedburner.com/XboxScene
22:38:49 M: 28753920    INFO: WEATHER: Weather download successful
22:38:50 M: 24100864  NOTICE: HDD: SMART is supported.
22:38:50 M: 24100864  NOTICE: HDD: SMART is enabled.
22:38:50 M: 24363008   DEBUG: CApplication::OnKey: 168 pressed, action is 2
22:38:50 M: 24100864   ERROR: Unable to wait for NTP reply from the SNTP server, GetLastError returns 10060
22:38:50 M: 29200384   DEBUG: CApplication::OnKey: 167 pressed, action is 4
22:38:51 M: 29200384   DEBUG: DVD Model: THOMSON-DVD
22:38:51 M: 29200384   DEBUG: DVD Firmware: 1.24
22:38:51 M: 29196288   DEBUG: CApplication::OnKey: 167 pressed, action is 4
22:38:51 M: 29720576   DEBUG: CApplication::OnKey: 11 pressed, action is 7
22:38:51 M: 29708288   DEBUG: Clearing cached fileitems [multipath://smb://user:pass@x.x.x.x/videos/ , smb://user:pass@x.x.x.x/MyVideos2/ , smb://user:pass@x.x.x.x/MyVideos3/ , smb://user:pass@x.x.x.x/MyVideos4/ , smb://user:pass@x.x.x.x/MyVideos5/]
22:38:51 M: 29708288   ERROR: XFILE::CFile::Delete - Error deleting file Z:\baf9ebc6.fi
22:38:51 M: 34689024   DEBUG: CGUIMediaWindow::GetDirectory (multipath://smb://user:pass@x.x.x.x/videos/ , smb://user:pass@x.x.x.x/MyVideos2/ , smb://user:pass@x.x.x.x/MyVideos3/ , smb://user:pass@x.x.x.x/MyVideos4/ , smb://user:pass@x.x.x.x/MyVideos5/)
22:38:51 M: 34689024   DEBUG:   ParentPath = []
22:38:51 M: 34689024   DEBUG: CMultiPathDirectory::GetDirectory(multipath://smb://user:pass@x.x.x.x/videos/ , smb://user:pass@x.x.x.x/MyVideos2/ , smb://user:pass@x.x.x.x/MyVideos3/ , smb://user:pass@x.x.x.x/MyVideos4/ , smb://user:pass@x.x.x.x/MyVideos5/)
22:38:51 M: 34689024   DEBUG: Getting Directory (smb://user:pass@x.x.x.x/videos/)
22:38:51 M: 34349056   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://user:pass@x.x.x.x/MyVideos1
22:38:52 M: 34095104   DEBUG: Getting Directory (smb://user:pass@x.x.x.x/MyVideos2/)
22:38:52 M: 34095104   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://user:pass@x.x.x.x/MyVideos2
22:38:52 M: 34095104   DEBUG: Getting Directory (smb://user:pass@x.x.x.x/MyVideos3/)
22:38:52 M: 34095104   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://user:pass@x.x.x.x/MyVideos3
22:38:52 M: 34095104   DEBUG: Getting Directory (smb://user:pass@x.x.x.x/MyVideos4/)
22:38:52 M: 34095104   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://user:pass@x.x.x.x/MyVideos4
22:38:52 M: 34095104   DEBUG: Getting Directory (smb://user:pass@x.x.x.x/MyVideos5/)
22:38:52 M: 34095104   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://user:pass@x.x.x.x/MyVideos5
22:38:52 M: 34095104   DEBUG: CMultiPathDirectory::MergeItems, items = 82
22:38:52 M: 34095104   DEBUG: Testing path: [000] smb://user:pass@x.x.x.x/videos/Video/
22:38:52 M: 34095104   DEBUG: Testing path: [001] smb://user:pass@x.x.x.x/MyVideos5/_Misc/
22:38:52 M: 34095104   DEBUG: CMultiPathDirectory::MergeItems, items = 82,  took 34 ms
22:38:52 M: 34095104 WARNING: CUtil::GetMatchingShare... no matching bookmark found for [smb://user:pass@x.x.x.x/]
22:38:53 M: 31748096   DEBUG: CApplication::OnKey: 11 pressed, action is 7
22:38:53 M: 31735808   DEBUG: Clearing cached fileitems [smb://user:pass@x.x.x.x/videos/Video/]
22:38:53 M: 31735808   ERROR: XFILE::CFile::Delete - Error deleting file Z:\fd964eb3.fi
22:38:53 M: 33832960   DEBUG: CGUIMediaWindow::GetDirectory (smb://user:pass@x.x.x.x/videos/Video/)
22:38:53 M: 33832960   DEBUG:   ParentPath = [multipath://smb://user:pass@x.x.x.x/videos/ , smb://user:pass@x.x.x.x/MyVideos2/ , smb://user:pass@x.x.x.x/MyVideos3/ , smb://user:pass@x.x.x.x/MyVideos4/ , smb://user:pass@x.x.x.x/MyVideos5/]
22:38:53 M: 33832960   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://user:pass@x.x.x.x/MyVideos/Video
22:38:54 M: 32452608   DEBUG: CApplication::OnKey: 168 pressed, action is 2
22:38:54 M: 32452608   DEBUG: CApplication::OnKey: 168 pressed, action is 2
22:38:54 M: 32452608   DEBUG: CApplication::OnKey: 11 pressed, action is 7
22:38:54 M: 32440320   DEBUG: Clearing cached fileitems [smb://user:pass@x.x.x.x/videos/Video/]
22:38:54 M: 32440320   ERROR: XFILE::CFile::Delete - Error deleting file Z:\50776da9.fi
22:38:54 M: 33832960   DEBUG: CGUIMediaWindow::GetDirectory (smb://user:pass@x.x.x.x/videos/Video/)
22:38:54 M: 33832960   DEBUG:   ParentPath = [smb://user:pass@x.x.x.x/videos/Video/]
22:38:54 M: 33832960   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://user:pass@x.x.x.x/MyVideos/Video
22:38:55 M: 33775616   ERROR: Unable to wait for NTP reply from the SNTP server, GetLastError returns 10060
22:38:55 M: 33841152   DEBUG: CApplication::OnKey: 167 pressed, action is 4
22:38:56 M: 33841152   DEBUG: CApplication::OnKey: 167 pressed, action is 4
22:38:56 M: 33841152   DEBUG: CApplication::OnKey: 167 pressed, action is 4
22:38:56 M: 33841152   DEBUG: CApplication::OnKey: 167 pressed, action is 4
22:38:56 M: 33841152   DEBUG: CApplication::OnKey: 167 pressed, action is 4
22:38:58 M: 33841152   DEBUG: CApplication::OnKey: 11 pressed, action is 7
22:38:58 M: 33828864   DEBUG: CPlayerCoreFactor::GetPlayers(smb://user:pass@x.x.x.x/videos/Video/Video.avi)
22:38:58 M: 33304576    INFO: mplayer play:smb://user:pass@x.x.x.x/videos/Video/Video.avi cachesize:2048
22:38:58 M: 33304576   DEBUG: CUtil::CacheSubtitles: START
22:38:58 M: 33304576   DEBUG: CUtil::CacheSubtitles: Checking for common subirs...
22:38:58 M: 33304576   DEBUG: CUtil::CacheSubtitles: Done (time: 22 ms)
22:38:58 M: 33304576   DEBUG: CUtil::CacheSubtitles: Searching for subtitles...
22:38:58 M: 33304576   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://user:pass@x.x.x.x/MyVideos/Video
22:38:58 M: 33304576   DEBUG: CUtil::CacheSubtitles: Done (time: 19 ms)
22:38:58 M: 33304576   DEBUG: CUtil::CacheSubtitles: END (total time: 41 ms)
22:38:59 M: 26226688   DEBUG:   msg:  set audio functions called
22:38:59 M: 26226688   DEBUG:   msg:  done
22:38:59 M: 26226688    INFO: Using -subcp enca:__:CP1252 to detect the subtitle charset
22:38:59 M: 26226688    INFO: Flipping bi-directional subtitles disabled
22:38:59 M: 26226688   DEBUG:   msg: mplayer_init()
22:38:59 M: 26226688   DEBUG:   msg: enable mplayer osd
22:38:59 M: 26226688   DEBUG:   msg: MPlayer XBMC-SVN-r8532 (C) 2000-2004 MPlayer Team
22:38:59 M: 26226688   DEBUG:   msg: CPU: Intel Celeron 2/Pentium III Coppermine,Geyserville
22:38:59 M: 26226688   DEBUG:   msg: (Family: 6, Stepping: 10)
22:38:59 M: 26226688   DEBUG:   msg: Detected cache-line size is 32 bytes
22:38:59 M: 26226688   DEBUG:   msg: CPUflags:  MMX: 1 MMX2: 1 3DNow: 0 3DNow2: 0 SSE: 0 SSE2: 0
22:38:59 M: 26226688   DEBUG:   msg: Compiled for x86 CPU with extensions:
22:38:59 M: 26226688   DEBUG:   msg:  MMX
22:38:59 M: 26226688   DEBUG:   msg:  MMX2
22:38:59 M: 26226688   DEBUG:   msg:  SSE
22:38:59 M: 26226688   DEBUG:   msg:
22:38:59 M: 26214400   DEBUG:   msg:
22:38:59 M: 26206208   DEBUG:   msg: Creating config file: Q:\system\players\mplayer\config
22:38:59 M: 26206208   DEBUG:   msg:
22:38:59 M: 26206208   DEBUG:   msg: get_path('codecs.conf') -> 'Q:\system\players\mplayer\codecs.conf'
22:38:59 M: 26206208   DEBUG:   msg: Reading Q:\system\players\mplayer\codecs.conf:
22:38:59 M: 25575424   DEBUG:   msg: 107 audio & 226 video codecs
22:38:59 M: 25575424   DEBUG:   msg: CommandLine:
22:38:59 M: 25575424   DEBUG:   msg:  '-dr'
22:38:59 M: 25575424   DEBUG:   msg:  '-v'
22:38:59 M: 25575424   DEBUG:   msg:  '-subcp'
22:38:59 M: 25575424   DEBUG:   msg:  'enca:__:CP1252'
22:38:59 M: 25575424   DEBUG:   msg:  '-channels'
22:38:59 M: 25575424   DEBUG:   msg:  '6'
22:38:59 M: 25575424   DEBUG:   msg:  '-a52drc'
22:38:59 M: 25575424   DEBUG:   msg:  '1'
22:38:59 M: 25575424   DEBUG:   msg:  '-noflip-hebrew'
22:38:59 M: 25575424   DEBUG:   msg:  '-noflip-hebrew-commas'
22:38:59 M: 25575424   DEBUG:   msg:  '-fs'
22:38:59 M: 25575424   DEBUG:   msg:  '1.avi'
22:38:59 M: 25575424   DEBUG:   msg:
22:38:59 M: 25575424   DEBUG:   msg: get_path('font/font.desc') -> 'Q:\system\players\mplayer\font/font.desc'
22:38:59 M: 25047040   DEBUG:   msg: font: can't open file: Q:\system\players\mplayer\font/font.desc
22:38:59 M: 25047040   DEBUG:   msg: font: can't open file: Q:\system\players\mplayer/font/font.desc
22:38:59 M: 25575424   DEBUG:   msg: Using MMX (with tiny bit MMX2) Optimized OnScreenDisplay
22:38:59 M: 25550848   DEBUG:   msg: Using XBOX High Resolution Timers for timing
22:38:59 M: 25550848   DEBUG:   msg: get_path('input.conf') -> 'Q:\system\players\mplayer\input.conf'
22:38:59 M: 25550848   DEBUG:   msg: Parsing input config file Q:\system\players\mplayer\input.conf
22:38:59 M: 25542656   DEBUG:   msg: Input config file Q:\system\players\mplayer\input.conf parsed: 51 binds
22:38:59 M: 25542656   DEBUG:   msg: mplayer_open_file(smb://user:pass@x.x.x.x/videos/Video/Video.avi)
22:38:59 M: 25542656   DEBUG:   msg: get_path('Video.avi.conf') -> 'Q:\system\players\mplayer\Video.avi.conf'
22:38:59 M: 25542656   DEBUG:   msg: 
                             Playing smb://user:pass@x.x.x.x/videos/Video/Video.avi.
22:38:59 M: 25542656   DEBUG:   msg: find subtitles
22:38:59 M: 25542656   DEBUG:   msg: auto open Z:\subtitle
22:38:59 M: 25542656   DEBUG:   msg: Filename for url is now smb://user:pass@x.x.x.x/videos/Video/Video.avi
22:38:59 M: 25542656   DEBUG:   msg: protocol:smb
22:38:59 M: 25542656   DEBUG:   msg: use standard file for protocol:smb
22:38:59 M: 25542656   DEBUG:   msg: Option stream url: This URL doesn't have a username part.
22:38:59 M: 25542656   DEBUG:   msg: Option stream url: This URL doesn't have a hostname part.
22:38:59 M: 25522176   DEBUG:   msg: WINSOCK2 init: 0
22:38:59 M: 25522176   DEBUG:   msg: [file] File size is 366462976 bytes
22:38:59 M: 25522176   DEBUG:   msg: STREAM: [file] smb://user:pass@x.x.x.x/videos/Video/Video.avi
22:38:59 M: 25522176   DEBUG:   msg: STREAM: Description: File
22:38:59 M: 25522176   DEBUG:   msg: STREAM: Author: Albeu
22:38:59 M: 25522176   DEBUG:   msg: STREAM: Comment: based on the code from ??? (probably Arpi)
22:38:59 M: 22872064   DEBUG:   msg: CACHE_PRE_INIT: 0 [0] 0  pre:419430  eof:0
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  0.00% (0 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  0.00% (0 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  0.00% (0 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  0.00% (0 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  0.00% (0 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  0.00% (0 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  0.00% (0 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  0.00% (0 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  0.00% (0 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  0.00% (0 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  0.00% (0 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  0.00% (0 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  3.13% (65536 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  3.13% (65536 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  3.13% (65536 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  3.13% (65536 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  3.13% (65536 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  3.13% (65536 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  3.13% (65536 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  3.13% (65536 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  3.13% (65536 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  3.13% (65536 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  3.13% (65536 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  3.13% (65536 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  3.13% (65536 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  3.13% (65536 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  3.13% (65536 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  3.13% (65536 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  3.13% (65536 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  6.25% (131072 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  6.25% (131072 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  6.25% (131072 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  6.25% (131072 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  6.25% (131072 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  6.25% (131072 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  6.25% (131072 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  6.25% (131072 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  6.25% (131072 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  6.25% (131072 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  6.25% (131072 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  6.25% (131072 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  6.25% (131072 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  9.38% (196608 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  9.38% (196608 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  9.38% (196608 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  9.38% (196608 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  9.38% (196608 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  9.38% (196608 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  9.38% (196608 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  9.38% (196608 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  9.38% (196608 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  9.38% (196608 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  9.38% (196608 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  9.38% (196608 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill:  9.38% (196608 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 12.50% (262144 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 12.50% (262144 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 12.50% (262144 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 12.50% (262144 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 12.50% (262144 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 12.50% (262144 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 12.50% (262144 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 12.50% (262144 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 12.50% (262144 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 15.63% (327680 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 15.63% (327680 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 15.63% (327680 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 15.63% (327680 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 15.63% (327680 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 15.63% (327680 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 15.63% (327680 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 15.63% (327680 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 15.63% (327680 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 15.63% (327680 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 15.63% (327680 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 15.63% (327680 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 15.63% (327680 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 15.63% (327680 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 18.75% (393216 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 18.75% (393216 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 18.75% (393216 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 18.75% (393216 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 18.75% (393216 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 18.75% (393216 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 18.75% (393216 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 18.75% (393216 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 18.75% (393216 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 18.75% (393216 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 18.75% (393216 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 18.75% (393216 bytes)
22:38:59 M: 22872064   DEBUG:   msg: 
Cache fill: 18.75% (393216 bytes)
22:38:59 M: 22872064   DEBUG:   msg:
22:38:59 M: 22872064   DEBUG:   msg: demux_open(00DA3010,0,-1,-1,-1)
22:38:59 M: 22872064   DEBUG:   msg: AVI file format detected.
22:38:59 M: 22872064   DEBUG:   msg: list_end=0x22D6
22:38:59 M: 22872064   DEBUG:   msg: ======= AVI Header =======
22:38:59 M: 22872064   DEBUG:   msg: us/frame: 41708  (fps=23.976)
22:38:59 M: 22872064   DEBUG:   msg: max bytes/sec: 0
22:38:59 M: 22872064   DEBUG:   msg: padding: 0
22:38:59 M: 22872064   DEBUG:   msg: MainAVIHeader.dwFlags: (272) HAS_INDEX IS_INTERLEAVED
22:38:59 M: 22872064   DEBUG:   msg: frames  total: 61428   initial: 0
22:38:59 M: 22872064   DEBUG:   msg: streams: 2
22:38:59 M: 22872064   DEBUG:   msg: Suggested BufferSize: 0
22:38:59 M: 22872064   DEBUG:   msg: Size:  640 x 352
22:38:59 M: 22872064   DEBUG:   msg: ==========================
22:38:59 M: 22872064   DEBUG:   msg: list_end=0x1138
22:38:59 M: 22872064   DEBUG:   msg: ==> Found video stream: 0
22:38:59 M: 22872064   DEBUG:   msg: ====== STREAM Header =====
22:38:59 M: 22872064   DEBUG:   msg: Type: vids   FCC: xvid (64697678)
22:38:59 M: 22872064   DEBUG:   msg: Flags: 0
22:38:59 M: 22872064   DEBUG:   msg: Priority: 0   Language: 0
22:38:59 M: 22872064   DEBUG:   msg: InitialFrames: 0
22:38:59 M: 22872064   DEBUG:   msg: Rate: 2997/125 = 23.976
22:38:59 M: 22872064   DEBUG:   msg: Start: 0   Len: 61428
22:38:59 M: 22872064   DEBUG:   msg: Suggested BufferSize: 48558
22:38:59 M: 22872064   DEBUG:   msg: Quality 10000
22:38:59 M: 22872064   DEBUG:   msg: Sample size: 0
22:38:59 M: 22872064   DEBUG:   msg: ==========================
22:38:59 M: 22872064   DEBUG:   msg: Found 'bih', 108 bytes of 40
22:38:59 M: 22872064   DEBUG:   msg: ======= VIDEO Format ======
22:38:59 M: 22872064   DEBUG:   msg:   biSize 40
22:38:59 M: 22872064   DEBUG:   msg:   biWidth 640
22:38:59 M: 22872064   DEBUG:   msg:   biHeight 352
22:38:59 M: 22872064   DEBUG:   msg:   biPlanes 1
22:38:59 M: 22872064   DEBUG:   msg:   biBitCount 16
22:38:59 M: 22872064   DEBUG:   msg:   biCompression 1145656920='XVID'
22:38:59 M: 22872064   DEBUG:   msg:   biSizeImage 1351680
22:38:59 M: 22872064   DEBUG:   msg: ===========================
22:38:59 M: 22872064   DEBUG:   msg: Regenerating keyframe table for MPEG-4 video.
22:38:59 M: 22872064   DEBUG:   msg: list_end=0x21CA
22:38:59 M: 22872064   DEBUG:   msg: ==> Found audio stream: 1
22:38:59 M: 22872064   DEBUG:   msg: ====== STREAM Header =====
22:38:59 M: 22872064   DEBUG:   msg: Type: auds   FCC:  (0)
22:38:59 M: 22872064   DEBUG:   msg: Flags: 0
22:38:59 M: 22872064   DEBUG:   msg: Priority: 0   Language: 0
22:38:59 M: 22872064   DEBUG:   msg: InitialFrames: 1
22:38:59 M: 22872064   DEBUG:   msg: Rate: 48000/1152 = 41.667
22:38:59 M: 22872064   DEBUG:   msg: Start: 0   Len: 106751
22:38:59 M: 22872064   DEBUG:   msg: Suggested BufferSize: 576
22:38:59 M: 22872064   DEBUG:   msg: Quality -1
22:38:59 M: 22872064   DEBUG:   msg: Sample size: 0
22:38:59 M: 22872064   DEBUG:   msg: ==========================
22:38:59 M: 22872064   DEBUG:   msg: Found 'wf', 30 bytes of 18
22:38:59 M: 22872064   DEBUG:   msg: ======= WAVE Format =======
22:38:59 M: 22872064   DEBUG:   msg: Format Tag: 85 (0x55)
22:38:59 M: 22872064   DEBUG:   msg: Channels: 2
22:38:59 M: 22872064   DEBUG:   msg: Samplerate: 48000
22:38:59 M: 22872064   DEBUG:   msg: avg byte/sec: 16194
22:38:59 M: 22872064   DEBUG:   msg: Block align: 1152
22:38:59 M: 22872064   DEBUG:   msg: bits/sample: 0
22:38:59 M: 22872064   DEBUG:   msg: cbSize: 12
22:38:59 M: 22872064   DEBUG:   msg: mp3.wID=1
22:38:59 M: 22872064   DEBUG:   msg: mp3.fdwFlags=0x2
22:38:59 M: 22872064   DEBUG:   msg: mp3.nBlockSize=388
22:38:59 M: 22872064   DEBUG:   msg: mp3.nFramesPerBlock=1
22:38:59 M: 22872064   DEBUG:   msg: mp3.nCodecDelay=0
22:38:59 M: 22872064   DEBUG:   msg: ===========================
22:38:59 M: 22872064   DEBUG:   msg: list_end=0x22D6
22:38:59 M: 22872064   DEBUG:   msg: AVI: dmlh found (size=248) (total_frames=61428)
22:38:59 M: 22872064   DEBUG:   msg: list_end=0x22FA
22:38:59 M: 22872064   DEBUG:   msg: hdr=Software  size=15
22:38:59 M: 22872064   DEBUG:   msg: Software  : Nandub v1.0rc2
22:38:59 M: 22872064   DEBUG:   msg: list_end=0x15AEB82A
22:38:59 M: 22872064   DEBUG:   msg: Found movie at 0x280C - 0x15AEB82A
22:38:59 M: 22872064   DEBUG:   msg: Reading INDEX block, 168179 chunks for 61428 frames (fpos=363771954).
22:38:59 M: 20176896    INFO: Loading skin file: DialogBusy.xml
22:38:59 M: 20176896   ERROR: unable to load:Q:\skin\Vision\pal\DialogBusy.xml, Line 0
                             Failed to open file
22:39:00 M: 20176896   DEBUG:   msg: AVI index offset: 0x2808 (movi=0x280C idx0=0x4 idx1=0x18C)
22:39:00 M: 20176896   DEBUG:   msg: Auto-selected AVI audio ID = 1
22:39:00 M: 20176896   DEBUG:   msg: Auto-selected AVI video ID = 0
22:39:00 M: 20176896   DEBUG:   msg: AVI: Searching for audio stream (id:1)
22:39:00 M: 20176896    INFO: Loading skin file: DialogBusy.xml
22:39:00 M: 20176896   ERROR: unable to load:Q:\skin\Vision\pal\DialogBusy.xml, Line 0
                             Failed to open file
22:39:01 M: 20176896   DEBUG:   msg: AVI video size=320895403 (61428) audio size=41490192 (106751)
22:39:01 M: 20176896   DEBUG:   msg: [V] filefmt:3  fourcc:0x44495658  size:640x352  fps:23.98  ftime:=0.0417
22:39:01 M: 20176896   DEBUG:   msg: Clip info:
22:39:01 M: 20176896   DEBUG:   msg:  Software: Nandub v1.0rc2
22:39:01 M: 20176896   DEBUG:   msg: get_path('sub/') -> 'Q:\system\players\mplayer\sub/'
22:39:01 M: 20176896   DEBUG:   msg: Starting lookup for subs
22:39:01 M: 20176896   DEBUG:   msg: Global Subsize: 0 - VOBSUB: -1, DEMUX: -1, SUBS: -1
22:39:01 M: 20176896   DEBUG:   msg: Global Subpos : -1
22:39:01 M: 20176896   DEBUG:   msg: ==========================================================================
22:39:01 M: 20176896   DEBUG:   msg: Opening audio decoder: [mp3lib] MPEG layer-2, layer-3
22:39:01 M: 20176896   DEBUG:   msg: dec_audio: Allocating 4608 + 65536 = 70144 bytes for output buffer.
22:39:01 M: 20103168   DEBUG:   msg: mp3lib: made decode tables with MMX optimization
22:39:01 M: 20103168   DEBUG:   msg: mp3lib: using MMX optimized decore!
22:39:01 M: 20103168   DEBUG:   msg: MP3lib: init layer2&3 finished, tables done
22:39:01 M: 20103168    INFO: Loading skin file: DialogBusy.xml
22:39:01 M: 20103168   ERROR: unable to load:Q:\skin\Vision\pal\DialogBusy.xml, Line 0
                             Failed to open file
22:39:02 M: 20103168    INFO: Loading skin file: DialogProgress.xml
22:39:02 M: 20103168   DEBUG:   msg: 
MPEG 1.0, Layer III, 48000 Hz 96 kbit Joint-Stereo, BPF: 288
22:39:02 M: 19398656   DEBUG:   msg: Channels: 2, copyright: No, original: Yes, CRC: No, emphasis: 0
22:39:02 M: 19398656   DEBUG:   msg: AUDIO: 48000 Hz, 2 ch, 16 bit (0x10), ratio: 12000->192000 (96.0 kbit)
22:39:02 M: 19398656   DEBUG:   msg: Selected audio codec: [mp3] afm:mp3lib (mp3lib MPEG layer-2, layer-3)
22:39:02 M: 19398656   DEBUG:   msg: ==========================================================================
22:39:02 M: 19398656   DEBUG: CXBoxRenderManager::PreInit - Selected RGB-Renderer
22:39:02 M: 19398656   DEBUG:   msg: ==========================================================================
22:39:02 M: 19398656   DEBUG:   msg: Opening video decoder: [ffmpeg] FFmpeg's libavcodec codec family
22:39:02 M: 18874368   DEBUG:   msg: INFO: libavcodec init OK!
22:39:02 M: 18874368   DEBUG:   msg: Selected video codec: [ffodivx] vfm:ffmpeg (FFmpeg MPEG-4)
22:39:02 M: 18874368   DEBUG:   msg: ==========================================================================
22:39:02 M: 18874368   DEBUG:   msg: Checking audio filter chain for 48000Hz/2ch/16bit -> 48000Hz/6ch/16bit...
22:39:02 M: 18874368   DEBUG:   msg: [libaf] Adding filter dummy
22:39:02 M: 18874368   DEBUG:   msg: [dummy] Was reinitialized, rate=48000Hz, nch = 2, format = 0x00000001 and bps = 2
22:39:02 M: 18874368   DEBUG:   msg: AF_pre: af format: 2 bps, 2 ch, 48000 hz, little endian signed int
22:39:02 M: 18874368   DEBUG:   msg: AF_pre: 48000Hz 2ch Signed 16-bit (Little-Endian)
22:39:02 M: 18825216   DEBUG:   msg: AO: [win32] 48000Hz 2ch Signed 16-bit (Little-Endian) (2 bps)
22:39:02 M: 18825216   DEBUG:   msg: AO: Description: Windows waveOut audio output
                             AO: Author: SaschaSommer <saschasommer@freenet.de>
22:39:02 M: 18825216   DEBUG:   msg: Building audio filter chain for 48000Hz/2ch/16bit -> 48000Hz/2ch/16bit...
22:39:02 M: 18825216   DEBUG:   msg: [dummy] Was reinitialized, rate=48000Hz, nch = 2, format = 0x00000001 and bps = 2
22:39:02 M: 18825216   DEBUG:   msg: [dummy] Was reinitialized, rate=48000Hz, nch = 2, format = 0x00000001 and bps = 2
22:39:02 M: 18755584   DEBUG:   msg: Starting playback...
22:39:02 M: 18755584   DEBUG:   msg: mplayer_open_file(smb://user:pass@x.x.x.x/videos/Video/Video.avi) done 1.0000
22:39:02 M: 16793600   DEBUG: Playback has started
22:39:02 M: 19058688   DEBUG:   msg: [ffmpeg] aspect_ratio: 1.818182
22:39:02 M: 19058688   DEBUG:   msg: VDec: vo config request - 640 x 352 (preferred colorspace: Planar YV12)
22:39:02 M: 19058688   DEBUG: CGUIInfoManager::SetCurrentMovie(smb://user:pass@x.x.x.x/videos/Video/Video.avi)
22:39:02 M: 19025920   DEBUG:   msg: Trying filter chain:
22:39:02 M: 18984960   DEBUG:   msg:  vo
22:39:02 M: 18984960   DEBUG:   msg:
22:39:02 M: 18980864   DEBUG:   msg: VDec: using Planar YV12 as output csp (no 0)
22:39:02 M: 18980864   DEBUG:   msg: Movie-Aspect is 1.82:1 - prescaling to correct movie aspect.
22:39:02 M: 18980864   DEBUG:   msg: VO Config (640x352->640x352,flags=1,'MPlayer',0x32315659)
22:39:02 M: 18980864   DEBUG:   msg: VO: [directx] 640x352 => 640x352 Planar YV12  [fs]
22:39:02 M: 19021824   DEBUG: CVideoDatabase::GetMovieInfo(smb://user:pass@x.x.x.x/videos/Video/Video.avi), query = select idMovie from movie where idFile=2
22:39:02 M: 19001344   DEBUG:   msg: VO: Description: XBOX Direct3D8 YUY2 renderer
22:39:02 M: 18980864   DEBUG:   msg: VO: Author: Frodo/JCMarshall
22:39:02 M: 18980864   DEBUG: mplayer::video_config(640, 352, 640, 352, 1, 842094169)
22:39:02 M: 19021824   DEBUG: CVideoDatabase::GetEpisodeInfo(smb://user:pass@x.x.x.x/videos/Video/Video.avi), query = select idEpisode from episode where idFile=2
22:39:02 M: 19001344  NOTICE: Display resolution AUTO : 720p 16:9 (1)
22:39:03 M: 18509824   DEBUG: Activating window ID: 12005
22:39:03 M: 18534400   DEBUG: Checking if window ID 12005 is locked.
22:39:03 M: 23871488   DEBUG: Setting resolution 1
22:39:03 M: 25755648   DEBUG: We set resolution 1
22:39:03 M: 25395200   DEBUG: Created YV12 texture 0
22:39:03 M: 25395200    INFO: Loading skin file: VideoFullscreen.xml
22:39:03 M: 25395200    INFO: Loading skin file: VideoOSD.xml
22:39:03 M: 25108480    INFO: Loading skin file: VideoOSDSettings.xml
22:39:03 M: 24240128    INFO: Loading skin file: VideoOSDSettings.xml
22:39:03 M: 24182784   DEBUG: CGUIFontTTF::Load Scaled size of font Q:\Media\Fonts\Arial.ttf (28): width = 76, height = 39
22:39:03 M: 23810048   DEBUG:   msg: *** [vo] Allocating (slices) mp_image_t, 640x352x12bpp YUV planar, 337920 bytes
22:39:03 M: 23248896   DEBUG:   msg: XXX initial  v_pts=0.000  a_pos=7392 (0.456)
22:39:03 M: 22908928   DEBUG:   msg: *** [vo] Allocating (slices) mp_image_t, 640x352x12bpp YUV planar, 337920 bytes
22:39:03 M: 22822912   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:04 M: 22822912   DEBUG:   msg: SEEK: idx=2189  (a:2189 v:2221)  v.skip=11  a.skip=0/0.000
22:39:04 M: 22802432   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:04 M: 22810624   DEBUG:   msg: SEEK: idx=4234  (a:4234 v:4266)  v.skip=11  a.skip=0/0.000
22:39:07 M: 22802432   DEBUG: CApplication::OnKey: 166 pressed, action is 22
22:39:07 M: 22810624   DEBUG:   msg: SEEK: idx=43831  (a:43831 v:43863)  v.skip=11  a.skip=0/0.000
22:39:10 M: 22843392   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:10 M: 22851584   DEBUG:   msg: SEEK: idx=46161  (a:46161 v:46193)  v.skip=11  a.skip=0/0.000
22:39:11 M: 22523904   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:11 M: 22532096   DEBUG:   msg: SEEK: idx=48311  (a:48311 v:48342)  v.skip=11  a.skip=0/0.000
22:39:12 M: 22532096   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:12 M: 22532096   DEBUG:   msg: SEEK: idx=50372  (a:50372 v:50404)  v.skip=11  a.skip=0/0.000
22:39:12 M: 22532096   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:12 M: 22532096   DEBUG:   msg: SEEK: idx=52475  (a:52475 v:52507)  v.skip=11  a.skip=0/0.000
22:39:13 M: 22523904   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:13 M: 22532096   DEBUG:   msg: SEEK: idx=54621  (a:54621 v:54653)  v.skip=11  a.skip=0/0.000
22:39:14 M: 22523904   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:14 M: 22532096   DEBUG:   msg: SEEK: idx=56869  (a:56869 v:56901)  v.skip=11  a.skip=0/0.000
22:39:15 M: 22515712   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:15 M: 22532096   DEBUG:   msg: SEEK: idx=59432  (a:59432 v:59463)  v.skip=11  a.skip=0/0.000
22:39:16 M: 22523904   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:16 M: 22532096   DEBUG:   msg: SEEK: idx=61723  (a:61723 v:61755)  v.skip=11  a.skip=0/0.000
22:39:16 M: 22523904   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:16 M: 22532096   DEBUG:   msg: SEEK: idx=63785  (a:63785 v:63816)  v.skip=11  a.skip=0/0.000
22:39:17 M: 22515712   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:17 M: 22532096   DEBUG:   msg: SEEK: idx=66087  (a:66087 v:66119)  v.skip=11  a.skip=0/0.000
22:39:17 M: 22532096   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:17 M: 22532096   DEBUG:   msg: SEEK: idx=68116  (a:68116 v:68148)  v.skip=11  a.skip=0/0.000
22:39:18 M: 22523904   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:18 M: 22532096   DEBUG:   msg: SEEK: idx=70254  (a:70254 v:70286)  v.skip=11  a.skip=0/0.000
22:39:18 M: 22528000   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:18 M: 22532096   DEBUG:   msg: SEEK: idx=72546  (a:72546 v:72578)  v.skip=11  a.skip=0/0.000
22:39:19 M: 22532096   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:19 M: 22532096   DEBUG:   msg: SEEK: idx=74881  (a:74881 v:74913)  v.skip=11  a.skip=0/0.000
22:39:20 M: 22528000   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:20 M: 22532096   DEBUG:   msg: SEEK: idx=77129  (a:77129 v:77161)  v.skip=11  a.skip=0/0.000
22:39:20 M: 22523904   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:20 M: 22532096   DEBUG:   msg: SEEK: idx=79169  (a:79169 v:79200)  v.skip=11  a.skip=0/0.000
22:39:21 M: 22515712   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:21 M: 22532096   DEBUG:   msg: SEEK: idx=81288  (a:81288 v:81319)  v.skip=11  a.skip=0/0.000
22:39:24 M: 22564864   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:24 M: 22573056   DEBUG:   msg: SEEK: idx=83569  (a:83569 v:83600)  v.skip=11  a.skip=0/0.000
22:39:25 M: 22519808   DEBUG: CApplication::OnKey: 168 pressed, action is 20
22:39:25 M: 22532096   DEBUG:   msg: SEEK: idx=85663  (a:85663 v:85695)  v.skip=11  a.skip=0/0.000
22:43:50 M: 17506304   ERROR: Unable to wait for NTP reply from the SNTP server, GetLastError returns 10060
22:43:55 M: 17514496   ERROR: Unable to wait for NTP reply from the SNTP server, GetLastError returns 10060
22:46:53 M: 14254080   DEBUG: CApplication::OnKey: 216 pressed, action is 76
22:46:53 M: 14254080   DEBUG:   msg: SEEK: idx=114279  (a:114279 v:114310)  v.skip=11  a.skip=0/0.000
22:48:50 M: 11960320   ERROR: Unable to wait for NTP reply from the SNTP server, GetLastError returns 10060
22:48:55 M: 11960320   ERROR: Unable to wait for NTP reply from the SNTP server, GetLastError returns 10060
22:49:00 M: 11685888   ERROR: Unable to wait for NTP reply from the SNTP server, GetLastError returns 10060
22:54:54 M:  5378048   DEBUG: CApplication::OnKey: 230 pressed, action is 12
22:54:56 M:  5300224   DEBUG: CApplication::OnKey: 230 pressed, action is 12
22:54:56 M:  5300224   DEBUG:   msg: FFRW:normal play
22:59:47 M:   106496   FATAL: Unknown exception code (0xe06d7363)
                              at 0x0009df9b