22:38:26 T:3880 NOTICE: special://profile/ is mapped to: special://masterprofile/ 22:38:26 T:3880 NOTICE: ----------------------------------------------------------------------- 22:38:26 T:3880 NOTICE: Starting Kodi (14.0 Git:20141223-ad747d9). Platform: Windows NT x86 32-bit 22:38:26 T:3880 NOTICE: Using Release Kodi x32 build 22:38:26 T:3880 NOTICE: Kodi compiled Dec 23 2014 by MSVC 180030723 for Windows NT x86 32-bit version 6.0 (0x06000000) 22:38:26 T:3880 NOTICE: Running on Gigabyte Technology Co., Ltd. P35-DS3R with Windows 7 SP1, kernel: Windows NT x86 64-bit version 6.1 22:38:26 T:3880 NOTICE: Host CPU: Intel(R) Core(TM)2 Quad CPU Q6600 @ 2.40GHz, 4 cores available 22:38:26 T:3880 NOTICE: Desktop Resolution: 1920x1080 32Bit at 60Hz 22:38:26 T:3880 NOTICE: Running with administrator rights 22:38:26 T:3880 NOTICE: Aero is enabled 22:38:26 T:3880 NOTICE: special://xbmc/ is mapped to: C:\Program Files (x86)\Kodi 22:38:26 T:3880 NOTICE: special://xbmcbin/ is mapped to: C:\Program Files (x86)\Kodi 22:38:26 T:3880 NOTICE: special://masterprofile/ is mapped to: C:\Users\Kodi\AppData\Roaming\Kodi\userdata 22:38:26 T:3880 NOTICE: special://home/ is mapped to: C:\Users\Kodi\AppData\Roaming\Kodi\ 22:38:26 T:3880 NOTICE: special://temp/ is mapped to: C:\Users\Kodi\AppData\Roaming\Kodi\cache 22:38:26 T:3880 NOTICE: The executable running is: C:\Program Files (x86)\Kodi\Kodi.exe 22:38:26 T:3880 NOTICE: Local hostname: Media-PC 22:38:26 T:3880 NOTICE: Log File is located: C:\Users\Kodi\AppData\Roaming\Kodi\kodi.log 22:38:26 T:3880 NOTICE: ----------------------------------------------------------------------- 22:38:26 T:3880 NOTICE: load settings... 22:38:26 T:3880 WARNING: CSettingString: unknown options filler "timezonecountries" of "locale.timezonecountry" 22:38:26 T:3880 WARNING: CSettingString: unknown options filler "timezones" of "locale.timezone" 22:38:26 T:3880 NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml) 22:38:26 T:3880 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 22:38:26 T:3880 NOTICE: Default DVD Player: dvdplayer 22:38:26 T:3880 NOTICE: Default Video Player: dvdplayer 22:38:26 T:3880 NOTICE: Default Audio Player: paplayer 22:38:26 T:3880 NOTICE: Disabled debug logging due to GUI setting. Level 0. 22:38:26 T:3880 NOTICE: Log level changed to "LOG_LEVEL_NORMAL" 22:38:26 T:3880 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml 22:38:26 T:3880 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 22:38:26 T:3880 NOTICE: Loaded playercorefactory configuration 22:38:26 T:3880 NOTICE: Loading player core factory settings from special://profile/playercorefactory.xml. 22:38:26 T:3880 NOTICE: Loaded playercorefactory configuration 22:38:26 T:632 NOTICE: Thread ActiveAE start, auto delete: false 22:38:26 T:3500 NOTICE: Thread AESink start, auto delete: false 22:38:26 T:632 NOTICE: CAESinkWASAPI::EnumerateDevicesEx: data format "AE_FMT_DTSHD" on device "Digitalaudio (HDMI) (2- High Definition Audio-Gerät)" seems to be not supported. 22:38:26 T:632 NOTICE: CAESinkWASAPI::EnumerateDevicesEx: data format "AE_FMT_TRUEHD" on device "Digitalaudio (HDMI) (2- High Definition Audio-Gerät)" seems to be not supported. 22:38:26 T:632 NOTICE: CAESinkWASAPI::EnumerateDevicesEx: data format "AE_FMT_EAC3" on device "Digitalaudio (HDMI) (2- High Definition Audio-Gerät)" seems to be not supported. 22:38:26 T:632 NOTICE: CAESinkWASAPI::EnumerateDevicesEx: data format "AE_FMT_DTS" on device "Digitalaudio (HDMI) (2- High Definition Audio-Gerät)" seems to be not supported. 22:38:26 T:632 NOTICE: CAESinkWASAPI::EnumerateDevicesEx: data format "AE_FMT_AC3" on device "Digitalaudio (HDMI) (2- High Definition Audio-Gerät)" seems to be not supported. 22:38:26 T:632 NOTICE: CAESinkWASAPI::EnumerateDevicesEx: data format "AE_FMT_AAC" on device "Digitalaudio (HDMI) (2- High Definition Audio-Gerät)" seems to be not supported. 22:38:26 T:632 NOTICE: CAESinkWASAPI::EnumerateDevicesEx: sample rate 192khz on device "Digitalaudio (HDMI) (2- High Definition Audio-Gerät)" seems to be not supported. 22:38:26 T:632 NOTICE: CAESinkWASAPI::EnumerateDevicesEx: data format "AE_FMT_LPCM" on device "Digitalaudio (HDMI) (2- High Definition Audio-Gerät)" seems to be not supported. 22:38:26 T:632 NOTICE: Found 2 Lists of Devices 22:38:26 T:632 NOTICE: Enumerated DIRECTSOUND devices: 22:38:26 T:632 NOTICE: Device 1 22:38:26 T:632 NOTICE: m_deviceName : {80733A18-CDD4-4827-8E6D-F12CB2524E64} 22:38:26 T:632 NOTICE: m_displayName : HDMI - Digitalaudio (HDMI) (2- High Definition Audio-Gerät) 22:38:27 T:632 NOTICE: m_displayNameExtra: DIRECTSOUND: Digitalaudio (HDMI) (2- High Definition Audio-Gerät) 22:38:27 T:632 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 22:38:27 T:632 NOTICE: m_channels : FL,FR 22:38:27 T:632 NOTICE: m_sampleRates : 44100 22:38:27 T:632 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_AC3,AE_FMT_DTS 22:38:27 T:632 NOTICE: Device 2 22:38:27 T:632 NOTICE: m_deviceName : default 22:38:27 T:632 NOTICE: m_displayName : default 22:38:27 T:632 NOTICE: m_displayNameExtra: 22:38:27 T:632 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 22:38:27 T:632 NOTICE: m_channels : FL,FR 22:38:27 T:632 NOTICE: m_sampleRates : 44100 22:38:27 T:632 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_AC3,AE_FMT_DTS 22:38:27 T:632 NOTICE: Device 3 22:38:27 T:632 NOTICE: m_deviceName : {FE5B9936-10E3-4B0C-9753-1404B8725D6F} 22:38:27 T:632 NOTICE: m_displayName : SPDIF - Digitalaudio (S/PDIF) (High Definition Audio-Gerät) 22:38:27 T:632 NOTICE: m_displayNameExtra: DIRECTSOUND: Digitalaudio (S/PDIF) (High Definition Audio-Gerät) 22:38:27 T:632 NOTICE: m_deviceType : AE_DEVTYPE_IEC958 22:38:27 T:632 NOTICE: m_channels : FL,FR 22:38:27 T:632 NOTICE: m_sampleRates : 44100 22:38:27 T:632 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_AC3,AE_FMT_DTS 22:38:27 T:632 NOTICE: Enumerated WASAPI devices: 22:38:27 T:632 NOTICE: Device 1 22:38:27 T:632 NOTICE: m_deviceName : {80733A18-CDD4-4827-8E6D-F12CB2524E64} 22:38:27 T:632 NOTICE: m_displayName : HDMI - Digitalaudio (HDMI) (2- High Definition Audio-Gerät) 22:38:27 T:632 NOTICE: m_displayNameExtra: WASAPI: Digitalaudio (HDMI) (2- High Definition Audio-Gerät) 22:38:27 T:632 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 22:38:27 T:632 NOTICE: m_channels : FL,FR 22:38:27 T:632 NOTICE: m_sampleRates : 192000,48000,44100,32000 22:38:27 T:632 NOTICE: m_dataFormats : AE_FMT_DTSHD,AE_FMT_TRUEHD,AE_FMT_EAC3,AE_FMT_DTS,AE_FMT_AC3,AE_FMT_AAC,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_S16BE,AE_FMT_LPCM 22:38:27 T:632 NOTICE: Device 2 22:38:27 T:632 NOTICE: m_deviceName : default 22:38:27 T:632 NOTICE: m_displayName : default 22:38:27 T:632 NOTICE: m_displayNameExtra: 22:38:27 T:632 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 22:38:27 T:632 NOTICE: m_channels : FL,FR 22:38:27 T:632 NOTICE: m_sampleRates : 192000,48000,44100,32000 22:38:27 T:632 NOTICE: m_dataFormats : AE_FMT_DTSHD,AE_FMT_TRUEHD,AE_FMT_EAC3,AE_FMT_DTS,AE_FMT_AC3,AE_FMT_AAC,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_S16BE,AE_FMT_LPCM 22:38:27 T:632 NOTICE: Device 3 22:38:27 T:632 NOTICE: m_deviceName : {FE5B9936-10E3-4B0C-9753-1404B8725D6F} 22:38:27 T:632 NOTICE: m_displayName : SPDIF - Digitalaudio (S/PDIF) (High Definition Audio-Gerät) 22:38:27 T:632 NOTICE: m_displayNameExtra: WASAPI: Digitalaudio (S/PDIF) (High Definition Audio-Gerät) 22:38:27 T:632 NOTICE: m_deviceType : AE_DEVTYPE_IEC958 22:38:27 T:632 NOTICE: m_channels : FL,FR 22:38:27 T:632 NOTICE: m_sampleRates : 192000,96000,88200,48000,44100 22:38:27 T:632 NOTICE: m_dataFormats : AE_FMT_DTS,AE_FMT_AC3,AE_FMT_AAC,AE_FMT_S24NE4MSB,AE_FMT_S32NE,AE_FMT_S32LE,AE_FMT_S32BE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_S16BE 22:38:27 T:3880 NOTICE: Running database version Addons16 22:38:27 T:3880 NOTICE: ADDONS: Using repository repository.xbmc.org 22:38:27 T:3880 NOTICE: ADDONS: Using repository repository.xstream 22:38:27 T:3880 NOTICE: ADDONS: Using repository repository.xbmchub 22:38:27 T:3880 NOTICE: ADDONS: Using repository repository.xbmcnerds-eden-pre 22:38:27 T:3880 NOTICE: ADDONS: Using repository repository.pvr-win32.xbmc.org 22:38:27 T:2640 NOTICE: Thread RemoteControl start, auto delete: false 22:38:27 T:2440 NOTICE: Thread PeripBusCEC start, auto delete: false 22:38:27 T:980 NOTICE: Thread PeripBusUSB start, auto delete: false 22:38:27 T:3204 NOTICE: Thread JobWorker start, auto delete: true 22:38:27 T:3880 NOTICE: Found screen: PnP-Monitor (Standard) on AMD Radeon HD 5450, adapter 0. 22:38:27 T:3880 NOTICE: Primary mode: 1920x1080@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 640x480@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 640x480@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 640x480@ 59.94 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 720x480@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 720x480@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 720x480@ 59.94 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 720x480@ 29.97i - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 720x480@ 30.00i - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 720x480@ 29.97i - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 720x480@ 30.00i - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 720x480@ 29.97i - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 720x480@ 30.00i - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 720x576@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 720x576@ 59.94 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 720x576@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 720x576@ 59.94 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 720x576@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 720x576@ 59.94 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 720x576@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 720x576@ 25.00i - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 800x600@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 800x600@ 56.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 800x600@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1024x768@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 1024x768@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1152x648@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1152x648@ 59.94 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1152x648@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1280x720@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1280x720@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1280x720@ 59.94 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1280x768@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 1280x768@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 1280x800@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 1280x800@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1280x960@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 1280x960@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1280x1024@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 1280x1024@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1360x768@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 1360x768@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 1360x1024@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 1360x1024@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 1366x768@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 1366x768@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 1400x1050@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 1400x1050@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 1440x900@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 1440x900@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1600x900@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 1600x900@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 1600x1200@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1680x1050@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Previous line repeats 2 times. 22:38:27 T:3880 NOTICE: Additional mode: 1680x1050@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1776x1000@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1776x1000@ 59.94 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1776x1000@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1776x1000@ 25.00i - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1776x1000@ 29.97i - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1776x1000@ 30.00i - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1920x1080@ 50.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1920x1080@ 60.00 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1920x1080@ 59.94 - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1920x1080@ 25.00i - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1920x1080@ 30.00i - Full Screen 22:38:27 T:3880 NOTICE: Additional mode: 1920x1080@ 29.97i - Full Screen 22:38:27 T:3880 NOTICE: Checking resolution 16 22:38:28 T:3880 NOTICE: Running database version Addons16 22:38:28 T:3880 NOTICE: Running database version ViewModes6 22:38:28 T:3880 NOTICE: Running database version Textures13 22:38:28 T:3880 NOTICE: Running database version MyMusic48 22:38:28 T:3880 NOTICE: Running database version MyVideos90 22:38:28 T:3880 NOTICE: Running database version TV26 22:38:28 T:3880 NOTICE: Running database version Epg8 22:38:28 T:3880 WARNING: JSONRPC: Could not parse type "PVR.Details.Channel" 22:38:28 T:3880 WARNING: JSONRPC: Could not parse type "PVR.Details.ChannelGroup.Extended" 22:38:28 T:3880 WARNING: JSONRPC: Could not parse type "GUI.Property.Value" 22:38:28 T:3880 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 22:38:28 T:1868 NOTICE: Thread LanguageInvoker start, auto delete: false 22:38:28 T:672 NOTICE: Previous line repeats 7 times. 22:38:28 T:672 NOTICE: -->Python Interpreter Initialized<-- 22:38:28 T:3880 WARNING: RunScript called for a non-script addon 'script.grab.fanart'. This behaviour is deprecated. 22:38:28 T:2320 NOTICE: Thread LanguageInvoker start, auto delete: false 22:38:28 T:3880 NOTICE: initialize done 22:38:28 T:2352 NOTICE: Thread LanguageInvoker start, auto delete: false 22:38:29 T:1868 NOTICE: -->Python Interpreter Initialized<-- 22:38:29 T:3880 NOTICE: Previous line repeats 6 times. 22:38:29 T:3880 NOTICE: Running the application... 22:38:29 T:3880 NOTICE: ES: Starting event server 22:38:29 T:3600 NOTICE: Thread LanguageInvoker start, auto delete: false 22:38:29 T:348 NOTICE: Thread EventServer start, auto delete: false 22:38:29 T:3540 NOTICE: Thread TCPServer start, auto delete: false 22:38:29 T:348 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777 22:38:29 T:348 NOTICE: UDP: Listening on port 9777 22:38:29 T:3452 NOTICE: Thread JobWorker start, auto delete: true 22:38:29 T:1552 NOTICE: script.tv.show.next.aired: ### TV Show - Next Aired starting background proc (6.0.13) 22:38:29 T:3404 NOTICE: RCB Service: Start 22:38:29 T:3404 NOTICE: RCB Service: launch RCB on startup = false 22:38:29 T:3404 NOTICE: RCB Service: scrape games on startup = true 22:38:29 T:3404 NOTICE: RCB Service: Starting DB UpdateC:\Users\Kodi\AppData\Roaming\Kodi\addons\script.games.rom.collection.browser\dbUpLauncher.py 22:38:29 T:3404 NOTICE: RCB Service: Done 22:38:29 T:2320 NOTICE: -->Python Interpreter Initialized<-- 22:38:29 T:2620 NOTICE: Previous line repeats 1 times. 22:38:29 T:2620 NOTICE: Thread LanguageInvoker start, auto delete: false 22:38:29 T:2320 NOTICE: script.grab.fanart: mode 22:38:29 T:2320 NOTICE: script.grab.fanart: refresh 22:38:29 T:4020 NOTICE: script.grab.fanart: Grab Fanart Service Started 22:38:29 T:3600 NOTICE: -->Python Interpreter Initialized<-- 22:38:29 T:3600 WARNING: CPythonInvoker(10): Script invoked without an addon. Adding all addon modules installed to python path as fallback. This behaviour will be removed in future version. 22:38:29 T:2352 NOTICE: StorageServer Module loaded RUN 22:38:29 T:2352 NOTICE: StorageClient-2.5.4 Starting server 22:38:29 T:2620 NOTICE: -->Python Interpreter Initialized<-- 22:38:29 T:2620 WARNING: CPythonInvoker(11): Script invoked without an addon. Adding all addon modules installed to python path as fallback. This behaviour will be removed in future version. 22:38:29 T:2620 NOTICE: RCB_INFO: Loading sqlite3 as DB engine 22:38:29 T:2620 NOTICE: RCB: init log level 22:38:29 T:2620 NOTICE: RCB: current log level: 2 22:38:29 T:2620 NOTICE: RCB_INFO: Loading sqlite3 as DB engine 22:38:30 T:2620 NOTICE: runUpdate 22:38:30 T:2620 NOTICE: C:\Users\Kodi\AppData\Roaming\Kodi\userdata\addon_data\script.games.rom.collection.browser\MyGames.db 22:38:30 T:2620 NOTICE: RCB_INFO: Config() set path to None 22:38:30 T:2620 NOTICE: RCB_INFO: readXml 22:38:30 T:2620 NOTICE: RCB_INFO: initXml 22:38:30 T:2620 NOTICE: RCB_INFO: Path to configuration file: C:\Users\Kodi\AppData\Roaming\Kodi\userdata\addon_data\script.games.rom.collection.browser\config.xml 22:38:30 T:2620 NOTICE: RCB_INFO: Begin readRomCollections 22:38:30 T:2620 NOTICE: RCB_INFO: current Rom Collection: Nintendo 64 22:38:30 T:2620 NOTICE: RCB_INFO: Rom path: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: Rom path: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\*.z64 22:38:30 T:2620 NOTICE: RCB_INFO: Media path: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\boxfront\%GAME%.* 22:38:30 T:2620 NOTICE: RCB_INFO: Media path: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\boxback\%GAME%.* 22:38:30 T:2620 NOTICE: RCB_INFO: Media path: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\cartridge\%GAME%.* 22:38:30 T:2620 NOTICE: RCB_INFO: Media path: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\screenshot\%GAME%.* 22:38:30 T:2620 NOTICE: RCB_INFO: Media path: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\fanart\%GAME%.* 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper site: thegamesdb.net 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper Site: thegamesdb.net 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper descFilePerGame: True 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper site: archive.vg 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper Site: archive.vg 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper descFilePerGame: True 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper site: mobygames.com 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper Site: mobygames.com 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper descFilePerGame: True 22:38:30 T:2620 NOTICE: RCB_INFO: Image Placing name: gameinfobig 22:38:30 T:2620 NOTICE: RCB_INFO: Image Placing name: gameinfosmall 22:38:30 T:2620 NOTICE: RCB_INFO: emulatorCmd: C:\Emulatoren\Project64 2.1\Project64.exe 22:38:30 T:2620 NOTICE: RCB_INFO: emulatorParams: "%ROM%" 22:38:30 T:2620 NOTICE: RCB_INFO: useBuiltinEmulator: False 22:38:30 T:2620 NOTICE: RCB_INFO: ignoreOnScan: False 22:38:30 T:2620 NOTICE: RCB_INFO: allowUpdate: True 22:38:30 T:2620 NOTICE: RCB_INFO: useEmuSolo: False 22:38:30 T:2620 NOTICE: RCB_INFO: usePopen: False 22:38:30 T:2620 NOTICE: RCB_INFO: autoplayVideoMain: True 22:38:30 T:2620 NOTICE: RCB_INFO: autoplayVideoInfo: True 22:38:30 T:2620 NOTICE: RCB_INFO: useFoldernameAsGamename: False 22:38:30 T:2620 NOTICE: RCB_INFO: maxFolderDepth: 99 22:38:30 T:2620 NOTICE: RCB_INFO: doNotExtractZipFiles: False 22:38:30 T:2620 NOTICE: RCB_INFO: diskPrefix: _Disk 22:38:30 T:2620 NOTICE: RCB_INFO: current Rom Collection: Wii 22:38:30 T:2620 NOTICE: RCB_INFO: Rom path: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: Rom path: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\*.iso 22:38:30 T:2620 NOTICE: RCB_INFO: Media path: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\boxfront\%GAME%.* 22:38:30 T:2620 NOTICE: RCB_INFO: Media path: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\boxback\%GAME%.* 22:38:30 T:2620 NOTICE: RCB_INFO: Media path: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\cartridge\%GAME%.* 22:38:30 T:2620 NOTICE: RCB_INFO: Media path: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\screenshot\%GAME%.* 22:38:30 T:2620 NOTICE: RCB_INFO: Media path: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\fanart\%GAME%.* 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper site: thegamesdb.net 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper Site: thegamesdb.net 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper descFilePerGame: True 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper site: archive.vg 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper Site: archive.vg 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper descFilePerGame: True 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper site: mobygames.com 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper Site: mobygames.com 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper descFilePerGame: True 22:38:30 T:2620 NOTICE: RCB_INFO: Image Placing name: gameinfobig 22:38:30 T:2620 NOTICE: RCB_INFO: Image Placing name: gameinfosmall 22:38:30 T:2620 NOTICE: RCB_INFO: emulatorCmd: C:\Emulatoren\Dolphin-x64\Dolphin.exe 22:38:30 T:2620 NOTICE: RCB_INFO: emulatorParams: "%ROM%" 22:38:30 T:2620 NOTICE: RCB_INFO: useBuiltinEmulator: False 22:38:30 T:2620 NOTICE: RCB_INFO: ignoreOnScan: False 22:38:30 T:2620 NOTICE: RCB_INFO: allowUpdate: True 22:38:30 T:2620 NOTICE: RCB_INFO: useEmuSolo: False 22:38:30 T:2620 NOTICE: RCB_INFO: usePopen: False 22:38:30 T:2620 NOTICE: RCB_INFO: autoplayVideoMain: True 22:38:30 T:2620 NOTICE: RCB_INFO: autoplayVideoInfo: True 22:38:30 T:2620 NOTICE: RCB_INFO: useFoldernameAsGamename: False 22:38:30 T:2620 NOTICE: RCB_INFO: maxFolderDepth: 99 22:38:30 T:2620 NOTICE: RCB_INFO: doNotExtractZipFiles: False 22:38:30 T:2620 NOTICE: RCB_INFO: diskPrefix: _Disk 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper Site: local nfo 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper descFilePerGame: True 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper Site: thegamesdb.net 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper descFilePerGame: True 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper Site: giantbomb.com 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper descFilePerGame: True 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper Site: mobygames.com 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper descFilePerGame: True 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper Site: archive.vg 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper descFilePerGame: True 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper Site: maws.mameworld.info 22:38:30 T:2620 NOTICE: RCB_INFO: Scraper descFilePerGame: True 22:38:30 T:2620 NOTICE: paintProgress 22:38:30 T:2620 NOTICE: RCB_INFO: init DBUpdate 22:38:30 T:2620 NOTICE: RCB_INFO: Start Update DB 22:38:30 T:2620 NOTICE: RCB_INFO: Iterating Rom Collections 22:38:30 T:2620 NOTICE: RCB_INFO: matchingRatioIndex: 2 22:38:30 T:2620 NOTICE: RCB_INFO: fuzzyFactor: 0.7 22:38:30 T:2620 NOTICE: RCB_INFO: enableFullReimport: False 22:38:30 T:2620 NOTICE: RCB_INFO: current Rom Collection: Nintendo 64 22:38:30 T:2620 NOTICE: RCB_INFO: ignoreOnScan: False 22:38:30 T:2620 NOTICE: RCB_INFO: update is allowed for current rom collection: True 22:38:30 T:2620 NOTICE: RCB_INFO: max folder depth: 99 22:38:30 T:2620 NOTICE: RCB_INFO: Rom path: ['C:\\Users\\Kodi\\Documents\\Spiele\\Roms\\Nintendo 64\\*.zip', 'C:\\Users\\Kodi\\Documents\\Spiele\\Roms\\Nintendo 64\\*.z64'] 22:38:30 T:2620 NOTICE: RCB_INFO: Reading rom files 22:38:30 T:2620 NOTICE: RCB_INFO: walkDownPath romPath: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: Running walkdown on: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: Begin getFilesByWildcard. pathName = C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: dirname: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64 22:38:30 T:2620 NOTICE: RCB_INFO: filemask: *.zip 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs dirs: ['FanArts'] 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs files: ['Mario Kart 64 (E) (V1.1) [!].nfo', 'Mario Kart 64 (E) (V1.1) [!].z64', 'Super Mario 64 (E) (M3) [!].nfo', 'Super Mario 64 (E) (M3) [!].z64'] 22:38:30 T:2620 NOTICE: RCB_INFO: Running walkdown on: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: Begin getFilesByWildcard. pathName = C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: dirname: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts 22:38:30 T:2620 NOTICE: RCB_INFO: filemask: *.zip 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs dirs: ['boxback', 'boxfront', 'fanart'] 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs files: ['Mario Kart 64 (E) (V1.1) [!]_fanart.jpg', 'Mario Kart 64 (E) (V1.1) [!]_thumb.jpg', 'Super Mario 64 (E) (M3) [!]_fanart.jpg', 'Super Mario 64 (E) (M3) [!]_thumb.jpg'] 22:38:30 T:2620 NOTICE: RCB_INFO: Running walkdown on: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\boxback\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: Begin getFilesByWildcard. pathName = C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\boxback\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: dirname: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\boxback 22:38:30 T:2620 NOTICE: RCB_INFO: filemask: *.zip 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs dirs: [] 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs files: ['Mario Kart 64 (E) (V1.1) [!].jpg', 'Super Mario 64 (E) (M3) [!].jpg'] 22:38:30 T:2620 NOTICE: RCB_INFO: Running walkdown on: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\boxfront\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: Begin getFilesByWildcard. pathName = C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\boxfront\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: dirname: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\boxfront 22:38:30 T:2620 NOTICE: RCB_INFO: filemask: *.zip 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs dirs: [] 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs files: ['Mario Kart 64 (E) (V1.1) [!].jpg', 'Super Mario 64 (E) (M3) [!].jpg'] 22:38:30 T:2620 NOTICE: RCB_INFO: Running walkdown on: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\fanart\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: Begin getFilesByWildcard. pathName = C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\fanart\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: dirname: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\fanart 22:38:30 T:2620 NOTICE: RCB_INFO: filemask: *.zip 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs dirs: [] 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs files: ['Mario Kart 64 (E) (V1.1) [!].jpg', 'Super Mario 64 (E) (M3) [!].jpg'] 22:38:30 T:2620 NOTICE: RCB_INFO: files after walkDown = [] 22:38:30 T:2620 NOTICE: RCB_INFO: walkDownPath romPath: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\*.z64 22:38:30 T:2620 NOTICE: RCB_INFO: Running walkdown on: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\*.z64 22:38:30 T:2620 NOTICE: RCB_INFO: Begin getFilesByWildcard. pathName = C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\*.z64 22:38:30 T:2620 NOTICE: RCB_INFO: dirname: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64 22:38:30 T:2620 NOTICE: RCB_INFO: filemask: *.z64 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs dirs: ['FanArts'] 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs files: ['Mario Kart 64 (E) (V1.1) [!].nfo', 'Mario Kart 64 (E) (V1.1) [!].z64', 'Super Mario 64 (E) (M3) [!].nfo', 'Super Mario 64 (E) (M3) [!].z64'] 22:38:30 T:2620 NOTICE: RCB_INFO: Running walkdown on: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\*.z64 22:38:30 T:2620 NOTICE: RCB_INFO: Begin getFilesByWildcard. pathName = C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\*.z64 22:38:30 T:2620 NOTICE: RCB_INFO: dirname: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts 22:38:30 T:2620 NOTICE: RCB_INFO: filemask: *.z64 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs dirs: ['boxback', 'boxfront', 'fanart'] 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs files: ['Mario Kart 64 (E) (V1.1) [!]_fanart.jpg', 'Mario Kart 64 (E) (V1.1) [!]_thumb.jpg', 'Super Mario 64 (E) (M3) [!]_fanart.jpg', 'Super Mario 64 (E) (M3) [!]_thumb.jpg'] 22:38:30 T:2620 NOTICE: RCB_INFO: Running walkdown on: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\boxback\*.z64 22:38:30 T:2620 NOTICE: RCB_INFO: Begin getFilesByWildcard. pathName = C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\boxback\*.z64 22:38:30 T:2620 NOTICE: RCB_INFO: dirname: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\boxback 22:38:30 T:2620 NOTICE: RCB_INFO: filemask: *.z64 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs dirs: [] 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs files: ['Mario Kart 64 (E) (V1.1) [!].jpg', 'Super Mario 64 (E) (M3) [!].jpg'] 22:38:30 T:2620 NOTICE: RCB_INFO: Running walkdown on: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\boxfront\*.z64 22:38:30 T:2620 NOTICE: RCB_INFO: Begin getFilesByWildcard. pathName = C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\boxfront\*.z64 22:38:30 T:2620 NOTICE: RCB_INFO: dirname: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\boxfront 22:38:30 T:2620 NOTICE: RCB_INFO: filemask: *.z64 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs dirs: [] 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs files: ['Mario Kart 64 (E) (V1.1) [!].jpg', 'Super Mario 64 (E) (M3) [!].jpg'] 22:38:30 T:2620 NOTICE: RCB_INFO: Running walkdown on: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\fanart\*.z64 22:38:30 T:2620 NOTICE: RCB_INFO: Begin getFilesByWildcard. pathName = C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\fanart\*.z64 22:38:30 T:2620 NOTICE: RCB_INFO: dirname: C:\Users\Kodi\Documents\Spiele\Roms\Nintendo 64\FanArts\fanart 22:38:30 T:2620 NOTICE: RCB_INFO: filemask: *.z64 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs dirs: [] 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs files: ['Mario Kart 64 (E) (V1.1) [!].jpg', 'Super Mario 64 (E) (M3) [!].jpg'] 22:38:30 T:2620 NOTICE: RCB_INFO: files after walkDown = ['C:\\Users\\Kodi\\Documents\\Spiele\\Roms\\Nintendo 64\\Mario Kart 64 (E) (V1.1) [!].z64', 'C:\\Users\\Kodi\\Documents\\Spiele\\Roms\\Nintendo 64\\Super Mario 64 (E) (M3) [!].z64'] 22:38:30 T:2620 NOTICE: RCB_INFO: Files read: [] 22:38:30 T:2620 NOTICE: RCB_INFO: current Rom Collection: Wii 22:38:30 T:2620 NOTICE: RCB_INFO: ignoreOnScan: False 22:38:30 T:2620 NOTICE: RCB_INFO: update is allowed for current rom collection: True 22:38:30 T:2620 NOTICE: RCB_INFO: max folder depth: 99 22:38:30 T:2620 NOTICE: RCB_INFO: Rom path: ['C:\\Users\\Kodi\\Documents\\Spiele\\Roms\\GC_WII\\*.zip', 'C:\\Users\\Kodi\\Documents\\Spiele\\Roms\\GC_WII\\*.iso'] 22:38:30 T:2620 NOTICE: RCB_INFO: Reading rom files 22:38:30 T:2620 NOTICE: RCB_INFO: walkDownPath romPath: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: Running walkdown on: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: Begin getFilesByWildcard. pathName = C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: dirname: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII 22:38:30 T:2620 NOTICE: RCB_INFO: filemask: *.zip 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs dirs: ['FanArts'] 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs files: ['Super Mario Party 9.iso', 'Super Mario Party 9.nfo'] 22:38:30 T:2620 NOTICE: RCB_INFO: Running walkdown on: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: Begin getFilesByWildcard. pathName = C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: dirname: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts 22:38:30 T:2620 NOTICE: RCB_INFO: filemask: *.zip 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs dirs: ['boxfront', 'fanart'] 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs files: ['Super Mario Party 9_fanart.jpg', 'Super Mario Party 9_thumb.jpg'] 22:38:30 T:2620 NOTICE: RCB_INFO: Running walkdown on: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\boxfront\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: Begin getFilesByWildcard. pathName = C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\boxfront\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: dirname: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\boxfront 22:38:30 T:2620 NOTICE: RCB_INFO: filemask: *.zip 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs dirs: [] 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs files: ['Super Mario Party 9.jpg'] 22:38:30 T:2620 NOTICE: RCB_INFO: Running walkdown on: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\fanart\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: Begin getFilesByWildcard. pathName = C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\fanart\*.zip 22:38:30 T:2620 NOTICE: RCB_INFO: dirname: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\fanart 22:38:30 T:2620 NOTICE: RCB_INFO: filemask: *.zip 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs dirs: [] 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs files: ['Super Mario Party 9.jpg'] 22:38:30 T:2620 NOTICE: RCB_INFO: files after walkDown = [] 22:38:30 T:2620 NOTICE: RCB_INFO: walkDownPath romPath: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\*.iso 22:38:30 T:2620 NOTICE: RCB_INFO: Running walkdown on: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\*.iso 22:38:30 T:2620 NOTICE: RCB_INFO: Begin getFilesByWildcard. pathName = C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\*.iso 22:38:30 T:2620 NOTICE: RCB_INFO: dirname: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII 22:38:30 T:2620 NOTICE: RCB_INFO: filemask: *.iso 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs dirs: ['FanArts'] 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs files: ['Super Mario Party 9.iso', 'Super Mario Party 9.nfo'] 22:38:30 T:2620 NOTICE: RCB_INFO: Running walkdown on: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\*.iso 22:38:30 T:2620 NOTICE: RCB_INFO: Begin getFilesByWildcard. pathName = C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\*.iso 22:38:30 T:2620 NOTICE: RCB_INFO: dirname: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts 22:38:30 T:2620 NOTICE: RCB_INFO: filemask: *.iso 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs dirs: ['boxfront', 'fanart'] 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs files: ['Super Mario Party 9_fanart.jpg', 'Super Mario Party 9_thumb.jpg'] 22:38:30 T:2620 NOTICE: RCB_INFO: Running walkdown on: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\boxfront\*.iso 22:38:30 T:2620 NOTICE: RCB_INFO: Begin getFilesByWildcard. pathName = C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\boxfront\*.iso 22:38:30 T:2620 NOTICE: RCB_INFO: dirname: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\boxfront 22:38:30 T:2620 NOTICE: RCB_INFO: filemask: *.iso 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs dirs: [] 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs files: ['Super Mario Party 9.jpg'] 22:38:30 T:2620 NOTICE: RCB_INFO: Running walkdown on: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\fanart\*.iso 22:38:30 T:2620 NOTICE: RCB_INFO: Begin getFilesByWildcard. pathName = C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\fanart\*.iso 22:38:30 T:2620 NOTICE: RCB_INFO: dirname: C:\Users\Kodi\Documents\Spiele\Roms\GC_WII\FanArts\fanart 22:38:30 T:2620 NOTICE: RCB_INFO: filemask: *.iso 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs dirs: [] 22:38:30 T:2620 NOTICE: RCB_INFO: xbmcvfs files: ['Super Mario Party 9.jpg'] 22:38:30 T:2620 NOTICE: RCB_INFO: files after walkDown = ['C:\\Users\\Kodi\\Documents\\Spiele\\Roms\\GC_WII\\Super Mario Party 9.iso'] 22:38:30 T:2620 NOTICE: RCB_INFO: Files read: [] 22:38:30 T:2620 NOTICE: writeMsg 22:38:30 T:2620 NOTICE: count = 1 22:38:30 T:2620 NOTICE: RCB_INFO: Update finished 22:38:45 T:3880 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 22:38:45 T:3880 NOTICE: Enabled debug logging due to GUI setting. Level 2. 22:38:45 T:3880 DEBUG: ------ Window Init () ------ 22:38:49 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:38:49 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:38:50 T:3880 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 22:38:50 T:3880 DEBUG: CApplication::OnKey: return (0xf00d) pressed, action is Select 22:38:53 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:38:53 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:38:53 T:3880 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 22:38:53 T:3880 DEBUG: CApplication::OnKey: return (0xf00d) pressed, action is Select 22:38:53 T:3880 DEBUG: ------ Window Init (DialogSelect.xml) ------ 22:38:53 T:3880 INFO: Loading skin file: DialogSelect.xml, load type: KEEP_IN_MEMORY 22:38:56 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:38:56 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:38:57 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:38:57 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:38:57 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:38:57 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:38:57 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:38:57 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:38:57 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:38:57 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:38:58 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:38:58 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:38:58 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:38:58 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:38:58 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:38:58 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:38:58 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:38:58 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:38:58 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:38:58 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:38:58 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:38:58 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:38:59 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:38:59 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:38:59 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:38:59 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:38:59 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:38:59 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:39:00 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:39:00 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:39:00 T:3880 DEBUG: ------ Window Deinit (DialogSelect.xml) ------ 22:39:00 T:3880 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/ImageLib.dll) 22:39:01 T:3204 DEBUG: Thread JobWorker 3204 terminating (autodelete) 22:39:01 T:3452 DEBUG: Thread JobWorker 3452 terminating (autodelete) 22:39:01 T:3880 INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://www.google.com (easy=00E11560, multi=00000000) 22:39:02 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:39:02 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:39:03 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:03 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:04 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:39:04 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:39:04 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:39:04 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:39:06 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:39:06 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:39:07 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:39:07 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:39:08 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:39:08 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:39:09 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:39:09 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:39:11 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:11 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:11 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:11 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:12 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:12 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:12 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:12 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:12 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:12 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:15 T:3880 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 22:39:15 T:3880 DEBUG: CApplication::OnKey: return (0xf00d) pressed, action is Select 22:39:16 T:3880 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 22:39:16 T:3880 DEBUG: CApplication::OnKey: return (0xf00d) pressed, action is Select 22:39:16 T:3880 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 22:39:16 T:3880 DEBUG: CApplication::OnKey: return (0xf00d) pressed, action is Select 22:39:17 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:17 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:18 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:18 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:18 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:18 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:19 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:19 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:19 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:19 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:19 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:19 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:20 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:20 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:20 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:20 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:21 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:21 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:22 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:39:22 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:39:22 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:22 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:23 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:23 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:24 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:24 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:29 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:39:29 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:39:29 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:29 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:29 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:29 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:34 T:3880 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 22:39:34 T:3880 DEBUG: CApplication::OnKey: return (0xf00d) pressed, action is Select 22:39:34 T:3880 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 22:39:34 T:3880 DEBUG: CApplication::OnKey: return (0xf00d) pressed, action is Select 22:39:35 T:3880 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 22:39:35 T:3880 DEBUG: CApplication::OnKey: return (0xf00d) pressed, action is Select 22:39:39 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:39 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:41 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:39:41 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:39:42 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:42 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:44 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:44 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:44 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:44 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:45 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:39:45 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:39:45 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:39:45 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:39:46 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:39:46 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:39:47 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:39:47 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:39:47 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:39:47 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:39:47 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:39:47 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:39:48 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:39:48 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:39:48 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:39:48 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:39:48 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:39:48 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:39:50 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:39:50 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:39:50 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:39:50 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:39:50 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:39:50 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:39:50 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:39:50 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:39:51 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:39:51 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:39:51 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:39:51 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:39:51 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:39:51 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:39:51 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:39:51 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:39:51 T:3880 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 22:39:51 T:3880 DEBUG: CApplication::OnKey: return (0xf00d) pressed, action is Select 22:39:51 T:3880 DEBUG: Activating window ID: 10035 22:39:52 T:3880 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------ 22:39:52 T:3880 DEBUG: ------ Window Init (SkinSettings.xml) ------ 22:39:52 T:3880 INFO: Loading skin file: SkinSettings.xml, load type: LOAD_EVERY_TIME 22:40:06 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:40:06 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:40:09 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:40:09 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:40:14 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:40:14 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:40:15 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:40:15 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:40:16 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:40:16 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:40:16 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:40:16 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:40:17 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:40:17 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:40:17 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:40:17 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:40:17 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:40:17 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:40:18 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:40:18 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:40:18 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:40:18 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:40:19 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:40:19 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:40:19 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:40:19 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:40:20 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:40:20 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:40:20 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:40:20 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:40:21 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:40:21 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:40:21 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:40:21 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:40:22 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:40:22 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:40:23 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:40:23 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:40:26 T:3500 DEBUG: CAESinkDirectSound::Deinitialize: Cleaning up 22:40:27 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:40:27 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:40:27 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:40:27 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:40:28 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:40:28 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:40:29 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:40:29 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:40:30 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:40:30 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:40:30 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:40:30 T:3880 DEBUG: ------ Window Deinit (SkinSettings.xml) ------ 22:40:31 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 22:40:31 T:3880 DEBUG: ------ Window Init (Home.xml) ------ 22:40:31 T:3880 WARNING: RunScript called for a non-script addon 'script.grab.fanart'. This behaviour is deprecated. 22:40:31 T:2724 NOTICE: Thread LanguageInvoker start, auto delete: false 22:40:31 T:2724 INFO: initializing python engine. 22:40:31 T:3980 NOTICE: Thread JobWorker start, auto delete: true 22:40:31 T:2724 DEBUG: CPythonInvoker(12, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart\default.py): start processing 22:40:31 T:3980 INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://www.google.com 22:40:32 T:2724 NOTICE: -->Python Interpreter Initialized<-- 22:40:32 T:2724 DEBUG: CPythonInvoker(12, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart\default.py): the source file to load is "C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart\default.py" 22:40:32 T:2724 DEBUG: CPythonInvoker(12, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart\default.py): setting the Python path to C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart;C:\Program Files (x86)\Kodi\system\python\DLLs;C:\Program Files (x86)\Kodi\system\python\Lib;C:\Program Files (x86)\Kodi\python27.zip;C:\Program Files (x86)\Kodi\system\python\lib\plat-win;C:\Program Files (x86)\Kodi\system\python\lib\lib-tk;C:\Program Files (x86)\Kodi;C:\Program Files (x86)\Kodi\system\python;C:\Program Files (x86)\Kodi\system\python\lib\site-packages 22:40:32 T:2724 DEBUG: CPythonInvoker(12, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart\default.py): entering source directory C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart 22:40:32 T:2724 DEBUG: CPythonInvoker(12, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart\default.py): instantiating addon using automatically obtained id of "script.grab.fanart" dependent on version 2.1.0 of the xbmc.python api 22:40:32 T:2724 DEBUG: script.grab.fanart: updating settings 22:40:32 T:2724 NOTICE: script.grab.fanart: mode 22:40:32 T:2724 NOTICE: script.grab.fanart: refresh 22:40:32 T:2724 INFO: CPythonInvoker(12, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart\default.py): script successfully run 22:40:32 T:2724 INFO: Python script stopped 22:40:32 T:2724 DEBUG: Thread LanguageInvoker 2724 terminating 22:40:35 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:40:35 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:40:35 T:3880 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib.dll) 22:40:35 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:40:35 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:40:35 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:40:35 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:40:36 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:40:36 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:40:36 T:3644 NOTICE: Thread JobWorker start, auto delete: true 22:40:36 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:40:36 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:40:37 T:3880 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 22:40:37 T:3880 DEBUG: CApplication::OnKey: return (0xf00d) pressed, action is Select 22:40:37 T:3880 DEBUG: Activating window ID: 10025 22:40:37 T:3880 DEBUG: ------ Window Deinit (Home.xml) ------ 22:40:37 T:3880 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 22:40:37 T:3880 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 22:40:38 T:3880 DEBUG: CGUIMediaWindow::GetDirectory (videodb://movies/titles/) 22:40:38 T:3880 DEBUG: ParentPath = [videodb://movies/titles/] 22:40:38 T:3880 DEBUG: CVideoDatabase::RunQuery took 14 ms for 295 items query: select * from movieview 22:40:38 T:1204 NOTICE: Thread BackgroundLoader start, auto delete: false 22:40:39 T:1152 NOTICE: Thread JobWorker start, auto delete: true 22:40:39 T:1152 DEBUG: CTextureCacheJob::GetImageHash - unable to stat url 22:40:39 T:3772 NOTICE: Thread JobWorker start, auto delete: true 22:40:39 T:1204 DEBUG: Thread BackgroundLoader 1204 terminating 22:40:40 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:40:40 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:40:40 T:3980 DEBUG: CTextureCacheJob::GetImageHash - unable to stat url 22:40:41 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:40:41 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:40:41 T:3644 DEBUG: CTextureCacheJob::GetImageHash - unable to stat url 22:40:41 T:3880 DEBUG: Keyboard: scancode: 0x50, sym: 0x0112, unicode: 0x0000, modifier: 0x0 22:40:41 T:3880 DEBUG: CApplication::OnKey: down (0xf081) pressed, action is Down 22:40:41 T:3980 DEBUG: CTextureCacheJob::GetImageHash - unable to stat url 22:40:41 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:40:41 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:40:41 T:3980 DEBUG: CTextureCacheJob::GetImageHash - unable to stat url 22:40:42 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:40:42 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:40:42 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:40:42 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:40:42 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:40:42 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:40:42 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:40:42 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:40:42 T:3980 DEBUG: CTextureCacheJob::GetImageHash - unable to stat url 22:40:43 T:3880 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 22:40:43 T:3880 DEBUG: CApplication::OnKey: return (0xf00d) pressed, action is Select 22:40:43 T:3880 INFO: Loading skin file: DialogContextMenu.xml, load type: KEEP_IN_MEMORY 22:40:43 T:3880 DEBUG: ------ Window Init (DialogContextMenu.xml) ------ 22:40:44 T:3880 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 22:40:44 T:3880 DEBUG: CApplication::OnKey: return (0xf00d) pressed, action is Select 22:40:45 T:3880 DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------ 22:40:45 T:3880 DEBUG: CGUIWindowVideoBase::OnPlayMedia smb://192.168.178.1/FRITZ.NAS/TOSHIBA-ExternalUSB3-0-01/Filme/White House Down 2013/White.House.Down.2013.German.DTSD.5.1.DL.1080p.BluRay.x264-DerSchuft.mkv 22:40:45 T:3880 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 22:40:45 T:3880 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 22:40:45 T:3880 DEBUG: CZipManager::GetZipList - Processing zip://C%3a%5cUsers%5cKodi%5cAppData%5cRoaming%5cKodi%5ccache%5cskin.aeonmq5.helixmod.zip/ 22:40:45 T:3880 DEBUG: Loading settings for smb://192.168.178.1/FRITZ.NAS/TOSHIBA-ExternalUSB3-0-01/Filme/White House Down 2013/White.House.Down.2013.German.DTSD.5.1.DL.1080p.BluRay.x264-DerSchuft.mkv 22:40:45 T:3880 DEBUG: CPlayerCoreFactory::GetPlayers(smb://192.168.178.1/FRITZ.NAS/TOSHIBA-ExternalUSB3-0-01/Filme/White House Down 2013/White.House.Down.2013.German.DTSD.5.1.DL.1080p.BluRay.x264-DerSchuft.mkv) 22:40:45 T:3880 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: un-named 22:40:45 T:3880 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: un-named 22:40:45 T:3880 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: un-named 22:40:45 T:3880 DEBUG: Previous line repeats 1 times. 22:40:45 T:3880 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: F:\\.* 22:40:45 T:3880 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 22:40:45 T:3880 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 22:40:45 T:3880 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv 22:40:45 T:3880 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp 22:40:45 T:3880 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 22:40:45 T:3880 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 22:40:45 T:3880 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 22:40:45 T:3880 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 22:40:45 T:3880 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 22:40:45 T:3880 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 22:40:45 T:3880 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 22:40:45 T:3880 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 22:40:45 T:3880 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 22:40:45 T:3880 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 22:40:45 T:3880 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1) 22:40:45 T:3880 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 22:40:45 T:3880 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: ISO_Player (4) 22:40:45 T:3880 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: BDMV_Player (5) 22:40:45 T:3880 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: Disc_Player (6) 22:40:45 T:3880 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 22:40:45 T:3880 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1) 22:40:45 T:3880 DEBUG: CPlayerCoreFactory::GetPlayers: added 4 players 22:40:45 T:3880 NOTICE: DVDPlayer: Opening: smb://192.168.178.1/FRITZ.NAS/TOSHIBA-ExternalUSB3-0-01/Filme/White House Down 2013/White.House.Down.2013.German.DTSD.5.1.DL.1080p.BluRay.x264-DerSchuft.mkv 22:40:45 T:3880 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 22:40:45 T:3880 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec 22:40:45 T:3880 NOTICE: DXVA::CProcessorHD::PreInit - The Direct3d device doesn't support DXVA-HD. 22:40:45 T:3880 NOTICE: CWinRenderer::Preinit - could not init DXVA-HD processor - skipping 22:40:45 T:3880 DEBUG: DXVA - checking samples array size using 842094158 render target 22:40:45 T:3880 DEBUG: DXVA - updated maximum samples count to 2 22:40:45 T:3880 DEBUG: DXVA - checking samples array size using 842094169 render target 22:40:45 T:3948 NOTICE: Thread DVDPlayer start, auto delete: false 22:40:45 T:3948 NOTICE: Creating InputStream 22:40:45 T:3948 DEBUG: CUtil::ScanForExternalSubtitles: Searching for subtitles... 22:40:45 T:3948 INFO: CUtil::ScanForExternalSubtitles: found subtitle file smb://192.168.178.1/FRITZ.NAS/TOSHIBA-ExternalUSB3-0-01/Filme/White House Down 2013/White.House.Down.2013.German.DTSD.5.1.DL.1080p.BluRay.x264-DerSchuft.en.srt 22:40:45 T:3948 DEBUG: CUtil::ScanForExternalSubtitles: END (total time: 320 ms) 22:40:45 T:3948 DEBUG: CUtil::GetExternalStreamDetailsFromFilename - Language = 'eng' / Name = '(Extern)' / Flag = '0' from smb://192.168.178.1/FRITZ.NAS/TOSHIBA-ExternalUSB3-0-01/Filme/White House Down 2013/White.House.Down.2013.German.DTSD.5.1.DL.1080p.BluRay.x264-DerSchuft.en.srt 22:40:45 T:3948 NOTICE: Creating Demuxer 22:40:45 T:3948 DEBUG: CDVDDemuxFFmpeg::Open - probing detected format [matroska,webm] 22:40:45 T:3948 DEBUG: CDVDDemuxFFmpeg::Open - avformat_find_stream_info starting 22:40:45 T:3948 DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished 22:40:45 T:3948 INFO: ffmpeg[F6C]: Input #0, matroska,webm, from 'smb://192.168.178.1/FRITZ.NAS/TOSHIBA-ExternalUSB3-0-01/Filme/White House Down 2013/White.House.Down.2013.German.DTSD.5.1.DL.1080p.BluRay.x264-DerSchuft.mkv': 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : DerSchuft 22:40:45 T:3948 INFO: ffmpeg[F6C]: encoder : libebml v0.8.0 + libmatroska v0.9.0 22:40:45 T:3948 INFO: ffmpeg[F6C]: creation_time : 2013-10-31 17:46:44 22:40:45 T:3948 INFO: ffmpeg[F6C]: Duration: 02:11:32.92, start: 0.000000, bitrate: 12388 kb/s 22:40:45 T:3948 INFO: ffmpeg[F6C]: Chapter #0.0: start 0.000000, end 399.774000 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : 00:00:00.000 22:40:45 T:3948 INFO: ffmpeg[F6C]: Chapter #0.1: start 399.774000, end 918.835000 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : 00:06:39.774 22:40:45 T:3948 INFO: ffmpeg[F6C]: Chapter #0.2: start 918.835000, end 1297.838000 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : 00:15:18.835 22:40:45 T:3948 INFO: ffmpeg[F6C]: Chapter #0.3: start 1297.838000, end 1810.809000 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : 00:21:37.838 22:40:45 T:3948 INFO: ffmpeg[F6C]: Chapter #0.4: start 1810.809000, end 2267.348000 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : 00:30:10.809 22:40:45 T:3880 DEBUG: ------ Window Init (DialogBusy.xml) ------ 22:40:45 T:3948 INFO: ffmpeg[F6C]: Chapter #0.5: start 2267.348000, end 2751.207000 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : 00:37:47.348 22:40:45 T:3948 INFO: ffmpeg[F6C]: Chapter #0.6: start 2751.207000, end 3072.278000 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : 00:45:51.207 22:40:45 T:3948 INFO: ffmpeg[F6C]: Chapter #0.7: start 3072.278000, end 3595.133000 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : 00:51:12.278 22:40:45 T:3948 INFO: ffmpeg[F6C]: Chapter #0.8: start 3595.133000, end 4028.942000 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : 00:59:55.133 22:40:45 T:3948 INFO: ffmpeg[F6C]: Chapter #0.9: start 4028.942000, end 4482.853000 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : 01:07:08.942 22:40:45 T:3948 INFO: ffmpeg[F6C]: Chapter #0.10: start 4482.853000, end 5053.590000 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : 01:14:42.853 22:40:45 T:3948 INFO: ffmpeg[F6C]: Chapter #0.11: start 5053.590000, end 5393.805000 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : 01:24:13.590 22:40:45 T:3948 INFO: ffmpeg[F6C]: Chapter #0.12: start 5393.805000, end 5847.717000 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : 01:29:53.805 22:40:45 T:3948 INFO: ffmpeg[F6C]: Chapter #0.13: start 5847.717000, end 6276.562000 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : 01:37:27.717 22:40:45 T:3948 INFO: ffmpeg[F6C]: Chapter #0.14: start 6276.562000, end 6857.851000 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : 01:44:36.562 22:40:45 T:3948 INFO: ffmpeg[F6C]: Chapter #0.15: start 6857.851000, end 7892.921000 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : 01:54:17.851 22:40:45 T:3948 INFO: ffmpeg[F6C]: Stream #0:0(eng): Video: h264 (High), yuv420p, 1920x800, SAR 1:1 DAR 12:5, 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc (default) (forced) 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : 1080p DerSchuft 22:40:45 T:3948 INFO: ffmpeg[F6C]: Stream #0:1(ger): Audio: dts (DTS), 48000 Hz, 5.1(side), fltp, 1536 kb/s (default) (forced) 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : DTS 5.1 dubbed by DerSchuft 22:40:45 T:3948 INFO: ffmpeg[F6C]: Stream #0:2(eng): Audio: dts (DTS), 48000 Hz, 5.1(side), fltp, 1536 kb/s 22:40:45 T:3948 INFO: ffmpeg[F6C]: Metadata: 22:40:45 T:3948 INFO: ffmpeg[F6C]: title : DTS 5.1 22:40:45 T:3948 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 22:40:45 T:3948 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 22:40:45 T:3948 DEBUG: CDVDDemuxFFmpeg::AddStream(2, ...) -> 2 22:40:45 T:3948 NOTICE: Opening stream: 0 source: 256 22:40:45 T:3948 NOTICE: Creating video codec with codec id: 28 22:40:45 T:3948 DEBUG: CDVDFactoryCodec: compiled in hardware support: AMCodec:no MediaCodec:no DXVA:yes iMXVPU:no 22:40:45 T:3948 DEBUG: FactoryCodec - Video: - Opening 22:40:45 T:3948 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 22:40:45 T:3948 DEBUG: FactoryCodec - Video: ff-h264 - Opened 22:40:45 T:3948 NOTICE: Creating video thread 22:40:45 T:3948 NOTICE: Opening stream: 1 source: 256 22:40:45 T:188 NOTICE: Thread DVDPlayerVideo start, auto delete: false 22:40:45 T:3948 NOTICE: Finding audio codec for: 86020 22:40:45 T:188 NOTICE: running thread: video_thread 22:40:45 T:3948 DEBUG: FactoryCodec - Audio: passthrough - Opening 22:40:45 T:3948 DEBUG: FactoryCodec - Audio: passthrough - Failed 22:40:45 T:3948 DEBUG: FactoryCodec - Audio: FFmpeg - Opening 22:40:45 T:3948 DEBUG: FactoryCodec - Audio: FFmpeg - Opened 22:40:45 T:3948 NOTICE: Creating audio thread 22:40:45 T:188 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 22:40:45 T:3948 NOTICE: Opening stream: 0 source: 1024 22:40:45 T:2292 NOTICE: Thread DVDPlayerAudio start, auto delete: false 22:40:45 T:2292 NOTICE: running thread: CDVDPlayerAudio::Process() 22:40:45 T:2292 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 22:40:46 T:3948 DEBUG: CEdl::ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: smb://192.168.178.1/FRITZ.NAS/TOSHIBA-ExternalUSB3-0-01/Filme/White House Down 2013/White.House.Down.2013.German.DTSD.5.1.DL.1080p.BluRay.x264-DerSchuft.mkv 22:40:46 T:3948 DEBUG: CDVDPlayer::Process - Start position set to last stopped position: 1858000 22:40:46 T:3948 DEBUG: CDVDDemuxFFmpeg::SeekTime - seek ended up on time 1862442 22:40:46 T:3948 DEBUG: CDVDPlayer::Process - starting demuxer from: 1858000 22:40:46 T:3948 DEBUG: CApplication::OnPlayBackStarted: play state was 1, starting 1 22:40:46 T:3948 DEBUG: CDVDPlayer::SetCaching - caching state 3 22:40:46 T:3880 DEBUG: CApplication::PlayFile: OpenFile succeed, play state 2 22:40:46 T:3880 DEBUG: CApplication::OnPlayBackStarted: play state was 2, starting 0 22:40:46 T:3880 DEBUG: CGUIInfoManager::SetCurrentMovie(smb://192.168.178.1/FRITZ.NAS/TOSHIBA-ExternalUSB3-0-01/Filme/White House Down 2013/White.House.Down.2013.German.DTSD.5.1.DL.1080p.BluRay.x264-DerSchuft.mkv) 22:40:46 T:3880 DEBUG: CVideoDatabase::GetMovieId (smb://192.168.178.1/FRITZ.NAS/TOSHIBA-ExternalUSB3-0-01/Filme/White House Down 2013/White.House.Down.2013.German.DTSD.5.1.DL.1080p.BluRay.x264-DerSchuft.mkv), query = select idMovie from movie where idFile=283 22:40:46 T:3880 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 22:40:46 T:3880 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 22:40:46 T:188 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(1862442000.000000, 1) 22:40:46 T:188 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 22:40:46 T:188 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1920x800) 22:40:46 T:2292 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(1862464000.000000, 1) 22:40:46 T:188 DEBUG: DXVA - open decoder 22:40:46 T:2292 NOTICE: Creating audio stream (codec id: 86020, channels: 6, sample rate: 48000, no pass-through) 22:40:46 T:2292 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback 22:40:46 T:3500 INFO: CActiveAESink::OpenSink - initialize sink 22:40:46 T:3500 DEBUG: CActiveAESink::OpenSink - trying to open device DIRECTSOUND:{80733A18-CDD4-4827-8E6D-F12CB2524E64} 22:40:46 T:3500 DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 328182 22:40:46 T:3500 DEBUG: CAESinkDirectSound::Initialize: secondary buffer created 22:40:46 T:3500 DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters: 22:40:46 T:3500 DEBUG: Audio Device : Digitalaudio (HDMI) (2- High Definition Audio-Gerät) 22:40:46 T:188 DEBUG: DXVA - supports 'MPEG2 IDCT' 22:40:46 T:3500 DEBUG: Sample Rate : 48000 22:40:46 T:188 DEBUG: DXVA - supports 'H.264 VLD, no FGT' 22:40:46 T:3500 DEBUG: Sample Format : AE_FMT_FLOAT 22:40:46 T:188 DEBUG: DXVA - supports 4245F676-2bbc-4166-a0bb-54e7b849c380 22:40:46 T:3500 DEBUG: Bits Per Sample : 32 22:40:46 T:188 DEBUG: DXVA - supports 6719B6FB-5cad-4acb-b00a-f3bfdec38727 22:40:46 T:3500 DEBUG: Valid Bits/Samp : 32 22:40:46 T:188 DEBUG: DXVA - supports 'VC-1 VLD' 22:40:46 T:3500 DEBUG: Channel Count : 2 22:40:46 T:188 DEBUG: DXVA - supports CA15D19A-2b48-43d6-979e-7a6e9c802ff8 22:40:46 T:3500 DEBUG: Block Align : 8 22:40:46 T:188 DEBUG: DXVA - trying 'H.264 VLD, no FGT' 22:40:46 T:3500 DEBUG: Avg. Bytes Sec : 384000 22:40:46 T:3500 DEBUG: Samples/Block : 32 22:40:46 T:3500 DEBUG: Format cBSize : 22 22:40:46 T:3500 DEBUG: Channel Layout : FL,FR 22:40:46 T:3500 DEBUG: Channel Mask : 3 22:40:46 T:3500 DEBUG: Frames : 720 22:40:46 T:3500 DEBUG: Frame Samples : 1440 22:40:46 T:3500 DEBUG: Frame Size : 8 22:40:46 T:3500 DEBUG: CActiveAESink::OpenSink - DIRECTSOUND Initialized: 22:40:46 T:3500 DEBUG: Output Device : HDMI - Digitalaudio (HDMI) (2- High Definition Audio-Gerät) 22:40:46 T:3500 DEBUG: Sample Rate : 48000 22:40:46 T:3500 DEBUG: Sample Format : AE_FMT_FLOAT 22:40:46 T:3500 DEBUG: Channel Count : 2 22:40:46 T:3500 DEBUG: Channel Layout: FL,FR 22:40:46 T:3500 DEBUG: Frames : 720 22:40:46 T:3500 DEBUG: Frame Samples : 1440 22:40:46 T:3500 DEBUG: Frame Size : 8 22:40:46 T:632 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 22:40:46 T:3948 DEBUG: Previous line repeats 1 times. 22:40:46 T:3948 DEBUG: CDVDPlayer::HandleMessages - player started 1 22:40:46 T:188 DEBUG: DXVA - source requires 5 references 22:40:46 T:188 DEBUG: DXVA - config 0: bitstream type 2 22:40:46 T:188 DEBUG: DXVA - config 1: bitstream type 2 22:40:46 T:188 DEBUG: DXVA - config 2: bitstream type 2, encrypted 22:40:46 T:188 DEBUG: DXVA - allocating 15 surfaces 22:40:46 T:188 NOTICE: DXVA::CDXVAContext::CreateDecoder - hw may not support multiple decoders, releasing existing ones 22:40:46 T:3500 DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback 22:40:46 T:188 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1920x800) 22:40:46 T:188 DEBUG: DXVA - open decoder 22:40:46 T:188 DEBUG: DXVA - trying 'H.264 VLD, no FGT' 22:40:46 T:188 DEBUG: DXVA - source requires 5 references 22:40:46 T:188 DEBUG: DXVA - config 0: bitstream type 2 22:40:46 T:188 DEBUG: DXVA - config 1: bitstream type 2 22:40:46 T:188 DEBUG: DXVA - config 2: bitstream type 2, encrypted 22:40:46 T:3880 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 22:40:46 T:188 DEBUG: DXVA - allocating 15 surfaces 22:40:46 T:188 NOTICE: DXVA::CDXVAContext::CreateDecoder - hw may not support multiple decoders, releasing existing ones 22:40:46 T:3880 DEBUG: ------ Window Init (VideoOverlay.xml) ------ 22:40:46 T:3880 INFO: Loading skin file: VideoOverlay.xml, load type: KEEP_IN_MEMORY 22:40:46 T:188 INFO: ffmpeg[BC]: [h264] Cannot parallelize slice decoding with deblocking filter type 1, decoding such frames in sequential order 22:40:46 T:188 INFO: ffmpeg[BC]: [h264] To parallelize slice decoding you need video encoded with disable_deblocking_filter_idc set to 2 (deblock only edges that do not cross slices). 22:40:46 T:188 INFO: ffmpeg[BC]: [h264] Setting the flags2 libavcodec option to +fast (-flags2 +fast) will disable deblocking across slices and enable parallel slice decoding but will generate non-standard-compliant output. 22:40:46 T:188 DEBUG: DXVA::CDecoder::~CDecoder - destructing decoder, 275429720 22:40:46 T:188 DEBUG: DXVA::CSurfaceContext::~CSurfaceContext - destructing surface context 22:40:46 T:188 NOTICE: DXVA::CDecoder::Close - closing decoder 22:40:46 T:188 NOTICE: fps: 23.976024, pwidth: 1920, pheight: 800, dwidth: 1920, dheight: 800 22:40:46 T:188 DEBUG: CDVDPlayerVideo::OutputPicture - change configuration. 1920x800. framerate: 23.98. format: DXVA 22:40:46 T:188 NOTICE: Display resolution DESKTOP : 1920x1080@ 60.00 - Full Screen (16) 22:40:46 T:188 NOTICE: D3D: rendering method forced to DXVA processor 22:40:46 T:188 DEBUG: DXVA - processor found Vector Adaptative Device 22:40:46 T:188 DEBUG: DXVA - processor found Motion Adaptative Device 22:40:46 T:188 DEBUG: DXVA - processor found Adaptative Device 22:40:46 T:188 DEBUG: DXVA - processor found Bob Device 22:40:46 T:188 DEBUG: DXVA - processor found Progressive Device 22:40:46 T:188 DEBUG: DXVA - processor selected Bob Device 22:40:46 T:188 DEBUG: DXVA - processor requires 0 past frames and 0 future frames 22:40:46 T:188 DEBUG: CWinRenderer::SelectRenderMethod: Selected render method 3: DXVA 22:40:46 T:188 DEBUG: CXBMCRenderManager::Configure - 5 22:40:46 T:3880 DEBUG: created video buffer 0 22:40:46 T:3880 DEBUG: created video buffer 1 22:40:46 T:3880 DEBUG: created video buffer 2 22:40:46 T:3880 DEBUG: created video buffer 3 22:40:46 T:3880 DEBUG: created video buffer 4 22:40:46 T:3880 WARNING: CWinRenderer::UpdateVideoFilter - chosen scaling method 1 is not supported by renderer 22:40:46 T:3880 DEBUG: CWinRenderer::CreateIntermediateRenderTarget: format 22 22:40:46 T:3948 DEBUG: CDVDPlayer::HandleMessages - player started 2 22:40:46 T:3948 DEBUG: CDVDPlayer::SetCaching - caching state 0 22:40:46 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError1 - was:1862464251.241258, should be:1862474666.666667, error:10415.425409 22:40:46 T:3880 DEBUG: Activating window ID: 12005 22:40:46 T:3880 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 22:40:46 T:3880 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 22:40:46 T:3880 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY 22:40:46 T:3880 DEBUG: ------ Window Deinit (VideoOverlay.xml) ------ 22:40:46 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError1 - was:1862585041.668930, should be:1862474666.666667, error:-110375.002263 22:40:47 T:1876 DEBUG: CMMNotificationClient::OnPropertyValueChanged: Changed device property of {0.0.0.00000000}.{80733a18-cdd4-4827-8e6d-f12cb2524e64} is {9855c4cd-df8c-449c-a181-8191b68bd06c}#0 22:40:48 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:1864485737.738869, should be:1864428609.177733, error:-57128.561136 22:40:49 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:49 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:49 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:49 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:50 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:50 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:50 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:50 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:50 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:50 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:50 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:50 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:50 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:50 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:50 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:50 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:50 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:50 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:50 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:50 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:50 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:50 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:50 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:50 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:50 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:50 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:50 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:50 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:50 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:50 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:50 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:50 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:50 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:50 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:50 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:50 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:50 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:50 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:50 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:50 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:50 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:50 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:50 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:50 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:50 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:50 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:50 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:50 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:50 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:50 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:50 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:50 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:50 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:50 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:50 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:50 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:50 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:50 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:50 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:50 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:51 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:51 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:51 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:51 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:51 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:51 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:51 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:51 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:51 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:51 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:51 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:51 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:51 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:51 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:51 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:51 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:51 T:188 DEBUG: CPullupCorrection: detected pattern of length 1: 41708.33, frameduration: 41708.333333 22:40:51 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:51 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:51 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:51 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:52 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:52 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:52 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:52 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:52 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:52 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:52 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:52 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:52 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:52 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:52 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:52 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:52 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:52 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:52 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:52 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:52 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:52 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:52 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:52 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:52 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:52 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:52 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:52 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:53 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:53 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:53 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:53 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:53 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:53 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:53 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:53 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:53 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:53 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:53 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:53 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:53 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:53 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:53 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:53 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:53 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:53 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:53 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:53 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:53 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:53 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:53 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:53 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:54 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:54 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:54 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:54 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:54 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:40:54 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:40:54 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:54 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:55 T:1876 DEBUG: CMMNotificationClient::OnPropertyValueChanged: Changed device property of {0.0.0.00000000}.{80733a18-cdd4-4827-8e6d-f12cb2524e64} is {9855c4cd-df8c-449c-a181-8191b68bd06c}#0 22:40:55 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 10 22:40:55 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 10 22:40:55 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:40:55 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:40:56 T:1876 DEBUG: CMMNotificationClient::OnPropertyValueChanged: Changed device property of {0.0.0.00000000}.{80733a18-cdd4-4827-8e6d-f12cb2524e64} is {9855c4cd-df8c-449c-a181-8191b68bd06c}#0 22:41:01 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:41:01 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:41:01 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:41:01 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:41:01 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:41:01 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:41:01 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:41:01 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:41:01 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:41:01 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:41:01 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:41:01 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:41:02 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:41:02 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:41:02 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:41:02 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:41:02 T:3880 INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://www.google.com (easy=00E11560, multi=00000000) 22:41:02 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:41:02 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:41:02 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:41:02 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:41:02 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 9 22:41:02 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 9 22:41:02 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:41:02 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:41:02 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 10 22:41:02 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 10 22:41:02 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:41:02 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:41:02 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 10 22:41:02 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 10 22:41:02 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:41:02 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:41:03 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 10 22:41:03 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 10 22:41:03 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:41:03 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:41:03 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 10 22:41:03 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 10 22:41:03 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:41:03 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:41:03 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 10 22:41:03 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 10 22:41:03 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:41:03 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:41:03 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 10 22:41:03 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 10 22:41:03 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:41:03 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:41:04 T:1876 DEBUG: CMMNotificationClient::OnPropertyValueChanged: Changed device property of {0.0.0.00000000}.{80733a18-cdd4-4827-8e6d-f12cb2524e64} is {9855c4cd-df8c-449c-a181-8191b68bd06c}#0 22:41:04 T:3880 DEBUG: WinEventsWin32.cpp: APPCOMMAND 10 22:41:04 T:3880 DEBUG: CApplication::OnAppCommand: unknown appcommand 10 22:41:04 T:3880 DEBUG: Keyboard: scancode: 0x00, sym: 0x0000, unicode: 0x0000, modifier: 0x0 22:41:04 T:3880 DEBUG: CApplication::OnKey: 0 (0xf200) pressed, action is 22:41:05 T:1876 DEBUG: CMMNotificationClient::OnPropertyValueChanged: Changed device property of {0.0.0.00000000}.{80733a18-cdd4-4827-8e6d-f12cb2524e64} is {9855c4cd-df8c-449c-a181-8191b68bd06c}#0 22:41:12 T:1152 DEBUG: Thread JobWorker 1152 terminating (autodelete) 22:41:12 T:3644 DEBUG: Thread JobWorker 3644 terminating (autodelete) 22:41:12 T:3980 DEBUG: Thread JobWorker 3980 terminating (autodelete) 22:41:12 T:3772 DEBUG: Thread JobWorker 3772 terminating (autodelete) 22:41:33 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:41:33 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is StepForward 22:41:33 T:3948 DEBUG: CDVDPlayer::SetCaching - caching state 3 22:41:33 T:3948 DEBUG: demuxer seek to: 1939604 22:41:33 T:3948 DEBUG: CDVDDemuxFFmpeg::SeekTime - seek ended up on time 1948820 22:41:33 T:3948 DEBUG: demuxer seek to: 1939604, success 22:41:34 T:3880 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 22:41:34 T:3880 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 22:41:34 T:3880 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 22:41:34 T:188 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 22:41:34 T:2292 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 22:41:34 T:188 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(1948820000.000000, 1) 22:41:34 T:188 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 22:41:34 T:188 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1920x800) 22:41:34 T:2292 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(1948875000.000000, 1) 22:41:34 T:188 DEBUG: DXVA - open decoder 22:41:34 T:188 DEBUG: DXVA - trying 'H.264 VLD, no FGT' 22:41:34 T:188 DEBUG: DXVA - source requires 5 references 22:41:34 T:188 DEBUG: DXVA - config 0: bitstream type 2 22:41:34 T:188 DEBUG: DXVA - config 1: bitstream type 2 22:41:34 T:188 DEBUG: DXVA - config 2: bitstream type 2, encrypted 22:41:34 T:188 DEBUG: DXVA - allocating 15 surfaces 22:41:34 T:188 NOTICE: DXVA::CDXVAContext::CreateDecoder - hw may not support multiple decoders, releasing existing ones 22:41:34 T:3948 DEBUG: CDVDPlayer::HandleMessages - player started 1 22:41:34 T:188 DEBUG: DXVA::CDecoder::~CDecoder - destructing decoder, 275429944 22:41:34 T:188 NOTICE: DXVA::CDecoder::Close - closing decoder 22:41:34 T:3948 DEBUG: CDVDPlayer::HandleMessages - player started 2 22:41:34 T:3948 DEBUG: CDVDPlayer::SetCaching - caching state 0 22:41:34 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError1 - was:1948722594.548449, should be:1948797547.276144, error:74952.727695 22:41:34 T:2292 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available 22:41:34 T:3880 WARNING: Previous line repeats 2 times. 22:41:34 T:3880 DEBUG: DXVA::CSurfaceContext::~CSurfaceContext - destructing surface context 22:41:34 T:2292 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available 22:41:36 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:1950800625.804397, should be:1950731566.500788, error:-69059.303609 22:41:36 T:3880 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 22:41:38 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:1952741653.453303, should be:1952718396.309552, error:-23257.143751 22:41:39 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:41:39 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is StepForward 22:41:39 T:3948 DEBUG: CDVDPlayer::SetCaching - caching state 3 22:41:39 T:3948 DEBUG: demuxer seek to: 1983575 22:41:39 T:3948 DEBUG: CDVDDemuxFFmpeg::SeekTime - seek ended up on time 1984106 22:41:39 T:3948 DEBUG: demuxer seek to: 1983575, success 22:41:39 T:3880 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 22:41:39 T:3880 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 22:41:39 T:3880 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 22:41:39 T:188 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 22:41:39 T:2292 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 22:41:39 T:188 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(1984106000.000000, 1) 22:41:39 T:188 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 22:41:39 T:188 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1920x800) 22:41:39 T:188 DEBUG: DXVA - open decoder 22:41:39 T:2292 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(1984160000.000000, 1) 22:41:39 T:188 DEBUG: DXVA - trying 'H.264 VLD, no FGT' 22:41:39 T:188 DEBUG: DXVA - source requires 5 references 22:41:39 T:188 DEBUG: DXVA - config 0: bitstream type 2 22:41:39 T:188 DEBUG: DXVA - config 1: bitstream type 2 22:41:39 T:188 DEBUG: DXVA - config 2: bitstream type 2, encrypted 22:41:39 T:188 DEBUG: DXVA - allocating 15 surfaces 22:41:39 T:188 NOTICE: DXVA::CDXVAContext::CreateDecoder - hw may not support multiple decoders, releasing existing ones 22:41:39 T:3948 DEBUG: CDVDPlayer::HandleMessages - player started 1 22:41:39 T:188 DEBUG: DXVA::CDecoder::~CDecoder - destructing decoder, 237889224 22:41:39 T:188 NOTICE: DXVA::CDecoder::Close - closing decoder 22:41:39 T:3948 DEBUG: CDVDPlayer::HandleMessages - player started 2 22:41:39 T:3948 DEBUG: CDVDPlayer::SetCaching - caching state 0 22:41:39 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError1 - was:1984004060.866177, should be:1984041631.308357, error:37570.442179 22:41:39 T:188 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available 22:41:39 T:2292 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available 22:41:39 T:3880 WARNING: Previous line repeats 5 times. 22:41:39 T:3880 DEBUG: DXVA::CSurfaceContext::~CSurfaceContext - destructing surface context 22:41:40 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:41:40 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is StepForward 22:41:40 T:3948 DEBUG: CDVDPlayer::SetCaching - caching state 3 22:41:40 T:3948 DEBUG: demuxer seek to: 2015097 22:41:40 T:3948 DEBUG: CDVDDemuxFFmpeg::SeekTime - seek ended up on time 2016429 22:41:40 T:3948 DEBUG: demuxer seek to: 2015097, success 22:41:40 T:3880 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 22:41:40 T:3880 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 22:41:40 T:188 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 22:41:40 T:2292 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 22:41:40 T:188 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(2016429000.000000, 1) 22:41:40 T:188 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 22:41:40 T:188 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1920x800) 22:41:40 T:188 DEBUG: DXVA - open decoder 22:41:40 T:2292 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(2016448000.000000, 1) 22:41:40 T:188 DEBUG: DXVA - trying 'H.264 VLD, no FGT' 22:41:40 T:188 DEBUG: DXVA - source requires 5 references 22:41:40 T:188 DEBUG: DXVA - config 0: bitstream type 2 22:41:40 T:3948 DEBUG: CDVDPlayer::HandleMessages - player started 1 22:41:40 T:188 DEBUG: DXVA - config 1: bitstream type 2 22:41:40 T:188 DEBUG: DXVA - config 2: bitstream type 2, encrypted 22:41:40 T:188 DEBUG: DXVA - allocating 15 surfaces 22:41:40 T:188 NOTICE: DXVA::CDXVAContext::CreateDecoder - hw may not support multiple decoders, releasing existing ones 22:41:40 T:188 DEBUG: DXVA::CDecoder::~CDecoder - destructing decoder, 237889448 22:41:40 T:188 NOTICE: DXVA::CDecoder::Close - closing decoder 22:41:40 T:3948 DEBUG: CDVDPlayer::HandleMessages - player started 2 22:41:40 T:3948 DEBUG: CDVDPlayer::SetCaching - caching state 0 22:41:40 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError1 - was:2016301320.467539, should be:2016341005.615066, error:39685.147527 22:41:40 T:2292 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available 22:41:40 T:3880 WARNING: Previous line repeats 3 times. 22:41:40 T:3880 DEBUG: DXVA::CSurfaceContext::~CSurfaceContext - destructing surface context 22:41:41 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:41:41 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is StepForward 22:41:41 T:3948 DEBUG: CDVDPlayer::SetCaching - caching state 3 22:41:41 T:3948 DEBUG: demuxer seek to: 2047004 22:41:41 T:3948 DEBUG: CDVDDemuxFFmpeg::SeekTime - seek ended up on time 2048043 22:41:41 T:3948 DEBUG: demuxer seek to: 2047004, success 22:41:41 T:3880 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 22:41:41 T:3880 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 22:41:41 T:188 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 22:41:41 T:2292 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 22:41:41 T:188 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(2048044000.000000, 1) 22:41:41 T:188 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 22:41:41 T:188 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1920x800) 22:41:41 T:188 DEBUG: DXVA - open decoder 22:41:41 T:188 DEBUG: DXVA - trying 'H.264 VLD, no FGT' 22:41:41 T:2292 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(2048096000.000000, 1) 22:41:41 T:188 DEBUG: DXVA - source requires 5 references 22:41:41 T:188 DEBUG: DXVA - config 0: bitstream type 2 22:41:41 T:188 DEBUG: DXVA - config 1: bitstream type 2 22:41:41 T:188 DEBUG: DXVA - config 2: bitstream type 2, encrypted 22:41:41 T:3948 DEBUG: CDVDPlayer::HandleMessages - player started 1 22:41:41 T:188 DEBUG: DXVA - allocating 15 surfaces 22:41:41 T:188 NOTICE: DXVA::CDXVAContext::CreateDecoder - hw may not support multiple decoders, releasing existing ones 22:41:41 T:188 DEBUG: DXVA::CDecoder::~CDecoder - destructing decoder, 237889224 22:41:41 T:188 NOTICE: DXVA::CDecoder::Close - closing decoder 22:41:41 T:3948 DEBUG: CDVDPlayer::HandleMessages - player started 2 22:41:41 T:3948 DEBUG: CDVDPlayer::SetCaching - caching state 0 22:41:41 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError1 - was:2047953740.085159, should be:2047999362.315951, error:45622.230792 22:41:41 T:2292 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available 22:41:41 T:3880 WARNING: Previous line repeats 4 times. 22:41:41 T:3880 DEBUG: DXVA::CSurfaceContext::~CSurfaceContext - destructing surface context 22:41:41 T:2292 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available 22:41:43 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:2050010639.098790, should be:2049963519.248973, error:-47119.849816 22:41:44 T:3880 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 22:41:45 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:2051973587.001829, should be:2051958654.557304, error:-14932.444525 22:41:46 T:188 DEBUG: CPullupCorrection: detected pattern of length 1: 41708.34, frameduration: 41708.333333 22:41:50 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:41:50 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is StepForward 22:41:50 T:3948 DEBUG: CDVDPlayer::SetCaching - caching state 3 22:41:50 T:3948 DEBUG: demuxer seek to: 2086595 22:41:50 T:3948 DEBUG: CDVDDemuxFFmpeg::SeekTime - seek ended up on time 2088208 22:41:50 T:3948 DEBUG: demuxer seek to: 2086595, success 22:41:50 T:3880 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 22:41:50 T:3880 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 22:41:50 T:3880 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 22:41:50 T:188 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 22:41:50 T:2292 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 22:41:50 T:188 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(2088209000.000000, 1) 22:41:50 T:188 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 22:41:50 T:188 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1920x800) 22:41:50 T:188 DEBUG: DXVA - open decoder 22:41:50 T:2292 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(2088267000.000000, 1) 22:41:50 T:188 DEBUG: DXVA - trying 'H.264 VLD, no FGT' 22:41:50 T:188 DEBUG: DXVA - source requires 5 references 22:41:50 T:188 DEBUG: DXVA - config 0: bitstream type 2 22:41:50 T:188 DEBUG: DXVA - config 1: bitstream type 2 22:41:50 T:3948 DEBUG: CDVDPlayer::HandleMessages - player started 1 22:41:50 T:188 DEBUG: DXVA - config 2: bitstream type 2, encrypted 22:41:50 T:188 DEBUG: DXVA - allocating 15 surfaces 22:41:50 T:188 NOTICE: DXVA::CDXVAContext::CreateDecoder - hw may not support multiple decoders, releasing existing ones 22:41:50 T:188 DEBUG: DXVA::CDecoder::~CDecoder - destructing decoder, 237889448 22:41:50 T:188 NOTICE: DXVA::CDecoder::Close - closing decoder 22:41:50 T:3948 DEBUG: CDVDPlayer::HandleMessages - player started 2 22:41:50 T:3948 DEBUG: CDVDPlayer::SetCaching - caching state 0 22:41:50 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError1 - was:2088124169.981465, should be:2088167986.347145, error:43816.365680 22:41:50 T:2292 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available 22:41:50 T:3880 WARNING: Previous line repeats 3 times. 22:41:50 T:3880 DEBUG: DXVA::CSurfaceContext::~CSurfaceContext - destructing surface context 22:41:52 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:2090182853.466302, should be:2090136971.426164, error:-45882.040138 22:41:53 T:3880 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 22:41:54 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:2092147043.018951, should be:2092130393.171634, error:-16649.847318 22:41:55 T:188 DEBUG: CPullupCorrection: detected pattern of length 1: 41708.32, frameduration: 41708.333333 22:42:04 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:42:04 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is StepForward 22:42:04 T:3948 DEBUG: CDVDPlayer::SetCaching - caching state 3 22:42:04 T:3948 DEBUG: demuxer seek to: 2132214 22:42:04 T:3948 DEBUG: CDVDDemuxFFmpeg::SeekTime - seek ended up on time 2132462 22:42:04 T:3948 DEBUG: demuxer seek to: 2132214, success 22:42:04 T:3880 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 22:42:04 T:3880 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 22:42:04 T:3880 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 22:42:04 T:188 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 22:42:04 T:2292 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 22:42:05 T:188 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(2132462000.000000, 1) 22:42:05 T:188 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 22:42:05 T:188 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1920x800) 22:42:05 T:188 DEBUG: DXVA - open decoder 22:42:05 T:2292 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(2132469000.000000, 1) 22:42:05 T:188 DEBUG: DXVA - trying 'H.264 VLD, no FGT' 22:42:05 T:188 DEBUG: DXVA - source requires 5 references 22:42:05 T:188 DEBUG: DXVA - config 0: bitstream type 2 22:42:05 T:3948 DEBUG: CDVDPlayer::HandleMessages - player started 1 22:42:05 T:188 DEBUG: DXVA - config 1: bitstream type 2 22:42:05 T:188 DEBUG: DXVA - config 2: bitstream type 2, encrypted 22:42:05 T:188 DEBUG: DXVA - allocating 15 surfaces 22:42:05 T:188 NOTICE: DXVA::CDXVAContext::CreateDecoder - hw may not support multiple decoders, releasing existing ones 22:42:05 T:188 DEBUG: DXVA::CDecoder::~CDecoder - destructing decoder, 237889224 22:42:05 T:188 NOTICE: DXVA::CDecoder::Close - closing decoder 22:42:05 T:3948 DEBUG: CDVDPlayer::HandleMessages - player started 2 22:42:05 T:3948 DEBUG: CDVDPlayer::SetCaching - caching state 0 22:42:05 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError1 - was:2132325916.514030, should be:2132380191.208494, error:54274.694465 22:42:05 T:2292 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available 22:42:05 T:3880 WARNING: Previous line repeats 3 times. 22:42:05 T:3880 DEBUG: DXVA::CSurfaceContext::~CSurfaceContext - destructing surface context 22:42:06 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:42:06 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is StepForward 22:42:06 T:3948 DEBUG: CDVDPlayer::SetCaching - caching state 3 22:42:06 T:3948 DEBUG: demuxer seek to: 2163672 22:42:06 T:3948 DEBUG: CDVDDemuxFFmpeg::SeekTime - seek ended up on time 2166579 22:42:06 T:3948 DEBUG: demuxer seek to: 2163672, success 22:42:06 T:3880 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 22:42:06 T:3880 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 22:42:06 T:188 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 22:42:06 T:2292 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 22:42:06 T:188 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(2166579000.000000, 1) 22:42:06 T:188 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 22:42:06 T:188 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1920x800) 22:42:06 T:188 DEBUG: DXVA - open decoder 22:42:06 T:2292 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(2166635000.000000, 1) 22:42:06 T:188 DEBUG: DXVA - trying 'H.264 VLD, no FGT' 22:42:06 T:188 DEBUG: DXVA - source requires 5 references 22:42:06 T:188 DEBUG: DXVA - config 0: bitstream type 2 22:42:06 T:3948 DEBUG: CDVDPlayer::HandleMessages - player started 1 22:42:06 T:188 DEBUG: DXVA - config 1: bitstream type 2 22:42:06 T:188 DEBUG: DXVA - config 2: bitstream type 2, encrypted 22:42:06 T:188 DEBUG: DXVA - allocating 15 surfaces 22:42:06 T:188 NOTICE: DXVA::CDXVAContext::CreateDecoder - hw may not support multiple decoders, releasing existing ones 22:42:06 T:188 DEBUG: DXVA::CDecoder::~CDecoder - destructing decoder, 237889448 22:42:06 T:188 NOTICE: DXVA::CDecoder::Close - closing decoder 22:42:06 T:3948 DEBUG: CDVDPlayer::HandleMessages - player started 2 22:42:06 T:3948 DEBUG: CDVDPlayer::SetCaching - caching state 0 22:42:06 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError1 - was:2166493100.750636, should be:2166531450.150427, error:38349.399791 22:42:06 T:2292 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available 22:42:06 T:3880 WARNING: Previous line repeats 2 times. 22:42:06 T:3880 DEBUG: DXVA::CSurfaceContext::~CSurfaceContext - destructing surface context 22:42:07 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:42:07 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is StepForward 22:42:07 T:3948 DEBUG: CDVDPlayer::SetCaching - caching state 3 22:42:07 T:3948 DEBUG: demuxer seek to: 2197070 22:42:07 T:3948 DEBUG: CDVDDemuxFFmpeg::SeekTime - seek ended up on time 2198403 22:42:07 T:3948 DEBUG: demuxer seek to: 2197070, success 22:42:07 T:3880 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 22:42:07 T:3880 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 22:42:07 T:188 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 22:42:07 T:2292 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 22:42:07 T:188 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(2198403000.000000, 1) 22:42:07 T:188 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 22:42:07 T:188 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1920x800) 22:42:07 T:188 DEBUG: DXVA - open decoder 22:42:07 T:2292 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(2198411000.000000, 1) 22:42:07 T:188 DEBUG: DXVA - trying 'H.264 VLD, no FGT' 22:42:07 T:188 DEBUG: DXVA - source requires 5 references 22:42:07 T:188 DEBUG: DXVA - config 0: bitstream type 2 22:42:07 T:188 DEBUG: DXVA - config 1: bitstream type 2 22:42:07 T:3948 DEBUG: CDVDPlayer::HandleMessages - player started 1 22:42:07 T:188 DEBUG: DXVA - config 2: bitstream type 2, encrypted 22:42:07 T:188 DEBUG: DXVA - allocating 15 surfaces 22:42:07 T:188 NOTICE: DXVA::CDXVAContext::CreateDecoder - hw may not support multiple decoders, releasing existing ones 22:42:07 T:188 DEBUG: DXVA::CDecoder::~CDecoder - destructing decoder, 237889224 22:42:07 T:188 NOTICE: DXVA::CDecoder::Close - closing decoder 22:42:07 T:3948 DEBUG: CDVDPlayer::HandleMessages - player started 2 22:42:07 T:3948 DEBUG: CDVDPlayer::SetCaching - caching state 0 22:42:07 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError1 - was:2198269155.534738, should be:2198301434.550772, error:32279.016034 22:42:07 T:2292 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available 22:42:07 T:3880 WARNING: Previous line repeats 5 times. 22:42:07 T:3880 DEBUG: DXVA::CSurfaceContext::~CSurfaceContext - destructing surface context 22:42:09 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:2200314097.549024, should be:2200278954.863988, error:-35142.685035 22:42:10 T:3880 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 22:42:11 T:2292 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:2202291045.712389, should be:2202278762.775455, error:-12282.936934 22:42:12 T:188 DEBUG: CPullupCorrection: detected pattern of length 1: 41708.33, frameduration: 41708.333333 22:42:29 T:3880 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 22:42:29 T:3880 DEBUG: CApplication::OnKey: return (0xf00d) pressed, action is OSD 22:42:29 T:3880 DEBUG: ------ Window Init (VideoOSD.xml) ------ 22:42:29 T:3880 INFO: Loading skin file: VideoOSD.xml, load type: KEEP_IN_MEMORY 22:42:30 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:42:30 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:42:31 T:3880 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 22:42:31 T:3880 DEBUG: CApplication::OnKey: return (0xf00d) pressed, action is Select 22:42:31 T:3880 NOTICE: CDVDPlayer::CloseFile() 22:42:31 T:3880 NOTICE: DVDPlayer: waiting for threads to exit 22:42:31 T:3948 NOTICE: CDVDPlayer::OnExit() 22:42:31 T:3948 NOTICE: Closing stream player 1 22:42:31 T:3948 NOTICE: Waiting for audio thread to exit 22:42:31 T:2292 NOTICE: thread end: CDVDPlayerAudio::OnExit() 22:42:31 T:3948 NOTICE: Closing audio device 22:42:31 T:2292 DEBUG: Thread DVDPlayerAudio 2292 terminating 22:42:31 T:632 DEBUG: CActiveAE::DiscardStream - audio stream deleted 22:42:31 T:3948 NOTICE: Deleting audio codec 22:42:31 T:632 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 22:42:31 T:3948 NOTICE: Closing stream player 2 22:42:31 T:632 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 22:42:31 T:3948 NOTICE: waiting for video thread to exit 22:42:31 T:3500 INFO: CActiveAESink::OpenSink - initialize sink 22:42:31 T:188 NOTICE: thread end: video_thread 22:42:31 T:3500 DEBUG: CAESinkDirectSound::Deinitialize: Cleaning up 22:42:31 T:188 DEBUG: Thread DVDPlayerVideo 188 terminating 22:42:31 T:3948 NOTICE: deleting video codec 22:42:31 T:3948 DEBUG: DXVA::CDecoder::~CDecoder - destructing decoder, 88164768 22:42:31 T:3500 DEBUG: CActiveAESink::OpenSink - trying to open device DIRECTSOUND:{80733A18-CDD4-4827-8E6D-F12CB2524E64} 22:42:31 T:3948 NOTICE: DXVA::CDecoder::Close - closing decoder 22:42:31 T:3500 DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 328182 22:42:31 T:3948 NOTICE: DXVA::Close - closing decoder context 22:42:31 T:3948 NOTICE: Closing stream player 3 22:42:31 T:3500 DEBUG: CAESinkDirectSound::Initialize: secondary buffer created 22:42:31 T:3500 DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters: 22:42:31 T:3500 DEBUG: Audio Device : Digitalaudio (HDMI) (2- High Definition Audio-Gerät) 22:42:31 T:3948 DEBUG: CApplication::OnPlayBackStopped: play state was 2, starting 0 22:42:31 T:3500 DEBUG: Sample Rate : 44100 22:42:31 T:3948 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 22:42:31 T:3500 DEBUG: Sample Format : AE_FMT_FLOAT 22:42:31 T:3948 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 22:42:31 T:3500 DEBUG: Bits Per Sample : 32 22:42:31 T:3948 DEBUG: Thread DVDPlayer 3948 terminating 22:42:31 T:3880 NOTICE: DVDPlayer: finished waiting 22:42:31 T:3500 DEBUG: Valid Bits/Samp : 32 22:42:31 T:3880 DEBUG: DXVA::CSurfaceContext::~CSurfaceContext - destructing surface context 22:42:31 T:3500 DEBUG: Channel Count : 2 22:42:31 T:3500 DEBUG: Block Align : 8 22:42:31 T:3500 DEBUG: Avg. Bytes Sec : 352800 22:42:31 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:31 T:3500 DEBUG: Samples/Block : 32 22:42:31 T:3500 DEBUG: Format cBSize : 22 22:42:31 T:3880 DEBUG: ------ Window Deinit (VideoOSD.xml) ------ 22:42:31 T:3500 DEBUG: Channel Layout : FL,FR 22:42:31 T:3880 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 22:42:31 T:3500 DEBUG: Channel Mask : 3 22:42:31 T:3500 DEBUG: Frames : 661 22:42:31 T:3500 DEBUG: Frame Samples : 1322 22:42:31 T:3500 DEBUG: Frame Size : 8 22:42:31 T:3500 DEBUG: CActiveAESink::OpenSink - DIRECTSOUND Initialized: 22:42:31 T:3500 DEBUG: Output Device : HDMI - Digitalaudio (HDMI) (2- High Definition Audio-Gerät) 22:42:31 T:3500 DEBUG: Sample Rate : 44100 22:42:31 T:3500 DEBUG: Sample Format : AE_FMT_FLOAT 22:42:31 T:3500 DEBUG: Channel Count : 2 22:42:31 T:3500 DEBUG: Channel Layout: FL,FR 22:42:31 T:3500 DEBUG: Frames : 661 22:42:31 T:3500 DEBUG: Frame Samples : 1322 22:42:31 T:3500 DEBUG: Frame Size : 8 22:42:31 T:632 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 22:42:31 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 22:42:31 T:3880 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 22:42:31 T:3880 DEBUG: CGUIMediaWindow::GetDirectory (videodb://movies/titles/) 22:42:31 T:3880 DEBUG: ParentPath = [videodb://movies/titles/] 22:42:31 T:3500 DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback 22:42:31 T:3880 DEBUG: CVideoDatabase::RunQuery took 17 ms for 295 items query: select * from movieview 22:42:31 T:2724 NOTICE: Thread BackgroundLoader start, auto delete: false 22:42:31 T:3276 NOTICE: Thread JobWorker start, auto delete: true 22:42:31 T:3276 DEBUG: CTextureCacheJob::GetImageHash - unable to stat url 22:42:31 T:3692 NOTICE: Thread JobWorker start, auto delete: true 22:42:31 T:3880 NOTICE: Previous line repeats 1 times. 22:42:31 T:3880 NOTICE: CDVDPlayer::CloseFile() 22:42:31 T:3880 NOTICE: DVDPlayer: waiting for threads to exit 22:42:31 T:3880 NOTICE: DVDPlayer: finished waiting 22:42:31 T:3880 NOTICE: CDVDPlayer::CloseFile() 22:42:31 T:3880 NOTICE: DVDPlayer: waiting for threads to exit 22:42:31 T:3880 NOTICE: DVDPlayer: finished waiting 22:42:31 T:3880 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/ImageLib.dll) 22:42:31 T:3692 DEBUG: CSaveFileStateJob::DoWork - Saving file state for video item smb://192.168.178.1/FRITZ.NAS/TOSHIBA-ExternalUSB3-0-01/Filme/White House Down 2013/White.House.Down.2013.German.DTSD.5.1.DL.1080p.BluRay.x264-DerSchuft.mkv 22:42:31 T:3692 DEBUG: CAnnouncementManager - Announcement: OnUpdate from xbmc 22:42:31 T:3692 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnUpdate 22:42:31 T:3692 DEBUG: CTextureCacheJob::GetImageHash - unable to stat url 22:42:31 T:2724 DEBUG: Previous line repeats 1 times. 22:42:31 T:2724 DEBUG: Thread BackgroundLoader 2724 terminating 22:42:32 T:2368 DEBUG: CVideoDatabase::RunQuery took 1 ms for 3 items query: select * from movieview WHERE (movieview.idFile IN (SELECT DISTINCT idFile FROM bookmark WHERE type = 1)) 22:42:32 T:3256 DEBUG: CMMNotificationClient::OnPropertyValueChanged: Changed device property of {0.0.0.00000000}.{80733a18-cdd4-4827-8e6d-f12cb2524e64} is {9855c4cd-df8c-449c-a181-8191b68bd06c}#0 22:42:32 T:2368 DEBUG: CVideoDatabase::RunQuery took 17 ms for 295 items query: select * from movieview WHERE ((movieview.playCount IS NULL OR movieview.playCount = 0)) 22:42:32 T:3248 DEBUG: CVideoDatabase::RunQuery took 2 ms for 3 items query: select * from movieview WHERE (movieview.idFile IN (SELECT DISTINCT idFile FROM bookmark WHERE type = 1)) 22:42:32 T:3248 DEBUG: CVideoDatabase::RunQuery took 15 ms for 295 items query: select * from movieview WHERE ((movieview.playCount IS NULL OR movieview.playCount = 0)) 22:42:32 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:32 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:32 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:33 T:3880 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 22:42:33 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 22:42:33 T:3880 DEBUG: ------ Window Init (Home.xml) ------ 22:42:33 T:3880 WARNING: RunScript called for a non-script addon 'script.grab.fanart'. This behaviour is deprecated. 22:42:33 T:908 NOTICE: Thread LanguageInvoker start, auto delete: false 22:42:33 T:908 INFO: initializing python engine. 22:42:33 T:908 DEBUG: CPythonInvoker(13, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart\default.py): start processing 22:42:33 T:908 NOTICE: -->Python Interpreter Initialized<-- 22:42:33 T:908 DEBUG: CPythonInvoker(13, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart\default.py): the source file to load is "C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart\default.py" 22:42:33 T:908 DEBUG: CPythonInvoker(13, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart\default.py): setting the Python path to C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart;C:\Program Files (x86)\Kodi\system\python\DLLs;C:\Program Files (x86)\Kodi\system\python\Lib;C:\Program Files (x86)\Kodi\python27.zip;C:\Program Files (x86)\Kodi\system\python\lib\plat-win;C:\Program Files (x86)\Kodi\system\python\lib\lib-tk;C:\Program Files (x86)\Kodi;C:\Program Files (x86)\Kodi\system\python;C:\Program Files (x86)\Kodi\system\python\lib\site-packages 22:42:33 T:908 DEBUG: CPythonInvoker(13, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart\default.py): entering source directory C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart 22:42:33 T:908 DEBUG: CPythonInvoker(13, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart\default.py): instantiating addon using automatically obtained id of "script.grab.fanart" dependent on version 2.1.0 of the xbmc.python api 22:42:33 T:908 DEBUG: script.grab.fanart: updating settings 22:42:33 T:908 NOTICE: script.grab.fanart: mode 22:42:33 T:908 NOTICE: script.grab.fanart: refresh 22:42:33 T:908 INFO: CPythonInvoker(13, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart\default.py): script successfully run 22:42:33 T:908 INFO: Python script stopped 22:42:33 T:908 DEBUG: Thread LanguageInvoker 908 terminating 22:42:34 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:34 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:34 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:34 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:34 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:34 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:35 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:35 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:35 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:36 T:3880 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 22:42:36 T:3880 DEBUG: CApplication::OnKey: backspace (0xf008) pressed, action is Back 22:42:36 T:3880 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 22:42:37 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:42:37 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:42:37 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:42:37 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:42:38 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:42:38 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:42:38 T:3880 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib.dll) 22:42:38 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:42:38 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:42:38 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:42:38 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:42:38 T:3692 INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://www.google.com 22:42:40 T:3880 DEBUG: Keyboard: scancode: 0x48, sym: 0x0111, unicode: 0x0000, modifier: 0x0 22:42:40 T:3880 DEBUG: CApplication::OnKey: up (0xf080) pressed, action is Up 22:42:40 T:3880 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0114, unicode: 0x0000, modifier: 0x0 22:42:40 T:3880 DEBUG: CApplication::OnKey: left (0xf082) pressed, action is Left 22:42:41 T:3880 DEBUG: Keyboard: scancode: 0x4d, sym: 0x0113, unicode: 0x0000, modifier: 0x0 22:42:41 T:3880 DEBUG: CApplication::OnKey: right (0xf083) pressed, action is Right 22:42:41 T:3880 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 22:42:41 T:3880 DEBUG: CApplication::OnKey: return (0xf00d) pressed, action is Select 22:42:41 T:3880 DEBUG: Activating window ID: 10111 22:42:41 T:3880 DEBUG: ------ Window Init (DialogButtonMenu.xml) ------ 22:42:41 T:3880 INFO: Loading skin file: DialogButtonMenu.xml, load type: KEEP_IN_MEMORY 22:42:42 T:3880 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 22:42:42 T:3880 DEBUG: CApplication::OnKey: return (0xf00d) pressed, action is Select 22:42:42 T:3880 DEBUG: ------ Window Deinit () ------ 22:42:42 T:3880 DEBUG: ------ Window Deinit (DialogButtonMenu.xml) ------ 22:42:42 T:3880 DEBUG: ------ Window Init () ------ 22:42:42 T:3880 DEBUG: CAnnouncementManager - Announcement: OnQuit from xbmc 22:42:42 T:3880 DEBUG: GOT ANNOUNCEMENT, type: 8, from xbmc, message OnQuit 22:42:42 T:3880 NOTICE: Storing total System Uptime 22:42:42 T:3880 NOTICE: Saving settings 22:42:42 T:3880 NOTICE: stop all 22:42:42 T:3880 NOTICE: stop player 22:42:42 T:3276 DEBUG: Thread JobWorker 3276 terminating (autodelete) 22:42:42 T:816 DEBUG: Thread JobWorker 816 terminating (autodelete) 22:42:42 T:3692 DEBUG: Thread JobWorker 3692 terminating (autodelete) 22:42:42 T:3880 INFO: stopping PVRManager 22:42:42 T:3880 DEBUG: CNetwork::NetworkMessage - Signaling network services to stop 22:42:42 T:3880 NOTICE: ES: Stopping event server 22:42:42 T:3880 DEBUG: CNetwork::NetworkMessage - Waiting for network services to stop 22:42:43 T:3540 DEBUG: Thread TCPServer 3540 terminating 22:42:43 T:348 NOTICE: ES: UDP Event server stopped 22:42:43 T:348 DEBUG: Thread EventServer 348 terminating 22:42:43 T:980 DEBUG: Thread PeripBusUSB 980 terminating 22:42:43 T:2440 DEBUG: Thread PeripBusCEC 2440 terminating 22:42:43 T:3880 NOTICE: stop sap announcement listener 22:42:43 T:3880 NOTICE: clean cached files! 22:42:43 T:3880 NOTICE: unload skin 22:42:43 T:3880 INFO: Unloading old skin ... 22:42:43 T:3880 DEBUG: ------ Window Deinit () ------ 22:42:43 T:3880 DEBUG: ------ Window Deinit (Home.xml) ------ 22:42:44 T:3880 WARNING: CGUITextureManager::Cleanup: Having to cleanup texture controls/button-focus.png 22:42:44 T:3880 WARNING: CGUITextureManager::Cleanup: Having to cleanup texture controls/button-nofocus.png 22:42:44 T:3880 DEBUG: CTextureBundleXBT::Cleanup - Closed bundle 22:42:44 T:3880 DEBUG: Infobool 'true' still used by 2 instances 22:42:44 T:3880 DEBUG: Previous line repeats 2 times. 22:42:44 T:3880 DEBUG: Infobool 'player.showcodec' still used by 2 instances 22:42:44 T:3880 DEBUG: Infobool 'true' still used by 2 instances 22:42:44 T:3880 DEBUG: ADDON: Stopping service addons. 22:42:47 T:1868 INFO: CPythonInvoker(0, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.cu.lrclyrics\default.py): script successfully run 22:42:47 T:3880 DEBUG: CPythonInvoker(0, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.cu.lrclyrics\default.py): script termination took 2971ms 22:42:47 T:1868 WARNING: CPythonInvoker(0, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.cu.lrclyrics\default.py): the python script "C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.cu.lrclyrics\default.py" has left several classes in memory that we couldn't clean up. The classes include: class PythonBindings::XBMCAddon_xbmc_Monitor_Director,class PythonBindings::XBMCAddon_xbmc_Player_Director 22:42:47 T:1868 INFO: Python script interrupted by user 22:42:47 T:3248 DEBUG: Skin Widgets: script version 0.0.29 stopped 22:42:47 T:3248 INFO: CPythonInvoker(2, C:\Users\Kodi\AppData\Roaming\Kodi\addons\service.skin.widgets\default.py): script successfully run 22:42:47 T:3880 DEBUG: CPythonInvoker(2, C:\Users\Kodi\AppData\Roaming\Kodi\addons\service.skin.widgets\default.py): script termination took 496ms 22:42:47 T:1868 DEBUG: Thread LanguageInvoker 1868 terminating 22:42:47 T:3248 WARNING: CPythonInvoker(2, C:\Users\Kodi\AppData\Roaming\Kodi\addons\service.skin.widgets\default.py): the python script "C:\Users\Kodi\AppData\Roaming\Kodi\addons\service.skin.widgets\default.py" has left several classes in memory that we couldn't clean up. The classes include: class XBMCAddon::xbmcgui::Window,class PythonBindings::XBMCAddon_xbmc_Monitor_Director,class PythonBindings::XBMCAddon_xbmc_Player_Director 22:42:47 T:3248 INFO: Python script interrupted by user 22:42:48 T:2352 NOTICE: StorageServer-2.5.4 Closed down 22:42:48 T:2352 INFO: CPythonInvoker(9, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.common.plugin.cache\default.py): script successfully run 22:42:48 T:3880 DEBUG: CPythonInvoker(9, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.common.plugin.cache\default.py): script termination took 309ms 22:42:48 T:3248 DEBUG: Thread LanguageInvoker 3248 terminating 22:42:48 T:2352 INFO: Python script interrupted by user 22:42:48 T:4020 INFO: CPythonInvoker(3, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart\service.py): script successfully run 22:42:48 T:3880 DEBUG: CPythonInvoker(3, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.grab.fanart\service.py): script termination took 494ms 22:42:48 T:2352 DEBUG: Thread LanguageInvoker 2352 terminating 22:42:48 T:4020 INFO: Python script interrupted by user 22:42:49 T:2368 DEBUG: Library Data Provider: service version 0.0.7 stopped 22:42:49 T:2368 INFO: CPythonInvoker(4, C:\Users\Kodi\AppData\Roaming\Kodi\addons\service.library.data.provider\service.py): script successfully run 22:42:49 T:3880 DEBUG: CPythonInvoker(4, C:\Users\Kodi\AppData\Roaming\Kodi\addons\service.library.data.provider\service.py): script termination took 687ms 22:42:49 T:4020 DEBUG: Thread LanguageInvoker 4020 terminating 22:42:49 T:2368 WARNING: CPythonInvoker(4, C:\Users\Kodi\AppData\Roaming\Kodi\addons\service.library.data.provider\service.py): the python script "C:\Users\Kodi\AppData\Roaming\Kodi\addons\service.library.data.provider\service.py" has left several classes in memory that we couldn't clean up. The classes include: class XBMCAddon::xbmcgui::Window,class PythonBindings::XBMCAddon_xbmc_Monitor_Director,class PythonBindings::XBMCAddon_xbmc_Player_Director 22:42:49 T:2368 INFO: Python script interrupted by user 22:42:49 T:1060 DEBUG: [Cinema Experience] - Cinema Experience service script version 4.0.10 stopped 22:42:49 T:1060 INFO: CPythonInvoker(6, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.cinema.experience\service.py): script successfully run 22:42:49 T:3880 DEBUG: CPythonInvoker(6, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.cinema.experience\service.py): script termination took 248ms 22:42:49 T:2368 DEBUG: Thread LanguageInvoker 2368 terminating 22:42:49 T:1060 INFO: Python script interrupted by user 22:42:50 T:1552 NOTICE: script.tv.show.next.aired: ### abort requested -- stopping background processing 22:42:50 T:1552 INFO: CPythonInvoker(7, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.tv.show.next.aired\service.py): script aborted 22:42:50 T:3880 DEBUG: CPythonInvoker(7, C:\Users\Kodi\AppData\Roaming\Kodi\addons\script.tv.show.next.aired\service.py): script termination took 684ms 22:42:50 T:1060 DEBUG: Thread LanguageInvoker 1060 terminating 22:42:50 T:1552 INFO: Python script interrupted by user 22:42:50 T:1552 DEBUG: Thread LanguageInvoker 1552 terminating 22:42:50 T:632 DEBUG: Thread ActiveAE 632 terminating 22:42:50 T:3500 DEBUG: Thread AESink 3500 terminating 22:42:50 T:3880 DEBUG: CAESinkDirectSound::Deinitialize: Cleaning up 22:42:50 T:3880 NOTICE: stopped 22:42:50 T:3880 NOTICE: destroy 22:42:50 T:3880 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0532A310 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 22:42:50 T:3880 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 00393CB0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 22:42:50 T:3880 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0532A478 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 22:42:50 T:3880 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 053D50B8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 22:42:50 T:3880 NOTICE: closing down remote control service 22:42:50 T:3880 NOTICE: unload sections 22:42:50 T:2640 DEBUG: Thread RemoteControl 2640 terminating 22:42:50 T:3880 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 22:42:50 T:3880 NOTICE: special://profile/ is mapped to: special://masterprofile/ 22:42:50 T:3880 NOTICE: destroy 22:42:50 T:3880 WARNING: Attempted to remove window 10013 from the window manager when it didn't exist 22:42:50 T:3880 WARNING: Attempted to remove window 10014 from the window manager when it didn't exist 22:42:50 T:3880 WARNING: Attempted to remove window 10015 from the window manager when it didn't exist 22:42:50 T:3880 WARNING: Attempted to remove window 10016 from the window manager when it didn't exist 22:42:50 T:3880 WARNING: Attempted to remove window 10017 from the window manager when it didn't exist 22:42:50 T:3880 WARNING: Attempted to remove window 10018 from the window manager when it didn't exist 22:42:50 T:3880 WARNING: Attempted to remove window 10019 from the window manager when it didn't exist 22:42:50 T:3880 WARNING: Attempted to remove window 10021 from the window manager when it didn't exist 22:42:50 T:3880 WARNING: Attempted to remove window 10107 from the window manager when it didn't exist 22:42:50 T:3880 WARNING: Attempted to remove window 10115 from the window manager when it didn't exist 22:42:50 T:3880 WARNING: Attempted to remove window 10104 from the window manager when it didn't exist 22:42:50 T:3880 NOTICE: closing down remote control service 22:42:50 T:3880 NOTICE: unload sections 22:42:50 T:3880 NOTICE: application stopped... 22:42:50 T:3880 DEBUG: PVRManager - destroyed 22:42:50 T:3880 DEBUG: SECTION:UnloadDll(special://xbmcbin/system/libcurl.dll) 22:42:50 T:3880 ERROR: dllFreeLibrary - Invalid hModule specified 22:42:50 T:3880 DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/cpluff.dll) 22:42:50 T:3880 DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/libcec.dll) 22:42:50 T:3880 DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/ImageLib.dll)