rendered paste body19:19:10 M: 54185984 NOTICE: -----------------------------------------------------------------------
19:19:10 M: 54165504 NOTICE: Starting XBoxMediaCenter. Built on Dec 25 2006
19:19:10 M: 54165504 NOTICE: Q is mapped to: Harddisk0\Partition1\APPS\XBMC
19:19:10 M: 54165504 NOTICE: Log File is located: Q:\xbmc.log
19:19:10 M: 54165504 NOTICE: -----------------------------------------------------------------------
19:19:10 M: 54165504 NOTICE: Setup DirectX
19:19:10 M: 54120448 NOTICE: load settings...
19:19:10 M: 54120448 NOTICE: loading T:\guisettings.xml
19:19:10 M: 53915648 NOTICE: Getting hardware information now...
19:19:10 M: 53915648 NOTICE: Checking resolution 1
19:19:10 M: 53915648 NOTICE: Per AV pack settings are on
19:19:10 M: 53895168 NOTICE: HDTV found : loading T:\avpacksettings.xml
19:19:10 M: 53821440 NOTICE: Getting hardware information now...
19:19:10 M: 53821440 NOTICE: Checking resolution 1
19:19:10 M: 54067200 NOTICE: q:\userdata\sources.xml
19:19:11 M: 43507712 ERROR: Window Translator: Can't find window myvideotitles
19:19:11 M: 42196992 NOTICE: Checking the Date!
19:19:12 M: 40108032 NOTICE: start dvd mediatype detection
19:19:12 M: 39583744 NOTICE: initializing playlistplayer
19:19:12 M: 39583744 NOTICE: DONE initializing playlistplayer
19:19:12 M: 39583744 NOTICE: load default skin:[PDM]
19:19:14 M: 40972288 NOTICE: use static ip
19:19:14 M: 40947712 NOTICE: initialize done
19:19:14 M: 40980480 INFO: Key combination detected for full debug logging (X+Y)
19:19:14 M: 40943616 INFO: CNetwork::LogState - Link: full duplex
19:19:14 M: 40943616 NOTICE: Running the application...
19:19:14 M: 41009152 INFO: CNetwork::LogState - Link: 100 mbps
19:19:14 M: 40968192 INFO: CNetwork::LogState - State: dns
19:19:14 M: 40972288 DEBUG: LoadLibraryA('python24.dll')
19:19:14 M: 40935424 INFO: CNetwork::LogState - State: static
19:19:15 M: 40996864 INFO: CNetwork::LogState - ip: 192.168.0.50
19:19:15 M: 40923136 INFO: CNetwork::LogState - subnet: 255.255.255.0
19:19:15 M: 39841792 INFO: CNetwork::LogState - gateway: 192.168.0.1
19:19:15 M: 39841792 INFO: CNetwork::LogState - dns: 195.92.195.94, 0.0.0.0
19:19:15 M: 39804928 INFO: WEATHER: Downloading weather
19:19:15 M: 39841792 INFO: Get URL: http://xoap.weather.com/weather/local/UKXX0139?cc=*&unit=m&dayf=4&prod=xoap&par=1004124588&key=079f24145f208494
19:19:15 M: 39878656 DEBUG: LoadLibrary('python24.dll') returning: 0xc14de0
19:19:16 M: 39841792 DEBUG: dllGetProcAddress(0x9a0e08(kernel32.dll), 'InterlockedCompareExchange') => 0x1c2964
19:19:16 M: 39473152 DEBUG: GetModuleFileNameA(0x0, 0xd92490, 256) => 'xbmc.xbe'
19:19:16 M: 39464960 DEBUG: advapi32.dll fake function RegQueryInfoKeyA called
19:19:16 M: 39505920 DEBUG: advapi32.dll fake function RegQueryInfoKeyA called
19:19:16 M: 39477248 INFO: WEATHER: Weather download successful
19:19:16 M: 39489536 INFO: Stating file Q:\system\python\python24.zlib
19:19:17 M: 34799616 INFO: Stating file Q:\system\python\python24.zlib\zlib
19:19:17 M: 35037184 INFO: Stating file Q:\system\python\DLLs
19:19:17 M: 34754560 INFO: Stating file Q:\system\python\DLLs\zlib
19:19:17 M: 34832384 DEBUG: LoadLibraryExA called with flags:
- LOAD_WITH_ALTERED_SEARCH_PATH
19:19:17 M: 34889728 DEBUG: LoadLibraryA('zlib.pyd')
19:19:17 M: 34885632 INFO: Using protocol iso9660://
19:19:17 M: 34885632 INFO: Disc label: STAR_WARS_EPISODE_IV
19:19:17 M: 35151872 DEBUG: MEDIA_DETECT::CDetectDVDMedia::SetNewDVDShareUrl: looking for disc thumb:[iso9660://folder.jpg]
19:19:17 M: 34885632 DEBUG: kernel32.dll fake function DisableThreadLibraryCalls called
19:19:17 M: 34885632 DEBUG: LoadLibrary('zlib.pyd') returning: 0xc35010
19:19:17 M: 34885632 DEBUG: dllGetProcAddress(0x13c0000(zlib.pyd), 'initzlib') => 0x13c2150
19:19:18 M: 34205696 INFO: Stating file Q:\system\python
19:19:18 M: 34209792 INFO: Stating file Q:\system\python\lib\site-packages
19:19:18 M: 33837056 INFO: Stating file Q:\system\python\python24.zlib\encodings
19:19:18 M: 33837056 INFO: Stating file Q:\system\python\python24.zlib
19:19:18 M: 34082816 INFO: Stating file Q:\system\python\python24.zlib\encodings\codecs
19:19:18 M: 33837056 INFO: Stating file Q:\system\python\python24.zlib\encodings\exceptions
19:19:18 M: 33837056 INFO: Stating file Q:\system\python\python24.zlib\encodings\types
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\python24.zlib\encodings\cp0
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\python24.zlib\cp0
19:19:18 M: 34091008 INFO: Stating file Q:\system\python\DLLs\cp0
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\Lib
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\Lib\cp0
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\spyce
19:19:18 M: 34091008 INFO: Stating file Q:\system\python\spyce\cp0
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\python24.zip
19:19:18 M: 33824768 INFO: Stating file Q:\system\python
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\python24.zip\cp0
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\lib\plat-win
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\lib
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\lib\plat-win\cp0
19:19:18 M: 34091008 INFO: Stating file Q:\system\python\lib\lib-tk
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\lib
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\lib\lib-tk\cp0
19:19:18 M: 33824768 INFO: Stating file Q:\python
19:19:18 M: 34091008 INFO: Stating file Q:\python\cp0
19:19:18 M: 33824768 INFO: Stating file Q:\system\python
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\cp0
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\python24.zlib\sitecustomize
19:19:18 M: 34091008 INFO: Stating file Q:\system\python\DLLs\sitecustomize
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\Lib\sitecustomize
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\spyce\sitecustomize
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\python24.zip\sitecustomize
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\lib\plat-win\sitecustomize
19:19:18 M: 34091008 INFO: Stating file Q:\system\python\lib\lib-tk\sitecustomize
19:19:18 M: 33824768 INFO: Stating file Q:\python\sitecustomize
19:19:18 M: 33824768 INFO: Stating file Q:\system\python\sitecustomize
19:19:18 M: 33804288 INFO: -->Python Initialized<--
19:19:18 M: 33804288 INFO:
19:19:18 M: 33280000 DEBUG: CNetwork::NetworkMessage - Starting network services
19:19:18 M: 33259520 NOTICE: start timeserver client
19:19:18 M: 32731136 DEBUG: kernel32.dll fake function SetConsoleCtrlHandler called
19:19:18 M: 32731136 NOTICE: Webserver: Starting...
19:19:18 M: 32919552 INFO: Scriptresult: Succes
19:19:18 M: 32653312 INFO: Python script stopped
19:19:18 M: 33177600 DEBUG: xbmcHttpShim starts
19:19:18 M: 32649216 NOTICE: XBFileZilla: Starting...
19:19:18 M: 32575488 INFO: WebServer: Server starting using Q:\web on 192.168.0.50:80
19:19:18 M: 31531008 DEBUG: AudioScrobbler: load cache
19:19:18 M: 31797248 DEBUG: DB: Registering database table <users>
19:19:18 M: 31191040 DEBUG: AudioScrobbler: ...
19:19:18 M: 30851072 DEBUG: DB: Registering database table <groups>
19:19:18 M: 30457856 INFO: Get URL: http://post.audioscrobbler.com/?hs=true&p=1.1&c=xbm&v=0.1&u=gergtreble
19:19:18 M: 30457856 DEBUG: DB: Registering database table <access>
19:19:18 M: 30400512 DEBUG: UM: Loading User Configuration from file <umconfig.txt>
19:19:18 M: 30666752 DEBUG: DB: About to read data file <Q:\web\umconfig.txt>
19:19:18 M: 30937088 DEBUG: DB: Failed to stat persistent data file.
19:19:18 M: 30785536 DEBUG: webs: Listening for HTTP requests at address 192.168.0.50
19:19:18 M: 30785536 NOTICE: Webserver: Started
19:19:18 M: 28749824 DEBUG: AudioScrobbler: Handshaking: Client up to date.
19:19:18 M: 28741632 DEBUG: AudioScrobbler: Submit interval set to 1 seconds.
19:19:18 M: 28741632 NOTICE: AudioScrobbler: Handshake successful.
19:19:18 M: 28753920 INFO: Scriptresult: Succes
19:19:18 M: 28999680 INFO: Python script stopped
19:19:18 M: 29544448 INFO: Python, unloading python24.dll cause no scripts are running anymore
19:19:19 M: 30203904 NOTICE: XBFileZilla: Started
19:19:21 M: 35323904 DEBUG: CApplication::OnKey: 270 pressed, action is 3
19:19:21 M: 35205120 DEBUG: CApplication::OnKey: 271 pressed, action is 4
19:19:22 M: 35225600 DEBUG: CApplication::OnKey: 256 pressed, action is 7
19:19:22 M: 34701312 INFO: WEATHER: Downloading weather
19:19:22 M: 34701312 INFO: Get URL: http://xoap.weather.com/weather/local/UKXX0139?cc=*&unit=m&dayf=4&prod=xoap&par=1004124588&key=079f24145f208494
19:19:22 M: 34701312 DEBUG: Activating window ID: 10000
19:19:22 M: 34701312 DEBUG: Checking if window ID 10000 is locked.
19:19:23 M: 36995072 INFO: WEATHER: Weather download successful
19:19:23 M: 37412864 DEBUG: Activating window ID: 10024
19:19:23 M: 37412864 DEBUG: Checking if window ID 10024 is locked.
19:19:23 M: 37588992 INFO: Attempting to default to: My Videos
19:19:23 M: 37588992 DEBUG: CURL::CURL - Url has no protocol My Videos, empty CURL created
19:19:23 M: 37588992 INFO: Success! Opened destination path: My Videos
19:19:23 M: 37588992 DEBUG: CVirtualPathDirectory::GetTypeAndBookmark(virtualpath://video/Videos) = [video],[Videos]
19:19:23 M: 37588992 DEBUG: CURL::CURL - Url has no protocol Videos, empty CURL created
19:19:23 M: 37576704 INFO: Loading skin file: MyVideo.xml
19:19:23 M: 37543936 ERROR: Texture manager unable to load file: Q:\skin\PDM\media\select-left.gif
19:19:23 M: 37539840 ERROR: Texture manager unable to load file: Q:\skin\PDM\media\select-right.gif
19:19:23 M: 37486592 DEBUG: CGUIMediaWindow::GetDirectory (smb://192.168.0.77/DISK 1/My Videos)
19:19:23 M: 37486592 DEBUG: ParentPath = [smb://192.168.0.77/DISK 1/My Videos]
19:19:23 M: 37146624 DEBUG: DIRECTORY::CSMBDirectory::OpenDir - Using authentication url smb://192.168.0.77/DISK%201/My%20Videos
19:19:29 M: 33464320 DEBUG: CApplication::OnKey: 257 pressed, action is 9
19:19:29 M: 33652736 DEBUG: CGUIMediaWindow::GetDirectory ()
19:19:29 M: 33652736 DEBUG: ParentPath = []
19:19:29 M: 33652736 DEBUG: CVirtualPathDirectory::GetTypeAndBookmark(virtualpath://video/Videos) = [video],[Videos]
19:19:29 M: 33652736 DEBUG: CURL::CURL - Url has no protocol Videos, empty CURL created
19:19:30 M: 33546240 DEBUG: CApplication::OnKey: 270 pressed, action is 3
19:19:30 M: 33427456 DEBUG: CApplication::OnKey: 270 pressed, action is 3
19:19:31 M: 33447936 DEBUG: CApplication::OnKey: 256 pressed, action is 7
19:19:31 M: 33632256 DEBUG: CGUIMediaWindow::GetDirectory (iso9660://)
19:19:31 M: 33632256 DEBUG: ParentPath = []
19:19:35 M: 33705984 DEBUG: CApplication::OnKey: 271 pressed, action is 4
19:19:35 M: 33587200 DEBUG: CApplication::OnKey: 256 pressed, action is 7
19:19:35 M: 33632256 DEBUG: CGUIMediaWindow::GetDirectory (iso9660://VIDEO_TS)
19:19:35 M: 33632256 DEBUG: ParentPath = [iso9660://]
19:19:37 M: 33705984 DEBUG: CApplication::OnKey: 257 pressed, action is 9
19:19:37 M: 33632256 DEBUG: CGUIMediaWindow::GetDirectory (iso9660://)
19:19:37 M: 33632256 DEBUG: ParentPath = []
19:19:37 M: 33566720 DEBUG: CApplication::OnKey: 257 pressed, action is 9
19:19:37 M: 33611776 DEBUG: CGUIMediaWindow::GetDirectory ()
19:19:37 M: 33611776 DEBUG: ParentPath = []
19:19:37 M: 33611776 DEBUG: CVirtualPathDirectory::GetTypeAndBookmark(virtualpath://video/Videos) = [video],[Videos]
19:19:37 M: 33611776 DEBUG: CURL::CURL - Url has no protocol Videos, empty CURL created
19:19:40 M: 33566720 DEBUG: CApplication::OnKey: 261 pressed, action is 117
19:19:40 M: 33566720 INFO: Loading skin file: DialogContextMenu.xml
19:19:40 M: 33566720 DEBUG: CURL::CURL - Url has no protocol My Videos, empty CURL created
19:19:41 M: 33099776 DEBUG: CApplication::OnKey: 256 pressed, action is 7
19:19:41 M: 33427456 DEBUG: CPlayerCoreFactor::GetPlayers(dvd://1)
19:19:41 M: 33427456 NOTICE: DVDPlayer: Opening: dvd://1
19:19:41 M: 33427456 NOTICE: CDVDPlayer::CloseFile()
19:19:41 M: 33427456 NOTICE: DVDPlayer: waiting for threads to exit
19:19:41 M: 33427456 NOTICE: DVDPlayer: finished waiting
19:19:41 M: 32903168 NOTICE: Creating InputStream
19:19:41 M: 32649216 INFO: msg: libdvdnav: Using dvdnav version 0.2.0cvs from http://dvd.sf.net
19:19:41 M: 32649216 INFO: msg: libdvdread: Using libdvdcss version 1.2.9 for DVD access
19:19:41 M: 32649216 INFO: Stating file \Device\Cdrom0
19:19:41 M: 32649216 INFO: msg: libdvdcss debug:
19:19:41 M: 32649216 INFO: msg: opening target `\Device\Cdrom0'
19:19:41 M: 32649216 INFO: msg:
19:19:41 M: 32649216 INFO: msg: libdvdcss debug:
19:19:41 M: 32649216 INFO: msg: using Win2K API for access
19:19:41 M: 32649216 INFO: msg:
19:19:41 M: 32649216 INFO: msg: libdvdcss debug:
19:19:41 M: 32649216 INFO: msg: disc is scrambled
19:19:41 M: 32649216 INFO: msg:
19:19:41 M: 32649216 INFO: msg: libdvdcss debug:
19:19:41 M: 32649216 INFO: msg: requesting AGID
19:19:41 M: 32649216 INFO: msg:
19:19:41 M: 32649216 INFO: msg: libdvdcss debug:
19:19:41 M: 32649216 INFO: msg: drive authenticated, using variant 0
19:19:41 M: 32649216 INFO: msg:
19:19:41 M: 32649216 INFO: msg: libdvdcss debug:
19:19:41 M: 32649216 INFO: msg: authentication established
19:19:41 M: 32649216 INFO: msg:
19:19:42 M: 32649216 INFO: msg: libdvdcss debug:
19:19:42 M: 32649216 INFO: msg: GetASF authenticated, ASF=1
19:19:42 M: 32649216 INFO: msg:
19:19:42 M: 32649216 INFO: msg: libdvdcss debug:
19:19:42 M: 32649216 INFO: msg: decrypting disc key bf:72:f2:0a:61
19:19:42 M: 32649216 INFO: msg:
19:19:42 M: 32649216 INFO: msg: libdvdcss debug:
19:19:42 M: 32649216 INFO: msg: trying player key 01:af:e3:12:80
19:19:42 M: 32649216 INFO: msg:
19:19:42 M: 32649216 INFO: msg: libdvdcss debug:
19:19:42 M: 32649216 INFO: msg: decrypted disc key is 00:fa:b4:a2:ba
19:19:42 M: 32649216 INFO: msg:
19:19:42 M: 32649216 INFO: msg: libdvdcss debug:
19:19:42 M: 32649216 INFO: msg: using CSS key cache dir: T:\cache/STAR_WARS_EPISODE_IV/2004061418065500-00fab4a2ba/
19:19:42 M: 32649216 INFO: msg:
19:19:42 M: 32649216 INFO: msg: libdvdnav: vm: DVD Title: STAR_WARS_EPISODE_IV
19:19:42 M: 32649216 INFO: msg: libdvdnav: Unable to find map file 'Q:\dvdplayer/.dvdnav/STAR_WARS_EPISODE_IV.map'
19:19:42 M: 32649216 INFO: msg: libdvdnav: DVD disk reports itself with Region mask 0x00f50000. Regions:
19:19:42 M: 32649216 INFO: msg: 2
19:19:42 M: 32649216 INFO: msg: 4
19:19:42 M: 32649216 DEBUG: msg:
19:19:42 M: 32649216 NOTICE: DVDPlayer: playing a dvd with menu's
19:19:42 M: 32649216 NOTICE: Creating Demuxer
19:19:43 M: 28995584 DEBUG: Playback has started
19:19:43 M: 28995584 DEBUG: CDVDInputStreamNavigator::SetActiveSubtitleStream - id: 0, stream: -1
19:19:43 M: 29179904 DEBUG: CGUIMediaWindow::GetDirectory ()
19:19:43 M: 29179904 DEBUG: ParentPath = []
19:19:43 M: 29179904 DEBUG: CVirtualPathDirectory::GetTypeAndBookmark(virtualpath://video/Videos) = [video],[Videos]
19:19:43 M: 29179904 DEBUG: CURL::CURL - Url has no protocol Videos, empty CURL created
19:19:43 M: 29179904 DEBUG: DVDNAV_HIGHLIGHT: Highlight button 1
19:19:43 M: 29179904 DEBUG: - DVDNAV_VTS_CHANGE (HOLDING)
19:19:43 M: 29179904 DEBUG: DVDNAV_VTS_CHANGE
19:19:43 M: 29179904 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 1
19:19:43 M: 29163520 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
19:19:43 M: 29143040 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 1
19:19:43 M: 29122560 ERROR: Error reading data from demuxer
19:19:43 M: 29126656 DEBUG: DVDNAV_CELL_CHANGE
19:19:43 M: 29106176 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:19:43 M: 29106176 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:19:43 M: 29147136 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:19:43 M: 28655616 INFO: msg: libdvdcss debug:
19:19:43 M: 29179904 INFO: msg: title key found in cache 00:00:00:00:00
19:19:43 M: 29179904 INFO: msg:
19:19:43 M: 28151808 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:0 TO:480000 DIFF:480000
19:19:43 M: 28053504 NOTICE: Opening video stream: 0
19:19:43 M: 27983872 NOTICE: Creating video codec with codec id: 2
19:19:43 M: 28000256 DEBUG: FactoryCodec - Video: libmpeg2 - Opening
19:19:43 M: 27836416 DEBUG: CGUIInfoManager::SetCurrentMovie(dvd://1)
19:19:43 M: 26574848 DEBUG: FactoryCodec - Video: libmpeg2 - Opened
19:19:43 M: 26554368 NOTICE: Creating video thread
19:19:43 M: 26046464 NOTICE: running thread: video_thread
19:19:43 M: 26046464 DEBUG: CDVDPlayerVideo::Process - Resync recieved.
19:19:43 M: 25018368 DEBUG: CDVDPlayerVideo:: Resync - clock:0, delay:0
19:19:43 M: 23130112 NOTICE: Initializing video device
19:19:43 M: 23130112 DEBUG: CXBoxRenderManager::PreInit - Selected RGB-Renderer
19:19:43 M: 23089152 NOTICE: fps: 25.000000, pwidth: 720, pheight: 576, dwidth: 1024, dheight: 576
19:19:43 M: 23089152 NOTICE: Display resolution USER : 720p 16:9 (1)
19:19:43 M: 22609920 DEBUG: - DVDNAV_WAIT (HOLDING)
19:19:43 M: 22618112 DEBUG: CVideoDatabase::GetMovieInfo(dvd://1), query = select * from movie join path on movie.idPath = path.idPath join movieinfo on movie.idMovie = movieinfo.idMovie join files on movie.idMovie = files.idMovie where (path.strPath like 'dvd:/' and files.strFileName like '/1') or path.strPath like 'stack://dvd:/'
19:19:43 M: 22573056 DEBUG: DVDNAV_STILL_FRAME - waiting 3 sec, with delay of 0 sec
19:19:43 M: 22634496 DEBUG: Activating window ID: 12005
19:19:43 M: 22634496 DEBUG: Checking if window ID 12005 is locked.
19:19:43 M: 26152960 DEBUG: Setting resolution 1
19:19:43 M: 28037120 DEBUG: We set resolution 1
19:19:43 M: 27373568 DEBUG: Created YV12 texture 0
19:19:43 M: 27373568 INFO: Loading skin file: VideoFullscreen.xml
19:19:43 M: 27365376 INFO: Loading skin file: VideoOSD.xml
19:19:43 M: 26763264 INFO: Loading skin file: VideoOSDSettings.xml
19:19:43 M: 26583040 INFO: Loading skin file: VideoOSDSettings.xml
19:19:43 M: 26554368 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\Media\Fonts\Arial.ttf (28): width = 76, height = 39
19:19:44 M: 26640384 INFO: CDVDPlayerVideo - Stillframe detected, switching to forced 25 fps
19:19:46 M: 26042368 DEBUG: DVDNAV_VTS_CHANGE
19:19:46 M: 26042368 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 1
19:19:46 M: 26042368 DEBUG: CDVDPlayerVideo - CDVDMsg::VIDEO_SET_ASPECT
19:19:46 M: 26042368 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
19:19:46 M: 26042368 DEBUG: DVDNAV_CELL_CHANGE
19:19:46 M: 26042368 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:19:46 M: 26042368 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:19:46 M: 26042368 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:19:46 M: 26042368 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:3480000 TO:480000 DIFF:-3000000
19:19:47 M: 25571328 DEBUG: CDVDPlayer::CheckContinuity - Potential long duration frame
19:19:47 M: 25571328 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:19:47 M: 25796608 NOTICE: Opening Subtitle stream: 1
19:19:47 M: 25706496 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:19:47 M: 25706496 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:19:47 M: 25931776 DEBUG: DVDNAV_CELL_CHANGE
19:19:47 M: 25952256 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:19:47 M: 25952256 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:19:47 M: 25952256 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:19:47 M: 25530368 DEBUG: CDVDPlayer::CheckContinuity - Potential long duration frame
19:19:47 M: 25530368 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:19:47 M: 25026560 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:19:47 M: 25026560 DEBUG: - DVDNAV_WAIT (HOLDING)
19:19:47 M: 25243648 DEBUG: DVDNAV_STILL_FRAME - waiting 10 sec, with delay of 0 sec
19:19:47 M: 25243648 INFO: CDVDPlayerVideo - Stillframe detected, switching to forced 25 fps
19:19:57 M: 25309184 DEBUG: DVDNAV_VTS_CHANGE
19:19:57 M: 25382912 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
19:19:57 M: 25382912 DEBUG: DVDNAV_CELL_CHANGE
19:19:57 M: 25403392 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:19:57 M: 25403392 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:19:57 M: 25403392 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:19:57 M: 25403392 DEBUG: CDVDPlayerVideo - CDVDMsg::VIDEO_SET_ASPECT
19:19:57 M: 25403392 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
19:19:57 M: 25403392 INFO: msg: libdvdcss debug:
19:19:57 M: 25403392 INFO: msg: title key found in cache c0:83:08:de:97
19:19:57 M: 25403392 INFO: msg:
19:19:57 M: 25403392 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:20480000 TO:195666 DIFF:-20284333
19:19:57 M: 25391104 DEBUG: CDVDPlayer::CheckContinuity - Potential long duration frame
19:19:57 M: 25391104 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:19:57 M: 25382912 NOTICE: Opening audio stream: 1
19:19:57 M: 25362432 NOTICE: Finding audio codec for: 86020
19:19:57 M: 25362432 DEBUG: FactoryCodec - Audio: passthrough - Opening
19:19:57 M: 25055232 DEBUG: FactoryCodec - Audio: passthrough - Opened
19:19:57 M: 25055232 NOTICE: Creating audio thread
19:19:57 M: 24530944 NOTICE: running thread: CDVDPlayerAudio::Process()
19:19:57 M: 24530944 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
19:19:57 M: 24530944 DEBUG: CDVDAudioCodecPassthrough: Synced to AC3 frame
19:19:57 M: 24510464 NOTICE: Creating audio device with codec id: 86020, channels: 2, sample rate: 48000, pass-through
19:19:57 M: 24875008 DEBUG: CDVDPlayerAudio:: Resync - clock:23031999, delay:59666
19:19:57 M: 23433216 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:19:57 M: 23437312 DEBUG: CDVDPlayerVideo - CDVDMsg::VIDEO_SET_ASPECT
19:19:57 M: 23437312 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC
19:20:12 M: 23199744 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:20:12 M: 23339008 DEBUG: DVDNAV_CELL_CHANGE
19:20:12 M: 23339008 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:20:12 M: 23339008 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:20:12 M: 23339008 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:20:12 M: 23412736 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:17595666 TO:195666 DIFF:-17400000
19:20:14 M: 23277568 DEBUG: CDVDPlayerAudio:: Detected Audio Discontinuity, syncing clock. diff was: -8110, -8101, av: -8105
19:20:22 M: 23203840 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:20:22 M: 23412736 DEBUG: DVDNAV_CELL_CHANGE
19:20:22 M: 23412736 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:20:22 M: 23412736 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:20:22 M: 23412736 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:20:22 M: 23457792 NOTICE: Opening Subtitle stream: 2
19:20:22 M: 23367680 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:20:24 M: 23138304 DEBUG: CDVDPlayerAudio:: Detected Audio Discontinuity, syncing clock. diff was: -56, 31970, av: 15957
19:20:39 M: 23019520 DEBUG: CApplication::OnKey: 271 pressed, action is 4
19:20:39 M: 23019520 DEBUG: - move down
19:20:39 M: 23060480 DEBUG: DVDNAV_HIGHLIGHT: Highlight button 2
19:20:39 M: 23097344 DEBUG: CApplication::OnKey: 271 pressed, action is 4
19:20:39 M: 23080960 DEBUG: - move down
19:20:39 M: 23105536 DEBUG: DVDNAV_HIGHLIGHT: Highlight button 3
19:20:41 M: 22896640 DEBUG: - DVDNAV_WAIT (HOLDING)
19:20:41 M: 23257088 DEBUG: DVDNAV_CELL_CHANGE
19:20:41 M: 23277568 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:20:41 M: 23277568 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:20:41 M: 23277568 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:20:41 M: 23302144 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:29155666 TO:9795666 DIFF:-19360000
19:20:41 M: 23212032 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:20:43 M: 23019520 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC
19:20:43 M: 23056384 DEBUG: CDVDPlayerAudio:: Resync - clock:69135999, delay:57833
19:20:45 M: 23076864 DEBUG: CApplication::OnKey: 256 pressed, action is 7
19:20:45 M: 23076864 DEBUG: - button select
19:20:45 M: 23089152 DEBUG: DVDNAV_HOP_CHANNEL
19:20:45 M: 24727552 DEBUG: CDVDPlayerAudio:: Detected Audio Discontinuity, syncing clock. diff was: -28, 72126, av: 36049
19:20:45 M: 24862720 ERROR: Error reading data from demuxer
19:20:45 M: 24862720 DEBUG: DVDNAV_HIGHLIGHT: Highlight button 1
19:20:45 M: 24862720 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:20:45 M: 24862720 DEBUG: DVDNAV_CELL_CHANGE
19:20:45 M: 24862720 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:20:45 M: 24862720 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:20:45 M: 24862720 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:20:45 M: 24875008 DEBUG: CDVDVideoCodecLibMpeg2::Reset()
19:20:45 M: 24895488 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:13555666 TO:195666 DIFF:-13360000
19:20:45 M: 24592384 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC
19:20:45 M: 24739840 DEBUG: CDVDAudioCodecPassthrough: Synced to AC3 frame
19:20:45 M: 24739840 DEBUG: CDVDPlayerAudio:: Resync - clock:73151999, delay:59666
19:20:47 M: 23224320 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:20:47 M: 23400448 DEBUG: DVDNAV_CELL_CHANGE
19:20:47 M: 23400448 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:20:47 M: 23400448 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:20:47 M: 23400448 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:20:47 M: 23359488 NOTICE: Opening Subtitle stream: 2