Project

General

Profile

Bug #214 ยป xbmc.log

XBMC Log - EFORCE, 22/08/2012 07:38 PM

 
21:30:15 M: 55599104 NOTICE: -----------------------------------------------------------------------
21:30:15 M: 55578624 NOTICE: Starting XBMC4Xbox. Built on Jul 25 2012 (SVN:31195, compiler 1310)
21:30:15 M: 55578624 NOTICE: special://xbmc/ is mapped to: Q:\
21:30:15 M: 55578624 NOTICE: special://masterprofile/ is mapped to: q:\UserData
21:30:15 M: 55578624 NOTICE: special://home/ is mapped to: Q:\
21:30:15 M: 55578624 NOTICE: special://temp/ is mapped to: Z:\
21:30:15 M: 55578624 NOTICE: The executable running is: E:\Apps\XBMC\default.xbe
21:30:15 M: 55578624 NOTICE: Log File is located: Q:\xbmc.log
21:30:15 M: 55578624 NOTICE: -----------------------------------------------------------------------
21:30:15 M: 55578624 NOTICE: Unmapped drive T
21:30:15 M: 55578624 NOTICE: Mapping drive T to Harddisk0\Partition1\Apps\XBMC\UserData
21:30:15 M: 55578624 NOTICE: Setup DirectX
21:30:15 M: 55554048 NOTICE: Mapping drive C to Harddisk0\Partition2
21:30:15 M: 55554048 NOTICE: Mapping drive E to Harddisk0\Partition1
21:30:15 M: 55554048 NOTICE: Unmapped drive D
21:30:15 M: 55554048 NOTICE: Mapping drive D to Cdrom0
21:30:19 M: 55554048 NOTICE: map extended drive F:
21:30:19 M: 55554048 NOTICE: Mapping drive F to Harddisk0\Partition6
21:30:19 M: 55554048 NOTICE: Mapping drive X to Harddisk0\Partition3
21:30:19 M: 55554048 NOTICE: Mapping drive Y to Harddisk0\Partition4
21:30:19 M: 55554048 NOTICE: Unmapped drive Z
21:30:19 M: 55554048 NOTICE: Mapping drive Z to Harddisk0\Partition5
21:30:19 M: 55549952 NOTICE: load settings...
21:30:19 M: 55549952 NOTICE: Mapping drive P to Harddisk0\Partition1\Apps\XBMC\UserData
21:30:19 M: 55549952 NOTICE: special://profile/ is mapped to: q:\UserData
21:30:19 M: 55549952 NOTICE: loading special://masterprofile/guisettings.xml
21:30:19 M: 55341056 NOTICE: Getting hardware information now...
21:30:19 M: 55341056 NOTICE: Checking resolution 10
21:30:19 M: 55341056 NOTICE: Setting autoresolution mode 1
21:30:19 M: 55341056 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
21:30:19 M: 55320576 NOTICE: Loaded playercorefactory configuration
21:30:19 M: 55320576 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
21:30:19 M: 55320576 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
21:30:19 M: 55320576 NOTICE: No advancedsettings.xml to load (special://masterprofile/advancedsettings.xml)
21:30:19 M: 55320576 NOTICE: Default Video Player: dvdplayer
21:30:19 M: 55320576 NOTICE: Default Audio Player: paplayer
21:30:19 M: 55320576 NOTICE: Enabled debug logging due to GUI setting
21:30:19 M: 55320576 NOTICE: Per AV pack settings are off
21:30:19 M: 55500800 NOTICE: q:\UserData\sources.xml
21:30:19 M: 55500800 DEBUG: Setting <default> source to : Games
21:30:19 M: 55500800 DEBUG: Setting <default> source to : VideoNAS
21:30:19 M: 55500800 INFO: Checking skinpath existence, and existence of keymap.xml:Q:\skin...
21:30:19 M: 55500800 DEBUG: We set resolution 1
21:30:19 M: 46993408 INFO: load language info file:special://xbmc/language/Dutch/langinfo.xml
21:30:19 M: 46993408 INFO: load keyboard layout configuration info file: Q:\language\Dutch\keyboardmap.xml
21:30:19 M: 46993408 INFO: unable to load Q:\language\Dutch\keyboardmap.xml: Failed to open file at line 0
21:30:19 M: 46469120 INFO: load language file:special://xbmc/language/Dutch/strings.xml
21:30:19 M: 46235648 INFO: load keymapping
21:30:19 M: 46235648 INFO: Loading special://xbmc/system/Keymap.xml
21:30:19 M: 46084096 DEBUG: CButtonTranslator::Load - no userdata Keymap.xml found, skipping
21:30:19 M: 46088192 INFO: Checking skin version of: Confluence
21:30:19 M: 46088192 INFO: Skin version is: 2.11 (2.110000)
21:30:19 M: 46088192 INFO: GUI format 1280x720 720p 16:9
21:30:19 M: 46088192 INFO: install unhandled exception filter
21:30:19 M: 46088192 INFO: creating subdirectories
21:30:19 M: 46088192 INFO: userdata folder: q:\UserData
21:30:19 M: 46088192 INFO: recording folder:
21:30:19 M: 46088192 INFO: screenshots folder:
21:30:19 M: 46088192 INFO: thumbnails folder: q:\UserData\Thumbnails
21:30:20 M: 46088192 DEBUG: CNetwork::SetupNetwork - Setting up network...
21:30:20 M: 46088192 NOTICE: Network: Using dashboard IP settings
21:30:20 M: 45760512 NOTICE: Checking the Date!
21:30:20 M: 45760512 INFO: Current Date is: 9-8-2012
21:30:20 M: 45760512 NOTICE: start dvd mediatype detection
21:30:20 M: 45694976 NOTICE: initializing playlistplayer
21:30:20 M: 45694976 DEBUG: Compiled with libcdio Version 0.72
21:30:20 M: 45694976 NOTICE: DONE initializing playlistplayer
21:30:20 M: 45694976 INFO: lcd not used
21:30:20 M: 45682688 NOTICE: load default skin:[Confluence]
21:30:20 M: 45682688 INFO: load skin from:Q:\skin\Confluence
21:30:20 M: 45682688 INFO: delete old skin...
21:30:20 M: 45682688 DEBUG: ------ Window Deinit (Pointer.xml) ------
21:30:20 M: 45682688 DEBUG: ------ Window Deinit (DialogMuteBug.xml) ------
21:30:20 M: 45682688 INFO: Default 4:3 resolution directory is Q:\skin\Confluence\720p
21:30:20 M: 45682688 INFO: Default 16:9 resolution directory is Q:\skin\Confluence\720p
21:30:20 M: 45682688 INFO: Skin version is: 2.11
21:30:20 M: 45682688 INFO: Loading skin includes from Q:\skin\Confluence\720p\includes.xml
21:30:20 M: 43118592 INFO: load fonts for skin...
21:30:20 M: 43114496 INFO: Loading colors from Q:\skin\Confluence\colors\Transperancy.xml
21:30:20 M: 43114496 INFO: Loading fonts from Q:\skin\Confluence\720p\Font.xml
21:30:20 M: 41709568 INFO: load new skin...
21:30:20 M: 41709568 INFO: Skin version is: 2.11 (2.110000)
21:30:20 M: 41709568 INFO: Loading skin file: Home.xml
21:30:21 M: 41160704 INFO: Loading user windows, path Q:\skin\Confluence\720p
21:30:21 M: 41160704 INFO: Loading skin file: Q:\skin\Confluence\720p\custom_DiscDialog_1113.xml
21:30:21 M: 41160704 INFO: Loading skin file: Q:\skin\Confluence\720p\custom_SkinSetting_1111.xml
21:30:21 M: 40951808 INFO: Loading user windows, path Q:\skin\Confluence\720p
21:30:21 M: 40931328 INFO: Loading skin file: Q:\skin\Confluence\720p\custom_DiscDialog_1113.xml
21:30:21 M: 41132032 INFO: Loading skin file: Q:\skin\Confluence\720p\custom_SkinSetting_1111.xml
21:30:21 M: 40947712 INFO: Loading user windows, path Q:\skin\Confluence\720p
21:30:21 M: 40927232 INFO: Loading skin file: Q:\skin\Confluence\720p\custom_DiscDialog_1113.xml
21:30:21 M: 41152512 INFO: Loading skin file: Q:\skin\Confluence\720p\custom_SkinSetting_1111.xml
21:30:21 M: 41148416 DEBUG: Load Skin XML: 365.54ms
21:30:21 M: 41148416 INFO: initialize new skin...
21:30:21 M: 41148416 INFO: Loading skin file: Pointer.xml
21:30:21 M: 41115648 INFO: Loading skin file: DialogVolumeBar.xml
21:30:21 M: 41107456 INFO: Loading skin file: DialogSeekBar.xml
21:30:21 M: 41099264 INFO: Loading skin file: DialogKaiToast.xml
21:30:21 M: 41099264 INFO: Loading skin file: DialogMuteBug.xml
21:30:21 M: 40701952 INFO: Loading special://home/skin/Confluence/sounds/sounds.xml
21:30:21 M: 40701952 INFO: skin loaded...
21:30:21 M: 39817216 DEBUG: kernel32.dll fake function DisableThreadLibraryCalls called
21:30:21 M: 39804928 INFO: Loading skin file: DialogBusy.xml
21:30:21 M: 40341504 DEBUG: Activating window ID: 12999
21:30:21 M: 40341504 DEBUG: Checking if window ID 12999 is locked.
21:30:21 M: 40341504 DEBUG: ------ Window Init (Startup.xml) ------
21:30:21 M: 40341504 INFO: Loading skin file: Startup.xml
21:30:21 M: 40361984 INFO: removing tempfiles
21:30:21 M: 40361984 NOTICE: initialize done
21:30:21 M: 40361984 NOTICE: Running the application...
21:30:21 M: 40361984 DEBUG: CApplication::OnMessage : Translating SetFocus(10)
21:30:21 M: 40361984 DEBUG: CApplication::OnMessage : To SetFocus(10)
21:30:21 M: 40361984 DEBUG: XBPython::Process - no system autoexec.py (Q:\scripts\autoexec.py) found, skipping
21:30:21 M: 40361984 DEBUG: CApplication::OnMessage : Translating ReplaceWindow(Home)
21:30:21 M: 40361984 DEBUG: CApplication::OnMessage : To ReplaceWindow(Home)
21:30:21 M: 40361984 DEBUG: Activating window ID: 10000
21:30:21 M: 40361984 DEBUG: Checking if window ID 10000 is locked.
21:30:21 M: 40361984 DEBUG: ------ Window Deinit (Startup.xml) ------
21:30:21 M: 40361984 DEBUG: ------ Window Init (Home.xml) ------
21:30:21 M: 37662720 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 4 times.
21:30:21 M: 32681984 WARNING: CApplication::OnMessage : Translating SetFocus(9000)
21:30:21 M: 32681984 DEBUG: CApplication::OnMessage : To SetFocus(9000)
21:30:22 M: 33234944 DEBUG: CNetwork::NetworkUp - Network service is up
21:30:22 M: 33234944 INFO: CNetwork::LogState - Link: full duplex
21:30:22 M: 33234944 INFO: CNetwork::LogState - Link: 100 mbps
21:30:22 M: 33234944 INFO: CNetwork::LogState - State: dns
21:30:22 M: 33234944 INFO: CNetwork::LogState - State: dhcp
21:30:22 M: 33234944 INFO: CNetwork::LogState - ip: 192.168.1.154
21:30:22 M: 33234944 INFO: CNetwork::LogState - subnet: 255.255.255.0
21:30:22 M: 33234944 INFO: CNetwork::LogState - gateway: 192.168.1.1
21:30:22 M: 33234944 INFO: CNetwork::LogState - dns: 192.168.1.1, 0.0.0.0
21:30:22 M: 33234944 DEBUG: CNetwork::NetworkMessage - Starting network services
21:30:22 M: 33234944 NOTICE: XBFileZilla: Starting...
21:30:22 M: 33169408 DEBUG: CLastfmScrobbler: Clearing session.
21:30:22 M: 33157120 DEBUG: CLibrefmScrobbler: Clearing session.
21:30:22 M: 32632832 INFO: WEATHER: Downloading weather
21:30:22 M: 32632832 DEBUG: FileCurl::Open(D02DE9DC) http://xml.weather.com/weather/local/NLXX0353?cc=*&unit=m&dayf=4&prod=xoap&link=xoap&par=1004124588&key=079f24145f208494
21:30:22 M: 32583680 INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://xml.weather.com
21:30:22 M: 31715328 NOTICE: XBFileZilla: Started
21:30:22 M: 31715328 INFO: WEATHER: Weather download successful
21:30:24 M: 32186368 DEBUG: CApplication::OnKey: 167 pressed, action is 4
21:30:24 M: 31834112 WARNING: old getenv from python.lib called, library check needed
21:30:24 M: 29204480 DEBUG: CApplication::OnKey: 11 pressed, action is 7
21:30:24 M: 29192192 DEBUG: CApplication::OnMessage : Translating ActivateWindow(VideoLibrary,MovieTitles,return)
21:30:24 M: 29192192 DEBUG: CApplication::OnMessage : To ActivateWindow(VideoLibrary,MovieTitles,return)
21:30:24 M: 29192192 DEBUG: Activating window ID: 10025
21:30:24 M: 29192192 DEBUG: Checking if window ID 10024 is locked.
21:30:24 M: 29192192 DEBUG: ------ Window Deinit (Home.xml) ------
21:30:25 M: 33001472 INFO: Attempting to return to: MovieTitles
21:30:25 M: 32989184 DEBUG: ------ Window Init (MyVideoNav.xml) ------
21:30:25 M: 32989184 INFO: Loading skin file: MyVideoNav.xml
21:30:25 M: 30609408 DEBUG: CGUIMediaWindow::GetDirectory (videodb://1/2/)
21:30:25 M: 30609408 DEBUG: ParentPath = [videodb://1/2/]
21:30:25 M: 30609408 DEBUG: CVideoDatabase::GetSetsNav query: select sets.idSet,sets.strSet,count(1),count(files.playCount) from sets join setlinkmovie on sets.idSet=setlinkmovie.idSet join movie on setlinkmovie.idMovie=movie.idMovie join files on files.idFile=movie.idFile group by sets.idSet
21:30:25 M: 30609408 DEBUG: CVideoDatabase::GetMoviesByWhere query: select * from movieview where movieview.idmovie NOT in (select idmovie from setlinkmovie)
21:30:25 M: 30617600 DEBUG: Time for actual SQL query = 31
21:30:25 M: 30609408 DEBUG: Time to retrieve movies from dataset = 89
21:30:25 M: 30629888 DEBUG: CFileItemList::Sort, sorting took 0 millis
21:30:25 M: 30629888 DEBUG: Saving fileitems [videodb://1/2/]
21:30:25 M: 30629888 DEBUG: -- items: 34, sort method: 25, ascending: true
21:30:26 M: 30105600 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 1 times.
21:30:26 M: 21573632 WARNING: CApplication::OnMessage : Translating SetFocus(50)
21:30:26 M: 21573632 DEBUG: CApplication::OnMessage : To SetFocus(50)
21:30:26 M: 21831680 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 8 times.
21:30:26 M: 20766720 WARNING: XFILE::CSMBDirectory::OpenDir - Using authentication url smb://CUBESTATION/Video/Films/Als%20Je%20Verliefd%20Wordt%20%282012%29
21:30:28 M: 26284032 DEBUG: CApplication::OnKey: 169 pressed, action is 1
21:30:28 M: 26267648 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 1 times.
21:30:28 M: 26030080 WARNING: CApplication::OnKey: 169 pressed, action is 1
21:30:28 M: 26009600 WARNING: old getenv from python.lib called, library check needed
21:30:29 M: 25833472 DEBUG: CApplication::OnKey: 169 pressed, action is 1
21:30:29 M: 25812992 WARNING: old getenv from python.lib called, library check needed
21:30:29 M: 25714688 DEBUG: CApplication::OnKey: 169 pressed, action is 1
21:30:29 M: 25698304 WARNING: old getenv from python.lib called, library check needed
21:30:30 M: 25595904 DEBUG: CApplication::OnKey: 169 pressed, action is 1
21:30:30 M: 25575424 WARNING: old getenv from python.lib called, library check needed
21:30:31 M: 25559040 DEBUG: CApplication::OnKey: 169 pressed, action is 1
21:30:31 M: 25808896 WARNING: old getenv from python.lib called, library check needed
21:30:32 M: 25948160 DEBUG: CApplication::OnKey: 169 pressed, action is 1
21:30:32 M: 25948160 WARNING: old getenv from python.lib called, library check needed
21:30:32 M: 25927680 DEBUG: CApplication::OnKey: 169 pressed, action is 1
21:30:32 M: 25907200 WARNING: old getenv from python.lib called, library check needed
21:30:32 M: 25808896 DEBUG: XFILE::CSMBDirectory::OpenDir - Using authentication url smb://CUBESTATION/Video/Films/THE%20FRONTIER%20BOYS%20%282012%29/VIDEO%5fTS
21:30:33 M: 25812992 DEBUG: XFILE::CSMBDirectory::OpenDir - Using authentication url smb://CUBESTATION/Video/Films/Lizzie%20%282012%29
21:30:33 M: 25710592 WARNING: old getenv from python.lib called, library check needed
21:30:33 M: 24264704 DEBUG: CApplication::OnKey: 169 pressed, action is 1
21:30:33 M: 24162304 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 1 times.
21:30:33 M: 22077440 WARNING: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://xml.weather.com (easy=00DDE010, multi=008E2CB0)
21:30:34 M: 22859776 DEBUG: CApplication::OnKey: 169 pressed, action is 1
21:30:34 M: 22798336 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 1 times.
21:30:38 M: 30400512 WARNING: CApplication::OnKey: 169 pressed, action is 1
21:30:38 M: 30326784 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 2 times.
21:30:40 M: 28209152 WARNING: CApplication::OnKey: 11 pressed, action is 7
21:30:41 M: 28196864 DEBUG: CPlayerCoreFactory::GetPlayers(smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VIDEO_TS.IFO)
21:30:41 M: 28196864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: un-named
21:30:41 M: 28196864 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: un-named
21:30:41 M: 28196864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
21:30:41 M: 28196864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/rtmp/mms/udp
21:30:41 M: 28196864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
21:30:41 M: 28196864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
21:30:41 M: 28196864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
21:30:41 M: 28196864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
21:30:41 M: 28196864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdfile
21:30:41 M: 28196864 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: dvdfile
21:30:41 M: 28196864 DEBUG: CPlayerSelectionRule::GetPlayers: adding player: DVDPlayer (1) for rule: dvdfile
21:30:41 M: 28196864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
21:30:41 M: 28196864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: ogv/flv/mov
21:30:41 M: 28196864 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
21:30:41 M: 28196864 DEBUG: CPlayerCoreFactory::GetPlayers: matched 1 rules with players
21:30:41 M: 28196864 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
21:30:41 M: 28196864 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
21:30:41 M: 28196864 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
21:30:41 M: 28196864 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
21:30:41 M: 28196864 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: MPlayer (2)
21:30:41 M: 28196864 DEBUG: CPlayerCoreFactory::GetPlayers: added 2 players
21:30:41 M: 28196864 NOTICE: DVDPlayer: Opening: smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VIDEO_TS.IFO
21:30:41 M: 28196864 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
21:30:41 M: 27672576 NOTICE: Creating InputStream
21:30:41 M: 27295744 DEBUG: GetModuleHandleA('libgcc_s_dw2-1.dll') failed
Previous line repeats 1 times.
21:30:41 M: 27295744 DEBUG: msg: libdvdnav: Using dvdnav version 4.1.3
21:30:41 M: 27295744 INFO: msg: libdvdread: Using libdvdcss version 1.2.10 for DVD access
21:30:41 M: 27295744 DEBUG: libdvdcss debug:
21:30:41 M: 27295744 INFO: msg: opening target `smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS'
21:30:41 M: 27295744 DEBUG: msg:
21:30:41 M: 27295744 DEBUG: libdvdcss debug:
21:30:41 M: 27295744 DEBUG: using libc for access
21:30:41 M: 27295744 DEBUG: msg:
21:30:41 M: 27295744 DEBUG: CFileSMB::Open - opened Video/Films/The Odds (2011)/VIDEO_TS, fd=-1
21:30:41 M: 27295744 INFO: FileSmb->Open: Unable to open file : 'smb://CUBESTATION/Video/Films/The%20Odds%20%282011%29/VIDEO%5fTS'
unix_err:'15' nt_err : 'c00000ba' error : 'NT_STATUS_FILE_IS_A_DIRECTORY'
21:30:41 M: 27295744 DEBUG: libdvdcss debug:
21:30:41 M: 27295744 INFO: msg: cannot open smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS (Is a directory)
21:30:41 M: 27295744 DEBUG: msg:
21:30:41 M: 27295744 INFO: msg: libdvdcss error: failed to open device
21:30:41 M: 27295744 INFO: msg: libdvdread: Could not open smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS with libdvdcss.
21:30:41 M: 27295744 INFO: msg: libdvdread: Can't open smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS for reading
21:30:41 M: 27295744 INFO: msg: libdvdread: Device (null) inaccessible, CSS authentication not available.
21:30:41 M: 27295744 INFO: msg: libdvdnav: vm: DVD Title:
21:30:41 M: 27295744 DEBUG: libdvdnav: Unable to find home directory
21:30:41 M: 27295744 DEBUG: libdvdcss debug:
21:30:41 M: 27295744 INFO: msg: opening target `smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VIDEO_TS.IFO'
21:30:41 M: 27295744 DEBUG: msg:
21:30:41 M: 27295744 DEBUG: libdvdcss debug:
21:30:41 M: 27295744 DEBUG: using libc for access
21:30:41 M: 27295744 DEBUG: msg:
21:30:41 M: 27295744 DEBUG: CFileSMB::Open - opened Video/Films/The Odds (2011)/VIDEO_TS/VIDEO_TS.IFO, fd=10000
21:30:41 M: 27295744 INFO: msg: libdvdnav: DVD disk reports itself with Region mask 0x00400000. Regions:
21:30:41 M: 27295744 INFO: msg: 1
21:30:41 M: 27295744 INFO: msg: 2
21:30:41 M: 27295744 INFO: msg: 3
21:30:41 M: 27295744 INFO: msg: 4
21:30:41 M: 27295744 INFO: msg: 5
21:30:41 M: 27295744 INFO: msg: 6
21:30:41 M: 27295744 INFO: msg: 8
21:30:41 M: 27295744 DEBUG: msg:
21:30:41 M: 27295744 DEBUG: libdvdcss debug:
21:30:41 M: 27295744 INFO: msg: opening target `smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VIDEO_TS.VOB'
21:30:41 M: 27295744 DEBUG: msg:
21:30:41 M: 27295744 DEBUG: libdvdcss debug:
21:30:41 M: 27295744 DEBUG: using libc for access
21:30:41 M: 27295744 DEBUG: msg:
21:30:41 M: 27295744 DEBUG: CFileSMB::Open - opened Video/Films/The Odds (2011)/VIDEO_TS/VIDEO_TS.VOB, fd=10001
21:30:41 M: 27295744 DEBUG: libdvdcss debug:
21:30:41 M: 27295744 INFO: msg: cracking title key at block 0
21:30:41 M: 27295744 DEBUG: msg:
21:30:41 M: 27295744 DEBUG: libdvdcss debug:
21:30:41 M: 27295744 DEBUG: read returned 0 (end of device?)
21:30:41 M: 27295744 DEBUG: msg:
21:30:41 M: 27295744 DEBUG: libdvdcss debug:
21:30:41 M: 27295744 DEBUG: end of title reached
21:30:41 M: 27295744 DEBUG: msg:
21:30:41 M: 27295744 DEBUG: libdvdcss debug:
21:30:41 M: 27295744 INFO: msg: successful attempts 0/0, scrambled blocks 0/29
21:30:41 M: 27295744 DEBUG: msg:
21:30:41 M: 27295744 DEBUG: libdvdcss debug:
21:30:41 M: 27295744 DEBUG: no scrambled sectors found
21:30:41 M: 27295744 DEBUG: msg:
21:30:41 M: 27295744 DEBUG: libdvdcss debug:
21:30:41 M: 27295744 INFO: msg: title key is 00:00:00:00:00
21:30:41 M: 27295744 DEBUG: msg:
21:30:41 M: 27295744 DEBUG: libdvdcss debug:
21:30:41 M: 27295744 DEBUG: unencrypted title
21:30:41 M: 27295744 DEBUG: msg:
21:30:41 M: 27295744 DEBUG: CFileSMB::Close closing fd 10001
21:30:41 M: 27295744 DEBUG: CDVDInputStreamNavigator::Open - Setting region mask bf
21:30:41 M: 27295744 NOTICE: DVDPlayer: playing a dvd with menu's
21:30:41 M: 27295744 NOTICE: Creating Demuxer
21:30:41 M: 26988544 DEBUG: GetModuleHandleA('libgcc_s_dw2-1.dll') failed
Previous line repeats 2 times.
21:30:42 M: 21458944 DEBUG: msg: libdvdnav: Language 'nl' not found, using 'en' instead
21:30:42 M: 21458944 DEBUG: libdvdnav: Menu Languages available:
21:30:42 M: 21458944 INFO: msg: en
21:30:42 M: 21458944 DEBUG: msg:
21:30:42 M: 21458944 INFO: msg: libdvdnav: Language 'nl' not found, using 'en' instead
21:30:42 M: 21458944 DEBUG: libdvdnav: Menu Languages available:
21:30:42 M: 21458944 INFO: msg: en
21:30:42 M: 21458944 DEBUG: msg:
21:30:42 M: 21458944 DEBUG: libdvdcss debug:
21:30:42 M: 21458944 INFO: msg: opening target `smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VTS_01_0.IFO'
21:30:42 M: 21458944 DEBUG: msg:
21:30:42 M: 21458944 DEBUG: libdvdcss debug:
21:30:42 M: 21458944 DEBUG: using libc for access
21:30:42 M: 21458944 DEBUG: msg:
21:30:42 M: 21458944 DEBUG: CFileSMB::Open - opened Video/Films/The Odds (2011)/VIDEO_TS/VTS_01_0.IFO, fd=10001
21:30:42 M: 21458944 INFO: msg: libdvdnav: Language 'nl' not found, using 'en' instead
21:30:42 M: 21458944 DEBUG: libdvdnav: Menu Languages available:
21:30:42 M: 21458944 INFO: msg: en
21:30:42 M: 21458944 DEBUG: msg:
21:30:42 M: 21458944 INFO: msg: libdvdnav: Language 'nl' not found, using 'en' instead
21:30:42 M: 21458944 DEBUG: libdvdnav: Menu Languages available:
21:30:42 M: 21458944 INFO: msg: en
21:30:42 M: 21458944 DEBUG: msg:
21:30:42 M: 21458944 DEBUG: DVDNAV_HIGHLIGHT: Highlight button 1
21:30:42 M: 21458944 DEBUG: libdvdcss debug:
21:30:42 M: 21458944 INFO: msg: opening target `smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VTS_01_1.VOB'
21:30:42 M: 21458944 DEBUG: msg:
21:30:42 M: 21458944 DEBUG: libdvdcss debug:
21:30:42 M: 21458944 DEBUG: using libc for access
21:30:42 M: 21458944 DEBUG: msg:
21:30:42 M: 21458944 DEBUG: CFileSMB::Open - opened Video/Films/The Odds (2011)/VIDEO_TS/VTS_01_1.VOB, fd=10002
21:30:42 M: 21458944 DEBUG: libdvdcss debug:
21:30:42 M: 21458944 INFO: msg: cracking title key at block 0
21:30:42 M: 21458944 DEBUG: msg:
21:30:42 M: 18055168 DEBUG: ------ Window Init (DialogBusy.xml) ------
21:30:42 M: 18055168 INFO: Loading skin file: DialogBusy.xml
21:30:44 M: 18305024 DEBUG: libdvdcss debug:
21:30:44 M: 18305024 DEBUG: end of title reached
21:30:44 M: 18305024 DEBUG: msg:
21:30:44 M: 18305024 DEBUG: libdvdcss debug:
21:30:44 M: 18305024 INFO: msg: successful attempts 0/0, scrambled blocks 0/2000
21:30:44 M: 18305024 DEBUG: msg:
21:30:44 M: 18305024 DEBUG: libdvdcss debug:
21:30:44 M: 18305024 DEBUG: no scrambled sectors found
21:30:44 M: 18305024 DEBUG: msg:
21:30:44 M: 18305024 DEBUG: libdvdcss debug:
21:30:44 M: 18305024 INFO: msg: title key is 00:00:00:00:00
21:30:44 M: 18305024 DEBUG: msg:
21:30:44 M: 18305024 DEBUG: libdvdcss debug:
21:30:44 M: 18305024 DEBUG: unencrypted title
21:30:44 M: 18305024 DEBUG: msg:
21:30:44 M: 18305024 DEBUG: - DVDNAV_VTS_CHANGE (HOLDING)
21:30:44 M: 18305024 DEBUG: CDVDDemuxFFmpeg::Open - avformat_find_stream_info starting
21:30:44 M: 18305024 DEBUG: ffmpeg[170]: [mpeg] Estimating duration from bitrate, this may be inaccurate
21:30:44 M: 18305024 WARNING: could not find codec parameters for smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VIDEO_TS.IFO
21:30:44 M: 18305024 DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished
21:30:44 M: 18305024 INFO: ffmpeg[170]: Input #0, mpeg, from 'smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VIDEO_TS.IFO':
21:30:44 M: 18305024 INFO: ffmpeg[170]: Duration: N/A, bitrate: N/A
21:30:44 M: 18296832 DEBUG: SECTION:Section LCODE loaded count:1 size:11812
21:30:44 M: 18296832 NOTICE: Opening audio stream: 0 source: 512
21:30:44 M: 18296832 DEBUG: CApplication::OnPlayBackStarted - Playback has started
21:30:44 M: 18296832 DEBUG: CDVDPlayer::SetCaching - caching state 2
21:30:44 M: 18296832 WARNING: CDVDMessageQueue(audio)::Put MSGQ_NOT_INITIALIZED
21:30:44 M: 18296832 WARNING: CDVDMessageQueue(video)::Put MSGQ_NOT_INITIALIZED
21:30:44 M: 21798912 DEBUG: CGUIInfoManager::SetCurrentMovie(smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VIDEO_TS.IFO)
21:30:44 M: 21811200 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
21:30:45 M: 22085632 DEBUG: CDVDPlayer::SetCaching - caching state 0
21:30:45 M: 22085632 DEBUG: DVDNAV_VTS_CHANGE
21:30:45 M: 22085632 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
21:30:45 M: 22048768 DEBUG: CDVDInputStreamNavigator::ProcessBlock - Cell change: Title 1, Chapter 1
21:30:45 M: 22048768 DEBUG: CDVDInputStreamNavigator::ProcessBlock - At position 0% inside the feature
21:30:45 M: 22048768 DEBUG: DVDNAV_CELL_CHANGE
21:30:45 M: 22048768 INFO: CDVDInputStreamNavigator::ProcessBlock - none or invalid audio stream selected, defaulting to first
21:30:45 M: 22048768 DEBUG: CDVDInputStreamNavigator::SetActiveAudioStream - id: 0, stream: 0
21:30:45 M: 21020672 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:0 TO:72155 DIFF:72155
21:30:46 M: 21020672 DEBUG: CDVDDemuxFFmpeg::Open - avformat_find_stream_info starting
21:30:46 M: 20938752 DEBUG: Unable to resolve: kernel32.dll InitializeConditionVariable
21:30:46 M: 20938752 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'InitializeConditionVariable') => 00000000
21:30:46 M: 20938752 DEBUG: Unable to resolve: kernel32.dll WakeAllConditionVariable
21:30:46 M: 20938752 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'WakeAllConditionVariable') => 00000000
21:30:46 M: 20938752 DEBUG: Unable to resolve: kernel32.dll WakeConditionVariable
21:30:46 M: 20938752 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'WakeConditionVariable') => 00000000
21:30:46 M: 20938752 DEBUG: Unable to resolve: kernel32.dll SleepConditionVariableCS
21:30:46 M: 20938752 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'SleepConditionVariableCS') => 00000000
21:30:46 M: 19861504 DEBUG: Unable to resolve: kernel32.dll InitializeConditionVariable
21:30:46 M: 19861504 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'InitializeConditionVariable') => 00000000
21:30:46 M: 19861504 DEBUG: Unable to resolve: kernel32.dll WakeAllConditionVariable
21:30:46 M: 19861504 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'WakeAllConditionVariable') => 00000000
21:30:46 M: 19861504 DEBUG: Unable to resolve: kernel32.dll WakeConditionVariable
21:30:46 M: 19861504 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'WakeConditionVariable') => 00000000
21:30:46 M: 19861504 DEBUG: Unable to resolve: kernel32.dll SleepConditionVariableCS
21:30:46 M: 19861504 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'SleepConditionVariableCS') => 00000000
21:30:46 M: 18571264 DEBUG: ffmpeg[170]: [mpeg] max_analyze_duration 500000 reached at 520000
21:30:46 M: 19619840 DEBUG: ffmpeg[170]: [mpeg] Estimating duration from bitrate, this may be inaccurate
21:30:46 M: 19668992 DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished
21:30:46 M: 19668992 INFO: ffmpeg[170]: Input #0, mpeg, from 'smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VIDEO_TS.IFO':
21:30:46 M: 19668992 INFO: ffmpeg[170]: Duration: N/A, start: 0.072156, bitrate: 9200 kb/s
21:30:46 M: 19668992 INFO: ffmpeg[170]: Stream #0:0[0x1e0]: Video: mpeg2video, yuv420p, 720x576 [SAR 64:45 DAR 16:9], 9008 kb/s, 25 fps, 25 tbr, 90k tbn, 50 tbc
21:30:46 M: 19668992 INFO: ffmpeg[170]: Stream #0:1[0x80]: Audio: ac3, 48000 Hz, stereo, s16, 192 kb/s
21:30:46 M: 19664896 NOTICE: Opening video stream: 0 source: 256
21:30:46 M: 19664896 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
21:30:46 M: 19664896 NOTICE: Creating video codec with codec id: 2
21:30:46 M: 19664896 DEBUG: FactoryCodec - Video: libmpeg2 - Opening
21:30:46 M: 18276352 DEBUG: FactoryCodec - Video: libmpeg2 - Opened
21:30:46 M: 18276352 NOTICE: Creating video thread
21:30:46 M: 17752064 DEBUG: CDVDPlayer::SetCaching - caching state 2
21:30:46 M: 17752064 DEBUG: CXBoxRenderManager::PreInit - Selected RGB-Renderer
21:30:46 M: 17747968 WARNING: CDVDMessageQueue(audio)::Put MSGQ_NOT_INITIALIZED
21:30:46 M: 17747968 NOTICE: Opening audio stream: 1 source: 256
21:30:46 M: 17747968 NOTICE: Finding audio codec for: 86019
21:30:46 M: 17170432 DEBUG: FactoryCodec - Audio: PassthroughFFmpeg - Opening
21:30:46 M: 17170432 INFO: CDVDAudioCodecPassthroughFFmpeg::SetupMuxer - Trying to setup spdif muxer
21:30:46 M: 17145856 INFO: CDVDAudioCodecPassthroughFFmpeg::SetupMuxer - spdif muxer ready
21:30:46 M: 17149952 DEBUG: FactoryCodec - Audio: PassthroughFFmpeg - Opened
21:30:46 M: 17149952 NOTICE: running thread: video_thread
21:30:46 M: 17149952 NOTICE: Creating audio thread
21:30:46 M: 17149952 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(0.000000, 1)
21:30:46 M: 16568320 NOTICE: running thread: CDVDPlayerAudio::Process()
21:30:46 M: 16519168 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
21:30:46 M: 16482304 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(0.000000, 0)
21:30:46 M: 16068608 NOTICE: Creating audio device with codec id: 86019, channels: 2, sample rate: 48000, pass-through
21:30:46 M: 15572992 DEBUG: CDVDPlayer::HandleMessages - player started 1
21:30:46 M: 14974976 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
21:30:46 M: 14954496 NOTICE: fps: 25.000000, pwidth: 720, pheight: 576, dwidth: 1024, dheight: 576
21:30:46 M: 14893056 DEBUG: CDVDPlayerVideo::OutputPicture - change configuration. 720x576. framerate: 25.00
21:30:46 M: 14893056 NOTICE: Display resolution AUTO : 720p 16:9 (1)
21:30:46 M: 13389824 DEBUG: Created YV12 texture 0
21:30:46 M: 12648448 DEBUG: Created YV12 texture 1
21:30:47 M: 12451840 DEBUG: Activating window ID: 12005
21:30:47 M: 12423168 DEBUG: CDVDPlayer::HandleMessages - player started 2
21:30:47 M: 12423168 DEBUG: Checking if window ID 12005 is locked.
21:30:47 M: 12451840 DEBUG: CDVDPlayer::SetCaching - caching state 3
21:30:47 M: 12451840 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
21:30:47 M: 12451840 DEBUG: CDVDPlayerAudio:: Discontinuity - was:326.551364, should be:0.000000, error:-326.551364
21:30:47 M: 12947456 DEBUG: CDVDPlayer::SetCaching - caching state 0
21:30:47 M: 14979072 DEBUG: Setting resolution 1
21:30:47 M: 16871424 DEBUG: We set resolution 1
21:30:47 M: 16347136 INFO: Starting async renderer thread
21:30:47 M: 17027072 DEBUG: Deleted YV12 texture 1
21:30:47 M: 17027072 DEBUG: ------ Window Init (VideoFullScreen.xml) ------
21:30:47 M: 17027072 INFO: Loading skin file: VideoFullScreen.xml
21:30:47 M: 16957440 INFO: Loading skin file: VideoOSD.xml
21:30:47 M: 16371712 INFO: Loading skin file: VideoOSDSettings.xml
Previous line repeats 1 times.
21:30:47 M: 14004224 INFO: Loading skin file: DialogFullScreenInfo.xml
21:30:48 M: 13537280 DEBUG: CDVDPlayerAudio:: Discontinuity - was:1018355.491827, should be:991959.147126, error:-26396.344700
21:31:08 M: 13496320 INFO: msg: libdvdnav: Language 'nl' not found, using 'en' instead
21:31:08 M: 13496320 DEBUG: libdvdnav: Menu Languages available:
21:31:08 M: 13496320 INFO: msg: en
21:31:08 M: 13496320 DEBUG: msg:
21:31:08 M: 13496320 DEBUG: CFileSMB::Close closing fd 10001
21:31:08 M: 13680640 DEBUG: libdvdcss debug:
21:31:08 M: 13680640 INFO: msg: opening target `smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VTS_02_0.IFO'
21:31:08 M: 13680640 DEBUG: msg:
21:31:08 M: 13680640 DEBUG: libdvdcss debug:
21:31:08 M: 13680640 DEBUG: using libc for access
21:31:08 M: 13680640 DEBUG: msg:
21:31:08 M: 13680640 DEBUG: CFileSMB::Open - opened Video/Films/The Odds (2011)/VIDEO_TS/VTS_02_0.IFO, fd=10001
21:31:09 M: 13811712 DEBUG: libdvdcss debug:
21:31:09 M: 13811712 INFO: msg: using CSS key cache dir: T:\cache/NONAME/0c1aac000c1b3800-0000000000/
21:31:09 M: 13811712 DEBUG: msg:
21:31:09 M: 13811712 DEBUG: CFileSMB::Close closing fd 10002
21:31:09 M: 13836288 DEBUG: libdvdcss debug:
21:31:09 M: 13836288 INFO: msg: opening target `smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VTS_02_1.VOB'
21:31:09 M: 13836288 DEBUG: msg:
21:31:09 M: 13836288 DEBUG: libdvdcss debug:
21:31:09 M: 13836288 DEBUG: using libc for access
21:31:09 M: 13836288 DEBUG: msg:
21:31:09 M: 13836288 DEBUG: CFileSMB::Open - opened Video/Films/The Odds (2011)/VIDEO_TS/VTS_02_1.VOB, fd=10002
21:31:09 M: 13856768 DEBUG: libdvdcss debug:
21:31:09 M: 13856768 INFO: msg: cracking title key at block 0
21:31:09 M: 13856768 DEBUG: msg:
21:31:10 M: 14561280 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
21:31:10 M: 14594048 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
21:31:10 M: 14594048 INFO: CDVDPlayerVideo - Stillframe detected, switching to forced 25.000000 fps
21:31:11 M: 14594048 DEBUG: libdvdcss debug:
21:31:11 M: 14594048 DEBUG: end of title reached
21:31:11 M: 14594048 DEBUG: msg:
21:31:11 M: 14594048 DEBUG: libdvdcss debug:
21:31:11 M: 14594048 INFO: msg: successful attempts 0/0, scrambled blocks 0/2000
21:31:11 M: 14594048 DEBUG: msg:
21:31:11 M: 14594048 DEBUG: libdvdcss debug:
21:31:11 M: 14594048 DEBUG: no scrambled sectors found
21:31:11 M: 14594048 DEBUG: msg:
21:31:11 M: 14594048 DEBUG: libdvdcss debug:
21:31:11 M: 14594048 INFO: msg: title key is 00:00:00:00:00
21:31:11 M: 14594048 DEBUG: msg:
21:31:11 M: 14594048 DEBUG: libdvdcss debug:
21:31:11 M: 14594048 DEBUG: unencrypted title
21:31:11 M: 14594048 DEBUG: msg:
21:31:11 M: 14594048 DEBUG: libdvdcss debug:
21:31:11 M: 14594048 INFO: msg: opening target `smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VTS_02_2.VOB'
21:31:11 M: 14594048 DEBUG: msg:
21:31:11 M: 14594048 DEBUG: libdvdcss debug:
21:31:11 M: 14594048 DEBUG: using libc for access
21:31:11 M: 14594048 DEBUG: msg:
21:31:11 M: 14594048 DEBUG: CFileSMB::Open - opened Video/Films/The Odds (2011)/VIDEO_TS/VTS_02_2.VOB, fd=10003
21:31:11 M: 14594048 DEBUG: libdvdcss debug:
21:31:11 M: 14594048 INFO: msg: cracking title key at block 0
21:31:11 M: 14594048 DEBUG: msg:
21:31:14 M: 14594048 DEBUG: libdvdcss debug:
21:31:14 M: 14594048 DEBUG: end of title reached
21:31:14 M: 14594048 DEBUG: msg:
21:31:14 M: 14594048 DEBUG: libdvdcss debug:
21:31:14 M: 14594048 INFO: msg: successful attempts 0/0, scrambled blocks 0/2000
21:31:14 M: 14594048 DEBUG: msg:
21:31:14 M: 14594048 DEBUG: libdvdcss debug:
21:31:14 M: 14594048 DEBUG: no scrambled sectors found
21:31:14 M: 14594048 DEBUG: msg:
21:31:14 M: 14594048 DEBUG: libdvdcss debug:
21:31:14 M: 14594048 INFO: msg: title key is 00:00:00:00:00
21:31:14 M: 14594048 DEBUG: msg:
21:31:14 M: 14594048 DEBUG: libdvdcss debug:
21:31:14 M: 14594048 DEBUG: unencrypted title
21:31:14 M: 14594048 DEBUG: msg:
21:31:14 M: 14594048 DEBUG: libdvdcss debug:
21:31:14 M: 14594048 INFO: msg: opening target `smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VTS_02_3.VOB'
21:31:14 M: 14594048 DEBUG: msg:
21:31:14 M: 14594048 DEBUG: libdvdcss debug:
21:31:14 M: 14594048 DEBUG: using libc for access
21:31:14 M: 14594048 DEBUG: msg:
21:31:14 M: 14594048 DEBUG: CFileSMB::Open - opened Video/Films/The Odds (2011)/VIDEO_TS/VTS_02_3.VOB, fd=10004
21:31:14 M: 14594048 DEBUG: libdvdcss debug:
21:31:14 M: 14594048 INFO: msg: cracking title key at block 0
21:31:14 M: 14594048 DEBUG: msg:
21:31:16 M: 14594048 DEBUG: libdvdcss debug:
21:31:16 M: 14594048 DEBUG: end of title reached
21:31:16 M: 14594048 DEBUG: msg:
21:31:16 M: 14594048 DEBUG: libdvdcss debug:
21:31:16 M: 14594048 INFO: msg: successful attempts 0/0, scrambled blocks 0/2000
21:31:16 M: 14594048 DEBUG: msg:
21:31:16 M: 14594048 DEBUG: libdvdcss debug:
21:31:16 M: 14594048 DEBUG: no scrambled sectors found
21:31:16 M: 14594048 DEBUG: msg:
21:31:16 M: 14594048 DEBUG: libdvdcss debug:
21:31:16 M: 14594048 INFO: msg: title key is 00:00:00:00:00
21:31:16 M: 14594048 DEBUG: msg:
21:31:16 M: 14594048 DEBUG: libdvdcss debug:
21:31:16 M: 14594048 DEBUG: unencrypted title
21:31:16 M: 14594048 DEBUG: msg:
21:31:17 M: 14594048 DEBUG: libdvdcss debug:
21:31:17 M: 14594048 INFO: msg: opening target `smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VTS_02_4.VOB'
21:31:17 M: 14594048 DEBUG: msg:
21:31:17 M: 14594048 DEBUG: libdvdcss debug:
21:31:17 M: 14594048 DEBUG: using libc for access
21:31:17 M: 14594048 DEBUG: msg:
21:31:17 M: 14594048 DEBUG: CFileSMB::Open - opened Video/Films/The Odds (2011)/VIDEO_TS/VTS_02_4.VOB, fd=10005
21:31:17 M: 14594048 DEBUG: libdvdcss debug:
21:31:17 M: 14594048 INFO: msg: cracking title key at block 0
21:31:17 M: 14594048 DEBUG: msg:
21:31:19 M: 14594048 DEBUG: libdvdcss debug:
21:31:19 M: 14594048 DEBUG: end of title reached
21:31:19 M: 14594048 DEBUG: msg:
21:31:19 M: 14594048 DEBUG: libdvdcss debug:
21:31:19 M: 14594048 INFO: msg: successful attempts 0/0, scrambled blocks 0/2000
21:31:19 M: 14594048 DEBUG: msg:
21:31:19 M: 14594048 DEBUG: libdvdcss debug:
21:31:19 M: 14594048 DEBUG: no scrambled sectors found
21:31:19 M: 14594048 DEBUG: msg:
21:31:19 M: 14594048 DEBUG: libdvdcss debug:
21:31:19 M: 14594048 INFO: msg: title key is 00:00:00:00:00
21:31:19 M: 14594048 DEBUG: msg:
21:31:19 M: 14594048 DEBUG: libdvdcss debug:
21:31:19 M: 14594048 DEBUG: unencrypted title
21:31:19 M: 14594048 DEBUG: msg:
21:31:19 M: 14594048 DEBUG: - DVDNAV_VTS_CHANGE (HOLDING)
21:31:19 M: 14680064 DEBUG: DVDNAV_VTS_CHANGE
21:31:19 M: 14680064 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
21:31:19 M: 14643200 DEBUG: CDVDInputStreamNavigator::ProcessBlock - Cell change: Title 2, Chapter 1
21:31:19 M: 14643200 DEBUG: CDVDPlayerVideo - CDVDMsg::VIDEO_SET_ASPECT
21:31:19 M: 14643200 DEBUG: CDVDInputStreamNavigator::ProcessBlock - At position 0% inside the feature
21:31:19 M: 14643200 DEBUG: DVDNAV_CELL_CHANGE
21:31:19 M: 14643200 INFO: CDVDInputStreamNavigator::ProcessBlock - none or invalid subtitle stream selected, defaulting to first
21:31:19 M: 14643200 DEBUG: CDVDInputStreamNavigator::SetActiveSubtitleStream - id: 0, stream: 0
21:31:19 M: 14643200 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:23392155 TO:48000 DIFF:-23344155
21:31:19 M: 14643200 DEBUG: CDVDDemuxFFmpeg::Open - avformat_find_stream_info starting
21:31:19 M: 14557184 DEBUG: Unable to resolve: kernel32.dll InitializeConditionVariable
21:31:19 M: 14557184 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'InitializeConditionVariable') => 00000000
21:31:19 M: 14557184 DEBUG: Unable to resolve: kernel32.dll WakeAllConditionVariable
21:31:19 M: 14557184 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'WakeAllConditionVariable') => 00000000
21:31:19 M: 14557184 DEBUG: Unable to resolve: kernel32.dll WakeConditionVariable
21:31:19 M: 14557184 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'WakeConditionVariable') => 00000000
21:31:19 M: 14557184 DEBUG: Unable to resolve: kernel32.dll SleepConditionVariableCS
21:31:19 M: 14557184 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'SleepConditionVariableCS') => 00000000
21:31:19 M: 14540800 DEBUG: Unable to resolve: kernel32.dll InitializeConditionVariable
21:31:19 M: 14540800 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'InitializeConditionVariable') => 00000000
21:31:19 M: 14540800 DEBUG: Unable to resolve: kernel32.dll WakeAllConditionVariable
21:31:19 M: 14540800 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'WakeAllConditionVariable') => 00000000
21:31:19 M: 14540800 DEBUG: Unable to resolve: kernel32.dll WakeConditionVariable
21:31:19 M: 14540800 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'WakeConditionVariable') => 00000000
21:31:19 M: 14540800 DEBUG: Unable to resolve: kernel32.dll SleepConditionVariableCS
21:31:19 M: 14540800 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'SleepConditionVariableCS') => 00000000
21:31:19 M: 13627392 DEBUG: ffmpeg[170]: [mpeg] max_analyze_duration 500000 reached at 504000
21:31:19 M: 14589952 DEBUG: ffmpeg[170]: [mpeg] Estimating duration from bitrate, this may be inaccurate
21:31:19 M: 14639104 DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished
21:31:19 M: 14639104 INFO: ffmpeg[170]: Input #0, mpeg, from 'smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VIDEO_TS.IFO':
21:31:19 M: 14639104 INFO: ffmpeg[170]: Duration: N/A, start: 0.048000, bitrate: 9208 kb/s
21:31:19 M: 14643200 INFO: ffmpeg[170]: Stream #0:0[0x1e0]: Video: mpeg2video, yuv420p, 720x576 [SAR 64:45 DAR 16:9], 8984 kb/s, 25 fps, 25 tbr, 90k tbn, 50 tbc
21:31:19 M: 14643200 INFO: ffmpeg[170]: Stream #0:1[0x1c0]: Audio: mp2, 48000 Hz, stereo, s16, 224 kb/s
21:31:19 M: 14643200 NOTICE: Opening audio stream: 1 source: 256
21:31:20 M: 14643200 NOTICE: Finding audio codec for: 86016
21:31:20 M: 14065664 DEBUG: FactoryCodec - Audio: PassthroughFFmpeg - Opening
21:31:20 M: 14065664 ERROR: CDVDAudioCodecPassthroughFFmpeg::Open - FFmpeg SPDIF muxer does not support this codec
21:31:20 M: 14065664 DEBUG: FactoryCodec - Audio: PassthroughFFmpeg - Failed
21:31:20 M: 14479360 DEBUG: FactoryCodec - Audio: libmad - Opening
21:31:20 M: 14376960 DEBUG: FactoryCodec - Audio: libmad - Opened
21:31:20 M: 14954496 DEBUG: CDVDPlayer::SetCaching - caching state 1
21:31:20 M: 14618624 NOTICE: Creating audio device with codec id: 86016, channels: 2, sample rate: 48000, no pass-through
21:31:20 M: 14569472 NOTICE: Opening video stream: 0 source: 256
21:31:20 M: 14569472 DEBUG: Pause stream
21:31:20 M: 14569472 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
21:31:20 M: 14569472 NOTICE: Creating video codec with codec id: 2
21:31:20 M: 14569472 DEBUG: FactoryCodec - Video: libmpeg2 - Opening
21:31:20 M: 13320192 DEBUG: FactoryCodec - Video: libmpeg2 - Opened
21:31:20 M: 13320192 DEBUG: CDVDPlayer::HandleMessages - player started 1
21:31:20 M: 13320192 DEBUG: ------ Window Init (DialogSeekBar.xml) ------
21:31:20 M: 13164544 NOTICE: Opening Subtitle stream: 2 source: 256
21:31:20 M: 13164544 WARNING: CDVDPlayer::CheckPlayerInit(3) - Ignoring too large delay of 24505000.000000
21:31:20 M: 13008896 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
21:31:20 M: 12951552 DEBUG: CDVDPlayer::HandleMessages - player started 2
Previous line repeats 1 times.
21:31:20 M: 11849728 DEBUG: CDVDPlayer::SetCaching - caching state 3
21:31:20 M: 11849728 DEBUG: CDVDPlayerAudio:: Discontinuity - was:-1330756.426202, should be:23336008.998256, error:24666765.424459
21:31:20 M: 11849728 DEBUG: CDVDPlayerAudio:: Discontinuity - was:23339496.498258, should be:23456003.388256, error:116506.889998
21:31:20 M: 13053952 DEBUG: CDVDPlayer::SetCaching - caching state 0
21:31:20 M: 12447744 DEBUG: CDVDPlayer::HandleMessages - player started 2
21:31:20 M: 12447744 DEBUG: CDVDPlayerAudio:: Discontinuity - was:23565227.189215, should be:23464000.000000, error:-101227.189215
21:31:20 M: 12447744 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
21:31:21 M: 12558336 DEBUG: CDVDPlayerAudio:: Discontinuity - was:24471964.364549, should be:24433033.459132, error:-38930.905417
21:31:24 M: 12460032 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
Previous line repeats 1 times.
21:31:50 M: 12640256 DEBUG: CApplication::OnKey: 223 pressed, action is 14
21:31:50 M: 12668928 DEBUG: CDVDPlayer::SetCaching - caching state 2
21:31:50 M: 12668928 DEBUG: CDVDDemuxFFmpeg::SeekChapter - chapter seeking using input stream
21:31:50 M: 12668928 DEBUG: Pause stream
21:31:50 M: 12668928 DEBUG: libdvdcss debug:
21:31:50 M: 12668928 INFO: msg: opening target `smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VTS_02_0.IFO'
21:31:50 M: 12668928 DEBUG: msg:
21:31:50 M: 12668928 DEBUG: libdvdcss debug:
21:31:50 M: 12668928 DEBUG: using libc for access
21:31:50 M: 12668928 DEBUG: msg:
21:31:50 M: 12668928 DEBUG: ------ Window Init (DialogSeekBar.xml) ------
21:31:50 M: 12562432 DEBUG: CFileSMB::Open - opened Video/Films/The Odds (2011)/VIDEO_TS/VTS_02_0.IFO, fd=10006
21:31:50 M: 12562432 DEBUG: libdvdcss debug:
21:31:50 M: 12562432 INFO: msg: using CSS key cache dir: T:\cache/NONAME/0c1aac000c1b3800-0000000000/
21:31:50 M: 12562432 DEBUG: msg:
21:31:51 M: 12562432 DEBUG: CFileSMB::Close closing fd 10001
21:31:51 M: 12566528 DEBUG: CDVDInputStreamNavigator::SetActiveSubtitleStream - id: 0, stream: 0
21:31:51 M: 12566528 DEBUG: CDVDInputStreamNavigator::SetActiveAudioStream - id: 0, stream: 0
21:31:51 M: 13766656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
21:31:51 M: 13766656 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
21:31:51 M: 13766656 DEBUG: CApplication::OnPlayBackSeekChapter - Playback skip
21:31:51 M: 13766656 DEBUG: DVDNAV_HOP_CHANNEL
21:31:51 M: 13766656 DEBUG: Stop stream
21:31:51 M: 13766656 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
21:31:51 M: 13766656 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
21:31:51 M: 13766656 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
21:31:51 M: 13766656 DEBUG: CDVDInputStreamNavigator::ProcessBlock - Cell change: Title 2, Chapter 2
21:31:51 M: 13766656 DEBUG: CDVDInputStreamNavigator::ProcessBlock - At position 6% inside the feature
21:31:51 M: 13766656 DEBUG: DVDNAV_CELL_CHANGE
21:31:51 M: 13766656 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:32288000 TO:300088000 DIFF:267800000
21:31:51 M: 13688832 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
21:31:51 M: 13647872 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
21:31:51 M: 13647872 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(55520000.000000, 1)
21:31:51 M: 13619200 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(55520000.000000, 0)
21:31:51 M: 13619200 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
21:31:51 M: 13619200 DEBUG: CDVDPlayer::HandleMessages - player started 1
21:31:51 M: 13639680 DEBUG: CDVDPlayer::HandleMessages - player started 2
21:31:51 M: 13639680 DEBUG: CDVDPlayer::SetCaching - caching state 0
21:31:51 M: 13668352 DEBUG: CDVDPlayerAudio:: Discontinuity - was:55520908.244546, should be:55560008.665529, error:39100.420983
21:31:51 M: 13668352 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
21:31:52 M: 12554240 DEBUG: CDVDPlayerAudio:: Discontinuity - was:56561188.731893, should be:56541363.691340, error:-19825.040553
21:31:53 M: 12525568 DEBUG: CDVDPlayerAudio:: Discontinuity - was:57550397.311799, should be:57521704.871518, error:-28692.440281
21:31:53 M: 12533760 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
21:31:54 M: 12771328 WARNING: CDVDPlayer::CheckPlayerInit(3) - Ignoring too large delay of 3835000.000000
21:31:54 M: 12615680 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
21:32:01 M: 12648448 DEBUG: CApplication::OnKey: 224 pressed, action is 13
21:32:01 M: 12664832 NOTICE: CDVDPlayer::CloseFile()
21:32:01 M: 12664832 DEBUG: CApplication::OnPlayBackSpeedChanged - Playback speed changed
21:32:01 M: 12664832 NOTICE: DVDPlayer: waiting for threads to exit
21:32:01 M: 12664832 NOTICE: CDVDPlayer::OnExit()
21:32:01 M: 12664832 NOTICE: DVDPlayer: closing audio stream
21:32:01 M: 12664832 NOTICE: Closing audio stream
21:32:01 M: 12664832 NOTICE: Waiting for audio thread to exit
21:32:01 M: 12664832 NOTICE: thread end: CDVDPlayerAudio::OnExit()
21:32:01 M: 13189120 NOTICE: Closing audio device
21:32:01 M: 13189120 DEBUG: Stop stream
21:32:01 M: 13242368 NOTICE: Deleting audio codec
21:32:01 M: 13455360 NOTICE: DVDPlayer: closing video stream
21:32:01 M: 13455360 NOTICE: Closing video stream
21:32:01 M: 13455360 NOTICE: waiting for video thread to exit
21:32:01 M: 13504512 NOTICE: thread end: video_thread
21:32:01 M: 15097856 NOTICE: deleting video codec
21:32:01 M: 18837504 NOTICE: DVDPlayer: closing subtitle stream
21:32:01 M: 18837504 NOTICE: Closing subtitle stream
21:32:01 M: 18857984 NOTICE: CDVDPlayer::OnExit() deleting demuxer
21:32:01 M: 18948096 NOTICE: CDVDPlayer::OnExit() deleting input stream
21:32:01 M: 18948096 DEBUG: CFileSMB::Close closing fd 10002
21:32:01 M: 18948096 DEBUG: CFileSMB::Close closing fd 10003
21:32:01 M: 18948096 DEBUG: CFileSMB::Close closing fd 10004
21:32:01 M: 18948096 DEBUG: CFileSMB::Close closing fd 10005
21:32:01 M: 18948096 DEBUG: CFileSMB::Close closing fd 10000
21:32:01 M: 19005440 DEBUG: CFileSMB::Close closing fd 10006
21:32:01 M: 21061632 DEBUG: CApplication::OnPlayBackStopped - Playback was stopped
21:32:01 M: 21585920 NOTICE: DVDPlayer: finished waiting
21:32:01 M: 21585920 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
21:32:01 M: 21585920 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------
21:32:01 M: 25022464 DEBUG: Setting resolution 1
21:32:02 M: 23138304 DEBUG: We set resolution 1
21:32:02 M: 22405120 DEBUG: Created YV12 texture 1
21:32:02 M: 22474752 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
21:32:02 M: 22462464 DEBUG: ------ Window Init (MyVideoNav.xml) ------
21:32:02 M: 22462464 INFO: Loading skin file: MyVideoNav.xml
21:32:02 M: 20283392 DEBUG: CGUIMediaWindow::GetDirectory (videodb://1/2/)
21:32:02 M: 20283392 DEBUG: ParentPath = [videodb://1/2/]
21:32:02 M: 20283392 DEBUG: CVideoDatabase::GetSetsNav query: select sets.idSet,sets.strSet,count(1),count(files.playCount) from sets join setlinkmovie on sets.idSet=setlinkmovie.idSet join movie on setlinkmovie.idMovie=movie.idMovie join files on files.idFile=movie.idFile group by sets.idSet
21:32:02 M: 20283392 DEBUG: CVideoDatabase::GetMoviesByWhere query: select * from movieview where movieview.idmovie NOT in (select idmovie from setlinkmovie)
21:32:02 M: 20299776 DEBUG: Time for actual SQL query = 34
21:32:03 M: 20283392 DEBUG: Time to retrieve movies from dataset = 98
21:32:03 M: 20316160 DEBUG: CFileItemList::Sort, sorting took 0 millis
21:32:03 M: 20316160 DEBUG: Saving fileitems [videodb://1/2/]
21:32:03 M: 20316160 DEBUG: -- items: 34, sort method: 25, ascending: true
21:32:03 M: 19312640 WARNING: old getenv from python.lib called, library check needed
21:32:03 M: 13922304 NOTICE: CDVDPlayer::CloseFile()
21:32:03 M: 13926400 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
21:32:03 M: 13926400 NOTICE: DVDPlayer: waiting for threads to exit
21:32:03 M: 13926400 WARNING: old getenv from python.lib called, library check needed
21:32:03 M: 13926400 NOTICE: DVDPlayer: finished waiting
21:32:03 M: 11026432 NOTICE: CDVDPlayerVideo::~CDVDPlayerVideo - uninitting video device
21:32:03 M: 12075008 DEBUG: CXBoxRenderer::UnInit - Cleaning up resources
21:32:03 M: 12738560 DEBUG: Deleted YV12 texture 0
21:32:03 M: 13402112 DEBUG: Deleted YV12 texture 1
21:32:03 M: 13402112 DEBUG: CApplication::OnMessage : Translating SetFocus(50)
21:32:03 M: 13402112 DEBUG: CApplication::OnMessage : To SetFocus(50)
21:32:03 M: 13402112 DEBUG: CApplication::SaveFileState - Saving file state for video item smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VIDEO_TS.IFO
21:32:03 M: 13389824 DEBUG: CApplication::SaveFileState - Marking video item smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VIDEO_TS.IFO as watched
21:32:03 M: 14512128 DEBUG: SECTION:UnloadDelayed(SECTION: LCODE)
21:32:03 M: 19378176 DEBUG: CGUIMediaWindow::GetDirectory (videodb://1/2/)
21:32:03 M: 19378176 WARNING: old getenv from python.lib called, library check needed
21:32:03 M: 17260544 DEBUG: ParentPath = [videodb://1/2/]
21:32:03 M: 17248256 DEBUG: CVideoDatabase::GetSetsNav query: select sets.idSet,sets.strSet,count(1),count(files.playCount) from sets join setlinkmovie on sets.idSet=setlinkmovie.idSet join movie on setlinkmovie.idMovie=movie.idMovie join files on files.idFile=movie.idFile group by sets.idSet
21:32:03 M: 17248256 DEBUG: CVideoDatabase::GetMoviesByWhere query: select * from movieview where movieview.idmovie NOT in (select idmovie from setlinkmovie)
21:32:03 M: 17362944 DEBUG: Time for actual SQL query = 44
21:32:04 M: 17350656 DEBUG: Time to retrieve movies from dataset = 114
21:32:04 M: 17371136 DEBUG: CFileItemList::Sort, sorting took 0 millis
21:32:04 M: 17371136 DEBUG: Saving fileitems [videodb://1/2/]
21:32:04 M: 17371136 DEBUG: -- items: 34, sort method: 25, ascending: true
21:32:04 M: 16216064 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 1 times.
21:32:05 M: 11972608 WARNING: CApplication::OnKey: 229 pressed, action is 117
21:32:05 M: 11972608 DEBUG: CPlayerCoreFactory::GetPlayers(smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VIDEO_TS.IFO)
21:32:05 M: 11972608 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: un-named
21:32:05 M: 11972608 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: un-named
21:32:05 M: 11972608 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
21:32:05 M: 11972608 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/rtmp/mms/udp
21:32:05 M: 11972608 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
21:32:05 M: 11972608 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
21:32:05 M: 11972608 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
21:32:05 M: 11972608 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
21:32:05 M: 11972608 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdfile
21:32:05 M: 11972608 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: dvdfile
21:32:05 M: 11972608 DEBUG: CPlayerSelectionRule::GetPlayers: adding player: DVDPlayer (1) for rule: dvdfile
21:32:05 M: 11972608 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
21:32:05 M: 11972608 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: ogv/flv/mov
21:32:05 M: 11972608 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
21:32:05 M: 11972608 DEBUG: CPlayerCoreFactory::GetPlayers: matched 1 rules with players
21:32:05 M: 11972608 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
21:32:05 M: 11972608 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
21:32:05 M: 11972608 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
21:32:05 M: 11972608 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
21:32:05 M: 11972608 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: MPlayer (2)
21:32:05 M: 11972608 DEBUG: CPlayerCoreFactory::GetPlayers: added 2 players
21:32:05 M: 11972608 DEBUG: CFavourites::Load - no system favourites found, skipping
21:32:05 M: 11972608 DEBUG: CFavourites::Load - no userdata favourites found, skipping
21:32:05 M: 11972608 INFO: Loading skin file: DialogContextMenu.xml
21:32:05 M: 11972608 DEBUG: ------ Window Init (DialogContextMenu.xml) ------
21:32:06 M: 17391616 DEBUG: CApplication::OnKey: 167 pressed, action is 4
Previous line repeats 5 times.
21:32:07 M: 23060480 DEBUG: CApplication::OnKey: 11 pressed, action is 7
21:32:07 M: 23048192 DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------
21:32:07 M: 23298048 INFO: Loading skin file: DialogYesNo.xml
21:32:07 M: 23298048 DEBUG: ------ Window Init (DialogYesNo.xml) ------
21:32:08 M: 23023616 DEBUG: CApplication::OnKey: 169 pressed, action is 1
21:32:09 M: 23023616 DEBUG: CApplication::OnKey: 11 pressed, action is 7
21:32:09 M: 23011328 DEBUG: ------ Window Deinit (DialogYesNo.xml) ------
21:32:09 M: 23285760 DEBUG: CVideoDatabase::GetMovieId (smb://CUBESTATION/Video/Films/The Odds (2011)/VIDEO_TS/VIDEO_TS.IFO), query = select idMovie from movie where idFile=15
21:32:09 M: 23453696 DEBUG: CGUIMediaWindow::GetDirectory (videodb://1/2/)
21:32:09 M: 23453696 DEBUG: ParentPath = [videodb://1/2/]
21:32:09 M: 23441408 DEBUG: CVideoDatabase::GetSetsNav query: select sets.idSet,sets.strSet,count(1),count(files.playCount) from sets join setlinkmovie on sets.idSet=setlinkmovie.idSet join movie on setlinkmovie.idMovie=movie.idMovie join files on files.idFile=movie.idFile group by sets.idSet
21:32:09 M: 23441408 DEBUG: CVideoDatabase::GetMoviesByWhere query: select * from movieview where movieview.idmovie NOT in (select idmovie from setlinkmovie)
21:32:09 M: 23429120 DEBUG: Time for actual SQL query = 32
21:32:09 M: 23425024 DEBUG: Time to retrieve movies from dataset = 92
21:32:09 M: 23965696 DEBUG: CFileItemList::Sort, sorting took 1 millis
21:32:09 M: 23965696 DEBUG: Saving fileitems [videodb://1/2/]
21:32:09 M: 23965696 DEBUG: -- items: 33, sort method: 25, ascending: true
21:32:09 M: 21499904 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 13 times.
21:32:11 M: 17141760 WARNING: SECTION:UnloadDelayed(DLL: Q:\system\players\dvdplayer\libdvdnav.dll)
21:32:11 M: 17141760 DEBUG: GetModuleHandleA('libgcc_s_dw2-1.dll') failed
Previous line repeats 1 times.
21:32:11 M: 17235968 DEBUG: Q:\system\players\dvdplayer\libdvdnav.dll: Detected 2 unfreed critical sections
21:32:12 M: 17645568 DEBUG: SECTION:UnloadDelayed(DLL: Q:\system\players\dvdplayer\avutil-51.dll)
21:32:12 M: 17645568 DEBUG: SECTION:UnloadDelayed(DLL: Q:\system\players\dvdplayer\avcodec-53.dll)
21:32:13 M: 17645568 DEBUG: SECTION:UnloadDelayed(DLL: Q:\system\players\dvdplayer\avformat-53.dll)
21:32:13 M: 17645568 DEBUG: GetModuleHandleA('libgcc_s_dw2-1.dll') failed
Previous line repeats 2 times.
21:32:13 M: 17657856 DEBUG: Q:\system\players\dvdplayer\avutil-51.dll (base 68B80000): Detected memory leaks: 13 leaks
21:32:13 M: 17780736 DEBUG: leak caller address 68B86768, size 123106, counter 13
21:32:13 M: 17780736 DEBUG: avutil-51.dll: Total bytes leaked: 123106
21:32:13 M: 29233152 DEBUG: CApplication::OnKey: 169 pressed, action is 1
21:32:13 M: 29138944 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 2 times.
21:32:13 M: 26923008 WARNING: SECTION:UnloadDelayed(DLL: Q:\system\players\dvdplayer\libmpeg2.dll)
21:32:14 M: 27062272 DEBUG: CApplication::OnKey: 169 pressed, action is 1
21:32:14 M: 26976256 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 1 times.
21:32:14 M: 24858624 WARNING: SECTION:UnloadDelayed(DLL: Q:\system\players\dvdplayer\libmad.dll)
21:32:14 M: 24858624 DEBUG: Q:\system\players\dvdplayer\libmad.dll (base 01B40000): Detected memory leaks: 1 leaks
21:32:14 M: 24858624 DEBUG: leak caller address 01B4888D, size 60, counter 1
21:32:14 M: 24858624 DEBUG: libmad.dll: Total bytes leaked: 60
21:32:14 M: 24965120 DEBUG: CApplication::OnKey: 169 pressed, action is 1
21:32:14 M: 23994368 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 1 times.
21:32:14 M: 17973248 WARNING: CApplication::OnKey: 169 pressed, action is 1
21:32:15 M: 21491712 WARNING: old getenv from python.lib called, library check needed
21:32:15 M: 19374080 DEBUG: CApplication::OnKey: 169 pressed, action is 1
21:32:15 M: 21508096 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 2 times.
21:32:15 M: 19185664 WARNING: CApplication::OnKey: 169 pressed, action is 1
21:32:15 M: 19075072 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 2 times.
21:32:16 M: 17510400 WARNING: CApplication::OnKey: 169 pressed, action is 1
21:32:16 M: 17371136 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 1 times.
21:32:17 M: 23203840 WARNING: CApplication::OnKey: 169 pressed, action is 1
21:32:17 M: 23175168 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 1 times.
21:32:18 M: 25575424 WARNING: CApplication::OnKey: 169 pressed, action is 1
21:32:18 M: 25530368 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 1 times.
21:32:19 M: 25128960 WARNING: CApplication::OnKey: 169 pressed, action is 1
21:32:19 M: 25055232 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 2 times.
21:32:19 M: 22745088 WARNING: CApplication::OnKey: 169 pressed, action is 1
21:32:19 M: 22581248 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 1 times.
21:32:20 M: 22491136 WARNING: CApplication::OnKey: 169 pressed, action is 1
21:32:20 M: 21528576 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 1 times.
21:32:22 M: 21512192 WARNING: CApplication::OnKey: 169 pressed, action is 1
21:32:22 M: 21417984 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 2 times.
21:32:23 M: 21921792 WARNING: CApplication::OnKey: 169 pressed, action is 1
21:32:23 M: 21807104 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 1 times.
21:32:24 M: 19726336 WARNING: CApplication::OnKey: 169 pressed, action is 1
21:32:24 M: 19644416 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 1 times.
21:32:25 M: 24776704 WARNING: CApplication::OnKey: 169 pressed, action is 1
21:32:25 M: 24702976 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 1 times.
21:32:29 M: 29769728 WARNING: CApplication::OnKey: 11 pressed, action is 7
21:32:29 M: 29765632 DEBUG: CPlayerCoreFactory::GetPlayers(smb://CUBESTATION/Video/Films/Bad Ass (2012)/Bad Ass (2012) RETAIL DD 5.1 1.5 GB SRT XVID.avi)
21:32:29 M: 29765632 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: un-named
21:32:29 M: 29765632 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: un-named
21:32:29 M: 29765632 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
21:32:29 M: 29765632 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/rtmp/mms/udp
21:32:29 M: 29765632 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
21:32:29 M: 29765632 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
21:32:29 M: 29765632 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
21:32:29 M: 29765632 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
21:32:29 M: 29765632 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdfile
21:32:29 M: 29765632 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
21:32:29 M: 29765632 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: ogv/flv/mov
21:32:29 M: 29765632 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
21:32:29 M: 29765632 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
21:32:29 M: 29765632 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
21:32:29 M: 29765632 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
21:32:29 M: 29765632 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
21:32:29 M: 29765632 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
21:32:29 M: 29765632 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: MPlayer (2)
21:32:29 M: 29765632 DEBUG: CPlayerCoreFactory::GetPlayers: added 2 players
21:32:29 M: 29765632 NOTICE: DVDPlayer: Opening: smb://CUBESTATION/Video/Films/Bad Ass (2012)/Bad Ass (2012) RETAIL DD 5.1 1.5 GB SRT XVID.avi
21:32:29 M: 29765632 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
21:32:29 M: 29241344 NOTICE: Creating InputStream
21:32:29 M: 29241344 DEBUG: CFileSMB::Open - opened Video/Films/Bad Ass (2012)/Bad Ass (2012) RETAIL DD 5.1 1.5 GB SRT XVID.avi, fd=10006
21:32:29 M: 29241344 INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles
21:32:29 M: 29241344 DEBUG: CUtil::CacheSubtitles: START
21:32:29 M: 29241344 DEBUG: CUtil::CacheSubtitles: Checking for common subdirs...
21:32:30 M: 29241344 DEBUG: CUtil::CacheSubtitles: Done (time: 143 ms)
21:32:30 M: 29241344 DEBUG: CUtil::CacheSubtitles: Searching for subtitles...
21:32:30 M: 29241344 DEBUG: XFILE::CSMBDirectory::OpenDir - Using authentication url smb://CUBESTATION/Video/Films/Bad%20Ass%20%282012%29
21:32:30 M: 29241344 DEBUG: CUtil::CacheSubtitles: Done (time: 8 ms)
21:32:30 M: 29241344 DEBUG: CUtil::CacheSubtitles: END (total time: 155 ms)
21:32:30 M: 29241344 INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles done
21:32:30 M: 29241344 NOTICE: Creating Demuxer
21:32:30 M: 28934144 DEBUG: GetModuleHandleA('libgcc_s_dw2-1.dll') failed
Previous line repeats 2 times.
21:32:30 M: 23924736 DEBUG: CDVDDemuxFFmpeg::Open - probing detected format [avi]
21:32:31 M: 17920000 DEBUG: ------ Window Init (DialogBusy.xml) ------
21:32:31 M: 17817600 INFO: Loading skin file: DialogBusy.xml
21:32:32 M: 14897152 DEBUG: CDVDDemuxFFmpeg::Open - avformat_find_stream_info starting
21:32:32 M: 14872576 DEBUG: Unable to resolve: kernel32.dll InitializeConditionVariable
21:32:32 M: 14872576 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'InitializeConditionVariable') => 00000000
21:32:32 M: 14872576 DEBUG: Unable to resolve: kernel32.dll WakeAllConditionVariable
21:32:32 M: 14872576 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'WakeAllConditionVariable') => 00000000
21:32:32 M: 14872576 DEBUG: Unable to resolve: kernel32.dll WakeConditionVariable
21:32:32 M: 14872576 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'WakeConditionVariable') => 00000000
21:32:32 M: 14872576 DEBUG: Unable to resolve: kernel32.dll SleepConditionVariableCS
21:32:32 M: 14872576 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'SleepConditionVariableCS') => 00000000
21:32:32 M: 14749696 DEBUG: Unable to resolve: kernel32.dll InitializeConditionVariable
21:32:32 M: 14749696 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'InitializeConditionVariable') => 00000000
21:32:32 M: 14749696 DEBUG: Unable to resolve: kernel32.dll WakeAllConditionVariable
21:32:32 M: 14749696 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'WakeAllConditionVariable') => 00000000
21:32:32 M: 14749696 DEBUG: Unable to resolve: kernel32.dll WakeConditionVariable
21:32:32 M: 14749696 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'WakeConditionVariable') => 00000000
21:32:32 M: 14749696 DEBUG: Unable to resolve: kernel32.dll SleepConditionVariableCS
21:32:32 M: 14749696 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'SleepConditionVariableCS') => 00000000
21:32:32 M: 14749696 DEBUG: ffmpeg[188]: [mpeg4] Invalid and inefficient vfw-avi packed B frames detected
21:32:32 M: 14934016 DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished
21:32:32 M: 14934016 INFO: ffmpeg[188]: Input #0, avi, from 'smb://CUBESTATION/Video/Films/Bad Ass (2012)/Bad Ass (2012) RETAIL DD 5.1 1.5 GB SRT XVID.avi':
21:32:32 M: 14934016 INFO: ffmpeg[188]: Metadata:
21:32:32 M: 14934016 INFO: ffmpeg[188]: encoder : VirtualDubMod 1.5.10.2 (build 2542/release)
21:32:32 M: 14934016 INFO: ffmpeg[188]: Duration: 01:30:08.73, start: 0.000000, bitrate: 2312 kb/s
21:32:32 M: 14934016 INFO: ffmpeg[188]: Stream #0:0: Video: mpeg4 (XVID / 0x44495658), yuv420p, 720x400 [SAR 1:1 DAR 9:5], 23.98 tbr, 23.98 tbn, 23.98 tbc
21:32:32 M: 14934016 INFO: ffmpeg[188]: Stream #0:1: Audio: ac3 ([0] [0][0] / 0x2000), 48000 Hz, 5.1(side), s16, 448 kb/s
21:32:32 M: 14934016 NOTICE: Opening video stream: 0 source: 256
21:32:32 M: 14934016 NOTICE: Creating video codec with codec id: 13
21:32:32 M: 14934016 DEBUG: FactoryCodec - Video: - Opening
21:32:32 M: 14921728 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: mpeg4
21:32:32 M: 14921728 DEBUG: Unable to resolve: kernel32.dll InitializeConditionVariable
21:32:32 M: 14921728 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'InitializeConditionVariable') => 00000000
21:32:32 M: 14921728 DEBUG: Unable to resolve: kernel32.dll WakeAllConditionVariable
21:32:32 M: 14921728 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'WakeAllConditionVariable') => 00000000
21:32:32 M: 14921728 DEBUG: Unable to resolve: kernel32.dll WakeConditionVariable
21:32:32 M: 14921728 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'WakeConditionVariable') => 00000000
21:32:32 M: 14921728 DEBUG: Unable to resolve: kernel32.dll SleepConditionVariableCS
21:32:32 M: 14921728 DEBUG: dllGetProcAddress(00881400(kernel32.dll), 'SleepConditionVariableCS') => 00000000
21:32:32 M: 14921728 DEBUG: FactoryCodec - Video: ff-mpeg4 - Opened
21:32:32 M: 14921728 NOTICE: Creating video thread
21:32:32 M: 14397440 NOTICE: Opening audio stream: 1 source: 256
21:32:32 M: 14397440 DEBUG: CXBoxRenderManager::PreInit - Selected RGB-Renderer
21:32:32 M: 14397440 NOTICE: Finding audio codec for: 86019
21:32:32 M: 13819904 DEBUG: FactoryCodec - Audio: PassthroughFFmpeg - Opening
21:32:32 M: 13819904 INFO: CDVDAudioCodecPassthroughFFmpeg::SetupMuxer - Trying to setup spdif muxer
21:32:32 M: 13795328 NOTICE: running thread: video_thread
21:32:32 M: 13795328 INFO: CDVDAudioCodecPassthroughFFmpeg::SetupMuxer - spdif muxer ready
21:32:32 M: 13795328 DEBUG: FactoryCodec - Audio: PassthroughFFmpeg - Opened
21:32:32 M: 13795328 NOTICE: Creating audio thread
21:32:32 M: 13271040 NOTICE: running thread: CDVDPlayerAudio::Process()
21:32:32 M: 13271040 DEBUG: CEdl::ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: smb://CUBESTATION/Video/Films/Bad Ass (2012)/Bad Ass (2012) RETAIL DD 5.1 1.5 GB SRT XVID.avi
21:32:32 M: 13271040 DEBUG: CDVDPlayer::SetCaching - caching state 2
21:32:32 M: 13271040 DEBUG: CApplication::OnPlayBackStarted - Playback has started
21:32:32 M: 16773120 DEBUG: CGUIInfoManager::SetCurrentMovie(smb://CUBESTATION/Video/Films/Bad Ass (2012)/Bad Ass (2012) RETAIL DD 5.1 1.5 GB SRT XVID.avi)
21:32:32 M: 16785408 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
21:32:33 M: 17059840 NOTICE: Creating audio device with codec id: 86019, channels: 2, sample rate: 48000, pass-through
21:32:33 M: 17408000 DEBUG: CDVDPlayer::HandleMessages - player started 1
21:32:33 M: 17408000 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
21:32:33 M: 17408000 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
21:32:33 M: 16961536 DEBUG: ffmpeg[124]: [mpeg4] Invalid and inefficient vfw-avi packed B frames detected
21:32:33 M: 16486400 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(41708.333333, 0)
21:32:33 M: 15990784 NOTICE: fps: 23.976025, pwidth: 720, pheight: 400, dwidth: 720, dheight: 400
21:32:33 M: 15990784 DEBUG: CDVDPlayerVideo::OutputPicture - change configuration. 720x400. framerate: 23.98
21:32:33 M: 15990784 NOTICE: Display resolution AUTO : 720p 16:9 (1)
21:32:34 M: 15007744 DEBUG: Created YV12 texture 0
21:32:34 M: 15007744 DEBUG: Activating window ID: 12005
21:32:34 M: 14544896 DEBUG: Created YV12 texture 1
21:32:34 M: 14508032 DEBUG: Checking if window ID 12005 is locked.
21:32:34 M: 14512128 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
21:32:34 M: 16683008 DEBUG: CDVDPlayer::HandleMessages - player started 2
21:32:34 M: 16928768 DEBUG: CDVDPlayer::SetCaching - caching state 3
21:32:34 M: 17084416 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(32000.000000, 1)
21:32:34 M: 16809984 DEBUG: CDVDPlayerAudio:: Discontinuity - was:308.072727, should be:0.000000, error:-308.072727
21:32:34 M: 16691200 DEBUG: CDVDPlayer::SetCaching - caching state 0
21:32:34 M: 16936960 DEBUG: Setting resolution 1
21:32:34 M: 18759680 DEBUG: We set resolution 1
21:32:34 M: 18194432 INFO: Starting async renderer thread
21:32:34 M: 18657280 DEBUG: Deleted YV12 texture 1
21:32:34 M: 18657280 DEBUG: ------ Window Init (VideoFullScreen.xml) ------
21:32:34 M: 18657280 INFO: Loading skin file: VideoFullScreen.xml
21:32:34 M: 18513920 INFO: Loading skin file: VideoOSD.xml
21:32:34 M: 17547264 INFO: Loading skin file: VideoOSDSettings.xml
Previous line repeats 1 times.
21:32:34 M: 14893056 INFO: Loading skin file: DialogFullScreenInfo.xml
21:32:35 M: 14168064 DEBUG: CDVDPlayerAudio:: Discontinuity - was:1018656.514554, should be:993203.277433, error:-25453.237121
21:43:37 M: 14159872 DEBUG: CApplication::OnKey: 230 pressed, action is 12
21:43:37 M: 14159872 DEBUG: CApplication::OnPlayBackPaused - Playback was paused
21:43:37 M: 14159872 DEBUG: ------ Window Init (DialogSeekBar.xml) ------
21:43:41 M: 14024704 DEBUG: CApplication::OnKey: 230 pressed, action is 12
21:43:41 M: 14024704 DEBUG: CDVDPlayerAudio:: Discontinuity - was:662908228.030576, should be:663076340.020139, error:168111.989563
21:43:41 M: 14028800 DEBUG: CApplication::OnPlayBackResumed - Playback was resumed
21:43:41 M: 14036992 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
21:49:05 M: 14581760 DEBUG: CApplication::OnKey: 230 pressed, action is 12
21:49:05 M: 14581760 DEBUG: CApplication::OnPlayBackPaused - Playback was paused
21:49:05 M: 14581760 DEBUG: ------ Window Init (DialogSeekBar.xml) ------
21:49:19 M: 14446592 DEBUG: CApplication::OnKey: 230 pressed, action is 12
21:49:19 M: 14446592 DEBUG: CDVDPlayerAudio:: Discontinuity - was:986731710.354983, should be:986916340.061048, error:184629.706066
21:49:19 M: 14450688 DEBUG: CApplication::OnPlayBackResumed - Playback was resumed
21:49:19 M: 14475264 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
21:56:59 M: 14004224 DEBUG: CApplication::OnKey: 230 pressed, action is 12
21:56:59 M: 14004224 DEBUG: CApplication::OnPlayBackPaused - Playback was paused
21:56:59 M: 14004224 DEBUG: ------ Window Init (DialogSeekBar.xml) ------
21:58:14 M: 13869056 DEBUG: CApplication::OnKey: 230 pressed, action is 12
21:58:14 M: 13869056 DEBUG: CDVDPlayerAudio:: Discontinuity - was:1447316966.012139, should be:1447492339.915139, error:175373.903000
21:58:14 M: 13869056 DEBUG: CApplication::OnPlayBackResumed - Playback was resumed
21:58:14 M: 13910016 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
22:18:37 M: 14123008 DEBUG: CApplication::OnKey: 195 pressed, action is 11
22:18:37 M: 14069760 DEBUG: ------ Window Init (DialogFullScreenInfo.xml) ------
22:18:37 M: 14016512 WARNING: old getenv from python.lib called, library check needed
22:18:40 M: 13910016 DEBUG: ------ Window Deinit (DialogFullScreenInfo.xml) ------
22:33:54 M: 15060992 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
22:33:55 M: 15065088 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
22:33:55 M: 15065088 INFO: CDVDPlayerVideo - Stillframe detected, switching to forced 23.976025 fps
22:33:57 M: 15065088 DEBUG: CDVDPlayer::SetCaching - caching state 1
22:33:57 M: 15065088 DEBUG: CDVDPlayer::HandleMessages - player started 1
22:33:57 M: 14974976 DEBUG: ------ Window Init (DialogSeekBar.xml) ------
22:33:57 M: 14745600 DEBUG: CDVDPlayer::HandleMessages - player started 2
22:33:57 M: 13852672 DEBUG: CDVDPlayer::SetCaching - caching state 3
22:33:57 M: 13856768 DEBUG: CDVDPlayerAudio:: Discontinuity - was:1464201030.355916, should be:3588740340.868321, error:2124539310.512406
22:33:57 M: 13856768 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
22:33:58 M: 13856768 DEBUG: CDVDPlayer::SetCaching - caching state 0
22:33:58 M: 13864960 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
22:46:37 M: 15044608 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
22:46:38 M: 15065088 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
22:46:38 M: 15065088 INFO: CDVDPlayerVideo - Stillframe detected, switching to forced 23.976025 fps
22:46:40 M: 15069184 DEBUG: CDVDPlayer::SetCaching - caching state 1
22:46:40 M: 15069184 DEBUG: CDVDPlayer::HandleMessages - player started 1
22:46:40 M: 15024128 DEBUG: ------ Window Init (DialogSeekBar.xml) ------
22:46:40 M: 14761984 DEBUG: CDVDPlayer::HandleMessages - player started 2
22:46:41 M: 13856768 DEBUG: CDVDPlayer::SetCaching - caching state 3
22:46:41 M: 13856768 DEBUG: CDVDPlayerAudio:: Discontinuity - was:3596525379.408224, should be:4348932339.990139, error:752406960.581915
22:46:41 M: 13856768 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
22:46:41 M: 13856768 DEBUG: CDVDPlayer::SetCaching - caching state 0
22:46:41 M: 13787136 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
22:59:29 M: 13860864 DEBUG: CApplication::OnKey: 224 pressed, action is 13
22:59:29 M: 13860864 NOTICE: CDVDPlayer::CloseFile()
22:59:29 M: 13860864 DEBUG: CApplication::OnPlayBackSpeedChanged - Playback speed changed
22:59:29 M: 13860864 DEBUG: CDVDPlayerAudio:: Discontinuity - was:4362319753.537588, should be:5116959314.376731, error:754639560.839143
22:59:29 M: 13860864 NOTICE: DVDPlayer: waiting for threads to exit
22:59:29 M: 13869056 NOTICE: CDVDPlayer::OnExit()
22:59:29 M: 13869056 NOTICE: DVDPlayer: closing audio stream
22:59:29 M: 13869056 NOTICE: Closing audio stream
22:59:29 M: 13869056 NOTICE: Waiting for audio thread to exit
22:59:29 M: 13869056 NOTICE: thread end: CDVDPlayerAudio::OnExit()
22:59:29 M: 14393344 NOTICE: Closing audio device
22:59:29 M: 14143488 NOTICE: Deleting audio codec
22:59:29 M: 14721024 NOTICE: DVDPlayer: closing video stream
22:59:29 M: 14721024 NOTICE: Closing video stream
22:59:29 M: 14721024 NOTICE: waiting for video thread to exit
22:59:29 M: 14721024 NOTICE: thread end: video_thread
22:59:29 M: 16375808 NOTICE: deleting video codec
22:59:29 M: 18395136 NOTICE: CDVDPlayer::OnExit() deleting demuxer
22:59:29 M: 23719936 NOTICE: CDVDPlayer::OnExit() deleting input stream
22:59:29 M: 23719936 DEBUG: CFileSMB::Close closing fd 10006
22:59:29 M: 23724032 DEBUG: CApplication::OnPlayBackStopped - Playback was stopped
22:59:29 M: 24248320 NOTICE: DVDPlayer: finished waiting
22:59:29 M: 24248320 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
22:59:29 M: 24248320 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------
22:59:30 M: 27987968 DEBUG: Setting resolution 1
22:59:30 M: 26103808 DEBUG: We set resolution 1
22:59:30 M: 25575424 DEBUG: Created YV12 texture 1
22:59:30 M: 25575424 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
22:59:30 M: 25563136 DEBUG: ------ Window Init (MyVideoNav.xml) ------
22:59:30 M: 25563136 INFO: Loading skin file: MyVideoNav.xml
22:59:31 M: 23764992 DEBUG: CGUIMediaWindow::GetDirectory (videodb://1/2/)
22:59:31 M: 23764992 DEBUG: ParentPath = [videodb://1/2/]
22:59:31 M: 23752704 DEBUG: CVideoDatabase::GetSetsNav query: select sets.idSet,sets.strSet,count(1),count(files.playCount) from sets join setlinkmovie on sets.idSet=setlinkmovie.idSet join movie on setlinkmovie.idMovie=movie.idMovie join files on files.idFile=movie.idFile group by sets.idSet
22:59:31 M: 23752704 DEBUG: CVideoDatabase::GetMoviesByWhere query: select * from movieview where movieview.idmovie NOT in (select idmovie from setlinkmovie)
22:59:31 M: 23740416 DEBUG: Time for actual SQL query = 42
22:59:31 M: 20320256 DEBUG: ------ Window Init (DialogBusy.xml) ------
22:59:31 M: 20320256 DEBUG: Time to retrieve movies from dataset = 95
22:59:31 M: 20332544 INFO: Loading skin file: DialogBusy.xml
22:59:31 M: 20062208 DEBUG: CFileItemList::Sort, sorting took 0 millis
22:59:31 M: 20062208 DEBUG: Saving fileitems [videodb://1/2/]
22:59:31 M: 20062208 DEBUG: -- items: 33, sort method: 25, ascending: true
22:59:31 M: 22372352 WARNING: old getenv from python.lib called, library check needed
Previous line repeats 1 times.
22:59:31 M: 15069184 WARNING: CDVDPlayer::CloseFile()
22:59:31 M: 15069184 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
22:59:31 M: 15069184 NOTICE: DVDPlayer: waiting for threads to exit
22:59:31 M: 15069184 NOTICE: DVDPlayer: finished waiting
22:59:31 M: 15069184 NOTICE: CDVDPlayerVideo::~CDVDPlayerVideo - uninitting video device
22:59:31 M: 16121856 DEBUG: CXBoxRenderer::UnInit - Cleaning up resources
22:59:31 M: 16584704 DEBUG: Deleted YV12 texture 0
22:59:31 M: 17047552 DEBUG: Deleted YV12 texture 1
22:59:31 M: 17051648 DEBUG: CApplication::OnMessage : Translating SetFocus(50)
22:59:31 M: 17051648 DEBUG: CApplication::OnMessage : To SetFocus(50)
22:59:31 M: 17051648 DEBUG: CApplication::SaveFileState - Saving file state for video item smb://CUBESTATION/Video/Films/Bad Ass (2012)/Bad Ass (2012) RETAIL DD 5.1 1.5 GB SRT XVID.avi
22:59:31 M: 17039360 DEBUG: CApplication::SaveFileState - Marking video item smb://CUBESTATION/Video/Films/Bad Ass (2012)/Bad Ass (2012) RETAIL DD 5.1 1.5 GB SRT XVID.avi as watched
22:59:31 M: 17580032 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
22:59:31 M: 18022400 DEBUG: CGUIMediaWindow::GetDirectory (videodb://1/2/)
22:59:31 M: 18022400 DEBUG: ParentPath = [videodb://1/2/]
22:59:32 M: 18010112 DEBUG: CVideoDatabase::GetSetsNav query: select sets.idSet,sets.strSet,count(1),count(files.playCount) from sets join setlinkmovie on sets.idSet=setlinkmovie.idSet join movie on setlinkmovie.idMovie=movie.idMovie join files on files.idFile=movie.idFile group by sets.idSet
22:59:32 M: 18010112 DEBUG: CVideoDatabase::GetMoviesByWhere query: select * from movieview where movieview.idmovie NOT in (select idmovie from setlinkmovie)
22:59:32 M: 18001920 DEBUG: Time for actual SQL query = 38
22:59:32 M: 17989632 DEBUG: Time to retrieve movies from dataset = 88
22:59:32 M: 18014208 DEBUG: CFileItemList::Sort, sorting took 0 millis
22:59:32 M: 18014208 DEBUG: Saving fileitems [videodb://1/2/]
22:59:32 M: 18014208 DEBUG: -- items: 33, sort method: 25, ascending: true
22:59:32 M: 17293312 WARNING: old getenv from python.lib called, library check needed
22:59:39 M: 24059904 DEBUG: SECTION:UnloadDelayed(DLL: Q:\system\players\dvdplayer\avutil-51.dll)
22:59:40 M: 24059904 DEBUG: SECTION:UnloadDelayed(DLL: Q:\system\players\dvdplayer\avcodec-53.dll)
22:59:40 M: 24059904 DEBUG: SECTION:UnloadDelayed(DLL: Q:\system\players\dvdplayer\avformat-53.dll)
22:59:40 M: 24059904 DEBUG: GetModuleHandleA('libgcc_s_dw2-1.dll') failed
Previous line repeats 2 times.
22:59:40 M: 24080384 DEBUG: Q:\system\players\dvdplayer\avutil-51.dll (base 68B80000): Detected memory leaks: 9 leaks
22:59:40 M: 24129536 DEBUG: leak caller address 68B86768, size 24530, counter 8
22:59:40 M: 24129536 DEBUG: leak caller address 68B867C9, size 32784, counter 1
22:59:40 M: 24129536 DEBUG: avutil-51.dll: Total bytes leaked: 57314
    (1-1/1)