rendered paste body19:30:36 M: 56016896 NOTICE: -----------------------------------------------------------------------
19:30:36 M: 55996416 NOTICE: Starting XBMC, Platform: Xbox. Built on May 19 2008
19:30:36 M: 55996416 NOTICE: Q is mapped to: E:\apps\xbmc
19:30:36 M: 55996416 NOTICE: The executeable running is: E:\apps\xbmc\default.xbe
19:30:36 M: 55996416 NOTICE: Log File is located: Q:\xbmc.log
19:30:36 M: 55996416 NOTICE: -----------------------------------------------------------------------
19:30:36 M: 55996416 NOTICE: Unmapped drive T
19:30:36 M: 55996416 NOTICE: Mapping drive T to Harddisk0\Partition1\apps\xbmc\UserData
19:30:36 M: 55996416 NOTICE: Setup DirectX
19:30:36 M: 55975936 NOTICE: Mapping drive C to Harddisk0\Partition2
19:30:36 M: 55975936 NOTICE: Mapping drive E to Harddisk0\Partition1
19:30:36 M: 55975936 NOTICE: Unmapped drive D
19:30:36 M: 55975936 NOTICE: Mapping drive D to Cdrom0
19:30:36 M: 55975936 NOTICE: Mapping drive F to Harddisk0\Partition6
19:30:36 M: 55975936 NOTICE: Mapping drive X to Harddisk0\Partition3
19:30:36 M: 55975936 NOTICE: Mapping drive Y to Harddisk0\Partition4
19:30:36 M: 55975936 NOTICE: Unmapped drive Z
19:30:36 M: 55975936 NOTICE: Mapping drive Z to Harddisk0\Partition5
19:30:36 M: 55975936 NOTICE: load settings...
19:30:36 M: 55975936 NOTICE: Mapping drive P to Harddisk0\Partition1\apps\xbmc\UserData
19:30:36 M: 55975936 NOTICE: loading T:\guisettings.xml
19:30:36 M: 55652352 NOTICE: Getting hardware information now...
19:30:36 M: 55652352 NOTICE: Checking resolution 1
19:30:37 M: 55652352 NOTICE: Getting hardware information now...
19:30:37 M: 55631872 INFO: Using digital output
19:30:37 M: 55631872 INFO: AC3 pass through is enabled
19:30:37 M: 55631872 INFO: DTS pass through is enabled
19:30:37 M: 55631872 NOTICE: Checking resolution 1
19:30:37 M: 55631872 INFO: AV Pack: HDTV
19:30:37 M: 55631872 INFO: AV Flags: Widescreen,Pal60,480p,720p,1080i
19:30:37 M: 55631872 NOTICE: Per AV pack settings are off
19:30:37 M: 55894016 NOTICE: q:\UserData\sources.xml
19:30:37 M: 55889920 DEBUG: Setting <default> source to : Games
19:30:37 M: 55869440 INFO: Checking skinpath existance, and existence of keymap.xml:Q:\skin...
19:30:37 M: 55869440 DEBUG: We set resolution 1
19:30:37 M: 47362048 INFO: load language info file:Q:\language\German\langinfo.xml
19:30:37 M: 46837760 INFO: load language file:Q:\language\German\strings.xml
19:30:37 M: 46665728 INFO: load keymapping
19:30:37 M: 46665728 INFO: Loading P:\Keymap.xml
19:30:37 M: 46469120 ERROR: Window Translator: Can't find window webbrowser
19:30:37 M: 46448640 ERROR: Window Translator: Can't find window webbrowserosd
19:30:37 M: 46448640 ERROR: Window Translator: Can't find window webbookmarks
19:30:37 M: 46448640 ERROR: Window Translator: Can't find window webhistory
19:30:37 M: 46608384 INFO: Checking skin version of: Project Mayhem III
19:30:37 M: 46620672 INFO: Skin version is: 2.1
19:30:37 M: 46620672 INFO: GUI format 1280x720 720p 16:9
19:30:37 M: 46620672 INFO: install unhandled exception filter
19:30:37 M: 46620672 INFO: creating subdirectories
19:30:37 M: 46620672 INFO: userdata folder: q:\UserData
19:30:37 M: 46620672 INFO: recording folder:F:\audio
19:30:37 M: 46620672 INFO: screenshots folder:E:\screenshots
19:30:37 M: 46620672 INFO: thumbnails folder:q:\UserData\Thumbnails
19:30:37 M: 46608384 NOTICE: Checking the Date!
19:30:37 M: 46608384 INFO: - Current Date is: 5-6-2008
19:30:37 M: 46608384 NOTICE: start dvd mediatype detection
19:30:37 M: 46542848 NOTICE: initializing playlistplayer
19:30:37 M: 46542848 DEBUG: Compiled with libcdio Version 0.72
19:30:37 M: 46542848 NOTICE: DONE initializing playlistplayer
19:30:37 M: 46542848 INFO: lcd not used
19:30:37 M: 46542848 NOTICE: start fancontroller
19:30:37 M: 46010368 NOTICE: load default skin:[Project Mayhem III]
19:30:37 M: 46010368 INFO: load skin from:Q:\skin\Project Mayhem III
19:30:37 M: 46010368 INFO: delete old skin...
19:30:37 M: 46010368 INFO: Default 4:3 resolution directory is Q:\skin\Project Mayhem III\PAL
19:30:37 M: 46010368 INFO: Default 16:9 resolution directory is Q:\skin\Project Mayhem III\PAL16x9
19:30:37 M: 46010368 INFO: Skin version is: 2.1
19:30:37 M: 46010368 INFO: Loading skin includes from Q:\skin\Project Mayhem III\PAL\includes.xml
19:30:38 M: 44548096 INFO: load fonts for skin...
19:30:38 M: 44556288 INFO: Loading colors from Q:\skin\Project Mayhem III\colors\SKINDEFAULT.xml
19:30:38 M: 44556288 INFO: Loading fonts from Q:\skin\Project Mayhem III\720p\Font.xml
19:30:38 M: 44457984 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\media\Fonts\Arial.ttf (18.722223): width = 52, height = 26, lineheight = 22
19:30:38 M: 44380160 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\media\Fonts\Arial.ttf (13.105556): width = 36, height = 19, lineheight = 15
19:30:38 M: 44294144 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\media\Fonts\Arial.ttf (17.786112): width = 49, height = 25, lineheight = 20
19:30:38 M: 44191744 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\media\Fonts\Arial.ttf (19.658335): width = 54, height = 28, lineheight = 23
19:30:38 M: 44154880 ERROR: unable to load Q:\skin\Project Mayhem III\language\German\strings.xml: Failed to open file at line 0
19:30:38 M: 44154880 ERROR: unable to load Q:\skin\Project Mayhem III\language\English\strings.xml: Failed to open file at line 0
19:30:38 M: 44154880 INFO: load new skin...
19:30:38 M: 44154880 INFO: Skin version is: 2.1
19:30:38 M: 44154880 INFO: Loading skin file: Home.xml
19:30:38 M: 43163648 DEBUG: Load Home.xml: 93.52ms (21.59 ms xml load)
19:30:38 M: 43298816 INFO: Loading user windows, path Q:\skin\Project Mayhem III\PAL16x9
19:30:38 M: 43319296 INFO: Loading user windows, path Q:\skin\Project Mayhem III\PAL
19:30:38 M: 43319296 INFO: Loading skin file: Q:\skin\Project Mayhem III\PAL\custom2_SkinSettings.xml
19:30:38 M: 43319296 DEBUG: Load Skin XML: 124.15ms
19:30:38 M: 43319296 INFO: initialize new skin...
19:30:38 M: 43319296 INFO: Loading skin file: Pointer.xml
19:30:38 M: 43319296 DEBUG: Load Pointer.xml: 10.77ms (9.29 ms xml load)
19:30:38 M: 43286528 DEBUG: Alloc resources: 76.10ms (12.08 ms skin load, 54.70 ms preload)
19:30:38 M: 43286528 INFO: Loading skin file: DialogVolumeBar.xml
19:30:38 M: 43286528 DEBUG: Load DialogVolumeBar.xml: 9.16ms (7.10 ms xml load)
19:30:38 M: 43278336 DEBUG: Alloc resources: 22.07ms (10.15 ms skin load, 0.15 ms preload)
19:30:38 M: 43278336 INFO: Loading skin file: DialogSeekBar.xml
19:30:38 M: 43274240 DEBUG: Load DialogSeekBar.xml: 13.70ms (4.80 ms xml load)
19:30:38 M: 43241472 DEBUG: Alloc resources: 16.62ms (15.02 ms skin load, 0.26 ms preload)
19:30:38 M: 43241472 INFO: Loading skin file: DialogKaiToast.xml
19:30:38 M: 43241472 DEBUG: Load DialogKaiToast.xml: 21.10ms (19.56 ms xml load)
19:30:38 M: 43241472 DEBUG: Alloc resources: 21.85ms (21.84 ms skin load, 0.00 ms preload)
19:30:38 M: 43241472 INFO: Loading skin file: DialogMuteBug.xml
19:30:38 M: 43241472 DEBUG: Load DialogMuteBug.xml: 1.64ms (1.01 ms xml load)
19:30:38 M: 43241472 DEBUG: Alloc resources: 2.20ms (2.20 ms skin load, 0.00 ms preload)
19:30:38 M: 42848256 INFO: skin loaded...
19:30:38 M: 42311680 INFO: Loading skin file: DialogBusy.xml
19:30:38 M: 42319872 DEBUG: Load DialogBusy.xml: 21.64ms (20.71 ms xml load)
19:30:38 M: 42844160 DEBUG: Activating window ID: 12999
19:30:38 M: 42844160 DEBUG: Checking if window ID 12999 is locked.
19:30:38 M: 42844160 INFO: Loading skin file: Startup.xml
19:30:38 M: 42844160 DEBUG: Load Startup.xml: 12.28ms (8.75 ms xml load)
19:30:38 M: 42844160 DEBUG: Alloc resources: 13.04ms (13.02 ms skin load, 0.01 ms preload)
19:30:38 M: 42844160 NOTICE: use DHCP
19:30:38 M: 42528768 INFO: removing tempfiles
19:30:38 M: 42528768 NOTICE: initialize done
19:30:38 M: 42528768 NOTICE: Running the application...
19:30:38 M: 40361984 INFO: CNetwork::LogState - Link: full duplex
19:30:38 M: 40361984 INFO: CNetwork::LogState - Link: 100 mbps
19:30:38 M: 40361984 INFO: CNetwork::LogState - ip:
19:30:38 M: 40361984 INFO: CNetwork::LogState - subnet:
19:30:38 M: 40673280 INFO: CNetwork::LogState - gateway:
19:30:38 M: 40148992 INFO: - dns: CNetwork::LogState,
19:30:38 M: 39522304 DEBUG: CApplication::OnMessage : Translating ReplaceWindow(Home)
19:30:38 M: 39522304 DEBUG: CApplication::OnMessage : To ReplaceWindow(Home)
19:30:38 M: 39522304 DEBUG: Activating window ID: 10000
19:30:38 M: 39522304 DEBUG: Checking if window ID 10000 is locked.
19:30:39 M: 42254336 DEBUG: Alloc resources: 34.37ms (0.00 ms skin load, 1.86 ms preload)
19:30:40 M: 38977536 INFO: CNetwork::LogState - Link: full duplex
19:30:40 M: 38977536 INFO: CNetwork::LogState - Link: 100 mbps
19:30:40 M: 38977536 INFO: CNetwork::LogState - State: dns
19:30:40 M: 38977536 INFO: CNetwork::LogState - State: dhcp
19:30:40 M: 38977536 DEBUG: CNetwork::NetworkMessage - Starting network services
19:30:40 M: 38977536 INFO: CNetwork::LogState - ip: 192.168.0.100
19:30:40 M: 38977536 DEBUG: SECTION:Section SNTP loaded count:1 size:7120
19:30:40 M: 38977536 INFO: CNetwork::LogState - subnet: 255.255.255.0
19:30:40 M: 38977536 NOTICE: start timeserver client
19:30:40 M: 38977536 INFO: CNetwork::LogState - gateway: 192.168.0.1
19:30:40 M: 38912000 NOTICE: Webserver: Starting...
19:30:40 M: 38838272 INFO: 192.168.0.1 - dns: CNetwork::LogState, 0.0.0.0
19:30:40 M: 38903808 INFO: WEATHER: Downloading weather
19:30:40 M: 38903808 DEBUG: SECTION:Section LIBHTTP loaded count:1 size:80384
19:30:40 M: 38903808 INFO: Get URL: http://xoap.weather.com/weather/local/GMXX0263?cc=*&unit=m&dayf=4&prod=xoap&link=xoap&par=1004124588&key=079f24145f208494
19:30:40 M: 38903808 DEBUG: xbmcHttpShim starts
19:30:40 M: 38838272 NOTICE: XBFileZilla: Starting...
19:30:40 M: 38772736 INFO: WebServer: Server starting using Q:\web on 192.168.0.100:80
19:30:40 M: 38694912 INFO: Get URL: http://feeds.feedburner.com/XboxScene
19:30:40 M: 38694912 NOTICE: starting upnp client
19:30:40 M: 38674432 DEBUG: DB: Registering database table <users>
19:30:40 M: 38686720 DEBUG: .\Platinum\Source\Core\PltUPnP.cpp(125): [platinum.core.upnp] 1212687040:783 INFO: Starting UPnP...
19:30:40 M: 38686720 DEBUG: DB: Registering database table <groups>
19:30:40 M: 38608896 DEBUG: .\Platinum\Source\Core\PltUPnP.cpp(210): [platinum.core.upnp] 1212687040:806 INFO: Starting Ctrlpoint...
19:30:40 M: 38522880 DEBUG: DB: Registering database table <access>
19:30:40 M: 38514688 DEBUG: .\Platinum\Source\Core\PltHttpServer.cpp(74): [platinum.core.http.server] 1212687040:808 INFO: HttpServer listening on 0.0.0.0:60387
19:30:40 M: 38514688 DEBUG: UM: Loading User Configuration from file <umconfig.txt>
19:30:40 M: 38146048 NOTICE: starting upnp server
19:30:40 M: 38141952 DEBUG: DB: About to read data file <Q:\web\umconfig.txt>
19:30:40 M: 38060032 ERROR: <music> tag is missing or sources.xml is malformed
19:30:40 M: 38060032 ERROR: <video> tag is missing or sources.xml is malformed
19:30:40 M: 38060032 DEBUG: DB: Failed to stat persistent data file.
19:30:40 M: 38060032 ERROR: <pictures> tag is missing or sources.xml is malformed
19:30:40 M: 38060032 DEBUG: webs: Listening for HTTP requests at address 192.168.0.100
19:30:40 M: 38047744 DEBUG: .\Platinum\Source\Core\PltUPnP.cpp(178): [platinum.core.upnp] 1212687040:867 INFO: Starting Device...
19:30:40 M: 37974016 NOTICE: Webserver: Started
19:30:40 M: 37974016 DEBUG: .\Platinum\Source\Core\PltHttpServer.cpp(74): [platinum.core.http.server] 1212687040:868 INFO: HttpServer listening on 0.0.0.0:81
19:30:40 M: 37904384 DEBUG: .\Platinum\Source\Core\PltHttpServer.cpp(74): [platinum.core.http.server] 1212687040:872 INFO: HttpServer listening on 0.0.0.0:56697
19:30:40 M: 37789696 NOTICE: starting upnp renderer
19:30:40 M: 37789696 ERROR: <music> tag is missing or sources.xml is malformed
19:30:40 M: 37781504 ERROR: <video> tag is missing or sources.xml is malformed
19:30:40 M: 37781504 ERROR: <pictures> tag is missing or sources.xml is malformed
19:30:40 M: 37683200 DEBUG: .\Platinum\Source\Core\PltUPnP.cpp(178): [platinum.core.upnp] 1212687040:955 INFO: Starting Device...
19:30:40 M: 37625856 DEBUG: .\Platinum\Source\Core\PltHttpServer.cpp(74): [platinum.core.http.server] 1212687040:956 INFO: HttpServer listening on 0.0.0.0:62955
19:30:41 M: 37511168 NOTICE: ES: Starting event server
19:30:41 M: 36458496 DEBUG: AudioScrobbler: load cache
19:30:41 M: 36454400 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777
19:30:41 M: 36458496 DEBUG: AudioScrobbler: ...
19:30:41 M: 36450304 NOTICE: UDP: Listening on port 9777
19:30:41 M: 36450304 INFO: Get URL: http://post.audioscrobbler.com/?hs=true&p=1.1&c=xbm&v=0.1&u=redacted
19:30:41 M: 35782656 NOTICE: XBFileZilla: Started
19:30:41 M: 35819520 DEBUG: AudioScrobbler: Handshaking: Client up to date.
19:30:41 M: 35819520 DEBUG: AudioScrobbler: Submit interval set to 1 seconds.
19:30:41 M: 35819520 NOTICE: AudioScrobbler: Handshake successful.
19:30:41 M: 35848192 INFO: WEATHER: Weather download successful
19:30:42 M: 36024320 DEBUG: CApplication::OnKey: 168 pressed, action is 2
19:30:42 M: 35962880 DEBUG: CApplication::OnKey: 11 pressed, action is 7
19:30:42 M: 35962880 DEBUG: CApplication::OnMessage : Translating ActivateWindow(Favourites)
19:30:42 M: 35962880 DEBUG: CApplication::OnMessage : To ActivateWindow(Favourites)
19:30:42 M: 35962880 DEBUG: Activating window ID: 10134
19:30:42 M: 35962880 DEBUG: Checking if window ID 10134 is locked.
19:30:42 M: 35962880 INFO: Loading skin file: DialogFavourites.xml
19:30:42 M: 35962880 DEBUG: Load DialogFavourites.xml: 37.24ms (33.04 ms xml load)
19:30:42 M: 35942400 DEBUG: Alloc resources: 38.49ms (38.48 ms skin load, 0.00 ms preload)
19:30:43 M: 33771520 DEBUG: Got rss feed: http://feeds.feedburner.com/XboxScene
19:30:43 M: 33718272 DEBUG: RSS feed encoding: UTF-8
19:30:43 M: 33697792 DEBUG: Parsed rss feed: http://feeds.feedburner.com/XboxScene
19:30:43 M: 33804288 INFO: Get URL: http://bitspace.dyndns.org:6560/rss.xml
19:30:43 M: 33755136 DEBUG: .\Platinum\Source\Devices\MediaServer\PltMediaBrowser.cpp(58): [platinum.media.server.browser] 1212687043:707 WARNING: Service urn:schemas-upnp-org:service:ContentDirectory:1 not found
19:30:43 M: 33800192 ERROR: Server returned: 404 Not Found
19:30:43 M: 33837056 INFO: Get URL: http://bitspace.dyndns.org:6560/rss.xml
19:30:44 M: 33837056 DEBUG: CApplication::OnKey: 166 pressed, action is 3
19:30:44 M: 33083392 DEBUG: CApplication::OnKey: 166 pressed, action is 3
19:30:45 M: 33083392 DEBUG: CApplication::OnKey: 11 pressed, action is 7
19:30:45 M: 33083392 DEBUG: CApplication::OnMessage : Translating RunScript(Q:\scripts\VeohProxy\default.py)
19:30:45 M: 33083392 DEBUG: CApplication::OnMessage : To RunScript(Q:\scripts\VeohProxy\default.py)
19:30:45 M: 33083392 DEBUG: LoadLibraryA('python24.dll')
19:30:45 M: 31952896 DEBUG: LoadLibrary('python24.dll') returning: 00C208E0
19:30:45 M: 31932416 DEBUG: dllGetProcAddress(007B8A10(kernel32.dll), 'InterlockedCompareExchange') => 000C8644
19:30:45 M: 31666176 DEBUG: GetModuleFileNameA(00000000, 1E102490, 256) => 'xbmc.xbe'
19:30:45 M: 31645696 DEBUG: advapi32.dll fake function RegQueryInfoKeyA called
19:30:45 M: 31645696 DEBUG: advapi32.dll fake function RegQueryInfoKeyA called
19:30:45 M: 31563776 DEBUG: LoadLibraryExA called with flags:
- LOAD_WITH_ALTERED_SEARCH_PATH
19:30:45 M: 31543296 DEBUG: LoadLibraryA('zlib.pyd')
19:30:45 M: 31473664 DEBUG: kernel32.dll fake function DisableThreadLibraryCalls called
19:30:45 M: 31473664 DEBUG: LoadLibrary('zlib.pyd') returning: 00A82480
19:30:45 M: 31473664 DEBUG: dllGetProcAddress(1E1B0000(zlib.pyd), 'initzlib') => 1E1B2150
19:30:46 M: 30384128 INFO: -->Python Initialized<--
19:30:46 M: 30363648 INFO:
19:30:46 M: 29462528 DEBUG: kernel32.dll fake function SetConsoleCtrlHandler called
19:30:46 M: 31559680 DEBUG: LoadLibraryExA called with flags:
- LOAD_WITH_ALTERED_SEARCH_PATH
19:30:46 M: 31559680 DEBUG: LoadLibraryA('_socket.pyd')
19:30:46 M: 31510528 DEBUG: kernel32.dll fake function DisableThreadLibraryCalls called
19:30:46 M: 31510528 DEBUG: LoadLibrary('_socket.pyd') returning: 009DC700
19:30:46 M: 31510528 DEBUG: dllGetProcAddress(1E1D0000(_socket.pyd), 'init_socket') => 1E1D4BF0
19:30:46 M: 31485952 DEBUG: LoadLibraryExA called with flags:
- LOAD_WITH_ALTERED_SEARCH_PATH
19:30:46 M: 31485952 DEBUG: LoadLibraryA('_ssl.pyd')
19:30:46 M: 30986240 DEBUG: Unable to resolve msvcr71.dll _getch
19:30:46 M: 30986240 DEBUG: Unable to resolve kernel32.dll FlushConsoleInputBuffer
19:30:46 M: 30986240 DEBUG: kernel32.dll fake function DisableThreadLibraryCalls called
19:30:46 M: 30986240 DEBUG: LoadLibrary('_ssl.pyd') returning: 00A40100
19:30:46 M: 30986240 DEBUG: dllGetProcAddress(10000000(_ssl.pyd), 'init_ssl') => 10001820
19:30:47 M: 30679040 DEBUG: dllGetProcAddress(007B9230(advapi32.dll), 'CryptAcquireContextA') => 0023EA73
19:30:47 M: 30679040 DEBUG: dllGetProcAddress(007B9230(advapi32.dll), 'CryptGenRandom') => 0023BEC0
19:30:47 M: 30679040 DEBUG: advapi32.dll fake function dllCryptAcquireContext() called
19:30:47 M: 30679040 DEBUG: dllbind: family:2 port:64652 ip:127.0.0.1
19:30:47 M: 30679040 DEBUG: LoadLibraryA('ws2_32')
19:30:47 M: 30679040 DEBUG: LoadLibrary('ws2_32.dll') returning: 007B89A8
19:30:47 M: 30679040 DEBUG: dllGetProcAddress(007B89A8(ws2_32.dll), 'getaddrinfo') => 0023BE9B
19:30:47 M: 30679040 DEBUG: dllGetProcAddress(007B89A8(ws2_32.dll), 'getaddrinfo') => 0023BE9B
19:30:47 M: 30679040 DEBUG: dllGetProcAddress(007B89A8(ws2_32.dll), 'getnameinfo') => 0023B580
19:30:47 M: 30679040 DEBUG: dllGetProcAddress(007B89A8(ws2_32.dll), 'freeaddrinfo') => 0023B101
19:30:47 M: 30679040 WARNING: Untested function dllgethostbyaddr called!
19:30:47 M: 30679040 INFO: Thu Jun 05 19:30:47 2008
19:30:47 M: 30679040 INFO:
19:30:47 M: 30679040 INFO: VeohProxy Starts - 127.0.0.1:64652
19:30:47 M: 30679040 INFO:
19:30:47 M: 30679040 DEBUG: CApplication::OnKey: 169 pressed, action is 1
19:30:48 M: 30732288 DEBUG: CApplication::OnKey: 167 pressed, action is 4
19:30:48 M: 30732288 DEBUG: CApplication::OnKey: 167 pressed, action is 4
19:30:49 M: 30732288 DEBUG: CApplication::OnKey: 11 pressed, action is 7
19:30:49 M: 30740480 DEBUG: CApplication::OnMessage : Translating ActivateWindow(MyVideos)
19:30:49 M: 30740480 DEBUG: CApplication::OnMessage : To ActivateWindow(MyVideos)
19:30:49 M: 30740480 DEBUG: Activating window ID: 10024
19:30:49 M: 30740480 DEBUG: Checking if window ID 10024 is locked.
19:30:49 M: 34230272 INFO: Attempting to default to:
19:30:49 M: 34217984 INFO: Loading skin file: MyVideo.xml
19:30:49 M: 33521664 DEBUG: Load MyVideo.xml: 122.28ms (32.46 ms xml load)
19:30:50 M: 33533952 DEBUG: Alloc resources: 194.51ms (128.56 ms skin load, 0.85 ms preload)
19:30:50 M: 33583104 DEBUG: CGUIMediaWindow::GetDirectory ()
19:30:50 M: 33583104 DEBUG: ParentPath = []
19:30:50 M: 30142464 DEBUG: CApplication::OnKey: 167 pressed, action is 4
19:30:51 M: 30142464 DEBUG: CApplication::OnKey: 167 pressed, action is 4
<Stuff removed, pastebin size limit>
19:30:52 M: 29487104 DEBUG: CApplication::OnKey: 167 pressed, action is 4
19:30:52 M: 29880320 DEBUG: CApplication::OnKey: 167 pressed, action is 4
19:30:52 M: 29741056 DEBUG: CApplication::OnKey: 166 pressed, action is 3
19:30:53 M: 29741056 DEBUG: CApplication::OnKey: 166 pressed, action is 3
19:30:53 M: 29741056 DEBUG: CApplication::OnKey: 166 pressed, action is 3
19:30:53 M: 29741056 DEBUG: CApplication::OnKey: 166 pressed, action is 3
19:30:54 M: 29741056 DEBUG: CApplication::OnKey: 11 pressed, action is 7
19:30:54 M: 29741056 DEBUG: Clearing cached fileitems [plugin://video/Ninja Video/]
19:30:54 M: 32358400 DEBUG: CGUIMediaWindow::GetDirectory (plugin://video/Ninja Video/)
19:30:54 M: 32358400 DEBUG: ParentPath = []
19:30:54 M: 32358400 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - URL for plugin settings: Ninja Video/
19:30:54 M: 32358400 ERROR: Unable to load: Q:\plugins\video\Ninja Video\resources\settings.xml, Line 0
Failed to open file
19:30:54 M: 32358400 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\German\strings.xml: Failed to open file at line 0
19:30:54 M: 32358400 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\english\strings.xml: Failed to open file at line 0
19:30:54 M: 32358400 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - calling plugin Q:\plugins\video\Ninja Video\default.py('plugin://video/Ninja Video/','0','')
19:30:54 M: 31834112 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult - waiting on the Ninja Video plugin...
19:30:55 M: 30912512 INFO: Mode: None
19:30:55 M: 30912512 INFO:
19:30:55 M: 30912512 INFO: URL: None
19:30:55 M: 30912512 INFO:
19:30:55 M: 30912512 INFO: Name: None
19:30:55 M: 30912512 INFO:
19:30:55 M: 30912512 INFO: main category index :
19:30:55 M: 30912512 INFO:
19:30:55 M: 30912512 INFO: Scriptresult: Succes
19:30:55 M: 30912512 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult- plugin returned successfully
19:30:55 M: 30912512 INFO: Python script stopped
19:30:56 M: 30720000 DEBUG: CApplication::OnKey: 168 pressed, action is 2
19:30:56 M: 30720000 DEBUG: CApplication::OnKey: 167 pressed, action is 4
19:30:57 M: 30720000 DEBUG: CApplication::OnKey: 11 pressed, action is 7
19:30:57 M: 30720000 DEBUG: Clearing cached fileitems [plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Ftvshows&mode=1&name=3.+TV+SHOWS]
19:30:57 M: 31436800 DEBUG: CGUIMediaWindow::GetDirectory (plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Ftvshows&mode=1&name=3.+TV+SHOWS)
19:30:57 M: 31436800 DEBUG: ParentPath = [plugin://video/Ninja Video/]
19:30:57 M: 31436800 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - URL for plugin settings: Ninja Video/
19:30:57 M: 31436800 ERROR: Unable to load: Q:\plugins\video\Ninja Video\resources\settings.xml, Line 0
Failed to open file
19:30:57 M: 31436800 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\German\strings.xml: Failed to open file at line 0
19:30:57 M: 31436800 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\english\strings.xml: Failed to open file at line 0
19:30:57 M: 31436800 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - calling plugin Q:\plugins\video\Ninja Video\default.py('plugin://video/Ninja Video/','1','?url=http%3A%2F%2Fwww.ninjavideo.net%2Ftvshows&mode=1&name=3.+TV+SHOWS')
19:30:57 M: 30912512 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult - waiting on the Ninja Video plugin...
19:30:57 M: 30912512 INFO: Mode: 1
19:30:57 M: 30912512 INFO:
19:30:57 M: 30912512 INFO: URL: http://www.ninjavideo.net/tvshows
19:30:57 M: 30912512 INFO:
19:30:57 M: 30912512 INFO: Name: 3. TV SHOWS
19:30:57 M: 30912512 INFO:
19:30:57 M: 30912512 INFO: index of shows : http://www.ninjavideo.net/tvshows
19:30:57 M: 30912512 INFO:
19:30:57 M: 30855168 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult- plugin returned successfully
19:30:57 M: 30834688 INFO: Scriptresult: Succes
19:30:57 M: 30814208 INFO: Python script stopped
19:31:00 M: 31186944 DEBUG: CApplication::OnKey: 167 pressed, action is 4
19:31:00 M: 31166464 DEBUG: CApplication::OnKey: 167 pressed, action is 4
<Stuff removed, pastebin size limit>
19:31:02 M: 31113216 DEBUG: CApplication::OnKey: 167 pressed, action is 4
19:31:02 M: 31096832 DEBUG: CApplication::OnKey: 167 pressed, action is 4
19:31:02 M: 31117312 DEBUG: CApplication::OnKey: 166 pressed, action is 3
19:31:03 M: 31117312 DEBUG: CApplication::OnKey: 166 pressed, action is 3
19:31:03 M: 31117312 DEBUG: CApplication::OnKey: 166 pressed, action is 3
19:31:03 M: 31117312 DEBUG: CApplication::OnKey: 166 pressed, action is 3
19:31:03 M: 31096832 DEBUG: CApplication::OnKey: 166 pressed, action is 3
19:31:03 M: 31096832 DEBUG: CApplication::OnKey: 166 pressed, action is 3
19:31:03 M: 31096832 DEBUG: CApplication::OnKey: 166 pressed, action is 3
19:31:03 M: 31096832 DEBUG: CApplication::OnKey: 166 pressed, action is 3
19:31:04 M: 31059968 DEBUG: CApplication::OnKey: 11 pressed, action is 7
19:31:04 M: 31059968 DEBUG: Clearing cached fileitems [plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fcat%2F294&mode=2&name=Bones]
19:31:04 M: 31059968 ERROR: Server returned: 404 Not Found
19:31:04 M: 31408128 DEBUG: CGUIMediaWindow::GetDirectory (plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fcat%2F294&mode=2&name=Bones)
19:31:04 M: 31408128 INFO: Get URL: http://bitspace.dyndns.org:6560/rss.xml
19:31:04 M: 31408128 DEBUG: ParentPath = [plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Ftvshows&mode=1&name=3.+TV+SHOWS]
19:31:04 M: 31408128 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - URL for plugin settings: Ninja Video/
19:31:04 M: 31408128 ERROR: Unable to load: Q:\plugins\video\Ninja Video\resources\settings.xml, Line 0
Failed to open file
19:31:04 M: 31408128 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\German\strings.xml: Failed to open file at line 0
19:31:04 M: 31408128 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\english\strings.xml: Failed to open file at line 0
19:31:04 M: 31408128 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - calling plugin Q:\plugins\video\Ninja Video\default.py('plugin://video/Ninja Video/','1','?url=http%3A%2F%2Fwww.ninjavideo.net%2Fcat%2F294&mode=2&name=Bones')
19:31:04 M: 30883840 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult - waiting on the Ninja Video plugin...
19:31:04 M: 30883840 INFO: Mode: 2
19:31:04 M: 30883840 INFO:
19:31:04 M: 30883840 INFO: URL: http://www.ninjavideo.net/cat/294
19:31:04 M: 30883840 INFO:
19:31:04 M: 30883840 INFO: Name: Bones
19:31:04 M: 30883840 INFO:
19:31:04 M: 30883840 INFO: index of seasons : http://www.ninjavideo.net/cat/294
19:31:04 M: 30883840 INFO:
19:31:04 M: 30846976 INFO: Scriptresult: Succes
19:31:04 M: 30846976 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult- plugin returned successfully
19:31:04 M: 30846976 INFO: Python script stopped
19:31:04 M: 31371264 ERROR: Server returned: 404 Not Found
19:31:05 M: 31342592 DEBUG: CApplication::OnKey: 167 pressed, action is 4
19:31:06 M: 31342592 DEBUG: CApplication::OnKey: 167 pressed, action is 4
19:31:06 M: 31342592 DEBUG: CApplication::OnKey: 167 pressed, action is 4
19:31:06 M: 31342592 DEBUG: CApplication::OnKey: 167 pressed, action is 4
19:31:06 M: 31342592 DEBUG: CApplication::OnKey: 167 pressed, action is 4
19:31:07 M: 31342592 DEBUG: CApplication::OnKey: 11 pressed, action is 7
19:31:07 M: 31342592 DEBUG: Clearing cached fileitems [plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fvideo%2F2873&mode=4&name=Bones+3x13+The+Verdict+In+The+Story]
19:31:07 M: 31473664 DEBUG: CGUIMediaWindow::GetDirectory (plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fvideo%2F2873&mode=4&name=Bones+3x13+The+Verdict+In+The+Story)
19:31:07 M: 31473664 DEBUG: ParentPath = [plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fcat%2F294&mode=2&name=Bones]
19:31:07 M: 31473664 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - URL for plugin settings: Ninja Video/
19:31:07 M: 31473664 ERROR: Unable to load: Q:\plugins\video\Ninja Video\resources\settings.xml, Line 0
Failed to open file
19:31:07 M: 31473664 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\German\strings.xml: Failed to open file at line 0
19:31:07 M: 31473664 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\english\strings.xml: Failed to open file at line 0
19:31:07 M: 31473664 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - calling plugin Q:\plugins\video\Ninja Video\default.py('plugin://video/Ninja Video/','1','?url=http%3A%2F%2Fwww.ninjavideo.net%2Fvideo%2F2873&mode=4&name=Bones+3x13+The+Verdict+In+The+Story')
19:31:07 M: 30949376 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult - waiting on the Ninja Video plugin...
19:31:07 M: 30953472 INFO: Mode: 4
19:31:07 M: 30953472 INFO:
19:31:07 M: 30953472 INFO: URL: http://www.ninjavideo.net/video/2873
19:31:07 M: 30953472 INFO:
19:31:07 M: 30953472 INFO: Name: Bones 3x13 The Verdict In The Story
19:31:07 M: 30953472 INFO:
19:31:07 M: 30953472 INFO: index of videolinks : http://www.ninjavideo.net/video/2873
19:31:07 M: 30953472 INFO:
19:31:07 M: 30953472 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult- plugin returned successfully
19:31:07 M: 30932992 INFO: Scriptresult: Succes
19:31:07 M: 30932992 INFO: Python script stopped
19:31:08 M: 31350784 DEBUG: CApplication::OnKey: 167 pressed, action is 4
19:31:08 M: 31350784 DEBUG: CApplication::OnKey: 11 pressed, action is 7
19:31:08 M: 30867456 DEBUG: Unable to resolve kernel32.dll PeekNamedPipe
19:31:08 M: 30867456 DEBUG: Dll MSVCP71.dll was not found in path
19:31:08 M: 30867456 DEBUG: Unable to load referenced dll MSVCP71.dll - Dll: Q:\system\libcurl.dll
19:31:08 M: 30867456 DEBUG: Unable to resolve MSVCP71.dll ?_Nomemory@std@@YAXXZ
19:31:08 M: 30867456 DEBUG: kernel32.dll fake function DisableThreadLibraryCalls called
19:31:08 M: 30830592 INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://127.0.0.1
19:31:08 M: 30830592 DEBUG: Curl:: Debug About to connect() to 127.0.0.1 port 64652 (#0)
19:31:08 M: 30830592 DEBUG: Curl:: Debug Trying 127.0.0.1...
19:31:08 M: 30306304 DEBUG: Curl:: Debug connected
19:31:08 M: 30294016 DEBUG: Curl:: Debug Connected to 127.0.0.1 (127.0.0.1) port 64652 (#0)
19:31:08 M: 30306304 DEBUG: Curl:: Debug HEAD /2873?.avi HTTP/1.1
User-Agent: XBMC/pre-2.1 (compatible; MSIE 6.0; Windows NT 5.1; WinampMPEG/5.09)
Host: 127.0.0.1:64652
Accept: */*
19:31:08 M: 30306304 INFO: Thu Jun 05 19:31:08 2008
19:31:08 M: 30306304 INFO:
19:31:08 M: 30306304 INFO: Serving HEAD request...
19:31:08 M: 30306304 INFO:
19:31:08 M: 30306304 INFO: Thu Jun 05 19:31:08 2008
19:31:08 M: 30306304 INFO:
19:31:08 M: 30306304 INFO: Getting infos from NinjaVideo.net for Video ID
19:31:08 M: 30306304 INFO:
19:31:08 M: 30306304 INFO: 2873
19:31:08 M: 30306304 INFO:
19:31:08 M: 30306304 INFO: ...
19:31:08 M: 30306304 INFO:
19:31:09 M: 30298112 WARNING: Untested function dllgethostbyaddr called!
19:31:09 M: 30298112 INFO: 127.0.0.1 - - [05/Jun/2008 19:31:09] "HEAD /2873?.avi HTTP/1.1" 200 -
19:31:09 M: 30298112 DEBUG: Curl:: Debug HTTP 1.0, assume close after body
19:31:09 M: 30298112 INFO: Thu Jun 05 19:31:09 2008
19:31:09 M: 30298112 DEBUG: Curl:: Debug HTTP/1.0 200 OK
19:31:09 M: 30298112 INFO:
19:31:09 M: 30298112 DEBUG: Curl:: Debug Server: BaseHTTP/0.3 Python/2.4.3
19:31:09 M: 30298112 INFO: Sending headers...
19:31:09 M: 30298112 DEBUG: Curl:: Debug Date: Thu, 05 Jun 2008 17:31:09 GMT
19:31:09 M: 30298112 INFO:
19:31:09 M: 30298112 DEBUG: Curl:: Debug Content-Disposition: inline; filename="Bones 3x13 The Verdict In The Story.avi"
19:31:09 M: 30822400 DEBUG: Curl:: Debug Content-type: application/x-msvideo
19:31:09 M: 30822400 DEBUG: Curl:: Debug Last-Modified: Wed, 21 Feb 2000 08:43:39 GMT
19:31:09 M: 30822400 DEBUG: Curl:: Debug ETag: efd7e9ed0e5e694ba6df444d84dfa37d
19:31:09 M: 30822400 DEBUG: Curl:: Debug Accept-Ranges: bytes
19:31:09 M: 30822400 DEBUG: Curl:: Debug Cache-Control: public, must-revalidate
19:31:09 M: 30822400 DEBUG: Curl:: Debug Cache-Control: no-cache
19:31:09 M: 30822400 DEBUG: Curl:: Debug Pragma: no-cache
19:31:09 M: 30822400 DEBUG: Curl:: Debug features: seekable,stridable
19:31:09 M: 30822400 DEBUG: Curl:: Debug client-id: 12345
19:31:09 M: 30822400 DEBUG: Curl:: Debug Content-Length: 363024692
19:31:09 M: 30822400 DEBUG: Curl:: Debug
19:31:09 M: 30822400 DEBUG: Curl:: Debug Closing connection #0
19:31:09 M: 30822400 DEBUG: FileCurl::Close(D00B4D24) http://127.0.0.1:64652/2873?.avi
19:31:09 M: 30822400 DEBUG: CPlayerCoreFactor::GetPlayers(http://127.0.0.1:64652/2873?.avi)
19:31:09 M: 30822400 DEBUG: file:http://127.0.0.1:64652/2873?.avi IsDVDImage:0 IsDVDIfoFile:0
19:31:09 M: 30822400 INFO: Loading skin file: DialogProgress.xml
19:31:09 M: 30822400 DEBUG: Load DialogProgress.xml: 35.47ms (32.79 ms xml load)
19:31:09 M: 30789632 DEBUG: Alloc resources: 15.43ms (0.00 ms skin load, 0.25 ms preload)
19:31:10 M: 29876224 INFO: mplayer play:http://127.0.0.1:64652/2873?.avi cachesize:8192
19:31:10 M: 23990272 DEBUG: msg: set audio functions called
19:31:10 M: 23990272 DEBUG: msg: done
19:31:10 M: 23990272 DEBUG: FileCurl::Open(00EB2990) http://127.0.0.1:64652/2873?.avi
19:31:10 M: 23887872 DEBUG: Curl:: Debug About to connect() to 127.0.0.1 port 64652 (#0)
19:31:10 M: 23887872 DEBUG: Curl:: Debug Trying 127.0.0.1...
19:31:10 M: 23363584 DEBUG: Curl:: Debug connected
19:31:10 M: 23351296 DEBUG: Curl:: Debug Connected to 127.0.0.1 (127.0.0.1) port 64652 (#0)
19:31:10 M: 23363584 INFO: Thu Jun 05 19:31:10 2008
19:31:10 M: 23363584 DEBUG: Curl:: Debug GET /2873?.avi HTTP/1.1
User-Agent: XBMC/pre-2.1 (compatible; MSIE 6.0; Windows NT 5.1; WinampMPEG/5.09)
Host: 127.0.0.1:64652
Accept: */*
19:31:10 M: 23363584 INFO:
19:31:10 M: 23363584 INFO: Serving GET request...
19:31:10 M: 23363584 INFO:
19:31:10 M: 23363584 WARNING: Untested function dllgethostbyaddr called!
19:31:10 M: 23363584 INFO: 127.0.0.1 - - [05/Jun/2008 19:31:10] "GET /2873?.avi HTTP/1.1" 200 -
19:31:10 M: 23363584 DEBUG: Curl:: Debug HTTP 1.0, assume close after body
19:31:10 M: 23363584 INFO: Thu Jun 05 19:31:10 2008
19:31:10 M: 23363584 DEBUG: Curl:: Debug HTTP/1.0 200 OK
19:31:10 M: 23363584 INFO:
19:31:10 M: 23363584 DEBUG: Curl:: Debug Server: BaseHTTP/0.3 Python/2.4.3
19:31:10 M: 23363584 INFO: Sending headers...
19:31:10 M: 23363584 DEBUG: Curl:: Debug Date: Thu, 05 Jun 2008 17:31:10 GMT
19:31:10 M: 23363584 INFO:
19:31:10 M: 23363584 DEBUG: Curl:: Debug Content-Disposition: inline; filename="Bones 3x13 The Verdict In The Story.avi"
19:31:10 M: 23363584 INFO: Thu Jun 05 19:31:10 2008
19:31:10 M: 23363584 DEBUG: Curl:: Debug Content-type: application/x-msvideo
19:31:10 M: 23363584 INFO:
19:31:10 M: 23363584 DEBUG: Curl:: Debug Last-Modified: Wed, 21 Feb 2000 08:43:39 GMT
19:31:10 M: 23363584 INFO: Starting download at byte
19:31:10 M: 23363584 DEBUG: Curl:: Debug ETag: efd7e9ed0e5e694ba6df444d84dfa37d
19:31:10 M: 23363584 INFO:
19:31:10 M: 23363584 DEBUG: Curl:: Debug Accept-Ranges: bytes
19:31:10 M: 23363584 INFO: 0
19:31:10 M: 23363584 DEBUG: Curl:: Debug Cache-Control: public, must-revalidate
19:31:10 M: 23363584 INFO:
19:31:10 M: 23363584 DEBUG: Curl:: Debug Cache-Control: no-cache
19:31:10 M: 23363584 DEBUG: Curl:: Debug Pragma: no-cache
19:31:10 M: 23363584 DEBUG: Curl:: Debug features: seekable,stridable
19:31:10 M: 23363584 DEBUG: Curl:: Debug client-id: 12345
19:31:10 M: 23363584 DEBUG: Curl:: Debug Content-Length: 363024692
19:31:10 M: 23363584 DEBUG: Curl:: Debug
19:31:11 M: 22941696 DEBUG: FileCurl::Close(00EB2990) http://127.0.0.1:64652/2873?.avi
19:31:11 M: 22962176 DEBUG: Curl:: Debug Expire cleared
19:31:11 M: 22962176 DEBUG: Curl:: Debug Closing connection #0
19:31:11 M: 23166976 INFO: Using -subcp enca:__:CP1252 to detect the subtitle charset
19:31:11 M: 23166976 INFO: Client Closed the connection.
19:31:11 M: 23166976 INFO: Flipping bi-directional subtitles disabled
19:31:11 M: 23166976 INFO:
19:31:11 M: 23961600 DEBUG: msg: mplayer_init()
19:31:11 M: 23961600 DEBUG: msg: MPlayer XBMC-SVN-r10070-4.1.2 (C) 2000-2004 MPlayer Team
19:31:11 M: 23961600 DEBUG: msg: CPU: Intel Celeron 2/Pentium III Coppermine,Geyserville
19:31:11 M: 23953408 DEBUG: msg: (Family: 6, Stepping: 10)
19:31:11 M: 23953408 DEBUG: msg: Detected cache-line size is 32 bytes
19:31:11 M: 23953408 DEBUG: msg: CPUflags: MMX: 1 MMX2: 1 3DNow: 0 3DNow2: 0 SSE: 0 SSE2: 0
19:31:11 M: 23953408 DEBUG: msg: Compiled for x86 CPU with extensions:
19:31:11 M: 23953408 DEBUG: msg: MMX
19:31:11 M: 23953408 DEBUG: msg: MMX2
19:31:11 M: 23953408 DEBUG: msg: SSE
19:31:11 M: 23953408 DEBUG: msg:
19:31:11 M: 23941120 DEBUG: msg:
19:31:11 M: 23949312 DEBUG: msg: Creating config file: Q:\system\players\mplayer\config
19:31:11 M: 23941120 DEBUG: msg:
19:31:11 M: 23953408 DEBUG: msg: get_path('codecs.conf') -> 'Q:\system\players\mplayer\codecs.conf'
19:31:11 M: 23932928 DEBUG: msg: Reading Q:\system\players\mplayer\codecs.conf:
19:31:12 M: 23609344 DEBUG: msg: 108 audio & 225 video codecs
19:31:12 M: 23609344 DEBUG: msg: CommandLine:
19:31:12 M: 23609344 DEBUG: msg: '-dr'
19:31:12 M: 23609344 DEBUG: msg: '-v'
19:31:12 M: 23609344 DEBUG: msg: '-subcp'
19:31:12 M: 23609344 DEBUG: msg: 'enca:__:CP1252'
19:31:12 M: 23609344 DEBUG: msg: '-channels'
19:31:12 M: 23609344 DEBUG: msg: '6'
19:31:12 M: 23609344 DEBUG: msg: '-ac'
19:31:12 M: 23609344 DEBUG: msg: 'hwdts,hwac3,'
19:31:12 M: 23609344 DEBUG: msg: '-noflip-hebrew'
19:31:12 M: 23609344 DEBUG: msg: '-noflip-hebrew-commas'
19:31:12 M: 23609344 DEBUG: msg: '-vf'
19:31:12 M: 23609344 DEBUG: msg: 'noise=1ta:1ta'
19:31:12 M: 23609344 DEBUG: msg: '-fs'
19:31:12 M: 23609344 DEBUG: msg: '1.avi'
19:31:12 M: 23609344 DEBUG: msg:
19:31:12 M: 23609344 DEBUG: msg: get_path('font/font.desc') -> 'Q:\system\players\mplayer\font/font.desc'
19:31:12 M: 23080960 DEBUG: msg: font: can't open file: Q:\system\players\mplayer\font/font.desc
19:31:12 M: 23080960 DEBUG: msg: font: can't open file: Q:\system\players\mplayer/font/font.desc
19:31:12 M: 23609344 DEBUG: msg: Using MMX (with tiny bit MMX2) Optimized OnScreenDisplay
19:31:12 M: 23576576 DEBUG: msg: Using XBOX High Resolution Timers for timing
19:31:12 M: 23576576 DEBUG: msg: get_path('input.conf') -> 'Q:\system\players\mplayer\input.conf'
19:31:12 M: 23576576 DEBUG: msg: Parsing input config file Q:\system\players\mplayer\input.conf
19:31:12 M: 23564288 DEBUG: msg: Input config file Q:\system\players\mplayer\input.conf parsed: 51 binds
19:31:12 M: 23564288 DEBUG: msg: mplayer_open_file(http://127.0.0.1:64652/2873?.avi)
19:31:12 M: 23564288 DEBUG: msg: get_path('2873?.avi.conf') -> 'Q:\system\players\mplayer\2873?.avi.conf'
19:31:12 M: 23564288 DEBUG: msg:
Playing http://127.0.0.1:64652/2873?.avi.
19:31:12 M: 23564288 DEBUG: msg: find subtitles
19:31:12 M: 23564288 DEBUG: msg: auto open Z:\subtitle
19:31:12 M: 23564288 DEBUG: msg: Filename for url is now http://127.0.0.1:64652/2873?.avi
19:31:12 M: 23564288 DEBUG: msg: protocol:http
19:31:12 M: 23564288 DEBUG: msg: open stream protocol:http
19:31:12 M: 23543808 DEBUG: msg: WINSOCK2 init: 0
19:31:12 M: 23543808 DEBUG: msg: Filename for url is now http://127.0.0.1:64652/2873?.avi
19:31:12 M: 23543808 DEBUG: msg: Connecting to server 127.0.0.1[127.0.0.1]:64652 ...
19:31:12 M: 23019520 INFO: Thu Jun 05 19:31:12 2008
19:31:12 M: 23019520 INFO:
19:31:12 M: 23019520 INFO: Serving GET request...
19:31:12 M: 23019520 INFO:
19:31:12 M: 23019520 WARNING: Untested function dllgethostbyaddr called!
19:31:12 M: 23019520 INFO: 127.0.0.1 - - [05/Jun/2008 19:31:12] "GET /2873?.avi HTTP/1.0" 200 -
19:31:12 M: 23019520 INFO: Thu Jun 05 19:31:12 2008
19:31:12 M: 23019520 INFO:
19:31:12 M: 23019520 INFO: Sending headers...
19:31:12 M: 23019520 INFO:
19:31:12 M: 23019520 INFO: Thu Jun 05 19:31:12 2008
19:31:12 M: 23019520 INFO:
19:31:12 M: 23019520 INFO: Starting download at byte
19:31:12 M: 23019520 INFO:
19:31:12 M: 23019520 INFO: 0
19:31:12 M: 23019520 INFO:
19:31:12 M: 23019520 DEBUG: msg: --- HTTP DEBUG HEADER --- START ---
19:31:12 M: 23019520 DEBUG: msg: protocol: [HTTP/1.0]
19:31:12 M: 23019520 DEBUG: msg: http minor version: [0]
19:31:12 M: 23019520 DEBUG: msg: uri: [(null)]
19:31:12 M: 23019520 DEBUG: msg: method: [(null)]
19:31:12 M: 23019520 DEBUG: msg: status code: [200]
19:31:12 M: 23019520 DEBUG: msg: reason phrase: [OK]
19:31:12 M: 23019520 DEBUG: msg: body size: [0]
19:31:12 M: 23019520 DEBUG: msg: Fields:
19:31:12 M: 23019520 DEBUG: msg: 0 - Server: BaseHTTP/0.3 Python/2.4.3
19:31:12 M: 23019520 DEBUG: msg: 1 - Date: Thu, 05 Jun 2008 17:31:12 GMT
19:31:12 M: 23019520 DEBUG: msg: 2 - Content-Disposition: inline; filename="Bones 3x13 The Verdict In The Story.avi"
19:31:12 M: 23019520 DEBUG: msg: 3 - Content-type: application/x-msvideo
19:31:12 M: 23019520 DEBUG: msg: 4 - Last-Modified: Wed, 21 Feb 2000 08:43:39 GMT
19:31:12 M: 23019520 DEBUG: msg: 5 - ETag: efd7e9ed0e5e694ba6df444d84dfa37d
19:31:12 M: 23019520 DEBUG: msg: 6 - Accept-Ranges: bytes
19:31:12 M: 23019520 DEBUG: msg: 7 - Cache-Control: public, must-revalidate
19:31:12 M: 23019520 DEBUG: msg: 8 - Cache-Control: no-cache
19:31:12 M: 23019520 DEBUG: msg: 9 - Pragma: no-cache
19:31:12 M: 23019520 DEBUG: msg: 10 - features: seekable,stridable
19:31:12 M: 23019520 DEBUG: msg: 11 - client-id: 12345
19:31:12 M: 23019520 DEBUG: msg: 12 - Content-Length: 363024692
19:31:12 M: 23019520 DEBUG: msg: --- HTTP DEBUG HEADER --- END ---
19:31:12 M: 23019520 DEBUG: msg: Content-Type: [application/x-msvideo]
19:31:12 M: 23019520 DEBUG: msg: Content-Length: [363024692]
19:31:12 M: 23019520 DEBUG: msg: Cache size set to 8192 KBytes
19:31:12 M: 23019520 DEBUG: msg: Connected to server: 127.0.0.1
19:31:12 M: 14069760 DEBUG: msg: CACHE_PRE_INIT: 0 [0] 0 pre:1677721 eof:0
19:31:12 M: 14069760 DEBUG: msg:
Cache fill: 0.00% (0 bytes)
19:31:12 M: 14069760 DEBUG: msg:
Cache fill: 0.00% (0 bytes)
<Stuff removed, pastebin size limit>
19:31:16 M: 13971456 DEBUG: msg:
Cache fill: 3.13% (262144 bytes)
19:31:17 M: 13918208 DEBUG: msg:
Cache fill: 3.13% (262144 bytes)
19:31:17 M: 13905920 INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http ://127.0.0.1 (easy=00EEA010, multi=00E6AFD0)
19:31:17 M: 13881344 DEBUG: msg:
Cache fill: 3.13% (262144 bytes)
19:31:17 M: 13819904 DEBUG: msg:
Cache fill: 3.13% (262144 bytes)
<Stuff removed, pastebin size limit>
19:31:24 M: 13787136 DEBUG: msg:
Cache fill: 18.75% (1572864 bytes)
19:31:24 M: 13737984 DEBUG: msg:
Cache fill: 18.75% (1572864 bytes)
19:31:25 M: 14086144 DEBUG: msg:
19:31:25 M: 14086144 DEBUG: msg: demux_open(00FDE010,0,-1,-1,-1)
19:31:25 M: 14086144 DEBUG: msg: AVI file format detected.
19:31:25 M: 14086144 DEBUG: msg: list_end=0x146
19:31:25 M: 14086144 DEBUG: msg: ======= AVI Header =======
19:31:25 M: 14086144 DEBUG: msg: us/frame: 41708 (fps=23.976)
19:31:25 M: 14086144 DEBUG: msg: max bytes/sec: 0
19:31:25 M: 14086144 DEBUG: msg: padding: 0
19:31:25 M: 14086144 DEBUG: msg: MainAVIHeader.dwFlags: (905279863) HAS_INDEX MUST_USE_INDEX IS_INTERLEAVED TRUST_CKTYPE WAS_CAPTUREFILE
19:31:25 M: 14086144 DEBUG: msg: frames total: 61085 initial: 0
19:31:25 M: 14086144 DEBUG: msg: streams: 2
19:31:25 M: 14086144 DEBUG: msg: Suggested BufferSize: 0
19:31:25 M: 14086144 DEBUG: msg: Size: 624 x 352
19:31:25 M: 14086144 DEBUG: msg: ==========================
19:31:25 M: 14086144 DEBUG: msg: list_end=0xD4
19:31:25 M: 14086144 DEBUG: msg: ==> Found video stream: 0
19:31:25 M: 14086144 DEBUG: msg: ====== STREAM Header =====
19:31:25 M: 14086144 DEBUG: msg: Type: vids FCC: XVID (44495658)
19:31:25 M: 14086144 DEBUG: msg: Flags: 0
19:31:25 M: 14086144 DEBUG: msg: Priority: 0 Language: 0
19:31:25 M: 14086144 DEBUG: msg: InitialFrames: 0
19:31:25 M: 14086144 DEBUG: msg: Rate: 23976024/1000000 = 23.976
19:31:25 M: 14086144 DEBUG: msg: Start: 0 Len: 61085
19:31:25 M: 14086144 DEBUG: msg: Suggested BufferSize: 140037
19:31:25 M: 14086144 DEBUG: msg: Quality 0
19:31:25 M: 14086144 DEBUG: msg: Sample size: 0
19:31:25 M: 14086144 DEBUG: msg: ==========================
19:31:25 M: 14086144 DEBUG: msg: Found 'bih', 40 bytes of 40
19:31:25 M: 14086144 DEBUG: msg: ======= VIDEO Format ======
19:31:25 M: 14086144 DEBUG: msg: biSize 40
19:31:25 M: 14086144 DEBUG: msg: biWidth 624
19:31:25 M: 14086144 DEBUG: msg: biHeight 352
19:31:25 M: 14073856 DEBUG: msg: biPlanes 1
19:31:25 M: 14073856 DEBUG: msg: biBitCount 24
19:31:25 M: 14073856 DEBUG: msg: biCompression 1145656920='XVID'
19:31:25 M: 14073856 DEBUG: msg: biSizeImage 658944
19:31:25 M: 14073856 DEBUG: msg: ===========================
19:31:25 M: 14073856 DEBUG: msg: Regenerating keyframe table for MPEG-4 video.
19:31:25 M: 14073856 DEBUG: msg: list_end=0x146
19:31:25 M: 14073856 DEBUG: msg: ==> Found audio stream: 1
19:31:25 M: 14073856 DEBUG: msg: ====== STREAM Header =====
19:31:25 M: 14073856 DEBUG: msg: Type: auds FCC: (0)
19:31:25 M: 14073856 DEBUG: msg: Flags: 0
19:31:25 M: 14073856 DEBUG: msg: Priority: 0 Language: 0
19:31:25 M: 14073856 DEBUG: msg: InitialFrames: 0
19:31:25 M: 14073856 DEBUG: msg: Rate: 48000/1152 = 41.667
19:31:25 M: 14073856 DEBUG: msg: Start: 0 Len: 106157
19:31:25 M: 14073856 DEBUG: msg: Suggested BufferSize: 0
19:31:25 M: 14073856 DEBUG: msg: Quality 0
19:31:25 M: 14073856 DEBUG: msg: Sample size: 0
19:31:25 M: 14073856 DEBUG: msg: ==========================
19:31:25 M: 14073856 DEBUG: msg: Found 'wf', 30 bytes of 18
19:31:25 M: 14073856 DEBUG: msg: ======= WAVE Format =======
19:31:25 M: 14073856 DEBUG: msg: Format Tag: 85 (0x55)
19:31:25 M: 14073856 DEBUG: msg: Channels: 2
19:31:25 M: 14073856 DEBUG: msg: Samplerate: 48000
19:31:25 M: 14073856 DEBUG: msg: avg byte/sec: 16000
19:31:25 M: 14073856 DEBUG: msg: Block align: 1152
19:31:25 M: 14073856 DEBUG: msg: bits/sample: 16
19:31:25 M: 14073856 DEBUG: msg: cbSize: 12
19:31:25 M: 14073856 DEBUG: msg: mp3.wID=1
19:31:25 M: 14073856 DEBUG: msg: mp3.fdwFlags=0x2
19:31:25 M: 14073856 DEBUG: msg: mp3.nBlockSize=1152
19:31:25 M: 14073856 DEBUG: msg: mp3.nFramesPerBlock=1
19:31:25 M: 14073856 DEBUG: msg: mp3.nCodecDelay=0
19:31:25 M: 14073856 DEBUG: msg: ===========================
19:31:25 M: 14073856 DEBUG: msg: list_end=0x16A
19:31:25 M: 14073856 DEBUG: msg: hdr=Software size=16
19:31:25 M: 14073856 DEBUG: msg: Software : transcode-1.0.2
19:31:25 M: 14073856 DEBUG: msg: list_end=0x157A7C8C
19:31:25 M: 14073856 DEBUG: msg: Found movie at 0x800 - 0x157A7C8C
19:31:26 M: 13832192 DEBUG: msg: Connecting to server 127.0.0.1[127.0.0.1]:64652 ...
19:31:26 M: 13205504 INFO: Thu Jun 05 19:31:26 2008
19:31:26 M: 13205504 INFO:
19:31:26 M: 13205504 INFO: Serving GET request...
19:31:26 M: 13205504 INFO:
19:31:26 M: 13205504 WARNING: Untested function dllgethostbyaddr called!
19:31:26 M: 13205504 INFO: 127.0.0.1 - - [05/Jun/2008 19:31:26] "GET /2873?.avi HTTP/1.0" 206 -
19:31:26 M: 13205504 INFO: Thu Jun 05 19:31:26 2008
19:31:26 M: 13205504 INFO:
19:31:26 M: 13205504 INFO: Sending headers...
19:31:26 M: 13205504 INFO:
19:31:26 M: 13205504 INFO: Thu Jun 05 19:31:26 2008
19:31:26 M: 13205504 DEBUG: msg: Content-Type: [application/x-msvideo]
19:31:26 M: 13205504 INFO:
19:31:26 M: 13205504 DEBUG: msg: Content-Length: [2691380]
19:31:26 M: 13303808 INFO: Starting download at byte
19:31:26 M: 13303808 INFO: Client Closed the connection.
19:31:26 M: 13303808 INFO:
19:31:26 M: 13570048 INFO:
19:31:26 M: 13570048 INFO: 360333312
19:31:26 M: 13570048 INFO:
19:31:27 M: 14094336 DEBUG: msg: Reading INDEX block, 167242 chunks for 61085 frames (fpos=360348820).
19:31:46 M: 11919360 DEBUG: msg: Connecting to server 127.0.0.1[127.0.0.1]:64652 ...
19:31:46 M: 11390976 INFO: Thu Jun 05 19:31:46 2008
19:31:46 M: 11390976 INFO:
19:31:46 M: 11390976 INFO: Serving GET request...
19:31:46 M: 11390976 INFO:
19:31:46 M: 11390976 WARNING: Untested function dllgethostbyaddr called!
19:31:46 M: 11390976 INFO: 127.0.0.1 - - [05/Jun/2008 19:31:46] "GET /2873?.avi HTTP/1.0" 200 -
19:31:46 M: 11390976 INFO: Thu Jun 05 19:31:46 2008
19:31:46 M: 11390976 INFO:
19:31:46 M: 11390976 INFO: Sending headers...
19:31:46 M: 11390976 INFO:
19:31:46 M: 11390976 DEBUG: msg: Content-Type: [application/x-msvideo]
19:31:46 M: 11390976 INFO: Thu Jun 05 19:31:46 2008
19:31:46 M: 11390976 INFO:
19:31:46 M: 11390976 DEBUG: msg: Content-Length: [363024692]
19:31:46 M: 11390976 INFO: Starting download at byte
19:31:46 M: 11390976 INFO:
19:31:46 M: 11390976 INFO: 0
19:31:46 M: 11390976 INFO:
19:31:47 M: 11218944 DEBUG: SECTION:UnloadDelayed(DLL: Q:\system\libcurl.dll)
19:31:47 M: 11870208 DEBUG: msg: AVI index offset: 0x0 (movi=0x800 idx0=0x800 idx1=0x119E)
19:31:47 M: 11870208 DEBUG: msg: Auto-selected AVI video ID = 0
19:31:47 M: 11870208 DEBUG: msg: Auto-selected AVI audio ID = 1
19:31:47 M: 11870208 DEBUG: msg: AVI: Searching for audio stream (id:1)
19:31:47 M: 11870208 DEBUG: msg: XXX initial v_pts=0.000 a_pos=0 (0.000)
19:31:47 M: 11870208 DEBUG: msg: AVI video size=316759146 (61085) audio size=42209016 (106157)
19:31:47 M: 11870208 DEBUG: msg: [V] filefmt:3 fourcc:0x44495658 size:624x352 fps:23.98 ftime:=0.0417
19:31:47 M: 11870208 DEBUG: msg: Clip info:
19:31:47 M: 11870208 DEBUG: msg: Software: transcode-1.0.2
19:31:47 M: 11870208 DEBUG: msg: get_path('sub/') -> 'Q:\system\players\mplayer\sub/'
19:31:47 M: 11870208 DEBUG: msg: Starting lookup for subs
19:31:47 M: 11870208 DEBUG: msg: Global Subsize: 0 - VOBSUB: -1, DEMUX: -1, SUBS: -1
19:31:47 M: 11870208 DEBUG: msg: Global Subpos : -1
19:31:47 M: 11870208 DEBUG: msg: ==========================================================================
19:31:47 M: 11870208 DEBUG: msg: Forced audio codec: hwdts
19:31:47 M: 11870208 DEBUG: msg: Forced audio codec: hwac3
19:31:48 M: 11870208 DEBUG: msg: Opening audio decoder: [mp3lib] MPEG layer-2, layer-3
19:31:48 M: 11870208 DEBUG: msg: dec_audio: Allocating 4608 + 65536 = 70144 bytes for output buffer.
19:31:48 M: 11796480 DEBUG: msg: mp3lib: made decode tables with MMX optimization
19:31:48 M: 11796480 DEBUG: msg: mp3lib: using MMX optimized decore!
19:31:48 M: 11796480 DEBUG: msg: MP3lib: init layer2&3 finished, tables done
19:31:48 M: 11788288 DEBUG: msg:
MPEG 1.0, Layer III, 48000 Hz 128 kbit Joint-Stereo, BPF: 384
19:31:48 M: 11788288 DEBUG: msg: Channels: 2, copyright: No, original: Yes, CRC: No, emphasis: 0
19:31:48 M: 11788288 DEBUG: msg: AUDIO: 48000 Hz, 2 ch, 16 bit (0x10), ratio: 16000->192000 (128.0 kbit)
19:31:48 M: 11788288 DEBUG: msg: Selected audio codec: [mp3] afm:mp3lib (mp3lib MPEG layer-2, layer-3)
19:31:48 M: 11788288 DEBUG: msg: ==========================================================================
19:31:48 M: 11788288 DEBUG: CXBoxRenderManager::PreInit - Selected RGB-Renderer V2
19:31:48 M: 11788288 DEBUG: Deleted 444P video textures
19:31:48 M: 11776000 DEBUG: msg: Opening video filter: [noise=1ta:1ta]
19:31:48 M: 11685888 DEBUG: msg: [vo] query(Planar YV12) -> 3
19:31:48 M: 11685888 DEBUG: msg: ==========================================================================
19:31:48 M: 11685888 DEBUG: msg: Opening video decoder: [ffmpeg] FFmpeg's libavcodec codec family
19:31:48 M: 11198464 DEBUG: msg: INFO: libavcodec init OK!
19:31:48 M: 11198464 DEBUG: msg: Selected video codec: [ffodivx] vfm:ffmpeg (FFmpeg MPEG-4)
19:31:48 M: 11198464 DEBUG: msg: ==========================================================================
19:31:48 M: 11198464 DEBUG: msg: Checking audio filter chain for 48000Hz/2ch/16bit -> 48000Hz/6ch/16bit...
19:31:48 M: 11198464 DEBUG: msg: [libaf] Adding filter dummy
19:31:48 M: 11198464 DEBUG: msg: [dummy] Was reinitialized, rate=48000Hz, nch = 2, format = 0x00000001 and bps = 2
19:31:48 M: 11198464 DEBUG: msg: AF_pre: af format: 2 bps, 2 ch, 48000 hz, little endian signed int
19:31:48 M: 11198464 DEBUG: msg: AF_pre: 48000Hz 2ch Signed 16-bit (Little-Endian)
19:31:48 M: 11137024 DEBUG: Pause stream
19:31:48 M: 11132928 DEBUG: msg: AO: [win32] 48000Hz 2ch Signed 16-bit (Little-Endian) (2 bps)
19:31:48 M: 11132928 DEBUG: msg: AO: Description: Windows waveOut audio output
AO: Author: SaschaSommer <saschasommer@freenet.de>
19:31:48 M: 11132928 DEBUG: msg: Building audio filter chain for 48000Hz/2ch/16bit -> 48000Hz/2ch/16bit...
19:31:48 M: 11132928 DEBUG: msg: [dummy] Was reinitialized, rate=48000Hz, nch = 2, format = 0x00000001 and bps = 2
19:31:48 M: 11132928 DEBUG: msg: [dummy] Was reinitialized, rate=48000Hz, nch = 2, format = 0x00000001 and bps = 2
19:31:48 M: 11063296 DEBUG: msg: Starting playback...
19:31:48 M: 11063296 DEBUG: msg: mplayer_open_file(http://127.0.0.1:64652/2873?.avi) done 1.0000
19:31:48 M: 10960896 INFO: Loading skin file: VideoOverlay.xml
19:31:48 M: 10960896 DEBUG: Playback has started
19:31:48 M: 11485184 DEBUG: Load VideoOverlay.xml: 16.90ms (13.21 ms xml load)
19:31:48 M: 11427840 DEBUG: Alloc resources: 24.82ms (24.82 ms skin load, 0.00 ms preload)
19:31:48 M: 11042816 DEBUG: CGUIInfoManager::SetCurrentMovie(http://127.0.0.1:64652/2873?.avi)
19:31:48 M: 11042816 DEBUG: msg: [ffmpeg] aspect_ratio: 1.772727
19:31:48 M: 11030528 DEBUG: msg: VDec: vo config request - 624 x 352 (preferred colorspace: Planar YV12)
19:31:48 M: 11030528 DEBUG: msg: Trying filter chain:
19:31:48 M: 11018240 DEBUG: msg: noise
19:31:48 M: 11010048 DEBUG: msg: vo
19:31:48 M: 11010048 DEBUG: msg:
19:31:48 M: 11010048 DEBUG: msg: VDec: using Planar YV12 as output csp (no 0)
19:31:48 M: 10997760 DEBUG: msg: Movie-Aspect is 1.77:1 - prescaling to correct movie aspect.
19:31:48 M: 10997760 DEBUG: msg: VO Config (624x352->624x352,flags=1,'MPlayer',0x32315659)
19:31:48 M: 10985472 DEBUG: msg: REQ: flags=0x437 req=0x0
19:31:48 M: 10973184 DEBUG: msg: VO: [directx] 624x352 => 624x352 Planar YV12 [fs]
19:31:48 M: 10973184 DEBUG: msg: VO: Description: XBOX Direct3D8 YUY2 renderer
19:31:48 M: 10973184 DEBUG: msg: VO: Author: Frodo/JCMarshall
19:31:48 M: 10973184 DEBUG: mplayer::video_config(624, 352, 624, 352, 1, 842094169)
19:31:48 M: 10973184 NOTICE: Display resolution USER : 720p 16:9 (1)
19:31:48 M: 10420224 DEBUG: Activating window ID: 12005
19:31:48 M: 10420224 DEBUG: Checking if window ID 12005 is locked.
19:31:48 M: 11902976 DEBUG: Setting resolution 1
19:31:48 M: 13737984 DEBUG: We set resolution 1
19:31:48 M: 13381632 DEBUG: Created YV12 texture 0
19:31:48 M: 12500992 INFO: Created 444P full texture
19:31:48 M: 12500992 INFO: Loading skin file: VideoFullScreen.xml
19:31:48 M: 12484608 DEBUG: Load VideoFullScreen.xml: 30.59ms (12.82 ms xml load)
19:31:48 M: 12451840 DEBUG: Alloc resources: 43.31ms (32.25 ms skin load, 0.27 ms preload)
19:31:48 M: 12451840 INFO: Loading skin file: VideoOSD.xml
19:31:48 M: 12447744 DEBUG: Load VideoOSD.xml: 21.98ms (12.78 ms xml load)
19:31:48 M: 11649024 DEBUG: Alloc resources: 33.26ms (0.00 ms skin load, 1.02 ms preload)
19:31:48 M: 11649024 INFO: Loading skin file: VideoOSDSettings.xml
19:31:48 M: 11636736 DEBUG: Load VideoOSDSettings.xml: 22.80ms (18.29 ms xml load)
19:31:48 M: 10944512 DEBUG: Alloc resources: 35.93ms (0.00 ms skin load, 0.52 ms preload)
19:31:48 M: 10944512 INFO: Loading skin file: VideoOSDSettings.xml
19:31:48 M: 10932224 DEBUG: Load VideoOSDSettings.xml: 12.45ms (7.77 ms xml load)
19:31:48 M: 10940416 DEBUG: Alloc resources: 0.43ms (0.00 ms skin load, 0.15 ms preload)
19:31:48 M: 10895360 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\media\Fonts\arial.ttf (32.763889): width = 127, height = 45, lineheight = 38
19:31:48 M: 10518528 DEBUG: msg: *** [noise] Allocating mp_image_t, 624x352x12bpp YUV planar, 329472 bytes
19:31:48 M: 10461184 DEBUG: Alloc resources: 0.69ms (0.00 ms skin load, 0.39 ms preload)
19:32:19 M: 10276864 DEBUG: msg: *** [noise] Allocating mp_image_t, 624x352x12bpp YUV planar, 329472 bytes
19:32:19 M: 10244096 DEBUG: msg: FFRW:normal play
19:32:19 M: 9920512 DEBUG: msg: *** [vo] Allocating mp_image_t, 624x352x12bpp YUV planar, 329472 bytes
19:32:19 M: 9920512 DEBUG: msg: *** [noise] Direct Rendering mp_image_t, 624x352x12bpp YUV planar, 329472 bytes
19:32:19 M: 9310208 INFO: Starting async renderer thread
19:36:11 M: 9203712 DEBUG: Alloc resources: 0.45ms (0.00 ms skin load, 0.17 ms preload)
19:36:45 M: 9027584 DEBUG: msg: FFRW:normal play
19:49:10 M: 9318400 INFO: Thu Jun 05 19:49:10 2008
19:49:10 M: 9318400 INFO:
19:49:10 M: 9318400 INFO: Could not read from URL...reopening...
19:49:10 M: 9318400 INFO:
20:14:46 M: 9437184 DEBUG: Alloc resources: 21.66ms (0.00 ms skin load, 0.17 ms preload)
20:15:23 M: 9314304 DEBUG: msg: FFRW:normal play
20:16:01 M: 10039296 DEBUG: msg: ds_fill_buffer: EOF reached (stream: audio)
20:16:01 M: 10051584 DEBUG: msg: ds_fill_buffer: EOF reached (stream: video)
20:16:01 M: 10055680 DEBUG: msg: mplayer_close_file()
20:16:01 M: 10055680 DEBUG: msg:
20:16:01 M: 10055680 DEBUG: msg: uninit_player
20:16:01 M: 18997248 DEBUG: msg: WINSOCK2 uninit
20:16:01 M: 19013632 DEBUG: msg: Uninit audio filters...
20:16:01 M: 19013632 DEBUG: msg: [libaf] Removing filter dummy
20:16:01 M: 19013632 DEBUG: msg: Uninit audio: mp3lib
20:16:01 M: 19144704 DEBUG: msg: Uninit video: ffmpeg
20:16:01 M: 24870912 DEBUG: Deleted 444P video textures
20:16:01 M: 25755648 DEBUG: Deleted YV12 texture 0
20:16:01 M: 26091520 DEBUG: msg: uninit_player - done
20:16:01 M: 26091520 DEBUG: Freeing FS segment @ 0x807080
20:16:01 M: 26091520 DEBUG: Playback has finished
20:16:01 M: 26607616 DEBUG: CVideoDatabase::GetMovieInfo (http://127.0.0.1:64652/2873?.avi), query = select idMovie from movie where idFile=3247
20:16:01 M: 26607616 DEBUG: CVideoDatabase::GetEpisodeInfo (http://127.0.0.1:64652/2873?.avi), query = select idEpisode from episode where idFile=3247
20:16:01 M: 26607616 DEBUG: CVideoDatabase::GetMusicVideoInfo (http://127.0.0.1:64652/2873?.avi), query = select idMVideo from musicvideo where idFile=3247
20:16:02 M: 26615808 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
20:16:02 M: 28221440 DEBUG: Setting resolution 1
20:16:02 M: 26337280 DEBUG: We set resolution 1
20:16:02 M: 26435584 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
20:16:02 M: 26427392 INFO: Loading skin file: MyVideo.xml
20:16:02 M: 26181632 DEBUG: Load MyVideo.xml: 152.57ms (40.75 ms xml load)
20:16:02 M: 26046464 DEBUG: Alloc resources: 236.21ms (185.82 ms skin load, 0.82 ms preload)
20:16:02 M: 26066944 DEBUG: CGUIMediaWindow::GetDirectory (plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fvideo%2F2873&mode=4&name=Bones+3x13+The+Verdict+In+The+Story)
20:16:02 M: 26066944 DEBUG: ParentPath = [plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fvideo%2F2873&mode=4&name=Bones+3x13+The+Verdict+In+The+Story]
20:16:02 M: 26066944 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - URL for plugin settings: Ninja Video/
20:16:02 M: 26066944 ERROR: Unable to load: Q:\plugins\video\Ninja Video\resources\settings.xml, Line 0
Failed to open file
20:16:02 M: 26066944 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\German\strings.xml: Failed to open file at line 0
20:16:02 M: 26066944 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\english\strings.xml: Failed to open file at line 0
20:16:02 M: 26066944 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - calling plugin Q:\plugins\video\Ninja Video\default.py('plugin://video/Ninja Video/','1','?url=http%3A%2F%2Fwww.ninjavideo.net%2Fvideo%2F2873&mode=4&name=Bones+3x13+The+Verdict+In+The+Story')
20:16:02 M: 25542656 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult - waiting on the Ninja Video plugin...
20:16:02 M: 25542656 INFO: Mode: 4
20:16:02 M: 25542656 INFO:
20:16:02 M: 25542656 INFO: URL: http://www.ninjavideo.net/video/2873
20:16:02 M: 25542656 INFO:
20:16:02 M: 25542656 INFO: Name: Bones 3x13 The Verdict In The Story
20:16:02 M: 25542656 INFO:
20:16:02 M: 25542656 INFO: index of videolinks : http://www.ninjavideo.net/video/2873
20:16:02 M: 25542656 INFO:
20:16:03 M: 25542656 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult- plugin returned successfully
20:16:03 M: 25542656 INFO: Scriptresult: Succes
20:16:03 M: 25518080 INFO: Python script stopped
20:16:03 M: 25542656 DEBUG: Q:\system\players\mplayer\mplayer.dll (base 010A0000): Detected memory leaks: 289 leaks
20:16:03 M: 25976832 DEBUG: leak caller address 10a10cc, size 128, counter 1
20:16:03 M: 26501120 DEBUG: leak caller address 10ae000, size 4, counter 1
20:16:03 M: 26501120 DEBUG: leak caller address 10ae1d5, size 40, counter 1
20:16:03 M: 26501120 DEBUG: leak caller address 10ae2a9, size 72, counter 2
20:16:03 M: 26501120 DEBUG: leak caller address 10ae49b, size 8, counter 1
20:16:03 M: 26501120 DEBUG: leak caller address 10ae4b3, size 0, counter 1
20:16:03 M: 26501120 DEBUG: leak caller address 10bd2d7, size 28, counter 2
20:16:03 M: 26501120 DEBUG: leak caller address 10bd300, size 0, counter 5
20:16:03 M: 26501120 DEBUG: leak caller address 10bd3a7, size 16, counter 1
20:16:03 M: 26501120 DEBUG: leak caller address 10bd3cc, size 0, counter 1
20:16:03 M: 26501120 DEBUG: leak caller address 10bd469, size 0, counter 5
20:16:03 M: 26501120 DEBUG: leak caller address 10c3106, size 0, counter 1
20:16:03 M: 26501120 DEBUG: leak caller address 10c312b, size 0, counter 1
20:16:03 M: 26501120 DEBUG: leak caller address 10c3151, size 0, counter 1
20:16:03 M: 26501120 DEBUG: leak caller address 113afb0, size 44, counter 1
20:16:03 M: 26501120 DEBUG: leak caller address 1159026, size 28, counter 1
20:16:03 M: 26501120 DEBUG: leak caller address 1159096, size 0, counter 1
20:16:03 M: 26501120 DEBUG: leak caller address 11590f1, size 5, counter 1
20:16:03 M: 26501120 DEBUG: leak caller address 11592cf, size 10, counter 1
20:16:03 M: 26501120 DEBUG: leak caller address 1159325, size 0, counter 1
20:16:03 M: 26501120 DEBUG: leak caller address 115cf29, size 1633, counter 50
20:16:03 M: 26501120 DEBUG: leak caller address 11c8dd4, size 869, counter 1
20:16:03 M: 26501120 DEBUG: leak caller address 11c8ef0, size 31232, counter 10
20:16:03 M: 26501120 DEBUG: leak caller address 13c24ad, size 496650, counter 198
20:16:03 M: 26501120 DEBUG: mplayer.dll: Total bytes leaked: 530767
20:16:23 M: 31072256 DEBUG: CApplication::OnKey: 216 pressed, action is 9
20:16:23 M: 31199232 DEBUG: CGUIMediaWindow::GetDirectory (plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fcat%2F294&mode=2&name=Bones)
20:16:23 M: 31199232 DEBUG: ParentPath = [plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Ftvshows&mode=1&name=3.+TV+SHOWS]
20:16:23 M: 31199232 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - URL for plugin settings: Ninja Video/
20:16:23 M: 31199232 ERROR: Unable to load: Q:\plugins\video\Ninja Video\resources\settings.xml, Line 0
Failed to open file
20:16:23 M: 31199232 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\German\strings.xml: Failed to open file at line 0
20:16:23 M: 31199232 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\english\strings.xml: Failed to open file at line 0
20:16:23 M: 31199232 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - calling plugin Q:\plugins\video\Ninja Video\default.py('plugin://video/Ninja Video/','1','?url=http%3A%2F%2Fwww.ninjavideo.net%2Fcat%2F294&mode=2&name=Bones')
20:16:23 M: 30674944 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult - waiting on the Ninja Video plugin...
20:16:23 M: 30683136 INFO: Mode: 2
20:16:23 M: 30683136 INFO:
20:16:23 M: 30683136 INFO: URL: http://www.ninjavideo.net/cat/294
20:16:23 M: 30683136 INFO:
20:16:23 M: 30683136 INFO: Name: Bones
20:16:23 M: 30683136 INFO:
20:16:23 M: 30683136 INFO: index of seasons : http://www.ninjavideo.net/cat/294
20:16:23 M: 30683136 INFO:
20:16:23 M: 30683136 INFO: Scriptresult: Succes
20:16:23 M: 30683136 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult- plugin returned successfully
20:16:23 M: 30683136 INFO: Python script stopped
20:16:24 M: 31080448 DEBUG: CApplication::OnKey: 167 pressed, action is 4
20:16:27 M: 31080448 DEBUG: CApplication::OnKey: 11 pressed, action is 7
20:16:27 M: 31080448 DEBUG: Clearing cached fileitems [plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fvideo%2F3823&mode=4&name=Bones+3x14+The+Wannabe+in+the+Weeds+]
20:16:27 M: 31207424 DEBUG: CGUIMediaWindow::GetDirectory (plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fvideo%2F3823&mode=4&name=Bones+3x14+The+Wannabe+in+the+Weeds+)
20:16:27 M: 31207424 DEBUG: ParentPath = [plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fcat%2F294&mode=2&name=Bones]
20:16:27 M: 31207424 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - URL for plugin settings: Ninja Video/
20:16:27 M: 31207424 ERROR: Unable to load: Q:\plugins\video\Ninja Video\resources\settings.xml, Line 0
Failed to open file
20:16:27 M: 31207424 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\German\strings.xml: Failed to open file at line 0
20:16:27 M: 31207424 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\english\strings.xml: Failed to open file at line 0
20:16:27 M: 31207424 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - calling plugin Q:\plugins\video\Ninja Video\default.py('plugin://video/Ninja Video/','1','?url=http%3A%2F%2Fwww.ninjavideo.net%2Fvideo%2F3823&mode=4&name=Bones+3x14+The+Wannabe+in+the+Weeds+')
20:16:27 M: 30683136 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult - waiting on the Ninja Video plugin...
20:16:27 M: 30683136 INFO: Mode: 4
20:16:27 M: 30683136 INFO:
20:16:27 M: 30683136 INFO: URL: http://www.ninjavideo.net/video/3823
20:16:27 M: 30683136 INFO:
20:16:27 M: 30683136 INFO: Name: Bones 3x14 The Wannabe in the Weeds
20:16:27 M: 30683136 INFO:
20:16:27 M: 30683136 INFO: index of videolinks : http://www.ninjavideo.net/video/3823
20:16:27 M: 30683136 INFO:
20:16:27 M: 30683136 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult- plugin returned successfully
20:16:27 M: 30683136 INFO: Scriptresult: Succes
20:16:27 M: 30662656 INFO: Python script stopped
20:16:29 M: 31080448 DEBUG: CApplication::OnKey: 167 pressed, action is 4
20:16:30 M: 31080448 DEBUG: CApplication::OnKey: 11 pressed, action is 7
20:16:30 M: 31080448 DEBUG: Initializing FS_SEG..
20:16:30 M: 31080448 DEBUG: FS segment @ 0xe5e000
20:16:30 M: 30597120 DEBUG: Unable to resolve kernel32.dll PeekNamedPipe
20:16:30 M: 30597120 DEBUG: Dll MSVCP71.dll was not found in path
20:16:30 M: 30597120 DEBUG: Unable to load referenced dll MSVCP71.dll - Dll: Q:\system\libcurl.dll
20:16:30 M: 30597120 DEBUG: Unable to resolve MSVCP71.dll ?_Nomemory@std@@YAXXZ
20:16:30 M: 30597120 DEBUG: kernel32.dll fake function DisableThreadLibraryCalls called
20:16:30 M: 30560256 INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://127.0.0.1
20:16:30 M: 30560256 DEBUG: Curl:: Debug About to connect() to 127.0.0.1 port 64652 (#0)
20:16:30 M: 30560256 DEBUG: Curl:: Debug Trying 127.0.0.1...
20:16:30 M: 30035968 DEBUG: Curl:: Debug connected
20:16:30 M: 30023680 DEBUG: Curl:: Debug Connected to 127.0.0.1 (127.0.0.1) port 64652 (#0)
20:16:30 M: 30023680 DEBUG: Curl:: Debug HEAD /3823?.avi HTTP/1.1
User-Agent: XBMC/pre-2.1 (compatible; MSIE 6.0; Windows NT 5.1; WinampMPEG/5.09)
Host: 127.0.0.1:64652
Accept: */*
20:16:30 M: 30035968 INFO: Thu Jun 05 20:16:30 2008
20:16:30 M: 30035968 INFO:
20:16:30 M: 30035968 INFO: Serving HEAD request...
20:16:30 M: 30035968 INFO:
20:16:30 M: 30035968 INFO: Thu Jun 05 20:16:30 2008
20:16:30 M: 30035968 INFO:
20:16:30 M: 30035968 INFO: Getting infos from NinjaVideo.net for Video ID
20:16:30 M: 30035968 INFO:
20:16:30 M: 30035968 INFO: 3823
20:16:30 M: 30035968 INFO:
20:16:30 M: 30035968 INFO: ...
20:16:30 M: 30035968 INFO:
20:16:31 M: 30044160 WARNING: Untested function dllgethostbyaddr called!
20:16:31 M: 30044160 INFO: 127.0.0.1 - - [05/Jun/2008 20:16:31] "HEAD /3823?.avi HTTP/1.1" 200 -
20:16:31 M: 30044160 DEBUG: Curl:: Debug HTTP 1.0, assume close after body
20:16:31 M: 30044160 INFO: Thu Jun 05 20:16:31 2008
20:16:31 M: 30044160 DEBUG: Curl:: Debug HTTP/1.0 200 OK
20:16:31 M: 30044160 INFO:
20:16:31 M: 30044160 DEBUG: Curl:: Debug Server: BaseHTTP/0.3 Python/2.4.3
20:16:31 M: 30044160 INFO: Sending headers...
20:16:31 M: 30044160 DEBUG: Curl:: Debug Date: Thu, 05 Jun 2008 18:16:31 GMT
20:16:31 M: 30044160 INFO:
20:16:31 M: 30044160 DEBUG: Curl:: Debug Content-Disposition: inline; filename="Bones 3x14 The Wannabe in the Weeds .avi"
20:16:31 M: 30568448 DEBUG: Curl:: Debug Content-type: application/x-msvideo
20:16:31 M: 30568448 DEBUG: Curl:: Debug Last-Modified: Wed, 21 Feb 2000 08:43:39 GMT
20:16:31 M: 30568448 DEBUG: Curl:: Debug ETag: bca382c81484983f2d437f97d1e141f3
20:16:31 M: 30568448 DEBUG: Curl:: Debug Accept-Ranges: bytes
20:16:31 M: 30568448 DEBUG: Curl:: Debug Cache-Control: public, must-revalidate
20:16:31 M: 30568448 DEBUG: Curl:: Debug Cache-Control: no-cache
20:16:31 M: 30568448 DEBUG: Curl:: Debug Pragma: no-cache
20:16:31 M: 30568448 DEBUG: Curl:: Debug features: seekable,stridable
20:16:31 M: 30568448 DEBUG: Curl:: Debug client-id: 12345
20:16:31 M: 30568448 DEBUG: Curl:: Debug Content-Length: 367852568
20:16:31 M: 30568448 DEBUG: Curl:: Debug
20:16:31 M: 30568448 DEBUG: Curl:: Debug Closing connection #0
20:16:31 M: 30568448 DEBUG: FileCurl::Close(D00B4D24) http://127.0.0.1:64652/3823?.avi
20:16:31 M: 30568448 DEBUG: CPlayerCoreFactor::GetPlayers(http://127.0.0.1:64652/3823?.avi)
20:16:31 M: 30568448 ERROR: XFILE::CFile::Delete - Error deleting file Z:\xbmc.edl
20:16:31 M: 30568448 DEBUG: file:http://127.0.0.1:64652/3823?.avi IsDVDImage:0 IsDVDIfoFile:0
20:16:31 M: 30568448 INFO: Loading skin file: DialogProgress.xml
20:16:31 M: 30568448 DEBUG: Load DialogProgress.xml: 38.35ms (35.68 ms xml load)
20:16:31 M: 30515200 DEBUG: Alloc resources: 15.46ms (0.00 ms skin load, 0.34 ms preload)
20:16:31 M: 29601792 INFO: mplayer play:http://127.0.0.1:64652/3823?.avi cachesize:8192
20:16:32 M: 23711744 DEBUG: msg: set audio functions called
20:16:32 M: 23711744 DEBUG: msg: done
20:16:32 M: 23711744 DEBUG: FileCurl::Open(00E90CC0) http://127.0.0.1:64652/3823?.avi
20:16:32 M: 23609344 DEBUG: Curl:: Debug About to connect() to 127.0.0.1 port 64652 (#0)
20:16:32 M: 23609344 DEBUG: Curl:: Debug Trying 127.0.0.1...
20:16:32 M: 23085056 DEBUG: Curl:: Debug connected
20:16:32 M: 23076864 DEBUG: Curl:: Debug Connected to 127.0.0.1 (127.0.0.1) port 64652 (#0)
20:16:32 M: 23080960 INFO: Thu Jun 05 20:16:32 2008
20:16:32 M: 23080960 DEBUG: Curl:: Debug GET /3823?.avi HTTP/1.1
User-Agent: XBMC/pre-2.1 (compatible; MSIE 6.0; Windows NT 5.1; WinampMPEG/5.09)
Host: 127.0.0.1:64652
Accept: */*
20:16:32 M: 23080960 INFO:
20:16:32 M: 23080960 INFO: Serving GET request...
20:16:32 M: 23080960 INFO:
20:16:32 M: 23080960 WARNING: Untested function dllgethostbyaddr called!
20:16:32 M: 23080960 INFO: 127.0.0.1 - - [05/Jun/2008 20:16:32] "GET /3823?.avi HTTP/1.1" 200 -
20:16:32 M: 23080960 DEBUG: Curl:: Debug HTTP 1.0, assume close after body
20:16:32 M: 23080960 INFO: Thu Jun 05 20:16:32 2008
20:16:32 M: 23080960 DEBUG: Curl:: Debug HTTP/1.0 200 OK
20:16:32 M: 23080960 INFO:
20:16:32 M: 23080960 DEBUG: Curl:: Debug Server: BaseHTTP/0.3 Python/2.4.3
20:16:32 M: 23080960 INFO: Sending headers...
20:16:32 M: 23080960 DEBUG: Curl:: Debug Date: Thu, 05 Jun 2008 18:16:32 GMT
20:16:32 M: 23080960 INFO:
20:16:32 M: 23080960 DEBUG: Curl:: Debug Content-Disposition: inline; filename="Bones 3x14 The Wannabe in the Weeds .avi"
20:16:32 M: 23080960 INFO: Thu Jun 05 20:16:32 2008
20:16:32 M: 23080960 DEBUG: Curl:: Debug Content-type: application/x-msvideo
20:16:32 M: 23080960 INFO:
20:16:32 M: 23080960 DEBUG: Curl:: Debug Last-Modified: Wed, 21 Feb 2000 08:43:39 GMT
20:16:32 M: 23080960 INFO: Starting download at byte
20:16:32 M: 23080960 DEBUG: Curl:: Debug ETag: bca382c81484983f2d437f97d1e141f3
20:16:32 M: 23080960 INFO:
20:16:32 M: 23080960 DEBUG: Curl:: Debug Accept-Ranges: bytes
20:16:32 M: 23080960 INFO: 0
20:16:32 M: 23080960 DEBUG: Curl:: Debug Cache-Control: public, must-revalidate
20:16:32 M: 23080960 INFO:
20:16:32 M: 23080960 DEBUG: Curl:: Debug Cache-Control: no-cache
20:16:32 M: 23080960 DEBUG: Curl:: Debug Pragma: no-cache
20:16:32 M: 23080960 DEBUG: Curl:: Debug features: seekable,stridable
20:16:32 M: 23080960 DEBUG: Curl:: Debug client-id: 12345
20:16:32 M: 23080960 DEBUG: Curl:: Debug Content-Length: 367852568
20:16:32 M: 23080960 DEBUG: Curl:: Debug
20:16:33 M: 22708224 DEBUG: FileCurl::Close(00E90CC0) http://127.0.0.1:64652/3823?.avi
20:16:33 M: 22708224 DEBUG: Curl:: Debug Expire cleared
20:16:33 M: 22708224 DEBUG: Curl:: Debug Closing connection #0
20:16:33 M: 22917120 INFO: Using -subcp enca:__:CP1252 to detect the subtitle charset
20:16:33 M: 22917120 INFO: Client Closed the connection.
20:16:33 M: 22917120 INFO: Flipping bi-directional subtitles disabled
20:16:33 M: 22917120 INFO:
20:16:33 M: 23711744 DEBUG: msg: mplayer_init()
20:16:33 M: 23711744 DEBUG: msg: MPlayer XBMC-SVN-r10070-4.1.2 (C) 2000-2004 MPlayer Team
20:16:33 M: 23711744 DEBUG: msg: CPU: Intel Celeron 2/Pentium III Coppermine,Geyserville
20:16:33 M: 23711744 DEBUG: msg: (Family: 6, Stepping: 10)
20:16:33 M: 23711744 DEBUG: msg: Detected cache-line size is 32 bytes
20:16:33 M: 23711744 DEBUG: msg: CPUflags: MMX: 1 MMX2: 1 3DNow: 0 3DNow2: 0 SSE: 0 SSE2: 0
20:16:33 M: 23711744 DEBUG: msg: Compiled for x86 CPU with extensions:
20:16:33 M: 23711744 DEBUG: msg: MMX
20:16:33 M: 23711744 DEBUG: msg: MMX2
20:16:33 M: 23711744 DEBUG: msg: SSE
20:16:33 M: 23711744 DEBUG: msg:
20:16:33 M: 23699456 DEBUG: msg:
20:16:33 M: 23711744 DEBUG: msg: Creating config file: Q:\system\players\mplayer\config
20:16:33 M: 23699456 DEBUG: msg:
20:16:33 M: 23711744 DEBUG: msg: get_path('codecs.conf') -> 'Q:\system\players\mplayer\codecs.conf'
20:16:33 M: 23711744 DEBUG: msg: Reading Q:\system\players\mplayer\codecs.conf:
20:16:33 M: 23375872 DEBUG: msg: 108 audio & 225 video codecs
20:16:33 M: 23375872 DEBUG: msg: CommandLine:
20:16:33 M: 23375872 DEBUG: msg: '-dr'
20:16:33 M: 23375872 DEBUG: msg: '-v'
20:16:33 M: 23375872 DEBUG: msg: '-subcp'
20:16:33 M: 23375872 DEBUG: msg: 'enca:__:CP1252'
20:16:33 M: 23375872 DEBUG: msg: '-channels'
20:16:33 M: 23375872 DEBUG: msg: '6'
20:16:33 M: 23375872 DEBUG: msg: '-ac'
20:16:33 M: 23375872 DEBUG: msg: 'hwdts,hwac3,'
20:16:33 M: 23375872 DEBUG: msg: '-noflip-hebrew'
20:16:33 M: 23375872 DEBUG: msg: '-noflip-hebrew-commas'
20:16:33 M: 23375872 DEBUG: msg: '-vf'
20:16:33 M: 23375872 DEBUG: msg: 'noise=1ta:1ta'
20:16:33 M: 23375872 DEBUG: msg: '-fs'
20:16:33 M: 23375872 DEBUG: msg: '1.avi'
20:16:33 M: 23375872 DEBUG: msg:
20:16:33 M: 23375872 DEBUG: msg: get_path('font/font.desc') -> 'Q:\system\players\mplayer\font/font.desc'
20:16:33 M: 22847488 DEBUG: msg: font: can't open file: Q:\system\players\mplayer\font/font.desc
20:16:33 M: 22847488 DEBUG: msg: font: can't open file: Q:\system\players\mplayer/font/font.desc
20:16:33 M: 23375872 DEBUG: msg: Using MMX (with tiny bit MMX2) Optimized OnScreenDisplay
20:16:33 M: 23367680 DEBUG: msg: Using XBOX High Resolution Timers for timing
20:16:33 M: 23367680 DEBUG: msg: get_path('input.conf') -> 'Q:\system\players\mplayer\input.conf'
20:16:33 M: 23367680 DEBUG: msg: Parsing input config file Q:\system\players\mplayer\input.conf
20:16:33 M: 23363584 DEBUG: msg: Input config file Q:\system\players\mplayer\input.conf parsed: 51 binds
20:16:33 M: 23363584 DEBUG: msg: mplayer_open_file(http://127.0.0.1:64652/3823?.avi)
20:16:33 M: 23363584 DEBUG: msg: get_path('3823?.avi.conf') -> 'Q:\system\players\mplayer\3823?.avi.conf'
20:16:33 M: 23363584 DEBUG: msg:
Playing http://127.0.0.1:64652/3823?.avi.
20:16:33 M: 23363584 DEBUG: msg: find subtitles
20:16:33 M: 23363584 DEBUG: msg: auto open Z:\subtitle
20:16:33 M: 23363584 DEBUG: msg: Filename for url is now http://127.0.0.1:64652/3823?.avi
20:16:33 M: 23363584 DEBUG: msg: protocol:http
20:16:33 M: 23363584 DEBUG: msg: open stream protocol:http
20:16:33 M: 23343104 DEBUG: msg: WINSOCK2 init: 0
20:16:33 M: 23343104 DEBUG: msg: Filename for url is now http://127.0.0.1:64652/3823?.avi
20:16:33 M: 23343104 DEBUG: msg: Connecting to server 127.0.0.1[127.0.0.1]:64652 ...
20:16:33 M: 22822912 INFO: Thu Jun 05 20:16:33 2008
20:16:33 M: 22822912 INFO:
20:16:33 M: 22822912 INFO: Serving GET request...
20:16:33 M: 22822912 INFO:
20:16:33 M: 22822912 WARNING: Untested function dllgethostbyaddr called!
20:16:33 M: 22822912 INFO: 127.0.0.1 - - [05/Jun/2008 20:16:33] "GET /3823?.avi HTTP/1.0" 200 -
20:16:33 M: 22822912 INFO: Thu Jun 05 20:16:33 2008
20:16:33 M: 22822912 INFO:
20:16:33 M: 22822912 INFO: Sending headers...
20:16:34 M: 22822912 INFO:
20:16:34 M: 22822912 INFO: Thu Jun 05 20:16:34 2008
20:16:34 M: 22822912 INFO:
20:16:34 M: 22822912 DEBUG: msg: --- HTTP DEBUG HEADER --- START ---
20:16:34 M: 22822912 INFO: Starting download at byte
20:16:34 M: 22822912 DEBUG: msg: protocol: [HTTP/1.0]
20:16:34 M: 22822912 INFO:
20:16:34 M: 22822912 DEBUG: msg: http minor version: [0]
20:16:34 M: 22822912 INFO: 0
20:16:34 M: 22822912 DEBUG: msg: uri: [(null)]
20:16:34 M: 22822912 INFO:
20:16:34 M: 22822912 DEBUG: msg: method: [(null)]
20:16:34 M: 22822912 DEBUG: msg: status code: [200]
20:16:34 M: 22822912 DEBUG: msg: reason phrase: [OK]
20:16:34 M: 22822912 DEBUG: msg: body size: [0]
20:16:34 M: 22822912 DEBUG: msg: Fields:
20:16:34 M: 22822912 DEBUG: msg: 0 - Server: BaseHTTP/0.3 Python/2.4.3
20:16:34 M: 22822912 DEBUG: msg: 1 - Date: Thu, 05 Jun 2008 18:16:33 GMT
20:16:34 M: 22822912 DEBUG: msg: 2 - Content-Disposition: inline; filename="Bones 3x14 The Wannabe in the Weeds .avi"
20:16:34 M: 22822912 DEBUG: msg: 3 - Content-type: application/x-msvideo
20:16:34 M: 22822912 DEBUG: msg: 4 - Last-Modified: Wed, 21 Feb 2000 08:43:39 GMT
20:16:34 M: 22822912 DEBUG: msg: 5 - ETag: bca382c81484983f2d437f97d1e141f3
20:16:34 M: 22822912 DEBUG: msg: 6 - Accept-Ranges: bytes
20:16:34 M: 22822912 DEBUG: msg: 7 - Cache-Control: public, must-revalidate
20:16:34 M: 22822912 DEBUG: msg: 8 - Cache-Control: no-cache
20:16:34 M: 22822912 DEBUG: msg: 9 - Pragma: no-cache
20:16:34 M: 22822912 DEBUG: msg: 10 - features: seekable,stridable
20:16:34 M: 22822912 DEBUG: msg: 11 - client-id: 12345
20:16:34 M: 22822912 DEBUG: msg: 12 - Content-Length: 367852568
20:16:34 M: 22822912 DEBUG: msg: --- HTTP DEBUG HEADER --- END ---
20:16:34 M: 22822912 DEBUG: msg: Content-Type: [application/x-msvideo]
20:16:34 M: 22822912 DEBUG: msg: Content-Length: [367852568]
20:16:34 M: 22822912 DEBUG: msg: Cache size set to 8192 KBytes
20:16:34 M: 22822912 DEBUG: msg: Connected to server: 127.0.0.1
20:16:34 M: 13877248 DEBUG: msg: CACHE_PRE_INIT: 0 [0] 0 pre:1677721 eof:0
20:16:34 M: 13877248 DEBUG: msg:
Cache fill: 0.00% (0 bytes)
20:16:34 M: 13852672 DEBUG: msg:
Cache fill: 0.00% (0 bytes)
<Stuff removed, pastebin size limit>
20:16:38 M: 13668352 DEBUG: msg:
Cache fill: 6.25% (524288 bytes)
20:16:38 M: 13611008 DEBUG: msg:
Cache fill: 6.25% (524288 bytes)
20:16:38 M: 13545472 INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http ://127.0.0.1 (easy=00FF2010, multi=00A23C10)
20:16:38 M: 13565952 DEBUG: msg:
Cache fill: 6.25% (524288 bytes)
20:16:39 M: 13504512 DEBUG: msg:
Cache fill: 6.25% (524288 bytes)
<Stuff removed, pastebin size limit>
20:16:46 M: 13619200 DEBUG: msg:
Cache fill: 18.75% (1572864 bytes)
20:16:46 M: 13545472 DEBUG: msg:
Cache fill: 18.75% (1572864 bytes)
20:16:47 M: 13897728 DEBUG: msg:
20:16:47 M: 13897728 DEBUG: msg: demux_open(00FFA590,0,-1,-1,-1)
20:16:47 M: 13897728 DEBUG: msg: AVI file format detected.
20:16:47 M: 13897728 DEBUG: msg: list_end=0x146
20:16:47 M: 13897728 DEBUG: msg: ======= AVI Header =======
20:16:47 M: 13897728 DEBUG: msg: us/frame: 41708 (fps=23.976)
20:16:47 M: 13897728 DEBUG: msg: max bytes/sec: 0
20:16:47 M: 13897728 DEBUG: msg: padding: 0
20:16:47 M: 13897728 DEBUG: msg: MainAVIHeader.dwFlags: (272) HAS_INDEX IS_INTERLEAVED
20:16:47 M: 13897728 DEBUG: msg: frames total: 60983 initial: 0
20:16:47 M: 13897728 DEBUG: msg: streams: 2
20:16:47 M: 13897728 DEBUG: msg: Suggested BufferSize: 0
20:16:47 M: 13897728 DEBUG: msg: Size: 624 x 352
20:16:47 M: 13897728 DEBUG: msg: ==========================
20:16:47 M: 13897728 DEBUG: msg: list_end=0xD4
20:16:47 M: 13897728 DEBUG: msg: ==> Found video stream: 0
20:16:47 M: 13897728 DEBUG: msg: ====== STREAM Header =====
20:16:47 M: 13897728 DEBUG: msg: Type: vids FCC: XVID (44495658)
20:16:47 M: 13897728 DEBUG: msg: Flags: 0
20:16:47 M: 13897728 DEBUG: msg: Priority: 0 Language: 0
20:16:47 M: 13897728 DEBUG: msg: InitialFrames: 0
20:16:47 M: 13897728 DEBUG: msg: Rate: 23976024/1000000 = 23.976
20:16:47 M: 13897728 DEBUG: msg: Start: 0 Len: 60983
20:16:47 M: 13897728 DEBUG: msg: Suggested BufferSize: 65885
20:16:47 M: 13897728 DEBUG: msg: Quality 0
20:16:47 M: 13897728 DEBUG: msg: Sample size: 0
20:16:47 M: 13897728 DEBUG: msg: ==========================
20:16:47 M: 13897728 DEBUG: msg: Found 'bih', 40 bytes of 40
20:16:47 M: 13897728 DEBUG: msg: ======= VIDEO Format ======
20:16:47 M: 13897728 DEBUG: msg: biSize 40
20:16:47 M: 13897728 DEBUG: msg: biWidth 624
20:16:47 M: 13897728 DEBUG: msg: biHeight 352
20:16:47 M: 13897728 DEBUG: msg: biPlanes 1
20:16:47 M: 13897728 DEBUG: msg: biBitCount 24
20:16:47 M: 13897728 DEBUG: msg: biCompression 1145656920='XVID'
20:16:47 M: 13897728 DEBUG: msg: biSizeImage 658944
20:16:47 M: 13897728 DEBUG: msg: ===========================
20:16:47 M: 13897728 DEBUG: msg: Regenerating keyframe table for MPEG-4 video.
20:16:47 M: 13897728 DEBUG: msg: list_end=0x146
20:16:47 M: 13897728 DEBUG: msg: ==> Found audio stream: 1
20:16:47 M: 13897728 DEBUG: msg: ====== STREAM Header =====
20:16:47 M: 13897728 DEBUG: msg: Type: auds FCC: (0)
20:16:47 M: 13897728 DEBUG: msg: Flags: 0
20:16:47 M: 13897728 DEBUG: msg: Priority: 0 Language: 0
20:16:47 M: 13897728 DEBUG: msg: InitialFrames: 0
20:16:47 M: 13897728 DEBUG: msg: Rate: 48000/1152 = 41.667
20:16:47 M: 13897728 DEBUG: msg: Start: 0 Len: 105980
20:16:47 M: 13897728 DEBUG: msg: Suggested BufferSize: 0
20:16:47 M: 13897728 DEBUG: msg: Quality 0
20:16:47 M: 13897728 DEBUG: msg: Sample size: 0
20:16:47 M: 13897728 DEBUG: msg: ==========================
20:16:47 M: 13897728 DEBUG: msg: Found 'wf', 30 bytes of 18
20:16:47 M: 13897728 DEBUG: msg: ======= WAVE Format =======
20:16:47 M: 13897728 DEBUG: msg: Format Tag: 85 (0x55)
20:16:47 M: 13897728 DEBUG: msg: Channels: 2
20:16:47 M: 13897728 DEBUG: msg: Samplerate: 48000
20:16:47 M: 13897728 DEBUG: msg: avg byte/sec: 16000
20:16:47 M: 13897728 DEBUG: msg: Block align: 1152
20:16:47 M: 13897728 DEBUG: msg: bits/sample: 16
20:16:47 M: 13897728 DEBUG: msg: cbSize: 12
20:16:47 M: 13897728 DEBUG: msg: mp3.wID=1
20:16:47 M: 13897728 DEBUG: msg: mp3.fdwFlags=0x2
20:16:47 M: 13897728 DEBUG: msg: mp3.nBlockSize=1152
20:16:47 M: 13897728 DEBUG: msg: mp3.nFramesPerBlock=1
20:16:47 M: 13897728 DEBUG: msg: mp3.nCodecDelay=0
20:16:47 M: 13897728 DEBUG: msg: ===========================
20:16:47 M: 13897728 DEBUG: msg: list_end=0x16A
20:16:47 M: 13897728 DEBUG: msg: hdr=Software size=16
20:16:47 M: 13897728 DEBUG: msg: Software : transcode-1.0.2
20:16:47 M: 13897728 DEBUG: msg: list_end=0x15C438E0
20:16:47 M: 13897728 DEBUG: msg: Found movie at 0x800 - 0x15C438E0
20:16:49 M: 13619200 DEBUG: msg: Connecting to server 127.0.0.1[127.0.0.1]:64652 ...
20:16:49 M: 13004800 INFO: Thu Jun 05 20:16:49 2008
20:16:49 M: 13004800 INFO:
20:16:49 M: 13004800 INFO: Serving GET request...
20:16:49 M: 13004800 INFO:
20:16:49 M: 13004800 WARNING: Untested function dllgethostbyaddr called!
20:16:49 M: 13004800 INFO: 127.0.0.1 - - [05/Jun/2008 20:16:49] "GET /3823?.avi HTTP/1.0" 206 -
20:16:49 M: 13004800 INFO: Thu Jun 05 20:16:49 2008
20:16:49 M: 13004800 INFO:
20:16:49 M: 13004800 INFO: Sending headers...
20:16:49 M: 13004800 INFO:
20:16:49 M: 13004800 DEBUG: msg: Content-Type: [application/x-msvideo]
20:16:49 M: 13004800 INFO: Thu Jun 05 20:16:49 2008
20:16:49 M: 13004800 DEBUG: msg: Content-Length: [2685976]
20:16:49 M: 13107200 INFO:
20:16:49 M: 13107200 INFO: Starting download at byte
20:16:49 M: 13107200 INFO:
20:16:49 M: 13107200 INFO: 365166592
20:16:49 M: 13107200 INFO:
20:16:49 M: 13107200 INFO: Client Closed the connection.
20:16:49 M: 13107200 INFO:
20:16:51 M: 13897728 DEBUG: msg: Reading INDEX block, 166963 chunks for 60983 frames (fpos=365181160).
20:17:06 M: 11747328 DEBUG: msg: Connecting to server 127.0.0.1[127.0.0.1]:64652 ...
20:17:06 M: 11223040 INFO: Thu Jun 05 20:17:06 2008
20:17:06 M: 11223040 INFO:
20:17:06 M: 11223040 INFO: Serving GET request...
20:17:06 M: 11223040 INFO:
20:17:06 M: 11223040 WARNING: Untested function dllgethostbyaddr called!
20:17:06 M: 11223040 INFO: 127.0.0.1 - - [05/Jun/2008 20:17:06] "GET /3823?.avi HTTP/1.0" 200 -
20:17:06 M: 11223040 INFO: Thu Jun 05 20:17:06 2008
20:17:06 M: 11223040 INFO:
20:17:06 M: 11223040 INFO: Sending headers...
20:17:06 M: 11223040 INFO:
20:17:06 M: 11223040 DEBUG: msg: Content-Type: [application/x-msvideo]
20:17:06 M: 11223040 INFO: Thu Jun 05 20:17:06 2008
20:17:06 M: 11223040 DEBUG: msg: Content-Length: [367852568]
20:17:06 M: 11223040 INFO:
20:17:06 M: 11223040 INFO: Starting download at byte
20:17:06 M: 11223040 INFO:
20:17:06 M: 11223040 INFO: 0
20:17:06 M: 11223040 INFO:
20:17:07 M: 11223040 DEBUG: msg: AVI index offset: 0x0 (movi=0x800 idx0=0x800 idx1=0x1174)
20:17:07 M: 11223040 DEBUG: msg: Auto-selected AVI video ID = 0
20:17:07 M: 11223040 DEBUG: msg: Auto-selected AVI audio ID = 1
20:17:07 M: 11223040 DEBUG: msg: AVI: Searching for audio stream (id:1)
20:17:07 M: 11223040 DEBUG: msg: XXX initial v_pts=0.000 a_pos=0 (0.000)
20:17:07 M: 11223040 DEBUG: msg: AVI video size=321156747 (60983) audio size=42656040 (105980)
20:17:07 M: 11223040 DEBUG: msg: [V] filefmt:3 fourcc:0x44495658 size:624x352 fps:23.98 ftime:=0.0417
20:17:07 M: 11223040 DEBUG: msg: Clip info:
20:17:07 M: 11223040 DEBUG: msg: Software: transcode-1.0.2
20:17:07 M: 11223040 DEBUG: msg: get_path('sub/') -> 'Q:\system\players\mplayer\sub/'
20:17:07 M: 11223040 DEBUG: msg: Starting lookup for subs
20:17:07 M: 11223040 DEBUG: msg: Global Subsize: 0 - VOBSUB: -1, DEMUX: -1, SUBS: -1
20:17:07 M: 11223040 DEBUG: msg: Global Subpos : -1
20:17:07 M: 11223040 DEBUG: msg: ==========================================================================
20:17:07 M: 11223040 DEBUG: msg: Forced audio codec: hwdts
20:17:07 M: 11223040 DEBUG: msg: Forced audio codec: hwac3
20:17:07 M: 11223040 DEBUG: msg: Opening audio decoder: [mp3lib] MPEG layer-2, layer-3
20:17:07 M: 11223040 DEBUG: msg: dec_audio: Allocating 4608 + 65536 = 70144 bytes for output buffer.
20:17:07 M: 11149312 DEBUG: msg: mp3lib: made decode tables with MMX optimization
20:17:07 M: 11149312 DEBUG: msg: mp3lib: using MMX optimized decore!
20:17:07 M: 11149312 DEBUG: msg: MP3lib: init layer2&3 finished, tables done
20:17:07 M: 11149312 DEBUG: msg:
MPEG 1.0, Layer III, 48000 Hz 32 kbit Joint-Stereo, BPF: 96
20:17:07 M: 11149312 DEBUG: msg: Channels: 2, copyright: No, original: Yes, CRC: No, emphasis: 0
20:17:07 M: 11149312 DEBUG: msg: AUDIO: 48000 Hz, 2 ch, 16 bit (0x10), ratio: 4000->192000 (32.0 kbit)
20:17:07 M: 11149312 DEBUG: msg: Selected audio codec: [mp3] afm:mp3lib (mp3lib MPEG layer-2, layer-3)
20:17:07 M: 11149312 DEBUG: msg: ==========================================================================
20:17:07 M: 11149312 DEBUG: CXBoxRenderManager::PreInit - Selected RGB-Renderer V2
20:17:07 M: 11149312 DEBUG: Deleted 444P video textures
20:17:07 M: 11149312 DEBUG: msg: Opening video filter: [noise=1ta:1ta]
20:17:07 M: 11071488 DEBUG: msg: [vo] query(Planar YV12) -> 3
20:17:07 M: 11071488 DEBUG: msg: ==========================================================================
20:17:07 M: 11071488 DEBUG: msg: Opening video decoder: [ffmpeg] FFmpeg's libavcodec codec family
20:17:07 M: 10735616 DEBUG: msg: INFO: libavcodec init OK!
20:17:07 M: 10735616 DEBUG: msg: Selected video codec: [ffodivx] vfm:ffmpeg (FFmpeg MPEG-4)
20:17:07 M: 10735616 DEBUG: msg: ==========================================================================
20:17:07 M: 10735616 DEBUG: msg: Checking audio filter chain for 48000Hz/2ch/16bit -> 48000Hz/6ch/16bit...
20:17:07 M: 10735616 DEBUG: msg: [libaf] Adding filter dummy
20:17:07 M: 10723328 DEBUG: msg: [dummy] Was reinitialized, rate=48000Hz, nch = 2, format = 0x00000001 and bps = 2
20:17:07 M: 10723328 DEBUG: msg: AF_pre: af format: 2 bps, 2 ch, 48000 hz, little endian signed int
20:17:07 M: 10723328 DEBUG: msg: AF_pre: 48000Hz 2ch Signed 16-bit (Little-Endian)
20:17:07 M: 10674176 DEBUG: Pause stream
20:17:07 M: 10674176 DEBUG: msg: AO: [win32] 48000Hz 2ch Signed 16-bit (Little-Endian) (2 bps)
20:17:07 M: 10674176 DEBUG: msg: AO: Description: Windows waveOut audio output
AO: Author: SaschaSommer <saschasommer@freenet.de>
20:17:07 M: 10674176 DEBUG: msg: Building audio filter chain for 48000Hz/2ch/16bit -> 48000Hz/2ch/16bit...
20:17:07 M: 10674176 DEBUG: msg: [dummy] Was reinitialized, rate=48000Hz, nch = 2, format = 0x00000001 and bps = 2
20:17:07 M: 10674176 DEBUG: msg: [dummy] Was reinitialized, rate=48000Hz, nch = 2, format = 0x00000001 and bps = 2
20:17:07 M: 10604544 DEBUG: msg: Starting playback...
20:17:07 M: 10604544 DEBUG: msg: mplayer_open_file(http://127.0.0.1:64652/3823?.avi) done 1.0000
20:17:07 M: 10522624 INFO: Loading skin file: DialogProgress.xml
20:17:07 M: 10522624 DEBUG: Playback has started
20:17:07 M: 10162176 DEBUG: Load DialogProgress.xml: 45.83ms (43.12 ms xml load)
20:17:07 M: 10108928 DEBUG: Alloc resources: 15.28ms (0.00 ms skin load, 0.33 ms preload)
20:17:07 M: 10108928 DEBUG: CGUIInfoManager::SetCurrentMovie(http://127.0.0.1:64652/3823?.avi)
20:17:07 M: 10108928 INFO: Loading skin file: VideoOverlay.xml
20:17:08 M: 10113024 DEBUG: Load VideoOverlay.xml: 35.21ms (32.29 ms xml load)
20:17:08 M: 10113024 DEBUG: Alloc resources: 36.30ms (36.30 ms skin load, 0.00 ms preload)
20:17:08 M: 10158080 DEBUG: msg: [ffmpeg] aspect_ratio: 1.772727
20:17:08 M: 10145792 DEBUG: msg: VDec: vo config request - 624 x 352 (preferred colorspace: Planar YV12)
20:17:08 M: 10145792 DEBUG: msg: Trying filter chain:
20:17:08 M: 10145792 DEBUG: msg: noise
20:17:08 M: 10133504 DEBUG: msg: vo
20:17:08 M: 10133504 DEBUG: msg:
20:17:08 M: 10121216 DEBUG: msg: VDec: using Planar YV12 as output csp (no 0)
20:17:08 M: 10121216 DEBUG: msg: Movie-Aspect is 1.77:1 - prescaling to correct movie aspect.
20:17:08 M: 10121216 DEBUG: msg: VO Config (624x352->624x352,flags=1,'MPlayer',0x32315659)
20:17:08 M: 10104832 DEBUG: msg: REQ: flags=0x437 req=0x0
20:17:08 M: 10104832 DEBUG: msg: VO: [directx] 624x352 => 624x352 Planar YV12 [fs]
20:17:08 M: 10092544 DEBUG: msg: VO: Description: XBOX Direct3D8 YUY2 renderer
20:17:08 M: 10080256 DEBUG: msg: VO: Author: Frodo/JCMarshall
20:17:08 M: 10088448 DEBUG: mplayer::video_config(624, 352, 624, 352, 1, 842094169)
20:17:08 M: 10076160 NOTICE: Display resolution USER : 720p 16:9 (1)
20:17:08 M: 9928704 DEBUG: Activating window ID: 12005
20:17:08 M: 9928704 DEBUG: Checking if window ID 12005 is locked.
20:17:08 M: 11489280 DEBUG: Setting resolution 1
20:17:08 M: 13361152 DEBUG: We set resolution 1
20:17:08 M: 13000704 DEBUG: Created YV12 texture 0
20:17:08 M: 12120064 INFO: Created 444P full texture
20:17:08 M: 12120064 INFO: Loading skin file: VideoFullScreen.xml
20:17:08 M: 12107776 DEBUG: Load VideoFullScreen.xml: 21.55ms (4.34 ms xml load)
20:17:08 M: 12029952 DEBUG: Alloc resources: 35.12ms (23.35 ms skin load, 0.36 ms preload)
20:17:08 M: 12029952 INFO: Loading skin file: VideoOSD.xml
20:17:08 M: 12013568 DEBUG: Load VideoOSD.xml: 15.62ms (7.43 ms xml load)
20:17:08 M: 11198464 DEBUG: Alloc resources: 46.70ms (0.01 ms skin load, 1.11 ms preload)
20:17:08 M: 11198464 INFO: Loading skin file: VideoOSDSettings.xml
20:17:08 M: 11198464 DEBUG: Load VideoOSDSettings.xml: 10.40ms (6.06 ms xml load)
20:17:08 M: 10498048 DEBUG: Alloc resources: 33.58ms (0.00 ms skin load, 0.59 ms preload)
20:17:08 M: 10502144 INFO: Loading skin file: VideoOSDSettings.xml
20:17:08 M: 10489856 DEBUG: Load VideoOSDSettings.xml: 7.03ms (2.45 ms xml load)
20:17:08 M: 10489856 DEBUG: Alloc resources: 0.42ms (0.00 ms skin load, 0.15 ms preload)
20:17:08 M: 10457088 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\media\Fonts\arial.ttf (32.763889): width = 127, height = 45, lineheight = 38
20:17:08 M: 10072064 DEBUG: msg: *** [noise] Allocating mp_image_t, 624x352x12bpp YUV planar, 329472 bytes
20:17:08 M: 9682944 DEBUG: msg: *** [vo] Allocating mp_image_t, 624x352x12bpp YUV planar, 329472 bytes
20:17:08 M: 9158656 INFO: Starting async renderer thread
20:17:08 M: 9142272 DEBUG: Alloc resources: 0.54ms (0.00 ms skin load, 0.18 ms preload)
20:17:09 M: 9035776 DEBUG: SECTION:UnloadDelayed(DLL: Q:\system\libcurl.dll)
20:17:42 M: 9871360 DEBUG: msg: FFRW:normal play
20:17:42 M: 9576448 DEBUG: msg: *** [noise] Allocating mp_image_t, 624x352x12bpp YUV planar, 329472 bytes
20:23:11 M: 9510912 DEBUG: Alloc resources: 17.51ms (0.00 ms skin load, 0.17 ms preload)
20:23:54 M: 9371648 DEBUG: msg: FFRW:normal play
20:34:55 M: 9752576 DEBUG: Alloc resources: 23.44ms (0.00 ms skin load, 0.18 ms preload)
20:35:36 M: 9617408 DEBUG: msg: FFRW:normal play
20:36:10 M: 9797632 DEBUG: Alloc resources: 13.93ms (0.00 ms skin load, 0.18 ms preload)
20:36:56 M: 9654272 DEBUG: msg: FFRW:normal play
20:44:05 M: 9793536 DEBUG: Alloc resources: 19.24ms (0.00 ms skin load, 0.18 ms preload)
20:44:46 M: 9666560 DEBUG: msg: FFRW:normal play
20:50:23 M: 9805824 DEBUG: Alloc resources: 22.59ms (0.00 ms skin load, 0.22 ms preload)
20:51:16 M: 9695232 DEBUG: msg: FFRW:normal play
20:56:45 M: 9781248 DEBUG: Alloc resources: 11.41ms (0.00 ms skin load, 0.18 ms preload)
20:57:38 M: 9629696 DEBUG: msg: FFRW:normal play
20:57:56 M: 9748480 DEBUG: Alloc resources: 7.25ms (0.00 ms skin load, 0.18 ms preload)
20:58:51 M: 9572352 DEBUG: msg: FFRW:normal play
21:01:31 M: 9789440 DEBUG: Alloc resources: 9.28ms (0.00 ms skin load, 0.18 ms preload)
21:02:25 M: 9682944 DEBUG: msg: FFRW:normal play
21:04:42 M: 9678848 DEBUG: CApplication::OnKey: 216 pressed, action is 76
21:04:42 M: 9637888 DEBUG: msg: SEEK: idx=158553 (a:158553 v:158555) v.skip=0 a.skip=0/0.000
21:04:42 M: 9613312 DEBUG: Stop stream
21:04:43 M: 9445376 DEBUG: Alloc resources: 5.02ms (0.00 ms skin load, 0.19 ms preload)
21:05:55 M: 9818112 DEBUG: Alloc resources: 10.22ms (0.00 ms skin load, 0.17 ms preload)
21:06:46 M: 9695232 DEBUG: msg: FFRW:normal play
21:07:41 M: 10362880 DEBUG: msg: ds_fill_buffer: EOF reached (stream: audio)
21:07:41 M: 10362880 DEBUG: msg: ds_fill_buffer: EOF reached (stream: video)
21:07:41 M: 10362880 DEBUG: msg: mplayer_close_file()
21:07:41 M: 10362880 DEBUG: msg:
21:07:41 M: 10362880 DEBUG: msg: uninit_player
21:07:41 M: 19300352 DEBUG: msg: WINSOCK2 uninit
21:07:41 M: 19312640 DEBUG: msg: Uninit audio filters...
21:07:41 M: 19312640 DEBUG: msg: [libaf] Removing filter dummy
21:07:41 M: 19312640 DEBUG: msg: Uninit audio: mp3lib
21:07:41 M: 19451904 DEBUG: msg: Uninit video: ffmpeg
21:07:41 M: 25088000 DEBUG: Deleted 444P video textures
21:07:41 M: 25972736 DEBUG: Deleted YV12 texture 0
21:07:41 M: 26210304 DEBUG: msg: uninit_player - done
21:07:41 M: 26210304 DEBUG: Freeing FS segment @ 0xe5e000
21:07:41 M: 26218496 DEBUG: Playback has finished
21:07:41 M: 26730496 DEBUG: CVideoDatabase::GetMovieInfo (http://127.0.0.1:64652/3823?.avi), query = select idMovie from movie where idFile=3248
21:07:41 M: 26730496 DEBUG: CVideoDatabase::GetEpisodeInfo (http://127.0.0.1:64652/3823?.avi), query = select idEpisode from episode where idFile=3248
21:07:41 M: 26730496 DEBUG: CVideoDatabase::GetMusicVideoInfo (http://127.0.0.1:64652/3823?.avi), query = select idMVideo from musicvideo where idFile=3248
21:07:42 M: 26742784 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:07:42 M: 28364800 DEBUG: Setting resolution 1
21:07:42 M: 26480640 DEBUG: We set resolution 1
21:07:42 M: 26599424 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
21:07:42 M: 26587136 INFO: Loading skin file: MyVideo.xml
21:07:42 M: 26390528 DEBUG: Load MyVideo.xml: 186.01ms (40.78 ms xml load)
21:07:42 M: 26300416 DEBUG: Alloc resources: 269.55ms (210.70 ms skin load, 0.83 ms preload)
21:07:42 M: 26300416 DEBUG: CGUIMediaWindow::GetDirectory (plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fvideo%2F3823&mode=4&name=Bones+3x14+The+Wannabe+in+the+Weeds+)
21:07:42 M: 26300416 DEBUG: ParentPath = [plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fvideo%2F3823&mode=4&name=Bones+3x14+The+Wannabe+in+the+Weeds+]
21:07:42 M: 26292224 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - URL for plugin settings: Ninja Video/
21:07:42 M: 26292224 ERROR: Unable to load: Q:\plugins\video\Ninja Video\resources\settings.xml, Line 0
Failed to open file
21:07:42 M: 26292224 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\German\strings.xml: Failed to open file at line 0
21:07:42 M: 26292224 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\english\strings.xml: Failed to open file at line 0
21:07:42 M: 26292224 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - calling plugin Q:\plugins\video\Ninja Video\default.py('plugin://video/Ninja Video/','1','?url=http%3A%2F%2Fwww.ninjavideo.net%2Fvideo%2F3823&mode=4&name=Bones+3x14+The+Wannabe+in+the+Weeds+')
21:07:42 M: 25767936 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult - waiting on the Ninja Video plugin...
21:07:42 M: 25767936 INFO: Mode: 4
21:07:42 M: 25767936 INFO:
21:07:42 M: 25767936 INFO: URL: http://www.ninjavideo.net/video/3823
21:07:42 M: 25767936 INFO:
21:07:42 M: 25767936 INFO: Name: Bones 3x14 The Wannabe in the Weeds
21:07:42 M: 25767936 INFO:
21:07:42 M: 25767936 INFO: index of videolinks : http://www.ninjavideo.net/video/3823
21:07:42 M: 25767936 INFO:
21:07:43 M: 25772032 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult- plugin returned successfully
21:07:43 M: 25776128 INFO: Scriptresult: Succes
21:07:43 M: 25755648 INFO: Python script stopped
21:07:43 M: 25776128 DEBUG: Q:\system\players\mplayer\mplayer.dll (base 01EC0000): Detected memory leaks: 289 leaks
21:07:43 M: 26185728 DEBUG: leak caller address 1ec10cc, size 128, counter 1
21:07:43 M: 26710016 DEBUG: leak caller address 1ece000, size 4, counter 1
21:07:43 M: 26710016 DEBUG: leak caller address 1ece1d5, size 40, counter 1
21:07:43 M: 26710016 DEBUG: leak caller address 1ece2a9, size 72, counter 2
21:07:43 M: 26710016 DEBUG: leak caller address 1ece49b, size 8, counter 1
21:07:43 M: 26710016 DEBUG: leak caller address 1ece4b3, size 0, counter 1
21:07:43 M: 26710016 DEBUG: leak caller address 1edd2d7, size 28, counter 2
21:07:43 M: 26710016 DEBUG: leak caller address 1edd300, size 0, counter 5
21:07:43 M: 26710016 DEBUG: leak caller address 1edd3a7, size 16, counter 1
21:07:43 M: 26710016 DEBUG: leak caller address 1edd3cc, size 0, counter 1
21:07:43 M: 26710016 DEBUG: leak caller address 1edd469, size 0, counter 5
21:07:43 M: 26710016 DEBUG: leak caller address 1ee3106, size 0, counter 1
21:07:43 M: 26710016 DEBUG: leak caller address 1ee312b, size 0, counter 1
21:07:43 M: 26710016 DEBUG: leak caller address 1ee3151, size 0, counter 1
21:07:43 M: 26710016 DEBUG: leak caller address 1f5afb0, size 44, counter 1
21:07:43 M: 26710016 DEBUG: leak caller address 1f79026, size 28, counter 1
21:07:43 M: 26710016 DEBUG: leak caller address 1f79096, size 0, counter 1
21:07:43 M: 26710016 DEBUG: leak caller address 1f790f1, size 5, counter 1
21:07:43 M: 26710016 DEBUG: leak caller address 1f792cf, size 10, counter 1
21:07:43 M: 26710016 DEBUG: leak caller address 1f79325, size 0, counter 1
21:07:43 M: 26710016 DEBUG: leak caller address 1f7cf29, size 1636, counter 50
21:07:43 M: 26710016 DEBUG: leak caller address 1fe8dd4, size 869, counter 1
21:07:43 M: 26710016 DEBUG: leak caller address 1fe8ef0, size 31232, counter 10
21:07:43 M: 26710016 DEBUG: leak caller address 21e24ad, size 496650, counter 198
21:07:43 M: 26710016 DEBUG: mplayer.dll: Total bytes leaked: 530770
21:07:45 M: 31309824 DEBUG: CApplication::OnKey: 216 pressed, action is 9
21:07:45 M: 31436800 DEBUG: CGUIMediaWindow::GetDirectory (plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fcat%2F294&mode=2&name=Bones)
21:07:45 M: 31436800 DEBUG: ParentPath = [plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Ftvshows&mode=1&name=3.+TV+SHOWS]
21:07:45 M: 31436800 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - URL for plugin settings: Ninja Video/
21:07:45 M: 31436800 ERROR: Unable to load: Q:\plugins\video\Ninja Video\resources\settings.xml, Line 0
Failed to open file
21:07:45 M: 31436800 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\German\strings.xml: Failed to open file at line 0
21:07:45 M: 31436800 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\english\strings.xml: Failed to open file at line 0
21:07:45 M: 31436800 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - calling plugin Q:\plugins\video\Ninja Video\default.py('plugin://video/Ninja Video/','1','?url=http%3A%2F%2Fwww.ninjavideo.net%2Fcat%2F294&mode=2&name=Bones')
21:07:45 M: 30912512 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult - waiting on the Ninja Video plugin...
21:07:45 M: 30912512 INFO: Mode: 2
21:07:45 M: 30912512 INFO:
21:07:45 M: 30912512 INFO: URL: http://www.ninjavideo.net/cat/294
21:07:45 M: 30912512 INFO:
21:07:45 M: 30912512 INFO: Name: Bones
21:07:45 M: 30912512 INFO:
21:07:45 M: 30912512 INFO: index of seasons : http://www.ninjavideo.net/cat/294
21:07:45 M: 30912512 INFO:
21:07:46 M: 30908416 INFO: Scriptresult: Succes
21:07:46 M: 30908416 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult- plugin returned successfully
21:07:46 M: 30908416 INFO: Python script stopped
21:07:47 M: 31305728 DEBUG: CApplication::OnKey: 167 pressed, action is 4
21:07:48 M: 31305728 DEBUG: CApplication::OnKey: 11 pressed, action is 7
21:07:48 M: 31305728 DEBUG: Clearing cached fileitems [plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fvideo%2F4665&mode=4&name=Bones+3x15+The+Pain+in+the+Heart]
21:07:48 M: 31432704 DEBUG: CGUIMediaWindow::GetDirectory (plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fvideo%2F4665&mode=4&name=Bones+3x15+The+Pain+in+the+Heart)
21:07:48 M: 31432704 DEBUG: ParentPath = [plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fcat%2F294&mode=2&name=Bones]
21:07:48 M: 31432704 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - URL for plugin settings: Ninja Video/
21:07:48 M: 31432704 ERROR: Unable to load: Q:\plugins\video\Ninja Video\resources\settings.xml, Line 0
Failed to open file
21:07:48 M: 31432704 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\German\strings.xml: Failed to open file at line 0
21:07:48 M: 31432704 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\english\strings.xml: Failed to open file at line 0
21:07:48 M: 31432704 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - calling plugin Q:\plugins\video\Ninja Video\default.py('plugin://video/Ninja Video/','1','?url=http%3A%2F%2Fwww.ninjavideo.net%2Fvideo%2F4665&mode=4&name=Bones+3x15+The+Pain+in+the+Heart')
21:07:48 M: 30908416 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult - waiting on the Ninja Video plugin...
21:07:48 M: 30908416 INFO: Mode: 4
21:07:48 M: 30908416 INFO:
21:07:49 M: 30908416 INFO: URL: http://www.ninjavideo.net/video/4665
21:07:49 M: 30908416 INFO:
21:07:49 M: 30908416 INFO: Name: Bones 3x15 The Pain in the Heart
21:07:49 M: 30908416 INFO:
21:07:49 M: 30908416 INFO: index of videolinks : http://www.ninjavideo.net/video/4665
21:07:49 M: 30908416 INFO:
21:07:49 M: 30908416 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult- plugin returned successfully
21:07:49 M: 30908416 INFO: Scriptresult: Succes
21:07:49 M: 30887936 INFO: Python script stopped
21:07:50 M: 31305728 DEBUG: CApplication::OnKey: 167 pressed, action is 4
21:07:51 M: 31305728 DEBUG: CApplication::OnKey: 11 pressed, action is 7
21:07:51 M: 31305728 DEBUG: Initializing FS_SEG..
21:07:51 M: 31305728 DEBUG: FS segment @ 0xb29530
21:07:51 M: 30818304 DEBUG: Unable to resolve kernel32.dll PeekNamedPipe
21:07:51 M: 30818304 DEBUG: Dll MSVCP71.dll was not found in path
21:07:51 M: 30818304 DEBUG: Unable to load referenced dll MSVCP71.dll - Dll: Q:\system\libcurl.dll
21:07:51 M: 30818304 DEBUG: Unable to resolve MSVCP71.dll ?_Nomemory@std@@YAXXZ
21:07:51 M: 30818304 DEBUG: kernel32.dll fake function DisableThreadLibraryCalls called
21:07:51 M: 30781440 INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://127.0.0.1
21:07:51 M: 30781440 DEBUG: Curl:: Debug About to connect() to 127.0.0.1 port 64652 (#0)
21:07:51 M: 30781440 DEBUG: Curl:: Debug Trying 127.0.0.1...
21:07:51 M: 30257152 DEBUG: Curl:: Debug connected
21:07:51 M: 30257152 DEBUG: Curl:: Debug Connected to 127.0.0.1 (127.0.0.1) port 64652 (#0)
21:07:51 M: 30257152 DEBUG: Curl:: Debug HEAD /4665?.avi HTTP/1.1
User-Agent: XBMC/pre-2.1 (compatible; MSIE 6.0; Windows NT 5.1; WinampMPEG/5.09)
Host: 127.0.0.1:64652
Accept: */*
21:07:51 M: 30261248 INFO: Thu Jun 05 21:07:51 2008
21:07:51 M: 30261248 INFO:
21:07:51 M: 30261248 INFO: Serving HEAD request...
21:07:51 M: 30261248 INFO:
21:07:51 M: 30261248 INFO: Thu Jun 05 21:07:51 2008
21:07:51 M: 30261248 INFO:
21:07:51 M: 30261248 INFO: Getting infos from NinjaVideo.net for Video ID
21:07:51 M: 30261248 INFO:
21:07:51 M: 30261248 INFO: 4665
21:07:51 M: 30261248 INFO:
21:07:51 M: 30261248 INFO: ...
21:07:51 M: 30261248 INFO:
21:07:52 M: 30257152 WARNING: Untested function dllgethostbyaddr called!
21:07:52 M: 30257152 INFO: 127.0.0.1 - - [05/Jun/2008 21:07:52] "HEAD /4665?.avi HTTP/1.1" 200 -
21:07:52 M: 30257152 INFO: Thu Jun 05 21:07:52 2008
21:07:52 M: 30257152 DEBUG: Curl:: Debug HTTP 1.0, assume close after body
21:07:52 M: 30257152 INFO:
21:07:52 M: 30257152 DEBUG: Curl:: Debug HTTP/1.0 200 OK
21:07:52 M: 30257152 INFO: Sending headers...
21:07:52 M: 30257152 DEBUG: Curl:: Debug Server: BaseHTTP/0.3 Python/2.4.3
21:07:52 M: 30257152 INFO:
21:07:52 M: 30781440 DEBUG: Curl:: Debug Date: Thu, 05 Jun 2008 19:07:52 GMT
21:07:52 M: 30781440 DEBUG: Curl:: Debug Content-Disposition: inline; filename="Bones 3x15 The Pain in the Heart.avi"
21:07:52 M: 30781440 DEBUG: Curl:: Debug Content-type: application/x-msvideo
21:07:52 M: 30781440 DEBUG: Curl:: Debug Last-Modified: Wed, 21 Feb 2000 08:43:39 GMT
21:07:52 M: 30781440 DEBUG: Curl:: Debug ETag: 7c0f63c15f8749d716ba1ac9121cc1a8
21:07:52 M: 30781440 DEBUG: Curl:: Debug Accept-Ranges: bytes
21:07:52 M: 30781440 DEBUG: Curl:: Debug Cache-Control: public, must-revalidate
21:07:52 M: 30781440 DEBUG: Curl:: Debug Cache-Control: no-cache
21:07:52 M: 30781440 DEBUG: Curl:: Debug Pragma: no-cache
21:07:52 M: 30781440 DEBUG: Curl:: Debug features: seekable,stridable
21:07:52 M: 30781440 DEBUG: Curl:: Debug client-id: 12345
21:07:52 M: 30781440 DEBUG: Curl:: Debug Content-Length: 366774272
21:07:52 M: 30781440 DEBUG: Curl:: Debug
21:07:52 M: 30781440 DEBUG: Curl:: Debug Closing connection #0
21:07:52 M: 30781440 DEBUG: FileCurl::Close(D00B4D24) http://127.0.0.1:64652/4665?.avi
21:07:52 M: 30781440 DEBUG: CPlayerCoreFactor::GetPlayers(http://127.0.0.1:64652/4665?.avi)
21:07:52 M: 30781440 ERROR: XFILE::CFile::Delete - Error deleting file Z:\xbmc.edl
21:07:52 M: 30781440 DEBUG: file:http://127.0.0.1:64652/4665?.avi IsDVDImage:0 IsDVDIfoFile:0
21:07:52 M: 30781440 INFO: Loading skin file: DialogProgress.xml
21:07:52 M: 30781440 DEBUG: Load DialogProgress.xml: 38.45ms (35.77 ms xml load)
21:07:52 M: 30728192 DEBUG: Alloc resources: 15.44ms (0.00 ms skin load, 0.34 ms preload)
21:07:53 M: 29814784 INFO: mplayer play:http://127.0.0.1:64652/4665?.avi cachesize:8192
21:07:53 M: 23924736 DEBUG: msg: set audio functions called
21:07:53 M: 23924736 DEBUG: msg: done
21:07:53 M: 23924736 DEBUG: FileCurl::Open(00EC19A0) http://127.0.0.1:64652/4665?.avi
21:07:53 M: 23822336 DEBUG: Curl:: Debug About to connect() to 127.0.0.1 port 64652 (#0)
21:07:53 M: 23822336 DEBUG: Curl:: Debug Trying 127.0.0.1...
21:07:53 M: 23298048 DEBUG: Curl:: Debug connected
21:07:53 M: 23285760 DEBUG: Curl:: Debug Connected to 127.0.0.1 (127.0.0.1) port 64652 (#0)
21:07:53 M: 23298048 DEBUG: Curl:: Debug GET /4665?.avi HTTP/1.1
User-Agent: XBMC/pre-2.1 (compatible; MSIE 6.0; Windows NT 5.1; WinampMPEG/5.09)
Host: 127.0.0.1:64652
Accept: */*
21:07:53 M: 23298048 INFO: Thu Jun 05 21:07:53 2008
21:07:53 M: 23298048 INFO:
21:07:53 M: 23298048 INFO: Serving GET request...
21:07:53 M: 23298048 INFO:
21:07:53 M: 23298048 WARNING: Untested function dllgethostbyaddr called!
21:07:53 M: 23298048 INFO: 127.0.0.1 - - [05/Jun/2008 21:07:53] "GET /4665?.avi HTTP/1.1" 200 -
21:07:53 M: 23298048 INFO: Thu Jun 05 21:07:53 2008
21:07:53 M: 23298048 DEBUG: Curl:: Debug HTTP 1.0, assume close after body
21:07:53 M: 23298048 INFO:
21:07:53 M: 23298048 DEBUG: Curl:: Debug HTTP/1.0 200 OK
21:07:53 M: 23298048 INFO: Sending headers...
21:07:53 M: 23298048 DEBUG: Curl:: Debug Server: BaseHTTP/0.3 Python/2.4.3
21:07:53 M: 23298048 INFO:
21:07:53 M: 23298048 DEBUG: Curl:: Debug Date: Thu, 05 Jun 2008 19:07:53 GMT
21:07:53 M: 23298048 INFO: Thu Jun 05 21:07:53 2008
21:07:53 M: 23298048 DEBUG: Curl:: Debug Content-Disposition: inline; filename="Bones 3x15 The Pain in the Heart.avi"
21:07:53 M: 23298048 INFO:
21:07:53 M: 23298048 DEBUG: Curl:: Debug Content-type: application/x-msvideo
21:07:53 M: 23298048 INFO: Starting download at byte
21:07:53 M: 23298048 DEBUG: Curl:: Debug Last-Modified: Wed, 21 Feb 2000 08:43:39 GMT
21:07:53 M: 23298048 INFO:
21:07:53 M: 23298048 DEBUG: Curl:: Debug ETag: 7c0f63c15f8749d716ba1ac9121cc1a8
21:07:53 M: 23298048 INFO: 0
21:07:53 M: 23298048 DEBUG: Curl:: Debug Accept-Ranges: bytes
21:07:53 M: 23298048 INFO:
21:07:53 M: 23298048 DEBUG: Curl:: Debug Cache-Control: public, must-revalidate
21:07:53 M: 23298048 DEBUG: Curl:: Debug Cache-Control: no-cache
21:07:53 M: 23298048 DEBUG: Curl:: Debug Pragma: no-cache
21:07:53 M: 23298048 DEBUG: Curl:: Debug features: seekable,stridable
21:07:53 M: 23298048 DEBUG: Curl:: Debug client-id: 12345
21:07:53 M: 23298048 DEBUG: Curl:: Debug Content-Length: 366774272
21:07:53 M: 23298048 DEBUG: Curl:: Debug
21:07:55 M: 23031808 DEBUG: FileCurl::Close(00EC19A0) http://127.0.0.1:64652/4665?.avi
21:07:55 M: 22929408 DEBUG: Curl:: Debug Expire cleared
21:07:55 M: 22929408 DEBUG: Curl:: Debug Closing connection #0
21:07:55 M: 23031808 INFO: Client Closed the connection.
21:07:55 M: 23134208 INFO: Using -subcp enca:__:CP1252 to detect the subtitle charset
21:07:55 M: 23134208 INFO:
21:07:55 M: 23924736 INFO: Flipping bi-directional subtitles disabled
21:07:55 M: 23924736 DEBUG: msg: mplayer_init()
21:07:55 M: 23924736 DEBUG: msg: MPlayer XBMC-SVN-r10070-4.1.2 (C) 2000-2004 MPlayer Team
21:07:55 M: 23924736 DEBUG: msg: CPU: Intel Celeron 2/Pentium III Coppermine,Geyserville
21:07:55 M: 23924736 DEBUG: msg: (Family: 6, Stepping: 10)
21:07:55 M: 23924736 DEBUG: msg: Detected cache-line size is 32 bytes
21:07:55 M: 23924736 DEBUG: msg: CPUflags: MMX: 1 MMX2: 1 3DNow: 0 3DNow2: 0 SSE: 0 SSE2: 0
21:07:55 M: 23924736 DEBUG: msg: Compiled for x86 CPU with extensions:
21:07:55 M: 23924736 DEBUG: msg: MMX
21:07:55 M: 23924736 DEBUG: msg: MMX2
21:07:55 M: 23924736 DEBUG: msg: SSE
21:07:55 M: 23924736 DEBUG: msg:
21:07:55 M: 23912448 DEBUG: msg:
21:07:55 M: 23924736 DEBUG: msg: Creating config file: Q:\system\players\mplayer\config
21:07:55 M: 23912448 DEBUG: msg:
21:07:55 M: 23924736 DEBUG: msg: get_path('codecs.conf') -> 'Q:\system\players\mplayer\codecs.conf'
21:07:55 M: 23924736 DEBUG: msg: Reading Q:\system\players\mplayer\codecs.conf:
21:07:55 M: 23613440 DEBUG: msg: 108 audio & 225 video codecs
21:07:55 M: 23613440 DEBUG: msg: CommandLine:
21:07:55 M: 23613440 DEBUG: msg: '-dr'
21:07:55 M: 23613440 DEBUG: msg: '-v'
21:07:55 M: 23613440 DEBUG: msg: '-subcp'
21:07:55 M: 23613440 DEBUG: msg: 'enca:__:CP1252'
21:07:55 M: 23613440 DEBUG: msg: '-channels'
21:07:55 M: 23613440 DEBUG: msg: '6'
21:07:55 M: 23613440 DEBUG: msg: '-ac'
21:07:55 M: 23613440 DEBUG: msg: 'hwdts,hwac3,'
21:07:55 M: 23613440 DEBUG: msg: '-noflip-hebrew'
21:07:55 M: 23613440 DEBUG: msg: '-noflip-hebrew-commas'
21:07:55 M: 23613440 DEBUG: msg: '-vf'
21:07:55 M: 23613440 DEBUG: msg: 'noise=1ta:1ta'
21:07:55 M: 23613440 DEBUG: msg: '-fs'
21:07:55 M: 23613440 DEBUG: msg: '1.avi'
21:07:55 M: 23613440 DEBUG: msg:
21:07:55 M: 23613440 DEBUG: msg: get_path('font/font.desc') -> 'Q:\system\players\mplayer\font/font.desc'
21:07:55 M: 23085056 DEBUG: msg: font: can't open file: Q:\system\players\mplayer\font/font.desc
21:07:55 M: 23085056 DEBUG: msg: font: can't open file: Q:\system\players\mplayer/font/font.desc
21:07:55 M: 23613440 DEBUG: msg: Using MMX (with tiny bit MMX2) Optimized OnScreenDisplay
21:07:55 M: 23580672 DEBUG: msg: Using XBOX High Resolution Timers for timing
21:07:55 M: 23580672 DEBUG: msg: get_path('input.conf') -> 'Q:\system\players\mplayer\input.conf'
21:07:55 M: 23580672 DEBUG: msg: Parsing input config file Q:\system\players\mplayer\input.conf
21:07:55 M: 23576576 DEBUG: msg: Input config file Q:\system\players\mplayer\input.conf parsed: 51 binds
21:07:55 M: 23576576 DEBUG: msg: mplayer_open_file(http://127.0.0.1:64652/4665?.avi)
21:07:55 M: 23576576 DEBUG: msg: get_path('4665?.avi.conf') -> 'Q:\system\players\mplayer\4665?.avi.conf'
21:07:55 M: 23576576 DEBUG: msg:
Playing http://127.0.0.1:64652/4665?.avi.
21:07:55 M: 23576576 DEBUG: msg: find subtitles
21:07:55 M: 23576576 DEBUG: msg: auto open Z:\subtitle
21:07:55 M: 23576576 DEBUG: msg: Filename for url is now http://127.0.0.1:64652/4665?.avi
21:07:55 M: 23576576 DEBUG: msg: protocol:http
21:07:55 M: 23576576 DEBUG: msg: open stream protocol:http
21:07:55 M: 23556096 DEBUG: msg: WINSOCK2 init: 0
21:07:55 M: 23556096 DEBUG: msg: Filename for url is now http://127.0.0.1:64652/4665?.avi
21:07:55 M: 23556096 DEBUG: msg: Connecting to server 127.0.0.1[127.0.0.1]:64652 ...
21:07:55 M: 23031808 INFO: Thu Jun 05 21:07:55 2008
21:07:55 M: 23031808 INFO:
21:07:55 M: 23031808 INFO: Serving GET request...
21:07:55 M: 23031808 INFO:
21:07:55 M: 23031808 WARNING: Untested function dllgethostbyaddr called!
21:07:55 M: 23031808 INFO: 127.0.0.1 - - [05/Jun/2008 21:07:55] "GET /4665?.avi HTTP/1.0" 200 -
21:07:55 M: 23031808 INFO: Thu Jun 05 21:07:55 2008
21:07:55 M: 23031808 INFO:
21:07:55 M: 23031808 INFO: Sending headers...
21:07:55 M: 23031808 INFO:
21:07:55 M: 23031808 INFO: Thu Jun 05 21:07:55 2008
21:07:55 M: 23031808 DEBUG: msg: --- HTTP DEBUG HEADER --- START ---
21:07:55 M: 23031808 INFO:
21:07:55 M: 23031808 DEBUG: msg: protocol: [HTTP/1.0]
21:07:55 M: 23031808 INFO: Starting download at byte
21:07:55 M: 23031808 INFO:
21:07:55 M: 23031808 INFO: 0
21:07:55 M: 23031808 INFO:
21:07:55 M: 23031808 DEBUG: msg: http minor version: [0]
21:07:55 M: 23031808 DEBUG: msg: uri: [(null)]
21:07:55 M: 23031808 DEBUG: msg: method: [(null)]
21:07:55 M: 23031808 DEBUG: msg: status code: [200]
21:07:55 M: 23031808 DEBUG: msg: reason phrase: [OK]
21:07:55 M: 23031808 DEBUG: msg: body size: [0]
21:07:55 M: 23031808 DEBUG: msg: Fields:
21:07:55 M: 23031808 DEBUG: msg: 0 - Server: BaseHTTP/0.3 Python/2.4.3
21:07:55 M: 23031808 DEBUG: msg: 1 - Date: Thu, 05 Jun 2008 19:07:55 GMT
21:07:55 M: 23031808 DEBUG: msg: 2 - Content-Disposition: inline; filename="Bones 3x15 The Pain in the Heart.avi"
21:07:55 M: 23031808 DEBUG: msg: 3 - Content-type: application/x-msvideo
21:07:55 M: 23031808 DEBUG: msg: 4 - Last-Modified: Wed, 21 Feb 2000 08:43:39 GMT
21:07:55 M: 23031808 DEBUG: msg: 5 - ETag: 7c0f63c15f8749d716ba1ac9121cc1a8
21:07:55 M: 23031808 DEBUG: msg: 6 - Accept-Ranges: bytes
21:07:55 M: 23031808 DEBUG: msg: 7 - Cache-Control: public, must-revalidate
21:07:55 M: 23031808 DEBUG: msg: 8 - Cache-Control: no-cache
21:07:55 M: 23031808 DEBUG: msg: 9 - Pragma: no-cache
21:07:55 M: 23031808 DEBUG: msg: 10 - features: seekable,stridable
21:07:55 M: 23031808 DEBUG: msg: 11 - client-id: 12345
21:07:55 M: 23031808 DEBUG: msg: 12 - Content-Length: 366774272
21:07:55 M: 23031808 DEBUG: msg: --- HTTP DEBUG HEADER --- END ---
21:07:56 M: 23031808 DEBUG: msg: Content-Type: [application/x-msvideo]
21:07:56 M: 23031808 DEBUG: msg: Content-Length: [366774272]
21:07:56 M: 23031808 DEBUG: msg: Cache size set to 8192 KBytes
21:07:56 M: 23031808 DEBUG: msg: Connected to server: 127.0.0.1
21:07:56 M: 14086144 DEBUG: msg: CACHE_PRE_INIT: 0 [0] 0 pre:1677721 eof:0
21:07:56 M: 14086144 DEBUG: msg:
Cache fill: 0.00% (0 bytes)
21:07:56 M: 14073856 DEBUG: msg:
Cache fill: 0.00% (0 bytes)
<Stuff removed, pastebin size limit>
21:08:00 M: 13979648 DEBUG: msg:
Cache fill: 6.25% (524288 bytes)
21:08:00 M: 13905920 DEBUG: msg:
Cache fill: 6.25% (524288 bytes)
21:08:00 M: 13893632 INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http ://127.0.0.1 (easy=00FED010, multi=00CF3D00)
21:08:01 M: 13926400 DEBUG: msg:
Cache fill: 6.25% (524288 bytes)
21:08:01 M: 13828096 DEBUG: msg:
Cache fill: 6.25% (524288 bytes)
<Stuff removed, pastebin size limit>
21:08:13 M: 13709312 DEBUG: msg:
Cache fill: 18.75% (1572864 bytes)
21:08:13 M: 13672448 DEBUG: msg:
Cache fill: 18.75% (1572864 bytes)
21:08:13 M: 14082048 DEBUG: msg:
21:08:13 M: 14082048 DEBUG: msg: demux_open(01008010,0,-1,-1,-1)
21:08:13 M: 14082048 DEBUG: msg: AVI file format detected.
21:08:13 M: 14082048 DEBUG: msg: list_end=0x229A
21:08:13 M: 14082048 DEBUG: msg: ======= AVI Header =======
21:08:13 M: 14082048 DEBUG: msg: us/frame: 41708 (fps=23.976)
21:08:13 M: 14082048 DEBUG: msg: max bytes/sec: 0
21:08:13 M: 14082048 DEBUG: msg: padding: 0
21:08:13 M: 14082048 DEBUG: msg: MainAVIHeader.dwFlags: (272) HAS_INDEX IS_INTERLEAVED
21:08:13 M: 14082048 DEBUG: msg: frames total: 62030 initial: 0
21:08:13 M: 14082048 DEBUG: msg: streams: 2
21:08:13 M: 14082048 DEBUG: msg: Suggested BufferSize: 0
21:08:13 M: 14082048 DEBUG: msg: Size: 624 x 352
21:08:13 M: 14082048 DEBUG: msg: ==========================
21:08:13 M: 14082048 DEBUG: msg: list_end=0x10F8
21:08:13 M: 14082048 DEBUG: msg: ==> Found video stream: 0
21:08:13 M: 14082048 DEBUG: msg: ====== STREAM Header =====
21:08:13 M: 14082048 DEBUG: msg: Type: vids FCC: xvid (64697678)
21:08:13 M: 14082048 DEBUG: msg: Flags: 0
21:08:13 M: 14082048 DEBUG: msg: Priority: 0 Language: 0
21:08:13 M: 14082048 DEBUG: msg: InitialFrames: 0
21:08:13 M: 14082048 DEBUG: msg: Rate: 24000/1001 = 23.976
21:08:13 M: 14082048 DEBUG: msg: Start: 0 Len: 62030
21:08:13 M: 14082048 DEBUG: msg: Suggested BufferSize: 128347
21:08:13 M: 14082048 DEBUG: msg: Quality 10000
21:08:13 M: 14082048 DEBUG: msg: Sample size: 0
21:08:13 M: 14082048 DEBUG: msg: ==========================
21:08:13 M: 14082048 DEBUG: msg: Found 'bih', 40 bytes of 40
21:08:13 M: 14082048 DEBUG: msg: ======= VIDEO Format ======
21:08:13 M: 14082048 DEBUG: msg: biSize 40
21:08:13 M: 14082048 DEBUG: msg: biWidth 624
21:08:13 M: 14082048 DEBUG: msg: biHeight 352
21:08:13 M: 14082048 DEBUG: msg: biPlanes 1
21:08:13 M: 14082048 DEBUG: msg: biBitCount 24
21:08:13 M: 14082048 DEBUG: msg: biCompression 1145656920='XVID'
21:08:13 M: 14082048 DEBUG: msg: biSizeImage 1317888
21:08:13 M: 14082048 DEBUG: msg: ===========================
21:08:13 M: 14082048 DEBUG: msg: Regenerating keyframe table for MPEG-4 video.
21:08:13 M: 14082048 DEBUG: msg: list_end=0x218E
21:08:13 M: 14082048 DEBUG: msg: ==> Found audio stream: 1
21:08:13 M: 14082048 DEBUG: msg: ====== STREAM Header =====
21:08:13 M: 14082048 DEBUG: msg: Type: auds FCC: (0)
21:08:13 M: 14082048 DEBUG: msg: Flags: 0
21:08:13 M: 14082048 DEBUG: msg: Priority: 0 Language: 0
21:08:13 M: 14082048 DEBUG: msg: InitialFrames: 1
21:08:13 M: 14082048 DEBUG: msg: Rate: 48000/1152 = 41.667
21:08:13 M: 14082048 DEBUG: msg: Start: 0 Len: 107797
21:08:13 M: 14082048 DEBUG: msg: Suggested BufferSize: 960
21:08:13 M: 14082048 DEBUG: msg: Quality -1
21:08:13 M: 14082048 DEBUG: msg: Sample size: 0
21:08:13 M: 14082048 DEBUG: msg: ==========================
21:08:13 M: 14082048 DEBUG: msg: Found 'wf', 30 bytes of 18
21:08:13 M: 14082048 DEBUG: msg: ======= WAVE Format =======
21:08:13 M: 14082048 DEBUG: msg: Format Tag: 85 (0x55)
21:08:13 M: 14082048 DEBUG: msg: Channels: 2
21:08:13 M: 14082048 DEBUG: msg: Samplerate: 48000
21:08:13 M: 14082048 DEBUG: msg: avg byte/sec: 16612
21:08:13 M: 14082048 DEBUG: msg: Block align: 1152
21:08:13 M: 14082048 DEBUG: msg: bits/sample: 0
21:08:13 M: 14082048 DEBUG: msg: cbSize: 12
21:08:13 M: 14082048 DEBUG: msg: mp3.wID=1
21:08:13 M: 14082048 DEBUG: msg: mp3.fdwFlags=0x2
21:08:13 M: 14082048 DEBUG: msg: mp3.nBlockSize=398
21:08:13 M: 14082048 DEBUG: msg: mp3.nFramesPerBlock=1
21:08:13 M: 14082048 DEBUG: msg: mp3.nCodecDelay=0
21:08:13 M: 14082048 DEBUG: msg: ===========================
21:08:13 M: 14082048 DEBUG: msg: list_end=0x229A
21:08:13 M: 14082048 DEBUG: msg: AVI: dmlh found (size=248) (total_frames=62030)
21:08:13 M: 14082048 DEBUG: msg: list_end=0x22BA
21:08:13 M: 14082048 DEBUG: msg: hdr=Software size=11
21:08:13 M: 14082048 DEBUG: msg: Software : VirtualDub
21:08:13 M: 14082048 DEBUG: msg: list_end=0x15B31120
21:08:13 M: 14082048 DEBUG: msg: Found movie at 0x280C - 0x15B31120
21:08:15 M: 13811712 DEBUG: msg: Connecting to server 127.0.0.1[127.0.0.1]:64652 ...
21:08:15 M: 13185024 INFO: Thu Jun 05 21:08:15 2008
21:08:15 M: 13185024 INFO:
21:08:15 M: 13185024 INFO: Serving GET request...
21:08:15 M: 13185024 INFO:
21:08:15 M: 13185024 WARNING: Untested function dllgethostbyaddr called!
21:08:15 M: 13185024 INFO: 127.0.0.1 - - [05/Jun/2008 21:08:15] "GET /4665?.avi HTTP/1.0" 206 -
21:08:15 M: 13185024 INFO: Thu Jun 05 21:08:15 2008
21:08:15 M: 13185024 INFO:
21:08:15 M: 13185024 INFO: Sending headers...
21:08:15 M: 13185024 INFO:
21:08:15 M: 13185024 DEBUG: msg: Content-Type: [application/x-msvideo]
21:08:15 M: 13185024 INFO: Thu Jun 05 21:08:15 2008
21:08:15 M: 13185024 DEBUG: msg: Content-Length: [2721792]
21:08:15 M: 13287424 INFO:
21:08:15 M: 13287424 INFO: Starting download at byte
21:08:15 M: 13287424 INFO:
21:08:15 M: 13287424 INFO: 364052480
21:08:15 M: 13287424 INFO:
21:08:15 M: 13287424 INFO: Client Closed the connection.
21:08:15 M: 13287424 INFO:
21:08:17 M: 14082048 DEBUG: msg: Reading INDEX block, 169827 chunks for 62030 frames (fpos=364056872).
21:08:31 M: 11362304 DEBUG: SECTION:UnloadDelayed(DLL: Q:\system\libcurl.dll)
21:08:42 M: 12361728 DEBUG: msg: Connecting to server 127.0.0.1[127.0.0.1]:64652 ...
21:08:42 M: 11837440 INFO: Thu Jun 05 21:08:42 2008
21:08:42 M: 11837440 INFO:
21:08:42 M: 11837440 INFO: Serving GET request...
21:08:42 M: 11837440 INFO:
21:08:42 M: 11837440 WARNING: Untested function dllgethostbyaddr called!
21:08:42 M: 11837440 INFO: 127.0.0.1 - - [05/Jun/2008 21:08:42] "GET /4665?.avi HTTP/1.0" 200 -
21:08:42 M: 11837440 INFO: Thu Jun 05 21:08:42 2008
21:08:42 M: 11837440 INFO:
21:08:42 M: 11837440 INFO: Sending headers...
21:08:42 M: 11837440 INFO:
21:08:42 M: 11833344 INFO: Thu Jun 05 21:08:42 2008
21:08:42 M: 11833344 DEBUG: msg: Content-Type: [application/x-msvideo]
21:08:42 M: 11833344 INFO:
21:08:42 M: 11833344 DEBUG: msg: Content-Length: [366774272]
21:08:42 M: 11837440 INFO: Starting download at byte
21:08:42 M: 11837440 INFO:
21:08:42 M: 11837440 INFO: 0
21:08:42 M: 11837440 INFO:
21:08:44 M: 11837440 DEBUG: msg: AVI index offset: 0x2808 (movi=0x280C idx0=0x4 idx1=0x18C)
21:08:44 M: 11837440 DEBUG: msg: Auto-selected AVI audio ID = 1
21:08:44 M: 11837440 DEBUG: msg: Auto-selected AVI video ID = 0
21:08:44 M: 11837440 DEBUG: msg: AVI: Searching for audio stream (id:1)
21:08:44 M: 11837440 DEBUG: msg: AVI video size=319680620 (62030) audio size=42976272 (107797)
21:08:44 M: 11837440 DEBUG: msg: [V] filefmt:3 fourcc:0x44495658 size:624x352 fps:23.98 ftime:=0.0417
21:08:44 M: 11837440 DEBUG: msg: Clip info:
21:08:44 M: 11837440 DEBUG: msg: Software: VirtualDub
21:08:44 M: 11837440 DEBUG: msg: get_path('sub/') -> 'Q:\system\players\mplayer\sub/'
21:08:44 M: 11837440 DEBUG: msg: Starting lookup for subs
21:08:44 M: 11837440 DEBUG: msg: Global Subsize: 0 - VOBSUB: -1, DEMUX: -1, SUBS: -1
21:08:44 M: 11837440 DEBUG: msg: Global Subpos : -1
21:08:44 M: 11837440 DEBUG: msg: ==========================================================================
21:08:44 M: 11837440 DEBUG: msg: Forced audio codec: hwdts
21:08:44 M: 11837440 DEBUG: msg: Forced audio codec: hwac3
21:08:44 M: 11837440 DEBUG: msg: Opening audio decoder: [mp3lib] MPEG layer-2, layer-3
21:08:44 M: 11837440 DEBUG: msg: dec_audio: Allocating 4608 + 65536 = 70144 bytes for output buffer.
21:08:44 M: 11755520 DEBUG: msg: mp3lib: made decode tables with MMX optimization
21:08:44 M: 11755520 DEBUG: msg: mp3lib: using MMX optimized decore!
21:08:44 M: 11755520 DEBUG: msg: MP3lib: init layer2&3 finished, tables done
21:08:44 M: 11755520 DEBUG: msg:
MPEG 1.0, Layer III, 48000 Hz 32 kbit Joint-Stereo, BPF: 96
21:08:44 M: 11755520 DEBUG: msg: Channels: 2, copyright: No, original: Yes, CRC: Yes, emphasis: 0
21:08:44 M: 11755520 DEBUG: msg: AUDIO: 48000 Hz, 2 ch, 16 bit (0x10), ratio: 4000->192000 (32.0 kbit)
21:08:44 M: 11755520 DEBUG: msg: Selected audio codec: [mp3] afm:mp3lib (mp3lib MPEG layer-2, layer-3)
21:08:44 M: 11755520 DEBUG: msg: ==========================================================================
21:08:44 M: 11755520 DEBUG: CXBoxRenderManager::PreInit - Selected RGB-Renderer V2
21:08:44 M: 11755520 DEBUG: Deleted 444P video textures
21:08:44 M: 11755520 DEBUG: msg: Opening video filter: [noise=1ta:1ta]
21:08:44 M: 11677696 DEBUG: msg: [vo] query(Planar YV12) -> 3
21:08:44 M: 11677696 DEBUG: msg: ==========================================================================
21:08:44 M: 11677696 DEBUG: msg: Opening video decoder: [ffmpeg] FFmpeg's libavcodec codec family
21:08:44 M: 11370496 DEBUG: msg: INFO: libavcodec init OK!
21:08:44 M: 11370496 DEBUG: msg: Selected video codec: [ffodivx] vfm:ffmpeg (FFmpeg MPEG-4)
21:08:44 M: 11370496 DEBUG: msg: ==========================================================================
21:08:44 M: 11370496 DEBUG: msg: Checking audio filter chain for 48000Hz/2ch/16bit -> 48000Hz/6ch/16bit...
21:08:44 M: 11370496 DEBUG: msg: [libaf] Adding filter dummy
21:08:44 M: 11370496 DEBUG: msg: [dummy] Was reinitialized, rate=48000Hz, nch = 2, format = 0x00000001 and bps = 2
21:08:44 M: 11370496 DEBUG: msg: AF_pre: af format: 2 bps, 2 ch, 48000 hz, little endian signed int
21:08:44 M: 11370496 DEBUG: msg: AF_pre: 48000Hz 2ch Signed 16-bit (Little-Endian)
21:08:44 M: 11321344 DEBUG: Pause stream
21:08:44 M: 11321344 DEBUG: msg: AO: [win32] 48000Hz 2ch Signed 16-bit (Little-Endian) (2 bps)
21:08:44 M: 11321344 DEBUG: msg: AO: Description: Windows waveOut audio output
AO: Author: SaschaSommer <saschasommer@freenet.de>
21:08:44 M: 11321344 DEBUG: msg: Building audio filter chain for 48000Hz/2ch/16bit -> 48000Hz/2ch/16bit...
21:08:44 M: 11321344 DEBUG: msg: [dummy] Was reinitialized, rate=48000Hz, nch = 2, format = 0x00000001 and bps = 2
21:08:44 M: 11321344 DEBUG: msg: [dummy] Was reinitialized, rate=48000Hz, nch = 2, format = 0x00000001 and bps = 2
21:08:44 M: 11251712 DEBUG: msg: Starting playback...
21:08:44 M: 11251712 DEBUG: msg: mplayer_open_file(http://127.0.0.1:64652/4665?.avi) done 1.0000
21:08:44 M: 11169792 INFO: Loading skin file: VideoOverlay.xml
21:08:44 M: 11169792 DEBUG: Playback has started
21:08:44 M: 11329536 DEBUG: Load VideoOverlay.xml: 48.19ms (45.28 ms xml load)
21:08:44 M: 11329536 DEBUG: Alloc resources: 49.33ms (49.33 ms skin load, 0.00 ms preload)
21:08:44 M: 11321344 DEBUG: msg: [ffmpeg] aspect_ratio: 1.772727
21:08:44 M: 11321344 DEBUG: CGUIInfoManager::SetCurrentMovie(http://127.0.0.1:64652/4665?.avi)
21:08:44 M: 11321344 DEBUG: msg: VDec: vo config request - 624 x 352 (preferred colorspace: Planar YV12)
21:08:44 M: 11321344 DEBUG: msg: Trying filter chain:
21:08:44 M: 11321344 DEBUG: msg: noise
21:08:44 M: 11321344 DEBUG: msg: vo
21:08:44 M: 11309056 DEBUG: msg:
21:08:44 M: 11309056 DEBUG: msg: VDec: using Planar YV12 as output csp (no 0)
21:08:44 M: 11309056 DEBUG: msg: Movie-Aspect is 1.77:1 - prescaling to correct movie aspect.
21:08:44 M: 11309056 DEBUG: msg: VO Config (624x352->624x352,flags=1,'MPlayer',0x32315659)
21:08:44 M: 11309056 DEBUG: msg: REQ: flags=0x437 req=0x0
21:08:44 M: 11309056 DEBUG: msg: VO: [directx] 624x352 => 624x352 Planar YV12 [fs]
21:08:44 M: 11300864 DEBUG: msg: VO: Description: XBOX Direct3D8 YUY2 renderer
21:08:44 M: 11300864 DEBUG: msg: VO: Author: Frodo/JCMarshall
21:08:44 M: 11300864 DEBUG: mplayer::video_config(624, 352, 624, 352, 1, 842094169)
21:08:44 M: 11300864 NOTICE: Display resolution USER : 720p 16:9 (1)
21:08:44 M: 10760192 DEBUG: Activating window ID: 12005
21:08:44 M: 10760192 DEBUG: Checking if window ID 12005 is locked.
21:08:44 M: 12337152 DEBUG: Setting resolution 1
21:08:44 M: 14196736 DEBUG: We set resolution 1
21:08:45 M: 13836288 DEBUG: Created YV12 texture 0
21:08:45 M: 12955648 INFO: Created 444P full texture
21:08:45 M: 12955648 INFO: Loading skin file: VideoFullScreen.xml
21:08:45 M: 12943360 DEBUG: Load VideoFullScreen.xml: 47.56ms (30.90 ms xml load)
21:08:45 M: 12853248 DEBUG: Alloc resources: 73.22ms (49.23 ms skin load, 0.37 ms preload)
21:08:45 M: 12853248 INFO: Loading skin file: VideoOSD.xml
21:08:45 M: 12861440 DEBUG: Load VideoOSD.xml: 15.27ms (7.20 ms xml load)
21:08:45 M: 12054528 DEBUG: Alloc resources: 31.67ms (0.00 ms skin load, 1.04 ms preload)
21:08:45 M: 12058624 INFO: Loading skin file: VideoOSDSettings.xml
21:08:45 M: 12046336 DEBUG: Load VideoOSDSettings.xml: 34.20ms (29.69 ms xml load)
21:08:45 M: 11350016 DEBUG: Alloc resources: 49.51ms (0.00 ms skin load, 0.54 ms preload)
21:08:45 M: 11350016 INFO: Loading skin file: VideoOSDSettings.xml
21:08:45 M: 11337728 DEBUG: Load VideoOSDSettings.xml: 14.50ms (9.95 ms xml load)
21:08:45 M: 11345920 DEBUG: Alloc resources: 0.43ms (0.00 ms skin load, 0.15 ms preload)
21:08:45 M: 11317248 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\media\Fonts\arial.ttf (32.763889): width = 127, height = 45, lineheight = 38
21:08:45 M: 10940416 DEBUG: msg: *** [noise] Allocating mp_image_t, 624x352x12bpp YUV planar, 329472 bytes
21:08:45 M: 10903552 DEBUG: Alloc resources: 0.53ms (0.00 ms skin load, 0.19 ms preload)
21:09:31 M: 10936320 DEBUG: msg: XXX initial v_pts=0.000 a_pos=2208 (0.133)
21:09:31 M: 10604544 DEBUG: msg: *** [noise] Allocating mp_image_t, 624x352x12bpp YUV planar, 329472 bytes
21:09:31 M: 10240000 DEBUG: msg: *** [vo] Allocating mp_image_t, 624x352x12bpp YUV planar, 329472 bytes
21:09:31 M: 9715712 DEBUG: msg: FFRW:normal play
21:09:31 M: 9715712 INFO: Starting async renderer thread
21:09:31 M: 9715712 DEBUG: msg: *** [noise] Direct Rendering mp_image_t, 624x352x12bpp YUV planar, 329472 bytes
21:11:54 M: 9715712 INFO: Thu Jun 05 21:11:54 2008
21:11:54 M: 9715712 INFO:
21:11:54 M: 9715712 INFO: Could not read from URL...reopening...
21:11:54 M: 9715712 INFO:
21:12:22 M: 9711616 DEBUG: Alloc resources: 0.52ms (0.00 ms skin load, 0.18 ms preload)
21:13:15 M: 9621504 DEBUG: msg: FFRW:normal play
21:13:41 M: 9691136 DEBUG: Alloc resources: 0.53ms (0.00 ms skin load, 0.18 ms preload)
21:14:29 M: 9613312 DEBUG: msg: FFRW:normal play
21:15:07 M: 9703424 DEBUG: Alloc resources: 0.52ms (0.00 ms skin load, 0.18 ms preload)
21:16:00 M: 9621504 DEBUG: msg: FFRW:normal play
21:16:24 M: 9662464 DEBUG: Alloc resources: 0.52ms (0.00 ms skin load, 0.18 ms preload)
21:17:15 M: 9605120 DEBUG: msg: FFRW:normal play
21:18:23 M: 9691136 DEBUG: Alloc resources: 0.53ms (0.00 ms skin load, 0.18 ms preload)
21:19:33 M: 9621504 DEBUG: msg: FFRW:normal play
21:19:54 M: 9666560 DEBUG: Alloc resources: 0.52ms (0.00 ms skin load, 0.18 ms preload)
21:21:23 M: 9596928 DEBUG: msg: FFRW:normal play
21:21:52 M: 9687040 DEBUG: Alloc resources: 0.53ms (0.00 ms skin load, 0.18 ms preload)
21:23:23 M: 9601024 DEBUG: msg: FFRW:normal play
21:24:17 M: 9699328 DEBUG: Alloc resources: 0.52ms (0.00 ms skin load, 0.18 ms preload)
21:25:02 M: 9277440 DEBUG: msg: nop_streaming_read error : Unknown error
21:25:02 M: 9273344 DEBUG: msg: FFRW:normal play
21:25:16 M: 9322496 DEBUG: msg: [mpeg4 @ 0227FF20]
21:25:16 M: 9326592 DEBUG: msg: ac-tex damaged at 15 19
21:25:16 M: 9326592 DEBUG: msg: [mpeg4 @ 0227FF20]
21:25:16 M: 9326592 DEBUG: msg: Error at MB: 775
21:25:16 M: 9326592 DEBUG: msg: [mpeg4 @ 0227FF20]
21:25:16 M: 9326592 DEBUG: msg: concealing 151 DC, 151 AC, 151 MV errors
21:25:16 M: 9347072 DEBUG: msg: ds_fill_buffer: EOF reached (stream: video)
21:25:16 M: 9342976 DEBUG: msg: mplayer_close_file()
21:25:16 M: 9342976 DEBUG: msg:
21:25:16 M: 9342976 DEBUG: msg: uninit_player
21:25:16 M: 18382848 INFO: Client Closed the connection.
21:25:16 M: 18382848 INFO:
21:25:16 M: 19169280 DEBUG: msg: WINSOCK2 uninit
21:25:16 M: 19185664 DEBUG: msg: Uninit audio filters...
21:25:16 M: 19185664 DEBUG: msg: [libaf] Removing filter dummy
21:25:16 M: 19185664 DEBUG: msg: Uninit audio: mp3lib
21:25:16 M: 19324928 DEBUG: msg: Uninit video: ffmpeg
21:25:16 M: 25014272 DEBUG: Deleted 444P video textures
21:25:16 M: 25899008 DEBUG: Deleted YV12 texture 0
21:25:16 M: 26169344 DEBUG: msg: uninit_player - done
21:25:16 M: 26169344 DEBUG: Freeing FS segment @ 0xb29530
21:25:16 M: 26169344 DEBUG: Playback has finished
21:25:16 M: 26681344 DEBUG: CVideoDatabase::GetMovieInfo (http://127.0.0.1:64652/4665?.avi), query = select idMovie from movie where idFile=3249
21:25:16 M: 26681344 DEBUG: CVideoDatabase::GetEpisodeInfo (http://127.0.0.1:64652/4665?.avi), query = select idEpisode from episode where idFile=3249
21:25:16 M: 26681344 DEBUG: CVideoDatabase::GetMusicVideoInfo (http://127.0.0.1:64652/4665?.avi), query = select idMVideo from musicvideo where idFile=3249
21:25:16 M: 26693632 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:25:17 M: 28270592 DEBUG: Setting resolution 1
21:25:17 M: 26386432 DEBUG: We set resolution 1
21:25:17 M: 26501120 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
21:25:17 M: 26488832 INFO: Loading skin file: MyVideo.xml
21:25:17 M: 26361856 DEBUG: Load MyVideo.xml: 160.85ms (40.74 ms xml load)
21:25:17 M: 26238976 DEBUG: Alloc resources: 244.37ms (185.64 ms skin load, 0.83 ms preload)
21:25:17 M: 26259456 DEBUG: CGUIMediaWindow::GetDirectory (plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fvideo%2F4665&mode=4&name=Bones+3x15+The+Pain+in+the+Heart)
21:25:17 M: 26279936 DEBUG: ParentPath = [plugin://video/Ninja Video/?url=http%3A%2F%2Fwww.ninjavideo.net%2Fvideo%2F4665&mode=4&name=Bones+3x15+The+Pain+in+the+Heart]
21:25:17 M: 26271744 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - URL for plugin settings: Ninja Video/
21:25:17 M: 26271744 ERROR: Unable to load: Q:\plugins\video\Ninja Video\resources\settings.xml, Line 0
Failed to open file
21:25:17 M: 26271744 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\German\strings.xml: Failed to open file at line 0
21:25:17 M: 26271744 ERROR: unable to load Q:\plugins\video\Ninja Video\resources\language\english\strings.xml: Failed to open file at line 0
21:25:17 M: 26271744 DEBUG: DIRECTORY::CPluginDirectory::GetDirectory - calling plugin Q:\plugins\video\Ninja Video\default.py('plugin://video/Ninja Video/','1','?url=http%3A%2F%2Fwww.ninjavideo.net%2Fvideo%2F4665&mode=4&name=Bones+3x15+The+Pain+in+the+Heart')
21:25:17 M: 25747456 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult - waiting on the Ninja Video plugin...
21:25:17 M: 25751552 INFO: Mode: 4
21:25:17 M: 25751552 INFO:
21:25:17 M: 25751552 INFO: URL: http://www.ninjavideo.net/video/4665
21:25:17 M: 25751552 INFO:
21:25:17 M: 25751552 INFO: Name: Bones 3x15 The Pain in the Heart
21:25:17 M: 25751552 INFO:
21:25:17 M: 25751552 INFO: index of videolinks : http://www.ninjavideo.net/video/4665
21:25:17 M: 25751552 INFO:
21:25:17 M: 25755648 DEBUG: DIRECTORY::CPluginDirectory::WaitOnScriptResult- plugin returned successfully
21:25:17 M: 25759744 INFO: Scriptresult: Succes
21:25:17 M: 25739264 INFO: Python script stopped
21:25:18 M: 25759744 DEBUG: Q:\system\players\mplayer\mplayer.dll (base 01EC0000): Detected memory leaks: 289 leaks
21:25:18 M: 26124288 DEBUG: leak caller address 1ec10cc, size 128, counter 1
21:25:18 M: 26648576 DEBUG: leak caller address 1ece000, size 4, counter 1
21:25:18 M: 26648576 DEBUG: leak caller address 1ece1d5, size 40, counter 1
21:25:18 M: 26648576 DEBUG: leak caller address 1ece2a9, size 72, counter 2
21:25:18 M: 26648576 DEBUG: leak caller address 1ece49b, size 8, counter 1
21:25:18 M: 26648576 DEBUG: leak caller address 1ece4b3, size 0, counter 1
21:25:18 M: 26648576 DEBUG: leak caller address 1edd2d7, size 28, counter 2
21:25:18 M: 26648576 DEBUG: leak caller address 1edd300, size 0, counter 5
21:25:18 M: 26648576 DEBUG: leak caller address 1edd3a7, size 16, counter 1
21:25:18 M: 26648576 DEBUG: leak caller address 1edd3cc, size 0, counter 1
21:25:18 M: 26648576 DEBUG: leak caller address 1edd469, size 0, counter 5
21:25:18 M: 26648576 DEBUG: leak caller address 1ee3106, size 0, counter 1
21:25:18 M: 26648576 DEBUG: leak caller address 1ee312b, size 0, counter 1
21:25:18 M: 26648576 DEBUG: leak caller address 1ee3151, size 0, counter 1
21:25:18 M: 26648576 DEBUG: leak caller address 1f5afb0, size 44, counter 1
21:25:18 M: 26648576 DEBUG: leak caller address 1f79026, size 28, counter 1
21:25:18 M: 26648576 DEBUG: leak caller address 1f79096, size 0, counter 1
21:25:18 M: 26648576 DEBUG: leak caller address 1f790f1, size 5, counter 1
21:25:18 M: 26648576 DEBUG: leak caller address 1f792cf, size 10, counter 1
21:25:18 M: 26648576 DEBUG: leak caller address 1f79325, size 0, counter 1
21:25:18 M: 26648576 DEBUG: leak caller address 1f7cf29, size 1624, counter 50
21:25:18 M: 26648576 DEBUG: leak caller address 1fe8dd4, size 869, counter 1
21:25:18 M: 26648576 DEBUG: leak caller address 1fe8ef0, size 31232, counter 10
21:25:18 M: 26648576 DEBUG: leak caller address 21e24ad, size 496650, counter 198
21:25:18 M: 26648576 DEBUG: mplayer.dll: Total bytes leaked: 530758