05:02:58.188 T:139833038960768 NOTICE: ----------------------------------------------------------------------- 05:02:58.188 T:139833038960768 NOTICE: Starting Kodi (18.0 Git:18.0-Leia). Platform: Linux x86 64-bit 05:02:58.188 T:139833038960768 NOTICE: Using Release Kodi x64 build 05:02:58.188 T:139833038960768 NOTICE: Kodi compiled 2019-01-29 by GCC 8.2.0 for Linux x86 64-bit version 4.19.17 (267025) 05:02:58.188 T:139833038960768 NOTICE: Running on LibreELEC (official): 9.0.0, kernel: Linux x86 64-bit version 4.19.17 05:02:58.188 T:139833038960768 NOTICE: FFmpeg version/source: 4.0.3-Kodi 05:02:58.188 T:139833038960768 NOTICE: Host CPU: Intel(R) Core(TM) i3-7100U CPU @ 2.40GHz, 4 cores available 05:02:58.188 T:139833038960768 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi/ 05:02:58.188 T:139833038960768 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi 05:02:58.188 T:139833038960768 NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons 05:02:58.188 T:139833038960768 NOTICE: special://masterprofile/ is mapped to: /storage/.kodi/userdata 05:02:58.188 T:139833038960768 NOTICE: special://envhome/ is mapped to: /storage 05:02:58.188 T:139833038960768 NOTICE: special://home/ is mapped to: /storage/.kodi 05:02:58.188 T:139833038960768 NOTICE: special://temp/ is mapped to: /storage/.kodi/temp 05:02:58.188 T:139833038960768 NOTICE: special://logpath/ is mapped to: /storage/.kodi/temp 05:02:58.188 T:139833038960768 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin 05:02:58.188 T:139833038960768 NOTICE: Local hostname: Bedroom 05:02:58.188 T:139833038960768 NOTICE: Log File is located: /storage/.kodi/temp/kodi.log 05:02:58.188 T:139833038960768 NOTICE: ----------------------------------------------------------------------- 05:02:58.191 T:139833038960768 INFO: loading settings 05:02:58.191 T:139833038960768 NOTICE: special://profile/ is mapped to: special://masterprofile/ 05:02:58.197 T:139833038960768 DEBUG: CSkinSettings: no tag found 05:02:58.197 T:139833038960768 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml 05:02:58.199 T:139833038960768 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml 05:02:58.200 T:139833038960768 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are... /usr/bin/cputemp /usr/bin/gputemp false 1 30 05:02:58.200 T:139833038960768 WARNING: CSettingsManager: missing version attribute 05:02:58.200 T:139833038960768 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 05:02:58.200 T:139833038960768 NOTICE: Default Video Player: VideoPlayer 05:02:58.200 T:139833038960768 NOTICE: Default Audio Player: paplayer 05:02:58.200 T:139833038960768 NOTICE: Enabled debug logging due to GUI setting (2) 05:02:58.200 T:139833038960768 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 05:02:58.202 T:139833038960768 INFO: creating subdirectories 05:02:58.202 T:139833038960768 INFO: userdata folder: special://masterprofile/ 05:02:58.202 T:139833038960768 INFO: recording folder: 05:02:58.202 T:139833038960768 INFO: screenshots folder: /storage/screenshots/ 05:02:58.209 T:139833038960768 NOTICE: PulseAudio: Server found running - will try to use Pulse 05:02:58.209 T:139833030563584 DEBUG: Thread Lirc start, auto delete: false 05:02:58.210 T:139833030563584 INFO: Loading special://xbmc/system/Lircmap.xml 05:02:58.214 T:139833030563584 INFO: * Adding remote mapping for device 'mceusb' 05:02:58.214 T:139833030563584 INFO: * Adding remote mapping for device 'XboxDVDDongle' 05:02:58.214 T:139833030563584 INFO: * Adding remote mapping for device 'Microsoft_Xbox' 05:02:58.214 T:139833030563584 INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote' 05:02:58.214 T:139833030563584 INFO: * Adding remote mapping for device 'anysee' 05:02:58.214 T:139833030563584 INFO: * Adding remote mapping for device 'iMON-PAD' 05:02:58.214 T:139833030563584 INFO: * Adding remote mapping for device 'Antec_Veris_RM200' 05:02:58.214 T:139833030563584 INFO: * Adding remote mapping for device 'MCE_via_iMON' 05:02:58.214 T:139833030563584 INFO: * Adding remote mapping for device 'TwinHanRemote' 05:02:58.214 T:139833030563584 INFO: * Adding remote mapping for device 'linux-input-layer' 05:02:58.214 T:139833030563584 INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote' 05:02:58.214 T:139833030563584 INFO: * Adding remote mapping for device 'mediacenter' 05:02:58.214 T:139833030563584 INFO: * Adding remote mapping for device 'devinput' 05:02:58.214 T:139833030563584 INFO: * Adding remote mapping for device 'devinput-32' 05:02:58.214 T:139833030563584 INFO: * Adding remote mapping for device 'devinput-64' 05:02:58.214 T:139833030563584 DEBUG: CIRTranslator::Load - no userdata Lircmap.xml found, skipping 05:02:58.219 T:139833038960768 NOTICE: Running database version Addons27 05:02:58.242 T:139833038960768 INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/kodi/addons: No such file or directory' 05:02:58.242 T:139833038960768 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.' 05:02:58.242 T:139833038960768 NOTICE: ADDON: audioencoder.kodi.builtin.aac v1.0.0 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: audioencoder.kodi.builtin.wma v1.0.0 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: driver.dvb.crazycat v9.0.0 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: driver.dvb.digital_devices v9.0.0 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: driver.dvb.dvb-latest v9.0.0 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: game.controller.default v1.0.8 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: game.controller.snes v1.0.8 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: kodi.binary.global.audioengine v1.0.1 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: kodi.binary.global.filesystem v1.0.2 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: kodi.binary.global.general v1.0.3 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: kodi.binary.global.gui v5.12.0 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: kodi.binary.global.main v1.0.14 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: kodi.binary.global.network v1.0.0 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: kodi.binary.instance.audiodecoder v2.0.0 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: kodi.binary.instance.audioencoder v2.0.0 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: kodi.binary.instance.game v1.1.0 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: kodi.binary.instance.imagedecoder v2.0.0 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: kodi.binary.instance.inputstream v2.0.8 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: kodi.binary.instance.peripheral v1.3.7 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: kodi.binary.instance.pvr v5.10.3 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: kodi.binary.instance.screensaver v2.0.0 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: kodi.binary.instance.vfs v2.0.0 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: kodi.binary.instance.videocodec v1.0.1 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: kodi.binary.instance.visualization v2.0.1 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: kodi.resource v1.0.0 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: metadata.album.universal v3.1.1 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: metadata.artists.universal v4.2.1 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: metadata.common.allmusic.com v3.2.0 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: metadata.common.fanart.tv v3.6.0 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: metadata.common.imdb.com v3.1.4 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: metadata.common.musicbrainz.org v2.2.1 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: metadata.common.theaudiodb.com v2.0.1 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: metadata.common.themoviedb.org v3.1.9 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: metadata.local v1.0.0 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: metadata.themoviedb.org v5.1.4 installed 05:02:58.242 T:139833038960768 NOTICE: ADDON: metadata.tvshows.themoviedb.org v3.1.0 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: os.libreelec.tv v9.0 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: os.openelec.tv v9.0 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: peripheral.joystick v1.4.6 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: repository.kodi.game v1.0.0 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: repository.libreelec.tv v9.0.1 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: repository.xbmc.org v3.1.5 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: resource.images.weathericons.default v1.1.8 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: resource.language.en_gb v2.0.1 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: resource.uisounds.kodi v1.0.0 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: screensaver.xbmc.builtin.black v1.0.32 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: screensaver.xbmc.builtin.dim v1.0.53 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: script.module.pil v1.1.7 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: script.module.pycryptodome v3.4.3 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: script.program.driverselect v0.1.6 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: service.libreelec.settings v9.0.0 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: skin.estuary v2.0.21 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: webinterface.default v18.x-2.4.6 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: xbmc.addon v18.0.0 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: xbmc.core v0.1.0 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: xbmc.gui v5.14.0 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: xbmc.json v10.1.1 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: xbmc.metadata v2.1.0 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: xbmc.python v2.26.0 installed 05:02:58.243 T:139833038960768 NOTICE: ADDON: xbmc.webinterface v1.0.0 installed 05:02:58.248 T:139833038960768 DEBUG: CFavourites::Load - no system favourites found, skipping 05:02:58.248 T:139833038960768 DEBUG: CFavourites::Load - no userdata favourites found, skipping 05:02:58.248 T:139833038960768 DEBUG: DBus method call to org.freedesktop.ConsoleKit.Manager.CanStop at /org/freedesktop/ConsoleKit/Manager of org.freedesktop.ConsoleKit failed: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.ConsoleKit was not provided by any .service files 05:02:58.248 T:139833038960768 INFO: Selected Logind/UPower as PowerSyscall 05:02:58.249 T:139833038960768 ERROR: DBus error: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files 05:02:58.249 T:139833038960768 INFO: LogindUPowerSyscall - UPower not found, battery information will not be available 05:02:58.255 T:139833038960768 DEBUG: LogindUPowerSyscall - inhibit lock taken, fd 12 05:02:58.256 T:139833038960768 DEBUG: DBus method call to org.freedesktop.UPower.EnumerateDevices at /org/freedesktop/UPower of org.freedesktop.UPower failed: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files 05:02:58.256 T:139833020696320 DEBUG: Thread ActiveAE start, auto delete: false 05:02:58.257 T:139833012303616 DEBUG: Thread AESink start, auto delete: false 05:02:58.257 T:139833003910912 DEBUG: Thread FDEventMonitor start, auto delete: false 05:02:58.271 T:139833020696320 INFO: CAESinkALSA - Unable to open device "surround21:CARD=PCH,DEV=0" for playback 05:02:58.278 T:139833020696320 DEBUG: CAESinkALSA - HDMI device "hdmi:CARD=PCH,DEV=0" may be unconnected (no ELD data) 05:02:58.279 T:139833020696320 DEBUG: CAESinkALSA - HDMI device "hdmi:CARD=PCH,DEV=2" may be unconnected (no ELD data) 05:02:58.280 T:139833020696320 DEBUG: CAESinkALSA - HDMI device "hdmi:CARD=PCH,DEV=3" may be unconnected (no ELD data) 05:02:58.280 T:139833020696320 DEBUG: CAESinkALSA - HDMI device "hdmi:CARD=PCH,DEV=4" may be unconnected (no ELD data) 05:02:58.281 T:139833020696320 DEBUG: PulseAudio: Context authorizing 05:02:58.281 T:139833020696320 DEBUG: PulseAudio: Context setting name 05:02:58.281 T:139833020696320 DEBUG: PulseAudio: Context ready 05:02:58.281 T:139833020696320 WARNING: Pulseaudio module module-allow-passthrough not loaded - opening PT devices might fail 05:02:58.282 T:139833020696320 NOTICE: Found 2 Lists of Devices 05:02:58.282 T:139833020696320 NOTICE: Enumerated ALSA devices: 05:02:58.282 T:139833020696320 NOTICE: Device 1 05:02:58.282 T:139833020696320 NOTICE: m_deviceName : @ 05:02:58.282 T:139833020696320 NOTICE: m_displayName : Default (HDA Intel PCH ALC283 Analog) 05:02:58.282 T:139833020696320 NOTICE: m_displayNameExtra: 05:02:58.282 T:139833020696320 NOTICE: m_deviceType : AE_DEVTYPE_PCM 05:02:58.282 T:139833020696320 NOTICE: m_channels : FL, FR 05:02:58.282 T:139833020696320 NOTICE: m_sampleRates : 48000 05:02:58.282 T:139833020696320 NOTICE: m_dataFormats : AE_FMT_S32NE 05:02:58.282 T:139833020696320 NOTICE: m_streamTypes : No passthrough capabilities 05:02:58.282 T:139833020696320 NOTICE: Device 2 05:02:58.282 T:139833020696320 NOTICE: m_deviceName : @:CARD=PCH,DEV=0 05:02:58.282 T:139833020696320 NOTICE: m_displayName : HDA Intel PCH 05:02:58.282 T:139833020696320 NOTICE: m_displayNameExtra: ALC283 Analog 05:02:58.282 T:139833020696320 NOTICE: m_deviceType : AE_DEVTYPE_PCM 05:02:58.282 T:139833020696320 NOTICE: m_channels : FL, FR 05:02:58.282 T:139833020696320 NOTICE: m_sampleRates : 48000 05:02:58.282 T:139833020696320 NOTICE: m_dataFormats : AE_FMT_S32NE 05:02:58.282 T:139833020696320 NOTICE: m_streamTypes : No passthrough capabilities 05:02:58.282 T:139833020696320 NOTICE: Device 3 05:02:58.282 T:139833020696320 NOTICE: m_deviceName : hdmi:CARD=PCH,DEV=0 05:02:58.282 T:139833020696320 NOTICE: m_displayName : HDA Intel PCH 05:02:58.282 T:139833020696320 NOTICE: m_displayNameExtra: HDMI #0 05:02:58.282 T:139833020696320 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 05:02:58.282 T:139833020696320 NOTICE: m_channels : FL, FR 05:02:58.282 T:139833020696320 NOTICE: m_sampleRates : 32000,44100,48000,88200,96000,176400,192000 05:02:58.282 T:139833020696320 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW 05:02:58.282 T:139833020696320 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_MA,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD 05:02:58.282 T:139833020696320 NOTICE: Device 4 05:02:58.282 T:139833020696320 NOTICE: m_deviceName : hdmi:CARD=PCH,DEV=1 05:02:58.282 T:139833020696320 NOTICE: m_displayName : HDA Intel PCH 05:02:58.282 T:139833020696320 NOTICE: m_displayNameExtra: SNY SONY TV *06 on DisplayPort #1 05:02:58.282 T:139833020696320 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 05:02:58.282 T:139833020696320 NOTICE: m_channels : FL, FR, LFE, FC, BL, BR 05:02:58.282 T:139833020696320 NOTICE: m_sampleRates : 32000,44100,48000 05:02:58.282 T:139833020696320 NOTICE: m_dataFormats : AE_FMT_RAW,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW 05:02:58.282 T:139833020696320 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_MA,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD 05:02:58.282 T:139833020696320 NOTICE: Device 5 05:02:58.282 T:139833020696320 NOTICE: m_deviceName : hdmi:CARD=PCH,DEV=2 05:02:58.282 T:139833020696320 NOTICE: m_displayName : HDA Intel PCH 05:02:58.282 T:139833020696320 NOTICE: m_displayNameExtra: HDMI #2 05:02:58.282 T:139833020696320 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 05:02:58.282 T:139833020696320 NOTICE: m_channels : FL, FR 05:02:58.282 T:139833020696320 NOTICE: m_sampleRates : 32000,44100,48000,88200,96000,176400,192000 05:02:58.282 T:139833020696320 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW 05:02:58.282 T:139833020696320 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_MA,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD 05:02:58.282 T:139833020696320 NOTICE: Device 6 05:02:58.282 T:139833020696320 NOTICE: m_deviceName : hdmi:CARD=PCH,DEV=3 05:02:58.282 T:139833020696320 NOTICE: m_displayName : HDA Intel PCH 05:02:58.282 T:139833020696320 NOTICE: m_displayNameExtra: HDMI #3 05:02:58.282 T:139833020696320 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 05:02:58.282 T:139833020696320 NOTICE: m_channels : FL, FR 05:02:58.282 T:139833020696320 NOTICE: m_sampleRates : 32000,44100,48000,88200,96000,176400,192000 05:02:58.282 T:139833020696320 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW 05:02:58.282 T:139833020696320 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_MA,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD 05:02:58.282 T:139833020696320 NOTICE: Device 7 05:02:58.282 T:139833020696320 NOTICE: m_deviceName : hdmi:CARD=PCH,DEV=4 05:02:58.282 T:139833020696320 NOTICE: m_displayName : HDA Intel PCH 05:02:58.282 T:139833020696320 NOTICE: m_displayNameExtra: HDMI #4 05:02:58.282 T:139833020696320 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 05:02:58.282 T:139833020696320 NOTICE: m_channels : FL, FR 05:02:58.282 T:139833020696320 NOTICE: m_sampleRates : 32000,44100,48000,88200,96000,176400,192000 05:02:58.282 T:139833020696320 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW 05:02:58.282 T:139833020696320 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_MA,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD 05:02:58.282 T:139833020696320 NOTICE: Enumerated PULSE devices: 05:02:58.282 T:139833020696320 NOTICE: Device 1 05:02:58.282 T:139833020696320 NOTICE: m_deviceName : Default 05:02:58.282 T:139833020696320 NOTICE: m_displayName : Default 05:02:58.282 T:139833020696320 NOTICE: m_displayNameExtra: Bluetooth Audio (PULSEAUDIO) 05:02:58.282 T:139833020696320 NOTICE: m_deviceType : AE_DEVTYPE_PCM 05:02:58.282 T:139833020696320 NOTICE: m_channels : FL, FR 05:02:58.282 T:139833020696320 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000 05:02:58.282 T:139833020696320 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT 05:02:58.282 T:139833020696320 NOTICE: m_streamTypes : No passthrough capabilities 05:02:58.282 T:139833012303616 INFO: CActiveAESink::OpenSink - initialize sink 05:02:58.282 T:139833012303616 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=1 05:02:58.282 T:139833012303616 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=1" 05:02:58.284 T:139833012303616 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=1,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00" 05:02:58.284 T:139833012303616 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 05:02:58.284 T:139833012303616 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 05:02:58.284 T:139833012303616 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2205, bufferSize 8820 05:02:58.295 T:139833012303616 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2205, bufferSize 8820 05:02:58.295 T:139833012303616 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms 05:02:58.296 T:139833012303616 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 05:02:58.296 T:139833012303616 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL, FR 05:02:58.296 T:139833012303616 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL, FR (ALSA: FL FR) 05:02:58.296 T:139833012303616 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 05:02:58.296 T:139833012303616 DEBUG: Output Device : HDA Intel PCH 05:02:58.296 T:139833012303616 DEBUG: Sample Rate : 44100 05:02:58.296 T:139833012303616 DEBUG: Sample Format : AE_FMT_S32NE 05:02:58.296 T:139833012303616 DEBUG: Channel Count : 2 05:02:58.296 T:139833012303616 DEBUG: Channel Layout: FL, FR 05:02:58.296 T:139833012303616 DEBUG: Frames : 2205 05:02:58.296 T:139833012303616 DEBUG: Frame Size : 8 05:02:58.298 T:139833038960768 INFO: CKeyboardLayoutManager: loading keyboard layouts from special://xbmc/system/keyboardlayouts... 05:02:58.302 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Arabic QWERTY" successfully loaded 05:02:58.302 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian ЯВЕРТЪ" successfully loaded 05:02:58.303 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian АБВ" successfully loaded 05:02:58.303 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BasePY" successfully loaded 05:02:58.303 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BaiduPY" successfully loaded 05:02:58.303 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Croatian QWERTY" successfully loaded 05:02:58.303 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Czech QWERTZ" successfully loaded 05:02:58.303 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Danish QWERTY" successfully loaded 05:02:58.303 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "English QWERTY" successfully loaded 05:02:58.304 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "English AZERTY" successfully loaded 05:02:58.304 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "English ABC" successfully loaded 05:02:58.304 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "French AZERTY" successfully loaded 05:02:58.304 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "German QWERTZ" successfully loaded 05:02:58.304 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "German ABC" successfully loaded 05:02:58.304 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Greek QWERTY" successfully loaded 05:02:58.304 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew QWERTY" successfully loaded 05:02:58.304 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew ABC" successfully loaded 05:02:58.305 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Hungarian QWERTZ" successfully loaded 05:02:58.305 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Icelandic QWERTY" successfully loaded 05:02:58.305 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Italian QWERTY" successfully loaded 05:02:58.305 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Korean ㄱㄴㄷ" successfully loaded 05:02:58.305 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian AZERTY" successfully loaded 05:02:58.305 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian QWERTY" successfully loaded 05:02:58.305 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Norwegian QWERTY" successfully loaded 05:02:58.306 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Polish QWERTY" successfully loaded 05:02:58.306 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Portuguese (Portugal) QWERTY" successfully loaded 05:02:58.306 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Romanian QWERTY" successfully loaded 05:02:58.306 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian ЙЦУКЕН" successfully loaded 05:02:58.306 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian АБВ" successfully loaded 05:02:58.306 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Silesian QWERTY" successfully loaded 05:02:58.307 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTZ" successfully loaded 05:02:58.307 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTY" successfully loaded 05:02:58.307 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak ABC" successfully loaded 05:02:58.307 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovenian QWERTZ" successfully loaded 05:02:58.307 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Spanish QWERTY" successfully loaded 05:02:58.307 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Swedish QWERTY" successfully loaded 05:02:58.307 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Thai Kedmanee" successfully loaded 05:02:58.307 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Turkish QWERTY" successfully loaded 05:02:58.308 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian ЙЦУКЕН" successfully loaded 05:02:58.308 T:139833038960768 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian АБВ" successfully loaded 05:02:58.308 T:139833038960768 DEBUG: DBus method call to org.freedesktop.DBus.Peer.Ping at /org/freedesktop/UDisks2 of org.freedesktop.UDisks2 failed: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UDisks2 was not provided by any .service files 05:02:58.308 T:139833038960768 DEBUG: DBus method call to org.freedesktop.UDisks.EnumerateDevices at /org/freedesktop/UDisks of org.freedesktop.UDisks failed: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UDisks was not provided by any .service files 05:02:58.309 T:139833038960768 DEBUG: Selected UDev as storage provider 05:02:58.313 T:139833038960768 INFO: Available videomodes (xrandr): 05:02:58.313 T:139833038960768 INFO: Output 'DP2' has 30 modes 05:02:58.313 T:139833038960768 INFO: ID:0x48 Name:1920x1080 Refresh:60.000000 Width:1920 Height:1080 05:02:58.313 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x17d Name:1920x1080 Refresh:59.940201 Width:1920 Height:1080 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x17f Name:1920x1080 Refresh:30.000000 Width:1920 Height:1080 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x180 Name:1920x1080 Refresh:24.000000 Width:1920 Height:1080 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x182 Name:1920x1080 Refresh:29.970100 Width:1920 Height:1080 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x183 Name:1920x1080 Refresh:23.976080 Width:1920 Height:1080 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x176 Name:4096x2160 Refresh:24.000000 Width:4096 Height:2160 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 0.937500 05:02:58.314 T:139833038960768 INFO: ID:0x177 Name:4096x2160 Refresh:23.976000 Width:4096 Height:2160 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 0.937500 05:02:58.314 T:139833038960768 INFO: ID:0x178 Name:3840x2160 Refresh:30.000000 Width:3840 Height:2160 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x179 Name:3840x2160 Refresh:25.000000 Width:3840 Height:2160 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x17a Name:3840x2160 Refresh:24.000000 Width:3840 Height:2160 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x17b Name:3840x2160 Refresh:29.969999 Width:3840 Height:2160 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x17c Name:3840x2160 Refresh:23.976000 Width:3840 Height:2160 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x17e Name:1920x1080i Refresh:30.000000 Width:1920 Height:1080 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x181 Name:1920x1080i Refresh:29.970100 Width:1920 Height:1080 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x184 Name:1600x900 Refresh:60.000000 Width:1600 Height:900 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x185 Name:1280x1024 Refresh:60.019741 Width:1280 Height:1024 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.422222 05:02:58.314 T:139833038960768 INFO: ID:0x186 Name:1280x720 Refresh:60.000000 Width:1280 Height:720 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x187 Name:1280x720 Refresh:30.000000 Width:1280 Height:720 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x188 Name:1280x720 Refresh:59.940201 Width:1280 Height:720 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x189 Name:1280x720 Refresh:29.970100 Width:1280 Height:720 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x18a Name:1280x720 Refresh:24.000000 Width:1280 Height:720 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x18b Name:1280x720 Refresh:23.976160 Width:1280 Height:720 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 INFO: ID:0x18c Name:1024x768 Refresh:60.003841 Width:1024 Height:768 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.333333 05:02:58.314 T:139833038960768 INFO: ID:0x18d Name:800x600 Refresh:60.316540 Width:800 Height:600 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.333333 05:02:58.314 T:139833038960768 INFO: ID:0x18e Name:720x480 Refresh:60.000000 Width:720 Height:480 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.185185 05:02:58.314 T:139833038960768 INFO: ID:0x18f Name:720x480 Refresh:59.940060 Width:720 Height:480 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.185185 05:02:58.314 T:139833038960768 INFO: ID:0x190 Name:640x480 Refresh:60.000000 Width:640 Height:480 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.333333 05:02:58.314 T:139833038960768 INFO: ID:0x191 Name:640x480 Refresh:59.940479 Width:640 Height:480 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.333333 05:02:58.314 T:139833038960768 INFO: ID:0x192 Name:3840x2160p60 Refresh:59.940399 Width:3840 Height:2160 05:02:58.314 T:139833038960768 INFO: Pixel Ratio: 1.000000 05:02:58.314 T:139833038960768 NOTICE: Checking resolution 46 05:02:58.314 T:139833038960768 DEBUG: Window Manager Name: Fluxbox 05:02:58.363 T:139833038960768 INFO: RetroPlayer[PROCESS]: Registering process control for X11 05:02:58.363 T:139833038960768 INFO: RetroPlayer[RENDER]: Registering renderer factory for OpenGL 05:02:58.384 T:139833038960768 NOTICE: Using visual 0x20 05:02:58.408 T:139833038960768 DEBUG: Vaapi2 EGL interop test results: general yes, deepColor yes 05:02:58.409 T:139833038960768 DEBUG: libva info: VA-API version 1.3.0 05:02:58.409 T:139833038960768 DEBUG: libva info: va_getDriverName() returns 0 05:02:58.409 T:139833038960768 DEBUG: libva info: Trying to open /usr/lib/dri/i965_drv_video.so 05:02:58.409 T:139833038960768 DEBUG: libva info: Found init function __vaDriverInit_1_3 05:02:58.410 T:139833038960768 DEBUG: libva info: va_openDriver() returns 0 05:02:58.410 T:139833038960768 NOTICE: VAAPI::Close - closing decoder context 05:02:58.410 T:139833038960768 DEBUG: EGL_EXTENSIONS: EGL_ANDROID_blob_cache EGL_ANDROID_native_fence_sync EGL_CHROMIUM_sync_control EGL_EXT_create_context_robustness EGL_EXT_image_dma_buf_import EGL_EXT_image_dma_buf_import_modifiers EGL_IMG_context_priority EGL_KHR_config_attribs EGL_KHR_create_context EGL_KHR_create_context_no_error EGL_KHR_fence_sync EGL_KHR_get_all_proc_addresses EGL_KHR_gl_colorspace EGL_KHR_gl_renderbuffer_image EGL_KHR_gl_texture_2D_image EGL_KHR_gl_texture_3D_image EGL_KHR_gl_texture_cubemap_image EGL_KHR_image EGL_KHR_image_base EGL_KHR_image_pixmap EGL_KHR_no_config_context EGL_KHR_reusable_sync EGL_KHR_surfaceless_context EGL_EXT_pixel_format_float EGL_KHR_wait_sync EGL_MESA_configless_context EGL_MESA_drm_image EGL_MESA_image_dma_buf_export EGL_NOK_swap_region EGL_NOK_texture_from_pixmap EGL_NV_post_sub_buffer 05:02:58.410 T:139833038960768 NOTICE: GL_VENDOR = Intel Open Source Technology Center 05:02:58.410 T:139833038960768 NOTICE: GL_RENDERER = Mesa DRI Intel(R) HD Graphics 620 (Kaby Lake GT2) 05:02:58.410 T:139833038960768 NOTICE: GL_VERSION = 4.5 (Core Profile) Mesa 18.3.2 05:02:58.410 T:139833038960768 NOTICE: GL_SHADING_LANGUAGE_VERSION = 4.50 05:02:58.410 T:139833038960768 NOTICE: GL_EXTENSIONS = GL_3DFX_texture_compression_FXT1 GL_AMD_conservative_depth GL_AMD_depth_clamp_separate GL_AMD_draw_buffers_blend GL_AMD_gpu_shader_int64 GL_AMD_multi_draw_indirect GL_AMD_query_buffer_object GL_AMD_seamless_cubemap_per_texture GL_AMD_shader_stencil_export GL_AMD_shader_trinary_minmax GL_AMD_vertex_shader_layer GL_AMD_vertex_shader_viewport_index GL_ANGLE_texture_compression_dxt3 GL_ANGLE_texture_compression_dxt5 GL_APPLE_object_purgeable GL_ARB_ES2_compatibility GL_ARB_ES3_1_compatibility GL_ARB_ES3_2_compatibility GL_ARB_ES3_compatibility GL_ARB_arrays_of_arrays GL_ARB_base_instance GL_ARB_blend_func_extended GL_ARB_buffer_storage GL_ARB_clear_buffer_object GL_ARB_clear_texture GL_ARB_clip_control GL_ARB_compressed_texture_pixel_storage GL_ARB_compute_shader GL_ARB_conditional_render_inverted GL_ARB_conservative_depth GL_ARB_copy_buffer GL_ARB_copy_image GL_ARB_cull_distance GL_ARB_debug_output GL_ARB_depth_buffer_float GL_ARB_depth_clamp GL_ARB_derivative_control GL_ARB_direct_state_access GL_ARB_draw_buffers GL_ARB_draw_buffers_blend GL_ARB_draw_elements_base_vertex GL_ARB_draw_indirect GL_ARB_draw_instanced GL_ARB_enhanced_layouts GL_ARB_explicit_attrib_location GL_ARB_explicit_uniform_location GL_ARB_fragment_coord_conventions GL_ARB_fragment_layer_viewport GL_ARB_fragment_shader GL_ARB_fragment_shader_interlock GL_ARB_framebuffer_no_attachments GL_ARB_framebuffer_object GL_ARB_framebuffer_sRGB GL_ARB_get_program_binary GL_ARB_get_texture_sub_image GL_ARB_gpu_shader5 GL_ARB_gpu_shader_fp64 GL_ARB_gpu_shader_int64 GL_ARB_half_float_pixel GL_ARB_half_float_vertex GL_ARB_indirect_parameters GL_ARB_instanced_arrays GL_ARB_internalformat_query GL_ARB_internalformat_query2 GL_ARB_invalidate_subdata GL_ARB_map_buffer_alignment GL_ARB_map_buffer_range GL_ARB_multi_bind GL_ARB_multi_draw_indirect GL_ARB_occlusion_query2 GL_ARB_pipeline_statistics_query GL_ARB_pixel_buffer_object GL_ARB_point_sprite GL_ARB_polygon_offset_clamp GL_ARB_post_depth_coverage GL_ARB_program_interface_query GL_ARB_provoking_vertex GL_ARB_query_buffer_object GL_ARB_robust_buffer_access_behavior GL_ARB_robustness GL_ARB_sample_shading GL_ARB_sampler_objects GL_ARB_seamless_cube_map GL_ARB_seamless_cubemap_per_texture GL_ARB_separate_shader_objects GL_ARB_shader_atomic_counter_ops GL_ARB_shader_atomic_counters GL_ARB_shader_ballot GL_ARB_shader_bit_encoding GL_ARB_shader_clock GL_ARB_shader_draw_parameters GL_ARB_shader_group_vote GL_ARB_shader_image_load_store GL_ARB_shader_image_size GL_ARB_shader_objects GL_ARB_shader_precision GL_ARB_shader_stencil_export GL_ARB_shader_storage_buffer_object GL_ARB_shader_subroutine GL_ARB_shader_texture_image_samples GL_ARB_shader_texture_lod GL_ARB_shader_viewport_layer_array GL_ARB_shading_language_420pack GL_ARB_shading_language_packing GL_ARB_stencil_texturing GL_ARB_sync GL_ARB_tessellation_shader GL_ARB_texture_barrier GL_ARB_texture_buffer_object GL_ARB_texture_buffer_object_rgb32 GL_ARB_texture_buffer_range GL_ARB_texture_compression_bptc GL_ARB_texture_compression_rgtc GL_ARB_texture_cube_map_array GL_ARB_texture_filter_anisotropic GL_ARB_texture_float GL_ARB_texture_gather GL_ARB_texture_mirror_clamp_to_edge GL_ARB_texture_multisample GL_ARB_texture_non_power_of_two GL_ARB_texture_query_levels GL_ARB_texture_query_lod GL_ARB_texture_rectangle GL_ARB_texture_rg GL_ARB_texture_rgb10_a2ui GL_ARB_texture_stencil8 GL_ARB_texture_storage GL_ARB_texture_storage_multisample GL_ARB_texture_swizzle GL_ARB_texture_view GL_ARB_timer_query GL_ARB_transform_feedback2 GL_ARB_transform_feedback3 GL_ARB_transform_feedback_instanced GL_ARB_transform_feedback_overflow_query GL_ARB_uniform_buffer_object GL_ARB_vertex_array_bgra GL_ARB_vertex_array_object GL_ARB_vertex_attrib_64bit GL_ARB_vertex_attrib_binding GL_ARB_vertex_buffer_object GL_ARB_vertex_shader GL_ARB_vertex_type_10f_11f_11f_rev GL_ARB_vertex_type_2_10_10_10_rev GL_ARB_viewport_array GL_ATI_blend_equation_separate GL_ATI_texture_float GL_EXT_abgr GL_EXT_blend_equation_separate GL_EXT_draw_buffers2 GL_EXT_draw_instanced GL_EXT_framebuffer_blit GL_EXT_framebuffer_multisample GL_EXT_framebuffer_multisample_blit_scaled GL_EXT_framebuffer_object GL_EXT_framebuffer_sRGB GL_EXT_packed_depth_stencil GL_EXT_packed_float GL_EXT_pixel_buffer_object GL_EXT_polygon_offset_clamp GL_EXT_provoking_vertex GL_EXT_shader_framebuffer_fetch GL_EXT_shader_framebuffer_fetch_non_coherent GL_EXT_shader_integer_mix GL_EXT_shader_samples_identical GL_EXT_texture_array GL_EXT_texture_compression_dxt1 GL_EXT_texture_compression_rgtc GL_EXT_texture_compression_s3tc GL_EXT_texture_filter_anisotropic GL_EXT_texture_integer GL_EXT_texture_sRGB GL_EXT_texture_sRGB_decode GL_EXT_texture_shared_exponent GL_EXT_texture_snorm GL_EXT_texture_swizzle GL_EXT_timer_query GL_EXT_transform_feedback GL_EXT_vertex_array_bgra GL_EXT_vertex_attrib_64bit GL_IBM_multimode_draw_arrays GL_INTEL_conservative_rasterization GL_INTEL_performance_query GL_INTEL_shader_atomic_float_minmax GL_KHR_blend_equation_advanced GL_KHR_blend_equation_advanced_coherent GL_KHR_context_flush_control GL_KHR_debug GL_KHR_no_error GL_KHR_robust_buffer_access_behavior GL_KHR_robustness GL_KHR_texture_compression_astc_ldr GL_KHR_texture_compression_astc_sliced_3d GL_MESA_pack_invert GL_MESA_shader_integer_functions GL_MESA_texture_signed_rgba GL_NV_conditional_render GL_NV_depth_clamp GL_NV_fragment_shader_interlock GL_NV_packed_depth_stencil GL_NV_texture_barrier GL_OES_EGL_image GL_S3_s3tc 05:02:58.425 T:139833038960768 NOTICE: CWinSystemX11::SetFullScreen - calling xrandr 05:02:58.425 T:139833038960768 DEBUG: OnLostDevice - notify display change event 05:02:58.649 T:139833038960768 INFO: XRANDR: /usr/lib/kodi/kodi-xrandr --screen 0 --output DP2 --mode 0x192 05:02:58.768 T:139833038960768 INFO: GL: Maximum texture width: 16384 05:02:58.768 T:139833038960768 DEBUG: guilib: Fill viewport on change for solving rendering passes 05:02:58.768 T:139833038960768 DEBUG: StereoscopicsManager: stereo mode setting changed to off 05:02:58.768 T:139833038960768 DEBUG: StereoscopicsManager::ApplyStereoMode: trying to apply stereo mode. Current: off | Target: off 05:02:58.892 T:139833038960768 INFO: GL: Enabling VSYNC 05:02:58.899 T:139833038960768 INFO: load keymapping 05:02:58.900 T:139833038960768 INFO: Loading special://xbmc/system/keymaps/appcommand.xml 05:02:58.902 T:139833038960768 INFO: Loading special://xbmc/system/keymaps/customcontroller.AppleRemote.xml 05:02:58.902 T:139833038960768 INFO: Loading special://xbmc/system/keymaps/customcontroller.Harmony.xml 05:02:58.904 T:139833038960768 INFO: Loading special://xbmc/system/keymaps/gamepad.xml 05:02:58.905 T:139833038960768 INFO: Loading special://xbmc/system/keymaps/joystick.xml 05:02:58.906 T:139833038960768 INFO: Loading special://xbmc/system/keymaps/keyboard.xml 05:02:58.909 T:139833038960768 INFO: Loading special://xbmc/system/keymaps/mouse.xml 05:02:58.909 T:139833038960768 INFO: Loading special://xbmc/system/keymaps/remote.xml 05:02:58.911 T:139833038960768 INFO: Loading special://xbmc/system/keymaps/touchscreen.xml 05:02:58.912 T:139833038960768 INFO: GUI format 3840x2160, Display DP2: 3840x2160p60 @ 59.94Hz 05:02:58.912 T:139833038960768 INFO: CLangInfo: loading resource.language.en_gb language information... 05:02:58.914 T:139833038960768 DEBUG: trying to set locale to en_US.UTF-8 05:02:58.919 T:139833038960768 INFO: global locale set to C 05:02:58.919 T:139833038960768 INFO: CLangInfo: loading resource.language.en_gb language strings... 05:02:58.930 T:139833038960768 DEBUG: LocalizeStrings: loaded 4000 strings from file resource://resource.language.en_gb/strings.po 05:02:58.934 T:139833038960768 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.kodi.builtin.aac/resources/language/English/strings.po 05:02:58.934 T:139833038960768 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.kodi.builtin.wma/resources/language/English/strings.po 05:02:58.935 T:139833038960768 DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/game.controller.default/resources/language/resource.language.en_gb/strings.po 05:02:58.935 T:139833038960768 DEBUG: LocalizeStrings: loaded 13 strings from file /usr/share/kodi/addons/game.controller.snes/resources/language/resource.language.en_gb/strings.po 05:02:58.937 T:139833038960768 DEBUG: LocalizeStrings: loaded 17 strings from file /usr/share/kodi/addons/metadata.album.universal/resources/language/English/strings.po 05:02:58.937 T:139833038960768 DEBUG: LocalizeStrings: loaded 32 strings from file /usr/share/kodi/addons/metadata.artists.universal/resources/language/English/strings.po 05:02:58.939 T:139833038960768 DEBUG: LocalizeStrings: loaded 8 strings from file /usr/share/kodi/addons/metadata.themoviedb.org/resources/language/English/strings.po 05:02:58.940 T:139833038960768 DEBUG: LocalizeStrings: loaded 5 strings from file /storage/.kodi/addons/metadata.tvshows.themoviedb.org/resources/language/English/strings.po 05:02:58.941 T:139833038960768 DEBUG: LocalizeStrings: loaded 9 strings from file /usr/share/kodi/addons/peripheral.joystick/resources/language/English/strings.po 05:02:58.943 T:139833038960768 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.en_gb/strings.po 05:02:58.945 T:139833038960768 DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/script.program.driverselect/resources/language/resource.language.en_gb/strings.po 05:02:58.947 T:139833038960768 DEBUG: LocalizeStrings: loaded 230 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/resource.language.en_gb/strings.po 05:02:58.948 T:139832908822272 DEBUG: Thread JobWorker start, auto delete: true 05:02:58.948 T:139832908822272 DEBUG: Initialize, updating databases... 05:02:58.948 T:139832908822272 NOTICE: Running database version Addons27 05:02:58.949 T:139832908822272 NOTICE: Running database version ViewModes6 05:02:58.950 T:139832908822272 NOTICE: Running database version Textures13 05:02:58.951 T:139832908822272 NOTICE: Running database version MyMusic72 05:02:58.955 T:139832908822272 NOTICE: Running database version MyVideos116 05:02:58.955 T:139832908822272 NOTICE: Running database version TV32 05:02:58.956 T:139832908822272 NOTICE: Running database version Epg12 05:02:58.956 T:139832908822272 DEBUG: Initialize, updating databases... DONE 05:02:58.963 T:139833038960768 NOTICE: start dvd mediatype detection 05:02:58.963 T:139832900364032 DEBUG: Thread DetectDVDMedia start, auto delete: false 05:02:58.964 T:139832900364032 DEBUG: Compiled with libcdio Version 0.94 05:02:58.964 T:139833038960768 DEBUG: DPMS: supported power-saving modes: SUSPEND OFF STANDBY 05:02:58.964 T:139832900364032 DEBUG: Thread DetectDVDMedia 139832900364032 terminating 05:02:58.973 T:139833038956288 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 05:02:58.973 T:139833038956288 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 05:02:58.985 T:139833038960768 INFO: Unloading old skin ... 05:02:58.985 T:139833038960768 NOTICE: load skin from: /usr/share/kodi/addons/skin.estuary (version: 2.0.21) 05:02:58.985 T:139833038960768 INFO: load fonts for skin... 05:02:58.990 T:139833038960768 INFO: Loading skin includes from /usr/share/kodi/addons/skin.estuary/xml/Includes.xml 05:02:59.019 T:139833038960768 INFO: Loading fonts from /usr/share/kodi/addons/skin.estuary/xml/Font.xml 05:02:59.047 T:139833038960768 DEBUG: LocalizeStrings: loaded 140 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.en_gb/strings.po 05:02:59.047 T:139833038960768 INFO: load new skin... 05:02:59.047 T:139833038960768 INFO: Loading custom window XMLs from skin path /usr/share/kodi/addons/skin.estuary/xml 05:02:59.051 T:139833038960768 DEBUG: Load Skin XML: 3.63ms 05:02:59.051 T:139833038960768 INFO: initialize new skin... 05:02:59.051 T:139833038960768 DEBUG: guilib: Fill viewport on change for solving rendering passes 05:02:59.051 T:139833038960768 INFO: Loading skin file: Custom_1109_TopBarOverlay.xml, load type: LOAD_ON_GUI_INIT 05:02:59.052 T:139833038960768 INFO: Loading skin file: DialogNotification.xml, load type: LOAD_ON_GUI_INIT 05:02:59.054 T:139833038960768 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT 05:02:59.062 T:139833038960768 DEBUG: OpenBundle - Opened bundle /usr/share/kodi/addons/skin.estuary/media/Textures.xbt 05:02:59.065 T:139833038960768 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT 05:02:59.066 T:139833038960768 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT 05:02:59.066 T:139833038960768 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT 05:02:59.067 T:139833038960768 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT 05:02:59.068 T:139833038960768 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT 05:02:59.069 T:139833038960768 INFO: Loading resource://resource.uisounds.kodi/sounds.xml 05:02:59.086 T:139833038960768 INFO: skin loaded... 05:02:59.086 T:139833038960768 DEBUG: Activating window ID: 12997 05:02:59.086 T:139833038960768 DEBUG: ------ Window Init () ------ 05:02:59.086 T:139833038960768 DEBUG: Activating window ID: 12999 05:02:59.086 T:139833038960768 DEBUG: ------ Window Init (Startup.xml) ------ 05:02:59.086 T:139833038960768 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME 05:02:59.086 T:139833038960768 DEBUG: Activating window ID: 10000 05:02:59.086 T:139833038960768 DEBUG: ------ Window Deinit (Startup.xml) ------ 05:02:59.086 T:139833038960768 DEBUG: ------ Window Init (Home.xml) ------ 05:02:59.086 T:139833038960768 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY 05:02:59.124 T:139833038960768 DEBUG: CDirectoryProvider[addons://]: refreshing.. 05:02:59.124 T:139833038960768 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 05:02:59.124 T:139833038960768 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 05:02:59.124 T:139833038960768 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing.. 05:02:59.124 T:139833038960768 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 05:02:59.124 T:139832890828544 DEBUG: Thread JobWorker start, auto delete: true 05:02:59.124 T:139833038960768 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 05:02:59.124 T:139833038960768 DEBUG: CDirectoryProvider[library://video/]: refreshing.. 05:02:59.124 T:139833038960768 DEBUG: CDirectoryProvider[sources://video/]: refreshing.. 05:02:59.124 T:139833038960768 DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing.. 05:02:59.124 T:139832882435840 DEBUG: Thread JobWorker start, auto delete: true 05:02:59.124 T:139833038960768 DEBUG: CDirectoryProvider[favourites://]: refreshing.. 05:02:59.124 T:139833038960768 DEBUG: CDirectoryProvider[sources://pictures/]: refreshing.. 05:02:59.124 T:139833038960768 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing.. 05:02:59.129 T:139832908822272 DEBUG: CAddonMgr::GetAvailableUpdates took 5 ms 05:02:59.139 T:139833038960768 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting 05:02:59.139 T:139833038960768 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 05:02:59.139 T:139833038960768 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting") 05:02:59.139 T:139833038960768 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting 05:02:59.141 T:139832908822272 DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3a%2f%2fprofile%2fplaylists%2fvideo/special%3a%2f%2fprofile%2fplaylists%2fmixed/) 05:02:59.141 T:139832908822272 DEBUG: Getting Directory (special://profile/playlists/video) 05:02:59.141 T:139832908822272 DEBUG: Getting Directory (special://profile/playlists/mixed) 05:02:59.141 T:139832908822272 DEBUG: CMultiPathDirectory::MergeItems, items = 0 05:02:59.145 T:139832882435840 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update 05:02:59.148 T:139832882435840 DEBUG: GetRecentlyAddedAlbumSongs() query: SELECT songview.*, songartistview.* FROM (SELECT idAlbum FROM album ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN songview ON songview.idAlbum = recentalbums.idAlbum JOIN songartistview ON songview.idSong = songartistview.idSong ORDER BY songview.idAlbum DESC, songview.idSong, songartistview.idRole, songartistview.iOrder 05:02:59.149 T:139832882435840 DEBUG: GetRecentlyAddedAlbums query: SELECT albumview.*, albumartistview.* FROM (SELECT idAlbum FROM album WHERE strAlbum != '' ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN albumview ON albumview.idAlbum = recentalbums.idAlbum JOIN albumartistview ON albumview.idAlbum = albumartistview.idAlbum ORDER BY albumview.idAlbum desc, albumartistview.iOrder 05:02:59.150 T:139832882435840 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update 05:02:59.150 T:139833038960768 INFO: JSONRPC v10.1.1: Successfully initialized 05:02:59.151 T:139833038960768 DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid" 05:02:59.151 T:139833038960768 DEBUG: LoadMappings - loaded node "CEC Adapter" 05:02:59.151 T:139833038960768 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter" 05:02:59.151 T:139833038960768 DEBUG: LoadMappings - loaded node "iMON HID device" 05:02:59.151 T:139833038960768 DEBUG: LoadMappings - loaded node "WETEK Play remote" 05:02:59.151 T:139833038960768 DEBUG: LoadMappings - loaded node "" 05:02:59.151 T:139833038960768 DEBUG: CPeripheralBusUSB - initialised udev monitor 05:02:59.151 T:139833038960768 DEBUG: Add-on bus: Registering add-on peripheral.joystick 05:02:59.151 T:139833038960768 DEBUG: PERIPHERAL - CreateAddon - creating peripheral add-on instance 'Joystick Support' 05:02:59.151 T:139833038960768 DEBUG: ADDON: Dll Initializing - Joystick Support 05:02:59.152 T:139833038960768 DEBUG: SECTION:LoadDLL(/usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.4.6) 05:02:59.152 T:139833038960768 DEBUG: Loading: /usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.4.6 05:02:59.154 T:139832882435840 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 05:02:59.155 T:139832882435840 DEBUG: GetArtistsByWhere query: SELECT COUNT(DISTINCT artistview.idArtist) FROM artistview WHERE ((EXISTS (SELECT 1 FROM song_artist WHERE song_artist.idArtist = artistview.idArtist AND song_artist.idRole = 1) OR EXISTS (SELECT 1 FROM album_artist WHERE album_artist.idArtist = artistview.idArtist)) AND (artistview.strArtist != '')) AND (artistview.strArtist <> 'Various artists') 05:02:59.159 T:139833038960768 DEBUG: AddOnLog: Joystick Support: Loaded 14 joystick families with 97 total joysticks 05:02:59.159 T:139833038960768 DEBUG: Calling TransferSettings for: Joystick Support 05:02:59.159 T:139833038960768 DEBUG: CAddonSettings[peripheral.joystick]: loading setting definitions 05:02:59.159 T:139833038960768 INFO: AddOnLog: Joystick Support: Enabling joystick interface "linux" 05:02:59.159 T:139832584038144 DEBUG: Thread PeripBusUSBUdev start, auto delete: false 05:02:59.159 T:139832575645440 DEBUG: Thread PeripBusCEC start, auto delete: false 05:02:59.159 T:139832567252736 DEBUG: Thread PeripBusAddon start, auto delete: false 05:02:59.159 T:139833038960768 DEBUG: Initialise - initialised peripheral on 'keyboard' with 1 features and 0 sub devices 05:02:59.159 T:139833038960768 NOTICE: Register - new keyboard device registered on application->keyboard: Keyboard (0000:0000) 05:02:59.160 T:139833038960768 DEBUG: Initialise - initialised peripheral on 'mouse' with 1 features and 0 sub devices 05:02:59.160 T:139833038960768 NOTICE: Register - new mouse device registered on application->mouse: Mouse (0000:0000) 05:02:59.160 T:139832558860032 DEBUG: Thread PeripEventScanner start, auto delete: false 05:02:59.160 T:139833038960768 DEBUG: ContextMenuManager: addon menus reloaded. 05:02:59.160 T:139833038960768 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 05:02:59.161 T:139833038960768 DEBUG: CPlayerCoreConfig::: created player VideoPlayer 05:02:59.161 T:139833038960768 DEBUG: CPlayerCoreConfig::: created player PAPlayer 05:02:59.161 T:139833038960768 DEBUG: CPlayerCoreConfig::: created player RetroPlayer 05:02:59.161 T:139833038960768 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules 05:02:59.161 T:139833038960768 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mms/udp 05:02:59.161 T:139833038960768 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout 05:02:59.161 T:139833038960768 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp 05:02:59.161 T:139833038960768 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp 05:02:59.161 T:139833038960768 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams 05:02:59.161 T:139833038960768 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp 05:02:59.161 T:139833038960768 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2 05:02:59.161 T:139833038960768 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd 05:02:59.161 T:139833038960768 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage 05:02:59.161 T:139833038960768 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf 05:02:59.161 T:139833038960768 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv 05:02:59.161 T:139833038960768 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio 05:02:59.161 T:139833038960768 NOTICE: Loaded playercorefactory configuration 05:02:59.161 T:139833038960768 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 05:02:59.161 T:139833038960768 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 05:02:59.161 T:139833038960768 INFO: removing tempfiles 05:02:59.165 T:139833038960768 DEBUG: CRepositoryUpdater: previous update at 02/06/2019 9:47:02 PM, next at 02/07/2019 9:47:02 PM 05:02:59.165 T:139832550467328 DEBUG: Thread Timer start, auto delete: false 05:02:59.165 T:139833038960768 DEBUG: CServiceAddonManager: starting service.libreelec.settings 05:02:59.166 T:139833038960768 NOTICE: initialize done 05:02:59.166 T:139833038960768 NOTICE: Running the application... 05:02:59.166 T:139832542074624 DEBUG: Thread LanguageInvoker start, auto delete: false 05:02:59.166 T:139832542074624 INFO: initializing python engine. 05:02:59.166 T:139833038960768 DEBUG: no profile autoexec.py (/storage/.kodi/userdata/autoexec.py) found, skipping 05:02:59.166 T:139833038960768 DEBUG: NetworkMessage - Starting network services 05:02:59.168 T:139833038960768 DEBUG: CZeroconfAvahi::clientCallback: client is up and running 05:02:59.168 T:139833038960768 NOTICE: starting zeroconf publishing 05:02:59.168 T:139833038960768 NOTICE: CWebServer[8080]: Started 05:02:59.168 T:139832882435840 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:Kodi (Bedroom) port:8080 05:02:59.168 T:139832890828544 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:Kodi (Bedroom) port:8080 05:02:59.168 T:139832882435840 DEBUG: CZeroconfAvahi::addService() named: Kodi (Bedroom) type: _http._tcp port:8080 05:02:59.169 T:139831896164096 DEBUG: Thread EventServer start, auto delete: false 05:02:59.169 T:139831896164096 NOTICE: ES: Starting UDP Event server on port 9777 05:02:59.169 T:139831896164096 NOTICE: UDP: Listening on port 9777 (ipv6 : false) 05:02:59.169 T:139832908822272 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:Kodi (Bedroom) port:9777 05:02:59.170 T:139832890828544 DEBUG: CZeroconfAvahi::addService() named: Kodi (Bedroom) type: _xbmc-jsonrpc-h._tcp port:8080 05:02:59.170 T:139833038960768 DEBUG: GetFirstConnectedInterface no connected interface found - requery list 05:02:59.170 T:139833038960768 DEBUG: SECTION:LoadDLL(libshairplay.so.0) 05:02:59.171 T:139833038960768 DEBUG: Loading: libshairplay.so.0 05:02:59.174 T:139832908822272 DEBUG: CZeroconfAvahi::addService() named: Kodi (Bedroom) type: _xbmc-events._udp port:9777 05:02:59.174 T:139833038960768 DEBUG: GetFirstConnectedInterface no connected interface found - requery list 05:02:59.174 T:139832882435840 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airtunes type: _raop._tcp name:000102030405@Kodi (Bedroom) port:36666 05:02:59.178 T:139831921342208 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 05:02:59.178 T:139832882435840 DEBUG: Previous line repeats 2 times. 05:02:59.178 T:139832882435840 DEBUG: CZeroconfAvahi::addService() named: 000102030405@Kodi (Bedroom) type: _raop._tcp port:36666 05:02:59.180 T:139831921342208 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 05:02:59.180 T:139832542074624 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): start processing 05:02:59.189 T:139832542074624 DEBUG: -->Python Interpreter Initialized<-- 05:02:59.190 T:139832542074624 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): the source file to load is "/usr/share/kodi/addons/service.libreelec.settings/service.py" 05:02:59.190 T:139832542074624 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): setting the Python path to /usr/share/kodi/addons/service.libreelec.settings:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/gtk-2.0 05:02:59.190 T:139832542074624 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): entering source directory /usr/share/kodi/addons/service.libreelec.settings 05:02:59.190 T:139832542074624 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): instantiating addon using automatically obtained id of "service.libreelec.settings" dependent on version 2.1.0 of the xbmc.python api 05:02:59.253 T:139833038960768 DEBUG: ------ Window Init () ------ 05:02:59.256 T:139833038960768 DEBUG: NotifyXRREvent - notify display reset event 05:02:59.269 T:139833038960768 DEBUG: RecreateWindow - current output: DP2, mode: 0x192, refresh: 59.940 05:02:59.270 T:139833038960768 DEBUG: OnLostDevice - notify display change event 05:02:59.282 T:139833038960768 DEBUG: Window Manager Name: Fluxbox 05:02:59.289 T:139833038960768 DEBUG: CWinSystemX11::RefreshEGLContext: refreshing context 05:02:59.297 T:139833020696320 DEBUG: CActiveAE - display reset event 05:02:59.297 T:139833012303616 INFO: CActiveAESink::OpenSink - initialize sink 05:02:59.297 T:139833012303616 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=1 05:02:59.297 T:139833012303616 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=1" 05:02:59.299 T:139833038960768 INFO: GL: Maximum texture width: 16384 05:02:59.300 T:139833012303616 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=1,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00" 05:02:59.300 T:139833012303616 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 05:02:59.300 T:139833012303616 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 05:02:59.300 T:139833012303616 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2205, bufferSize 8820 05:02:59.312 T:139833012303616 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2205, bufferSize 8820 05:02:59.312 T:139833012303616 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms 05:02:59.313 T:139833012303616 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 05:02:59.313 T:139833012303616 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL, FR 05:02:59.313 T:139833012303616 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL, FR (ALSA: FL FR) 05:02:59.313 T:139833012303616 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 05:02:59.313 T:139833012303616 DEBUG: Output Device : HDA Intel PCH 05:02:59.313 T:139833012303616 DEBUG: Sample Rate : 44100 05:02:59.313 T:139833012303616 DEBUG: Sample Format : AE_FMT_S32NE 05:02:59.313 T:139833012303616 DEBUG: Channel Count : 2 05:02:59.313 T:139833012303616 DEBUG: Channel Layout: FL, FR 05:02:59.313 T:139833012303616 DEBUG: Frames : 2205 05:02:59.313 T:139833012303616 DEBUG: Frame Size : 8 05:02:59.313 T:139833020696320 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 05:02:59.337 T:139833038960768 INFO: GL: Enabling VSYNC 05:02:59.338 T:139833038960768 DEBUG: ------ Window Init (DialogNotification.xml) ------ 05:02:59.379 T:139832542074624 DEBUG: ## LibreELEC Addon ## 9.0.0 05:02:59.655 T:139832542074624 INFO: ## LibreELEC Addon ## system::set_hostname ## Bedroom 05:02:59.656 T:139832542074624 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## us,us -model pc105 05:02:59.670 T:139833038960768 DEBUG: LogindUPowerSyscall - Received unknown signal NameAcquired 05:02:59.734 T:139832542074624 ERROR: ## LibreELEC Addon ## oe::load_url(http://releases.libreelec.tv/releases.json) ## ERROR: (URLError(gaierror(-3, 'Temporary failure in name resolution'),)) 05:02:59.734 T:139832542074624 ERROR: Traceback (most recent call last): File "/var/lib/jenkins/LE/build2/workspace/Generic/build.LibreELEC-Generic.x86_64-9.0.0/LibreELEC-settings-37e206b712a46213522a567a408382f5f082502a/.install_pkg/usr/share/kodi/addons/service.libreelec.settings/oe.py", line 270, in load_url File "/usr/lib/python2.7/urllib2.py", line 154, in urlopen File "/usr/lib/python2.7/urllib2.py", line 429, in open File "/usr/lib/python2.7/urllib2.py", line 447, in _open File "/usr/lib/python2.7/urllib2.py", line 407, in _call_chain File "/usr/lib/python2.7/urllib2.py", line 1228, in http_open File "/usr/lib/python2.7/urllib2.py", line 1198, in do_open URLError: 05:02:59.734 T:139832542074624 INFO: ## LibreELEC Addon ## updates::updateThread ## Started 05:02:59.736 T:139832542074624 INFO: ## LibreELEC Addon ## updates::set_auto_update ## auto 05:02:59.744 T:139831868450560 ERROR: ## LibreELEC Addon ## oe::load_url(https://update.libreelec.tv/updates.php?i=3785315ce99d9f35c7f100e75c5a0440&d=LibreELEC&pa=Generic.x86_64&v=9.0.0&f=i915) ## ERROR: (URLError(gaierror(-3, 'Temporary failure in name resolution'),)) 05:02:59.744 T:139831868450560 ERROR: Traceback (most recent call last): File "/var/lib/jenkins/LE/build2/workspace/Generic/build.LibreELEC-Generic.x86_64-9.0.0/LibreELEC-settings-37e206b712a46213522a567a408382f5f082502a/.install_pkg/usr/share/kodi/addons/service.libreelec.settings/oe.py", line 270, in load_url File "/usr/lib/python2.7/urllib2.py", line 154, in urlopen File "/usr/lib/python2.7/urllib2.py", line 429, in open File "/usr/lib/python2.7/urllib2.py", line 447, in _open File "/usr/lib/python2.7/urllib2.py", line 407, in _call_chain File "/usr/lib/python2.7/urllib2.py", line 1241, in https_open File "/usr/lib/python2.7/urllib2.py", line 1198, in do_open URLError: 05:02:59.745 T:139831868450560 ERROR: ## LibreELEC Addon ## updates::check_updates_v2 ## ERROR: (TypeError('expected string or buffer',)) 05:02:59.745 T:139831868450560 ERROR: Traceback (most recent call last): File "/var/lib/jenkins/LE/build2/workspace/Generic/build.LibreELEC-Generic.x86_64-9.0.0/LibreELEC-settings-37e206b712a46213522a567a408382f5f082502a/.install_pkg/usr/share/kodi/addons/service.libreelec.settings/resources/lib/modules/updates.py", line 501, in check_updates_v2 File "/usr/lib/python2.7/json/__init__.py", line 339, in loads File "/usr/lib/python2.7/json/decoder.py", line 364, in decode TypeError: expected string or buffer 05:02:59.754 T:139831711622912 INFO: ## LibreELEC Addon ## _service_::run ## WAITING: 05:02:59.760 T:139831720015616 INFO: ## LibreELEC Addon ## xdbus Monitor started. ## 05:03:05.836 T:139833038960768 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 05:03:06.925 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:06.926 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:06.984 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:07.085 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:07.085 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:07.169 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:07.256 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:07.256 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:07.354 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:07.590 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:07.590 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:07.690 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:07.723 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:07.723 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:07.857 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:07.941 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:07.941 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:08.057 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:08.140 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:08.140 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:08.238 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:08.327 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:08.327 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:08.422 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:08.510 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:08.510 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:08.605 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:09.485 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 05:03:09.614 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x0000, modifier: 0x0 05:03:09.614 T:139833038960768 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 05:03:09.614 T:139833038960768 DEBUG: Activating window ID: 10025 05:03:09.925 T:139833038960768 DEBUG: ------ Window Deinit (Home.xml) ------ 05:03:09.925 T:139833038960768 DEBUG: FreeVisualisation() done 05:03:09.935 T:139833038960768 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 05:03:09.935 T:139833038960768 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 05:03:09.975 T:139833038960768 DEBUG: CDirectoryProvider[]: refreshing.. 05:03:09.975 T:139832890828544 DEBUG: Previous line repeats 1 times. 05:03:09.975 T:139832890828544 ERROR: GetDirectory - Error getting 05:03:09.975 T:139833038960768 DEBUG: CDirectoryProvider[]: refreshing.. 05:03:09.975 T:139832908822272 ERROR: GetDirectory - Error getting 05:03:09.975 T:139833038960768 DEBUG: CDirectoryProvider[]: refreshing.. 05:03:09.975 T:139832882435840 DEBUG: Previous line repeats 2 times. 05:03:09.975 T:139832882435840 ERROR: GetDirectory - Error getting 05:03:09.975 T:139833038960768 DEBUG: CDirectoryProvider[]: refreshing.. 05:03:09.975 T:139832890828544 ERROR: GetDirectory - Error getting 05:03:09.975 T:139833038960768 ERROR: Previous line repeats 3 times. 05:03:09.975 T:139833038960768 DEBUG: CGUIMediaWindow::GetDirectory () 05:03:09.975 T:139833038960768 DEBUG: ParentPath = [] 05:03:10.003 T:139831703230208 DEBUG: Thread BackgroundLoader start, auto delete: false 05:03:10.005 T:139831703230208 DEBUG: Thread BackgroundLoader 139831703230208 terminating 05:03:10.523 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 05:03:10.657 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x0000, modifier: 0x0 05:03:10.657 T:139833038960768 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 05:03:10.658 T:139833038960768 DEBUG: CGUIMediaWindow::GetDirectory (library://video/files.xml/) 05:03:10.658 T:139833038960768 DEBUG: ParentPath = [] 05:03:10.659 T:139831703230208 DEBUG: Thread waiting start, auto delete: false 05:03:10.682 T:139831703230208 DEBUG: Thread waiting 139831703230208 terminating 05:03:10.705 T:139831703230208 DEBUG: Thread BackgroundLoader start, auto delete: false 05:03:10.711 T:139831703230208 DEBUG: Thread BackgroundLoader 139831703230208 terminating 05:03:11.459 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:11.460 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:11.592 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:11.826 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 05:03:12.014 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x0000, modifier: 0x0 05:03:12.014 T:139833038960768 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 05:03:12.015 T:139833038960768 DEBUG: CGUIMediaWindow::GetDirectory (nfs://192.168.1.205/lake/movies/) 05:03:12.015 T:139833038960768 DEBUG: ParentPath = [sources://video/] 05:03:12.016 T:139831703230208 DEBUG: Thread waiting start, auto delete: false 05:03:12.022 T:139831703230208 DEBUG: NFS: Context for 192.168.1.205/lake/movies not open - get a new context. 05:03:12.033 T:139831703230208 DEBUG: NFS: Connected to server 192.168.1.205 and export /lake/movies 05:03:12.033 T:139831703230208 DEBUG: NFS: chunks: r/w 1048576/1048576 05:03:12.060 T:139831703230208 DEBUG: Thread waiting 139831703230208 terminating 05:03:12.078 T:139831703230208 DEBUG: Thread BackgroundLoader start, auto delete: false 05:03:12.574 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:12.574 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:12.657 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:12.741 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:12.741 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:12.807 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:12.891 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:12.891 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:12.974 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:13.041 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:13.041 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:13.141 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:13.441 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 05:03:13.574 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x0000, modifier: 0x0 05:03:13.575 T:139833038960768 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 05:03:13.579 T:139831703230208 DEBUG: Thread BackgroundLoader 139831703230208 terminating 05:03:13.579 T:139833038960768 DEBUG: CGUIMediaWindow::GetDirectory (nfs://192.168.1.205/lake/movies/3D/) 05:03:13.579 T:139833038960768 DEBUG: ParentPath = [nfs://192.168.1.205/lake/movies/] 05:03:13.580 T:139831703230208 DEBUG: Thread waiting start, auto delete: false 05:03:13.632 T:139831703230208 DEBUG: Thread waiting 139831703230208 terminating 05:03:13.661 T:139831703230208 DEBUG: Thread BackgroundLoader start, auto delete: false 05:03:13.946 T:139831703230208 DEBUG: Thread BackgroundLoader 139831703230208 terminating 05:03:14.219 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:14.220 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:14.280 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:14.330 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:14.330 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:14.430 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:14.511 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:14.511 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:14.650 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:16.168 T:139833038960768 DEBUG: Keyboard: scancode: 0x72, sym: 0x0113, unicode: 0x0000, modifier: 0x0 05:03:16.168 T:139833038960768 DEBUG: HandleKey: right (0xf083) pressed, action is Right 05:03:16.231 T:139833038960768 DEBUG: Keyboard: scancode: 0x72, sym: 0x0113, unicode: 0x0000, modifier: 0x0 05:03:16.448 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:16.448 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:16.545 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:16.647 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:16.647 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:16.747 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:17.148 T:139833038960768 DEBUG: Keyboard: scancode: 0x71, sym: 0x0114, unicode: 0x0000, modifier: 0x0 05:03:17.148 T:139833038960768 DEBUG: HandleKey: left (0xf082) pressed, action is Left 05:03:17.281 T:139833038960768 DEBUG: Keyboard: scancode: 0x71, sym: 0x0114, unicode: 0x0000, modifier: 0x0 05:03:17.556 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:03:17.556 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:03:17.601 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:03:17.682 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:17.682 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:03:17.782 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:03:17.818 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:17.819 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:03:17.914 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:03:17.998 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:17.998 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:03:18.065 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:03:18.148 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:18.149 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:03:18.232 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:03:18.282 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:18.282 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:03:18.365 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:03:18.431 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:18.431 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:03:18.534 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:03:19.100 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:19.100 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:03:19.272 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:03:19.338 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:19.338 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:03:19.472 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:03:19.706 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 05:03:19.840 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x0000, modifier: 0x0 05:03:19.840 T:139833038960768 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 05:03:19.841 T:139833038960768 DEBUG: CGUIMediaWindow::GetDirectory (nfs://192.168.1.205/lake/movies/3D/IMAX - Space Station 3D/) 05:03:19.841 T:139833038960768 DEBUG: ParentPath = [nfs://192.168.1.205/lake/movies/3D/] 05:03:19.842 T:139831703230208 DEBUG: Thread waiting start, auto delete: false 05:03:19.845 T:139831703230208 DEBUG: Thread waiting 139831703230208 terminating 05:03:19.866 T:139831703230208 DEBUG: Thread BackgroundLoader start, auto delete: false 05:03:19.875 T:139831703230208 DEBUG: Thread BackgroundLoader 139831703230208 terminating 05:03:20.670 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:20.670 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:20.752 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:20.853 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:03:20.853 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:03:20.968 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:03:21.546 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 05:03:21.674 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x0000, modifier: 0x0 05:03:21.674 T:139833038960768 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 05:03:21.682 T:139833038960768 DEBUG: OnPlayMedia nfs://192.168.1.205/lake/movies/3D/IMAX - Space Station 3D/IMAX Space Station 3D 3D-SBS 1080p-lr.mkv 05:03:21.691 T:139833038956288 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 05:03:21.691 T:139833038956288 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 05:03:21.691 T:139833038960768 DEBUG: CPlayerCoreFactory::GetPlayers(nfs://192.168.1.205/lake/movies/3D/IMAX - Space Station 3D/IMAX Space Station 3D 3D-SBS 1080p-lr.mkv) 05:03:21.691 T:139833038960768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 05:03:21.691 T:139833038960768 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 05:03:21.691 T:139833038960768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 05:03:21.691 T:139833038960768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 05:03:21.691 T:139833038960768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 05:03:21.691 T:139833038960768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 05:03:21.691 T:139833038960768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 05:03:21.691 T:139833038960768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 05:03:21.691 T:139833038960768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 05:03:21.691 T:139833038960768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 05:03:21.691 T:139833038960768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 05:03:21.691 T:139833038960768 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 05:03:21.691 T:139833038960768 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 05:03:21.691 T:139833038960768 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 05:03:21.691 T:139833038960768 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 05:03:21.691 T:139833038960768 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 05:03:21.691 T:139833038960768 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 05:03:21.693 T:139833038960768 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 05:03:21.693 T:139833038960768 NOTICE: VideoPlayer::OpenFile: nfs://192.168.1.205/lake/movies/3D/IMAX - Space Station 3D/IMAX Space Station 3D 3D-SBS 1080p-lr.mkv 05:03:21.693 T:139833038960768 DEBUG: OnPlayBackStarted: CApplication::OnPlayBackStarted 05:03:21.693 T:139831692420864 DEBUG: Thread BackgroundLoader start, auto delete: false 05:03:21.693 T:139831703230208 DEBUG: Thread VideoPlayer start, auto delete: false 05:03:21.693 T:139831703230208 NOTICE: Creating InputStream 05:03:21.697 T:139831703230208 DEBUG: CNFSFile::Open - opened lake/movies/3D/IMAX - Space Station 3D/IMAX Space Station 3D 3D-SBS 1080p-lr.mkv 05:03:21.697 T:139833038960768 DEBUG: CVideoGUIInfo::InitCurrentItem(nfs://192.168.1.205/lake/movies/3D/IMAX - Space Station 3D/IMAX Space Station 3D 3D-SBS 1080p-lr.mkv) 05:03:21.697 T:139832908822272 DEBUG: Loading settings for nfs://192.168.1.205/lake/movies/3D/IMAX - Space Station 3D/IMAX Space Station 3D 3D-SBS 1080p-lr.mkv 05:03:21.697 T:139833038960768 DEBUG: CPlayerGUIInfo::InitCurrentItem(nfs://192.168.1.205/lake/movies/3D/IMAX - Space Station 3D/IMAX Space Station 3D 3D-SBS 1080p-lr.mkv) 05:03:21.697 T:139833038956288 DEBUG: CAnnouncementManager - Announcement: OnChanged from xbmc 05:03:21.697 T:139833038956288 DEBUG: GOT ANNOUNCEMENT, type: 1024, from xbmc, message OnChanged 05:03:21.698 T:139831703230208 DEBUG: ScanForExternalSubtitles: Searching for subtitles... 05:03:21.700 T:139831703230208 DEBUG: ScanForExternalSubtitles: END (total time: 2 ms) 05:03:21.700 T:139831703230208 NOTICE: Creating Demuxer 05:03:21.702 T:139833038956288 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 05:03:21.702 T:139833038956288 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 05:03:21.703 T:139831692420864 DEBUG: Thread BackgroundLoader 139831692420864 terminating 05:03:21.712 T:139831703230208 DEBUG: Open - probing detected format [matroska,webm] 05:03:21.712 T:139831703230208 DEBUG: Open - avformat_find_stream_info starting 05:03:21.750 T:139831703230208 DEBUG: ffmpeg[7F2D1AFFD700]: [matroska,webm] Could not find codec parameters for stream 3 (Attachment: none): unknown codec 05:03:21.750 T:139831703230208 DEBUG: ffmpeg[7F2D1AFFD700]: [matroska,webm] Consider increasing the value for the 'analyzeduration' and 'probesize' options 05:03:21.750 T:139831703230208 DEBUG: Open - av_find_stream_info finished 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: Input #0, matroska,webm, from 'nfs://192.168.1.205/lake/movies/3D/IMAX - Space Station 3D/IMAX Space Station 3D 3D-SBS 1080p-lr.mkv': 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: Metadata: 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: creation_time : 2015-04-17T15:25:18.000000Z 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: AUTHOR : BD3D2MK3D 0.63 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: TITLE : IMAX Space Station 3D 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: ENCODER : x264 0.146.2538 121396c 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: : (libswscale 3.1.101) 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: : (libavformat 56.23.106) 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: : (ffmpegsource 2.17.4.0) 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: : built by Komisar on Mar 1 2015, gcc: 4.8.4 (multilib.generic.Komisar) 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: : x264 configuration: --bit-depth=8 --chroma-format=all 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: : libx264 configuration: --bit-depth=8 --chroma-format=all 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: : x264 license: GPL version 2 or later 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: : libswscale/libavformat/ffmpegsource license: GPL version 2 or later 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: : (64bit) 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: ENCODER_SETTINGS: --crf 17 --preset slower --opencl --frame-packing 3 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: DATE_ENCODED : 2015-04-14 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: ORIGINAL_MEDIA_TYPE: Blu-ray 3D 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: Duration: 00:47:11.85, start: 0.000000, bitrate: 20206 kb/s 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: Chapter #0:0: start 0.000000, end 2831.851000 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: Metadata: 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: title : 1 - 0:00:00 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: Stream #0:0: Video: h264 (High), yuv420p(progressive), 3840x1080, SAR 2:1 DAR 64:9, 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc (default) 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: Metadata: 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: title : 3D Full-SBS (x264 high CRF 17 preset slower) 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: stereo_mode : left_right 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: Side data: 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: stereo3d: side by side 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: Stream #0:1(eng): Audio: dts (DTS-HD MA), 48000 Hz, 5.1(side), s32p (24 bit) (default) 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: Metadata: 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: title : English (DTS Multi-channel 48KHz) 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: Stream #0:2: Attachment: text 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: Metadata: 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: filename : _ENCODE_3D_MOVIE.avs 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: mimetype : text/plain 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: Stream #0:3: Attachment: none 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: Metadata: 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: filename : _ENCODE.cmd 05:03:21.751 T:139831703230208 INFO: ffmpeg[7F2D1AFFD700]: mimetype : text/x-msdos-batch 05:03:21.751 T:139831703230208 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0 05:03:21.751 T:139831703230208 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1 05:03:21.751 T:139831703230208 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 2 05:03:21.751 T:139831703230208 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 3 05:03:21.751 T:139831703230208 NOTICE: Opening stream: 0 source: 256 05:03:21.751 T:139831703230208 NOTICE: Creating video codec with codec id: 27 05:03:21.751 T:139831703230208 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 05:03:21.751 T:139831703230208 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264 05:03:21.751 T:139831703230208 DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 27 05:03:21.751 T:139831703230208 NOTICE: Creating video thread 05:03:21.751 T:139831692420864 DEBUG: Thread VideoPlayerVideo start, auto delete: false 05:03:21.751 T:139831703230208 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: nfs://192.168.1.205/lake/movies/3D/IMAX - Space Station 3D/IMAX Space Station 3D 3D-SBS 1080p-lr.mkv 05:03:21.751 T:139831692420864 NOTICE: running thread: video_thread 05:03:21.751 T:139831692420864 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: 0 05:03:21.751 T:139831703230208 NOTICE: Opening stream: 1 source: 256 05:03:21.751 T:139831703230208 NOTICE: Finding audio codec for: 86020 05:03:21.751 T:139831703230208 NOTICE: CDVDAudioCodecFFmpeg::Open() Successful opened audio decoder dca 05:03:21.751 T:139831703230208 NOTICE: Creating audio thread 05:03:21.752 T:139831703230208 DEBUG: CVideoPlayer::SetCaching - caching state 2 05:03:21.752 T:139831703230208 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 05:03:21.752 T:139831684028160 DEBUG: Thread VideoPlayerAudio start, auto delete: false 05:03:21.752 T:139831703230208 DEBUG: CVideoPlayer::HandleMessages - player 2 reported state: 0 05:03:21.752 T:139831684028160 NOTICE: running thread: CVideoPlayerAudio::Process() 05:03:21.752 T:139831703230208 DEBUG: CVideoPlayer::SetCaching - caching state 1 05:03:21.752 T:139831692420864 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 05:03:21.752 T:139831684028160 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_PAUSE: 0 05:03:21.752 T:139831703230208 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 05:03:21.752 T:139831684028160 DEBUG: CDVDAudio::Pause - pausing audio stream 05:03:21.752 T:139831703230208 DEBUG: Previous line repeats 1 times. 05:03:21.752 T:139831703230208 DEBUG: CVideoPlayer::HandleMessages - player 1 reported state: 0 05:03:21.752 T:139832908822272 DEBUG: OnAVChange: CApplication::OnAVChange 05:03:21.752 T:139831692420864 DEBUG: libva info: VA-API version 1.3.0 05:03:21.752 T:139831692420864 DEBUG: libva info: va_getDriverName() returns 0 05:03:21.752 T:139831692420864 DEBUG: libva info: Trying to open /usr/lib/dri/i965_drv_video.so 05:03:21.752 T:139831684028160 NOTICE: Creating audio stream (codec id: 86020, channels: 6, sample rate: 48000, no pass-through) 05:03:21.752 T:139831692420864 DEBUG: libva info: Found init function __vaDriverInit_1_3 05:03:21.752 T:139831684028160 DEBUG: CVideoPlayerAudio:: synctype set to 0: clock feedback 05:03:21.753 T:139831692420864 DEBUG: libva info: va_openDriver() returns 0 05:03:21.753 T:139831674586880 DEBUG: Thread Vaapi-Output start, auto delete: false 05:03:21.753 T:139831674586880 NOTICE: COutput::OnStartup: Output Thread created 05:03:21.754 T:139831703230208 DEBUG: CVideoPlayer::CheckContinuity - wrapback :2, prev:167000.000000, curr:0.000000, diff:-167000.000000 05:03:21.755 T:139833038956288 DEBUG: CAnnouncementManager - Announcement: OnAVChange from xbmc 05:03:21.755 T:139833038956288 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVChange 05:03:21.762 T:139831692420864 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264-vaapi 05:03:21.774 T:139833012303616 INFO: CActiveAESink::OpenSink - initialize sink 05:03:21.795 T:139831692420864 DEBUG: CRenderManager::Configure - change configuration. 3840x1080. display: 3840x1080. framerate: 23.98. 05:03:21.795 T:139832890828544 DEBUG: OnAVChange: CApplication::OnAVChange 05:03:21.795 T:139832890828544 DEBUG: StereoscopicsManager: autodetected stereo mode for movie mode left_right is: split_vertical 05:03:21.796 T:139831703230208 DEBUG: CVideoPlayer::SetCaching - caching state 2 05:03:21.796 T:139831703230208 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 05:03:21.798 T:139833038960768 DEBUG: ------ Window Init (DialogBusy.xml) ------ 05:03:21.800 T:139833038960768 DEBUG: DeleteRenderer - deleting renderer 05:03:21.800 T:139833038960768 DEBUG: LinuxRendererGL: Cleaning up GL resources 05:03:21.801 T:139833038956288 DEBUG: CAnnouncementManager - Announcement: OnPause from xbmc 05:03:21.801 T:139833038956288 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPause 05:03:21.802 T:139833038960768 DEBUG: GL: Disabling non-linear stretch 05:03:21.802 T:139833038960768 DEBUG: GL: Requested render method: 0 05:03:21.802 T:139833038960768 DEBUG: GL: BaseYUV2RGBGLSLShader: defines: #define XBMC_texture_rectangle 0 #define XBMC_texture_rectangle_hack 0 #define XBMC_STRETCH 0 #define XBMC_NV12 05:03:21.803 T:139833038960768 NOTICE: GL: Selecting YUV 2 RGB shader 05:03:21.803 T:139833038960768 NOTICE: GL: NPOT texture support detected 05:03:21.803 T:139833038960768 NOTICE: GL: Using GL_ARB_pixel_buffer_object 05:03:21.803 T:139833038960768 NOTICE: Using GL_TEXTURE_2D 05:03:21.803 T:139833038960768 DEBUG: CRenderManager::Configure - 4 05:03:21.803 T:139833038960768 DEBUG: GL: Requested render method: 0 05:03:21.803 T:139833038960768 DEBUG: GL: BaseYUV2RGBGLSLShader: defines: #define XBMC_texture_rectangle 0 #define XBMC_texture_rectangle_hack 0 #define XBMC_STRETCH 0 #define XBMC_NV12 05:03:21.804 T:139833038960768 NOTICE: GL: Selecting YUV 2 RGB shader 05:03:21.804 T:139833038960768 NOTICE: GL: NPOT texture support detected 05:03:21.804 T:139833038960768 NOTICE: GL: Using GL_ARB_pixel_buffer_object 05:03:21.806 T:139831703230208 DEBUG: CVideoPlayer::HandleMessages - player started 2 05:03:21.808 T:139833038960768 DEBUG: ------ Window Init (DialogSelect.xml) ------ 05:03:21.808 T:139833038960768 INFO: Loading skin file: DialogSelect.xml, load type: KEEP_IN_MEMORY 05:03:21.975 T:139833012303616 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=1 05:03:21.975 T:139833012303616 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=1" 05:03:21.983 T:139833012303616 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=1,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x02" 05:03:21.984 T:139833012303616 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 05:03:21.984 T:139833012303616 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 05:03:21.984 T:139833012303616 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2400, bufferSize 9600 05:03:21.994 T:139833012303616 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2400, bufferSize 9600 05:03:21.994 T:139833012303616 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms 05:03:21.996 T:139833012303616 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 05:03:21.996 T:139833012303616 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL, FR 05:03:21.996 T:139833012303616 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL, FR (ALSA: FL FR) 05:03:21.996 T:139833012303616 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 05:03:21.996 T:139833012303616 DEBUG: Output Device : HDA Intel PCH 05:03:21.996 T:139833012303616 DEBUG: Sample Rate : 48000 05:03:21.996 T:139833012303616 DEBUG: Sample Format : AE_FMT_S32NE 05:03:21.996 T:139833012303616 DEBUG: Channel Count : 2 05:03:21.996 T:139833012303616 DEBUG: Channel Layout: FL, FR 05:03:21.996 T:139833012303616 DEBUG: Frames : 2400 05:03:21.996 T:139833012303616 DEBUG: Frame Size : 8 05:03:22.001 T:139833020696320 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 05:03:22.002 T:139831684028160 DEBUG: Previous line repeats 1 times. 05:03:22.002 T:139831684028160 DEBUG: CDVDAudio::Pause - pausing audio stream 05:03:22.024 T:139831703230208 DEBUG: Previous line repeats 1 times. 05:03:22.024 T:139831703230208 DEBUG: CVideoPlayer::HandleMessages - player started 1 05:03:22.024 T:139831703230208 DEBUG: VideoPlayer::Sync - Audio - pts: 298000.000000, cache: 491408.553037, totalcache: 800000.011921 05:03:22.024 T:139831703230208 DEBUG: VideoPlayer::Sync - Video - pts: 0.000000, cache: 50000.000000, totalcache: 100000.000000 05:03:22.024 T:139831692420864 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(0.000000) 05:03:22.024 T:139831684028160 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(0.000000), level: 99, cache: 483286.696037 05:03:22.058 T:139833038960768 DEBUG: Activating window ID: 12005 05:03:22.059 T:139833038960768 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 05:03:22.059 T:139833038960768 DEBUG: FreeVisualisation() done 05:03:22.060 T:139833038960768 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 05:03:22.060 T:139833038960768 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY 05:03:22.065 T:139833038960768 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 05:03:22.085 T:139833038960768 DEBUG: ------ Window Init (Custom_1109_TopBarOverlay.xml) ------ 05:03:23.270 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 05:03:23.420 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x0000, modifier: 0x0 05:03:23.420 T:139833038960768 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 05:03:23.670 T:139833038960768 DEBUG: ------ Window Deinit (DialogSelect.xml) ------ 05:03:23.671 T:139832890828544 DEBUG: StereoscopicsManager: stereo mode setting changed to row_interleaved 05:03:23.671 T:139832890828544 DEBUG: StereoscopicsManager::ApplyStereoMode: trying to apply stereo mode. Current: off | Target: row_interleaved 05:03:23.671 T:139832890828544 DEBUG: StereoscopicsManager: stereo mode changed to row_interleaved 05:03:23.692 T:139833038960768 INFO: GL: Maximum texture width: 16384 05:03:23.695 T:139833038960768 DEBUG: ------ Window Init (DialogNotification.xml) ------ 05:03:23.695 T:139832890828544 DEBUG: OnAVChange: CApplication::OnAVChange 05:03:23.695 T:139832890828544 DEBUG: Previous line repeats 1 times. 05:03:23.695 T:139832890828544 DEBUG: OnAVStarted: CApplication::OnAVStarted 05:03:23.695 T:139832882435840 DEBUG: OnAVChange: CApplication::OnAVChange 05:03:23.698 T:139831684028160 DEBUG: CDVDAudio::Resume - resume audio stream 05:03:23.698 T:139833020696320 DEBUG: ActiveAE - start sync of audio stream 05:03:23.705 T:139833038956288 DEBUG: CAnnouncementManager - Announcement: OnResume from xbmc 05:03:23.705 T:139833038956288 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnResume 05:03:23.713 T:139833038956288 DEBUG: CAnnouncementManager - Announcement: OnAVChange from xbmc 05:03:23.713 T:139833038956288 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVChange 05:03:23.718 T:139833038956288 DEBUG: CAnnouncementManager - Announcement: OnAVChange from xbmc 05:03:23.718 T:139833038956288 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVChange 05:03:23.722 T:139833038956288 DEBUG: CAnnouncementManager - Announcement: OnAVChange from xbmc 05:03:23.722 T:139833038956288 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVChange 05:03:23.724 T:139833038956288 DEBUG: CAnnouncementManager - Announcement: OnAVStart from xbmc 05:03:23.724 T:139833038956288 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVStart 05:03:23.726 T:139833038956288 DEBUG: CAnnouncementManager - Announcement: OnAVChange from xbmc 05:03:23.726 T:139833038956288 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVChange 05:03:23.737 T:139833038960768 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 05:03:23.777 T:139831692420864 NOTICE: CDVDVideoCodecFFmpeg::CDropControl: calculated diff time: 41727 05:03:23.798 T:139833020696320 DEBUG: ActiveAE::SyncStream - average error of -201.288625, start adjusting 05:03:23.799 T:139833020696320 DEBUG: ActiveAE::SyncStream - average error -1.288625 below threshold of 30.000000 05:03:23.906 T:139833038960768 DEBUG: Inhibiting OS screen saver 05:03:23.907 T:139831040538368 DEBUG: Thread Timer start, auto delete: false 05:03:24.850 T:139831684028160 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-41775.385048, adjusted:-41775.385048 05:03:26.524 T:139833038960768 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 05:03:26.538 T:139833038960768 DEBUG: ------ Window Deinit (Custom_1109_TopBarOverlay.xml) ------ 05:03:28.606 T:139831692420864 DEBUG: CPtsTracker: detected pattern of length 1: 41708.33, frameduration: 41708.333333 05:03:29.424 T:139833038960768 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 05:03:53.696 T:139832908822272 DEBUG: Thread JobWorker 139832908822272 terminating (autodelete) 05:03:53.696 T:139832890828544 DEBUG: Thread JobWorker 139832890828544 terminating (autodelete) 05:03:53.696 T:139832882435840 DEBUG: Thread JobWorker 139832882435840 terminating (autodelete) 05:03:56.201 T:139833038960768 DEBUG: Keyboard: scancode: 0x35, sym: 0x0078, unicode: 0x0078, modifier: 0x0 05:03:56.201 T:139833038960768 DEBUG: HandleKey: x (0xf058) pressed, action is Stop 05:03:56.201 T:139833038960768 NOTICE: CVideoPlayer::CloseFile() 05:03:56.201 T:139833038960768 NOTICE: VideoPlayer: waiting for threads to exit 05:03:56.209 T:139831703230208 NOTICE: CVideoPlayer::OnExit() 05:03:56.210 T:139831703230208 NOTICE: Closing stream player 1 05:03:56.210 T:139831703230208 NOTICE: Waiting for audio thread to exit 05:03:56.249 T:139831684028160 NOTICE: thread end: CVideoPlayerAudio::OnExit() 05:03:56.249 T:139831684028160 DEBUG: Thread VideoPlayerAudio 139831684028160 terminating 05:03:56.249 T:139831703230208 NOTICE: Closing audio device 05:03:56.299 T:139831703230208 DEBUG: CDVDAudio::Flush - flush audio stream 05:03:56.299 T:139833020696320 DEBUG: CActiveAE::DiscardStream - audio stream deleted 05:03:56.299 T:139833020696320 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 05:03:56.299 T:139833012303616 DEBUG: Previous line repeats 2 times. 05:03:56.299 T:139833012303616 INFO: CActiveAESink::OpenSink - initialize sink 05:03:56.299 T:139831703230208 NOTICE: Deleting audio codec 05:03:56.299 T:139831703230208 NOTICE: Closing stream player 2 05:03:56.299 T:139831703230208 NOTICE: waiting for video thread to exit 05:03:56.300 T:139831692420864 NOTICE: thread end: video_thread 05:03:56.300 T:139831692420864 DEBUG: Thread VideoPlayerVideo 139831692420864 terminating 05:03:56.300 T:139831703230208 NOTICE: deleting video codec 05:03:56.302 T:139831692420864 DEBUG: Thread JobWorker start, auto delete: true 05:03:56.302 T:139831703230208 DEBUG: CNFSFile::Close closing file lake/movies/3D/IMAX - Space Station 3D/IMAX Space Station 3D 3D-SBS 1080p-lr.mkv 05:03:56.302 T:139831703230208 DEBUG: Thread VideoPlayer 139831703230208 terminating 05:03:56.302 T:139833038960768 NOTICE: VideoPlayer: finished waiting 05:03:56.302 T:139833038960768 DEBUG: DeleteRenderer - deleting renderer 05:03:56.302 T:139833038960768 NOTICE: VAAPI::Close 05:03:56.302 T:139831674586880 NOTICE: COutput::OnExit: Output Thread terminated 05:03:56.302 T:139831674586880 DEBUG: Thread Vaapi-Output 139831674586880 terminating 05:03:56.302 T:139833038960768 NOTICE: VAAPI::Close - closing decoder context 05:03:56.302 T:139833038960768 DEBUG: LinuxRendererGL: Cleaning up GL resources 05:03:56.302 T:139833038960768 NOTICE: CVideoPlayer::CloseFile() 05:03:56.302 T:139833038960768 NOTICE: VideoPlayer: waiting for threads to exit 05:03:56.302 T:139833038960768 NOTICE: VideoPlayer: finished waiting 05:03:56.303 T:139833038960768 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 05:03:56.304 T:139831674586880 DEBUG: Thread JobWorker start, auto delete: true 05:03:56.304 T:139831692420864 DEBUG: DoWork - Saving file state for video item nfs://192.168.1.205/lake/movies/3D/IMAX - Space Station 3D/IMAX Space Station 3D 3D-SBS 1080p-lr.mkv 05:03:56.321 T:139831692420864 DEBUG: OnPlayBackStopped: CApplication::OnPlayBackStopped 05:03:56.323 T:139833038956288 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 05:03:56.323 T:139833038956288 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 05:03:56.324 T:139833038960768 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 05:03:56.324 T:139833038960768 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 05:03:56.326 T:139833038960768 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 05:03:56.327 T:139833038960768 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 05:03:56.328 T:139833038960768 DEBUG: CGUIMediaWindow::GetDirectory (nfs://192.168.1.205/lake/movies/3D/IMAX - Space Station 3D/) 05:03:56.328 T:139833038960768 DEBUG: ParentPath = [nfs://192.168.1.205/lake/movies/3D/IMAX - Space Station 3D/] 05:03:56.336 T:139831703230208 DEBUG: Thread BackgroundLoader start, auto delete: false 05:03:56.341 T:139831703230208 DEBUG: Thread BackgroundLoader 139831703230208 terminating 05:03:56.397 T:139833038960768 DEBUG: Keyboard: scancode: 0x35, sym: 0x0078, unicode: 0x0000, modifier: 0x0 05:03:56.500 T:139833012303616 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=1 05:03:56.500 T:139833012303616 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=1" 05:03:56.508 T:139833012303616 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=1,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00" 05:03:56.509 T:139833012303616 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 05:03:56.509 T:139833012303616 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 05:03:56.509 T:139833012303616 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2205, bufferSize 8820 05:03:56.521 T:139833012303616 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2205, bufferSize 8820 05:03:56.521 T:139833012303616 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms 05:03:56.523 T:139833012303616 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 05:03:56.523 T:139833012303616 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL, FR 05:03:56.523 T:139833012303616 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL, FR (ALSA: FL FR) 05:03:56.523 T:139833012303616 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 05:03:56.523 T:139833012303616 DEBUG: Output Device : HDA Intel PCH 05:03:56.523 T:139833012303616 DEBUG: Sample Rate : 44100 05:03:56.523 T:139833012303616 DEBUG: Sample Format : AE_FMT_S32NE 05:03:56.523 T:139833012303616 DEBUG: Channel Count : 2 05:03:56.523 T:139833012303616 DEBUG: Channel Layout: FL, FR 05:03:56.523 T:139833012303616 DEBUG: Frames : 2205 05:03:56.523 T:139833012303616 DEBUG: Frame Size : 8 05:03:56.526 T:139833020696320 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 05:03:56.526 T:139833038960768 DEBUG: Uninhibiting OS screen saver 05:03:56.526 T:139831040538368 DEBUG: Thread Timer 139831040538368 terminating 05:03:56.526 T:139833020696320 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 05:03:57.089 T:139833038960768 DEBUG: Keyboard: scancode: 0x16, sym: 0x0008, unicode: 0x0008, modifier: 0x0 05:03:57.259 T:139833038960768 DEBUG: Keyboard: scancode: 0x16, sym: 0x0008, unicode: 0x0000, modifier: 0x0 05:03:57.259 T:139833038960768 DEBUG: HandleKey: backspace (0xf008) pressed, action is Back 05:03:57.259 T:139833038960768 DEBUG: CGUIMediaWindow::GetDirectory (nfs://192.168.1.205/lake/movies/3D/) 05:03:57.259 T:139833038960768 DEBUG: ParentPath = [nfs://192.168.1.205/lake/movies/] 05:03:57.260 T:139831040538368 DEBUG: Thread waiting start, auto delete: false 05:03:57.265 T:139831040538368 DEBUG: Thread waiting 139831040538368 terminating 05:03:57.290 T:139831040538368 DEBUG: Thread BackgroundLoader start, auto delete: false 05:03:57.581 T:139831040538368 DEBUG: Thread BackgroundLoader 139831040538368 terminating 05:03:57.879 T:139833038960768 DEBUG: Keyboard: scancode: 0x16, sym: 0x0008, unicode: 0x0008, modifier: 0x0 05:03:58.010 T:139833038960768 DEBUG: Keyboard: scancode: 0x16, sym: 0x0008, unicode: 0x0000, modifier: 0x0 05:03:58.010 T:139833038960768 DEBUG: HandleKey: backspace (0xf008) pressed, action is Back 05:03:58.010 T:139833038960768 DEBUG: CGUIMediaWindow::GetDirectory (nfs://192.168.1.205/lake/movies/) 05:03:58.011 T:139833038960768 DEBUG: ParentPath = [sources://video/] 05:03:58.011 T:139831040538368 DEBUG: Thread waiting start, auto delete: false 05:03:58.067 T:139831040538368 DEBUG: Thread waiting 139831040538368 terminating 05:03:58.088 T:139831040538368 DEBUG: Thread BackgroundLoader start, auto delete: false 05:03:58.505 T:139833038960768 DEBUG: Keyboard: scancode: 0x16, sym: 0x0008, unicode: 0x0008, modifier: 0x0 05:03:58.671 T:139833038960768 DEBUG: Keyboard: scancode: 0x16, sym: 0x0008, unicode: 0x0000, modifier: 0x0 05:03:58.671 T:139833038960768 DEBUG: HandleKey: backspace (0xf008) pressed, action is Back 05:03:58.677 T:139831040538368 DEBUG: Thread BackgroundLoader 139831040538368 terminating 05:03:58.677 T:139833038960768 DEBUG: CGUIMediaWindow::GetDirectory (sources://video/) 05:03:58.677 T:139833038960768 DEBUG: ParentPath = [] 05:03:58.677 T:139831040538368 DEBUG: Thread waiting start, auto delete: false 05:03:58.686 T:139831040538368 DEBUG: Thread waiting 139831040538368 terminating 05:03:58.692 T:139831040538368 DEBUG: Thread BackgroundLoader start, auto delete: false 05:03:58.694 T:139831040538368 DEBUG: Thread BackgroundLoader 139831040538368 terminating 05:03:59.193 T:139833038960768 DEBUG: Keyboard: scancode: 0x16, sym: 0x0008, unicode: 0x0008, modifier: 0x0 05:03:59.356 T:139833038960768 DEBUG: Keyboard: scancode: 0x16, sym: 0x0008, unicode: 0x0000, modifier: 0x0 05:03:59.356 T:139833038960768 DEBUG: HandleKey: backspace (0xf008) pressed, action is Back 05:03:59.356 T:139833038960768 DEBUG: CGUIMediaWindow::GetDirectory () 05:03:59.356 T:139833038960768 DEBUG: ParentPath = [] 05:03:59.363 T:139831040538368 DEBUG: Thread waiting start, auto delete: false 05:03:59.365 T:139831040538368 DEBUG: Thread waiting 139831040538368 terminating 05:03:59.389 T:139831040538368 DEBUG: Thread BackgroundLoader start, auto delete: false 05:03:59.394 T:139831040538368 DEBUG: Thread BackgroundLoader 139831040538368 terminating 05:03:59.887 T:139833038960768 DEBUG: Keyboard: scancode: 0x16, sym: 0x0008, unicode: 0x0008, modifier: 0x0 05:04:00.031 T:139833038960768 DEBUG: Keyboard: scancode: 0x16, sym: 0x0008, unicode: 0x0000, modifier: 0x0 05:04:00.031 T:139833038960768 DEBUG: HandleKey: backspace (0xf008) pressed, action is Back 05:04:00.031 T:139833038960768 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 05:04:00.362 T:139833038960768 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 05:04:00.362 T:139833038960768 DEBUG: FreeVisualisation() done 05:04:00.364 T:139833038960768 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 05:04:00.364 T:139833038960768 DEBUG: ------ Window Init (Home.xml) ------ 05:04:00.364 T:139833038960768 DEBUG: CDirectoryProvider[addons://]: refreshing.. 05:04:00.364 T:139833038960768 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 05:04:00.365 T:139833038960768 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 05:04:00.365 T:139833038960768 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing.. 05:04:00.365 T:139833038960768 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 05:04:00.365 T:139833038960768 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 05:04:00.365 T:139831040538368 DEBUG: Thread JobWorker start, auto delete: true 05:04:00.365 T:139833038960768 DEBUG: CDirectoryProvider[library://video/]: refreshing.. 05:04:00.365 T:139833038960768 DEBUG: CDirectoryProvider[sources://video/]: refreshing.. 05:04:00.365 T:139833038960768 DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing.. 05:04:00.365 T:139833038960768 DEBUG: CDirectoryProvider[favourites://]: refreshing.. 05:04:00.366 T:139833038960768 DEBUG: CDirectoryProvider[sources://pictures/]: refreshing.. 05:04:00.366 T:139833038960768 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing.. 05:04:00.381 T:139831692420864 DEBUG: CAddonMgr::GetAvailableUpdates took 16 ms 05:04:00.401 T:139831692420864 DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3a%2f%2fprofile%2fplaylists%2fvideo/special%3a%2f%2fprofile%2fplaylists%2fmixed/) 05:04:00.401 T:139831692420864 DEBUG: Getting Directory (special://profile/playlists/video) 05:04:00.401 T:139831692420864 DEBUG: Getting Directory (special://profile/playlists/mixed) 05:04:00.402 T:139831692420864 DEBUG: CMultiPathDirectory::MergeItems, items = 0 05:04:01.133 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:04:01.133 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:04:01.235 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:04:01.298 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:04:01.298 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:04:01.396 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:04:01.460 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:04:01.461 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:04:01.540 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:04:01.597 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:04:01.597 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:04:01.702 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:04:01.770 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:04:01.770 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:04:01.868 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:04:02.201 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:04:02.201 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:04:02.299 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:04:03.075 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:04:03.075 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:04:03.252 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:04:03.385 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:04:03.385 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:04:03.519 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:04:03.884 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:04:03.884 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:04:04.022 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:04:04.319 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:04:04.319 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:04:04.452 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:04:04.969 T:139833038960768 DEBUG: Keyboard: scancode: 0x72, sym: 0x0113, unicode: 0x0000, modifier: 0x0 05:04:04.970 T:139833038960768 DEBUG: HandleKey: right (0xf083) pressed, action is Right 05:04:05.136 T:139833038960768 DEBUG: Keyboard: scancode: 0x72, sym: 0x0113, unicode: 0x0000, modifier: 0x0 05:04:05.412 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 05:04:05.539 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x0000, modifier: 0x0 05:04:05.539 T:139833038960768 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 05:04:05.540 T:139833038960768 DEBUG: Activating window ID: 10004 05:04:05.884 T:139833038960768 DEBUG: ------ Window Deinit (Home.xml) ------ 05:04:05.884 T:139833038960768 DEBUG: FreeVisualisation() done 05:04:05.886 T:139833038960768 DEBUG: ------ Window Init (Settings.xml) ------ 05:04:05.886 T:139833038960768 INFO: Loading skin file: Settings.xml, load type: KEEP_IN_MEMORY 05:04:06.722 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:04:06.723 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:04:06.824 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:04:06.890 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:04:06.890 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:04:06.985 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:04:07.407 T:139833038960768 DEBUG: Keyboard: scancode: 0x72, sym: 0x0113, unicode: 0x0000, modifier: 0x0 05:04:07.407 T:139833038960768 DEBUG: HandleKey: right (0xf083) pressed, action is Right 05:04:07.507 T:139833038960768 DEBUG: Keyboard: scancode: 0x72, sym: 0x0113, unicode: 0x0000, modifier: 0x0 05:04:07.608 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:04:07.608 T:139833038960768 DEBUG: HandleKey: right (0xf083) pressed, action is Right 05:04:07.674 T:139833038960768 DEBUG: Keyboard: scancode: 0x72, sym: 0x0113, unicode: 0x0000, modifier: 0x0 05:04:07.741 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:04:07.741 T:139833038960768 DEBUG: HandleKey: right (0xf083) pressed, action is Right 05:04:07.842 T:139833038960768 DEBUG: Keyboard: scancode: 0x72, sym: 0x0113, unicode: 0x0000, modifier: 0x0 05:04:08.226 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 05:04:08.354 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x0000, modifier: 0x0 05:04:08.354 T:139833038960768 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 05:04:08.354 T:139833038960768 DEBUG: Activating window ID: 10016 05:04:08.707 T:139833038960768 DEBUG: ------ Window Deinit (Settings.xml) ------ 05:04:08.707 T:139833038960768 DEBUG: FreeVisualisation() done 05:04:08.708 T:139833038960768 DEBUG: ------ Window Init (SettingsCategory.xml) ------ 05:04:08.708 T:139833038960768 INFO: Loading skin file: SettingsCategory.xml, load type: KEEP_IN_MEMORY 05:04:10.073 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:04:10.073 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:04:10.205 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:04:10.273 T:139833038960768 DEBUG: Previous line repeats 1 times. 05:04:10.273 T:139833038960768 DEBUG: HandleKey: up (0xf080) pressed, action is Up 05:04:10.369 T:139833038960768 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 05:04:10.821 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:04:10.822 T:139833038960768 DEBUG: HandleKey: down (0xf081) pressed, action is Down 05:04:10.956 T:139833038960768 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 05:04:11.232 T:139833038960768 DEBUG: Keyboard: scancode: 0x72, sym: 0x0113, unicode: 0x0000, modifier: 0x0 05:04:11.233 T:139833038960768 DEBUG: HandleKey: right (0xf083) pressed, action is Right 05:04:11.382 T:139833038960768 DEBUG: Keyboard: scancode: 0x72, sym: 0x0113, unicode: 0x0000, modifier: 0x0 05:04:11.617 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 05:04:11.717 T:139833038960768 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x0000, modifier: 0x0 05:04:11.717 T:139833038960768 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 05:04:11.717 T:139833038960768 NOTICE: Disabled debug logging due to GUI setting. Level 0. 05:04:11.717 T:139833038960768 NOTICE: Log level changed to "LOG_LEVEL_NORMAL"