All pastes #1087905 Raw Edit

ritz xbox log

public text v1 · immutable
#1087905 ·published 2008-07-31 01:49 UTC
rendered paste body
18:45:15 M: 56299520  NOTICE: -----------------------------------------------------------------------
18:45:15 M: 56279040  NOTICE: Starting XBMC, Platform: Xbox.  Built on Jul 17 2008
18:45:15 M: 56279040  NOTICE: Q is mapped to: E:\Apps\XBMC
18:45:15 M: 56279040  NOTICE: The executeable running is: E:\Apps\XBMC\default.xbe
18:45:15 M: 56279040  NOTICE: Log File is located: Q:\xbmc.log
18:45:15 M: 56279040  NOTICE: -----------------------------------------------------------------------
18:45:15 M: 56279040  NOTICE: Unmapped drive T
18:45:15 M: 56279040  NOTICE: Mapping drive T to Harddisk0\Partition1\Apps\XBMC\userdata
18:45:15 M: 56279040  NOTICE: Setup DirectX
18:45:15 M: 56254464  NOTICE: Mapping drive C to Harddisk0\Partition2
18:45:15 M: 56254464  NOTICE: Mapping drive E to Harddisk0\Partition1
18:45:15 M: 56254464  NOTICE: Unmapped drive D
18:45:15 M: 56254464  NOTICE: Mapping drive D to Cdrom0
18:45:15 M: 56254464  NOTICE: Mapping drive F to Harddisk0\Partition6
18:45:15 M: 56254464  NOTICE: Mapping drive X to Harddisk0\Partition3
18:45:15 M: 56254464  NOTICE: Mapping drive Y to Harddisk0\Partition4
18:45:15 M: 56254464  NOTICE: Unmapped drive Z
18:45:15 M: 56254464  NOTICE: Mapping drive Z to Harddisk0\Partition5
18:45:15 M: 56254464  NOTICE: load settings...
18:45:15 M: 56254464  NOTICE: Mapping drive P to Harddisk0\Partition1\Apps\XBMC\userdata
18:45:15 M: 56254464  NOTICE: loading T:\guisettings.xml
18:45:15 M: 56074240  NOTICE: Enabled debug logging due to GUI setting
18:45:15 M: 56074240  NOTICE: Getting hardware information now...
18:45:15 M: 56074240    INFO: Using analog output
18:45:15 M: 56074240    INFO: AC3 pass through is disabled
18:45:15 M: 56074240    INFO: DTS pass through is disabled
18:45:15 M: 56074240  NOTICE: Checking resolution 10
18:45:15 M: 56074240    INFO: AV Pack: S-Video
18:45:15 M: 56074240    INFO: AV Flags:
18:45:15 M: 56074240  NOTICE: Setting autoresolution mode 4
18:45:15 M: 56074240  NOTICE: Per AV pack settings are off
18:45:15 M: 56201216  NOTICE: q:\userdata\sources.xml
18:45:15 M: 56184832   ERROR:   <programs> tag is missing or sources.xml is malformed
18:45:15 M: 56164352   DEBUG:     Setting <default> source to : Games
18:45:15 M: 56205312    INFO: Checking skinpath existance, and existence of keymap.xml:Q:\skin...
18:45:15 M: 51773440    INFO: load language info file:Q:\language\english\langinfo.xml
18:45:15 M: 51249152    INFO: load language file:Q:\language\english\strings.xml
18:45:15 M: 50659328    INFO: load keymapping
18:45:15 M: 50659328    INFO: Loading P:\Keymap.xml
18:45:16 M: 50946048   ERROR: Window Translator: Can't find window videotitles
18:45:16 M: 51040256    INFO: Checking skin version of: Project Mayhem III
18:45:16 M: 51040256    INFO: Skin version is: 2.1
18:45:16 M: 51044352    INFO:  GUI format 720x480 NTSC 4:3
18:45:16 M: 51044352    INFO: install unhandled exception filter
18:45:16 M: 51044352    INFO: creating subdirectories
18:45:16 M: 51044352    INFO: userdata folder: q:\userdata
18:45:16 M: 51044352    INFO:   recording folder:
18:45:16 M: 51044352    INFO:   screenshots folder:
18:45:16 M: 51044352    INFO:   thumbnails folder:q:\userdata\Thumbnails
18:45:16 M: 51032064  NOTICE: Checking the Date!
18:45:16 M: 51032064    INFO: - Current Date is: 30-7-2008
18:45:16 M: 51032064  NOTICE: start dvd mediatype detection
18:45:16 M: 50966528  NOTICE: initializing playlistplayer
18:45:16 M: 50966528   DEBUG: Compiled with libcdio Version 0.72
18:45:16 M: 50966528  NOTICE: DONE initializing playlistplayer
18:45:16 M: 50966528    INFO: lcd not used
18:45:16 M: 50958336  NOTICE: load default skin:[Project Mayhem III]
18:45:16 M: 50958336    INFO:   load skin from:Q:\skin\Project Mayhem III
18:45:16 M: 50958336    INFO:   delete old skin...
18:45:16 M: 50958336    INFO: Default 4:3 resolution directory is Q:\skin\Project Mayhem III\PAL
18:45:16 M: 50958336    INFO: Default 16:9 resolution directory is Q:\skin\Project Mayhem III\PAL16x9
18:45:16 M: 50958336    INFO: Skin version is: 2.1
18:45:16 M: 50958336    INFO: Loading skin includes from Q:\skin\Project Mayhem III\PAL\includes.xml
18:45:16 M: 49565696    INFO:   load fonts for skin...
18:45:16 M: 49565696    INFO: Loading fonts from Q:\skin\Project Mayhem III\NTSC\Font.xml
18:45:16 M: 49479680   DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Project Mayhem III\Fonts\FrancophilSans.ttf (10.250000): width = 12, height = 13, lineheight = 12
18:45:16 M: 49401856   DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Project Mayhem III\Fonts\FrancophilSans.ttf (12.812501): width = 15, height = 16, lineheight = 15
18:45:16 M: 49324032   DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Project Mayhem III\Fonts\FrancophilSans.ttf (13.666667): width = 17, height = 17, lineheight = 16
18:45:16 M: 49254400   DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Project Mayhem III\Fonts\FrancophilSans.ttf (14.520834): width = 18, height = 18, lineheight = 17
18:45:16 M: 49225728   ERROR: unable to load Q:\skin\Project Mayhem III\language\english\strings.xml: Failed to open file at line 0
18:45:16 M: 49225728   ERROR: unable to load Q:\skin\Project Mayhem III\language\English\strings.xml: Failed to open file at line 0
18:45:16 M: 49225728    INFO:   load new skin...
18:45:16 M: 49225728    INFO: Skin version is: 2.1
18:45:16 M: 49225728    INFO: Loading skin file: Home.xml
18:45:16 M: 48848896    INFO: Loading references file: Q:\skin\Project Mayhem III\NTSC\references.xml
18:45:16 M: 48082944   DEBUG: Load Home.xml: 116.95ms (22.70 ms xml load)
18:45:16 M: 48259072    INFO: Loading user windows, path Q:\skin\Project Mayhem III\PAL
18:45:16 M: 48279552    INFO: Loading skin file: Q:\skin\Project Mayhem III\PAL\custom1_SettingsSubmenu.xml
18:45:16 M: 48279552    INFO: Loading skin file: Q:\skin\Project Mayhem III\PAL\custom2_SkinSettings.xml
18:45:16 M: 48279552    INFO: Loading skin file: Q:\skin\Project Mayhem III\PAL\custom5_SlideshowOverlay.xml
18:45:16 M: 48279552   DEBUG: Load Skin XML: 166.43ms
18:45:16 M: 48279552    INFO:   initialize new skin...
18:45:16 M: 48279552    INFO: Loading skin file: Pointer.xml
18:45:16 M: 48279552   DEBUG: Load Pointer.xml: 6.69ms (5.29 ms xml load)
18:45:16 M: 48246784   DEBUG: Alloc resources: 49.75ms (7.32 ms skin load, 28.74 ms preload)
18:45:16 M: 48246784    INFO: Loading skin file: DialogVolumeBar.xml
18:45:16 M: 48246784   DEBUG: Load DialogVolumeBar.xml: 5.32ms (3.29 ms xml load)
18:45:16 M: 48238592   DEBUG: Alloc resources: 22.28ms (6.77 ms skin load, 0.16 ms preload)
18:45:16 M: 48238592    INFO: Loading skin file: DialogSeekBar.xml
18:45:16 M: 48238592   DEBUG: Load DialogSeekBar.xml: 20.46ms (11.50 ms xml load)
18:45:16 M: 48201728   DEBUG: Alloc resources: 24.54ms (22.51 ms skin load, 0.27 ms preload)
18:45:16 M: 48201728    INFO: Loading skin file: DialogKaiToast.xml
18:45:16 M: 48201728   DEBUG: Load DialogKaiToast.xml: 9.85ms (8.35 ms xml load)
18:45:16 M: 48201728   DEBUG: Alloc resources: 11.31ms (11.31 ms skin load, 0.00 ms preload)
18:45:16 M: 48201728    INFO: Loading skin file: DialogMuteBug.xml
18:45:16 M: 48201728   DEBUG: Load DialogMuteBug.xml: 1.46ms (0.89 ms xml load)
18:45:16 M: 48201728   DEBUG: Alloc resources: 2.02ms (2.01 ms skin load, 0.00 ms preload)
18:45:16 M: 47804416    INFO: Loading Q:\skin\Project Mayhem III\sounds\sounds.xml
18:45:16 M: 47804416    INFO:   skin loaded...
18:45:17 M: 47247360    INFO: Loading skin file: DialogBusy.xml
18:45:17 M: 47206400   DEBUG: Load DialogBusy.xml: 16.23ms (15.33 ms xml load)
18:45:17 M: 47804416   DEBUG: Activating window ID: 12999
18:45:17 M: 47804416   DEBUG: Checking if window ID 12999 is locked.
18:45:17 M: 47374336    INFO: Loading skin file: Startup.xml
18:45:17 M: 47374336   DEBUG: Load Startup.xml: 13.52ms (9.55 ms xml load)
18:45:17 M: 47374336   DEBUG: Alloc resources: 15.12ms (15.10 ms skin load, 0.01 ms preload)
18:45:17 M: 47374336 WARNING: use dashboard
18:45:17 M: 47058944    INFO: removing tempfiles
18:45:17 M: 47058944  NOTICE: initialize done
18:45:17 M: 47058944  NOTICE: Running the application...
18:45:17 M: 47058944    INFO: CNetwork::LogState - Link: full duplex
18:45:17 M: 46002176    INFO: CNetwork::LogState - Link: 100 mbps
18:45:17 M: 46002176    INFO: CNetwork::LogState - ip:
18:45:17 M: 46002176    INFO: CNetwork::LogState - subnet:
18:45:17 M: 44892160    INFO: CNetwork::LogState - gateway:
18:45:17 M: 44892160    INFO:  - dns: CNetwork::LogState,
18:45:17 M: 44052480   DEBUG: CApplication::OnMessage : Translating ReplaceWindow(Home)
18:45:17 M: 44052480   DEBUG: CApplication::OnMessage : To ReplaceWindow(Home)
18:45:17 M: 44052480   DEBUG: Activating window ID: 10000
18:45:17 M: 44052480   DEBUG: Checking if window ID 10000 is locked.
18:45:18 M: 46784512   DEBUG: Alloc resources: 43.05ms (0.00 ms skin load, 0.46 ms preload)
18:45:19 M: 43507712   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:19 M: 43507712    INFO: CNetwork::LogState - Link: full duplex
18:45:19 M: 43483136    INFO: CNetwork::LogState - Link: 100 mbps
18:45:19 M: 43483136    INFO: CNetwork::LogState - State: dns
18:45:19 M: 43483136   DEBUG: CNetwork::NetworkMessage - Starting network services
18:45:19 M: 43483136    INFO: CNetwork::LogState - State: dhcp
18:45:19 M: 43483136  NOTICE: XBFileZilla: Starting...
18:45:19 M: 43483136    INFO: CNetwork::LogState - ip: 192.168.0.21
18:45:19 M: 43413504  NOTICE: ES: Starting event server
18:45:19 M: 42352640    INFO: CNetwork::LogState - subnet: 255.255.255.0
18:45:19 M: 41152512  NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777
18:45:19 M: 41598976    INFO: CNetwork::LogState - gateway: 192.168.0.1
18:45:19 M: 41598976    INFO: WEATHER: Downloading weather
18:45:19 M: 41598976  NOTICE: UDP: Listening on port 9777
18:45:19 M: 41607168    INFO: 192.168.0.1 - dns: CNetwork::LogState, 0.0.0.0
18:45:19 M: 41607168    INFO: Get URL: http://xoap.weather.com/weather/local/GMXX0154?cc=*&unit=m&dayf=4&prod=xoap&link=xoap&par=1004124588&key=079f24145f208494
18:45:19 M: 41594880    INFO: Get URL: http://feeds.feedburner.com/XboxScene
18:45:19 M: 42356736   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:20 M: 41586688   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:20 M: 41783296   DEBUG: CApplication::OnKey: 270 pressed, action is 3
18:45:20 M: 40529920  NOTICE: XBFileZilla: Started
18:45:20 M: 40919040   DEBUG: CApplication::OnKey: 270 pressed, action is 3
18:45:21 M: 41660416   DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:45:21 M: 41648128   DEBUG: CApplication::OnMessage : Translating ActivateWindow(MyVideos)
18:45:21 M: 41648128   DEBUG: CApplication::OnMessage : To ActivateWindow(MyVideos)
18:45:21 M: 41648128   DEBUG: Activating window ID: 10024
18:45:21 M: 41648128   DEBUG: Checking if window ID 10024 is locked.
18:45:21 M: 45146112    INFO: Attempting to default to:
18:45:21 M: 45101056    INFO: Loading skin file: MyVideo.xml
18:45:21 M: 45117440    INFO: WEATHER: Weather download successful
18:45:21 M: 39800832   DEBUG: Load MyVideo.xml: 155.36ms (25.99 ms xml load)
18:45:21 M: 39825408   DEBUG: Alloc resources: 226.32ms (162.79 ms skin load, 0.88 ms preload)
18:45:21 M: 39825408   DEBUG: CGUIMediaWindow::GetDirectory ()
18:45:21 M: 39825408   DEBUG:   ParentPath = []
18:45:22 M: 39014400   DEBUG: Got rss feed: http://feeds.feedburner.com/XboxScene
18:45:23 M: 39153664   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:23 M: 39129088   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:23 M: 38862848   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:23 M: 39129088   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:23 M: 43331584   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:23 M: 43982848   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:24 M: 43982848   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:24 M: 43982848   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:24 M: 44007424   DEBUG: CApplication::OnKey: 270 pressed, action is 3
18:45:25 M: 44007424   DEBUG: CApplication::OnKey: 270 pressed, action is 3
18:45:25 M: 43982848   DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:45:25 M: 43995136   DEBUG: Clearing cached fileitems [smb://]
18:45:25 M: 44224512   DEBUG: CGUIMediaWindow::GetDirectory (smb://)
18:45:25 M: 44224512   DEBUG:   ParentPath = []
18:45:25 M: 43884544   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://
18:45:27 M: 43724800    INFO: Loading skin file: DialogBusy.xml
18:45:27 M: 43724800   DEBUG: Load DialogBusy.xml: 23.68ms (22.81 ms xml load)
18:45:27 M: 43724800   DEBUG: Alloc resources: 24.26ms (24.26 ms skin load, 0.00 ms preload)
18:45:29 M: 43450368   DEBUG: Saving fileitems [smb://]
18:45:29 M: 43450368   DEBUG:   -- items: 1, sort method: 0, ascending: false
18:45:29 M: 43601920   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:30 M: 43577344   DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:45:30 M: 43589632   DEBUG: Clearing cached fileitems [smb://MSHOME/]
18:45:30 M: 43610112   DEBUG: CGUIMediaWindow::GetDirectory (smb://MSHOME/)
18:45:30 M: 43610112   DEBUG:   ParentPath = [smb://]
18:45:30 M: 43610112   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://MSHOME
18:45:31 M: 43331584   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:31 M: 43307008   DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:45:31 M: 43319296   DEBUG: Clearing cached fileitems [smb://MIGUEL/]
18:45:31 M: 43339776   DEBUG: CGUIMediaWindow::GetDirectory (smb://MIGUEL/)
18:45:31 M: 43339776   DEBUG:   ParentPath = [smb://MSHOME/]
18:45:31 M: 43339776   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://MIGUEL
18:45:31 M: 42795008    INFO: Creating thumb from: smb://MIGUEL/My Music/folder.jpg as: q:\userdata\Thumbnails\Video\e\e53fc4ef.tbn
18:45:31 M: 42164224   DEBUG: Unable to resolve msvcr71.dll div
18:45:31 M: 42164224   DEBUG: Unable to resolve msvcr71.dll ??1type_info@@UAE@XZ
18:45:31 M: 42164224   DEBUG: Unable to resolve msvcr71.dll ?terminate@@YAXXZ
18:45:31 M: 42164224   DEBUG: kernel32.dll fake function DisableThreadLibraryCalls called
18:45:31 M: 42164224 WARNING: Unable to resolve: ImageLib.dll ReleaseImage
18:45:31 M: 42164224   ERROR: Unable to resolve exports from dll Q:\system\ImageLib.dll
18:45:32 M: 42700800   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:32 M: 42676224   DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:45:32 M: 42688512   DEBUG: Clearing cached fileitems [smb://MIGUEL/Movies/]
18:45:32 M: 42708992   DEBUG: CGUIMediaWindow::GetDirectory (smb://MIGUEL/Movies/)
18:45:32 M: 42708992   DEBUG:   ParentPath = [smb://MIGUEL/]
18:45:32 M: 42708992   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://MIGUEL/Movies
18:45:32 M: 42631168   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:33 M: 42606592   DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:45:33 M: 42618880   DEBUG: Clearing cached fileitems [smb://MIGUEL/Movies/HOODWINKED/]
18:45:33 M: 42708992   DEBUG: CGUIMediaWindow::GetDirectory (smb://MIGUEL/Movies/HOODWINKED/)
18:45:33 M: 42708992   DEBUG:   ParentPath = [smb://MIGUEL/Movies/]
18:45:33 M: 42708992   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://MIGUEL/Movies/HOODWINKED
18:45:33 M: 42700800   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:33 M: 42676224   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:33 M: 42676224   DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:45:33 M: 42688512   DEBUG: Clearing cached fileitems [smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/]
18:45:33 M: 42708992   DEBUG: CGUIMediaWindow::GetDirectory (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/)
18:45:33 M: 42708992   DEBUG:   ParentPath = [smb://MIGUEL/Movies/HOODWINKED/]
18:45:33 M: 42708992   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS
18:45:34 M: 42717184   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:34 M: 42692608   DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:45:34 M: 42704896   DEBUG: CPlayerCoreFactor::GetPlayers(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO)
18:45:34 M: 42704896  NOTICE: DVDPlayer: Opening: smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO
18:45:34 M: 42704896 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
18:45:34 M: 42180608  NOTICE: Creating InputStream
18:45:34 M: 41926656    INFO:   msg: libdvdnav: Using dvdnav version 0.2.0cvs from http://dvd.sf.net
18:45:34 M: 41926656    INFO:   msg: libdvdread: Using libdvdcss version 1.2.9 for DVD access
18:45:34 M: 41926656    INFO:   msg: libdvdcss debug:
18:45:34 M: 41926656    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS'
18:45:34 M: 41926656    INFO:   msg:
18:45:34 M: 41926656    INFO:   msg: libdvdcss debug:
18:45:34 M: 41926656    INFO:   msg: using libc for access
18:45:34 M: 41926656    INFO:   msg:
18:45:34 M: 41926656   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS, fd=-1
18:45:34 M: 41926656    INFO: FileSmb->Open: Unable to open file : 'smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS'
                             unix_err:'15' nt_err : 'c00000ba' error : 'NT_STATUS_FILE_IS_A_DIRECTORY'
18:45:34 M: 41926656    INFO:   msg: libdvdcss debug:
18:45:34 M: 41926656    INFO:   msg: cannot open smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS (Is a directory)
18:45:34 M: 41926656    INFO:   msg:
18:45:34 M: 41926656    INFO:   msg: libdvdcss error: failed to open device
18:45:34 M: 41926656    INFO:   msg: libdvdread: Could not open smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS with libdvdcss.
18:45:34 M: 41926656    INFO:   msg: libdvdread: Can't open smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS for reading
18:45:34 M: 41926656    INFO:   msg: libdvdread: Device (null) inaccessible, CSS authentication not available.
18:45:34 M: 41926656    INFO:   msg: libdvdnav: vm: DVD Title:
18:45:34 M: 41926656    INFO:   msg: libdvdnav: Unable to find map file 'Q:\dvdplayer/.dvdnav/.map'
18:45:34 M: 41926656    INFO:   msg: libdvdcss debug:
18:45:34 M: 41926656    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO'
18:45:34 M: 41926656    INFO:   msg:
18:45:34 M: 41926656    INFO:   msg: libdvdcss debug:
18:45:34 M: 41926656    INFO:   msg: using libc for access
18:45:34 M: 41926656    INFO:   msg:
18:45:34 M: 41926656   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO, fd=10000
18:45:34 M: 41926656    INFO:   msg: libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions:
18:45:34 M: 41926656    INFO:   msg:  1
18:45:34 M: 41926656    INFO:   msg:  2
18:45:34 M: 41926656    INFO:   msg:  3
18:45:34 M: 41926656    INFO:   msg:  4
18:45:34 M: 41926656    INFO:   msg:  5
18:45:34 M: 41926656    INFO:   msg:  6
18:45:34 M: 41926656    INFO:   msg:  7
18:45:34 M: 41926656    INFO:   msg:  8
18:45:34 M: 41926656   DEBUG:   msg:
18:45:34 M: 41926656    INFO:   msg: libdvdcss debug:
18:45:34 M: 41926656    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB'
18:45:34 M: 41926656    INFO:   msg:
18:45:34 M: 41926656    INFO:   msg: libdvdcss debug:
18:45:34 M: 41926656    INFO:   msg: using libc for access
18:45:34 M: 41926656    INFO:   msg:
18:45:34 M: 41926656   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB, fd=10001
18:45:34 M: 41926656    INFO:   msg: libdvdcss debug:
18:45:34 M: 41926656    INFO:   msg: cracking title key at block 0
18:45:34 M: 41926656    INFO:   msg:
18:45:34 M: 41926656    INFO:   msg: libdvdcss debug:
18:45:34 M: 41926656    INFO:   msg: read returned 0 (end of device?)
18:45:34 M: 41926656    INFO:   msg:
18:45:34 M: 41926656    INFO:   msg: libdvdcss debug:
18:45:34 M: 41926656    INFO:   msg: end of title reached
18:45:34 M: 41926656    INFO:   msg:
18:45:34 M: 41926656    INFO:   msg: libdvdcss debug:
18:45:34 M: 41926656    INFO:   msg: successful attempts 0/0, scrambled blocks 0/225
18:45:34 M: 41926656    INFO:   msg:
18:45:34 M: 41926656    INFO:   msg: libdvdcss debug:
18:45:34 M: 41926656    INFO:   msg: no scrambled sectors found
18:45:34 M: 41926656    INFO:   msg:
18:45:34 M: 41926656    INFO:   msg: libdvdcss debug:
18:45:34 M: 41926656    INFO:   msg: title key is 00:00:00:00:00
18:45:34 M: 41926656    INFO:   msg:
18:45:34 M: 41926656    INFO:   msg: libdvdcss debug:
18:45:34 M: 41926656    INFO:   msg: unencrypted title
18:45:34 M: 41926656    INFO:   msg:
18:45:34 M: 41926656   DEBUG: CFileSMB::Close closing fd 10001
18:45:34 M: 41926656   DEBUG: CDVDInputStreamNavigator::Open - Setting region mask ff
18:45:34 M: 41926656  NOTICE: DVDPlayer: playing a dvd with menu's
18:45:34 M: 41926656  NOTICE: Creating Demuxer
18:45:35 M: 37273600   DEBUG: dvdnav: Cannot get current position
18:45:35 M: 37273600    INFO:   msg: libdvdcss debug:
18:45:35 M: 37273600    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VTS_02_0.IFO'
18:45:35 M: 37273600    INFO:   msg:
18:45:35 M: 37273600    INFO:   msg: libdvdcss debug:
18:45:35 M: 37273600    INFO:   msg: using libc for access
18:45:35 M: 37273600    INFO:   msg:
18:45:35 M: 37273600   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VTS_02_0.IFO, fd=10001
18:45:35 M: 37273600   DEBUG: DVDNAV_HIGHLIGHT: Highlight button 1
18:45:35 M: 37273600    INFO:   msg: libdvdcss debug:
18:45:35 M: 37273600    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VTS_02_0.VOB'
18:45:35 M: 37273600    INFO:   msg:
18:45:35 M: 37273600    INFO:   msg: libdvdcss debug:
18:45:35 M: 37273600    INFO:   msg: using libc for access
18:45:35 M: 37273600    INFO:   msg:
18:45:35 M: 37273600   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VTS_02_0.VOB, fd=10002
18:45:35 M: 37273600    INFO:   msg: libdvdcss debug:
18:45:35 M: 37273600    INFO:   msg: cracking title key at block 0
18:45:35 M: 37273600    INFO:   msg:
18:45:35 M: 37273600    INFO:   msg: libdvdcss debug:
18:45:35 M: 37273600    INFO:   msg: read returned 0 (end of device?)
18:45:35 M: 37273600    INFO:   msg:
18:45:35 M: 37273600    INFO:   msg: libdvdcss debug:
18:45:35 M: 37273600    INFO:   msg: end of title reached
18:45:35 M: 37273600    INFO:   msg:
18:45:35 M: 37273600    INFO:   msg: libdvdcss debug:
18:45:35 M: 37273600    INFO:   msg: successful attempts 0/0, scrambled blocks 0/204
18:45:35 M: 37273600    INFO:   msg:
18:45:35 M: 37273600    INFO:   msg: libdvdcss debug:
18:45:35 M: 37273600    INFO:   msg: no scrambled sectors found
18:45:35 M: 37273600    INFO:   msg:
18:45:35 M: 37273600    INFO:   msg: libdvdcss debug:
18:45:35 M: 37273600    INFO:   msg: title key is 00:00:00:00:00
18:45:35 M: 37273600    INFO:   msg:
18:45:35 M: 37273600    INFO:   msg: libdvdcss debug:
18:45:35 M: 37273600    INFO:   msg: unencrypted title
18:45:35 M: 37273600    INFO:   msg:
18:45:35 M: 37273600   DEBUG:  - DVDNAV_VTS_CHANGE (HOLDING)
18:45:35 M: 37273600    INFO: ffmpeg: Input #0, mpeg, from 'smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO':
18:45:35 M: 37273600    INFO: ffmpeg:   Duration: N/A, bitrate: N/A
18:45:35 M: 37273600   DEBUG: Playback has started
18:45:35 M: 37273600    INFO: Loading skin file: VideoOverlay.xml
18:45:35 M: 37273600   DEBUG: DVDNAV_VTS_CHANGE
18:45:35 M: 37273600    INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 1
18:45:35 M: 37273600    INFO: CDVDPlayer::Process - eof reading from demuxer
18:45:35 M: 37273600  NOTICE: CDVDPlayer::OnExit()
18:45:35 M: 37273600   DEBUG: Load VideoOverlay.xml: 39.29ms (35.23 ms xml load)
18:45:35 M: 37273600  NOTICE: DVDPlayer: eof, waiting for queues to empty
18:45:35 M: 37273600   DEBUG: Alloc resources: 40.15ms (40.15 ms skin load, 0.01 ms preload)
18:45:35 M: 37273600  NOTICE: CDVDPlayer::OnExit() deleting demuxer
18:45:35 M: 37273600  NOTICE: CDVDPlayer::OnExit() deleting input stream
18:45:35 M: 37265408   DEBUG: CGUIInfoManager::SetCurrentMovie(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO)
18:45:35 M: 37265408   DEBUG: CFileSMB::Close closing fd 10002
18:45:35 M: 37244928   DEBUG: CFileSMB::Close closing fd 10000
18:45:35 M: 37224448   DEBUG: CFileSMB::Close closing fd 10001
18:45:35 M: 37244928   DEBUG: Playback has finished
18:45:35 M: 37789696   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMovie from movie where idFile=2
18:45:35 M: 37789696   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idEpisode from episode where idFile=2
18:45:35 M: 37789696   DEBUG: CVideoDatabase::GetMusicVideoId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMVideo from musicvideo where idFile=2
18:45:35 M: 37789696   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMovie from movie where idFile=2
18:45:35 M: 37789696   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idEpisode from episode where idFile=2
18:45:35 M: 37789696   DEBUG: CVideoDatabase::GetMusicVideoId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMVideo from musicvideo where idFile=2
18:45:35 M: 37801984  NOTICE: CDVDPlayer::CloseFile()
18:45:35 M: 37801984 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
18:45:35 M: 37801984  NOTICE: DVDPlayer: waiting for threads to exit
18:45:35 M: 37801984  NOTICE: DVDPlayer: finished waiting
18:45:36 M: 37822464   DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:45:36 M: 37810176   DEBUG: CPlayerCoreFactor::GetPlayers(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO)
18:45:36 M: 37810176   ERROR: XFILE::CFile::Delete - Error deleting file Z:\xbmc.edl
18:45:36 M: 37810176  NOTICE: DVDPlayer: Opening: smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO
18:45:36 M: 37810176 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
18:45:36 M: 37285888  NOTICE: Creating InputStream
18:45:36 M: 37285888    INFO:   msg: libdvdnav: Using dvdnav version 0.2.0cvs from http://dvd.sf.net
18:45:36 M: 37285888    INFO:   msg: libdvdread: Using libdvdcss version 1.2.9 for DVD access
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS'
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: using libc for access
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS, fd=-1
18:45:36 M: 37285888    INFO: FileSmb->Open: Unable to open file : 'smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS'
                             unix_err:'15' nt_err : 'c00000ba' error : 'NT_STATUS_FILE_IS_A_DIRECTORY'
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: cannot open smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS (Is a directory)
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss error: failed to open device
18:45:36 M: 37285888    INFO:   msg: libdvdread: Could not open smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS with libdvdcss.
18:45:36 M: 37285888    INFO:   msg: libdvdread: Can't open smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS for reading
18:45:36 M: 37285888    INFO:   msg: libdvdread: Device (null) inaccessible, CSS authentication not available.
18:45:36 M: 37285888    INFO:   msg: libdvdnav: vm: DVD Title:
18:45:36 M: 37285888    INFO:   msg: libdvdnav: Unable to find map file 'Q:\dvdplayer/.dvdnav/.map'
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO'
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: using libc for access
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO, fd=10001
18:45:36 M: 37285888    INFO:   msg: libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions:
18:45:36 M: 37285888    INFO:   msg:  1
18:45:36 M: 37285888    INFO:   msg:  2
18:45:36 M: 37285888    INFO:   msg:  3
18:45:36 M: 37285888    INFO:   msg:  4
18:45:36 M: 37285888    INFO:   msg:  5
18:45:36 M: 37285888    INFO:   msg:  6
18:45:36 M: 37285888    INFO:   msg:  7
18:45:36 M: 37285888    INFO:   msg:  8
18:45:36 M: 37285888   DEBUG:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB'
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: using libc for access
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB, fd=10000
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: cracking title key at block 0
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: read returned 0 (end of device?)
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: end of title reached
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: successful attempts 0/0, scrambled blocks 0/225
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: no scrambled sectors found
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: title key is 00:00:00:00:00
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: unencrypted title
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888   DEBUG: CFileSMB::Close closing fd 10000
18:45:36 M: 37285888   DEBUG: CDVDInputStreamNavigator::Open - Setting region mask ff
18:45:36 M: 37285888  NOTICE: DVDPlayer: playing a dvd with menu's
18:45:36 M: 37285888  NOTICE: Creating Demuxer
18:45:36 M: 37285888   DEBUG: dvdnav: Cannot get current position
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VTS_02_0.IFO'
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: using libc for access
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VTS_02_0.IFO, fd=10000
18:45:36 M: 37285888   DEBUG: DVDNAV_HIGHLIGHT: Highlight button 1
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VTS_02_0.VOB'
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: using libc for access
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VTS_02_0.VOB, fd=10002
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: cracking title key at block 0
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: read returned 0 (end of device?)
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: end of title reached
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: successful attempts 0/0, scrambled blocks 0/204
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: no scrambled sectors found
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: title key is 00:00:00:00:00
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:36 M: 37285888    INFO:   msg: unencrypted title
18:45:36 M: 37285888    INFO:   msg:
18:45:36 M: 37285888   DEBUG:  - DVDNAV_VTS_CHANGE (HOLDING)
18:45:36 M: 37285888    INFO: ffmpeg: Input #0, mpeg, from 'smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO':
18:45:36 M: 37285888    INFO: ffmpeg:   Duration: N/A, bitrate: N/A
18:45:36 M: 37285888   DEBUG: Playback has started
18:45:36 M: 37285888    INFO: Loading skin file: VideoOverlay.xml
18:45:36 M: 37285888   DEBUG: DVDNAV_VTS_CHANGE
18:45:36 M: 37285888   DEBUG: Load VideoOverlay.xml: 24.82ms (21.89 ms xml load)
18:45:36 M: 37285888    INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 1
18:45:36 M: 37285888   DEBUG: Alloc resources: 25.69ms (25.69 ms skin load, 0.00 ms preload)
18:45:36 M: 37285888    INFO: CDVDPlayer::Process - eof reading from demuxer
18:45:36 M: 37277696  NOTICE: CDVDPlayer::OnExit()
18:45:36 M: 37277696   DEBUG: CGUIInfoManager::SetCurrentMovie(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO)
18:45:36 M: 37265408  NOTICE: DVDPlayer: eof, waiting for queues to empty
18:45:36 M: 37244928  NOTICE: CDVDPlayer::OnExit() deleting demuxer
18:45:36 M: 37244928  NOTICE: CDVDPlayer::OnExit() deleting input stream
18:45:36 M: 37265408   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMovie from movie where idFile=2
18:45:36 M: 37265408   DEBUG: CFileSMB::Close closing fd 10002
18:45:36 M: 37224448   DEBUG: CFileSMB::Close closing fd 10001
18:45:36 M: 37265408   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idEpisode from episode where idFile=2
18:45:36 M: 37265408   DEBUG: CFileSMB::Close closing fd 10000
18:45:36 M: 37224448   DEBUG: Playback has finished
18:45:36 M: 37789696   DEBUG: CVideoDatabase::GetMusicVideoId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMVideo from musicvideo where idFile=2
18:45:36 M: 37789696   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMovie from movie where idFile=2
18:45:36 M: 37789696   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idEpisode from episode where idFile=2
18:45:36 M: 37789696   DEBUG: CVideoDatabase::GetMusicVideoId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMVideo from musicvideo where idFile=2
18:45:36 M: 37801984  NOTICE: CDVDPlayer::CloseFile()
18:45:36 M: 37801984 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
18:45:36 M: 37801984  NOTICE: DVDPlayer: waiting for threads to exit
18:45:36 M: 37801984  NOTICE: DVDPlayer: finished waiting
18:45:37 M: 37822464   DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:45:37 M: 37810176   DEBUG: CPlayerCoreFactor::GetPlayers(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO)
18:45:37 M: 37810176  NOTICE: DVDPlayer: Opening: smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO
18:45:37 M: 37810176 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
18:45:37 M: 37285888  NOTICE: Creating InputStream
18:45:37 M: 37285888    INFO:   msg: libdvdnav: Using dvdnav version 0.2.0cvs from http://dvd.sf.net
18:45:37 M: 37285888    INFO:   msg: libdvdread: Using libdvdcss version 1.2.9 for DVD access
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS'
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: using libc for access
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS, fd=-1
18:45:37 M: 37285888    INFO: FileSmb->Open: Unable to open file : 'smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS'
                             unix_err:'15' nt_err : 'c00000ba' error : 'NT_STATUS_FILE_IS_A_DIRECTORY'
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: cannot open smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS (Is a directory)
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss error: failed to open device
18:45:37 M: 37285888    INFO:   msg: libdvdread: Could not open smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS with libdvdcss.
18:45:37 M: 37285888    INFO:   msg: libdvdread: Can't open smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS for reading
18:45:37 M: 37285888    INFO:   msg: libdvdread: Device (null) inaccessible, CSS authentication not available.
18:45:37 M: 37285888    INFO:   msg: libdvdnav: vm: DVD Title:
18:45:37 M: 37285888    INFO:   msg: libdvdnav: Unable to find map file 'Q:\dvdplayer/.dvdnav/.map'
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO'
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: using libc for access
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO, fd=10000
18:45:37 M: 37285888    INFO:   msg: libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions:
18:45:37 M: 37285888    INFO:   msg:  1
18:45:37 M: 37285888    INFO:   msg:  2
18:45:37 M: 37285888    INFO:   msg:  3
18:45:37 M: 37285888    INFO:   msg:  4
18:45:37 M: 37285888    INFO:   msg:  5
18:45:37 M: 37285888    INFO:   msg:  6
18:45:37 M: 37285888    INFO:   msg:  7
18:45:37 M: 37285888    INFO:   msg:  8
18:45:37 M: 37285888   DEBUG:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB'
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: using libc for access
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB, fd=10001
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: cracking title key at block 0
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: read returned 0 (end of device?)
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: end of title reached
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: successful attempts 0/0, scrambled blocks 0/225
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: no scrambled sectors found
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: title key is 00:00:00:00:00
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: unencrypted title
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888   DEBUG: CFileSMB::Close closing fd 10001
18:45:37 M: 37285888   DEBUG: CDVDInputStreamNavigator::Open - Setting region mask ff
18:45:37 M: 37285888  NOTICE: DVDPlayer: playing a dvd with menu's
18:45:37 M: 37285888  NOTICE: Creating Demuxer
18:45:37 M: 37285888   DEBUG: dvdnav: Cannot get current position
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VTS_02_0.IFO'
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: using libc for access
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VTS_02_0.IFO, fd=10001
18:45:37 M: 37285888   DEBUG: DVDNAV_HIGHLIGHT: Highlight button 1
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VTS_02_0.VOB'
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: using libc for access
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VTS_02_0.VOB, fd=10002
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: cracking title key at block 0
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: read returned 0 (end of device?)
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: end of title reached
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: successful attempts 0/0, scrambled blocks 0/204
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: no scrambled sectors found
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: title key is 00:00:00:00:00
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:37 M: 37285888    INFO:   msg: unencrypted title
18:45:37 M: 37285888    INFO:   msg:
18:45:37 M: 37285888   DEBUG:  - DVDNAV_VTS_CHANGE (HOLDING)
18:45:37 M: 37285888    INFO: ffmpeg: Input #0, mpeg, from 'smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO':
18:45:37 M: 37285888    INFO: ffmpeg:   Duration: N/A, bitrate: N/A
18:45:37 M: 37285888    INFO: Loading skin file: VideoOverlay.xml
18:45:37 M: 37285888   DEBUG: Playback has started
18:45:37 M: 37285888   DEBUG: Load VideoOverlay.xml: 27.29ms (24.31 ms xml load)
18:45:37 M: 37285888   DEBUG: DVDNAV_VTS_CHANGE
18:45:37 M: 37285888   DEBUG: Alloc resources: 28.19ms (28.19 ms skin load, 0.00 ms preload)
18:45:37 M: 37285888    INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 1
18:45:37 M: 37277696    INFO: CDVDPlayer::Process - eof reading from demuxer
18:45:37 M: 37277696   DEBUG: CGUIInfoManager::SetCurrentMovie(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO)
18:45:37 M: 37244928  NOTICE: CDVDPlayer::OnExit()
18:45:37 M: 37265408  NOTICE: DVDPlayer: eof, waiting for queues to empty
18:45:37 M: 37265408   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMovie from movie where idFile=2
18:45:37 M: 37265408  NOTICE: CDVDPlayer::OnExit() deleting demuxer
18:45:37 M: 37265408   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idEpisode from episode where idFile=2
18:45:37 M: 37265408  NOTICE: CDVDPlayer::OnExit() deleting input stream
18:45:37 M: 37265408   DEBUG: CVideoDatabase::GetMusicVideoId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMVideo from musicvideo where idFile=2
18:45:37 M: 37277696   DEBUG: CFileSMB::Close closing fd 10002
18:45:37 M: 37289984   DEBUG: CFileSMB::Close closing fd 10000
18:45:37 M: 37289984   DEBUG: CFileSMB::Close closing fd 10001
18:45:37 M: 37289984   DEBUG: Playback has finished
18:45:37 M: 37801984   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMovie from movie where idFile=2
18:45:37 M: 37801984   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idEpisode from episode where idFile=2
18:45:37 M: 37801984   DEBUG: CVideoDatabase::GetMusicVideoId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMVideo from musicvideo where idFile=2
18:45:38 M: 37814272  NOTICE: CDVDPlayer::CloseFile()
18:45:38 M: 37814272 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
18:45:38 M: 37814272  NOTICE: DVDPlayer: waiting for threads to exit
18:45:38 M: 37814272  NOTICE: DVDPlayer: finished waiting
18:45:38 M: 37822464   DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:45:38 M: 37810176   DEBUG: CPlayerCoreFactor::GetPlayers(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO)
18:45:38 M: 37810176  NOTICE: DVDPlayer: Opening: smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO
18:45:38 M: 37810176 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
18:45:38 M: 37285888  NOTICE: Creating InputStream
18:45:38 M: 37285888    INFO:   msg: libdvdnav: Using dvdnav version 0.2.0cvs from http://dvd.sf.net
18:45:38 M: 37285888    INFO:   msg: libdvdread: Using libdvdcss version 1.2.9 for DVD access
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS'
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: using libc for access
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS, fd=-1
18:45:38 M: 37285888    INFO: FileSmb->Open: Unable to open file : 'smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS'
                             unix_err:'15' nt_err : 'c00000ba' error : 'NT_STATUS_FILE_IS_A_DIRECTORY'
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: cannot open smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS (Is a directory)
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss error: failed to open device
18:45:38 M: 37285888    INFO:   msg: libdvdread: Could not open smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS with libdvdcss.
18:45:38 M: 37285888    INFO:   msg: libdvdread: Can't open smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS for reading
18:45:38 M: 37285888    INFO:   msg: libdvdread: Device (null) inaccessible, CSS authentication not available.
18:45:38 M: 37285888    INFO:   msg: libdvdnav: vm: DVD Title:
18:45:38 M: 37285888    INFO:   msg: libdvdnav: Unable to find map file 'Q:\dvdplayer/.dvdnav/.map'
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO'
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: using libc for access
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO, fd=10001
18:45:38 M: 37285888    INFO:   msg: libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions:
18:45:38 M: 37285888    INFO:   msg:  1
18:45:38 M: 37285888    INFO:   msg:  2
18:45:38 M: 37285888    INFO:   msg:  3
18:45:38 M: 37285888    INFO:   msg:  4
18:45:38 M: 37285888    INFO:   msg:  5
18:45:38 M: 37285888    INFO:   msg:  6
18:45:38 M: 37285888    INFO:   msg:  7
18:45:38 M: 37285888    INFO:   msg:  8
18:45:38 M: 37285888   DEBUG:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB'
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: using libc for access
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB, fd=10000
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: cracking title key at block 0
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: read returned 0 (end of device?)
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: end of title reached
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: successful attempts 0/0, scrambled blocks 0/225
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: no scrambled sectors found
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: title key is 00:00:00:00:00
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: unencrypted title
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888   DEBUG: CFileSMB::Close closing fd 10000
18:45:38 M: 37285888   DEBUG: CDVDInputStreamNavigator::Open - Setting region mask ff
18:45:38 M: 37285888  NOTICE: DVDPlayer: playing a dvd with menu's
18:45:38 M: 37285888  NOTICE: Creating Demuxer
18:45:38 M: 37285888   DEBUG: dvdnav: Cannot get current position
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VTS_02_0.IFO'
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: using libc for access
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VTS_02_0.IFO, fd=10000
18:45:38 M: 37285888   DEBUG: DVDNAV_HIGHLIGHT: Highlight button 1
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VTS_02_0.VOB'
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: using libc for access
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VTS_02_0.VOB, fd=10002
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: cracking title key at block 0
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: read returned 0 (end of device?)
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: end of title reached
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: successful attempts 0/0, scrambled blocks 0/204
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: no scrambled sectors found
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: title key is 00:00:00:00:00
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: unencrypted title
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888   DEBUG:  - DVDNAV_VTS_CHANGE (HOLDING)
18:45:38 M: 37285888    INFO: ffmpeg: Input #0, mpeg, from 'smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO':
18:45:38 M: 37285888    INFO: ffmpeg:   Duration: N/A, bitrate: N/A
18:45:38 M: 37285888   DEBUG: Playback has started
18:45:38 M: 37285888    INFO: Loading skin file: VideoOverlay.xml
18:45:38 M: 37285888   DEBUG: DVDNAV_VTS_CHANGE
18:45:38 M: 37285888   DEBUG: Load VideoOverlay.xml: 37.43ms (34.48 ms xml load)
18:45:38 M: 37285888    INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 1
18:45:38 M: 37285888   DEBUG: Alloc resources: 38.28ms (38.28 ms skin load, 0.00 ms preload)
18:45:38 M: 37285888    INFO: CDVDPlayer::Process - eof reading from demuxer
18:45:38 M: 37277696  NOTICE: CDVDPlayer::OnExit()
18:45:38 M: 37277696   DEBUG: CGUIInfoManager::SetCurrentMovie(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO)
18:45:38 M: 37244928  NOTICE: DVDPlayer: eof, waiting for queues to empty
18:45:38 M: 37265408  NOTICE: CDVDPlayer::OnExit() deleting demuxer
18:45:38 M: 37224448  NOTICE: CDVDPlayer::OnExit() deleting input stream
18:45:38 M: 37265408   DEBUG: CFileSMB::Close closing fd 10002
18:45:38 M: 37265408   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMovie from movie where idFile=2
18:45:38 M: 37224448   DEBUG: CFileSMB::Close closing fd 10001
18:45:38 M: 37265408   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idEpisode from episode where idFile=2
18:45:38 M: 37265408   DEBUG: CFileSMB::Close closing fd 10000
18:45:38 M: 37265408   DEBUG: CVideoDatabase::GetMusicVideoId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMVideo from musicvideo where idFile=2
18:45:38 M: 37265408   DEBUG: Playback has finished
18:45:38 M: 37789696   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMovie from movie where idFile=2
18:45:38 M: 37789696   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idEpisode from episode where idFile=2
18:45:38 M: 37789696   DEBUG: CVideoDatabase::GetMusicVideoId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMVideo from musicvideo where idFile=2
18:45:38 M: 37801984  NOTICE: CDVDPlayer::CloseFile()
18:45:38 M: 37801984 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
18:45:38 M: 37801984  NOTICE: DVDPlayer: waiting for threads to exit
18:45:38 M: 37801984  NOTICE: DVDPlayer: finished waiting
18:45:38 M: 37822464   DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:45:38 M: 37810176   DEBUG: CPlayerCoreFactor::GetPlayers(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO)
18:45:38 M: 37810176   ERROR: XFILE::CFile::Delete - Error deleting file Z:\xbmc.edl
18:45:38 M: 37810176  NOTICE: DVDPlayer: Opening: smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO
18:45:38 M: 37810176 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
18:45:38 M: 37285888  NOTICE: Creating InputStream
18:45:38 M: 37285888    INFO:   msg: libdvdnav: Using dvdnav version 0.2.0cvs from http://dvd.sf.net
18:45:38 M: 37285888    INFO:   msg: libdvdread: Using libdvdcss version 1.2.9 for DVD access
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS'
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: using libc for access
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS, fd=-1
18:45:38 M: 37285888    INFO: FileSmb->Open: Unable to open file : 'smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS'
                             unix_err:'15' nt_err : 'c00000ba' error : 'NT_STATUS_FILE_IS_A_DIRECTORY'
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: cannot open smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS (Is a directory)
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss error: failed to open device
18:45:38 M: 37285888    INFO:   msg: libdvdread: Could not open smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS with libdvdcss.
18:45:38 M: 37285888    INFO:   msg: libdvdread: Can't open smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS for reading
18:45:38 M: 37285888    INFO:   msg: libdvdread: Device (null) inaccessible, CSS authentication not available.
18:45:38 M: 37285888    INFO:   msg: libdvdnav: vm: DVD Title:
18:45:38 M: 37285888    INFO:   msg: libdvdnav: Unable to find map file 'Q:\dvdplayer/.dvdnav/.map'
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO'
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: using libc for access
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO, fd=10000
18:45:38 M: 37285888    INFO:   msg: libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions:
18:45:38 M: 37285888    INFO:   msg:  1
18:45:38 M: 37285888    INFO:   msg:  2
18:45:38 M: 37285888    INFO:   msg:  3
18:45:38 M: 37285888    INFO:   msg:  4
18:45:38 M: 37285888    INFO:   msg:  5
18:45:38 M: 37285888    INFO:   msg:  6
18:45:38 M: 37285888    INFO:   msg:  7
18:45:38 M: 37285888    INFO:   msg:  8
18:45:38 M: 37285888   DEBUG:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB'
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: using libc for access
18:45:38 M: 37285888    INFO:   msg:
18:45:38 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB, fd=10001
18:45:38 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:38 M: 37285888    INFO:   msg: cracking title key at block 0
18:45:38 M: 37285888    INFO:   msg:
18:45:39 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:39 M: 37285888    INFO:   msg: read returned 0 (end of device?)
18:45:39 M: 37285888    INFO:   msg:
18:45:39 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:39 M: 37285888    INFO:   msg: end of title reached
18:45:39 M: 37285888    INFO:   msg:
18:45:39 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:39 M: 37285888    INFO:   msg: successful attempts 0/0, scrambled blocks 0/225
18:45:39 M: 37285888    INFO:   msg:
18:45:39 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:39 M: 37285888    INFO:   msg: no scrambled sectors found
18:45:39 M: 37285888    INFO:   msg:
18:45:39 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:39 M: 37285888    INFO:   msg: title key is 00:00:00:00:00
18:45:39 M: 37285888    INFO:   msg:
18:45:39 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:39 M: 37285888    INFO:   msg: unencrypted title
18:45:39 M: 37285888    INFO:   msg:
18:45:39 M: 37285888   DEBUG: CFileSMB::Close closing fd 10001
18:45:39 M: 37285888   DEBUG: CDVDInputStreamNavigator::Open - Setting region mask ff
18:45:39 M: 37285888  NOTICE: DVDPlayer: playing a dvd with menu's
18:45:39 M: 37285888  NOTICE: Creating Demuxer
18:45:39 M: 37285888   DEBUG: dvdnav: Cannot get current position
18:45:39 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:39 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VTS_02_0.IFO'
18:45:39 M: 37285888    INFO:   msg:
18:45:39 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:39 M: 37285888    INFO:   msg: using libc for access
18:45:39 M: 37285888    INFO:   msg:
18:45:39 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VTS_02_0.IFO, fd=10001
18:45:39 M: 37285888   DEBUG: DVDNAV_HIGHLIGHT: Highlight button 1
18:45:39 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:39 M: 37285888    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VTS_02_0.VOB'
18:45:39 M: 37285888    INFO:   msg:
18:45:39 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:39 M: 37285888    INFO:   msg: using libc for access
18:45:39 M: 37285888    INFO:   msg:
18:45:39 M: 37285888   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VTS_02_0.VOB, fd=10002
18:45:39 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:39 M: 37285888    INFO:   msg: cracking title key at block 0
18:45:39 M: 37285888    INFO:   msg:
18:45:39 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:39 M: 37285888    INFO:   msg: read returned 0 (end of device?)
18:45:39 M: 37285888    INFO:   msg:
18:45:39 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:39 M: 37285888    INFO:   msg: end of title reached
18:45:39 M: 37285888    INFO:   msg:
18:45:39 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:39 M: 37285888    INFO:   msg: successful attempts 0/0, scrambled blocks 0/204
18:45:39 M: 37285888    INFO:   msg:
18:45:39 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:39 M: 37285888    INFO:   msg: no scrambled sectors found
18:45:39 M: 37285888    INFO:   msg:
18:45:39 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:39 M: 37285888    INFO:   msg: title key is 00:00:00:00:00
18:45:39 M: 37285888    INFO:   msg:
18:45:39 M: 37285888    INFO:   msg: libdvdcss debug:
18:45:39 M: 37285888    INFO:   msg: unencrypted title
18:45:39 M: 37285888    INFO:   msg:
18:45:39 M: 37285888   DEBUG:  - DVDNAV_VTS_CHANGE (HOLDING)
18:45:39 M: 37285888    INFO: ffmpeg: Input #0, mpeg, from 'smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO':
18:45:39 M: 37285888    INFO: ffmpeg:   Duration: N/A, bitrate: N/A
18:45:39 M: 37285888    INFO: Loading skin file: VideoOverlay.xml
18:45:39 M: 37285888   DEBUG: Playback has started
18:45:39 M: 37285888   DEBUG: Load VideoOverlay.xml: 27.90ms (24.93 ms xml load)
18:45:39 M: 37285888   DEBUG: DVDNAV_VTS_CHANGE
18:45:39 M: 37285888   DEBUG: Alloc resources: 28.82ms (28.82 ms skin load, 0.00 ms preload)
18:45:39 M: 37285888    INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 1
18:45:39 M: 37277696    INFO: CDVDPlayer::Process - eof reading from demuxer
18:45:39 M: 37277696   DEBUG: CGUIInfoManager::SetCurrentMovie(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO)
18:45:39 M: 37244928  NOTICE: CDVDPlayer::OnExit()
18:45:39 M: 37265408   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMovie from movie where idFile=2
18:45:39 M: 37265408  NOTICE: DVDPlayer: eof, waiting for queues to empty
18:45:39 M: 37265408   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idEpisode from episode where idFile=2
18:45:39 M: 37265408  NOTICE: CDVDPlayer::OnExit() deleting demuxer
18:45:39 M: 37265408   DEBUG: CVideoDatabase::GetMusicVideoId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMVideo from musicvideo where idFile=2
18:45:39 M: 37277696  NOTICE: CDVDPlayer::OnExit() deleting input stream
18:45:39 M: 37285888   DEBUG: CFileSMB::Close closing fd 10002
18:45:39 M: 37285888   DEBUG: CFileSMB::Close closing fd 10000
18:45:39 M: 37285888   DEBUG: CFileSMB::Close closing fd 10001
18:45:39 M: 37285888   DEBUG: Playback has finished
18:45:39 M: 37797888   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMovie from movie where idFile=2
18:45:39 M: 37797888   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idEpisode from episode where idFile=2
18:45:39 M: 37797888   DEBUG: CVideoDatabase::GetMusicVideoId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMVideo from musicvideo where idFile=2
18:45:39 M: 37810176  NOTICE: CDVDPlayer::CloseFile()
18:45:39 M: 37810176 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
18:45:39 M: 37810176  NOTICE: DVDPlayer: waiting for threads to exit
18:45:39 M: 37810176  NOTICE: DVDPlayer: finished waiting
18:45:40 M: 37818368   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:41 M: 37818368   DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:45:41 M: 37806080   DEBUG: CPlayerCoreFactor::GetPlayers(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB)
18:45:41 M: 37806080  NOTICE: DVDPlayer: Opening: smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB
18:45:41 M: 37806080 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
18:45:41 M: 37281792  NOTICE: Creating InputStream
18:45:41 M: 37281792   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB, fd=10001
18:45:41 M: 37281792  NOTICE: Creating Demuxer
18:45:41 M: 37244928   DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info starting
18:45:41 M: 37249024   DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished
18:45:41 M: 37249024    INFO: ffmpeg: Input #0, mpeg, from 'smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB':
18:45:41 M: 37249024    INFO: ffmpeg:   Duration: N/A, start: 0.280633, bitrate: N/A
18:45:41 M: 37249024    INFO: ffmpeg:     Stream #0.0[0x1e0]: Video: mpeg2video, yuv420p, 720x480 [PAR 32:27 DAR 16:9], 8000 kb/s, 29.97 tb(r)
18:45:41 M: 37249024    INFO: ffmpeg:     Stream #0.1[0x20]: Subtitle: dvdsub
18:45:41 M: 37249024    INFO: ffmpeg:     Stream #0.2[0x21]: Subtitle: dvdsub
18:45:41 M: 37249024    INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles
18:45:41 M: 37249024   DEBUG: CUtil::CacheSubtitles: START
18:45:41 M: 37249024   DEBUG: CUtil::CacheSubtitles: Checking for common subirs...
18:45:41 M: 37249024   DEBUG: CUtil::CacheSubtitles: Done (time: 23 ms)
18:45:41 M: 37249024   DEBUG: CUtil::CacheSubtitles: Searching for subtitles...
18:45:41 M: 37249024   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS
18:45:41 M: 37249024   DEBUG: CUtil::CacheSubtitles: Done (time: 28 ms)
18:45:41 M: 37249024   DEBUG: CUtil::CacheSubtitles: END (total time: 52 ms)
18:45:41 M: 37249024    INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles done
18:45:41 M: 37249024  NOTICE: Opening video stream: 0 source: 256
18:45:41 M: 37249024  NOTICE: Creating video codec with codec id: 2
18:45:41 M: 37249024   DEBUG: FactoryCodec - Video: libmpeg2 - Opening
18:45:41 M: 35876864   DEBUG: FactoryCodec - Video: libmpeg2 - Opened
18:45:41 M: 35876864  NOTICE: Creating video thread
18:45:41 M: 35352576  NOTICE: Opening Subtitle stream: 1 source: 256
18:45:41 M: 35352576   DEBUG: CXBoxRenderManager::PreInit - Selected RGB-Renderer
18:45:41 M: 35352576   DEBUG: FactoryCodec - Overlay: FFmpeg Subtitle Decoder - Opening
18:45:41 M: 35352576  NOTICE: running thread: video_thread
18:45:41 M: 35352576   DEBUG: FactoryCodec - Overlay: FFmpeg Subtitle Decoder - Opened
18:45:41 M: 35352576   DEBUG: Playback has started
18:45:41 M: 35352576    INFO: Loading skin file: VideoOverlay.xml
18:45:41 M: 35323904   DEBUG: CDVDPlayerVideo:: Resync - clock:0.000000, delay:0.000000
18:45:41 M: 34648064   DEBUG: Load VideoOverlay.xml: 25.48ms (21.52 ms xml load)
18:45:41 M: 33603584   DEBUG: Alloc resources: 31.71ms (31.70 ms skin load, 0.01 ms preload)
18:45:41 M: 33566720  NOTICE:  fps: 29.970030, pwidth: 720, pheight: 480, dwidth: 853, dheight: 480
18:45:41 M: 33509376   DEBUG: CDVDPlayerVideo::OutputPicture - change configuration. 720x480. framerate: 29.97
18:45:41 M: 33509376   DEBUG: CGUIInfoManager::SetCurrentMovie(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB)
18:45:41 M: 33488896  NOTICE: Display resolution USER : NTSC 4:3 (4)
18:45:41 M: 32411648   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB), query = select idMovie from movie where idFile=3
18:45:41 M: 31928320   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB), query = select idEpisode from episode where idFile=3
18:45:41 M: 31928320   DEBUG: CVideoDatabase::GetMusicVideoId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB), query = select idMVideo from musicvideo where idFile=3
18:45:42 M: 32473088   DEBUG: Activating window ID: 12005
18:45:42 M: 32473088   DEBUG: Checking if window ID 12005 is locked.
18:45:42 M: 34062336   DEBUG: Setting resolution 4
18:45:42 M: 34799616   DEBUG: We set resolution 4
18:45:42 M: 34246656   DEBUG: Created YV12 texture 0
18:45:42 M: 34246656    INFO: Loading skin file: VideoFullScreen.xml
18:45:42 M: 34246656   DEBUG: Load VideoFullScreen.xml: 19.19ms (17.68 ms xml load)
18:45:42 M: 34246656   DEBUG: Alloc resources: 19.85ms (19.84 ms skin load, 0.01 ms preload)
18:45:42 M: 34246656    INFO: Loading skin file: VideoOSD.xml
18:45:42 M: 34254848   DEBUG: Load VideoOSD.xml: 13.37ms (4.22 ms xml load)
18:45:42 M: 33452032   DEBUG: Alloc resources: 32.20ms (0.01 ms skin load, 1.49 ms preload)
18:45:42 M: 33452032    INFO: Loading skin file: VideoOSDSettings.xml
18:45:42 M: 33452032   DEBUG: Load VideoOSDSettings.xml: 6.39ms (2.16 ms xml load)
18:45:42 M: 32743424   DEBUG: Alloc resources: 31.56ms (0.00 ms skin load, 1.15 ms preload)
18:45:42 M: 32743424    INFO: Loading skin file: VideoOSDSettings.xml
18:45:42 M: 32743424   DEBUG: Load VideoOSDSettings.xml: 6.40ms (2.14 ms xml load)
18:45:42 M: 32743424   DEBUG: Alloc resources: 0.55ms (0.00 ms skin load, 0.19 ms preload)
18:45:42 M: 32710656   DEBUG: CGUIFontTTF::Load Scaled size of font Q:\media\Fonts\Arial.ttf (19.930555): width = 68, height = 28, lineheight = 23
18:45:42 M: 31653888    INFO: Starting async renderer thread
18:45:42 M: 32350208   DEBUG: CDVDPlayerVideo:: Resync - clock:0.000000, delay:16649.135295
18:45:42 M: 32350208  NOTICE:  fps: 29.970030, pwidth: 720, pheight: 480, dwidth: 853, dheight: 480
18:45:42 M: 32350208   DEBUG: CDVDPlayerVideo::OutputPicture - change configuration. 720x480. framerate: 29.97
18:45:42 M: 32350208  NOTICE: Display resolution USER : NTSC 4:3 (4)
18:45:42 M: 32391168  NOTICE: CDVDPlayer::OnExit()
18:45:42 M: 32391168  NOTICE: DVDPlayer: eof, waiting for queues to empty
18:45:42 M: 32415744  NOTICE: DVDPlayer: closing video stream
18:45:42 M: 32415744  NOTICE: Closing video stream
18:45:42 M: 32415744  NOTICE: waiting for video thread to exit
18:45:42 M: 32415744   ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true
18:45:42 M: 32415744  NOTICE: thread end: video_thread
18:45:42 M: 32940032  NOTICE: deleting video codec
18:45:42 M: 36257792  NOTICE: DVDPlayer: closing video stream
18:45:42 M: 36257792  NOTICE: Closing subtitle stream
18:45:42 M: 36257792  NOTICE: CDVDPlayer::OnExit() deleting demuxer
18:45:42 M: 36298752  NOTICE: CDVDPlayer::OnExit() deleting input stream
18:45:42 M: 36298752   DEBUG: CFileSMB::Close closing fd 10001
18:45:42 M: 36298752   DEBUG: Playback has finished
18:45:42 M: 36810752   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB), query = select idMovie from movie where idFile=3
18:45:42 M: 36810752   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB), query = select idEpisode from episode where idFile=3
18:45:42 M: 36810752   DEBUG: CVideoDatabase::GetMusicVideoId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB), query = select idMVideo from musicvideo where idFile=3
18:45:43 M: 36823040   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
18:45:43 M: 38363136   DEBUG: Setting resolution 4
18:45:43 M: 37625856   DEBUG: We set resolution 4
18:45:43 M: 37072896   DEBUG: Created YV12 texture 1
18:45:43 M: 37134336   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
18:45:43 M: 37122048    INFO: Loading skin file: MyVideo.xml
18:45:43 M: 36659200   DEBUG: Load MyVideo.xml: 206.39ms (33.76 ms xml load)
18:45:43 M: 36536320   DEBUG: Alloc resources: 259.47ms (212.68 ms skin load, 0.88 ms preload)
18:45:43 M: 36577280   DEBUG: CGUIMediaWindow::GetDirectory (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/)
18:45:43 M: 36581376   DEBUG:   ParentPath = [smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/]
18:45:43 M: 36581376   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS
18:45:43 M: 35532800  NOTICE: CDVDPlayer::CloseFile()
18:45:43 M: 35532800 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
18:45:43 M: 35532800  NOTICE: DVDPlayer: waiting for threads to exit
18:45:43 M: 35532800  NOTICE: DVDPlayer: finished waiting
18:45:43 M: 35532800  NOTICE: CDVDPlayerVideo::~CDVDPlayerVideo - uninitting video device
18:45:43 M: 37134336   DEBUG: Deleted YV12 texture 0
18:45:43 M: 37687296   DEBUG: Deleted YV12 texture 1
18:45:44 M: 37425152   DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:45:44 M: 37412864   DEBUG: CPlayerCoreFactor::GetPlayers(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB)
18:45:44 M: 37412864   ERROR: XFILE::CFile::Delete - Error deleting file Z:\xbmc.edl
18:45:44 M: 37412864  NOTICE: DVDPlayer: Opening: smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB
18:45:44 M: 37412864 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
18:45:44 M: 36888576  NOTICE: Creating InputStream
18:45:44 M: 36888576   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB, fd=10001
18:45:44 M: 36888576  NOTICE: Creating Demuxer
18:45:44 M: 36851712   DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info starting
18:45:44 M: 36847616   DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished
18:45:44 M: 36847616    INFO: ffmpeg: Input #0, mpeg, from 'smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB':
18:45:44 M: 36847616    INFO: ffmpeg:   Duration: N/A, start: 0.280633, bitrate: N/A
18:45:44 M: 36847616    INFO: ffmpeg:     Stream #0.0[0x1e0]: Video: mpeg2video, yuv420p, 720x480 [PAR 32:27 DAR 16:9], 8000 kb/s, 29.97 tb(r)
18:45:44 M: 36847616    INFO: ffmpeg:     Stream #0.1[0x20]: Subtitle: dvdsub
18:45:44 M: 36847616    INFO: ffmpeg:     Stream #0.2[0x21]: Subtitle: dvdsub
18:45:44 M: 36847616    INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles
18:45:44 M: 36847616   DEBUG: CUtil::CacheSubtitles: START
18:45:44 M: 36847616   DEBUG: CUtil::CacheSubtitles: Checking for common subirs...
18:45:44 M: 36847616   DEBUG: CUtil::CacheSubtitles: Done (time: 22 ms)
18:45:44 M: 36847616   DEBUG: CUtil::CacheSubtitles: Searching for subtitles...
18:45:44 M: 36847616   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS
18:45:44 M: 36847616   DEBUG: CUtil::CacheSubtitles: Done (time: 28 ms)
18:45:44 M: 36847616   DEBUG: CUtil::CacheSubtitles: END (total time: 51 ms)
18:45:44 M: 36847616    INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles done
18:45:44 M: 36847616  NOTICE: Opening video stream: 0 source: 256
18:45:44 M: 36847616  NOTICE: Creating video codec with codec id: 2
18:45:44 M: 36847616   DEBUG: FactoryCodec - Video: libmpeg2 - Opening
18:45:44 M: 35602432   DEBUG: FactoryCodec - Video: libmpeg2 - Opened
18:45:44 M: 35602432  NOTICE: Creating video thread
18:45:44 M: 35078144  NOTICE: Opening Subtitle stream: 1 source: 256
18:45:44 M: 35078144   DEBUG: CXBoxRenderManager::PreInit - Selected RGB-Renderer
18:45:44 M: 35078144   DEBUG: FactoryCodec - Overlay: FFmpeg Subtitle Decoder - Opening
18:45:44 M: 35078144  NOTICE: running thread: video_thread
18:45:44 M: 35078144   DEBUG: FactoryCodec - Overlay: FFmpeg Subtitle Decoder - Opened
18:45:44 M: 35078144   DEBUG: Playback has started
18:45:44 M: 35078144    INFO: Loading skin file: VideoOverlay.xml
18:45:44 M: 35024896   DEBUG: CDVDPlayerVideo:: Resync - clock:0.000000, delay:0.000000
18:45:44 M: 34316288   DEBUG: Load VideoOverlay.xml: 33.63ms (30.47 ms xml load)
18:45:45 M: 33243136   DEBUG: Alloc resources: 43.22ms (43.22 ms skin load, 0.01 ms preload)
18:45:45 M: 33157120  NOTICE:  fps: 29.970030, pwidth: 720, pheight: 480, dwidth: 853, dheight: 480
18:45:45 M: 33112064   DEBUG: CDVDPlayerVideo::OutputPicture - change configuration. 720x480. framerate: 29.97
18:45:45 M: 33132544   DEBUG: CGUIInfoManager::SetCurrentMovie(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB)
18:45:45 M: 32358400  NOTICE: Display resolution USER : NTSC 4:3 (4)
18:45:45 M: 31653888   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB), query = select idMovie from movie where idFile=3
18:45:45 M: 31629312   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB), query = select idEpisode from episode where idFile=3
18:45:45 M: 31629312   DEBUG: CVideoDatabase::GetMusicVideoId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB), query = select idMVideo from musicvideo where idFile=3
18:45:45 M: 32186368   DEBUG: Activating window ID: 12005
18:45:45 M: 32186368   DEBUG: Checking if window ID 12005 is locked.
18:45:45 M: 33918976   DEBUG: Setting resolution 4
18:45:45 M: 34656256   DEBUG: We set resolution 4
18:45:45 M: 34103296   DEBUG: Created YV12 texture 0
18:45:45 M: 34103296    INFO: Loading skin file: VideoFullScreen.xml
18:45:45 M: 34103296   DEBUG: Load VideoFullScreen.xml: 17.20ms (15.68 ms xml load)
18:45:45 M: 34103296   DEBUG: Alloc resources: 17.89ms (17.88 ms skin load, 0.01 ms preload)
18:45:45 M: 34103296    INFO: Loading skin file: VideoOSD.xml
18:45:45 M: 34123776   DEBUG: Load VideoOSD.xml: 11.79ms (3.87 ms xml load)
18:45:45 M: 33320960   DEBUG: Alloc resources: 33.58ms (0.01 ms skin load, 1.45 ms preload)
18:45:45 M: 33320960    INFO: Loading skin file: VideoOSDSettings.xml
18:45:45 M: 33320960   DEBUG: Load VideoOSDSettings.xml: 6.43ms (2.17 ms xml load)
18:45:45 M: 32612352   DEBUG: Alloc resources: 31.68ms (0.00 ms skin load, 0.72 ms preload)
18:45:45 M: 32612352    INFO: Loading skin file: VideoOSDSettings.xml
18:45:45 M: 32612352   DEBUG: Load VideoOSDSettings.xml: 6.48ms (2.17 ms xml load)
18:45:45 M: 32612352   DEBUG: Alloc resources: 0.55ms (0.00 ms skin load, 0.19 ms preload)
18:45:45 M: 32579584   DEBUG: CGUIFontTTF::Load Scaled size of font Q:\media\Fonts\Arial.ttf (19.930555): width = 68, height = 28, lineheight = 23
18:45:45 M: 31547392    INFO: Starting async renderer thread
18:45:45 M: 32235520   DEBUG: CDVDPlayerVideo:: Resync - clock:0.000000, delay:16755.890295
18:45:45 M: 32235520  NOTICE:  fps: 29.970030, pwidth: 720, pheight: 480, dwidth: 853, dheight: 480
18:45:45 M: 32235520   DEBUG: CDVDPlayerVideo::OutputPicture - change configuration. 720x480. framerate: 29.97
18:45:45 M: 32235520  NOTICE: Display resolution USER : NTSC 4:3 (4)
18:45:45 M: 32305152  NOTICE: CDVDPlayer::OnExit()
18:45:45 M: 32305152  NOTICE: DVDPlayer: eof, waiting for queues to empty
18:45:45 M: 32305152  NOTICE: DVDPlayer: closing video stream
18:45:45 M: 32305152  NOTICE: Closing video stream
18:45:45 M: 32305152  NOTICE: waiting for video thread to exit
18:45:45 M: 32305152   ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true
18:45:45 M: 32305152  NOTICE: thread end: video_thread
18:45:45 M: 32829440  NOTICE: deleting video codec
18:45:45 M: 36155392  NOTICE: DVDPlayer: closing video stream
18:45:45 M: 36155392  NOTICE: Closing subtitle stream
18:45:45 M: 36163584  NOTICE: CDVDPlayer::OnExit() deleting demuxer
18:45:45 M: 36204544  NOTICE: CDVDPlayer::OnExit() deleting input stream
18:45:45 M: 36204544   DEBUG: CFileSMB::Close closing fd 10001
18:45:45 M: 36208640   DEBUG: Playback has finished
18:45:46 M: 36720640   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB), query = select idMovie from movie where idFile=3
18:45:46 M: 36720640   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB), query = select idEpisode from episode where idFile=3
18:45:46 M: 36720640   DEBUG: CVideoDatabase::GetMusicVideoId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB), query = select idMVideo from musicvideo where idFile=3
18:45:46 M: 36732928   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
18:45:46 M: 38313984   DEBUG: Setting resolution 4
18:45:46 M: 37576704   DEBUG: We set resolution 4
18:45:46 M: 37023744   DEBUG: Created YV12 texture 1
18:45:46 M: 37097472   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
18:45:46 M: 37085184    INFO: Loading skin file: MyVideo.xml
18:45:46 M: 36663296   DEBUG: Load MyVideo.xml: 203.85ms (31.23 ms xml load)
18:45:46 M: 36536320   DEBUG: Alloc resources: 256.95ms (210.18 ms skin load, 0.88 ms preload)
18:45:46 M: 36556800   DEBUG: CGUIMediaWindow::GetDirectory (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/)
18:45:46 M: 36556800   DEBUG:   ParentPath = [smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/]
18:45:46 M: 36556800   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS
18:45:46 M: 35528704  NOTICE: CDVDPlayer::CloseFile()
18:45:46 M: 35528704 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
18:45:46 M: 35528704  NOTICE: DVDPlayer: waiting for threads to exit
18:45:46 M: 35528704  NOTICE: DVDPlayer: finished waiting
18:45:46 M: 35528704  NOTICE: CDVDPlayerVideo::~CDVDPlayerVideo - uninitting video device
18:45:46 M: 37134336   DEBUG: Deleted YV12 texture 0
18:45:46 M: 37687296   DEBUG: Deleted YV12 texture 1
18:45:47 M: 37429248   DEBUG: CApplication::OnKey: 270 pressed, action is 3
18:45:49 M: 37429248   DEBUG: CApplication::OnKey: 260 pressed, action is 33
18:45:49 M: 37429248   DEBUG: Activating window ID: 10028
18:45:49 M: 37429248   DEBUG: Checking if window ID 10028 is locked.
18:45:49 M: 39153664    INFO: Loading skin file: MyVideoPlaylist.xml
18:45:49 M: 39129088   DEBUG: Load MyVideoPlaylist.xml: 53.27ms (8.53 ms xml load)
18:45:49 M: 39059456   DEBUG: Alloc resources: 67.79ms (56.55 ms skin load, 0.62 ms preload)
18:45:49 M: 39059456   DEBUG: CGUIMediaWindow::GetDirectory (playlistvideo://)
18:45:49 M: 39059456   DEBUG:   ParentPath = []
18:45:50 M: 37765120   DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:45:50 M: 37752832   DEBUG: CPlayerCoreFactor::GetPlayers(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB)
18:45:50 M: 37752832   ERROR: XFILE::CFile::Delete - Error deleting file Z:\xbmc.edl
18:45:50 M: 37752832  NOTICE: DVDPlayer: Opening: smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB
18:45:50 M: 37752832 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
18:45:50 M: 37228544  NOTICE: Creating InputStream
18:45:50 M: 37228544   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB, fd=10001
18:45:50 M: 37228544  NOTICE: Creating Demuxer
18:45:50 M: 37191680   DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info starting
18:45:50 M: 37195776   DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished
18:45:50 M: 37195776    INFO: ffmpeg: Input #0, mpeg, from 'smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB':
18:45:50 M: 37195776    INFO: ffmpeg:   Duration: N/A, start: 0.280633, bitrate: N/A
18:45:50 M: 37195776    INFO: ffmpeg:     Stream #0.0[0x1e0]: Video: mpeg2video, yuv420p, 720x480 [PAR 32:27 DAR 16:9], 8000 kb/s, 29.97 tb(r)
18:45:50 M: 37195776    INFO: ffmpeg:     Stream #0.1[0x20]: Subtitle: dvdsub
18:45:50 M: 37195776    INFO: ffmpeg:     Stream #0.2[0x21]: Subtitle: dvdsub
18:45:50 M: 37195776    INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles
18:45:50 M: 37195776   DEBUG: CUtil::CacheSubtitles: START
18:45:50 M: 37195776   DEBUG: CUtil::CacheSubtitles: Checking for common subirs...
18:45:50 M: 37195776   DEBUG: CUtil::CacheSubtitles: Done (time: 23 ms)
18:45:50 M: 37195776   DEBUG: CUtil::CacheSubtitles: Searching for subtitles...
18:45:50 M: 37195776   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS
18:45:50 M: 37195776   DEBUG: CUtil::CacheSubtitles: Done (time: 27 ms)
18:45:50 M: 37195776   DEBUG: CUtil::CacheSubtitles: END (total time: 50 ms)
18:45:50 M: 37195776    INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles done
18:45:50 M: 37195776  NOTICE: Opening video stream: 0 source: 256
18:45:50 M: 37195776  NOTICE: Creating video codec with codec id: 2
18:45:50 M: 37195776   DEBUG: FactoryCodec - Video: libmpeg2 - Opening
18:45:50 M: 35950592   DEBUG: FactoryCodec - Video: libmpeg2 - Opened
18:45:50 M: 35950592  NOTICE: Creating video thread
18:45:50 M: 35426304  NOTICE: Opening Subtitle stream: 1 source: 256
18:45:50 M: 35426304   DEBUG: CXBoxRenderManager::PreInit - Selected RGB-Renderer
18:45:50 M: 35426304   DEBUG: FactoryCodec - Overlay: FFmpeg Subtitle Decoder - Opening
18:45:50 M: 35426304  NOTICE: running thread: video_thread
18:45:50 M: 35426304   DEBUG: FactoryCodec - Overlay: FFmpeg Subtitle Decoder - Opened
18:45:50 M: 35426304   DEBUG: Playback has started
18:45:50 M: 35426304    INFO: Loading skin file: VideoOverlay.xml
18:45:50 M: 35401728   DEBUG: CDVDPlayerVideo:: Resync - clock:0.000000, delay:0.000000
18:45:50 M: 33660928   DEBUG: Load VideoOverlay.xml: 31.19ms (28.17 ms xml load)
18:45:50 M: 33652736  NOTICE:  fps: 29.970030, pwidth: 720, pheight: 480, dwidth: 853, dheight: 480
18:45:50 M: 33673216   DEBUG: Alloc resources: 40.78ms (40.77 ms skin load, 0.01 ms preload)
18:45:50 M: 33636352   DEBUG: CDVDPlayerVideo::OutputPicture - change configuration. 720x480. framerate: 29.97
18:45:50 M: 33636352  NOTICE: Display resolution USER : NTSC 4:3 (4)
18:45:50 M: 32522240   DEBUG: CGUIInfoManager::SetCurrentMovie(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB)
18:45:51 M: 32473088   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB), query = select idMovie from movie where idFile=3
18:45:51 M: 32022528   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB), query = select idEpisode from episode where idFile=3
18:45:51 M: 31993856   DEBUG: CVideoDatabase::GetMusicVideoId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB), query = select idMVideo from musicvideo where idFile=3
18:45:51 M: 32534528   DEBUG: Activating window ID: 12005
18:45:51 M: 32534528   DEBUG: Checking if window ID 12005 is locked.
18:45:51 M: 33873920   DEBUG: Setting resolution 4
18:45:51 M: 34611200   DEBUG: We set resolution 4
18:45:51 M: 34058240   DEBUG: Created YV12 texture 0
18:45:51 M: 34058240    INFO: Loading skin file: VideoFullScreen.xml
18:45:51 M: 34058240   DEBUG: Load VideoFullScreen.xml: 19.66ms (18.12 ms xml load)
18:45:51 M: 34058240   DEBUG: Alloc resources: 20.34ms (20.33 ms skin load, 0.00 ms preload)
18:45:51 M: 34058240    INFO: Loading skin file: VideoOSD.xml
18:45:51 M: 34058240   DEBUG: Load VideoOSD.xml: 12.09ms (4.24 ms xml load)
18:45:51 M: 33259520   DEBUG: Alloc resources: 33.68ms (0.00 ms skin load, 1.07 ms preload)
18:45:51 M: 33259520    INFO: Loading skin file: VideoOSDSettings.xml
18:45:51 M: 33259520   DEBUG: Load VideoOSDSettings.xml: 6.40ms (2.14 ms xml load)
18:45:51 M: 32587776   DEBUG: Alloc resources: 20.36ms (0.00 ms skin load, 0.66 ms preload)
18:45:51 M: 32587776    INFO: Loading skin file: VideoOSDSettings.xml
18:45:51 M: 32587776   DEBUG: Load VideoOSDSettings.xml: 6.39ms (2.16 ms xml load)
18:45:51 M: 32587776   DEBUG: Alloc resources: 0.50ms (0.00 ms skin load, 0.18 ms preload)
18:45:51 M: 32555008   DEBUG: CGUIFontTTF::Load Scaled size of font Q:\media\Fonts\Arial.ttf (19.930555): width = 68, height = 28, lineheight = 23
18:45:51 M: 31498240    INFO: Starting async renderer thread
18:45:51 M: 32210944   DEBUG: CDVDPlayerVideo:: Resync - clock:0.000000, delay:16758.395295
18:45:51 M: 32210944  NOTICE:  fps: 29.970030, pwidth: 720, pheight: 480, dwidth: 853, dheight: 480
18:45:51 M: 32210944   DEBUG: CDVDPlayerVideo::OutputPicture - change configuration. 720x480. framerate: 29.97
18:45:51 M: 32210944  NOTICE: Display resolution USER : NTSC 4:3 (4)
18:45:51 M: 32284672  NOTICE: CDVDPlayer::OnExit()
18:45:51 M: 32284672  NOTICE: DVDPlayer: eof, waiting for queues to empty
18:45:51 M: 32284672  NOTICE: DVDPlayer: closing video stream
18:45:51 M: 32284672  NOTICE: Closing video stream
18:45:51 M: 32284672  NOTICE: waiting for video thread to exit
18:45:51 M: 32284672   ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true
18:45:51 M: 32284672  NOTICE: thread end: video_thread
18:45:51 M: 32808960  NOTICE: deleting video codec
18:45:51 M: 36134912  NOTICE: DVDPlayer: closing video stream
18:45:51 M: 36134912  NOTICE: Closing subtitle stream
18:45:51 M: 36134912  NOTICE: CDVDPlayer::OnExit() deleting demuxer
18:45:51 M: 36167680  NOTICE: CDVDPlayer::OnExit() deleting input stream
18:45:51 M: 36167680   DEBUG: CFileSMB::Close closing fd 10001
18:45:51 M: 36167680   DEBUG: Playback has finished
18:45:52 M: 36683776   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB), query = select idMovie from movie where idFile=3
18:45:52 M: 36683776   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB), query = select idEpisode from episode where idFile=3
18:45:52 M: 36683776   DEBUG: CVideoDatabase::GetMusicVideoId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB), query = select idMVideo from musicvideo where idFile=3
18:45:52 M: 36696064   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
18:45:52 M: 38203392   DEBUG: Setting resolution 4
18:45:52 M: 37466112   DEBUG: We set resolution 4
18:45:52 M: 36913152   DEBUG: Created YV12 texture 1
18:45:52 M: 36970496   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
18:45:52 M: 36958208    INFO: Loading skin file: MyVideoPlaylist.xml
18:45:52 M: 36896768   DEBUG: Load MyVideoPlaylist.xml: 97.06ms (33.58 ms xml load)
18:45:52 M: 36835328   DEBUG: Alloc resources: 126.09ms (100.36 ms skin load, 0.62 ms preload)
18:45:52 M: 36855808   DEBUG: CGUIMediaWindow::GetDirectory (playlistvideo://)
18:45:52 M: 36855808   DEBUG:   ParentPath = [playlistvideo://]
18:45:52 M: 36438016  NOTICE: CDVDPlayer::CloseFile()
18:45:52 M: 36438016 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
18:45:52 M: 36438016  NOTICE: DVDPlayer: waiting for threads to exit
18:45:52 M: 36438016  NOTICE: DVDPlayer: finished waiting
18:45:52 M: 36438016  NOTICE: CDVDPlayerVideo::~CDVDPlayerVideo - uninitting video device
18:45:52 M: 38563840   DEBUG: Deleted YV12 texture 0
18:45:52 M: 39116800   DEBUG: Deleted YV12 texture 1
18:45:52 M: 39116800   DEBUG: CGUIMediaWindow::GetDirectory (playlistvideo://)
18:45:52 M: 39116800   DEBUG:   ParentPath = [playlistvideo://]
18:45:53 M: 37806080   DEBUG: CApplication::OnKey: 260 pressed, action is 33
18:45:53 M: 37806080   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
18:45:53 M: 39120896   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
18:45:53 M: 39108608    INFO: Loading skin file: MyVideo.xml
18:45:53 M: 38686720   DEBUG: Load MyVideo.xml: 181.06ms (18.31 ms xml load)
18:45:53 M: 38551552   DEBUG: Alloc resources: 221.79ms (187.27 ms skin load, 0.97 ms preload)
18:45:53 M: 38596608   DEBUG: CGUIMediaWindow::GetDirectory (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/)
18:45:53 M: 38596608   DEBUG:   ParentPath = [smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/]
18:45:53 M: 38596608   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS
18:45:54 M: 37408768   DEBUG: CApplication::OnKey: 261 pressed, action is 117
18:45:54 M: 37408768   DEBUG: CPlayerCoreFactor::GetPlayers(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO)
18:45:55 M: 37408768   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idEpisode from episode where idFile=2
18:45:55 M: 37408768   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMovie from movie where idFile=2
18:45:55 M: 37408768   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idEpisode from episode where idFile=2
18:45:55 M: 37408768    INFO: Loading skin file: DialogContextMenu.xml
18:45:55 M: 37408768   DEBUG: Load DialogContextMenu.xml: 19.87ms (18.10 ms xml load)
18:45:55 M: 37388288   DEBUG: Alloc resources: 13.54ms (0.00 ms skin load, 0.42 ms preload)
18:45:55 M: 37298176   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:45:55 M: 37273600   DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:45:56 M: 37396480   DEBUG: CPlayerCoreFactor::GetPlayers(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO)
18:45:56 M: 37396480    INFO: Loading skin file: DialogContextMenu.xml
18:45:56 M: 37396480   DEBUG: Load DialogContextMenu.xml: 2.82ms (1.14 ms xml load)
18:45:56 M: 37376000   DEBUG: Alloc resources: 0.89ms (0.00 ms skin load, 0.24 ms preload)
18:45:56 M: 37298176   DEBUG: CApplication::OnKey: 256 pressed, action is 7
18:45:56 M: 37396480   ERROR: XFILE::CFile::Delete - Error deleting file Z:\xbmc.edl
18:45:56 M: 37396480  NOTICE: DVDPlayer: Opening: smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO
18:45:56 M: 37396480 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
18:45:56 M: 36872192  NOTICE: Creating InputStream
18:45:56 M: 36872192    INFO:   msg: libdvdnav: Using dvdnav version 0.2.0cvs from http://dvd.sf.net
18:45:56 M: 36872192    INFO:   msg: libdvdread: Using libdvdcss version 1.2.9 for DVD access
18:45:56 M: 36872192    INFO:   msg: libdvdcss debug:
18:45:56 M: 36872192    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS'
18:45:56 M: 36872192    INFO:   msg:
18:45:56 M: 36872192    INFO:   msg: libdvdcss debug:
18:45:56 M: 36872192    INFO:   msg: using libc for access
18:45:56 M: 36872192    INFO:   msg:
18:45:56 M: 36872192   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS, fd=-1
18:45:56 M: 36872192    INFO: FileSmb->Open: Unable to open file : 'smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS'
                             unix_err:'15' nt_err : 'c00000ba' error : 'NT_STATUS_FILE_IS_A_DIRECTORY'
18:45:56 M: 36872192    INFO:   msg: libdvdcss debug:
18:45:56 M: 36872192    INFO:   msg: cannot open smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS (Is a directory)
18:45:56 M: 36872192    INFO:   msg:
18:45:56 M: 36872192    INFO:   msg: libdvdcss error: failed to open device
18:45:56 M: 36872192    INFO:   msg: libdvdread: Could not open smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS with libdvdcss.
18:45:56 M: 36872192    INFO:   msg: libdvdread: Can't open smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS for reading
18:45:56 M: 36872192    INFO:   msg: libdvdread: Device (null) inaccessible, CSS authentication not available.
18:45:56 M: 36872192    INFO:   msg: libdvdnav: vm: DVD Title:
18:45:56 M: 36872192    INFO:   msg: libdvdnav: Unable to find map file 'Q:\dvdplayer/.dvdnav/.map'
18:45:56 M: 36872192    INFO:   msg: libdvdcss debug:
18:45:56 M: 36872192    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO'
18:45:56 M: 36872192    INFO:   msg:
18:45:56 M: 36872192    INFO:   msg: libdvdcss debug:
18:45:56 M: 36872192    INFO:   msg: using libc for access
18:45:56 M: 36872192    INFO:   msg:
18:45:56 M: 36872192   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO, fd=10001
18:45:56 M: 36868096    INFO:   msg: libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions:
18:45:56 M: 36868096    INFO:   msg:  1
18:45:56 M: 36868096    INFO:   msg:  2
18:45:56 M: 36868096    INFO:   msg:  3
18:45:56 M: 36868096    INFO:   msg:  4
18:45:56 M: 36868096    INFO:   msg:  5
18:45:56 M: 36868096    INFO:   msg:  6
18:45:56 M: 36868096    INFO:   msg:  7
18:45:56 M: 36868096    INFO:   msg:  8
18:45:56 M: 36868096   DEBUG:   msg:
18:45:56 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:56 M: 36868096    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB'
18:45:56 M: 36868096    INFO:   msg:
18:45:56 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:56 M: 36868096    INFO:   msg: using libc for access
18:45:56 M: 36868096    INFO:   msg:
18:45:56 M: 36868096   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.VOB, fd=10000
18:45:56 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:56 M: 36868096    INFO:   msg: cracking title key at block 0
18:45:56 M: 36868096    INFO:   msg:
18:45:57 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:57 M: 36868096    INFO:   msg: read returned 0 (end of device?)
18:45:57 M: 36868096    INFO:   msg:
18:45:57 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:57 M: 36868096    INFO:   msg: end of title reached
18:45:57 M: 36868096    INFO:   msg:
18:45:57 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:57 M: 36868096    INFO:   msg: successful attempts 0/0, scrambled blocks 0/225
18:45:57 M: 36868096    INFO:   msg:
18:45:57 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:57 M: 36868096    INFO:   msg: no scrambled sectors found
18:45:57 M: 36868096    INFO:   msg:
18:45:57 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:57 M: 36868096    INFO:   msg: title key is 00:00:00:00:00
18:45:57 M: 36868096    INFO:   msg:
18:45:57 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:57 M: 36868096    INFO:   msg: unencrypted title
18:45:57 M: 36868096    INFO:   msg:
18:45:57 M: 36868096   DEBUG: CFileSMB::Close closing fd 10000
18:45:57 M: 36868096   DEBUG: CDVDInputStreamNavigator::Open - Setting region mask ff
18:45:57 M: 36868096  NOTICE: DVDPlayer: playing a dvd with menu's
18:45:57 M: 36868096  NOTICE: Creating Demuxer
18:45:57 M: 36868096   DEBUG: dvdnav: Cannot get current position
18:45:57 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:57 M: 36868096    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VTS_02_0.IFO'
18:45:57 M: 36868096    INFO:   msg:
18:45:57 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:57 M: 36868096    INFO:   msg: using libc for access
18:45:57 M: 36868096    INFO:   msg:
18:45:57 M: 36868096   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VTS_02_0.IFO, fd=10000
18:45:57 M: 36868096   DEBUG: DVDNAV_HIGHLIGHT: Highlight button 1
18:45:57 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:57 M: 36868096    INFO:   msg: opening target `smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VTS_02_0.VOB'
18:45:57 M: 36868096    INFO:   msg:
18:45:57 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:57 M: 36868096    INFO:   msg: using libc for access
18:45:57 M: 36868096    INFO:   msg:
18:45:57 M: 36868096   DEBUG: CFileSMB::Open - opened Movies/HOODWINKED/VIDEO_TS/VTS_02_0.VOB, fd=10002
18:45:57 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:57 M: 36868096    INFO:   msg: cracking title key at block 0
18:45:57 M: 36868096    INFO:   msg:
18:45:57 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:57 M: 36868096    INFO:   msg: read returned 0 (end of device?)
18:45:57 M: 36868096    INFO:   msg:
18:45:57 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:57 M: 36868096    INFO:   msg: end of title reached
18:45:57 M: 36868096    INFO:   msg:
18:45:57 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:57 M: 36868096    INFO:   msg: successful attempts 0/0, scrambled blocks 0/204
18:45:57 M: 36868096    INFO:   msg:
18:45:57 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:57 M: 36868096    INFO:   msg: no scrambled sectors found
18:45:57 M: 36868096    INFO:   msg:
18:45:57 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:57 M: 36868096    INFO:   msg: title key is 00:00:00:00:00
18:45:57 M: 36868096    INFO:   msg:
18:45:57 M: 36868096    INFO:   msg: libdvdcss debug:
18:45:57 M: 36868096    INFO:   msg: unencrypted title
18:45:57 M: 36868096    INFO:   msg:
18:45:57 M: 36868096   DEBUG:  - DVDNAV_VTS_CHANGE (HOLDING)
18:45:57 M: 36868096    INFO: ffmpeg: Input #0, mpeg, from 'smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO':
18:45:57 M: 36868096    INFO: ffmpeg:   Duration: N/A, bitrate: N/A
18:45:57 M: 36868096    INFO: Loading skin file: VideoOverlay.xml
18:45:57 M: 36868096   DEBUG: Playback has started
18:45:57 M: 36868096   DEBUG: Load VideoOverlay.xml: 23.36ms (20.26 ms xml load)
18:45:57 M: 36868096   DEBUG: DVDNAV_VTS_CHANGE
18:45:57 M: 36868096   DEBUG: Alloc resources: 24.36ms (24.36 ms skin load, 0.00 ms preload)
18:45:57 M: 36868096    INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 1
18:45:57 M: 36868096    INFO: CDVDPlayer::Process - eof reading from demuxer
18:45:57 M: 36859904   DEBUG: CGUIInfoManager::SetCurrentMovie(smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO)
18:45:57 M: 36827136  NOTICE: CDVDPlayer::OnExit()
18:45:57 M: 36843520  NOTICE: DVDPlayer: eof, waiting for queues to empty
18:45:57 M: 36843520   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMovie from movie where idFile=2
18:45:57 M: 36802560  NOTICE: CDVDPlayer::OnExit() deleting demuxer
18:45:57 M: 36810752  NOTICE: CDVDPlayer::OnExit() deleting input stream
18:45:57 M: 36843520   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idEpisode from episode where idFile=2
18:45:57 M: 36843520   DEBUG: CFileSMB::Close closing fd 10002
18:45:57 M: 36794368   DEBUG: CFileSMB::Close closing fd 10001
18:45:57 M: 36843520   DEBUG: CVideoDatabase::GetMusicVideoId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMVideo from musicvideo where idFile=2
18:45:57 M: 36843520   DEBUG: CFileSMB::Close closing fd 10000
18:45:57 M: 36794368   DEBUG: Playback has finished
18:45:57 M: 37371904   DEBUG: CVideoDatabase::GetMovieId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMovie from movie where idFile=2
18:45:57 M: 37371904   DEBUG: CVideoDatabase::GetEpisodeId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idEpisode from episode where idFile=2
18:45:57 M: 37371904   DEBUG: CVideoDatabase::GetMusicVideoId (smb://MIGUEL/Movies/HOODWINKED/VIDEO_TS/VIDEO_TS.IFO), query = select idMVideo from musicvideo where idFile=2
18:45:57 M: 37384192  NOTICE: CDVDPlayer::CloseFile()
18:45:57 M: 37384192 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
18:45:57 M: 37384192  NOTICE: DVDPlayer: waiting for threads to exit
18:45:57 M: 37384192  NOTICE: DVDPlayer: finished waiting
18:46:00 M: 37404672   DEBUG: CApplication::OnKey: 257 pressed, action is 9
18:46:00 M: 37523456   DEBUG: CGUIMediaWindow::GetDirectory (smb://MIGUEL/Movies/HOODWINKED/)
18:46:00 M: 37523456   DEBUG:   ParentPath = [smb://MIGUEL/Movies/]
18:46:00 M: 37523456   DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://MIGUEL/Movies/HOODWINKED
18:46:01 M: 37404672   DEBUG: CApplication::OnKey: 275 pressed, action is 10
18:46:01 M: 37396480   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
18:46:01 M: 39157760   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
18:46:01 M: 39157760    INFO: Loading skin file: Home.xml
18:46:01 M: 39043072   DEBUG: Load Home.xml: 128.14ms (47.84 ms xml load)
18:46:01 M: 38768640   DEBUG: Alloc resources: 164.90ms (133.40 ms skin load, 1.20 ms preload)
18:46:02 M: 34762752   DEBUG: SECTION:UnloadDelayed(DLL: Q:\system\ImageLib.dll)
18:46:03 M: 35393536   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:46:03 M: 34623488   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:46:03 M: 35368960   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:46:04 M: 35278848   DEBUG: CApplication::OnKey: 271 pressed, action is 4
18:46:07 M: 35209216   DEBUG: CApplication::OnKey: 257 pressed, action is 9
18:46:08 M: 35209216   DEBUG: CApplication::OnKey: 275 pressed, action is 10
18:46:22 M: 34930688   DEBUG: SECTION:UnloadDelayed(DLL: Q:\system\players\dvdplayer\libmpeg2.dll)
18:46:22 M: 34930688   DEBUG: Q:\system\players\dvdplayer\libmpeg2.dll (base 01490000): Detected memory leaks: 1 leaks
18:46:22 M: 34930688   DEBUG: leak caller address  14a8c3a, size       56, counter    1
18:46:22 M: 34930688   DEBUG: libmpeg2.dll: Total bytes leaked: 56
18:46:27 M: 35057664   DEBUG: SECTION:UnloadDelayed(DLL: Q:\system\players\dvdplayer\libdvdnav.dll)
18:46:27 M: 35057664   DEBUG: Q:\system\players\dvdplayer\libdvdcss-2.dll (base 01480000): Detected memory leaks: 1 leaks
18:46:27 M: 35057664   DEBUG: leak caller address  148772d, size       60, counter    1
18:46:27 M: 35057664   DEBUG: libdvdcss-2.dll: Total bytes leaked: 60
18:46:27 M: 35115008   DEBUG: Q:\system\players\dvdplayer\libdvdnav.dll (base 01450000): Detected memory leaks: 115 leaks
18:46:27 M: 35115008   DEBUG: leak caller address  145e15a, size       96, counter    6
18:46:27 M: 35115008   DEBUG: leak caller address  145e209, size       24, counter    6
18:46:27 M: 35115008   DEBUG: leak caller address  145e28b, size       48, counter    6
18:46:27 M: 35115008   DEBUG: leak caller address  145e353, size       72, counter    6
18:46:27 M: 35115008   DEBUG: leak caller address  145f01f, size    22680, counter   90
18:46:27 M: 35115008   DEBUG: leak caller address  147150d, size       60, counter    1
18:46:27 M: 35115008   DEBUG: libdvdnav.dll: Total bytes leaked: 22980
18:46:27 M: 35115008   DEBUG: Q:\system\players\dvdplayer\libdvdnav.dll: Detected 12 unfreed critical sections
18:46:27 M: 35311616   DEBUG: SECTION:UnloadDelayed(DLL: Q:\system\players\dvdplayer\avutil-49.dll)
18:46:28 M: 35311616   DEBUG: SECTION:UnloadDelayed(DLL: Q:\system\players\dvdplayer\avcodec-51.dll)
18:46:28 M: 35311616   DEBUG: SECTION:UnloadDelayed(DLL: Q:\system\players\dvdplayer\avformat-52.dll)