rendered paste body19:00:28 M: 54112256 NOTICE: -----------------------------------------------------------------------
19:00:28 M: 54091776 NOTICE: Starting XBoxMediaCenter. Built on Mar 15 2007
19:00:28 M: 54091776 NOTICE: Q is mapped to: Harddisk0\Partition1\XBMC
19:00:28 M: 54091776 NOTICE: Log File is located: Q:\xbmc.log
19:00:28 M: 54091776 NOTICE: -----------------------------------------------------------------------
19:00:28 M: 54091776 NOTICE: Setup DirectX
19:00:30 M: 54063104 NOTICE: load settings...
19:00:30 M: 54063104 NOTICE: loading T:\guisettings.xml
19:00:30 M: 53903360 NOTICE: Getting hardware information now...
19:00:30 M: 53903360 NOTICE: Checking resolution 10
19:00:30 M: 53903360 NOTICE: Setting autoresolution mode 1
19:00:30 M: 53903360 NOTICE: Getting hardware information now...
19:00:30 M: 53903360 NOTICE: Checking resolution 10
19:00:30 M: 53903360 NOTICE: Setting autoresolution mode 1
19:00:30 M: 53903360 NOTICE: Per AV pack settings are on
19:00:30 M: 53903360 NOTICE: HDTV found : loading T:\avpacksettings.xml
19:00:30 M: 53886976 NOTICE: Getting hardware information now...
19:00:30 M: 53866496 NOTICE: Checking resolution 10
19:00:30 M: 53866496 NOTICE: Setting autoresolution mode 1
19:00:30 M: 54005760 NOTICE: q:\userdata\sources.xml
19:00:30 M: 54005760 INFO: Key combination detected for full debug logging (X+Y)
19:00:30 M: 54005760 INFO: Checking skinpath existance, and existence of keymap.xml:Q:\skin...
19:00:30 M: 54005760 DEBUG: We set resolution 5
19:00:30 M: 44265472 INFO: load language info file:Q:\language\english\langinfo.xml
19:00:30 M: 43741184 INFO: load language file:Q:\language\english\strings.xml
19:00:30 M: 40083456 INFO: load keymapping
19:00:30 M: 40116224 INFO: Loading P:\keymap.xml
19:00:30 M: 39956480 ERROR: Window Translator: Can't find window my changes
19:00:30 M: 43511808 INFO: Checking skin version of: Xbox-Classic
19:00:30 M: 43515904 INFO: Skin version is: 2.1
19:00:30 M: 43515904 INFO: GUI format 1280x720 720p 16:9
19:00:30 M: 43515904 INFO: install unhandled exception filter
19:00:30 M: 43515904 INFO: creating subdirectories
19:00:30 M: 43515904 INFO: userdata folder: q:\userdata
19:00:30 M: 43515904 INFO: recording folder:
19:00:30 M: 43515904 INFO: screenshots folder:F:\Pictures\Screenshots
19:00:30 M: 43515904 INFO: thumbnails folder:q:\userdata\Thumbnails
19:00:30 M: 42991616 NOTICE: Checking the Date!
19:00:30 M: 42991616 INFO: - Current Date is: 15-3-2007
19:00:30 M: 42991616 NOTICE: start dvd mediatype detection
19:00:30 M: 42467328 NOTICE: initializing playlistplayer
19:00:30 M: 42467328 NOTICE: DONE initializing playlistplayer
19:00:30 M: 42467328 INFO: lcd not used
19:00:30 M: 42467328 NOTICE: load default skin:[Xbox-Classic]
19:00:30 M: 42467328 INFO: load skin from:Q:\skin\Xbox-Classic
19:00:30 M: 42467328 INFO: delete old skin...
19:00:30 M: 42467328 INFO: Default 4:3 resolution directory is Q:\skin\Xbox-Classic\pal
19:00:30 M: 42467328 INFO: Default 16:9 resolution directory is Q:\skin\Xbox-Classic\pal16x9
19:00:30 M: 42467328 INFO: Skin version is: 2.1
19:00:31 M: 42467328 INFO: Loading skin includes from Q:\skin\Xbox-Classic\pal16x9\includes.xml
19:00:31 M: 41861120 INFO: load fonts for skin...
19:00:31 M: 41861120 INFO: Loading fonts from Q:\skin\Xbox-Classic\720p\font.xml
19:00:31 M: 41861120 WARNING: file doesnt have <fontset> with name 'Trebuchet TTF', defaulting to first fontset
19:00:31 M: 41848832 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Xbox-Classic\fonts\Prototype.ttf (38): width = 189, height = 46
19:00:31 M: 41787392 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Xbox-Classic\fonts\Prototype.ttf (23): width = 115, height = 29
19:00:31 M: 41746432 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Xbox-Classic\fonts\Prototype.ttf (27): width = 135, height = 33
19:00:31 M: 41705472 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Xbox-Classic\fonts\Prototype.ttf (22): width = 110, height = 27
19:00:31 M: 41664512 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Xbox-Classic\fonts\Prototype.ttf (20): width = 100, height = 25
19:00:31 M: 41623552 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\skin\Xbox-Classic\fonts\Prototype.ttf (21): width = 105, height = 26
19:00:31 M: 41586688 INFO: load new skin...
19:00:31 M: 41586688 INFO: Skin version is: 2.1
19:00:31 M: 41586688 INFO: Loading skin file: home.xml
19:00:31 M: 41455616 INFO: Loading user windows, path Q:\skin\Xbox-Classic\pal16x9
19:00:31 M: 41455616 INFO: Loading user windows, path Q:\skin\Xbox-Classic\pal
19:00:31 M: 41455616 INFO: Loading skin file: Q:\skin\Xbox-Classic\pal\custom_SkinScriptSetting_1113.xml
19:00:31 M: 41455616 INFO: Loading skin file: Q:\skin\Xbox-Classic\pal\custom_SkinSetting_1112.xml
19:00:31 M: 41463808 INFO: initialize new skin...
19:00:31 M: 41463808 INFO: Loading skin file: Pointer.xml
19:00:31 M: 41160704 INFO: Loading skin file: DialogVolumeBar.xml
19:00:31 M: 41140224 INFO: Loading skin file: DialogSeekbar.xml
19:00:31 M: 41086976 INFO: Loading skin file: DialogKaiToast.xml
19:00:31 M: 41095168 INFO: Loading skin file: DialogMuteBug.xml
19:00:31 M: 40701952 INFO: Loading Q:\skin\Xbox-Classic\sounds\sounds.xml
19:00:31 M: 40701952 INFO: skin loaded...
19:00:31 M: 41185280 DEBUG: Activating window ID: 12999
19:00:31 M: 41185280 DEBUG: Checking if window ID 12999 is locked.
19:00:31 M: 40775680 INFO: Loading skin file: Startup.xml
19:00:31 M: 40775680 WARNING: use dashboard
19:00:31 M: 39931904 INFO: removing tempfiles
19:00:31 M: 39923712 DEBUG: - Detected TSOP/ModChip: Unknown/Onboard TSOP (protected)
19:00:31 M: 39923712 NOTICE: initialize done
19:00:31 M: 39923712 DEBUG: - Detected TSOP/ModChip: Unknown/Onboard TSOP (protected)
19:00:31 M: 38871040 INFO: Key combination detected for full debug logging (X+Y)
19:00:31 M: 38776832 NOTICE: Running the application...
19:00:31 M: 38776832 DEBUG: CApplication::OnMessage : Translating ReplaceWindow(Home)
19:00:31 M: 38776832 DEBUG: CApplication::OnMessage : To ReplaceWindow(Home)
19:00:31 M: 38776832 DEBUG: Activating window ID: 10000
19:00:31 M: 38776832 DEBUG: Checking if window ID 10000 is locked.
19:00:31 M: 38584320 INFO: KAICLIENT: Instantiating...
19:00:31 M: 38584320 DEBUG: UDPCLIENT: Creating UDP socket...
19:00:31 M: 38584320 DEBUG: UDPCLIENT: Setting broadcast socket option...
19:00:31 M: 38584320 DEBUG: UDPCLIENT: Setting non-blocking socket options...
19:00:31 M: 38584320 DEBUG: UDPCLIENT: Spawning listener thread...
19:00:31 M: 38055936 DEBUG: UDPCLIENT: Ready.
19:00:31 M: 38055936 INFO: KAICLIENT: Ready.
19:00:31 M: 38055936 DEBUG: FreeVisualisation() started
19:00:31 M: 38055936 DEBUG: FreeVisualisation() done
19:00:31 M: 34988032 INFO: CNetwork::LogState - Link: full duplex
19:00:31 M: 34988032 INFO: CNetwork::LogState - Link: 100 mbps
19:00:31 M: 34988032 INFO: CNetwork::LogState - State: dns
19:00:31 M: 34766848 INFO: CNetwork::LogState - State: static
19:00:32 M: 34779136 INFO: CNetwork::LogState - ip: 192.168.1.20
19:00:32 M: 34779136 INFO: CNetwork::LogState - subnet: 255.255.255.0
19:00:32 M: 34779136 INFO: CNetwork::LogState - gateway: 192.168.1.1
19:00:32 M: 34779136 INFO: CNetwork::LogState - dns: 192.168.1.1, 0.0.0.0
19:00:32 M: 34779136 DEBUG: CNetwork::NetworkMessage - Starting network services
19:00:32 M: 34779136 INFO: Get URL: http://feeds.feedburner.com/XboxScene
19:00:32 M: 34779136 NOTICE: start timeserver client
19:00:32 M: 34254848 NOTICE: XBFileZilla: Starting...
19:00:32 M: 33730560 NOTICE: starting kai
19:00:32 M: 33730560 NOTICE: KAICLIENT: Discovering Kai engine via UDP broadcast.
19:00:33 M: 33624064 DEBUG: Got rss feed: http://feeds.feedburner.com/XboxScene
19:00:33 M: 33554432 DEBUG: RSS feed encoding: UTF-8
19:00:33 M: 33533952 DEBUG: Parsed rss feed: http://feeds.feedburner.com/XboxScene
19:00:34 M: 34140160 DEBUG: - Detected BIOS [256 KB]: Retail 5838.01
19:00:34 M: 34140160 DEBUG: - BIOS MD5 Hash: C5907D241DE37C22B083B6E30FA934B0
19:00:34 M: 28823552 DEBUG: CApplication::OnKey: 273 pressed, action is 2
19:00:35 M: 33669120 NOTICE: XBFileZilla: Started
19:00:35 M: 34017280 DEBUG: - CPU Speed: 733.335811MHz
19:00:35 M: 34017280 DEBUG: CApplication::OnKey: 256 pressed, action is 7
19:00:35 M: 34004992 DEBUG: CApplication::OnMessage : Translating xbmc.activatewindow(scripts)
19:00:35 M: 34004992 DEBUG: CApplication::OnMessage : To xbmc.activatewindow(scripts)
19:00:35 M: 34004992 DEBUG: Activating window ID: 10020
19:00:35 M: 34004992 DEBUG: Checking if window ID 10020 is locked.
19:00:35 M: 34004992 DEBUG: Video Encoder: XCALIBUR
19:00:35 M: 34004992 DEBUG: - XBOX production info: Country: China, LineNumber: 3, Week 47, Year 2004
19:00:35 M: 33996800 NOTICE: HDD: SMART is supported.
19:00:35 M: 33996800 NOTICE: HDD: SMART is enabled.
19:00:35 M: 36581376 INFO: Loading skin file: MyScripts.xml
19:00:35 M: 36319232 DEBUG: CGUIMediaWindow::GetDirectory (Q:\scripts)
19:00:35 M: 36380672 DEBUG: ParentPath = []
19:00:36 M: 31760384 DEBUG: DVD Model: SAMSUNG DVD-ROM SDG-605F
19:00:36 M: 31760384 DEBUG: DVD Firmware: x204
19:00:36 M: 32280576 DEBUG: CApplication::OnKey: 275 pressed, action is 10
19:00:36 M: 32272384 DEBUG: UDPCLIENT: Listening.
19:00:36 M: 32272384 DEBUG: UDPCLIENT TX: 8631 -> 'KAI_CLIENT_DISCOVER;'
19:00:36 M: 37056512 INFO: Loading skin file: Home.xml
19:00:37 M: 36749312 DEBUG: FreeVisualisation() started
19:00:37 M: 36749312 DEBUG: FreeVisualisation() done
19:00:37 M: 34779136 DEBUG: CApplication::OnKey: 272 pressed, action is 1
19:00:38 M: 34455552 DEBUG: CApplication::OnKey: 271 pressed, action is 4
19:00:38 M: 34283520 DEBUG: CApplication::OnKey: 256 pressed, action is 7
19:00:38 M: 34271232 DEBUG: CApplication::OnMessage : Translating XBMC.ActivateWindow(6)
19:00:38 M: 34271232 DEBUG: CApplication::OnMessage : To XBMC.ActivateWindow(6)
19:00:38 M: 34271232 DEBUG: Activating window ID: 10025
19:00:38 M: 34271232 DEBUG: Checking if window ID 10024 is locked.
19:00:38 M: 37474304 INFO: Loading skin file: MyVideoNav.xml
19:00:38 M: 37076992 DEBUG: CGUIMediaWindow::GetDirectory ()
19:00:38 M: 37076992 DEBUG: ParentPath = []
19:00:40 M: 34013184 DEBUG: CApplication::OnKey: 256 pressed, action is 7
19:00:40 M: 34078720 DEBUG: CGUIMediaWindow::GetDirectory (videodb://1/)
19:00:40 M: 34078720 DEBUG: ParentPath = []
19:00:41 M: 34025472 DEBUG: CApplication::OnKey: 271 pressed, action is 4
19:00:41 M: 34000896 DEBUG: CApplication::OnKey: 256 pressed, action is 7
19:00:41 M: 34091008 DEBUG: CGUIMediaWindow::GetDirectory (videodb://1/2/)
19:00:41 M: 34091008 DEBUG: ParentPath = [videodb://1/]
19:00:41 M: 34091008 DEBUG: Loading fileitems [Z:\vdb-17492a19.fi]
19:00:41 M: 34082816 DEBUG: CVideoDatabase::GetTitlesNav() query: select movie.*,files.strFileName,path.strPath from movie join files on files.idMovie=movie.idMovie join path on files.idPath=path.idPath limit 5000 offset 0
19:00:41 M: 33984512 DEBUG: CVideoDatabase::GetTitlesNav times: Info 7, Cast 0
19:00:41 M: 33964032 DEBUG: CVideoDatabase::GetTitlesNav() query: select movie.*,files.strFileName,path.strPath from movie join files on files.idMovie=movie.idMovie join path on files.idPath=path.idPath limit 5000 offset 5000
19:00:41 M: 33988608 DEBUG: Saving fileitems [videodb://1/2/]
19:00:41 M: 33980416 DEBUG: -- items: 53, sort method: 2, ascending: true
19:00:42 M: 30208000 DEBUG: CApplication::OnKey: 271 pressed, action is 4
19:00:43 M: 30208000 DEBUG: CApplication::OnKey: 256 pressed, action is 7
19:00:43 M: 30195712 DEBUG: CPlayerCoreFactor::GetPlayers(smb://SERVER/MOVIES/The Ant Bully.iso)
19:00:43 M: 30195712 NOTICE: DVDPlayer: Opening: smb://SERVER/MOVIES/The Ant Bully.iso
19:00:43 M: 30195712 NOTICE: CDVDPlayer::CloseFile()
19:00:43 M: 30195712 NOTICE: DVDPlayer: waiting for threads to exit
19:00:43 M: 30195712 NOTICE: DVDPlayer: finished waiting
19:00:43 M: 29671424 NOTICE: Creating InputStream
19:00:43 M: 29421568 INFO: msg: libdvdnav: Using dvdnav version 0.2.0cvs from http://dvd.sf.net
19:00:43 M: 29421568 INFO: msg: libdvdread: Using libdvdcss version 1.2.9 for DVD access
19:00:43 M: 29421568 INFO: Stating file smb://SERVER/MOVIES/The Ant Bully.iso
19:00:43 M: 28798976 INFO: msg: libdvdcss debug:
19:00:43 M: 28798976 INFO: msg: opening target `smb://SERVER/MOVIES/The Ant Bully.iso'
19:00:43 M: 28798976 INFO: msg:
19:00:43 M: 28798976 INFO: msg: libdvdcss debug:
19:00:43 M: 28798976 INFO: msg: using libc for access
19:00:43 M: 28798976 INFO: msg:
19:00:43 M: 28798976 INFO: msg: libdvdcss debug:
19:00:43 M: 28798976 INFO: msg: using CSS key cache dir: T:\cache/THE_ANT_BULLY/2007031002220600-0000000000/
19:00:43 M: 28798976 INFO: msg:
19:00:43 M: 28811264 INFO: msg: libdvdnav: vm: DVD Title: THE_ANT_BULLY
19:00:43 M: 28811264 INFO: msg: libdvdnav: Unable to find map file 'Q:\dvdplayer/.dvdnav/THE_ANT_BULLY.map'
19:00:43 M: 28803072 INFO: msg: libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions:
19:00:43 M: 28803072 INFO: msg: 1
19:00:43 M: 28803072 INFO: msg: 2
19:00:43 M: 28803072 INFO: msg: 3
19:00:43 M: 28803072 INFO: msg: 4
19:00:43 M: 28803072 INFO: msg: 5
19:00:43 M: 28803072 INFO: msg: 6
19:00:43 M: 28803072 INFO: msg: 7
19:00:43 M: 28803072 INFO: msg: 8
19:00:43 M: 28803072 DEBUG: msg:
19:00:43 M: 28803072 DEBUG: CDVDInputStreamNavigator::Open - Setting region mask ff
19:00:43 M: 28803072 NOTICE: DVDPlayer: playing a dvd with menu's
19:00:43 M: 28803072 NOTICE: Creating Demuxer
19:00:44 M: 25141248 DEBUG: Playback has started
19:00:44 M: 25141248 INFO: Loading skin file: VideoOverlay.xml
19:00:44 M: 25141248 DEBUG: CDVDInputStreamNavigator::SetActiveSubtitleStream - id: 0, stream: 128
19:00:44 M: 24952832 DEBUG: DVDNAV_HIGHLIGHT: Highlight button 1
19:00:44 M: 24952832 DEBUG: - DVDNAV_VTS_CHANGE (HOLDING)
19:00:44 M: 24952832 DEBUG: DVDNAV_VTS_CHANGE
19:00:44 M: 24952832 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
19:00:44 M: 24952832 WARNING: CDVDMessageQueue::Put MSGQ_NOT_INITIALIZED
19:00:44 M: 24952832 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
19:00:44 M: 24952832 ERROR: Error reading data from demuxer
19:00:44 M: 24952832 DEBUG: DVDNAV_CELL_CHANGE
19:00:44 M: 24952832 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:00:44 M: 24952832 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:00:44 M: 24952832 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:00:44 M: 24952832 INFO: msg: libdvdcss debug:
19:00:44 M: 24952832 INFO: msg: title key found in cache 00:00:00:00:00
19:00:44 M: 24952832 INFO: msg:
19:00:44 M: 23924736 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:0 TO:45500 DIFF:45500
19:00:44 M: 23924736 DEBUG: CGUIInfoManager::SetCurrentMovie(smb://SERVER/MOVIES/The Ant Bully.iso)
19:00:44 M: 23912448 NOTICE: Opening video stream: 0
19:00:44 M: 23912448 NOTICE: Creating video codec with codec id: 2
19:00:44 M: 23912448 DEBUG: FactoryCodec - Video: libmpeg2 - Opening
19:00:44 M: 22540288 DEBUG: FactoryCodec - Video: libmpeg2 - Opened
19:00:44 M: 22540288 NOTICE: Creating video thread
19:00:44 M: 22016000 NOTICE: running thread: video_thread
19:00:44 M: 22016000 DEBUG: CDVDPlayerVideo::Process - Resync recieved.
19:00:44 M: 22016000 DEBUG: CDVDPlayerVideo:: Resync - clock:66733, delay:0
19:00:44 M: 20434944 DEBUG: CDVDPlayerVideo::Process - Resync recieved.
19:00:44 M: 20447232 DEBUG: CDVDPlayerVideo:: Resync - clock:0, delay:0
19:00:44 M: 20447232 NOTICE: Initializing video device
19:00:44 M: 20447232 NOTICE: Opening audio stream: 3
19:00:44 M: 20447232 DEBUG: CXBoxRenderManager::PreInit - Selected RGB-Renderer
19:00:44 M: 20447232 NOTICE: Finding audio codec for: 86020
19:00:44 M: 20447232 NOTICE: fps: 29.970030, pwidth: 720, pheight: 480, dwidth: 853, dheight: 480
19:00:44 M: 20426752 DEBUG: FactoryCodec - Audio: passthrough - Opening
19:00:44 M: 20426752 NOTICE: Display resolution AUTO : 720p 16:9 (1)
19:00:44 M: 19902464 DEBUG: FactoryCodec - Audio: passthrough - Failed
19:00:44 M: 19902464 DEBUG: Activating window ID: 12005
19:00:44 M: 19783680 DEBUG: FactoryCodec - Audio: liba52 - Opening
19:00:44 M: 19775488 DEBUG: Checking if window ID 12005 is locked.
19:00:44 M: 26750976 DEBUG: Setting resolution 1
19:00:44 M: 28565504 DEBUG: FactoryCodec - Audio: liba52 - Opened
19:00:44 M: 28565504 NOTICE: Creating audio thread
19:00:44 M: 28041216 NOTICE: running thread: CDVDPlayerAudio::Process()
19:00:44 M: 28041216 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
19:00:44 M: 28041216 NOTICE: Creating audio device with codec id: 86020, channels: 6, sample rate: 48000, no pass-through
19:00:44 M: 28016640 DEBUG: CDVDPlayerAudio:: Resync - clock:32000, delay:7550
19:00:44 M: 26988544 DEBUG: We set resolution 1
19:00:44 M: 26435584 DEBUG: Created YV12 texture 0
19:00:44 M: 26435584 INFO: Loading skin file: VideoFullscreen.xml
19:00:44 M: 26427392 INFO: Loading skin file: VideoOSD.xml
19:00:44 M: 26144768 INFO: Loading skin file: VideoOSDSettings.xml
19:00:44 M: 25075712 INFO: Loading skin file: VideoOSDSettings.xml
19:00:44 M: 25026560 DEBUG: CGUIFontTTF::Load Scaled size of font Q:\Media\Fonts\Arial.ttf (28): width = 76, height = 39
19:00:44 M: 24457216 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:00:44 M: 24457216 DEBUG: CDVDPlayerVideo - CDVDMsg::VIDEO_SET_ASPECT
19:00:44 M: 24457216 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC
19:00:48 M: 23580672 DEBUG: CApplication::OnKey: 279 pressed, action is 113
19:00:48 M: 23400448 DEBUG: CDVDPlayerAudio:: Discontinuty - was:4288105, should be:4238457, error:-49648
19:00:48 M: 23433216 DEBUG: CApplication::OnKey: 279 pressed, action is 113
19:00:48 M: 23433216 DEBUG: CDVDPlayerAudio:: Discontinuty - was:4501857, should be:4451075, error:-50782
19:00:48 M: 23371776 DEBUG: CDVDPlayerAudio:: Discontinuty - was:4504880, should be:4526112, error:21232
19:00:53 M: 23654400 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:00:53 M: 23801856 DEBUG: DVDNAV_CELL_CHANGE
19:00:53 M: 23805952 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:00:53 M: 23805952 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:00:53 M: 23805952 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:00:53 M: 23805952 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:12057500 TO:45500 DIFF:-12012000
19:00:56 M: 24100864 DEBUG: CDVDPlayerAudio:: Discontinuty - was:12014092, should be:12026101, error:12009
19:00:59 M: 23580672 DEBUG: CApplication::OnKey: 223 pressed, action is 14
19:00:59 M: 23580672 DEBUG: - pushed next
19:00:59 M: 23576576 INFO: msg: libdvdnav: Language 'en' not found, using 'ÿÿ' instead
19:00:59 M: 23617536 DEBUG: libdvdnav: Menu Languages available:
19:00:59 M: 23617536 INFO: msg: ÿÿ
19:00:59 M: 23617536 DEBUG: msg:
19:00:59 M: 23691264 DEBUG: DVDNAV_HOP_CHANNEL
19:00:59 M: 25239552 ERROR: Error reading data from demuxer
19:00:59 M: 25239552 DEBUG: - DVDNAV_VTS_CHANGE (HOLDING)
19:00:59 M: 25239552 DEBUG: DVDNAV_VTS_CHANGE
19:00:59 M: 25239552 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
19:00:59 M: 25239552 ERROR: Error reading data from demuxer
19:00:59 M: 25247744 DEBUG: DVDNAV_CELL_CHANGE
19:00:59 M: 25247744 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:00:59 M: 25247744 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:00:59 M: 25247744 INFO: CDVDInputStreamNavigator::ProcessBlock - none or invalid audio stream selected, defaulting to first
19:00:59 M: 25247744 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:00:59 M: 25272320 DEBUG: CDVDVideoCodecLibMpeg2::Reset()
19:00:59 M: 25276416 INFO: msg: libdvdcss debug:
19:00:59 M: 25276416 DEBUG: CDVDPlayerVideo - CDVDMsg::VIDEO_SET_ASPECT
19:00:59 M: 25276416 INFO: msg: title key found in cache 00:00:00:00:00
19:00:59 M: 25276416 INFO: msg:
19:00:59 M: 25276416 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:5300744 TO:45500 DIFF:-5255244
19:00:59 M: 25268224 NOTICE: Closing audio stream
19:00:59 M: 25268224 DEBUG: CDVDPlayerAudio::Process - Abort recieved, exiting thread
19:00:59 M: 25268224 NOTICE: waiting for audio thread to exit
19:00:59 M: 25268224 NOTICE: Closing audio device
19:00:59 M: 25292800 NOTICE: thread end: CDVDPlayerAudio::OnExit()
19:00:59 M: 25817088 NOTICE: Deleting audio codec
19:00:59 M: 25956352 DEBUG: CDVDPlayer::CheckContinuity - Potential long duration frame
19:00:59 M: 25956352 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:00:59 M: 25956352 DEBUG: CDVDPlayerVideo::Process - Resync recieved.
19:00:59 M: 25956352 DEBUG: CDVDPlayerVideo:: Resync - clock:17350655, delay:33366
19:01:02 M: 24322048 DEBUG: CApplication::OnKey: 223 pressed, action is 14
19:01:02 M: 24326144 DEBUG: - pushed next
19:01:02 M: 24350720 DEBUG: DVDNAV_HOP_CHANNEL
19:01:02 M: 25784320 ERROR: Error reading data from demuxer
19:01:02 M: 25784320 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:01:02 M: 25952256 DEBUG: DVDNAV_CELL_CHANGE
19:01:02 M: 25952256 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:01:02 M: 25952256 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:01:02 M: 25952256 INFO: CDVDInputStreamNavigator::ProcessBlock - none or invalid audio stream selected, defaulting to first
19:01:02 M: 25952256 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:01:02 M: 25952256 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:5534311 TO:121888 DIFF:-5412422
19:01:02 M: 25968640 DEBUG: CDVDVideoCodecLibMpeg2::Reset()
19:01:02 M: 25767936 DEBUG: CDVDPlayer::CheckContinuity - Potential long duration frame
19:01:02 M: 25767936 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:01:02 M: 25767936 INFO: msg: libdvdnav: Language 'en' not found, using 'ÿÿ' instead
19:01:02 M: 25767936 DEBUG: CDVDPlayerVideo::Process - Resync recieved.
19:01:02 M: 25767936 DEBUG: libdvdnav: Menu Languages available:
19:01:02 M: 25767936 DEBUG: CDVDPlayerVideo:: Resync - clock:22756054, delay:33366
19:01:02 M: 25767936 INFO: msg: ÿÿ
19:01:02 M: 25702400 DEBUG: msg:
19:01:02 M: 25706496 DEBUG: - DVDNAV_VTS_CHANGE (HOLDING)
19:01:02 M: 25817088 DEBUG: DVDNAV_VTS_CHANGE
19:01:02 M: 25817088 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 0, Scale permissions: 3
19:01:02 M: 25817088 ERROR: Error reading data from demuxer
19:01:02 M: 25817088 DEBUG: CDVDPlayerVideo - CDVDMsg::VIDEO_SET_ASPECT
19:01:02 M: 25817088 DEBUG: DVDNAV_CELL_CHANGE
19:01:02 M: 25817088 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:01:02 M: 25817088 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:01:02 M: 25817088 INFO: CDVDInputStreamNavigator::ProcessBlock - none or invalid audio stream selected, defaulting to first
19:01:02 M: 25817088 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:01:02 M: 25817088 INFO: msg: libdvdcss debug:
19:01:02 M: 25817088 INFO: msg: title key found in cache 00:00:00:00:00
19:01:02 M: 25817088 INFO: msg:
19:01:02 M: 25817088 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:622388 TO:52000 DIFF:-570388
19:01:02 M: 25784320 DEBUG: CDVDPlayer::CheckContinuity - Potential long duration frame
19:01:02 M: 25784320 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:01:02 M: 25751552 NOTICE: fps: 29.970030, pwidth: 720, pheight: 480, dwidth: 656, dheight: 480
19:01:02 M: 25739264 NOTICE: Display resolution AUTO : 720p 16:9 (1)
19:01:03 M: 24383488 DEBUG: CApplication::OnKey: 223 pressed, action is 14
19:01:03 M: 24383488 DEBUG: - pushed next
19:01:03 M: 24399872 DEBUG: DVDNAV_HOP_CHANNEL
19:01:03 M: 25800704 ERROR: Error reading data from demuxer
19:01:03 M: 25800704 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:01:03 M: 25800704 DEBUG: DVDNAV_CELL_CHANGE
19:01:03 M: 25800704 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:01:03 M: 25800704 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:01:03 M: 25800704 INFO: CDVDInputStreamNavigator::ProcessBlock - none or invalid audio stream selected, defaulting to first
19:01:03 M: 25800704 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:01:03 M: 25800704 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:4056000 TO:121888 DIFF:-3934111
19:01:03 M: 25714688 DEBUG: CDVDVideoCodecLibMpeg2::Reset()
19:01:03 M: 25600000 DEBUG: CDVDPlayer::CheckContinuity - Potential long duration frame
19:01:03 M: 25600000 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:01:03 M: 25600000 INFO: msg: libdvdnav: Language 'en' not found, using 'ÿÿ' instead
19:01:03 M: 25600000 DEBUG: CDVDPlayerVideo::Process - Resync recieved.
19:01:03 M: 25600000 DEBUG: libdvdnav: Menu Languages available:
19:01:03 M: 25600000 DEBUG: CDVDPlayerVideo:: Resync - clock:27260554, delay:33366
19:01:03 M: 25600000 INFO: msg: ÿÿ
19:01:03 M: 25702400 DEBUG: msg:
19:01:03 M: 25702400 DEBUG: - DVDNAV_VTS_CHANGE (HOLDING)
19:01:03 M: 25812992 DEBUG: DVDNAV_VTS_CHANGE
19:01:03 M: 25812992 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
19:01:03 M: 25812992 ERROR: Error reading data from demuxer
19:01:03 M: 25812992 DEBUG: CDVDPlayerVideo - CDVDMsg::VIDEO_SET_ASPECT
19:01:03 M: 25812992 DEBUG: DVDNAV_CELL_CHANGE
19:01:03 M: 25812992 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:01:03 M: 25812992 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:01:03 M: 25812992 INFO: CDVDInputStreamNavigator::ProcessBlock - none or invalid audio stream selected, defaulting to first
19:01:03 M: 25812992 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:01:03 M: 25812992 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:622388 TO:45500 DIFF:-576888
19:01:03 M: 25796608 DEBUG: CDVDPlayer::CheckContinuity - Potential long duration frame
19:01:03 M: 25796608 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:01:03 M: 25800704 NOTICE: fps: 29.970030, pwidth: 720, pheight: 480, dwidth: 853, dheight: 480
19:01:03 M: 25792512 NOTICE: Display resolution AUTO : 720p 16:9 (1)
19:01:04 M: 24334336 DEBUG: CApplication::OnKey: 223 pressed, action is 14
19:01:04 M: 24342528 DEBUG: - pushed next
19:01:04 M: 24342528 DEBUG: DVDNAV_HOP_CHANNEL
19:01:04 M: 25784320 ERROR: Error reading data from demuxer
19:01:04 M: 25784320 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:01:04 M: 25784320 DEBUG: DVDNAV_CELL_CHANGE
19:01:04 M: 25784320 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:01:04 M: 25784320 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:01:04 M: 25784320 INFO: CDVDInputStreamNavigator::ProcessBlock - none or invalid audio stream selected, defaulting to first
19:01:04 M: 25784320 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:01:04 M: 25784320 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:3565677 TO:121888 DIFF:-3443788
19:01:04 M: 25571328 DEBUG: CDVDPlayer::CheckContinuity - Potential long duration frame
19:01:04 M: 25571328 INFO: msg: libdvdnav: Language 'en' not found, using 'ÿÿ' instead
19:01:04 M: 25571328 DEBUG: libdvdnav: Menu Languages available:
19:01:04 M: 25571328 INFO: msg: ÿÿ
19:01:04 M: 25571328 DEBUG: msg:
19:01:04 M: 25600000 DEBUG: CDVDVideoCodecLibMpeg2::Reset()
19:01:04 M: 25600000 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:01:04 M: 25600000 DEBUG: - DVDNAV_VTS_CHANGE (HOLDING)
19:01:04 M: 25600000 DEBUG: CDVDPlayerVideo::Process - Resync recieved.
19:01:04 M: 25710592 DEBUG: DVDNAV_VTS_CHANGE
19:01:04 M: 25710592 DEBUG: CDVDPlayerVideo:: Resync - clock:31281232, delay:33366
19:01:04 M: 25812992 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 0, Scale permissions: 3
19:01:04 M: 25812992 ERROR: Error reading data from demuxer
19:01:04 M: 25812992 DEBUG: DVDNAV_CELL_CHANGE
19:01:04 M: 25812992 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:01:04 M: 25812992 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:01:04 M: 25812992 INFO: CDVDInputStreamNavigator::ProcessBlock - none or invalid audio stream selected, defaulting to first
19:01:04 M: 25812992 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:01:04 M: 25812992 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:622388 TO:45500 DIFF:-576888
19:01:04 M: 25812992 DEBUG: CDVDPlayerVideo - CDVDMsg::VIDEO_SET_ASPECT
19:01:04 M: 25796608 DEBUG: CDVDPlayer::CheckContinuity - Potential long duration frame
19:01:05 M: 25796608 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:01:05 M: 25800704 NOTICE: fps: 29.970030, pwidth: 720, pheight: 480, dwidth: 656, dheight: 480
19:01:05 M: 25792512 NOTICE: Display resolution AUTO : 720p 16:9 (1)
19:01:05 M: 24379392 DEBUG: CApplication::OnKey: 223 pressed, action is 14
19:01:05 M: 24387584 DEBUG: - pushed next
19:01:06 M: 24387584 DEBUG: DVDNAV_HOP_CHANNEL
19:01:06 M: 25788416 ERROR: Error reading data from demuxer
19:01:06 M: 25788416 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:01:06 M: 25788416 DEBUG: DVDNAV_CELL_CHANGE
19:01:06 M: 25788416 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:01:06 M: 25788416 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:01:06 M: 25788416 INFO: CDVDInputStreamNavigator::ProcessBlock - none or invalid audio stream selected, defaulting to first
19:01:06 M: 25788416 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:01:06 M: 25788416 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:3415533 TO:121888 DIFF:-3293644
19:01:06 M: 25575424 INFO: msg: libdvdnav: Language 'en' not found, using 'ÿÿ' instead
19:01:06 M: 25575424 DEBUG: libdvdnav: Menu Languages available:
19:01:06 M: 25575424 INFO: msg: ÿÿ
19:01:06 M: 25575424 DEBUG: msg:
19:01:06 M: 25591808 DEBUG: CDVDVideoCodecLibMpeg2::Reset()
19:01:06 M: 25591808 DEBUG: CDVDPlayerVideo::Process - Resync recieved.
19:01:06 M: 25591808 DEBUG: CDVDPlayerVideo:: Resync - clock:35151765, delay:33366
19:01:06 M: 25645056 DEBUG: - DVDNAV_VTS_CHANGE (HOLDING)
19:01:06 M: 25755648 DEBUG: DVDNAV_VTS_CHANGE
19:01:06 M: 25755648 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 1
19:01:06 M: 25755648 ERROR: Error reading data from demuxer
19:01:06 M: 25755648 DEBUG: DVDNAV_CELL_CHANGE
19:01:06 M: 25755648 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:01:06 M: 25755648 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:01:06 M: 25755648 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:01:06 M: 25755648 INFO: msg: libdvdcss debug:
19:01:06 M: 25755648 INFO: msg: title key found in cache 00:00:00:00:00
19:01:06 M: 25755648 INFO: msg:
19:01:06 M: 25755648 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:622388 TO:45500 DIFF:-576888
19:01:06 M: 25755648 DEBUG: CDVDPlayerVideo - CDVDMsg::VIDEO_SET_ASPECT
19:01:06 M: 25739264 DEBUG: CDVDPlayer::CheckContinuity - Potential long duration frame
19:01:06 M: 25739264 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:01:06 M: 25747456 NOTICE: Opening audio stream: 1
19:01:06 M: 25747456 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:01:06 M: 25747456 NOTICE: Finding audio codec for: 86020
19:01:06 M: 25731072 DEBUG: FactoryCodec - Audio: passthrough - Opening
19:01:06 M: 25731072 DEBUG: FactoryCodec - Audio: passthrough - Failed
19:01:06 M: 25608192 DEBUG: FactoryCodec - Audio: liba52 - Opening
19:01:06 M: 25591808 DEBUG: FactoryCodec - Audio: liba52 - Opened
19:01:06 M: 25591808 NOTICE: Creating audio thread
19:01:06 M: 25067520 NOTICE: running thread: CDVDPlayerAudio::Process()
19:01:06 M: 25067520 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 1
19:01:06 M: 25067520 NOTICE: Creating audio device with codec id: 86020, channels: 2, sample rate: 48000, no pass-through
19:01:06 M: 25042944 DEBUG: CDVDPlayerVideo - CDVDMsg::VIDEO_SET_ASPECT
19:01:06 M: 25042944 DEBUG: CDVDPlayerAudio:: Resync - clock:35684266, delay:7562
19:01:06 M: 24952832 NOTICE: fps: 29.970030, pwidth: 720, pheight: 480, dwidth: 853, dheight: 480
19:01:06 M: 24780800 NOTICE: Display resolution AUTO : 720p 16:9 (1)
19:01:07 M: 23457792 DEBUG: CApplication::OnKey: 223 pressed, action is 14
19:01:07 M: 23457792 DEBUG: - pushed next
19:01:07 M: 23457792 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:01:07 M: 23584768 DEBUG: DVDNAV_CELL_CHANGE
19:01:07 M: 23588864 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:01:07 M: 23588864 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:01:07 M: 23588864 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:01:07 M: 23556096 NOTICE: Opening Subtitle stream: 3
19:01:07 M: 23465984 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:01:09 M: 22781952 DEBUG: CDVDPlayerAudio:: Discontinuty - was:38685963, should be:38716935, error:30972
19:01:10 M: 23011328 DEBUG: CApplication::OnKey: 11 pressed, action is 7
19:01:10 M: 23011328 DEBUG: - button select
19:01:10 M: 23019520 DEBUG: DVDNAV_HOP_CHANNEL
19:01:10 M: 24662016 ERROR: Error reading data from demuxer
19:01:10 M: 24662016 DEBUG: - DVDNAV_VTS_CHANGE (HOLDING)
19:01:10 M: 24662016 DEBUG: DVDNAV_VTS_CHANGE
19:01:10 M: 24662016 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
19:01:10 M: 24662016 ERROR: Error reading data from demuxer
19:01:10 M: 24678400 DEBUG: DVDNAV_CELL_CHANGE
19:01:10 M: 24678400 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:01:10 M: 24678400 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:01:10 M: 24678400 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:01:10 M: 24694784 DEBUG: CDVDVideoCodecLibMpeg2::Reset()
19:01:10 M: 24694784 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:6585366 TO:45500 DIFF:-6539866
19:01:10 M: 24694784 DEBUG: CDVDPlayerVideo - CDVDMsg::VIDEO_SET_ASPECT
19:01:10 M: 24678400 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC
19:01:10 M: 24678400 NOTICE: Closing audio stream
19:01:10 M: 24686592 DEBUG: CDVDPlayerAudio::Process - Abort recieved, exiting thread
19:01:10 M: 24686592 NOTICE: waiting for audio thread to exit
19:01:10 M: 24686592 NOTICE: Closing audio device
19:01:10 M: 24711168 NOTICE: thread end: CDVDPlayerAudio::OnExit()
19:01:10 M: 25235456 NOTICE: Deleting audio codec
19:01:10 M: 25391104 NOTICE: Opening audio stream: 1
19:01:10 M: 25391104 NOTICE: Finding audio codec for: 86020
19:01:10 M: 25391104 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:01:10 M: 25374720 DEBUG: FactoryCodec - Audio: passthrough - Opening
19:01:10 M: 25374720 DEBUG: FactoryCodec - Audio: passthrough - Failed
19:01:10 M: 25251840 DEBUG: FactoryCodec - Audio: liba52 - Opening
19:01:10 M: 25235456 DEBUG: FactoryCodec - Audio: liba52 - Opened
19:01:10 M: 25235456 NOTICE: Creating audio thread
19:01:10 M: 24711168 NOTICE: running thread: CDVDPlayerAudio::Process()
19:01:10 M: 24711168 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
19:01:10 M: 24711168 DEBUG: CDVDPlayerVideo - CDVDMsg::VIDEO_SET_ASPECT
19:01:10 M: 24711168 NOTICE: Closing audio stream
19:01:10 M: 24711168 DEBUG: CDVDPlayerAudio::Process - Abort recieved, exiting thread
19:01:10 M: 24711168 NOTICE: waiting for audio thread to exit
19:01:10 M: 24711168 NOTICE: Closing audio device
19:01:10 M: 24711168 NOTICE: thread end: CDVDPlayerAudio::OnExit()
19:01:10 M: 25235456 NOTICE: Deleting audio codec
19:01:10 M: 25391104 NOTICE: Opening audio stream: 3
19:01:10 M: 25391104 NOTICE: Finding audio codec for: 86020
19:01:10 M: 25391104 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:01:10 M: 25374720 DEBUG: FactoryCodec - Audio: passthrough - Opening
19:01:10 M: 25374720 DEBUG: FactoryCodec - Audio: passthrough - Failed
19:01:10 M: 25251840 DEBUG: FactoryCodec - Audio: liba52 - Opening
19:01:10 M: 25235456 DEBUG: FactoryCodec - Audio: liba52 - Opened
19:01:10 M: 25235456 NOTICE: Creating audio thread
19:01:10 M: 24711168 NOTICE: running thread: CDVDPlayerAudio::Process()
19:01:10 M: 24711168 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
19:01:10 M: 24711168 DEBUG: CDVDPlayerVideo - CDVDMsg::VIDEO_SET_ASPECT
19:01:10 M: 24690688 NOTICE: Creating audio device with codec id: 86020, channels: 6, sample rate: 48000, no pass-through
19:01:10 M: 24518656 DEBUG: CDVDPlayerAudio:: Discontinuty - was:39910076, should be:42239819, error:2329743
19:01:13 M: 23040000 DEBUG: CApplication::OnKey: 223 pressed, action is 14
19:01:13 M: 23040000 DEBUG: - pushed next
19:01:13 M: 23113728 DEBUG: DVDNAV_HOP_CHANNEL
19:01:13 M: 24596480 ERROR: Error reading data from demuxer
19:01:13 M: 24600576 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:01:13 M: 24600576 DEBUG: DVDNAV_CELL_CHANGE
19:01:13 M: 24600576 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:01:13 M: 24600576 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:01:13 M: 24600576 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:01:13 M: 24600576 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:5050500 TO:45500 DIFF:-5005000
19:01:13 M: 24461312 DEBUG: CDVDVideoCodecLibMpeg2::Reset()
19:01:13 M: 24453120 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC
19:01:13 M: 24461312 DEBUG: CDVDPlayerAudio:: Resync - clock:47220099, delay:8000
19:01:15 M: 22945792 DEBUG: CApplication::OnKey: 223 pressed, action is 14
19:01:15 M: 22945792 DEBUG: - pushed next
19:01:15 M: 22990848 DEBUG: DVDNAV_HOP_CHANNEL
19:01:15 M: 24395776 ERROR: Error reading data from demuxer
19:01:15 M: 24395776 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:01:15 M: 24395776 DEBUG: DVDNAV_CELL_CHANGE
19:01:15 M: 24395776 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:01:15 M: 24395776 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:01:15 M: 24395776 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:01:15 M: 24395776 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:4032811 TO:167646266 DIFF:163613455
19:01:15 M: 24420352 DEBUG: CDVDVideoCodecLibMpeg2::Reset()
19:01:15 M: 24305664 DEBUG: CDVDPlayer::CheckContinuity - Potential long duration frame
19:01:15 M: 24305664 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
19:01:15 M: 24305664 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:01:15 M: 24305664 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC
19:01:15 M: 24305664 DEBUG: CDVDPlayerAudio:: Resync - clock:51158644, delay:8000
19:01:16 M: 22888448 DEBUG: CApplication::OnKey: 223 pressed, action is 14
19:01:16 M: 22888448 DEBUG: - pushed next
19:01:16 M: 22933504 DEBUG: DVDNAV_HOP_CHANNEL
19:01:16 M: 24342528 ERROR: Error reading data from demuxer
19:01:16 M: 24342528 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:01:16 M: 24342528 DEBUG: DVDNAV_CELL_CHANGE
19:01:16 M: 24342528 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:01:16 M: 24342528 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:01:16 M: 24342528 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:01:16 M: 24342528 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:171066344 TO:352831266 DIFF:181764922
19:01:16 M: 24383488 DEBUG: CDVDVideoCodecLibMpeg2::Reset()
19:01:16 M: 24227840 DEBUG: CDVDPlayer::CheckContinuity - Potential long duration frame
19:01:16 M: 24227840 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
19:01:16 M: 24227840 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:01:16 M: 24227840 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC
19:01:16 M: 24227840 DEBUG: CDVDPlayerAudio:: Resync - clock:54577722, delay:8000
19:01:17 M: 23482368 NOTICE: Opening Subtitle stream: 9
19:01:17 M: 23392256 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:01:17 M: 22786048 DEBUG: CApplication::OnKey: 223 pressed, action is 14
19:01:17 M: 22740992 DEBUG: - pushed next
19:01:17 M: 22781952 DEBUG: DVDNAV_HOP_CHANNEL
19:01:17 M: 24297472 ERROR: Error reading data from demuxer
19:01:17 M: 24297472 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:01:17 M: 24297472 DEBUG: DVDNAV_CELL_CHANGE
19:01:17 M: 24313856 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:01:17 M: 24313856 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:01:17 M: 24313856 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:01:17 M: 24313856 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:355750844 TO:657435566 DIFF:301684722
19:01:17 M: 24334336 DEBUG: CDVDVideoCodecLibMpeg2::Reset()
19:01:17 M: 24313856 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC
19:01:17 M: 24268800 DEBUG: CDVDPlayerAudio:: Resync - clock:57533000, delay:8000
19:01:18 M: 22773760 DEBUG: CApplication::OnKey: 223 pressed, action is 14
19:01:18 M: 22773760 DEBUG: - pushed next
19:01:18 M: 22798336 DEBUG: DVDNAV_HOP_CHANNEL
19:01:18 M: 24301568 ERROR: Error reading data from demuxer
19:01:18 M: 24301568 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:01:18 M: 24301568 DEBUG: DVDNAV_CELL_CHANGE
19:01:18 M: 24301568 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:01:18 M: 24301568 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:01:18 M: 24301568 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:01:18 M: 24317952 DEBUG: CDVDVideoCodecLibMpeg2::Reset()
19:01:18 M: 24317952 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:660355144 TO:900511733 DIFF:240156588
19:01:18 M: 24199168 DEBUG: CDVDPlayer::CheckContinuity - Potential long duration frame
19:01:18 M: 24199168 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
19:01:18 M: 24199168 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:01:18 M: 24199168 DEBUG: CDVDPlayerAudio:: Resync - clock:60416411, delay:8000
19:01:18 M: 24199168 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC
19:01:19 M: 22798336 DEBUG: CApplication::OnKey: 223 pressed, action is 14
19:01:19 M: 22798336 DEBUG: - pushed next
19:01:19 M: 22818816 DEBUG: DVDNAV_HOP_CHANNEL
19:01:19 M: 24264704 ERROR: Error reading data from demuxer
19:01:19 M: 24264704 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:01:19 M: 24264704 DEBUG: DVDNAV_CELL_CHANGE
19:01:19 M: 24264704 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:01:19 M: 24264704 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:01:19 M: 24264704 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:01:19 M: 24264704 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:903431311 TO:1194472066 DIFF:291040755
19:01:19 M: 24268800 DEBUG: CDVDVideoCodecLibMpeg2::Reset()
19:01:19 M: 24133632 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC
19:01:19 M: 24207360 DEBUG: CDVDPlayerAudio:: Resync - clock:63359655, delay:8000
19:01:21 M: 22704128 DEBUG: CApplication::OnKey: 223 pressed, action is 14
19:01:21 M: 22704128 DEBUG: - pushed next
19:01:21 M: 22728704 DEBUG: DVDNAV_HOP_CHANNEL
19:01:21 M: 24211456 ERROR: Error reading data from demuxer
19:01:21 M: 24211456 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:01:21 M: 24211456 DEBUG: DVDNAV_CELL_CHANGE
19:01:21 M: 24211456 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:01:21 M: 24211456 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:01:21 M: 24211456 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:01:21 M: 24211456 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:1198893144 TO:1406016733 DIFF:207123588
19:01:21 M: 24244224 DEBUG: CDVDVideoCodecLibMpeg2::Reset()
19:01:21 M: 24244224 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC
19:01:21 M: 24252416 DEBUG: CDVDPlayerAudio:: Resync - clock:67820066, delay:8000
19:01:21 M: 24162304 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:01:22 M: 22573056 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:01:25 M: 22728704 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:01:28 M: 22691840 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:01:29 M: 22781952 DEBUG: CApplication::OnKey: 247 pressed, action is 24
19:01:31 M: 22638592 DEBUG: CApplication::OnKey: 168 pressed, action is 2
19:01:31 M: 22540288 DEBUG: CApplication::OnKey: 168 pressed, action is 2
19:01:31 M: 22499328 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:01:31 M: 22478848 DEBUG: CApplication::OnKey: 168 pressed, action is 2
19:01:32 M: 22495232 DEBUG: CApplication::OnKey: 168 pressed, action is 2
19:01:32 M: 22646784 DEBUG: CApplication::OnKey: 168 pressed, action is 2
19:01:33 M: 22548480 DEBUG: CApplication::OnKey: 11 pressed, action is 7
19:01:33 M: 22548480 DEBUG: CApplication::OnMessage : Translating XBMC.ActivateWindow(124)
19:01:33 M: 22507520 DEBUG: CApplication::OnMessage : To XBMC.ActivateWindow(124)
19:01:33 M: 22507520 DEBUG: Activating window ID: 10124
19:01:33 M: 22507520 DEBUG: Checking if window ID 10124 is locked.
19:01:38 M: 22642688 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:01:39 M: 22487040 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:01:42 M: 22470656 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:01:45 M: 22503424 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:01:47 M: 22495232 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:01:51 M: 22478848 DEBUG: CApplication::OnKey: 247 pressed, action is 51
19:01:51 M: 22425600 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:01:53 M: 22474752 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:01:56 M: 22577152 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:00 M: 22564864 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:04 M: 22474752 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:06 M: 22482944 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:09 M: 22536192 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:13 M: 22519808 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:14 M: 22487040 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:16 M: 22478848 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:19 M: 22507520 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:21 M: 22487040 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:23 M: 22540288 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:26 M: 22523904 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:27 M: 22454272 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:28 M: 22433792 DEBUG: CApplication::OnKey: 247 pressed, action is 51
19:02:29 M: 22695936 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:32 M: 22716416 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:34 M: 22654976 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:37 M: 22650880 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:40 M: 22663168 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:42 M: 22642688 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:56 M: 22757376 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:02:59 M: 22667264 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:02 M: 22720512 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:06 M: 22634496 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:08 M: 22708224 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:10 M: 22687744 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:12 M: 22675456 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:15 M: 22671360 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:17 M: 22622208 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:19 M: 22581248 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:24 M: 22642688 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:28 M: 22720512 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:31 M: 22614016 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:35 M: 22568960 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:38 M: 22671360 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:41 M: 22622208 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:44 M: 22630400 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:46 M: 22650880 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:49 M: 22650880 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:51 M: 22675456 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:03:55 M: 22630400 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:04:00 M: 22663168 DEBUG: CApplication::OnKey: 247 pressed, action is 24
19:04:02 M: 22429696 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:04:04 M: 22519808 DEBUG: CApplication::OnKey: 247 pressed, action is 51
19:04:06 M: 22642688 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:04:09 M: 22646784 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:04:11 M: 22654976 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:04:17 M: 22720512 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:04:20 M: 22618112 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:04:24 M: 22667264 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:04:29 M: 22609920 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:04:33 M: 22663168 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:04:38 M: 22712320 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:04:39 M: 22650880 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:04:42 M: 22667264 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:04:43 M: 22618112 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:04:46 M: 22638592 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:04:49 M: 22622208 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:04:57 M: 22708224 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:04:59 M: 22638592 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:05:01 M: 22622208 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:05:07 M: 22634496 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:05:09 M: 22564864 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:05:11 M: 22622208 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:05:13 M: 22654976 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:05:15 M: 22650880 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:05:22 M: 22753280 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC
19:05:22 M: 22753280 DEBUG: CDVDPlayerAudio:: Resync - clock:308652066, delay:17878
19:05:23 M: 22691840 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:05:23 M: 22925312 DEBUG: DVDNAV_CELL_CHANGE
19:05:23 M: 22937600 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:05:23 M: 22937600 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:05:23 M: 22937600 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:05:24 M: 22962176 NOTICE: Closing audio stream
19:05:25 M: 24293376 NOTICE: waiting for audio thread to exit
19:05:25 M: 24293376 NOTICE: Closing audio device
19:05:25 M: 24317952 NOTICE: thread end: CDVDPlayerAudio::OnExit()
19:05:25 M: 24911872 NOTICE: Deleting audio codec
19:05:25 M: 25055232 NOTICE: Opening audio stream: 3
19:05:25 M: 25055232 NOTICE: Finding audio codec for: 86020
19:05:25 M: 25038848 DEBUG: FactoryCodec - Audio: passthrough - Opening
19:05:25 M: 25038848 DEBUG: FactoryCodec - Audio: passthrough - Failed
19:05:25 M: 24915968 DEBUG: FactoryCodec - Audio: liba52 - Opening
19:05:25 M: 24899584 DEBUG: FactoryCodec - Audio: liba52 - Opened
19:05:25 M: 24899584 NOTICE: Creating audio thread
19:05:25 M: 24375296 NOTICE: running thread: CDVDPlayerAudio::Process()
19:05:25 M: 24375296 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
19:05:25 M: 24338432 ERROR: CDVDAudioCodecLiba52::Decode - a52_block failed
19:05:25 M: 24334336 ERROR: CDVDPlayerAudio::Process - Decode Error. Skipping audio packet
19:05:25 M: 24309760 WARNING: CDVDAudioCodecLiba52::SetupChannels - Number of channels changed in stream from 4 to 6, data might be truncated
19:05:25 M: 24158208 NOTICE: Creating audio device with codec id: 86020, channels: 4, sample rate: 48000, no pass-through
19:05:25 M: 24158208 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:05:25 M: 24158208 DEBUG: CDVDPlayerVideo - CDVDMsg::VIDEO_SET_ASPECT
19:05:25 M: 24158208 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC
19:05:25 M: 23900160 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:05:25 M: 23883776 DEBUG: CDVDPlayerAudio:: Discontinuty - was:311913160, should be:312036902, error:123742
19:05:29 M: 22708224 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:05:32 M: 22626304 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:05:36 M: 22659072 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:05:44 M: 22487040 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:05:45 M: 22323200 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:05:47 M: 22568960 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:05:48 M: 22560768 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:05:55 M: 22622208 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:05:58 M: 22548480 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:01 M: 22503424 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:04 M: 22536192 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:06 M: 22519808 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:08 M: 22528000 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:10 M: 22536192 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:13 M: 22560768 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:18 M: 22618112 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:20 M: 22515712 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:21 M: 22425600 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:25 M: 22491136 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:27 M: 22495232 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:29 M: 22536192 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:31 M: 22511616 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:35 M: 22499328 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:37 M: 22482944 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:39 M: 22511616 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:42 M: 22593536 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:46 M: 22536192 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:48 M: 22544384 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:49 M: 22487040 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:06:53 M: 22552576 DEBUG: CApplication::OnKey: 247 pressed, action is 24
19:06:54 M: 22446080 DEBUG: CApplication::OnKey: 247 pressed, action is 51
19:06:55 M: 22581248 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:02 M: 22585344 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:05 M: 22515712 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:07 M: 22458368 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:17 M: 22515712 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:20 M: 22495232 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:23 M: 22507520 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:25 M: 22499328 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:28 M: 22478848 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:31 M: 22425600 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:34 M: 22470656 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:37 M: 22519808 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:39 M: 22495232 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:40 M: 22413312 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:42 M: 22388736 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:44 M: 22474752 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:46 M: 22450176 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:48 M: 22462464 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:51 M: 22482944 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:54 M: 22495232 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:55 M: 22544384 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:07:59 M: 22515712 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:08:02 M: 22491136 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:08:05 M: 22540288 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:08:07 M: 22491136 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:08:12 M: 22577152 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:08:20 M: 22712320 DEBUG: DVDNAV_CELL_CHANGE (HOLDING)
19:08:20 M: 22896640 DEBUG: DVDNAV_CELL_CHANGE
19:08:20 M: 22913024 DEBUG: DVDNAV_SPU_CLUT_CHANGE
19:08:20 M: 22913024 DEBUG: DVDNAV_SPU_STREAM_CHANGE
19:08:20 M: 22913024 DEBUG: DVDNAV_AUDIO_STREAM_CHANGE
19:08:20 M: 22876160 NOTICE: Closing audio stream
19:08:22 M: 24219648 NOTICE: waiting for audio thread to exit
19:08:22 M: 24219648 NOTICE: Closing audio device
19:08:22 M: 24244224 NOTICE: thread end: CDVDPlayerAudio::OnExit()
19:08:22 M: 24776704 NOTICE: Deleting audio codec
19:08:22 M: 24924160 NOTICE: Opening audio stream: 3
19:08:22 M: 24924160 NOTICE: Finding audio codec for: 86020
19:08:22 M: 24907776 DEBUG: FactoryCodec - Audio: passthrough - Opening
19:08:22 M: 24907776 DEBUG: FactoryCodec - Audio: passthrough - Failed
19:08:22 M: 24784896 DEBUG: FactoryCodec - Audio: liba52 - Opening
19:08:22 M: 24768512 DEBUG: FactoryCodec - Audio: liba52 - Opened
19:08:22 M: 24768512 NOTICE: Creating audio thread
19:08:22 M: 24244224 NOTICE: running thread: CDVDPlayerAudio::Process()
19:08:22 M: 24244224 INFO: CDVDInputStreamNavigator::GetVideoAspectRatio - Aspect wanted: 3, Scale permissions: 2
19:08:22 M: 24215552 NOTICE: Creating audio device with codec id: 86020, channels: 6, sample rate: 48000, no pass-through
19:08:22 M: 24178688 DEBUG: CDVDPlayerAudio:: Resync - clock:488780066, delay:7513
19:08:22 M: 23764992 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
19:08:22 M: 23764992 DEBUG: CDVDPlayerVideo - CDVDMsg::VIDEO_SET_ASPECT
19:08:22 M: 23764992 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC
19:08:27 M: 22622208 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:08:29 M: 22528000 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:08:31 M: 22552576 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:08:34 M: 22540288 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:08:36 M: 22495232 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:08:39 M: 22470656 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:08:43 M: 22511616 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:08:47 M: 22556672 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet
19:08:50 M: 22544384 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet