22:05:04 T:2244 NOTICE: ----------------------------------------------------------------------- 22:05:04 T:2244 NOTICE: Starting XBMC (12.0-ALPHA7 Git:20121102-e292b11), Platform: Windows XP Professional SP3 64-bit, build 2600. Built on Nov 2 2012 (compiler 1600) 22:05:04 T:2244 NOTICE: AMD Phenom(tm) II X4 965 Processor 22:05:04 T:2244 NOTICE: Desktop Resolution: 1920x1080 32Bit at 60Hz 22:05:04 T:2244 NOTICE: Running with administrator rights 22:05:04 T:2244 NOTICE: Aero is disabled 22:05:04 T:2244 NOTICE: special://xbmc/ is mapped to: C:\Program Files (x86)\XBMC 22:05:04 T:2244 NOTICE: special://xbmcbin/ is mapped to: C:\Program Files (x86)\XBMC 22:05:04 T:2244 NOTICE: special://masterprofile/ is mapped to: C:\Users\User\AppData\Roaming\XBMC\userdata 22:05:04 T:2244 NOTICE: special://home/ is mapped to: C:\Users\User\AppData\Roaming\XBMC\ 22:05:04 T:2244 NOTICE: special://temp/ is mapped to: C:\Users\User\AppData\Roaming\XBMC\cache 22:05:04 T:2244 NOTICE: The executable running is: C:\Program Files (x86)\XBMC\XBMC.exe 22:05:04 T:2244 NOTICE: Local hostname: MediaCenter 22:05:04 T:2244 NOTICE: Log File is located: C:\Users\User\AppData\Roaming\XBMC\xbmc.log 22:05:04 T:2244 NOTICE: ----------------------------------------------------------------------- 22:05:04 T:2244 NOTICE: Enumerated DirectSound devices: 22:05:04 T:2244 NOTICE: Device 1 22:05:04 T:2244 NOTICE: m_deviceName : {5658a469-dab8-4d4c-a348-626eea707e2d} 22:05:04 T:2244 NOTICE: m_displayName : Lautsprecher (High Definition Audio-Gerät) 22:05:04 T:2244 NOTICE: m_displayNameExtra: DirectSound: Lautsprecher (High Definition Audio-Gerät) 22:05:04 T:2244 NOTICE: m_deviceType : AE_DEVTYPE_PCM 22:05:04 T:2244 NOTICE: m_channels : FL,FR 22:05:04 T:2244 NOTICE: m_sampleRates : 96000 22:05:04 T:2244 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_AC3 22:05:04 T:2244 NOTICE: Device 2 22:05:04 T:2244 NOTICE: m_deviceName : {2222474d-eade-4677-8bef-0c03baeff7c5} 22:05:04 T:2244 NOTICE: m_displayName : Digitalaudio (HDMI) (High Definition Audio-Gerät) 22:05:04 T:2244 NOTICE: m_displayNameExtra: DirectSound: Digitalaudio (HDMI) (High Definition Audio-Gerät) 22:05:04 T:2244 NOTICE: m_deviceType : AE_DEVTYPE_PCM 22:05:04 T:2244 NOTICE: m_channels : FL,FR 22:05:04 T:2244 NOTICE: m_sampleRates : 96000 22:05:04 T:2244 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_AC3 22:05:04 T:2244 NOTICE: Device 3 22:05:04 T:2244 NOTICE: m_deviceName : {920ce316-c21d-4047-9bff-9bac24cc140e} 22:05:04 T:2244 NOTICE: m_displayName : Digitalaudio (S/PDIF) (High Definition Audio-Gerät) 22:05:04 T:2244 NOTICE: m_displayNameExtra: DirectSound: Digitalaudio (S/PDIF) (High Definition Audio-Gerät) 22:05:04 T:2244 NOTICE: m_deviceType : AE_DEVTYPE_PCM 22:05:04 T:2244 NOTICE: m_channels : FL,FR 22:05:04 T:2244 NOTICE: m_sampleRates : 96000 22:05:04 T:2244 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_AC3 22:05:04 T:2244 NOTICE: load settings... 22:05:04 T:2244 NOTICE: special://profile/ is mapped to: special://masterprofile/ 22:05:04 T:2244 NOTICE: loading special://masterprofile/guisettings.xml 22:05:04 T:2244 NOTICE: Getting hardware information now... 22:05:04 T:2244 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 22:05:04 T:2244 NOTICE: Loaded playercorefactory configuration 22:05:04 T:2244 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 22:05:04 T:2244 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 22:05:04 T:2244 NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml) 22:05:04 T:2244 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 22:05:04 T:2244 NOTICE: Default DVD Player: dvdplayer 22:05:04 T:2244 NOTICE: Default Video Player: dvdplayer 22:05:04 T:2244 NOTICE: Default Audio Player: paplayer 22:05:04 T:2244 NOTICE: Disabled debug logging due to GUI setting. Level 0. 22:05:04 T:2244 NOTICE: Log level changed to 0 22:05:04 T:2244 NOTICE: Loading media sources from special://masterprofile/sources.xml 22:05:04 T:6412 NOTICE: Thread CSoftAE start, auto delete: false 22:05:04 T:2244 NOTICE: Running database version Addons15 22:05:04 T:3752 NOTICE: Thread XBMC Peripherals start, auto delete: false 22:05:04 T:1212 NOTICE: Thread CRemoteControl start, auto delete: false 22:05:06 T:2244 NOTICE: Found screen: PnP-Monitor (Standard) on ATI Radeon HD 3200 Graphics, adapter 0. 22:05:06 T:2244 NOTICE: Primary mode: 1920x1080 @ 60.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 640x480 @ 59.94 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 640x480 @ 60.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 640x480 @ 73.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 640x480 @ 75.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 800x600 @ 60.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 800x600 @ 70.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 800x600 @ 72.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 800x600 @ 75.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 1024x768 @ 60.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 1024x768 @ 70.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 1024x768 @ 72.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 1024x768 @ 75.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 1280x720 @ 60.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 1280x960 @ 60.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 1280x1024 @ 60.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 1280x1024 @ 70.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 1280x1024 @ 75.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 1360x768 @ 60.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 1600x1200 @ 60.00 - Full Screen 22:05:06 T:2244 NOTICE: Additional mode: 1920x1080 @ 60.00 - Full Screen 22:05:06 T:2244 NOTICE: Checking resolution 16 22:05:07 T:2244 NOTICE: Running database version Addons15 22:05:07 T:2244 NOTICE: Running database version ViewModes4 22:05:07 T:2244 NOTICE: Running database version Textures13 22:05:07 T:2244 NOTICE: Running database version MyMusic30 22:05:07 T:2244 NOTICE: Running database version MyVideos72 22:05:07 T:2244 NOTICE: Running database version TV22 22:05:07 T:2244 NOTICE: Running database version Epg7 22:05:07 T:2244 NOTICE: initializing playlistplayer 22:05:07 T:2244 NOTICE: DONE initializing playlistplayer 22:05:08 T:6748 NOTICE: Thread XBPyThread start, auto delete: false 22:05:08 T:2244 NOTICE: initialize done 22:05:08 T:6748 NOTICE: -->Python Interpreter Initialized<-- 22:05:08 T:6748 ERROR: C:\Users\User\AppData\Roaming\XBMC\addons\script.TraktUtilities\nbhttpconnection.py:22: DeprecationWarning: the sha module is deprecated; use the hashlib module instead import sha 22:05:08 T:2244 NOTICE: Running the application... 22:05:09 T:5956 NOTICE: Thread Jobworker start, auto delete: true 22:05:09 T:2244 NOTICE: Webserver: Starting... 22:05:09 T:2244 NOTICE: WebServer: Started the webserver 22:05:09 T:2244 NOTICE: starting upnp server 22:05:09 T:2244 NOTICE: starting upnp renderer 22:05:09 T:2244 NOTICE: ES: Starting event server 22:05:09 T:6632 NOTICE: Thread CEventServer start, auto delete: false 22:05:09 T:6632 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777 22:05:09 T:6632 NOTICE: UDP: Listening on port 9777 22:05:09 T:4536 NOTICE: Thread CTCPServer start, auto delete: false 22:05:09 T:2040 NOTICE: Thread Jobworker start, auto delete: true 22:05:09 T:1420 NOTICE: Thread XBPyThread start, auto delete: false 22:05:09 T:1420 NOTICE: -->Python Interpreter Initialized<-- 22:05:09 T:7012 NOTICE: Thread Jobworker start, auto delete: true 22:05:10 T:7012 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 22:05:29 T:2244 WARNING: Failed to find previously selected audio sink 22:05:34 T:2244 NOTICE: Log level changed to 2 22:05:34 T:2244 NOTICE: Enabled debug logging due to GUI setting. Level 2. 22:05:34 T:2244 DEBUG: ------ Window Init () ------ 22:05:40 T:2244 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/players/dvdplayer/avutil-51.dll) 22:05:41 T:2244 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/players/dvdplayer/avcodec-53.dll) 22:05:41 T:2244 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/players/dvdplayer/avformat-53.dll) 22:05:42 T:2244 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/ImageLib.dll) 22:05:42 T:2244 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/players/dvdplayer/swscale-2.dll) 22:05:43 T:2244 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/players/dvdplayer/swresample-0.dll) 22:05:43 T:2244 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/players/dvdplayer/avfilter-2.dll) 22:05:44 T:6412 DEBUG: CAESinkDirectSound::Deinitialize: Cleaning up 22:05:45 T:2244 DEBUG: Keyboard: scancode: 01, sym: 001b, unicode: 001b, modifier: 0 22:05:45 T:2244 DEBUG: CApplication::OnKey: escape (f01b) pressed, action is PreviousMenu 22:05:45 T:6412 DEBUG: CSoftAE::Run - Sink restart flagged 22:05:45 T:6412 INFO: CSoftAE::LoadSettings - Stereo upmix is enabled 22:05:45 T:6412 INFO: CSoftAE::InternalOpenSink - sink incompatible, re-starting 22:05:45 T:6412 DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 394378 22:05:45 T:6412 DEBUG: CAESinkDirectSound::Initialize: Couldn't create secondary buffer (DSERR_UNSUPPORTED). Trying without LOCHARDWARE. 22:05:45 T:6412 DEBUG: CAESinkDirectSound::Initialize: secondary buffer created 22:05:45 T:6412 DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters: 22:05:45 T:6412 DEBUG: Audio Device : Lautsprecher (High Definition Audio-Gerät) 22:05:45 T:6412 DEBUG: Sample Rate : 44100 22:05:45 T:6412 DEBUG: Sample Format : AE_FMT_FLOAT 22:05:45 T:6412 DEBUG: Bits Per Sample : 32 22:05:45 T:6412 DEBUG: Valid Bits/Samp : 32 22:05:45 T:6412 DEBUG: Channel Count : 6 22:05:45 T:6412 DEBUG: Block Align : 24 22:05:45 T:6412 DEBUG: Avg. Bytes Sec : 1058400 22:05:45 T:6412 DEBUG: Samples/Block : 32 22:05:45 T:6412 DEBUG: Format cBSize : 22 22:05:45 T:6412 DEBUG: Channel Layout : FL,FR,FC,LFE,BL,BR 22:05:45 T:6412 DEBUG: Channel Mask : 63 22:05:45 T:6412 DEBUG: Frames : 441 22:05:45 T:6412 DEBUG: Frame Samples : 2646 22:05:45 T:6412 DEBUG: Frame Size : 24 22:05:45 T:6412 DEBUG: CSoftAE::InternalOpenSink - DirectSound Initialized: 22:05:45 T:6412 DEBUG: Output Device : Lautsprecher (High Definition Audio-Gerät) 22:05:45 T:6412 DEBUG: Sample Rate : 44100 22:05:45 T:6412 DEBUG: Sample Format : AE_FMT_FLOAT 22:05:45 T:6412 DEBUG: Channel Count : 6 22:05:45 T:6412 DEBUG: Channel Layout: FL,FR,FC,LFE,BL,BR 22:05:45 T:6412 DEBUG: Frames : 441 22:05:45 T:6412 DEBUG: Frame Samples : 2646 22:05:45 T:6412 DEBUG: Frame Size : 24 22:05:45 T:6412 DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 5.1 22:05:45 T:6412 DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 10584 22:05:45 T:6412 DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback 22:05:45 T:2244 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:05:45 T:2244 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------ 22:05:45 T:2244 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 22:05:45 T:2244 DEBUG: ------ Window Init (Settings.xml) ------ 22:05:46 T:2244 DEBUG: Keyboard: scancode: 01, sym: 001b, unicode: 001b, modifier: 0 22:05:46 T:2244 DEBUG: CApplication::OnKey: escape (f01b) pressed, action is PreviousMenu 22:05:46 T:2244 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:05:46 T:2244 DEBUG: ------ Window Deinit (Settings.xml) ------ 22:05:46 T:2244 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 22:05:46 T:2244 DEBUG: ------ Window Init (Home.xml) ------ 22:05:46 T:2244 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib.dll) 22:05:48 T:2244 DEBUG: Keyboard: scancode: 4b, sym: 0114, unicode: 0000, modifier: 0 22:05:48 T:2244 DEBUG: CApplication::OnKey: left (f082) pressed, action is Left 22:05:49 T:2244 DEBUG: Keyboard: scancode: 4b, sym: 0114, unicode: 0000, modifier: 0 22:05:49 T:2244 DEBUG: CApplication::OnKey: left (f082) pressed, action is Left 22:05:51 T:2244 DEBUG: Keyboard: scancode: 4b, sym: 0114, unicode: 0000, modifier: 0 22:05:51 T:2244 DEBUG: CApplication::OnKey: left (f082) pressed, action is Left 22:05:51 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:05:51 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:05:53 T:2244 DEBUG: Keyboard: scancode: 1c, sym: 000d, unicode: 000d, modifier: 0 22:05:53 T:2244 DEBUG: CApplication::OnKey: return (f00d) pressed, action is Select 22:05:53 T:2244 DEBUG: CApplication::ExecuteXBMCAction : Translating ActivateWindow(Videos,Files,return) 22:05:53 T:2244 DEBUG: CApplication::ExecuteXBMCAction : To ActivateWindow(Videos,Files,return) 22:05:53 T:2244 DEBUG: Activating window ID: 10025 22:05:53 T:2244 DEBUG: ------ Window Deinit (Home.xml) ------ 22:05:53 T:2244 DEBUG: CApplication::ExecuteXBMCAction : Translating SetProperty(VideosDirectLink,True) 22:05:53 T:2244 DEBUG: CApplication::ExecuteXBMCAction : To SetProperty(VideosDirectLink,True) 22:05:53 T:2244 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 22:05:53 T:2244 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 22:05:53 T:2244 DEBUG: CGUIMediaWindow::GetDirectory (sources://video/) 22:05:53 T:2244 DEBUG: ParentPath = [sources://video/] 22:05:53 T:6396 NOTICE: Thread Background Loader start, auto delete: false 22:05:53 T:6396 DEBUG: Thread Background Loader 6396 terminating 22:05:55 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:05:55 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:05:55 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:05:55 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:05:55 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:05:55 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:05:56 T:2244 DEBUG: Keyboard: scancode: 1c, sym: 000d, unicode: 000d, modifier: 0 22:05:56 T:2244 DEBUG: CApplication::OnKey: return (f00d) pressed, action is Select 22:05:56 T:2244 DEBUG: CGUIMediaWindow::GetDirectory (multipath://I%3a%5cAction%5c/J%3a%5cAction%5c/L%3a%5cAction%5c/k%3a%5caction%5c/) 22:05:56 T:2244 DEBUG: ParentPath = [sources://video/] 22:05:56 T:2040 DEBUG: CMultiPathDirectory::GetDirectory(multipath://I%3a%5cAction%5c/J%3a%5cAction%5c/L%3a%5cAction%5c/k%3a%5caction%5c/) 22:05:56 T:2040 DEBUG: Getting Directory (I:\Action\) 22:05:56 T:2040 DEBUG: Getting Directory (J:\Action\) 22:05:56 T:2040 DEBUG: Getting Directory (L:\Action\) 22:05:56 T:2040 DEBUG: Getting Directory (k:\action\) 22:05:56 T:2040 DEBUG: CMultiPathDirectory::MergeItems, items = 325 22:05:56 T:2244 DEBUG: CVideoDatabase::RunQuery took 8 ms for 21 items query: select * from movieview WHERE c23=90 22:05:56 T:2244 DEBUG: CVideoDatabase::RunQuery took 7 ms for 23 items query: select * from movieview WHERE c23=107 22:05:56 T:2244 DEBUG: CVideoDatabase::RunQuery took 7 ms for 25 items query: select * from movieview WHERE c23=462 22:05:56 T:2244 DEBUG: CVideoDatabase::RunQuery took 1 ms for 13 items query: select * from movieview WHERE c23=1118 22:05:56 T:2244 DEBUG: CVideoDatabase::RunQuery took 0 ms for 21 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=90 22:05:56 T:2244 DEBUG: CVideoDatabase::RunQuery took 1 ms for 23 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=107 22:05:56 T:2244 DEBUG: CVideoDatabase::RunQuery took 0 ms for 25 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=462 22:05:56 T:2244 DEBUG: CVideoDatabase::RunQuery took 0 ms for 14 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=1118 22:05:56 T:7120 NOTICE: Thread Background Loader start, auto delete: false 22:05:56 T:296 NOTICE: Thread Jobworker start, auto delete: true 22:05:56 T:7012 DEBUG: CThumbExtractor::DoWork - trying to extract filestream details from video file k:\action\Conair.m2ts 22:05:57 T:7120 DEBUG: Thread Background Loader 7120 terminating 22:05:57 T:2244 DEBUG: Keyboard: scancode: 4b, sym: 0114, unicode: 0000, modifier: 0 22:05:57 T:2244 DEBUG: CApplication::OnKey: left (f082) pressed, action is Left 22:05:57 T:2244 DEBUG: Keyboard: scancode: 4b, sym: 0114, unicode: 0000, modifier: 0 22:05:57 T:2244 DEBUG: CApplication::OnKey: left (f082) pressed, action is Left 22:05:58 T:2244 DEBUG: Keyboard: scancode: 4b, sym: 0114, unicode: 0000, modifier: 0 22:05:58 T:2244 DEBUG: CApplication::OnKey: left (f082) pressed, action is Left 22:05:58 T:2244 DEBUG: Keyboard: scancode: 4b, sym: 0114, unicode: 0000, modifier: 0 22:05:58 T:2244 DEBUG: CApplication::OnKey: left (f082) pressed, action is Left 22:05:59 T:2244 DEBUG: Keyboard: scancode: 1c, sym: 000d, unicode: 000d, modifier: 0 22:05:59 T:2244 DEBUG: CApplication::OnKey: return (f00d) pressed, action is Select 22:05:59 T:2244 INFO: Loading skin file: DialogContextMenu.xml, load type: KEEP_IN_MEMORY 22:05:59 T:2244 DEBUG: ------ Window Init (DialogContextMenu.xml) ------ 22:06:00 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:06:00 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:06:01 T:2244 DEBUG: Keyboard: scancode: 1c, sym: 000d, unicode: 000d, modifier: 0 22:06:01 T:2244 DEBUG: CApplication::OnKey: return (f00d) pressed, action is Select 22:06:01 T:2244 DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------ 22:06:01 T:2244 DEBUG: CGUIWindowVideoBase::OnPlayMedia I:\Action\Transporter 3.m2ts 22:06:01 T:2244 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 22:06:01 T:2244 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 22:06:01 T:2244 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 22:06:01 T:2244 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 22:06:01 T:2244 DEBUG: CPlayerCoreFactory::GetPlayers(I:\Action\Transporter 3.m2ts) 22:06:01 T:2244 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 22:06:01 T:2244 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 22:06:01 T:2244 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv 22:06:01 T:2244 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp 22:06:01 T:2244 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 22:06:01 T:2244 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 22:06:01 T:2244 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 22:06:01 T:2244 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 22:06:01 T:2244 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 22:06:01 T:2244 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 22:06:01 T:2244 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 22:06:01 T:2244 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 22:06:01 T:2244 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 22:06:01 T:2244 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1) 22:06:01 T:2244 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 22:06:01 T:2244 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 22:06:01 T:2244 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1) 22:06:01 T:2244 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 22:06:01 T:2244 NOTICE: DVDPlayer: Opening: I:\Action\Transporter 3.m2ts 22:06:01 T:2244 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 22:06:01 T:2244 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec 22:06:01 T:2244 DEBUG: DXVA - cheking samples array size using 842094158 render target 22:06:01 T:2244 DEBUG: DXVA - updated maximum samples count to 2 22:06:01 T:2244 DEBUG: DXVA - cheking samples array size using 842094169 render target 22:06:01 T:1420 NOTICE: Thread CDVDPlayer start, auto delete: false 22:06:01 T:1420 NOTICE: Creating InputStream 22:06:01 T:1420 DEBUG: CUtil::ScanForExternalSubtitles: Searching for subtitles... 22:06:01 T:2244 DEBUG: ------ Window Init (DialogBusy.xml) ------ 22:06:01 T:1420 DEBUG: CUtil::ScanForExternalSubtitles: END (total time: 109 ms) 22:06:01 T:1420 NOTICE: Creating Demuxer 22:06:01 T:1420 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avutil-51.dll) 22:06:01 T:1420 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avcodec-53.dll) 22:06:01 T:1420 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avformat-53.dll) 22:06:02 T:1420 DEBUG: CDVDDemuxFFmpeg::Open - probing detected format [mpegts] 22:06:02 T:1420 DEBUG: CDVDDemuxFFmpeg::Open - avformat_find_stream_info starting 22:06:02 T:1420 DEBUG: ffmpeg[58C]: [mpegts] max_analyze_duration 5000000 reached at 5002667 22:06:02 T:1420 DEBUG: ffmpeg[58C]: [NULL] start time is not set in estimate_timings_from_pts 22:06:02 T:1420 DEBUG: Previous line repeats 1 times. 22:06:02 T:1420 DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished 22:06:02 T:1420 INFO: ffmpeg[58C]: Input #0, mpegts, from 'I:\Action\Transporter 3.m2ts': 22:06:02 T:1420 INFO: ffmpeg[58C]: Duration: 01:43:27.98, start: 600.000000, bitrate: 33704 kb/s 22:06:02 T:1420 INFO: ffmpeg[58C]: Program 1 22:06:02 T:1420 INFO: ffmpeg[58C]: Stream #0:0[0x1011]: Video: vc1 (Advanced) (VC-1 / 0x312D4356), yuv420p, 1920x1080 [SAR 1:1 DAR 16:9], 24 fps, 24 tbr, 90k tbn, 48 tbc 22:06:02 T:1420 INFO: ffmpeg[58C]: Stream #0:1[0x1100](deu): Audio: dts (DTS-HD MA) ([0][0][0] / 0x0086), 48000 Hz, 5.1(side), s16, 1536 kb/s 22:06:02 T:1420 INFO: ffmpeg[58C]: Stream #0:2[0x1200](deu): Subtitle: hdmv_pgs_subtitle ([0][0][0] / 0x0090) 22:06:02 T:1420 INFO: ffmpeg[58C]: Stream #0:3[0x1201](deu): Subtitle: hdmv_pgs_subtitle ([0][0][0] / 0x0090) 22:06:02 T:1420 NOTICE: Opening video stream: 0 source: 256 22:06:02 T:1420 NOTICE: Creating video codec with codec id: 72 22:06:02 T:1420 DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:yes DXVA:yes 22:06:02 T:1420 DEBUG: FactoryCodec - Video: - Opening 22:06:02 T:1420 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/swscale-2.dll) 22:06:02 T:1420 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/swresample-0.dll) 22:06:02 T:1420 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avfilter-2.dll) 22:06:02 T:1420 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: SMPTE VC-1 22:06:02 T:1420 DEBUG: FactoryCodec - Video: ff-vc1 - Opened 22:06:02 T:6028 NOTICE: Thread CVideoReferenceClock start, auto delete: false 22:06:02 T:6028 DEBUG: CVideoReferenceClock: Setting up Direct3d 22:06:02 T:6028 DEBUG: CVideoReferenceClock: SetThreadPriority failed 22:06:02 T:6028 DEBUG: CVideoReferenceClock: detected refreshrate: 60 hertz, assuming 60 hertz 22:06:02 T:1420 NOTICE: Creating video thread 22:06:02 T:1420 NOTICE: Opening audio stream: 1 source: 256 22:06:02 T:1420 NOTICE: Finding audio codec for: 86020 22:06:02 T:1420 DEBUG: FactoryCodec - Audio: FFmpeg - Opening 22:06:02 T:6352 NOTICE: Thread CDVDPlayerVideo start, auto delete: false 22:06:02 T:6352 NOTICE: running thread: video_thread 22:06:02 T:6352 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 22:06:02 T:1420 DEBUG: FactoryCodec - Audio: FFmpeg - Opened 22:06:02 T:1420 NOTICE: Creating audio thread 22:06:02 T:1420 NOTICE: Opening Subtitle stream: 2 source: 256 22:06:02 T:1420 DEBUG: FactoryCodec - Overlay: FFmpeg Subtitle Decoder - Opening 22:06:02 T:4232 NOTICE: Thread CDVDPlayerAudio start, auto delete: false 22:06:02 T:4232 NOTICE: running thread: CDVDPlayerAudio::Process() 22:06:02 T:1420 DEBUG: FactoryCodec - Overlay: FFmpeg Subtitle Decoder - Opened 22:06:02 T:1420 DEBUG: CEdl::ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: I:\Action\Transporter 3.m2ts 22:06:02 T:1420 DEBUG: CDVDPlayer::SetCaching - caching state 3 22:06:02 T:6352 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(0.000000, 1) 22:06:02 T:4232 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(0.000000, 0) 22:06:02 T:6352 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 22:06:02 T:4232 NOTICE: Creating audio stream (codec id: 86020, channels: 6, sample rate: 48000, no pass-through) 22:06:02 T:4232 INFO: CSoftAE::MakeStream - AE_FMT_S16NE, 48000, FL,FR,FC,LFE,SL,SR 22:06:02 T:6412 DEBUG: CSoftAE::Run - Sink restart flagged 22:06:02 T:6412 INFO: CSoftAE::LoadSettings - Stereo upmix is enabled 22:06:02 T:6412 DEBUG: CAESinkDirectSound::IsCompatible: Formats Incompatible due to different :Sample Rates 22:06:02 T:6412 INFO: CSoftAE::InternalOpenSink - sink incompatible, re-starting 22:06:02 T:6412 DEBUG: CAESinkDirectSound::Deinitialize: Cleaning up 22:06:02 T:2244 DEBUG: CGUIInfoManager::SetCurrentMovie(I:\Action\Transporter 3.m2ts) 22:06:02 T:2244 DEBUG: CVideoDatabase::GetMovieId (I:\Action\Transporter 3.m2ts), query = select idMovie from movie where idFile=906 22:06:02 T:2244 DEBUG: CVideoDatabase::GetEpisodeId (I:\Action\Transporter 3.m2ts), query = select idEpisode from episode where idFile=906 22:06:02 T:2244 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 22:06:02 T:2244 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 22:06:02 T:2244 DEBUG: Building didl for object 'I:\Action\Transporter 3.m2ts' 22:06:02 T:6352 NOTICE: fps: 24.000000, pwidth: 1920, pheight: 1080, dwidth: 1920, dheight: 1080 22:06:02 T:6352 DEBUG: CDVDPlayerVideo::OutputPicture - change configuration. 1920x1080. framerate: 24.00. format: YV12 22:06:02 T:6352 DEBUG: Resolution 1920x1080 @ 60.00 - Full Screen (16) not a very good match for fps 24.000 (weight: 0.167), trying 2:3 cadence 22:06:02 T:6352 NOTICE: Display resolution ADJUST : 1920x1080 @ 60.00 - Full Screen (16) (weight: 0.000) 22:06:02 T:6352 DEBUG: CWinRenderer::SelectRenderMethod: Requested render method: 0 22:06:02 T:6352 DEBUG: CWinShader::LoadEffect - loading shader special://xbmc/system/shaders/testshader.fx 22:06:02 T:6352 DEBUG: CWinRenderer::SelectRenderMethod: Selected render method 1: Pixel Shaders 22:06:02 T:2244 DEBUG: Activating window ID: 12005 22:06:02 T:6412 DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 394378 22:06:02 T:6412 DEBUG: CAESinkDirectSound::Initialize: Couldn't create secondary buffer (DSERR_UNSUPPORTED). Trying without LOCHARDWARE. 22:06:02 T:2244 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 22:06:02 T:6412 DEBUG: CAESinkDirectSound::Initialize: secondary buffer created 22:06:02 T:6412 DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters: 22:06:02 T:6412 DEBUG: Audio Device : Lautsprecher (High Definition Audio-Gerät) 22:06:02 T:6412 DEBUG: Sample Rate : 48000 22:06:02 T:6412 DEBUG: Sample Format : AE_FMT_FLOAT 22:06:02 T:6412 DEBUG: Bits Per Sample : 32 22:06:02 T:6412 DEBUG: Valid Bits/Samp : 32 22:06:02 T:6412 DEBUG: Channel Count : 6 22:06:02 T:6412 DEBUG: Block Align : 24 22:06:02 T:6412 DEBUG: Avg. Bytes Sec : 1152000 22:06:02 T:6412 DEBUG: Samples/Block : 32 22:06:02 T:6412 DEBUG: Format cBSize : 22 22:06:02 T:6412 DEBUG: Channel Layout : FL,FR,FC,LFE,BL,BR 22:06:02 T:6412 DEBUG: Channel Mask : 63 22:06:02 T:6412 DEBUG: Frames : 480 22:06:02 T:6412 DEBUG: Frame Samples : 2880 22:06:02 T:6412 DEBUG: Frame Size : 24 22:06:02 T:6412 DEBUG: CSoftAE::InternalOpenSink - DirectSound Initialized: 22:06:02 T:6412 DEBUG: Output Device : Lautsprecher (High Definition Audio-Gerät) 22:06:02 T:6412 DEBUG: Sample Rate : 48000 22:06:02 T:6412 DEBUG: Sample Format : AE_FMT_FLOAT 22:06:02 T:6412 DEBUG: Channel Count : 6 22:06:02 T:6412 DEBUG: Channel Layout: FL,FR,FC,LFE,BL,BR 22:06:02 T:6412 DEBUG: Frames : 480 22:06:02 T:6412 DEBUG: Frame Samples : 2880 22:06:02 T:6412 DEBUG: Frame Size : 24 22:06:02 T:6412 DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 5.1 22:06:02 T:6412 DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 11520 22:06:02 T:6412 DEBUG: AERemap: Downmix normalization is disabled 22:06:02 T:2244 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 22:06:02 T:2244 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY 22:06:02 T:6412 DEBUG: AERemap: Downmix normalization is disabled 22:06:02 T:6412 DEBUG: Previous line repeats 5 times. 22:06:02 T:6412 DEBUG: CSoftAEStream::CSoftAEStream - Converting from AE_FMT_S16NE to AE_FMT_FLOAT 22:06:02 T:4232 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback 22:06:02 T:1420 DEBUG: CDVDPlayer::HandleMessages - player started 1 22:06:02 T:6412 DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback 22:06:02 T:1420 DEBUG: CDVDPlayer::SetCaching - caching state 0 22:06:02 T:6412 DEBUG: CSoftAE::Run - Sink restart flagged 22:06:02 T:6412 INFO: CSoftAE::LoadSettings - Stereo upmix is enabled 22:06:02 T:6412 DEBUG: CAESinkDirectSound::IsCompatible: Formats compatible - reusing existing sink 22:06:02 T:6412 INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR,FC,BL,BR,LFE, 48000hz 22:06:02 T:6412 DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 5.1 22:06:02 T:6412 DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 11520 22:06:02 T:4232 DEBUG: CDVDPlayerAudio:: Discontinuity - was:3622.304257, should be:10666.666667, error:7044.362410 22:06:02 T:2244 DEBUG: created video buffer 0 22:06:02 T:2244 DEBUG: created video buffer 1 22:06:02 T:2244 DEBUG: CWinShader::LoadEffect - loading shader special://xbmc/system/shaders/yuv2rgb_d3d.fx 22:06:02 T:4232 DEBUG: CDVDPlayerAudio:: Discontinuity - was:172798.283150, should be:42541.663569, error:-130256.619581 22:06:02 T:1420 DEBUG: CDVDPlayer::HandleMessages - player started 2 22:06:02 T:2244 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 22:06:04 T:4232 DEBUG: CDVDPlayerAudio:: Discontinuity - was:2048020.837193, should be:2031354.170526, error:-16666.666667 22:06:07 T:6352 DEBUG: CPullupCorrection: detected pattern of length 1: 41666.67, frameduration: 41666.666667 22:06:08 T:2244 DEBUG: Keyboard: scancode: 18, sym: 006f, unicode: 006f, modifier: 0 22:06:08 T:2244 DEBUG: CApplication::OnKey: o (f04f) pressed, action is CodecInfo 22:06:14 T:6352 DEBUG: CPullupCorrection: detected pattern of length 1: 41666.67, frameduration: 41666.666667 22:06:23 T:2244 DEBUG: Keyboard: scancode: 4d, sym: 0113, unicode: 0000, modifier: 0 22:06:23 T:2244 DEBUG: CApplication::OnKey: right (f083) pressed, action is StepForward 22:06:23 T:1420 DEBUG: CDVDPlayer::SetCaching - caching state 3 22:06:23 T:1420 DEBUG: demuxer seek to: 50103 22:06:23 T:2244 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 22:06:23 T:2244 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 22:06:23 T:2244 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 22:06:23 T:6412 DEBUG: CSoftAE::Run - Sink restart flagged 22:06:23 T:6412 INFO: CSoftAE::LoadSettings - Stereo upmix is enabled 22:06:23 T:6412 DEBUG: CAESinkDirectSound::IsCompatible: Formats compatible - reusing existing sink 22:06:23 T:6412 INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR,FC,BL,BR,LFE, 48000hz 22:06:23 T:6412 DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 5.1 22:06:23 T:6412 DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 11520 22:06:23 T:1420 DEBUG: CDVDDemuxFFmpeg::SeekTime - seek ended up on time 50458 22:06:23 T:1420 DEBUG: demuxer seek to: 50103, success 22:06:23 T:4232 DEBUG: CSoftAEStream::Flush 22:06:23 T:4232 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 22:06:23 T:6352 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 22:06:23 T:4232 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(50464000.000000, 1) 22:06:23 T:6352 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(50458333.333333, 0) 22:06:23 T:1420 DEBUG: CDVDPlayer::HandleMessages - player started 1 22:06:23 T:6352 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 22:06:23 T:1420 DEBUG: CDVDPlayer::HandleMessages - player started 2 22:06:23 T:1420 DEBUG: CDVDPlayer::SetCaching - caching state 0 22:06:23 T:6412 DEBUG: CSoftAE::Run - Sink restart flagged 22:06:23 T:6412 INFO: CSoftAE::LoadSettings - Stereo upmix is enabled 22:06:23 T:6412 DEBUG: CAESinkDirectSound::IsCompatible: Formats compatible - reusing existing sink 22:06:23 T:6412 INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR,FC,BL,BR,LFE, 48000hz 22:06:23 T:6412 DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 5.1 22:06:23 T:6412 DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 11520 22:06:23 T:4232 DEBUG: CDVDPlayerAudio:: Discontinuity - was:50358741.643064, should be:50371993.047107, error:13251.404044 22:06:23 T:4232 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available 22:06:25 T:4232 WARNING: Previous line repeats 2 times. 22:06:25 T:4232 DEBUG: CDVDPlayerAudio:: Discontinuity - was:52402373.576420, should be:52385706.909754, error:-16666.666667 22:06:26 T:2244 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 22:06:27 T:4232 DEBUG: CDVDPlayerAudio:: Discontinuity - was:54505378.153340, should be:54488711.486674, error:-16666.666667 22:06:28 T:7012 DEBUG: Thread Jobworker 7012 terminating (autodelete) 22:06:28 T:5956 DEBUG: Thread Jobworker 5956 terminating (autodelete) 22:06:28 T:2040 DEBUG: Thread Jobworker 2040 terminating (autodelete) 22:06:28 T:296 DEBUG: Thread Jobworker 296 terminating (autodelete) 22:06:29 T:6352 DEBUG: CPullupCorrection: detected pattern of length 1: 41666.67, frameduration: 41666.666667 22:06:30 T:2244 DEBUG: Keyboard: scancode: 18, sym: 006f, unicode: 006f, modifier: 0 22:06:30 T:2244 DEBUG: CApplication::OnKey: o (f04f) pressed, action is CodecInfo 22:06:33 T:2244 DEBUG: ------ Window Init (VideoOSD.xml) ------ 22:06:33 T:2244 INFO: Loading skin file: VideoOSD.xml, load type: KEEP_IN_MEMORY 22:06:33 T:2244 DEBUG: ------ Window Init (Pointer.xml) ------ 22:06:33 T:4232 DEBUG: CDVDPlayerAudio:: Discontinuity - was:60879012.297113, should be:60862345.630446, error:-16666.666667 22:06:36 T:2244 DEBUG: CApplication::ProcessMouse: trying mouse action leftclick 22:06:36 T:2244 DEBUG: CApplication::ExecuteXBMCAction : Translating PlayerControl(Stop) 22:06:36 T:2244 DEBUG: CApplication::ExecuteXBMCAction : To PlayerControl(Stop) 22:06:36 T:2244 NOTICE: CDVDPlayer::CloseFile() 22:06:36 T:2244 NOTICE: DVDPlayer: waiting for threads to exit 22:06:36 T:1420 NOTICE: CDVDPlayer::OnExit() 22:06:36 T:1420 NOTICE: DVDPlayer: closing audio stream 22:06:36 T:1420 NOTICE: Closing audio stream 22:06:36 T:1420 NOTICE: Waiting for audio thread to exit 22:06:36 T:4232 NOTICE: thread end: CDVDPlayerAudio::OnExit() 22:06:36 T:1420 NOTICE: Closing audio device 22:06:36 T:4232 DEBUG: Thread CDVDPlayerAudio 4232 terminating 22:06:36 T:6412 DEBUG: CSoftAE::Run - Sink restart flagged 22:06:36 T:6412 INFO: CSoftAE::LoadSettings - Stereo upmix is enabled 22:06:36 T:6412 DEBUG: CAESinkDirectSound::IsCompatible: Formats Incompatible due to different :Sample Rates 22:06:36 T:6412 INFO: CSoftAE::InternalOpenSink - sink incompatible, re-starting 22:06:36 T:6412 DEBUG: CAESinkDirectSound::Deinitialize: Cleaning up 22:06:36 T:6412 DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 394378 22:06:36 T:6412 DEBUG: CAESinkDirectSound::Initialize: Couldn't create secondary buffer (DSERR_UNSUPPORTED). Trying without LOCHARDWARE. 22:06:36 T:6412 DEBUG: CAESinkDirectSound::Initialize: secondary buffer created 22:06:36 T:6412 DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters: 22:06:36 T:6412 DEBUG: Audio Device : Lautsprecher (High Definition Audio-Gerät) 22:06:36 T:6412 DEBUG: Sample Rate : 44100 22:06:36 T:6412 DEBUG: Sample Format : AE_FMT_FLOAT 22:06:36 T:6412 DEBUG: Bits Per Sample : 32 22:06:36 T:6412 DEBUG: Valid Bits/Samp : 32 22:06:36 T:6412 DEBUG: Channel Count : 6 22:06:36 T:6412 DEBUG: Block Align : 24 22:06:36 T:6412 DEBUG: Avg. Bytes Sec : 1058400 22:06:36 T:6412 DEBUG: Samples/Block : 32 22:06:36 T:6412 DEBUG: Format cBSize : 22 22:06:36 T:6412 DEBUG: Channel Layout : FL,FR,FC,LFE,BL,BR 22:06:36 T:6412 DEBUG: Channel Mask : 63 22:06:36 T:6412 DEBUG: Frames : 441 22:06:36 T:6412 DEBUG: Frame Samples : 2646 22:06:36 T:6412 DEBUG: Frame Size : 24 22:06:36 T:6412 DEBUG: CSoftAE::InternalOpenSink - DirectSound Initialized: 22:06:36 T:6412 DEBUG: Output Device : Lautsprecher (High Definition Audio-Gerät) 22:06:36 T:6412 DEBUG: Sample Rate : 44100 22:06:36 T:6412 DEBUG: Sample Format : AE_FMT_FLOAT 22:06:36 T:6412 DEBUG: Channel Count : 6 22:06:36 T:6412 DEBUG: Channel Layout: FL,FR,FC,LFE,BL,BR 22:06:36 T:6412 DEBUG: Frames : 441 22:06:36 T:6412 DEBUG: Frame Samples : 2646 22:06:36 T:6412 DEBUG: Frame Size : 24 22:06:36 T:6412 DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 5.1 22:06:36 T:6412 DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 10584 22:06:36 T:6412 DEBUG: AERemap: Downmix normalization is disabled 22:06:36 T:1420 DEBUG: Previous line repeats 5 times. 22:06:36 T:1420 DEBUG: CSoftAEStream::~CSoftAEStream - Destructed 22:06:36 T:1420 NOTICE: Deleting audio codec 22:06:36 T:1420 NOTICE: DVDPlayer: closing video stream 22:06:36 T:1420 NOTICE: Closing video stream 22:06:36 T:1420 NOTICE: waiting for video thread to exit 22:06:36 T:6412 DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback 22:06:36 T:6352 NOTICE: thread end: video_thread 22:06:36 T:6352 DEBUG: Thread CDVDPlayerVideo 6352 terminating 22:06:36 T:1420 NOTICE: deleting video codec 22:06:36 T:1420 NOTICE: DVDPlayer: closing subtitle stream 22:06:36 T:1420 NOTICE: Closing subtitle stream 22:06:36 T:1420 NOTICE: CDVDPlayer::OnExit() deleting demuxer 22:06:36 T:1420 NOTICE: CDVDPlayer::OnExit() deleting input stream 22:06:36 T:1420 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 22:06:36 T:1420 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 22:06:36 T:1420 DEBUG: Thread CDVDPlayer 1420 terminating 22:06:36 T:2244 NOTICE: DVDPlayer: finished waiting 22:06:36 T:2244 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:06:36 T:2244 DEBUG: ------ Window Deinit (VideoOSD.xml) ------ 22:06:36 T:2244 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 22:06:37 T:2244 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 22:06:37 T:2244 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 22:06:37 T:2244 DEBUG: CGUIMediaWindow::GetDirectory (multipath://I%3a%5cAction%5c/J%3a%5cAction%5c/L%3a%5cAction%5c/k%3a%5caction%5c/) 22:06:37 T:2244 DEBUG: ParentPath = [multipath://I%3a%5cAction%5c/J%3a%5cAction%5c/L%3a%5cAction%5c/k%3a%5caction%5c/] 22:06:37 T:2244 DEBUG: CMultiPathDirectory::GetDirectory(multipath://I%3a%5cAction%5c/J%3a%5cAction%5c/L%3a%5cAction%5c/k%3a%5caction%5c/) 22:06:37 T:2244 DEBUG: Getting Directory (I:\Action\) 22:06:37 T:2244 DEBUG: Getting Directory (J:\Action\) 22:06:37 T:2244 DEBUG: Getting Directory (L:\Action\) 22:06:37 T:2244 DEBUG: Getting Directory (k:\action\) 22:06:37 T:2244 DEBUG: CMultiPathDirectory::MergeItems, items = 325 22:06:37 T:2244 DEBUG: CVideoDatabase::RunQuery took 2 ms for 21 items query: select * from movieview WHERE c23=90 22:06:37 T:2244 DEBUG: CVideoDatabase::RunQuery took 2 ms for 23 items query: select * from movieview WHERE c23=107 22:06:37 T:2244 DEBUG: CVideoDatabase::RunQuery took 2 ms for 25 items query: select * from movieview WHERE c23=462 22:06:37 T:2244 DEBUG: CVideoDatabase::RunQuery took 3 ms for 13 items query: select * from movieview WHERE c23=1118 22:06:37 T:2244 DEBUG: CVideoDatabase::RunQuery took 2 ms for 21 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=90 22:06:37 T:2244 DEBUG: CVideoDatabase::RunQuery took 1 ms for 23 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=107 22:06:37 T:2244 DEBUG: CVideoDatabase::RunQuery took 1 ms for 25 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=462 22:06:37 T:2244 DEBUG: CVideoDatabase::RunQuery took 1 ms for 14 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=1118 22:06:37 T:5436 NOTICE: Thread Background Loader start, auto delete: false 22:06:37 T:7156 NOTICE: Thread Jobworker start, auto delete: true 22:06:37 T:7156 DEBUG: CThumbExtractor::DoWork - trying to extract filestream details from video file k:\action\Conair.m2ts 22:06:37 T:5436 DEBUG: Thread Background Loader 5436 terminating 22:06:37 T:2244 NOTICE: CDVDPlayer::CloseFile() 22:06:37 T:2244 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 22:06:37 T:2244 NOTICE: DVDPlayer: waiting for threads to exit 22:06:37 T:2244 NOTICE: DVDPlayer: finished waiting 22:06:37 T:6028 DEBUG: CVideoReferenceClock: Cleaning up Direct3d 22:06:37 T:6028 DEBUG: Thread CVideoReferenceClock 6028 terminating 22:06:37 T:7156 DEBUG: CSaveFileStateJob::DoWork - Saving file state for video item I:\Action\Transporter 3.m2ts 22:06:37 T:2244 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/ImageLib.dll) 22:06:37 T:7156 DEBUG: CAnnouncementManager - Announcement: OnUpdate from xbmc 22:06:37 T:7156 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnUpdate 22:06:38 T:2244 DEBUG: Keyboard: scancode: 01, sym: 001b, unicode: 001b, modifier: 0 22:06:38 T:2244 DEBUG: CApplication::OnKey: escape (f01b) pressed, action is PreviousMenu 22:06:38 T:2244 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:06:38 T:2244 DEBUG: ------ Window Deinit (Pointer.xml) ------ 22:06:38 T:2244 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 22:06:39 T:2244 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 22:06:39 T:2244 DEBUG: ------ Window Init (Home.xml) ------ 22:06:39 T:2244 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib.dll) 22:06:39 T:2244 DEBUG: Keyboard: scancode: 4d, sym: 0113, unicode: 0000, modifier: 0 22:06:39 T:2244 DEBUG: CApplication::OnKey: right (f083) pressed, action is Right 22:06:40 T:2244 DEBUG: Keyboard: scancode: 4d, sym: 0113, unicode: 0000, modifier: 0 22:06:40 T:2244 DEBUG: CApplication::OnKey: right (f083) pressed, action is Right 22:06:40 T:2244 DEBUG: Keyboard: scancode: 4d, sym: 0113, unicode: 0000, modifier: 0 22:06:40 T:2244 DEBUG: CApplication::OnKey: right (f083) pressed, action is Right 22:06:41 T:2244 DEBUG: Keyboard: scancode: 1c, sym: 000d, unicode: 000d, modifier: 0 22:06:41 T:2244 DEBUG: CApplication::OnKey: return (f00d) pressed, action is Select 22:06:41 T:2244 DEBUG: CApplication::ExecuteXBMCAction : Translating ActivateWindow(Settings) 22:06:41 T:2244 DEBUG: CApplication::ExecuteXBMCAction : To ActivateWindow(Settings) 22:06:41 T:2244 DEBUG: Activating window ID: 10004 22:06:41 T:2244 DEBUG: ------ Window Deinit (Home.xml) ------ 22:06:41 T:2244 DEBUG: ------ Window Init (Settings.xml) ------ 22:06:42 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:06:42 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:06:43 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:06:43 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:06:43 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:06:43 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:06:43 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:06:43 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:06:43 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:06:43 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:06:43 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:06:43 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:06:43 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:06:43 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:06:43 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:06:43 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:06:44 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:06:44 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:06:44 T:2244 DEBUG: Keyboard: scancode: 1c, sym: 000d, unicode: 000d, modifier: 0 22:06:44 T:2244 DEBUG: CApplication::OnKey: return (f00d) pressed, action is Select 22:06:44 T:2244 DEBUG: CApplication::ExecuteXBMCAction : Translating ActivateWindow(SystemSettings) 22:06:44 T:2244 DEBUG: CApplication::ExecuteXBMCAction : To ActivateWindow(SystemSettings) 22:06:44 T:2244 DEBUG: Activating window ID: 10016 22:06:45 T:2244 DEBUG: ------ Window Deinit (Settings.xml) ------ 22:06:45 T:2244 DEBUG: ------ Window Init (SettingsCategory.xml) ------ 22:06:46 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:06:46 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:06:46 T:2244 WARNING: Failed to find previously selected audio sink 22:06:46 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:06:46 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:06:46 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:06:46 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:06:46 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:06:46 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:06:47 T:2244 DEBUG: Keyboard: scancode: 50, sym: 0112, unicode: 0000, modifier: 0 22:06:47 T:2244 DEBUG: CApplication::OnKey: down (f081) pressed, action is Down 22:06:47 T:2244 DEBUG: Keyboard: scancode: 4d, sym: 0113, unicode: 0000, modifier: 0 22:06:47 T:2244 DEBUG: CApplication::OnKey: right (f083) pressed, action is Right 22:06:48 T:2244 DEBUG: Keyboard: scancode: 1c, sym: 000d, unicode: 000d, modifier: 0 22:06:48 T:2244 DEBUG: CApplication::OnKey: return (f00d) pressed, action is Select 22:06:48 T:2244 NOTICE: Disabled debug logging due to GUI setting. Level 0. 22:06:48 T:2244 NOTICE: Log level changed to 0 22:07:06 T:2244 NOTICE: Storing total System Uptime 22:07:06 T:2244 NOTICE: Saving settings 22:07:06 T:2244 NOTICE: stop all 22:07:06 T:2244 NOTICE: ES: Stopping event server 22:07:06 T:2244 NOTICE: stopping upnp 22:07:06 T:2244 NOTICE: stopping zeroconf publishing 22:07:06 T:2244 NOTICE: Webserver: Stopping... 22:07:06 T:2244 NOTICE: WebServer: Stopped the webserver 22:07:06 T:2244 NOTICE: Webserver: Stopped... 22:07:07 T:6632 NOTICE: ES: UDP Event server stopped 22:07:07 T:2244 NOTICE: stop sap announcement listener 22:07:07 T:2244 NOTICE: clean cached files! 22:07:07 T:2244 NOTICE: unload skin 22:07:07 T:2244 WARNING: CGUITextureManager::Cleanup: Having to cleanup texture button-nofocus.png 22:07:07 T:2244 WARNING: CGUITextureManager::Cleanup: Having to cleanup texture button-focus.png 22:07:07 T:2244 NOTICE: stop python 22:07:07 T:2244 NOTICE: stopped 22:07:07 T:2244 NOTICE: destroy 22:07:07 T:2244 NOTICE: closing down remote control service 22:07:07 T:2244 NOTICE: unload sections 22:07:07 T:2244 NOTICE: destroy 22:07:07 T:2244 WARNING: Attempted to remove window 10013 from the window manager when it didn't exist 22:07:07 T:2244 WARNING: Attempted to remove window 10014 from the window manager when it didn't exist 22:07:07 T:2244 WARNING: Attempted to remove window 10015 from the window manager when it didn't exist 22:07:07 T:2244 WARNING: Attempted to remove window 10016 from the window manager when it didn't exist 22:07:07 T:2244 WARNING: Attempted to remove window 10017 from the window manager when it didn't exist 22:07:07 T:2244 WARNING: Attempted to remove window 10018 from the window manager when it didn't exist 22:07:07 T:2244 WARNING: Attempted to remove window 10019 from the window manager when it didn't exist 22:07:07 T:2244 WARNING: Attempted to remove window 10021 from the window manager when it didn't exist 22:07:07 T:2244 WARNING: Attempted to remove window 10107 from the window manager when it didn't exist 22:07:07 T:2244 WARNING: Attempted to remove window 10115 from the window manager when it didn't exist 22:07:07 T:2244 WARNING: Attempted to remove window 10104 from the window manager when it didn't exist 22:07:07 T:2244 NOTICE: closing down remote control service 22:07:07 T:2244 NOTICE: unload sections 22:07:07 T:2244 NOTICE: application stopped...