Win Kodi 16.1 not playing video only "Ambilight" - Printable Version +- Kodi Community Forum (https://forum.kodi.tv) +-- Forum: Support (https://forum.kodi.tv/forumdisplay.php?fid=33) +--- Forum: Video Support (https://forum.kodi.tv/forumdisplay.php?fid=264) +--- Thread: Win Kodi 16.1 not playing video only "Ambilight" (/showthread.php?tid=301209) |
Kodi 16.1 not playing video only "Ambilight" - cherberg - 2016-12-18 Hi everyone I am using KODI on a Raspberry, Android and on a Windows Machine. With the Windows installation I now have a problem. When trying to play a video (regardless of Streaming or playing a local file) the Screen just flickers in different colours sort of like what I imagine what an Ambilight would do Please check the Video here: https://www.youtube.com/watch?v=exo4Dm8i6Ms This is a recording of what happens when I try to play movies with my Windows 16.1 Kodi Installation. It used to work fine before, I may have accidentally changed something but cannot figure out what. I have changed every available setting on Video back an forth (including Hardware Acceleration), updated the Video Drivers reinstalled the Codecs and uninstalled and reinstalled Kodi several times without any success. All search on this problem ended without success. I am close to taking the burden of reinstalling Windows but of course would like to prevent that. Please help. Logs 23:31:43 T:2460 NOTICE: special://profile/ is mapped to: special://masterprofile/ 23:31:43 T:2460 NOTICE: ----------------------------------------------------------------------- 23:31:43 T:2460 NOTICE: Starting Kodi (16.1 Git:20160424-c327c53). Platform: Windows NT x86 32-bit 23:31:43 T:2460 NOTICE: Using Release Kodi x32 build 23:31:43 T:2460 NOTICE: Kodi compiled Apr 24 2016 by MSVC 180040629 for Windows NT x86 32-bit version 6.0 (0x06000000) 23:31:43 T:2460 NOTICE: Running on MICRO-STAR INTERNATIONAL CO., LTD U90/U100 with Windows 7 SP1, kernel: Windows NT x86 32-bit version 6.1 23:31:43 T:2460 NOTICE: Host CPU: Intel® Atom CPU N270 @ 1.60GHz, 2 cores available 23:31:43 T:2460 NOTICE: Desktop Resolution: 1024x600 32Bit at 60Hz 23:31:43 T:2460 NOTICE: Running with restricted rights 23:31:43 T:2460 NOTICE: Aero is enabled 23:31:43 T:2460 NOTICE: special://xbmc/ is mapped to: C:\Program Files\Kodi 23:31:43 T:2460 NOTICE: special://xbmcbin/ is mapped to: C:\Program Files\Kodi 23:31:43 T:2460 NOTICE: special://masterprofile/ is mapped to: C:\Users\Medion\AppData\Roaming\Kodi\userdata 23:31:43 T:2460 NOTICE: special://home/ is mapped to: C:\Users\Medion\AppData\Roaming\Kodi\ 23:31:43 T:2460 NOTICE: special://temp/ is mapped to: C:\Users\Medion\AppData\Roaming\Kodi\cache 23:31:43 T:2460 NOTICE: The executable running is: C:\Program Files\Kodi\Kodi.exe 23:31:43 T:2460 NOTICE: Local hostname: Medion-PC 23:31:43 T:2460 NOTICE: Log File is located: C:\Users\Medion\AppData\Roaming\Kodi\kodi.log 23:31:43 T:2460 NOTICE: ----------------------------------------------------------------------- 23:31:43 T:2460 NOTICE: load settings... 23:31:43 T:2460 WARNING: CSettingString: unknown options filler "timezonecountries" of "locale.timezonecountry" 23:31:43 T:2460 WARNING: CSettingString: unknown options filler "timezones" of "locale.timezone" 23:31:43 T:2460 NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml) 23:31:43 T:2460 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 23:31:43 T:2460 NOTICE: Default DVD Player: dvdplayer 23:31:43 T:2460 NOTICE: Default Video Player: dvdplayer 23:31:43 T:2460 NOTICE: Default Audio Player: paplayer 23:31:43 T:2460 NOTICE: Disabled debug logging due to GUI setting. Level 0. 23:31:43 T:2460 NOTICE: Log level changed to "LOG_LEVEL_NORMAL" 23:31:43 T:2460 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml 23:31:43 T:2460 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 23:31:43 T:2460 NOTICE: Loaded playercorefactory configuration 23:31:43 T:2460 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 23:31:43 T:2460 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 23:31:45 T:2160 NOTICE: Found 2 Lists of Devices 23:31:45 T:2160 NOTICE: Enumerated DIRECTSOUND devices: 23:31:45 T:2160 NOTICE: Device 1 23:31:45 T:2160 NOTICE: m_deviceName : {5FE76B71-BC1D-4461-BEE9-D36FAED91359} 23:31:45 T:2160 NOTICE: m_displayName : Speakers - Lautsprecher (High Definition Audio-Gerät) 23:31:45 T:2160 NOTICE: m_displayNameExtra: DIRECTSOUND: Lautsprecher (High Definition Audio-Gerät) 23:31:45 T:2160 NOTICE: m_deviceType : AE_DEVTYPE_PCM 23:31:45 T:2160 NOTICE: m_channels : FL,FR 23:31:45 T:2160 NOTICE: m_sampleRates : 44100 23:31:45 T:2160 NOTICE: m_dataFormats : AE_FMT_FLOAT 23:31:45 T:2160 NOTICE: Device 2 23:31:45 T:2160 NOTICE: m_deviceName : default 23:31:45 T:2160 NOTICE: m_displayName : default 23:31:45 T:2160 NOTICE: m_displayNameExtra: 23:31:45 T:2160 NOTICE: m_deviceType : AE_DEVTYPE_PCM 23:31:45 T:2160 NOTICE: m_channels : FL,FR 23:31:45 T:2160 NOTICE: m_sampleRates : 44100 23:31:45 T:2160 NOTICE: m_dataFormats : AE_FMT_FLOAT 23:31:45 T:2160 NOTICE: Enumerated WASAPI devices: 23:31:45 T:2160 NOTICE: Device 1 23:31:45 T:2160 NOTICE: m_deviceName : {5FE76B71-BC1D-4461-BEE9-D36FAED91359} 23:31:45 T:2160 NOTICE: m_displayName : Speakers - Lautsprecher (High Definition Audio-Gerät) 23:31:45 T:2160 NOTICE: m_displayNameExtra: WASAPI: Lautsprecher (High Definition Audio-Gerät) 23:31:45 T:2160 NOTICE: m_deviceType : AE_DEVTYPE_PCM 23:31:45 T:2160 NOTICE: m_channels : FL,FR 23:31:45 T:2160 NOTICE: m_sampleRates : 192000,96000,48000,44100 23:31:45 T:2160 NOTICE: m_dataFormats : AE_FMT_S24NE4MSB,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_S16BE 23:31:45 T:2160 NOTICE: Device 2 23:31:45 T:2160 NOTICE: m_deviceName : default 23:31:45 T:2160 NOTICE: m_displayName : default 23:31:45 T:2160 NOTICE: m_displayNameExtra: 23:31:45 T:2160 NOTICE: m_deviceType : AE_DEVTYPE_PCM 23:31:45 T:2160 NOTICE: m_channels : FL,FR 23:31:45 T:2160 NOTICE: m_sampleRates : 192000,96000,48000,44100 23:31:45 T:2160 NOTICE: m_dataFormats : AE_FMT_S24NE4MSB,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_S16BE 23:31:45 T:2460 NOTICE: Running database version Addons20 23:31:45 T:2460 NOTICE: ADDONS: Using repository repository.xbmc.org 23:31:45 T:2460 NOTICE: Found screen: PnP-Monitor (Standard) on Mobile Intel® 945 Express Chipset Family, adapter 0. 23:31:45 T:2460 NOTICE: Primary mode: 1024x600@ 60.00 - Full Screen 23:31:45 T:2460 NOTICE: Additional mode: 320x200@ 60.00 - Full Screen 23:31:45 T:2460 NOTICE: Previous line repeats 1 times. 23:31:45 T:2460 NOTICE: Additional mode: 320x240@ 60.00 - Full Screen 23:31:45 T:2460 NOTICE: Previous line repeats 1 times. 23:31:45 T:2460 NOTICE: Additional mode: 400x300@ 60.00 - Full Screen 23:31:45 T:2460 NOTICE: Previous line repeats 1 times. 23:31:45 T:2460 NOTICE: Additional mode: 512x384@ 60.00 - Full Screen 23:31:45 T:2460 NOTICE: Previous line repeats 1 times. 23:31:45 T:2460 NOTICE: Additional mode: 640x400@ 60.00 - Full Screen 23:31:45 T:2460 NOTICE: Previous line repeats 1 times. 23:31:45 T:2460 NOTICE: Additional mode: 640x480@ 60.00 - Full Screen 23:31:45 T:2460 NOTICE: Previous line repeats 1 times. 23:31:45 T:2460 NOTICE: Additional mode: 800x600@ 60.00 - Full Screen 23:31:45 T:2460 NOTICE: Previous line repeats 1 times. 23:31:45 T:2460 NOTICE: Additional mode: 1024x600@ 60.00 - Full Screen 23:31:45 T:2460 NOTICE: Checking resolution 16 23:31:47 T:2460 NOTICE: Running database version Addons20 23:31:47 T:2460 NOTICE: Running database version ViewModes6 23:31:47 T:2460 NOTICE: Running database version Textures13 23:31:47 T:2460 NOTICE: Running database version MyMusic56 23:31:47 T:2460 NOTICE: Running database version MyVideos99 23:31:47 T:2460 NOTICE: Running database version TV29 23:31:47 T:2460 NOTICE: Running database version Epg11 23:31:48 T:2460 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 23:31:48 T:2460 NOTICE: ActiveAE DSP - starting 23:31:48 T:2460 NOTICE: initialize done 23:31:48 T:2460 NOTICE: Running the application... 23:31:49 T:2460 NOTICE: starting upnp client 23:31:49 T:3336 NOTICE: ES: Starting UDP Event server on 127.0.0.1:9777 23:31:49 T:3336 NOTICE: UDP: Listening on port 9777 23:32:06 T:2460 ERROR: XFILE::CDirectory::GetDirectory - Error getting C:\Users\Medion\AppData\Roaming\Kodi\media\Fonts\ 23:32:06 T:2460 ERROR: XFILE::CDirectory::GetDirectory - Error getting special://home/media/Fonts/ 23:32:06 T:2460 ERROR: XFILE::CDirectory::GetDirectory - Error getting C:\Users\Medion\AppData\Roaming\Kodi\media\Fonts\ 23:32:06 T:2460 ERROR: XFILE::CDirectory::GetDirectory - Error getting special://home/media/Fonts/ 23:32:25 T:2804 WARNING: CWin32DirectSound::GetSpace - buffer underrun - W:2688, P:50000, O:63456. 23:32:33 T:2460 ERROR: Unable to activate the previous window 23:32:39 T:2460 NOTICE: DVDPlayer: Opening: C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi 23:32:39 T:2460 WARNING: CDVDMessageQueue(player):ut MSGQ_NOT_INITIALIZED 23:32:39 T:952 NOTICE: Creating InputStream 23:32:39 T:952 NOTICE: Creating Demuxer 23:32:40 T:952 NOTICE: Opening stream: 0 source: 256 23:32:40 T:952 NOTICE: Creating video codec with codec id: 13 23:32:40 T:952 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-4 part 2 23:32:40 T:952 NOTICE: Creating video thread 23:32:40 T:952 NOTICE: Opening stream: 1 source: 256 23:32:40 T:952 NOTICE: Finding audio codec for: 86019 23:32:40 T:1392 NOTICE: running thread: video_thread 23:32:40 T:952 NOTICE: Creating audio thread 23:32:40 T:1392 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-4 part 2 23:32:40 T:3972 NOTICE: running thread: CDVDPlayerAudio:rocess() 23:32:40 T:3972 NOTICE: Creating audio stream (codec id: 86019, channels: 6, sample rate: 48000, no pass-through) 23:32:40 T:1392 NOTICE: fps: 25.000000, pwidth: 576, pheight: 432, dwidth: 576, dheight: 432 23:32:40 T:1392 NOTICE: Display resolution DESKTOP : 1024x600@ 60.00 - Full Screen (16) 23:32:40 T:3972 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 32 23:32:47 T:2460 NOTICE: Previous line repeats 4 times. 23:32:47 T:2460 NOTICE: CDVDPlayer::CloseFile() 23:32:47 T:2460 NOTICE: DVDPlayer: waiting for threads to exit 23:32:47 T:952 NOTICE: CDVDPlayer::OnExit() 23:32:47 T:952 NOTICE: Closing stream player 1 23:32:47 T:952 NOTICE: Waiting for audio thread to exit 23:32:47 T:3972 NOTICE: thread end: CDVDPlayerAudio::OnExit() 23:32:47 T:952 NOTICE: Closing audio device 23:32:47 T:952 NOTICE: Deleting audio codec 23:32:47 T:952 NOTICE: Closing stream player 2 23:32:47 T:952 NOTICE: waiting for video thread to exit 23:32:47 T:1392 NOTICE: thread end: video_thread 23:32:47 T:952 NOTICE: deleting video codec 23:32:47 T:2460 NOTICE: DVDPlayer: finished waiting 23:32:47 T:2460 NOTICE: CDVDPlayer::CloseFile() 23:32:47 T:2460 NOTICE: DVDPlayer: waiting for threads to exit 23:32:47 T:2460 NOTICE: DVDPlayer: finished waiting 23:32:47 T:2460 NOTICE: CDVDPlayer::CloseFile() 23:32:47 T:2460 NOTICE: DVDPlayer: waiting for threads to exit 23:32:47 T:2460 NOTICE: DVDPlayer: finished waiting 23:34:10 T:2460 ERROR: XFILE::CDirectory::GetDirectory - Error getting C:\Users\Medion\AppData\Roaming\Kodi\media\Fonts\ 23:34:10 T:2460 ERROR: XFILE::CDirectory::GetDirectory - Error getting special://home/media/Fonts/ 23:34:10 T:2460 ERROR: XFILE::CDirectory::GetDirectory - Error getting C:\Users\Medion\AppData\Roaming\Kodi\media\Fonts\ 23:34:10 T:2460 ERROR: XFILE::CDirectory::GetDirectory - Error getting special://home/media/Fonts/ 23:34:27 T:2460 ERROR: XFILE::CDirectory::GetDirectory - Error getting C:\Users\Medion\AppData\Roaming\Kodi\media\Fonts\ 23:34:27 T:2460 ERROR: XFILE::CDirectory::GetDirectory - Error getting special://home/media/Fonts/ 23:34:27 T:2460 ERROR: XFILE::CDirectory::GetDirectory - Error getting C:\Users\Medion\AppData\Roaming\Kodi\media\Fonts\ 23:34:27 T:2460 ERROR: XFILE::CDirectory::GetDirectory - Error getting special://home/media/Fonts/ 23:39:49 T:2460 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 23:39:49 T:2460 NOTICE: Enabled debug logging due to GUI setting. Level 2. 23:39:49 T:2460 DEBUG: ------ Window Init () ------ 23:39:54 T:2460 DEBUG: ------ Window Deinit (Pointer.xml) ------ 23:40:11 T:2460 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 23:40:11 T:2460 DEBUG: CInputManager::OnKey: escape (0xf01b) pressed, action is PreviousMenu 23:40:11 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Deactivate 23:40:11 T:2460 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------ 23:40:11 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Activate new 23:40:11 T:2460 DEBUG: ------ Window Init (Settings.xml) ------ 23:40:11 T:3656 DEBUG: Thread JobWorker start, auto delete: true 23:40:11 T:3656 DEBUG: CImageLoader:oWork - took 115 ms to load special://skin/backgrounds/settings.jpg 23:40:11 T:2460 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/ImageLib.dll) 23:40:11 T:2460 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 23:40:11 T:2460 DEBUG: CInputManager::OnKey: escape (0xf01b) pressed, action is PreviousMenu 23:40:11 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Deactivate 23:40:12 T:2460 DEBUG: ------ Window Deinit (Settings.xml) ------ 23:40:12 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Activate new 23:40:12 T:2460 DEBUG: ------ Window Init (Home.xml) ------ 23:40:13 T:2460 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 23:40:13 T:2460 DEBUG: CInputManager::OnKey: left (0xf082) pressed, action is Left 23:40:13 T:2460 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 23:40:13 T:2460 DEBUG: CInputManager::OnKey: left (0xf082) pressed, action is Left 23:40:14 T:2460 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 23:40:14 T:2460 DEBUG: CInputManager::OnKey: left (0xf082) pressed, action is Left 23:40:14 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:40:14 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:40:15 T:2460 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 23:40:15 T:2460 DEBUG: CInputManager::OnKey: return (0xf00d) pressed, action is Select 23:40:15 T:2460 DEBUG: Activating window ID: 10025 23:40:15 T:2460 DEBUG: ------ Window Deinit (Home.xml) ------ 23:40:15 T:2460 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 23:40:15 T:2460 DEBUG: CGUIMediaWindow::GetDirectory (C:\Videos\Family Guy\Season 8\) 23:40:15 T:2460 DEBUG: ParentPath = [C:\Videos\Family Guy\Season 8\] 23:40:15 T:2460 DEBUG: CVideoDatabase::RunQuery took 1 ms for 10 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=5 23:40:15 T:2604 DEBUG: Thread BackgroundLoader start, auto delete: false 23:40:16 T:2604 DEBUG: Thread BackgroundLoader 2604 terminating 23:40:17 T:2460 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 23:40:17 T:2460 DEBUG: CInputManager::OnKey: return (0xf00d) pressed, action is Select 23:40:17 T:2460 DEBUG: CGUIWindowVideoBase::OnPlayMedia C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi 23:40:17 T:2460 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 23:40:17 T:2460 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 23:40:17 T:2460 DEBUG: CVideoDatabase::GetMovieId (C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi), query = select idMovie from movie where idFile=4 23:40:17 T:2460 DEBUG: CVideoDatabase::GetEpisodeId (C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi), query = select idEpisode from episode where idFile=4 23:40:17 T:2460 DEBUG: CVideoDatabase::GetMusicVideoId (C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi), query = select idMVideo from musicvideo where idFile=4 23:40:17 T:2460 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 23:40:17 T:2460 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 23:40:17 T:2460 DEBUG: Loading settings for C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi 23:40:17 T:2460 DEBUG: CPlayerCoreFactory::GetPlayers(C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi) 23:40:17 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 23:40:17 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 23:40:17 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 23:40:17 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 23:40:17 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 23:40:17 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 23:40:17 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 23:40:17 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 23:40:17 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 23:40:17 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 23:40:17 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 23:40:17 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 23:40:17 T:2460 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 23:40:17 T:2460 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1) 23:40:17 T:2460 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 23:40:17 T:2460 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 23:40:17 T:2460 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1) 23:40:17 T:2460 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 23:40:17 T:2460 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData::CDVDRadioRDSData 23:40:17 T:2460 NOTICE: DVDPlayer: Opening: C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi 23:40:17 T:2460 WARNING: CDVDMessageQueue(player):ut MSGQ_NOT_INITIALIZED 23:40:17 T:2460 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec 23:40:17 T:2480 DEBUG: Thread DVDPlayer start, auto delete: false 23:40:17 T:2480 NOTICE: Creating InputStream 23:40:17 T:2480 DEBUG: CUtil::ScanForExternalSubtitles: Searching for subtitles... 23:40:17 T:2480 DEBUG: CUtil::ScanForExternalSubtitles: END (total time: 2 ms) 23:40:17 T:2480 NOTICE: Creating Demuxer 23:40:17 T:2480 DEBUG: CDVDDemuxFFmpeg::Open - probing detected format [avi] 23:40:17 T:2480 DEBUG: CDVDDemuxFFmpeg::Open - avformat_find_stream_info starting 23:40:17 T:2480 DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished 23:40:17 T:2480 INFO: ffmpeg[9B0]: Input #0, avi, C:\Videos\Family Guy\Season 8\Family Guy S08E12.av': 23:40:17 T:2480 INFO: ffmpeg[9B0]: Metadata: 23:40:17 T:2480 INFO: ffmpeg[9B0]: encoder : VirtualDubMod 1.5.10.2 (build 2540/release) 23:40:17 T:2480 INFO: ffmpeg[9B0]: Duration: 00:23:06.20, start: 0.000000, bitrate: 1062 kb/s 23:40:17 T:2480 INFO: ffmpeg[9B0]: Stream #0:0: Video: mpeg4 (Advanced Simple Profile) (XVID / 0x44495658), yuv420p, 576x432 [SAR 1:1 DAR 4:3], 604 kb/s, 25 fps, 25 tbr, 25 tbn, 25 tbc 23:40:17 T:2480 INFO: ffmpeg[9B0]: Stream #0:1: Audio: ac3 ([0] [0][0] / 0x2000), 48000 Hz, 5.1(side), fltp, 448 kb/s 23:40:17 T:2480 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 23:40:17 T:2480 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 23:40:17 T:2480 NOTICE: Opening stream: 0 source: 256 23:40:17 T:2480 NOTICE: Creating video codec with codec id: 13 23:40:17 T:2480 DEBUG: CDVDFactoryCodec: compiled in hardware support: AMCodec:no MediaCodec:no DXVA:yes iMXVPU:no MMAL:no 23:40:17 T:2480 DEBUG: FactoryCodec - Video: - Opening 23:40:17 T:2480 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-4 part 2 23:40:17 T:2480 DEBUG: FactoryCodec - Video: ff-mpeg4 - Opened 23:40:17 T:2480 NOTICE: Creating video thread 23:40:17 T:2480 NOTICE: Opening stream: 1 source: 256 23:40:17 T:2480 NOTICE: Finding audio codec for: 86019 23:40:17 T:2480 DEBUG: FactoryCodec - Audio: passthrough - Opening 23:40:17 T:2480 DEBUG: FactoryCodec - Audio: passthrough - Failed 23:40:17 T:2480 DEBUG: FactoryCodec - Audio: FFmpeg - Opening 23:40:17 T:3956 DEBUG: Thread DVDPlayerVideo start, auto delete: false 23:40:17 T:3956 NOTICE: running thread: video_thread 23:40:17 T:2480 DEBUG: FactoryCodec - Audio: FFmpeg - Opened 23:40:17 T:2480 NOTICE: Creating audio thread 23:40:17 T:3956 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 23:40:17 T:2480 DEBUG: CEdl::ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi 23:40:17 T:2480 DEBUG: CApplication::OnPlayBackStarted: play state was 1, starting 1 23:40:17 T:2480 DEBUG: CDVDPlayer::SetCaching - caching state 3 23:40:17 T:3088 DEBUG: Thread DVDPlayerAudio start, auto delete: false 23:40:17 T:3088 NOTICE: running thread: CDVDPlayerAudio:rocess() 23:40:17 T:3088 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 23:40:17 T:3088 NOTICE: Creating audio stream (codec id: 86019, channels: 6, sample rate: 48000, no pass-through) 23:40:17 T:3088 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback 23:40:17 T:3956 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 23:40:17 T:3956 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-4 part 2 23:40:17 T:3956 DEBUG: CDVDVideoCodecFFmpeg - open frame threaded with 2 threads 23:40:17 T:2804 INFO: CActiveAESink::OpenSink - initialize sink 23:40:17 T:2804 DEBUG: CAESinkDirectSound:einitialize: Cleaning up 23:40:17 T:3956 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(40000.000000, 0) 23:40:17 T:2460 DEBUG: CApplication:layFile: OpenFile succeed, play state 2 23:40:17 T:2460 DEBUG: CApplication::OnPlayBackStarted: play state was 2, starting 0 23:40:18 T:1920 INFO: ffmpeg[780]: [mpeg4] Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it. 23:40:18 T:3956 DEBUG: ffmpeg[F74]: [src] w:576 h:432 pixfmt:yuv420p tb:1/25 fr:0/1 sar:1/1 sws_param: 23:40:18 T:3956 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 23:40:18 T:3956 DEBUG: Previous line repeats 1 times. 23:40:18 T:3956 NOTICE: fps: 25.000000, pwidth: 576, pheight: 432, dwidth: 576, dheight: 432 23:40:18 T:3956 DEBUG: CDVDPlayerVideo::OutputPicture - change configuration. 576x432. framerate: 25.00. format: YV12 23:40:18 T:3956 NOTICE: Display resolution DESKTOP : 1024x600@ 60.00 - Full Screen (16) 23:40:18 T:3956 DEBUG: CWinRenderer::SelectRenderMethod: Requested render method: 0 23:40:18 T:3956 DEBUG: CWinRenderer::SelectRenderMethod: Selected render method 1: Pixel Shaders 23:40:18 T:3956 DEBUG: CXBMCRenderManager::Configure - 3 23:40:18 T:2460 DEBUG: created video buffer 0 23:40:18 T:2460 DEBUG: created video buffer 1 23:40:18 T:2460 DEBUG: created video buffer 2 23:40:18 T:3956 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 23:40:18 T:2480 DEBUG: CDVDPlayer::HandleMessages - player started 2 23:40:18 T:2460 DEBUG: CGUIInfoManager::SetCurrentMovie(C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi) 23:40:18 T:2460 DEBUG: CVideoDatabase::GetMovieId (C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi), query = select idMovie from movie where idFile=4 23:40:18 T:2460 DEBUG: CVideoDatabase::GetEpisodeId (C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi), query = select idEpisode from episode where idFile=4 23:40:18 T:2460 DEBUG: CVideoDatabase::GetMusicVideoId (C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi), query = select idMVideo from musicvideo where idFile=4 23:40:18 T:2460 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 23:40:18 T:2460 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 23:40:18 T:2460 DEBUG: Activating window ID: 12005 23:40:18 T:2460 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 23:40:18 T:2460 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 23:40:18 T:2460 DEBUG: CWinShader::LoadEffect - loading shader special://xbmc/system/shaders/yuv2rgb_d3d.fx 23:40:18 T:2804 DEBUG: CActiveAESink::OpenSink - trying to open device DIRECTSOUND:default 23:40:18 T:2804 DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 000E0196 23:40:18 T:2804 DEBUG: CAESinkDirectSound::Initialize: secondary buffer created 23:40:18 T:2804 DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters: 23:40:18 T:2804 DEBUG: Audio Device : Lautsprecher (High Definition Audio-Gerät) 23:40:18 T:2804 DEBUG: Sample Rate : 48000 23:40:18 T:2804 DEBUG: Sample Format : AE_FMT_FLOAT 23:40:18 T:2804 DEBUG: Bits Per Sample : 32 23:40:18 T:2804 DEBUG: Valid Bits/Samp : 32 23:40:18 T:2804 DEBUG: Channel Count : 2 23:40:18 T:2804 DEBUG: Block Align : 8 23:40:18 T:2804 DEBUG: Avg. Bytes Sec : 384000 23:40:18 T:2804 DEBUG: Samples/Block : 32 23:40:18 T:2804 DEBUG: Format cBSize : 22 23:40:18 T:2804 DEBUG: Channel Layout : FL,FR 23:40:18 T:2804 DEBUG: Channel Mask : 3 23:40:18 T:2804 DEBUG: Frames : 720 23:40:18 T:2804 DEBUG: Frame Samples : 1440 23:40:18 T:2804 DEBUG: Frame Size : 8 23:40:18 T:2804 DEBUG: CActiveAESink::OpenSink - DIRECTSOUND Initialized: 23:40:18 T:2804 DEBUG: Output Device : default 23:40:18 T:2804 DEBUG: Sample Rate : 48000 23:40:18 T:2804 DEBUG: Sample Format : AE_FMT_FLOAT 23:40:18 T:2804 DEBUG: Channel Count : 2 23:40:18 T:2804 DEBUG: Channel Layout: FL,FR 23:40:18 T:2804 DEBUG: Frames : 720 23:40:18 T:2804 DEBUG: Frame Samples : 1440 23:40:18 T:2804 DEBUG: Frame Size : 8 23:40:18 T:2160 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 23:40:18 T:2480 DEBUG: Previous line repeats 1 times. 23:40:18 T:2480 DEBUG: CDVDPlayer::HandleMessages - player started 1 23:40:18 T:2480 DEBUG: CDVDPlayer::SetCaching - caching state 0 23:40:18 T:3956 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 23:40:18 T:3088 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(32000.000000, 1) 23:40:18 T:3956 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 23:40:18 T:2804 DEBUG: Previous line repeats 3 times. 23:40:18 T:2804 DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback 23:40:18 T:3088 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 32 23:40:18 T:3088 NOTICE: Previous line repeats 4 times. 23:40:18 T:3088 DEBUG: CDVDPlayerAudio::HandleSyncError - average error -16256.402179 below threshold of 50000.000000 23:40:18 T:3088 DEBUG: CDVDClock:iscontinuity - CDVDPlayerAudio::HandleSyncError2 - was:204817.319665, should be:188563.477422, error:-16253.842243 23:40:25 T:3956 DEBUG: CPullupCorrection: detected pattern of length 1: 40000.00, frameduration: 40000.000000 23:40:26 T:2460 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 23:40:26 T:2460 DEBUG: CInputManager::OnKey: escape (0xf01b) pressed, action is Fullscreen 23:40:26 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Deactivate 23:40:26 T:2460 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 23:40:26 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Activate new 23:40:26 T:2460 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 23:40:26 T:2460 DEBUG: CGUIMediaWindow::GetDirectory (C:\Videos\Family Guy\Season 8\) 23:40:26 T:2460 DEBUG: ParentPath = [C:\Videos\Family Guy\Season 8\] 23:40:26 T:2460 DEBUG: CVideoDatabase::RunQuery took 1 ms for 10 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=5 23:40:26 T:3956 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 23:40:26 T:3244 DEBUG: Previous line repeats 1 times. 23:40:26 T:3244 DEBUG: Thread BackgroundLoader start, auto delete: false 23:40:27 T:3956 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 23:40:27 T:3244 DEBUG: Previous line repeats 8 times. 23:40:27 T:3244 DEBUG: Thread BackgroundLoader 3244 terminating 23:40:27 T:3956 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 23:40:28 T:2460 DEBUG: Previous line repeats 5 times. 23:40:28 T:2460 DEBUG: ------ Window Init (Pointer.xml) ------ 23:40:29 T:3956 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 23:40:29 T:2460 DEBUG: Previous line repeats 1 times. 23:40:29 T:2460 DEBUG: CInputManager:rocessMouse: trying mouse action leftclick 23:40:29 T:2460 DEBUG: Activating window ID: 12005 23:40:29 T:2460 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 23:40:29 T:2460 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 23:40:30 T:2460 DEBUG: ------ Window Init (VideoOSD.xml) ------ 23:40:31 T:3956 DEBUG: CPullupCorrection: detected pattern of length 1: 40000.00, frameduration: 40000.000000 23:40:32 T:2460 DEBUG: CInputManager:rocessMouse: trying mouse action leftclick 23:40:32 T:2460 NOTICE: CDVDPlayer::CloseFile() 23:40:32 T:2460 NOTICE: DVDPlayer: waiting for threads to exit 23:40:32 T:2480 NOTICE: CDVDPlayer::OnExit() 23:40:32 T:2480 NOTICE: Closing stream player 1 23:40:32 T:2480 NOTICE: Waiting for audio thread to exit 23:40:32 T:3088 NOTICE: thread end: CDVDPlayerAudio::OnExit() 23:40:32 T:3088 DEBUG: Thread DVDPlayerAudio 3088 terminating 23:40:32 T:2480 NOTICE: Closing audio device 23:40:32 T:2480 NOTICE: Deleting audio codec 23:40:32 T:2480 NOTICE: Closing stream player 2 23:40:32 T:2480 NOTICE: waiting for video thread to exit 23:40:32 T:2160 DEBUG: CActiveAE:iscardStream - audio stream deleted 23:40:32 T:2160 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 23:40:32 T:2804 DEBUG: Previous line repeats 1 times. 23:40:32 T:2804 INFO: CActiveAESink::OpenSink - initialize sink 23:40:32 T:2804 DEBUG: CAESinkDirectSound:einitialize: Cleaning up 23:40:32 T:3956 NOTICE: thread end: video_thread 23:40:32 T:3956 DEBUG: Thread DVDPlayerVideo 3956 terminating 23:40:32 T:2480 NOTICE: deleting video codec 23:40:32 T:2480 DEBUG: CApplication::OnPlayBackStopped: play state was 2, starting 0 23:40:32 T:2480 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 23:40:32 T:2480 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 23:40:32 T:2460 NOTICE: DVDPlayer: finished waiting 23:40:32 T:2480 DEBUG: Thread DVDPlayer 2480 terminating 23:40:32 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Deactivate 23:40:32 T:2460 DEBUG: ------ Window Deinit (VideoOSD.xml) ------ 23:40:32 T:2460 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 23:40:32 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Activate new 23:40:32 T:2460 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 23:40:32 T:2460 DEBUG: CGUIMediaWindow::GetDirectory (C:\Videos\Family Guy\Season 8\) 23:40:32 T:2460 DEBUG: ParentPath = [C:\Videos\Family Guy\Season 8\] 23:40:32 T:2460 DEBUG: CVideoDatabase::RunQuery took 1 ms for 10 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=5 23:40:32 T:2460 NOTICE: CDVDPlayer::CloseFile() 23:40:32 T:2460 NOTICE: DVDPlayer: waiting for threads to exit 23:40:32 T:2460 NOTICE: DVDPlayer: finished waiting 23:40:32 T:2460 NOTICE: CDVDPlayer::CloseFile() 23:40:32 T:2460 NOTICE: DVDPlayer: waiting for threads to exit 23:40:32 T:2460 NOTICE: DVDPlayer: finished waiting 23:40:32 T:2460 DEBUG: Radio UECP (RDS) Processor - delete CDVDRadioRDSData::~CDVDRadioRDSData 23:40:32 T:2804 DEBUG: CActiveAESink::OpenSink - trying to open device DIRECTSOUND:default 23:40:32 T:2188 DEBUG: Thread BackgroundLoader start, auto delete: false 23:40:32 T:2804 DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 000E0196 23:40:32 T:2804 DEBUG: CAESinkDirectSound::Initialize: secondary buffer created 23:40:32 T:2804 DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters: 23:40:32 T:2804 DEBUG: Audio Device : Lautsprecher (High Definition Audio-Gerät) 23:40:32 T:2804 DEBUG: Sample Rate : 44100 23:40:32 T:2804 DEBUG: Sample Format : AE_FMT_FLOAT 23:40:32 T:2804 DEBUG: Bits Per Sample : 32 23:40:32 T:2804 DEBUG: Valid Bits/Samp : 32 23:40:32 T:2804 DEBUG: Channel Count : 2 23:40:32 T:2804 DEBUG: Block Align : 8 23:40:32 T:2804 DEBUG: Avg. Bytes Sec : 352800 23:40:32 T:2804 DEBUG: Samples/Block : 32 23:40:32 T:2804 DEBUG: Format cBSize : 22 23:40:32 T:2804 DEBUG: Channel Layout : FL,FR 23:40:32 T:2804 DEBUG: Channel Mask : 3 23:40:32 T:2804 DEBUG: Frames : 661 23:40:32 T:2804 DEBUG: Frame Samples : 1322 23:40:32 T:2804 DEBUG: Frame Size : 8 23:40:32 T:2804 DEBUG: CActiveAESink::OpenSink - DIRECTSOUND Initialized: 23:40:32 T:2804 DEBUG: Output Device : default 23:40:32 T:2804 DEBUG: Sample Rate : 44100 23:40:32 T:2804 DEBUG: Sample Format : AE_FMT_FLOAT 23:40:32 T:2804 DEBUG: Channel Count : 2 23:40:32 T:2804 DEBUG: Channel Layout: FL,FR 23:40:32 T:2804 DEBUG: Frames : 661 23:40:32 T:2804 DEBUG: Frame Samples : 1322 23:40:32 T:2804 DEBUG: Frame Size : 8 23:40:32 T:2160 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 23:40:32 T:2188 DEBUG: Thread BackgroundLoader 2188 terminating 23:40:32 T:3656 DEBUG: CSaveFileStateJob:oWork - Saving file state for video item C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi 23:40:32 T:2804 DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback 23:40:37 T:2460 DEBUG: ------ Window Deinit (Pointer.xml) ------ 23:41:02 T:3656 DEBUG: Thread JobWorker 3656 terminating (autodelete) 23:41:15 T:2460 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 23:41:15 T:2460 DEBUG: CInputManager::OnKey: escape (0xf01b) pressed, action is PreviousMenu 23:41:15 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Deactivate 23:41:16 T:2460 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 23:41:16 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Activate new 23:41:16 T:2460 DEBUG: ------ Window Init (Home.xml) ------ 23:41:16 T:2460 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 23:41:16 T:2460 DEBUG: CInputManager::OnKey: escape (0xf01b) pressed, action is PreviousMenu 23:41:16 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Deactivate 23:41:17 T:2460 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 23:41:17 T:2460 DEBUG: CInputManager::OnKey: right (0xf083) pressed, action is Right 23:41:17 T:2460 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 23:41:17 T:2460 DEBUG: CInputManager::OnKey: right (0xf083) pressed, action is Right 23:41:18 T:2460 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 23:41:18 T:2460 DEBUG: CInputManager::OnKey: right (0xf083) pressed, action is Right 23:41:18 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:41:18 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:41:20 T:2460 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 23:41:20 T:2460 DEBUG: CInputManager::OnKey: return (0xf00d) pressed, action is Select 23:41:20 T:2460 DEBUG: Activating window ID: 10004 23:41:20 T:2460 DEBUG: ------ Window Deinit (Home.xml) ------ 23:41:20 T:2460 DEBUG: ------ Window Init (Settings.xml) ------ 23:41:20 T:2192 DEBUG: Thread JobWorker start, auto delete: true 23:41:21 T:2460 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 23:41:22 T:2460 DEBUG: CInputManager::OnKey: return (0xf00d) pressed, action is Select 23:41:22 T:2460 DEBUG: Activating window ID: 10016 23:41:22 T:2460 DEBUG: ------ Window Deinit (Settings.xml) ------ 23:41:22 T:2460 DEBUG: ------ Window Init (SettingsCategory.xml) ------ 23:41:25 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:41:25 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:41:25 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:41:25 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:41:25 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:41:25 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:41:25 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:41:25 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:41:26 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:41:26 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:41:27 T:2460 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 23:41:27 T:2460 DEBUG: CInputManager::OnKey: right (0xf083) pressed, action is Right 23:41:28 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:41:28 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:41:28 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:41:28 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:41:28 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:41:28 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:41:29 T:2460 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 23:41:29 T:2460 DEBUG: CInputManager::OnKey: return (0xf00d) pressed, action is Select 23:41:29 T:2460 NOTICE: Disabled debug logging due to GUI setting. Level 0. 23:41:29 T:2460 NOTICE: Log level changed to "LOG_LEVEL_NORMAL" 23:41:30 T:2460 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 23:41:30 T:2460 NOTICE: Enabled debug logging due to GUI setting. Level 2. 23:41:30 T:2460 DEBUG: ------ Window Init () ------ 23:41:33 T:2460 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 23:41:33 T:2460 DEBUG: CInputManager::OnKey: return (0xf00d) pressed, action is Select 23:41:33 T:2460 NOTICE: Disabled debug logging due to GUI setting. Level 0. 23:41:33 T:2460 NOTICE: Log level changed to "LOG_LEVEL_NORMAL" 23:44:42 T:2460 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 23:44:42 T:2460 NOTICE: Enabled debug logging due to GUI setting. Level 2. 23:44:42 T:2460 DEBUG: ------ Window Init () ------ 23:44:44 T:2460 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 23:44:44 T:2460 DEBUG: CInputManager::OnKey: escape (0xf01b) pressed, action is PreviousMenu 23:44:44 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Deactivate 23:44:44 T:2460 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------ 23:44:44 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Activate new 23:44:44 T:2460 DEBUG: ------ Window Init (Settings.xml) ------ 23:44:44 T:1216 DEBUG: Thread JobWorker start, auto delete: true 23:44:45 T:2460 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 23:44:45 T:2460 DEBUG: CInputManager::OnKey: escape (0xf01b) pressed, action is PreviousMenu 23:44:45 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Deactivate 23:44:45 T:2460 DEBUG: ------ Window Deinit (Settings.xml) ------ 23:44:45 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Activate new 23:44:45 T:2460 DEBUG: ------ Window Init (Home.xml) ------ 23:44:46 T:2460 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 23:44:46 T:2460 DEBUG: CInputManager::OnKey: escape (0xf01b) pressed, action is PreviousMenu 23:44:46 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Deactivate 23:44:47 T:2460 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 23:44:47 T:2460 DEBUG: CInputManager::OnKey: left (0xf082) pressed, action is Left 23:44:47 T:2460 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 23:44:47 T:2460 DEBUG: CInputManager::OnKey: left (0xf082) pressed, action is Left 23:44:48 T:2460 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 23:44:48 T:2460 DEBUG: CInputManager::OnKey: left (0xf082) pressed, action is Left 23:44:48 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:44:48 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:44:50 T:2460 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 23:44:50 T:2460 DEBUG: CInputManager::OnKey: return (0xf00d) pressed, action is Select 23:44:50 T:2460 DEBUG: Activating window ID: 10025 23:44:50 T:2460 DEBUG: ------ Window Deinit (Home.xml) ------ 23:44:50 T:2460 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 23:44:50 T:2460 DEBUG: CGUIMediaWindow::GetDirectory (C:\Videos\Family Guy\Season 8\) 23:44:50 T:2460 DEBUG: ParentPath = [C:\Videos\Family Guy\Season 8\] 23:44:50 T:2460 DEBUG: CVideoDatabase::RunQuery took 1 ms for 10 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=5 23:44:50 T:2496 DEBUG: Thread BackgroundLoader start, auto delete: false 23:44:50 T:2496 DEBUG: Thread BackgroundLoader 2496 terminating 23:44:51 T:2460 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 23:44:51 T:2460 DEBUG: CInputManager::OnKey: return (0xf00d) pressed, action is Select 23:44:51 T:2460 DEBUG: CGUIWindowVideoBase::OnPlayMedia C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi 23:44:51 T:2460 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 23:44:51 T:2460 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 23:44:51 T:2460 DEBUG: CVideoDatabase::GetMovieId (C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi), query = select idMovie from movie where idFile=4 23:44:51 T:2460 DEBUG: CVideoDatabase::GetEpisodeId (C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi), query = select idEpisode from episode where idFile=4 23:44:51 T:2460 DEBUG: CVideoDatabase::GetMusicVideoId (C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi), query = select idMVideo from musicvideo where idFile=4 23:44:51 T:2460 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 23:44:51 T:2460 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 23:44:51 T:2460 DEBUG: Loading settings for C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi 23:44:51 T:2460 DEBUG: CPlayerCoreFactory::GetPlayers(C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi) 23:44:51 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 23:44:51 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 23:44:51 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 23:44:51 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 23:44:51 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 23:44:51 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 23:44:51 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 23:44:51 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 23:44:51 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 23:44:51 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 23:44:51 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 23:44:51 T:2460 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 23:44:51 T:2460 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 23:44:51 T:2460 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1) 23:44:51 T:2460 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 23:44:51 T:2460 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 23:44:51 T:2460 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1) 23:44:51 T:2460 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 23:44:51 T:2460 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData::CDVDRadioRDSData 23:44:51 T:2460 NOTICE: DVDPlayer: Opening: C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi 23:44:51 T:2460 WARNING: CDVDMessageQueue(player):ut MSGQ_NOT_INITIALIZED 23:44:51 T:2460 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec 23:44:51 T:1192 DEBUG: Thread DVDPlayer start, auto delete: false 23:44:51 T:1192 NOTICE: Creating InputStream 23:44:51 T:1192 DEBUG: CUtil::ScanForExternalSubtitles: Searching for subtitles... 23:44:51 T:1192 DEBUG: CUtil::ScanForExternalSubtitles: END (total time: 2 ms) 23:44:51 T:1192 NOTICE: Creating Demuxer 23:44:51 T:1192 DEBUG: CDVDDemuxFFmpeg::Open - probing detected format [avi] 23:44:51 T:1192 DEBUG: CDVDDemuxFFmpeg::Open - avformat_find_stream_info starting 23:44:51 T:1192 DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished 23:44:51 T:1192 INFO: ffmpeg[4A8]: Input #0, avi, C:\Videos\Family Guy\Season 8\Family Guy S08E12.av': 23:44:51 T:1192 INFO: ffmpeg[4A8]: Metadata: 23:44:51 T:1192 INFO: ffmpeg[4A8]: encoder : VirtualDubMod 1.5.10.2 (build 2540/release) 23:44:51 T:1192 INFO: ffmpeg[4A8]: Duration: 00:23:06.20, start: 0.000000, bitrate: 1062 kb/s 23:44:51 T:1192 INFO: ffmpeg[4A8]: Stream #0:0: Video: mpeg4 (Advanced Simple Profile) (XVID / 0x44495658), yuv420p, 576x432 [SAR 1:1 DAR 4:3], 604 kb/s, 25 fps, 25 tbr, 25 tbn, 25 tbc 23:44:51 T:1192 INFO: ffmpeg[4A8]: Stream #0:1: Audio: ac3 ([0] [0][0] / 0x2000), 48000 Hz, 5.1(side), fltp, 448 kb/s 23:44:51 T:1192 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 23:44:51 T:1192 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 23:44:51 T:1192 NOTICE: Opening stream: 0 source: 256 23:44:51 T:1192 NOTICE: Creating video codec with codec id: 13 23:44:51 T:1192 DEBUG: CDVDFactoryCodec: compiled in hardware support: AMCodec:no MediaCodec:no DXVA:yes iMXVPU:no MMAL:no 23:44:51 T:1192 DEBUG: FactoryCodec - Video: - Opening 23:44:51 T:1192 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-4 part 2 23:44:51 T:1192 DEBUG: FactoryCodec - Video: ff-mpeg4 - Opened 23:44:51 T:1192 NOTICE: Creating video thread 23:44:51 T:1192 NOTICE: Opening stream: 1 source: 256 23:44:51 T:1192 NOTICE: Finding audio codec for: 86019 23:44:51 T:1192 DEBUG: FactoryCodec - Audio: passthrough - Opening 23:44:51 T:1192 DEBUG: FactoryCodec - Audio: passthrough - Failed 23:44:51 T:1192 DEBUG: FactoryCodec - Audio: FFmpeg - Opening 23:44:51 T:2820 DEBUG: Thread DVDPlayerVideo start, auto delete: false 23:44:51 T:2820 NOTICE: running thread: video_thread 23:44:51 T:1192 DEBUG: FactoryCodec - Audio: FFmpeg - Opened 23:44:51 T:1192 NOTICE: Creating audio thread 23:44:51 T:2820 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 23:44:51 T:1192 DEBUG: CEdl::ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi 23:44:51 T:1192 DEBUG: CApplication::OnPlayBackStarted: play state was 1, starting 1 23:44:51 T:1192 DEBUG: CDVDPlayer::SetCaching - caching state 3 23:44:51 T:2460 DEBUG: CApplication:layFile: OpenFile succeed, play state 2 23:44:51 T:2460 DEBUG: CApplication::OnPlayBackStarted: play state was 2, starting 0 23:44:51 T:2176 DEBUG: Thread DVDPlayerAudio start, auto delete: false 23:44:51 T:2176 NOTICE: running thread: CDVDPlayerAudio:rocess() 23:44:51 T:2176 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 23:44:51 T:2176 NOTICE: Creating audio stream (codec id: 86019, channels: 6, sample rate: 48000, no pass-through) 23:44:51 T:2176 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback 23:44:51 T:2820 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 23:44:51 T:2820 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-4 part 2 23:44:51 T:2820 DEBUG: CDVDVideoCodecFFmpeg - open frame threaded with 2 threads 23:44:51 T:2804 INFO: CActiveAESink::OpenSink - initialize sink 23:44:51 T:2804 DEBUG: CAESinkDirectSound:einitialize: Cleaning up 23:44:51 T:2820 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(40000.000000, 0) 23:44:51 T:1192 DEBUG: CDVDPlayer::SetCaching - caching state 0 23:44:52 T:2820 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 23:44:52 T:2288 INFO: ffmpeg[8F0]: [mpeg4] Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it. 23:44:52 T:2820 DEBUG: ffmpeg[B04]: [src] w:576 h:432 pixfmt:yuv420p tb:1/25 fr:0/1 sar:1/1 sws_param: 23:44:52 T:2820 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 23:44:52 T:2820 DEBUG: Previous line repeats 1 times. 23:44:52 T:2820 NOTICE: fps: 25.000000, pwidth: 576, pheight: 432, dwidth: 576, dheight: 432 23:44:52 T:2820 DEBUG: CDVDPlayerVideo::OutputPicture - change configuration. 576x432. framerate: 25.00. format: YV12 23:44:52 T:2820 NOTICE: Display resolution DESKTOP : 1024x600@ 60.00 - Full Screen (16) 23:44:52 T:2820 DEBUG: CWinRenderer::SelectRenderMethod: Requested render method: 0 23:44:52 T:2820 DEBUG: CWinRenderer::SelectRenderMethod: Selected render method 1: Pixel Shaders 23:44:52 T:2820 DEBUG: CXBMCRenderManager::Configure - 3 23:44:52 T:2460 DEBUG: created video buffer 0 23:44:52 T:2460 DEBUG: created video buffer 1 23:44:52 T:2460 DEBUG: created video buffer 2 23:44:52 T:2820 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 23:44:52 T:1192 DEBUG: Previous line repeats 1 times. 23:44:52 T:1192 DEBUG: CDVDPlayer::HandleMessages - player started 2 23:44:52 T:2460 DEBUG: CGUIInfoManager::SetCurrentMovie(C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi) 23:44:52 T:2460 DEBUG: CVideoDatabase::GetMovieId (C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi), query = select idMovie from movie where idFile=4 23:44:52 T:2460 DEBUG: CVideoDatabase::GetEpisodeId (C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi), query = select idEpisode from episode where idFile=4 23:44:52 T:2460 DEBUG: CVideoDatabase::GetMusicVideoId (C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi), query = select idMVideo from musicvideo where idFile=4 23:44:52 T:2460 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 23:44:52 T:2460 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 23:44:52 T:2460 DEBUG: Activating window ID: 12005 23:44:52 T:2460 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 23:44:52 T:2460 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 23:44:52 T:2820 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 23:44:52 T:2460 DEBUG: Previous line repeats 1 times. 23:44:52 T:2460 DEBUG: CWinShader::LoadEffect - loading shader special://xbmc/system/shaders/yuv2rgb_d3d.fx 23:44:52 T:2820 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 23:44:52 T:2804 DEBUG: Previous line repeats 1 times. 23:44:52 T:2804 DEBUG: CActiveAESink::OpenSink - trying to open device DIRECTSOUND:default 23:44:52 T:2804 DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 000E0196 23:44:52 T:2804 DEBUG: CAESinkDirectSound::Initialize: secondary buffer created 23:44:52 T:2804 DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters: 23:44:52 T:2804 DEBUG: Audio Device : Lautsprecher (High Definition Audio-Gerät) 23:44:52 T:2804 DEBUG: Sample Rate : 48000 23:44:52 T:2804 DEBUG: Sample Format : AE_FMT_FLOAT 23:44:52 T:2804 DEBUG: Bits Per Sample : 32 23:44:52 T:2804 DEBUG: Valid Bits/Samp : 32 23:44:52 T:2804 DEBUG: Channel Count : 2 23:44:52 T:2804 DEBUG: Block Align : 8 23:44:52 T:2804 DEBUG: Avg. Bytes Sec : 384000 23:44:52 T:2804 DEBUG: Samples/Block : 32 23:44:52 T:2804 DEBUG: Format cBSize : 22 23:44:52 T:2804 DEBUG: Channel Layout : FL,FR 23:44:52 T:2804 DEBUG: Channel Mask : 3 23:44:52 T:2804 DEBUG: Frames : 720 23:44:52 T:2804 DEBUG: Frame Samples : 1440 23:44:52 T:2804 DEBUG: Frame Size : 8 23:44:52 T:2804 DEBUG: CActiveAESink::OpenSink - DIRECTSOUND Initialized: 23:44:52 T:2804 DEBUG: Output Device : default 23:44:52 T:2804 DEBUG: Sample Rate : 48000 23:44:52 T:2804 DEBUG: Sample Format : AE_FMT_FLOAT 23:44:52 T:2804 DEBUG: Channel Count : 2 23:44:52 T:2804 DEBUG: Channel Layout: FL,FR 23:44:52 T:2804 DEBUG: Frames : 720 23:44:52 T:2804 DEBUG: Frame Samples : 1440 23:44:52 T:2804 DEBUG: Frame Size : 8 23:44:52 T:2160 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 23:44:52 T:2176 DEBUG: Previous line repeats 1 times. 23:44:52 T:2176 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(32000.000000, 1) 23:44:52 T:1192 DEBUG: CDVDPlayer::HandleMessages - player started 1 23:44:52 T:2804 DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback 23:44:52 T:2176 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 32 23:44:52 T:2176 NOTICE: Previous line repeats 4 times. 23:44:52 T:2176 DEBUG: CDVDPlayerAudio::HandleSyncError - average error -30714.377819 below threshold of 50000.000000 23:44:52 T:2176 DEBUG: CDVDClock:iscontinuity - CDVDPlayerAudio::HandleSyncError2 - was:216336.394450, should be:185624.576567, error:-30711.817883 23:44:55 T:2460 DEBUG: ------ Window Init (Pointer.xml) ------ 23:44:55 T:2460 DEBUG: ------ Window Init (VideoOSD.xml) ------ 23:44:58 T:2820 DEBUG: CPullupCorrection: detected pattern of length 1: 40000.00, frameduration: 40000.000000 23:44:59 T:2460 DEBUG: CInputManager:rocessMouse: trying mouse action leftclick 23:44:59 T:2460 NOTICE: CDVDPlayer::CloseFile() 23:44:59 T:2460 NOTICE: DVDPlayer: waiting for threads to exit 23:44:59 T:1192 NOTICE: CDVDPlayer::OnExit() 23:44:59 T:1192 NOTICE: Closing stream player 1 23:44:59 T:1192 NOTICE: Waiting for audio thread to exit 23:44:59 T:2176 NOTICE: thread end: CDVDPlayerAudio::OnExit() 23:44:59 T:2176 DEBUG: Thread DVDPlayerAudio 2176 terminating 23:44:59 T:1192 NOTICE: Closing audio device 23:44:59 T:2160 DEBUG: CActiveAE:iscardStream - audio stream deleted 23:44:59 T:2160 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 23:44:59 T:1192 NOTICE: Deleting audio codec 23:44:59 T:1192 NOTICE: Closing stream player 2 23:44:59 T:2160 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 23:44:59 T:2804 INFO: CActiveAESink::OpenSink - initialize sink 23:44:59 T:1192 NOTICE: waiting for video thread to exit 23:44:59 T:2804 DEBUG: CAESinkDirectSound:einitialize: Cleaning up 23:44:59 T:2820 NOTICE: thread end: video_thread 23:44:59 T:2820 DEBUG: Thread DVDPlayerVideo 2820 terminating 23:44:59 T:1192 NOTICE: deleting video codec 23:44:59 T:1192 DEBUG: CApplication::OnPlayBackStopped: play state was 2, starting 0 23:44:59 T:1192 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 23:44:59 T:1192 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 23:44:59 T:2460 NOTICE: DVDPlayer: finished waiting 23:44:59 T:1192 DEBUG: Thread DVDPlayer 1192 terminating 23:44:59 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Deactivate 23:44:59 T:2460 DEBUG: ------ Window Deinit (VideoOSD.xml) ------ 23:44:59 T:2460 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 23:44:59 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Activate new 23:44:59 T:2460 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 23:44:59 T:2460 DEBUG: CGUIMediaWindow::GetDirectory (C:\Videos\Family Guy\Season 8\) 23:44:59 T:2460 DEBUG: ParentPath = [C:\Videos\Family Guy\Season 8\] 23:44:59 T:2460 DEBUG: CVideoDatabase::RunQuery took 1 ms for 10 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=5 23:45:00 T:2804 DEBUG: CActiveAESink::OpenSink - trying to open device DIRECTSOUND:default 23:45:00 T:1936 DEBUG: Thread BackgroundLoader start, auto delete: false 23:45:00 T:2804 DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 000E0196 23:45:00 T:2804 DEBUG: CAESinkDirectSound::Initialize: secondary buffer created 23:45:00 T:2804 DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters: 23:45:00 T:2804 DEBUG: Audio Device : Lautsprecher (High Definition Audio-Gerät) 23:45:00 T:2804 DEBUG: Sample Rate : 44100 23:45:00 T:2804 DEBUG: Sample Format : AE_FMT_FLOAT 23:45:00 T:2804 DEBUG: Bits Per Sample : 32 23:45:00 T:2804 DEBUG: Valid Bits/Samp : 32 23:45:00 T:2804 DEBUG: Channel Count : 2 23:45:00 T:2804 DEBUG: Block Align : 8 23:45:00 T:2804 DEBUG: Avg. Bytes Sec : 352800 23:45:00 T:2804 DEBUG: Samples/Block : 32 23:45:00 T:2804 DEBUG: Format cBSize : 22 23:45:00 T:2804 DEBUG: Channel Layout : FL,FR 23:45:00 T:2804 DEBUG: Channel Mask : 3 23:45:00 T:2804 DEBUG: Frames : 661 23:45:00 T:2804 DEBUG: Frame Samples : 1322 23:45:00 T:2804 DEBUG: Frame Size : 8 23:45:00 T:2804 DEBUG: CActiveAESink::OpenSink - DIRECTSOUND Initialized: 23:45:00 T:2804 DEBUG: Output Device : default 23:45:00 T:2804 DEBUG: Sample Rate : 44100 23:45:00 T:2804 DEBUG: Sample Format : AE_FMT_FLOAT 23:45:00 T:2804 DEBUG: Channel Count : 2 23:45:00 T:2804 DEBUG: Channel Layout: FL,FR 23:45:00 T:2804 DEBUG: Frames : 661 23:45:00 T:2804 DEBUG: Frame Samples : 1322 23:45:00 T:2804 DEBUG: Frame Size : 8 23:45:00 T:2160 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 23:45:00 T:2460 NOTICE: CDVDPlayer::CloseFile() 23:45:00 T:2460 NOTICE: DVDPlayer: waiting for threads to exit 23:45:00 T:2460 NOTICE: DVDPlayer: finished waiting 23:45:00 T:2460 NOTICE: CDVDPlayer::CloseFile() 23:45:00 T:2460 NOTICE: DVDPlayer: waiting for threads to exit 23:45:00 T:2460 NOTICE: DVDPlayer: finished waiting 23:45:00 T:2460 DEBUG: Radio UECP (RDS) Processor - delete CDVDRadioRDSData::~CDVDRadioRDSData 23:45:00 T:1936 DEBUG: Thread BackgroundLoader 1936 terminating 23:45:00 T:2804 DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback 23:45:00 T:1216 DEBUG: CSaveFileStateJob:oWork - Saving file state for video item C:\Videos\Family Guy\Season 8\Family Guy S08E12.avi 23:45:01 T:2460 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 23:45:01 T:2460 DEBUG: CInputManager::OnKey: escape (0xf01b) pressed, action is PreviousMenu 23:45:01 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Deactivate 23:45:01 T:2460 DEBUG: ------ Window Deinit (Pointer.xml) ------ 23:45:01 T:2460 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 23:45:01 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Activate new 23:45:01 T:2460 DEBUG: ------ Window Init (Home.xml) ------ 23:45:02 T:2460 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 23:45:02 T:2460 DEBUG: CInputManager::OnKey: escape (0xf01b) pressed, action is PreviousMenu 23:45:02 T:2460 DEBUG: CGUIWindowManager:reviousWindow: Deactivate 23:45:02 T:2460 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 23:45:02 T:2460 DEBUG: CInputManager::OnKey: right (0xf083) pressed, action is Right 23:45:03 T:2460 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 23:45:03 T:2460 DEBUG: CInputManager::OnKey: right (0xf083) pressed, action is Right 23:45:03 T:2460 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 23:45:03 T:2460 DEBUG: CInputManager::OnKey: right (0xf083) pressed, action is Right 23:45:04 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:45:04 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:45:04 T:2460 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 23:45:04 T:2460 DEBUG: CInputManager::OnKey: return (0xf00d) pressed, action is Select 23:45:04 T:2460 DEBUG: Activating window ID: 10004 23:45:05 T:2460 DEBUG: ------ Window Deinit (Home.xml) ------ 23:45:05 T:2460 DEBUG: ------ Window Init (Settings.xml) ------ 23:45:06 T:2460 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 23:45:06 T:2460 DEBUG: CInputManager::OnKey: return (0xf00d) pressed, action is Select 23:45:06 T:2460 DEBUG: Activating window ID: 10016 23:45:06 T:2460 DEBUG: ------ Window Deinit (Settings.xml) ------ 23:45:06 T:2460 DEBUG: ------ Window Init (SettingsCategory.xml) ------ 23:45:07 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:45:07 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:45:07 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:45:07 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:45:07 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:45:08 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:45:08 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:45:08 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:45:08 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:45:08 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:45:09 T:2460 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 23:45:09 T:2460 DEBUG: CInputManager::OnKey: right (0xf083) pressed, action is Right 23:45:10 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:45:10 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:45:10 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:45:10 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:45:10 T:2460 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:45:10 T:2460 DEBUG: CInputManager::OnKey: down (0xf081) pressed, action is Down 23:45:11 T:2460 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 23:45:11 T:2460 DEBUG: CInputManager::OnKey: return (0xf00d) pressed, action is Select 23:45:11 T:2460 NOTICE: Disabled debug logging due to GUI setting. Level 0. 23:45:11 T:2460 NOTICE: Log level changed to "LOG_LEVEL_NORMAL" RE: Kodi 16.1 not playing video only "Ambilight" - cherberg - 2016-12-18 Update: Since I had nothing to lose I updated to 17 beta 6. Same behaviour RE: Kodi 16.1 not playing video only "Ambilight" - DarrenHill - 2016-12-19 Please don't post full logs directly here. Remove the one above and post it to PasteBin.Com or similar and provide their link here instead. |