Public feed
#889515
18:31:31 M: 57991168 NOTICE: -----------------------------------------------------------------------
18:31:31 M: 57970688 NOTICE: Starting XBMC, Platform: Windows. Built on Jan 14 2008
18:31:31 M: 57970688 NOTICE: Q is mapped to: E:\XBMC
18:31:31 M: 57970688 NOTICE: The executeable running is: E:\XBMC\default.xbe
18:31:31 M: 57970688 NOTICE: Log File is located: Q:\xbmc.log
18:31:31 M: 57970688 NOTICE: -----------------------------------------------------------------------
18:31:31 M: 57970688 NOTICE: Unmapped drive T
18:31:31 M: 57970688 NOTICE: Mapping drive T to Harddisk0\Partition1\XBMC\userdata
18:31:31 M: 57970688 NOTICE: Setup DirectX
18:31:31 M: 57946112 NOTICE: Mapping drive C to Harddisk0\Partition2
18:31:31 M: 57946112 NOTICE: Mapping drive E to Harddisk0\Partition1
18:31:31 M: 57946112 NOTICE: Unmapped drive D
18:31:31 M: 57946112 NOTICE: Mapping drive D to Cdrom0
18:31:33 M: 57942016 NOTICE: Mapping drive F to Harddisk0\Partition6
18:31:37 M: 57942016 NOTICE: Mapping drive G to Harddisk0\Partition7
18:31:38 M: 57942016 NOTICE: Mapping drive X to Harddisk0\Partition3
18:31:38 M: 57942016 NOTICE: Mapping drive Y to Harddisk0\Partition4
18:31:38 M: 57942016 NOTICE: Unmapped drive Z
18:31:38 M: 57942016 NOTICE: Mapping drive Z to Harddisk0\Partition5
18:31:38 M: 57942016 NOTICE: load settings...
18:31:38 M: 57942016 NOTICE: Mapping drive P to Harddisk0\Partition1\XBMC\userdata
18:31:38 M: 57942016 NOTICE: loading T:\guisettings.xml
18:31:38 M: 57724928 NOTICE: Getting hardware information now...
18:31:38 M: 57724928 NOTICE: Checking resolution 5
18:31:38 M: 57724928 NOTICE: Per AV pack settings are off
18:31:38 M: 57876480 NOTICE: q:\userdata\sources.xml
18:31:38 M: 57876480 INFO: Key combination detected for full debug logging (X+Y)
18:31:38 M: 57876480 INFO: Checking skinpath existance, and existence of keymap.xml:Q:\skin...
18:31:38 M: 52232192 INFO: load language info file:Q:\language\english\langinfo.xml
18:31:38 M: 51707904 INFO: load language file:Q:\language\english\strings.xml
18:31:38 M: 51544064 INFO: load keymapping
18:31:38 M: 51544064 INFO: Loading P:\keymap.xml
18:31:38 M: 50077696 INFO: Checking skin version of: Project Mayhem III SE
18:31:38 M: 50085888 INFO: Skin version is: 2.1
18:31:38 M: 50085888 INFO: GUI format 720x480 NTSC 16:9
18:31:38 M: 50085888 INFO: install unhandled exception filter
18:31:38 M: 50085888 INFO: creating subdirectories
18:31:38 M: 50085888 INFO: userdata folder: q:\userdata
18:31:38 M: 50085888 INFO: recording folder:
18:31:38 M: 47996928 INFO: screenshots folder:
18:31:38 M: 47996928 INFO: thumbnails folder:q:\userdata\Thumbnails
18:31:38 M: 51474432 NOTICE: Checking the Date!
18:31:38 M: 51474432 INFO: - Current Date is: 2-2-2008
18:31:38 M: 51474432 NOTICE: start dvd mediatype detection
18:31:38 M: 51404800 NOTICE: initializing playlistplayer
18:31:38 M: 51404800 NOTICE: DONE initializing playlistplayer
18:31:38 M: 51404800 INFO: lcd not used
18:31:38 M: 51404800 NOTICE: start fancontroller
18:31:38 M: 50872320 NOTICE: load default skin:[Project Mayhem III SE]
18:31:38 M: 50872320 INFO: load skin from:Q:\skin\Project Mayhem III SE
18:31:38 M: 50872320 INFO: delete old skin...
18:31:39 M: 50872320 INFO: Default 4:3 resolution directory is Q:\skin\Project Mayhem III SE\pal
18:31:39 M: 50872320 INFO: Default 16:9 resolution directory is Q:\skin\Project Mayhem III SE\pal16x9
18:31:39 M: 50872320 INFO: Skin version is: 2.1
18:31:39 M: 50872320 INFO: Loading skin includes from Q:\skin\Project Mayhem III SE\pal\includes.xml
18:31:39 M: 49618944 NOTICE: Dismounted Cdrom0
18:31:39 M: 49999872 NOTICE: Unmapped drive D
18:31:39 M: 49999872 NOTICE: Mapping drive D to Cdrom0
18:31:39 M: 49897472 INFO: Detecting DVD-ROM media filesystem...
18:31:39 M: 49577984 INFO: load fonts for skin...
18:31:39 M: 49577984 INFO: Loading fonts from Q:\skin\Project Mayhem III SE\ntsc16x9\Font.xml
18:31:39 M: 49516544 INFO: CD Analysis Report
18:31:39 M: 49496064 INFO: __________________________________
18:31:39 M: 49496064 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Project Mayhem III SE\Fonts\FrancophilSans.ttf (10.924999): width = 13, height = 14, lineheight = 13
18:31:39 M: 49442816 INFO: CD-ROM with both UDF and ISO 9660 filesystem
18:31:39 M: 49422336 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Project Mayhem III SE\Fonts\FrancophilSans.ttf (13.656249): width = 16, height = 17, lineheight = 16
18:31:39 M: 49414144 INFO: ISO 9660: 2286002 blocks, label `THE_LIFE_OF_DAVID_GALE '
18:31:39 M: 49352704 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Project Mayhem III SE\Fonts\FrancophilSans.ttf (14.566667): width = 17, height = 18, lineheight = 17
18:31:39 M: 49352704 INFO: UDF: version 1.02
18:31:39 M: 49324032 INFO: Tracks overall:1; Audio tracks:0; Data tracks:1
18:31:39 M: 49283072 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Project Mayhem III SE\Fonts\FrancophilSans.ttf (15.477083): width = 18, height = 19, lineheight = 19
18:31:40 M: 49242112 INFO: Using protocol iso9660://
18:31:40 M: 49242112 INFO: Disc label: THE_LIFE_OF_DAVID_GALE
18:31:40 M: 49242112 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Project Mayhem III SE\Fonts\evt_nfo.ttf (11.835416): width = 5, height = 13, lineheight = 12
18:31:40 M: 49238016 ERROR: unable to load Q:\skin\Project Mayhem III SE\language\english\strings.xml: Failed to open file at line 0
18:31:40 M: 49254400 DEBUG: MEDIA_DETECT::CDetectDVDMedia::SetNewDVDShareUrl: looking for disc thumb:[iso9660://folder.jpg]
18:31:40 M: 49254400 INFO: load new skin...
18:31:40 M: 49254400 INFO: Skin version is: 2.1
18:31:40 M: 49254400 INFO: Loading skin file: home.xml
18:31:40 M: 48156672 INFO: Loading user windows, path Q:\skin\Project Mayhem III SE\pal16x9
18:31:40 M: 48156672 INFO: Loading user windows, path Q:\skin\Project Mayhem III SE\pal
18:31:40 M: 48156672 INFO: Loading skin file: Q:\skin\Project Mayhem III SE\pal\custom2_SkinSettings.xml
18:31:40 M: 48152576 INFO: Loading skin file: Q:\skin\Project Mayhem III SE\pal\customx_RSSFeeds.xml
18:31:40 M: 48152576 INFO: initialize new skin...
18:31:40 M: 48152576 INFO: Loading skin file: Pointer.xml
18:31:40 M: 48119808 INFO: Loading skin file: DialogVolumeBar.xml
18:31:40 M: 48111616 INFO: Loading skin file: DialogSeekbar.xml
18:31:40 M: 48074752 INFO: Loading skin file: DialogKaiToast.xml
18:31:40 M: 48074752 INFO: Loading skin file: DialogMuteBug.xml
18:31:40 M: 47677440 INFO: Loading Q:\skin\Project Mayhem III SE\sounds\sounds.xml
18:31:40 M: 47677440 INFO: skin loaded...
18:31:40 M: 47140864 INFO: Loading skin file: DialogBusy.xml
18:31:40 M: 47677440 DEBUG: Activating window ID: 12999
18:31:40 M: 47677440 DEBUG: Checking if window ID 12999 is locked.
18:31:40 M: 47247360 INFO: Loading skin file: Startup.xml
18:31:40 M: 47247360 NOTICE: use DHCP
18:31:40 M: 46931968 INFO: removing tempfiles
18:31:40 M: 46931968 NOTICE: initialize done
18:31:40 M: 46931968 INFO: Key combination detected for full debug logging (X+Y)
18:31:40 M: 46931968 NOTICE: Running the application...
18:31:40 M: 43925504 INFO: CNetwork::LogState - Link: full duplex
18:31:40 M: 43925504 INFO: CNetwork::LogState - Link: 100 mbps
18:31:40 M: 43925504 INFO: CNetwork::LogState - ip:
18:31:40 M: 43925504 INFO: CNetwork::LogState - subnet:
18:31:40 M: 43925504 INFO: CNetwork::LogState - gateway:
18:31:40 M: 43925504 DEBUG: CApplication::OnMessage : Translating ReplaceWindow(Home)
18:31:40 M: 43925504 INFO: CNetwork::LogState - dns: ,
18:31:40 M: 43925504 DEBUG: CApplication::OnMessage : To ReplaceWindow(Home)
18:31:40 M: 43925504 DEBUG: Activating window ID: 10000
18:31:40 M: 43925504 DEBUG: Checking if window ID 10000 is locked.
18:31:41 M: 43294720 INFO: CNetwork::LogState - Link: full duplex
18:31:41 M: 43294720 INFO: CNetwork::LogState - Link: 100 mbps
18:31:41 M: 43294720 INFO: CNetwork::LogState - State: dns
18:31:41 M: 43294720 INFO: CNetwork::LogState - State: dhcp
18:31:41 M: 43294720 INFO: CNetwork::LogState - ip: 192.168.1.119
18:31:41 M: 43294720 INFO: CNetwork::LogState - subnet: 255.255.255.0
18:31:41 M: 43294720 INFO: CNetwork::LogState - gateway: 192.168.1.1
18:31:41 M: 43294720 INFO: CNetwork::LogState - dns: 192.168.1.1, 0.0.0.0
18:31:41 M: 43294720 INFO: WEATHER: Downloading weather
18:31:41 M: 43294720 INFO: Get URL: http://xoap.weather.com/weather/local/CAXX0539?cc=*&unit=m&dayf=4&prod=xoap&par=1004124588&key=079f24145f208494
18:31:41 M: 43294720 INFO: Get URL: http://www.xbox-hq.com/html/backend.php
18:31:41 M: 43294720 DEBUG: CNetwork::NetworkMessage - Starting network services
18:31:41 M: 43294720 NOTICE: start timeserver client
18:31:41 M: 43229184 NOTICE: XBFileZilla: Starting...
18:31:41 M: 41959424 NOTICE: XBFileZilla: Started
18:31:41 M: 41996288 DEBUG: Got rss feed: http://www.xbox-hq.com/html/backend.php
18:31:41 M: 41996288 DEBUG: RSS feed encoding: ISO-8859-1
18:31:41 M: 41996288 DEBUG: Parsed rss feed: http://www.xbox-hq.com/html/backend.php
18:31:41 M: 42098688 INFO: WEATHER: Weather download successful
18:31:44 M: 42594304 DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:31:44 M: 41824256 DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:31:44 M: 42569728 DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:31:45 M: 42569728 DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:31:45 M: 42491904 DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:31:45 M: 43622400 DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:31:46 M: 42876928 DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:31:46 M: 42864640 DEBUG: CApplication::OnMessage : Translating ActivateWindow(Settings)
18:31:46 M: 42864640 DEBUG: CApplication::OnMessage : To ActivateWindow(Settings)
18:31:46 M: 42864640 DEBUG: Activating window ID: 10004
18:31:46 M: 42864640 DEBUG: Checking if window ID 10004 is locked.
18:31:46 M: 46641152 INFO: Loading skin file: Settings.xml
18:31:46 M: 44752896 DEBUG: CApplication::OnKey: 273 pressed, action is 2
18:31:47 M: 44752896 DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:31:47 M: 44752896 DEBUG: CApplication::OnKey: 273 pressed, action is 2
18:31:48 M: 44752896 DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:31:48 M: 44740608 DEBUG: CApplication::OnMessage : Translating ActivateWindow(SystemSettings)
18:31:48 M: 44740608 DEBUG: CApplication::OnMessage : To ActivateWindow(SystemSettings)
18:31:48 M: 44740608 DEBUG: Activating window ID: 10016
18:31:48 M: 44740608 DEBUG: Checking if window ID 10016 is locked.
18:31:48 M: 46637056 INFO: Loading skin file: SettingsCategory.xml
18:31:49 M: 45576192 DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:31:49 M: 45551616 DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:31:49 M: 45559808 DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:31:50 M: 45559808 DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:31:50 M: 45551616 DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:31:51 M: 45584384 DEBUG: CApplication::OnKey: 273 pressed, action is 2
18:31:52 M: 45584384 DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:31:55 M: 45584384 DEBUG: CApplication::OnKey: 272 pressed, action is 1
18:31:56 M: 45584384 DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:31:56 M: 45584384 DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:31:58 M: 45584384 DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:31:58 M: 45576192 DEBUG: CApplication::OnKey: 270 pressed, action is 3
18:31:59 M: 45559808 DEBUG: CApplication::OnKey: 273 pressed, action is 2
18:31:59 M: 45584384 DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:31:59 M: 45584384 DEBUG: CApplication::OnKey: 270 pressed, action is 3
18:32:00 M: 45584384 DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:32:00 M: 45584384 DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:32:00 M: 45559808 DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:32:00 M: 45559808 DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:32:02 M: 45584384 DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:32:04 M: 45584384 DEBUG: CApplication::OnKey: 257 pressed, action is 10
18:32:05 M: 46641152 INFO: Loading skin file: Settings.xml
18:32:06 M: 44748800 DEBUG: CApplication::OnKey: 257 pressed, action is 10
18:32:06 M: 46641152 INFO: Loading skin file: Home.xml
18:32:08 M: 42512384 DEBUG: CApplication::OnKey: 270 pressed, action is 3
18:32:08 M: 43163648 DEBUG: CApplication::OnKey: 270 pressed, action is 3
18:32:08 M: 42442752 DEBUG: CApplication::OnKey: 270 pressed, action is 3
18:32:09 M: 41672704 DEBUG: CApplication::OnKey: 270 pressed, action is 3
18:32:09 M: 42418176 DEBUG: CApplication::OnKey: 270 pressed, action is 3
18:32:11 M: 42442752 DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:32:11 M: 42430464 DEBUG: CApplication::OnMessage : Translating ActivateWindow(MyVideos)
18:32:11 M: 42430464 DEBUG: CApplication::OnMessage : To ActivateWindow(MyVideos)
18:32:11 M: 42430464 DEBUG: Activating window ID: 10024
18:32:11 M: 42430464 DEBUG: Checking if window ID 10024 is locked.
18:32:11 M: 46612480 INFO: Attempting to default to:
18:32:11 M: 46600192 INFO: Loading skin file: MyVideo.xml
18:32:11 M: 46018560 DEBUG: CGUIMediaWindow::GetDirectory ()
18:32:11 M: 46063616 DEBUG: ParentPath = []
18:32:12 M: 45080576 DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:32:12 M: 45068288 DEBUG: Clearing cached fileitems [G:\Movies AVI\]
18:32:12 M: 45068288 ERROR: XFILE::CFile::Delete - Error deleting file Z:\969069cc.fi
18:32:12 M: 45146112 DEBUG: CGUIMediaWindow::GetDirectory (G:\Movies AVI\)
18:32:12 M: 45146112 DEBUG: ParentPath = []
18:32:15 M: 44998656 DEBUG: CApplication::OnKey: 272 pressed, action is 1
18:32:15 M: 44994560 DEBUG: CApplication::OnKey: 272 pressed, action is 1
18:32:19 M: 45019136 DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:32:19 M: 45006848 DEBUG: CPlayerCoreFactor::GetPlayers(G:\Movies AVI\Saw IV.avi)
18:32:19 M: 44478464 INFO: mplayer play:G:\Movies AVI\Saw IV.avi cachesize:2048
18:32:19 M: 44478464 INFO: Loading skin file: DialogProgress.xml
18:32:19 M: 44478464 DEBUG: CUtil::CacheSubtitles: START
18:32:19 M: 44478464 DEBUG: CUtil::CacheSubtitles: Checking for common subirs...
18:32:19 M: 44478464 DEBUG: CUtil::CacheSubtitles: Done (time: 21 ms)
18:32:19 M: 44478464 DEBUG: CUtil::CacheSubtitles: Searching for subtitles...
18:32:19 M: 44478464 DEBUG: CUtil::CacheSubtitles: Done (time: 5 ms)
18:32:19 M: 44478464 DEBUG: CUtil::CacheSubtitles: END (total time: 48 ms)
18:32:19 M: 38596608 DEBUG: msg: set audio functions called
18:32:19 M: 38596608 DEBUG: msg: done
18:32:19 M: 38596608 INFO: Using -subcp enca:__:CP1252 to detect the subtitle charset
18:32:19 M: 38596608 INFO: Flipping bi-directional subtitles disabled
18:32:19 M: 38596608 DEBUG: msg: mplayer_init()
18:32:19 M: 38596608 DEBUG: msg: MPlayer XBMC-SVN-r10070-4.1.2 (C) 2000-2004 MPlayer Team
18:32:19 M: 38596608 DEBUG: msg: CPU: Intel Celeron 2/Pentium III Coppermine,Geyserville
18:32:19 M: 38596608 DEBUG: msg: (Family: 6, Stepping: 10)
18:32:19 M: 38596608 DEBUG: msg: Detected cache-line size is 32 bytes
18:32:19 M: 38596608 DEBUG: msg: CPUflags: MMX: 1 MMX2: 1 3DNow: 0 3DNow2: 0 SSE: 0 SSE2: 0
18:32:19 M: 38596608 DEBUG: msg: Compiled for x86 CPU with extensions:
18:32:19 M: 38596608 DEBUG: msg: MMX
18:32:19 M: 38596608 DEBUG: msg: MMX2
18:32:19 M: 38596608 DEBUG: msg: SSE
18:32:19 M: 38596608 DEBUG: msg:
18:32:19 M: 38584320 DEBUG: msg:
18:32:19 M: 38596608 DEBUG: msg: Creating config file: Q:\system\players\mplayer\config
18:32:19 M: 38584320 DEBUG: msg:
18:32:19 M: 38596608 DEBUG: msg: get_path('codecs.conf') -> 'Q:\system\players\mplayer\codecs.conf'
18:32:19 M: 38596608 DEBUG: msg: Reading Q:\system\players\mplayer\codecs.conf:
18:32:19 M: 38268928 DEBUG: msg: 108 audio & 225 video codecs
18:32:19 M: 38268928 DEBUG: msg: CommandLine:
18:32:19 M: 38268928 DEBUG: msg: '-dr'
18:32:19 M: 38268928 DEBUG: msg: '-v'
18:32:19 M: 38268928 DEBUG: msg: '-cache-min'
18:32:19 M: 38268928 DEBUG: msg: '5.0000'
18:32:19 M: 38268928 DEBUG: msg: '-cache-prefill'
18:32:19 M: 38268928 DEBUG: msg: '5.0000'
18:32:19 M: 38268928 DEBUG: msg: '-subcp'
18:32:19 M: 38268928 DEBUG: msg: 'enca:__:CP1252'
18:32:19 M: 38268928 DEBUG: msg: '-channels'
18:32:19 M: 38268928 DEBUG: msg: '6'
18:32:19 M: 38268928 DEBUG: msg: '-a52drc'
18:32:19 M: 38268928 DEBUG: msg: '1'
18:32:19 M: 38268928 DEBUG: msg: '-noflip-hebrew'
18:32:19 M: 38268928 DEBUG: msg: '-noflip-hebrew-commas'
18:32:19 M: 38268928 DEBUG: msg: '-fs'
18:32:19 M: 38268928 DEBUG: msg: '1.avi'
18:32:19 M: 38268928 DEBUG: msg:
18:32:19 M: 38268928 DEBUG: msg: get_path('font/font.desc') -> 'Q:\system\players\mplayer\font/font.desc'
18:32:19 M: 37740544 DEBUG: msg: font: can't open file: Q:\system\players\mplayer\font/font.desc
18:32:19 M: 37740544 DEBUG: msg: font: can't open file: Q:\system\players\mplayer/font/font.desc
18:32:19 M: 38268928 DEBUG: msg: Using MMX (with tiny bit MMX2) Optimized OnScreenDisplay
18:32:19 M: 38236160 DEBUG: msg: Using XBOX High Resolution Timers for timing
18:32:19 M: 38236160 DEBUG: msg: get_path('input.conf') -> 'Q:\system\players\mplayer\input.conf'
18:32:19 M: 38236160 DEBUG: msg: Parsing input config file Q:\system\players\mplayer\input.conf
18:32:19 M: 38232064 DEBUG: msg: Input config file Q:\system\players\mplayer\input.conf parsed: 51 binds
18:32:19 M: 38232064 DEBUG: msg: mplayer_open_file(G:\Movies AVI\Saw IV.avi)
18:32:19 M: 38232064 DEBUG: msg: get_path('G:\Movies AVI\Saw IV.avi.conf') -> 'Q:\system\players\mplayer\G:\Movies AVI\Saw IV.avi.conf'
18:32:19 M: 38232064 DEBUG: msg:
Playing G:\Movies AVI\Saw IV.avi.
18:32:19 M: 38232064 DEBUG: msg: find subtitles
18:32:19 M: 38232064 DEBUG: msg: auto open Z:\subtitle
18:32:19 M: 38211584 DEBUG: msg: WINSOCK2 init: 0
18:32:19 M: 38211584 DEBUG: msg: [file] File size is 733450240 bytes
18:32:19 M: 38211584 DEBUG: msg: STREAM: [file] G:\Movies AVI\Saw IV.avi
18:32:19 M: 38211584 DEBUG: msg: STREAM: Description: File
18:32:19 M: 38211584 DEBUG: msg: STREAM: Author: Albeu
18:32:19 M: 38211584 DEBUG: msg: STREAM: Comment: based on the code from ??? (probably Arpi)
18:32:19 M: 35561472 DEBUG: msg: CACHE_PRE_INIT: 0 [0] 0 pre:104857 eof:0
18:32:19 M: 35561472 DEBUG: msg:
Cache fill: 0.00% (0 bytes)
18:32:20 M: 35561472 DEBUG: msg:
18:32:20 M: 35561472 DEBUG: msg: demux_open(00BE8010,0,-1,-1,-1)
18:32:20 M: 35561472 DEBUG: msg: AVI file format detected.
18:32:20 M: 35561472 DEBUG: msg: list_end=0x2286
18:32:20 M: 35561472 DEBUG: msg: ======= AVI Header =======
18:32:20 M: 35561472 DEBUG: msg: us/frame: 40000 (fps=25.000)
18:32:20 M: 35561472 DEBUG: msg: max bytes/sec: 0
18:32:20 M: 35561472 DEBUG: msg: padding: 0
18:32:20 M: 35561472 DEBUG: msg: MainAVIHeader.dwFlags: (272) HAS_INDEX IS_INTERLEAVED
18:32:20 M: 35561472 DEBUG: msg: frames total: 133176 initial: 0
18:32:20 M: 35561472 DEBUG: msg: streams: 2
18:32:20 M: 35561472 DEBUG: msg: Suggested BufferSize: 0
18:32:20 M: 35561472 DEBUG: msg: Size: 624 x 336
18:32:20 M: 35561472 DEBUG: msg: ==========================
18:32:20 M: 35561472 DEBUG: msg: list_end=0x10F4
18:32:20 M: 35561472 DEBUG: msg: ==> Found video stream: 0
18:32:20 M: 35561472 DEBUG: msg: ====== STREAM Header =====
18:32:20 M: 35561472 DEBUG: msg: Type: vids FCC: divx (78766964)
18:32:20 M: 35561472 DEBUG: msg: Flags: 0
18:32:20 M: 35561472 DEBUG: msg: Priority: 0 Language: 0
18:32:20 M: 35561472 DEBUG: msg: InitialFrames: 0
18:32:20 M: 35561472 DEBUG: msg: Rate: 25/1 = 25.000
18:32:20 M: 35561472 DEBUG: msg: Start: 0 Len: 133176
18:32:20 M: 35561472 DEBUG: msg: Suggested BufferSize: 161085
18:32:20 M: 35561472 DEBUG: msg: Quality 10000
18:32:20 M: 35561472 DEBUG: msg: Sample size: 0
18:32:20 M: 35561472 DEBUG: msg: ==========================
18:32:20 M: 35561472 DEBUG: msg: Found 'bih', 40 bytes of 40
18:32:20 M: 35561472 DEBUG: msg: ======= VIDEO Format ======
18:32:20 M: 35561472 DEBUG: msg: biSize 40
18:32:20 M: 35561472 DEBUG: msg: biWidth 624
18:32:20 M: 35561472 DEBUG: msg: biHeight 336
18:32:20 M: 35561472 DEBUG: msg: biPlanes 1
18:32:20 M: 35561472 DEBUG: msg: biBitCount 24
18:32:20 M: 35561472 DEBUG: msg: biCompression 808802372='DX50'
18:32:20 M: 35561472 DEBUG: msg: biSizeImage 628992
18:32:20 M: 35561472 DEBUG: msg: ===========================
18:32:20 M: 35561472 DEBUG: msg: Regenerating keyframe table for MPEG-4 video.
18:32:20 M: 35561472 DEBUG: msg: list_end=0x217A
18:32:20 M: 35561472 DEBUG: msg: ==> Found audio stream: 1
18:32:20 M: 35561472 DEBUG: msg: ====== STREAM Header =====
18:32:20 M: 35561472 DEBUG: msg: Type: auds FCC: (0)
18:32:20 M: 35561472 DEBUG: msg: Flags: 0
18:32:20 M: 35561472 DEBUG: msg: Priority: 0 Language: 0
18:32:20 M: 35561472 DEBUG: msg: InitialFrames: 1
18:32:20 M: 35561472 DEBUG: msg: Rate: 20000/1 = 20000.000
18:32:20 M: 35561472 DEBUG: msg: Start: 0 Len: 106539520
18:32:20 M: 35561472 DEBUG: msg: Suggested BufferSize: 10000
18:32:20 M: 35561472 DEBUG: msg: Quality -1
18:32:20 M: 35561472 DEBUG: msg: Sample size: 1
18:32:20 M: 35561472 DEBUG: msg: ==========================
18:32:20 M: 35561472 DEBUG: msg: Found 'wf', 18 bytes of 18
18:32:20 M: 35561472 DEBUG: msg: ======= WAVE Format =======
18:32:20 M: 35561472 DEBUG: msg: Format Tag: 8192 (0x2000)
18:32:20 M: 35561472 DEBUG: msg: Channels: 2
18:32:20 M: 35561472 DEBUG: msg: Samplerate: 48000
18:32:20 M: 35561472 DEBUG: msg: avg byte/sec: 20000
18:32:20 M: 35561472 DEBUG: msg: Block align: 1
18:32:20 M: 35561472 DEBUG: msg: bits/sample: 0
18:32:20 M: 35561472 DEBUG: msg: cbSize: 0
18:32:20 M: 35561472 DEBUG: msg: ===========================
18:32:20 M: 35561472 DEBUG: msg: list_end=0x2286
18:32:20 M: 35561472 DEBUG: msg: AVI: dmlh found (size=248) (total_frames=133176)
18:32:20 M: 35561472 DEBUG: msg: list_end=0x22C6
18:32:20 M: 35561472 DEBUG: msg: hdr=Software size=44
18:32:20 M: 35561472 DEBUG: msg: Software : VirtualDubMod 1.5.10.2 (build 2540/release)
18:32:20 M: 35561472 DEBUG: msg: list_end=0x2B768470
18:32:20 M: 35561472 DEBUG: msg: Found movie at 0x280C - 0x2B768470
18:32:20 M: 35561472 DEBUG: msg: Reading INDEX block, 266339 chunks for 133176 frames (fpos=729187448).
18:32:20 M: 31293440 DEBUG: msg: AVI index offset: 0x2808 (movi=0x280C idx0=0x4 idx1=0x271C)
18:32:20 M: 31293440 DEBUG: msg: Auto-selected AVI audio ID = 1
18:32:20 M: 31293440 DEBUG: msg: Auto-selected AVI video ID = 0
18:32:20 M: 31281152 DEBUG: msg: AVI: Searching for audio stream (id:1)
18:32:20 M: 31281152 DEBUG: msg: AVI video size=620448277 (133176) audio size=106539520 (106539520)
18:32:20 M: 31281152 DEBUG: msg: [V] filefmt:3 fourcc:0x30355844 size:624x336 fps:25.00 ftime:=0.0400
18:32:20 M: 31281152 DEBUG: msg: Clip info:
18:32:20 M: 31281152 DEBUG: msg: Software: VirtualDubMod 1.5.10.2 (build 2540/release)
18:32:20 M: 31281152 DEBUG: msg: get_path('sub/') -> 'Q:\system\players\mplayer\sub/'
18:32:20 M: 31281152 DEBUG: msg: Starting lookup for subs
18:32:20 M: 31281152 DEBUG: msg: Global Subsize: 0 - VOBSUB: -1, DEMUX: -1, SUBS: -1
18:32:20 M: 31281152 DEBUG: msg: Global Subpos : -1
18:32:20 M: 31281152 DEBUG: msg: ==========================================================================
18:32:20 M: 31281152 DEBUG: msg: Opening audio decoder: [liba52] AC3 decoding with liba52
18:32:20 M: 31281152 DEBUG: msg: dec_audio: Allocating 3840 bytes for input buffer.
18:32:20 M: 31281152 DEBUG: msg: dec_audio: Allocating 18432 + 65536 = 83968 bytes for output buffer.
18:32:20 M: 31178752 DEBUG: No accelerated IMDCT transform found
18:32:20 M: 31178752 DEBUG: msg: AC3: 2.0 (stereo) 48000 Hz 160.0 kbit/s
18:32:20 M: 31178752 DEBUG: msg: A52 flags before a52_frame: 0x37
18:32:20 M: 31178752 DEBUG: msg: A52 flags after a52_frame: 0x2
18:32:20 M: 31178752 INFO: msg: Unimplemented resampler for mode 0x2 -> 6 channels conversion - Contact MPlayer developers!
18:32:20 M: 31178752 DEBUG: msg: A52 flags before a52_frame: 0x27
18:32:20 M: 31178752 DEBUG: msg: A52 flags after a52_frame: 0x2
18:32:20 M: 31178752 INFO: msg: Unimplemented resampler for mode 0x2 -> 5 channels conversion - Contact MPlayer developers!
18:32:20 M: 31178752 DEBUG: msg: A52 flags before a52_frame: 0x26
18:32:20 M: 31178752 DEBUG: msg: A52 flags after a52_frame: 0x2
18:32:20 M: 31178752 INFO: msg: Unimplemented resampler for mode 0x2 -> 4 channels conversion - Contact MPlayer developers!
18:32:20 M: 31178752 DEBUG: msg: A52 flags before a52_frame: 0x24
18:32:20 M: 31178752 DEBUG: msg: A52 flags after a52_frame: 0x2
18:32:20 M: 31178752 INFO: msg: Unimplemented resampler for mode 0x2 -> 3 channels conversion - Contact MPlayer developers!
18:32:20 M: 31178752 DEBUG: msg: A52 flags before a52_frame: 0x2A
18:32:20 M: 31178752 DEBUG: msg: A52 flags after a52_frame: 0x2
18:32:20 M: 31178752 DEBUG: Using MMX optimized resampler
18:32:20 M: 31178752 DEBUG: msg: AUDIO: 48000 Hz, 2 ch, 16 bit (0x10), ratio: 20000->192000 (160.0 kbit)
18:32:20 M: 31178752 DEBUG: msg: Selected audio codec: [a52] afm:liba52 (AC3-liba52)
18:32:20 M: 31178752 DEBUG: msg: ==========================================================================
18:32:20 M: 31178752 DEBUG: CXBoxRenderManager::PreInit - Selected RGB-Renderer
18:32:20 M: 31178752 DEBUG: msg: ==========================================================================
18:32:20 M: 31178752 DEBUG: msg: Opening video decoder: [ffmpeg] FFmpeg's libavcodec codec family
18:32:20 M: 30924800 DEBUG: msg: INFO: libavcodec init OK!
18:32:20 M: 30924800 DEBUG: msg: Selected video codec: [ffodivx] vfm:ffmpeg (FFmpeg MPEG-4)
18:32:20 M: 30924800 DEBUG: msg: ==========================================================================
18:32:20 M: 30924800 DEBUG: msg: Checking audio filter chain for 48000Hz/2ch/16bit -> 48000Hz/6ch/16bit...
18:32:20 M: 30924800 DEBUG: msg: [libaf] Adding filter dummy
18:32:20 M: 30924800 DEBUG: msg: [dummy] Was reinitialized, rate=48000Hz, nch = 2, format = 0x00000001 and bps = 2
18:32:20 M: 30924800 DEBUG: msg: AF_pre: af format: 2 bps, 2 ch, 48000 hz, little endian signed int
18:32:20 M: 30924800 DEBUG: msg: AF_pre: 48000Hz 2ch Signed 16-bit (Little-Endian)
18:32:20 M: 30887936 DEBUG: msg: AO: [win32] 48000Hz 2ch Signed 16-bit (Little-Endian) (2 bps)
18:32:20 M: 30887936 DEBUG: msg: AO: Description: Windows waveOut audio output
AO: Author: SaschaSommer <saschasommer@freenet.de>
18:32:20 M: 30887936 DEBUG: msg: Building audio filter chain for 48000Hz/2ch/16bit -> 48000Hz/2ch/16bit...
18:32:20 M: 30887936 DEBUG: msg: [dummy] Was reinitialized, rate=48000Hz, nch = 2, format = 0x00000001 and bps = 2
18:32:20 M: 30887936 DEBUG: msg: [dummy] Was reinitialized, rate=48000Hz, nch = 2, format = 0x00000001 and bps = 2
18:32:20 M: 30818304 DEBUG: msg: Starting playback...
18:32:20 M: 30818304 DEBUG: msg: mplayer_open_file(G:\Movies AVI\Saw IV.avi) done 1.0000
18:32:20 M: 30294016 INFO: Loading skin file: VideoOverlay.xml
18:32:20 M: 30294016 DEBUG: Playback has started
18:32:20 M: 30408704 DEBUG: msg: [ffmpeg] aspect_ratio: 1.857143
18:32:20 M: 30408704 DEBUG: CGUIInfoManager::SetCurrentMovie(G:\Movies AVI\Saw IV.avi)
18:32:20 M: 30408704 DEBUG: msg: VDec: vo config request - 624 x 336 (preferred colorspace: Planar YV12)
18:32:20 M: 30392320 DEBUG: msg: Trying filter chain:
18:32:20 M: 30367744 DEBUG: msg: vo
18:32:20 M: 30388224 DEBUG: msg:
18:32:20 M: 30347264 DEBUG: msg: VDec: using Planar YV12 as output csp (no 0)
18:32:20 M: 30347264 DEBUG: msg: Movie-Aspect is 1.86:1 - prescaling to correct movie aspect.
18:32:20 M: 30347264 DEBUG: msg: VO Config (624x336->624x336,flags=1,'MPlayer',0x32315659)
18:32:20 M: 30347264 DEBUG: msg: VO: [directx] 624x336 => 624x336 Planar YV12 [fs]
18:32:20 M: 30347264 DEBUG: msg: VO: Description: XBOX Direct3D8 YUY2 renderer
18:32:20 M: 30347264 DEBUG: msg: VO: Author: Frodo/JCMarshall
18:32:20 M: 30388224 DEBUG: CVideoDatabase::GetMovieInfo(G:\Movies AVI\Saw IV.avi), query = select idMovie from movie where idFile=44
18:32:20 M: 30347264 DEBUG: mplayer::video_config(624, 336, 624, 336, 1, 842094169)
18:32:20 M: 30347264 NOTICE: Display resolution AUTO : 480p 16:9 (3)
18:32:20 M: 29327360 DEBUG: CVideoDatabase::GetEpisodeInfo(G:\Movies AVI\Saw IV.avi), query = select idEpisode from episode where idFile=44
18:32:20 M: 29331456 DEBUG: CVideoDatabase::GetMusicVideoInfo(G:\Movies AVI\Saw IV.avi), query = select idMVideo from musicvideo where idFile=44
18:32:20 M: 29884416 DEBUG: Activating window ID: 12005
18:32:20 M: 29884416 DEBUG: Checking if window ID 12005 is locked.
18:32:20 M: 31133696 DEBUG: Setting resolution 3
18:32:20 M: 33345536 ERROR: exception in CApplication::Process()