18:45:02.927 T:140175580372288 NOTICE: special://profile/ is mapped to: special://masterprofile/
18:45:02.927 T:140175580372288 NOTICE: -----------------------------------------------------------------------
18:45:02.927 T:140175580372288 NOTICE: Starting Kodi (17.6 Git:a9a7a20). Platform: Linux x86 64-bit
18:45:02.927 T:140175580372288 NOTICE: Using Release Kodi x64 build
18:45:02.927 T:140175580372288 NOTICE: Kodi compiled Apr 13 2018 by GCC 6.2.0 for Linux x86 64-bit version 4.11.12 (264972)
18:45:02.927 T:140175580372288 NOTICE: Running on LibreELEC (official): 8.2.5, kernel: Linux x86 64-bit version 4.11.12
18:45:02.927 T:140175580372288 NOTICE: FFmpeg version/source: ffmpeg-3.1-kodi
18:45:02.927 T:140175580372288 NOTICE: Host CPU: Intel(R) Core(TM) i5-7200U CPU @ 2.50GHz, 4 cores available
18:45:02.927 T:140175580372288 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi/
18:45:02.927 T:140175580372288 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi
18:45:02.927 T:140175580372288 NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons
18:45:02.927 T:140175580372288 NOTICE: special://masterprofile/ is mapped to: /storage/.kodi/userdata
18:45:02.927 T:140175580372288 NOTICE: special://envhome/ is mapped to: /storage
18:45:02.927 T:140175580372288 NOTICE: special://home/ is mapped to: /storage/.kodi
18:45:02.927 T:140175580372288 NOTICE: special://temp/ is mapped to: /storage/.kodi/temp
18:45:02.927 T:140175580372288 NOTICE: special://logpath/ is mapped to: /storage/.kodi/temp
18:45:02.927 T:140175580372288 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin
18:45:02.927 T:140175580372288 NOTICE: Local hostname: LibreELEC
18:45:02.927 T:140175580372288 NOTICE: Log File is located: /storage/.kodi/temp//kodi.log
18:45:02.929 T:140175580372288 NOTICE: -----------------------------------------------------------------------
18:45:02.962 T:140175580372288 ERROR: DBus: Error org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files
18:45:02.963 T:140175580372288 NOTICE: load settings...
18:45:02.998 T:140175580372288 NOTICE: Found 2 Lists of Devices
18:45:02.998 T:140175580372288 NOTICE: Enumerated ALSA devices:
18:45:02.998 T:140175580372288 NOTICE: Device 1
18:45:02.998 T:140175580372288 NOTICE: m_deviceName : @
18:45:02.998 T:140175580372288 NOTICE: m_displayName : Default (HDA Intel PCH ALC255 Analog)
18:45:02.998 T:140175580372288 NOTICE: m_displayNameExtra:
18:45:02.998 T:140175580372288 NOTICE: m_deviceType : AE_DEVTYPE_PCM
18:45:02.998 T:140175580372288 NOTICE: m_channels : FL,FR
18:45:02.998 T:140175580372288 NOTICE: m_sampleRates : 48000
18:45:02.998 T:140175580372288 NOTICE: m_dataFormats : AE_FMT_S32NE
18:45:02.998 T:140175580372288 NOTICE: m_streamTypes : No passthrough capabilities
18:45:02.998 T:140175580372288 NOTICE: Device 2
18:45:02.998 T:140175580372288 NOTICE: m_deviceName : @:CARD=PCH,DEV=0
18:45:02.998 T:140175580372288 NOTICE: m_displayName : HDA Intel PCH
18:45:02.998 T:140175580372288 NOTICE: m_displayNameExtra: ALC255 Analog
18:45:02.998 T:140175580372288 NOTICE: m_deviceType : AE_DEVTYPE_PCM
18:45:02.998 T:140175580372288 NOTICE: m_channels : FL,FR
18:45:02.998 T:140175580372288 NOTICE: m_sampleRates : 48000
18:45:02.998 T:140175580372288 NOTICE: m_dataFormats : AE_FMT_S32NE
18:45:02.998 T:140175580372288 NOTICE: m_streamTypes : No passthrough capabilities
18:45:02.998 T:140175580372288 NOTICE: Device 3
18:45:02.998 T:140175580372288 NOTICE: m_deviceName : hdmi:CARD=PCH,DEV=0
18:45:02.998 T:140175580372288 NOTICE: m_displayName : HDA Intel PCH
18:45:02.998 T:140175580372288 NOTICE: m_displayNameExtra: HDMI #0
18:45:02.998 T:140175580372288 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
18:45:02.998 T:140175580372288 NOTICE: m_channels : FL,FR
18:45:02.998 T:140175580372288 NOTICE: m_sampleRates : 32000,44100,48000,88200,96000,176400,192000
18:45:02.998 T:140175580372288 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW
18:45:02.998 T:140175580372288 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD
18:45:02.998 T:140175580372288 NOTICE: Device 4
18:45:02.998 T:140175580372288 NOTICE: m_deviceName : hdmi:CARD=PCH,DEV=1
18:45:02.998 T:140175580372288 NOTICE: m_displayName : HDA Intel PCH
18:45:02.998 T:140175580372288 NOTICE: m_displayNameExtra: UMC UMC SHARP on DisplayPort #1
18:45:02.998 T:140175580372288 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
18:45:02.998 T:140175580372288 NOTICE: m_channels : FL,FR
18:45:02.998 T:140175580372288 NOTICE: m_sampleRates : 32000,44100,48000
18:45:02.998 T:140175580372288 NOTICE: m_dataFormats : AE_FMT_RAW,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW
18:45:02.998 T:140175580372288 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD
18:45:02.998 T:140175580372288 NOTICE: Device 5
18:45:02.998 T:140175580372288 NOTICE: m_deviceName : hdmi:CARD=PCH,DEV=2
18:45:02.998 T:140175580372288 NOTICE: m_displayName : HDA Intel PCH
18:45:02.998 T:140175580372288 NOTICE: m_displayNameExtra: HDMI #2
18:45:02.998 T:140175580372288 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
18:45:02.998 T:140175580372288 NOTICE: m_channels : FL,FR
18:45:02.998 T:140175580372288 NOTICE: m_sampleRates : 32000,44100,48000,88200,96000,176400,192000
18:45:02.998 T:140175580372288 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW
18:45:02.998 T:140175580372288 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD
18:45:02.998 T:140175580372288 NOTICE: Device 6
18:45:02.998 T:140175580372288 NOTICE: m_deviceName : hdmi:CARD=PCH,DEV=3
18:45:02.998 T:140175580372288 NOTICE: m_displayName : HDA Intel PCH
18:45:02.998 T:140175580372288 NOTICE: m_displayNameExtra: HDMI #3
18:45:02.998 T:140175580372288 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
18:45:02.998 T:140175580372288 NOTICE: m_channels : FL,FR
18:45:02.998 T:140175580372288 NOTICE: m_sampleRates : 32000,44100,48000,88200,96000,176400,192000
18:45:02.998 T:140175580372288 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW
18:45:02.998 T:140175580372288 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD
18:45:02.998 T:140175580372288 NOTICE: Device 7
18:45:02.998 T:140175580372288 NOTICE: m_deviceName : hdmi:CARD=PCH,DEV=4
18:45:02.998 T:140175580372288 NOTICE: m_displayName : HDA Intel PCH
18:45:02.998 T:140175580372288 NOTICE: m_displayNameExtra: HDMI #4
18:45:02.998 T:140175580372288 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
18:45:02.998 T:140175580372288 NOTICE: m_channels : FL,FR
18:45:02.998 T:140175580372288 NOTICE: m_sampleRates : 32000,44100,48000,88200,96000,176400,192000
18:45:02.998 T:140175580372288 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW
18:45:02.998 T:140175580372288 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD
18:45:02.998 T:140175580372288 NOTICE: Enumerated PULSE devices:
18:45:02.998 T:140175580372288 NOTICE: Device 1
18:45:02.998 T:140175580372288 NOTICE: m_deviceName : Default
18:45:02.998 T:140175580372288 NOTICE: m_displayName : Default
18:45:02.998 T:140175580372288 NOTICE: m_displayNameExtra: Bluetooth Audio (PULSEAUDIO)
18:45:02.998 T:140175580372288 NOTICE: m_deviceType : AE_DEVTYPE_PCM
18:45:02.998 T:140175580372288 NOTICE: m_channels : FL,FR
18:45:02.998 T:140175580372288 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000
18:45:02.998 T:140175580372288 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT
18:45:02.998 T:140175580372288 NOTICE: m_streamTypes : No passthrough capabilities
18:45:03.003 T:140175580372288 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml
18:45:03.003 T:140175580372288 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are...
false
1
cputemp
gputemp
30
18:45:03.004 T:140175580372288 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml)
18:45:03.004 T:140175580372288 NOTICE: Default Video Player: VideoPlayer
18:45:03.004 T:140175580372288 NOTICE: Default Audio Player: paplayer
18:45:03.004 T:140175580372288 NOTICE: Enabled debug logging due to GUI setting (2)
18:45:03.004 T:140175580372288 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM"
18:45:03.004 T:140175580372288 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml
18:45:03.004 T:140175580372288 DEBUG: CMediaSourceSettings: tag is missing or sources.xml is malformed
18:45:03.004 T:140175580372288 DEBUG: CMediaSourceSettings: tag is missing or sources.xml is malformed
18:45:03.004 T:140175580372288 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
18:45:03.004 T:140175580372288 DEBUG: CPlayerCoreConfig::: created player VideoPlayer
18:45:03.004 T:140175580372288 DEBUG: CPlayerCoreConfig::: created player PAPlayer
18:45:03.004 T:140175580372288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules
18:45:03.004 T:140175580372288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mms/udp
18:45:03.004 T:140175580372288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout
18:45:03.004 T:140175580372288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp
18:45:03.004 T:140175580372288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp
18:45:03.004 T:140175580372288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams
18:45:03.004 T:140175580372288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp
18:45:03.004 T:140175580372288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2
18:45:03.004 T:140175580372288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd
18:45:03.004 T:140175580372288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage
18:45:03.004 T:140175580372288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf
18:45:03.004 T:140175580372288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv
18:45:03.004 T:140175580372288 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio
18:45:03.004 T:140175580372288 NOTICE: Loaded playercorefactory configuration
18:45:03.004 T:140175580372288 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
18:45:03.004 T:140175580372288 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
18:45:03.006 T:140175580372288 INFO: creating subdirectories
18:45:03.006 T:140175580372288 INFO: userdata folder: special://masterprofile/
18:45:03.006 T:140175580372288 INFO: recording folder:
18:45:03.006 T:140175580372288 INFO: screenshots folder: /storage/screenshots/
18:45:03.019 T:140175580372288 NOTICE: Running database version Addons27
18:45:03.020 T:140175580372288 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcpluff-x86_64-linux.so)
18:45:03.020 T:140175580372288 DEBUG: Loading: /usr/lib/kodi/system/libcpluff-x86_64-linux.so
18:45:03.029 T:140175580372288 INFO: ADDON: cpluff: 'Could not read plug-in directory /storage/.kodi/addons: No such file or directory'
18:45:03.045 T:140175580372288 INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/kodi/addons: No such file or directory'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in resource.images.weathericons.default has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.audioencoder has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in kodi.audiodecoder has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in kodi.peripheral has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in kodi.guilib has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in peripheral.joystick has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in kodi.adsp has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.wma has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in game.controller.default has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in service.libreelec.settings has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in kodi.game has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in kodi.resource has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in os.openelec.tv has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in repository.kodi.game has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in os.libreelec.tv has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in kodi.inputstream has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in repository.libreelec.tv has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.aac has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in resource.language.en_gb has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in metadata.local has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.webinterface has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in resource.uisounds.kodi has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in xbmc.codec has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Plug-in skin.estuary has been installed.'
18:45:03.045 T:140175580372288 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.'
18:45:03.075 T:140175561430784 DEBUG: Thread JobWorker start, auto delete: true
18:45:03.079 T:140175580372288 NOTICE: ADDONS: Using repository repository.kodi.game
18:45:03.079 T:140175580372288 NOTICE: ADDONS: Using repository repository.libreelec.tv
18:45:03.079 T:140175580372288 NOTICE: ADDONS: Using repository repository.xbmc.org
18:45:03.084 T:140175551420160 DEBUG: Thread ActiveAE start, auto delete: false
18:45:03.084 T:140175543027456 DEBUG: Thread AESink start, auto delete: false
18:45:03.084 T:140175551420160 INFO: CActiveAE::ApplySettings - Forcing samplerate to 48000
18:45:03.085 T:140175543027456 INFO: CActiveAESink::OpenSink - initialize sink
18:45:03.085 T:140175543027456 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:@
18:45:03.085 T:140175543027456 INFO: CAESinkALSA::Initialize - Attempting to open device "@"
18:45:03.089 T:140175543027456 INFO: CAESinkALSA::Initialize - Opened device "sysdefault"
18:45:03.089 T:140175543027456 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
18:45:03.089 T:140175543027456 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
18:45:03.089 T:140175543027456 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 1024, bufferSize 9600
18:45:03.090 T:140175543027456 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 1024, bufferSize 9216
18:45:03.090 T:140175543027456 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 192 ms
18:45:03.090 T:140175543027456 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
18:45:03.090 T:140175543027456 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
18:45:03.090 T:140175543027456 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR)
18:45:03.090 T:140175543027456 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
18:45:03.090 T:140175543027456 DEBUG: Output Device : Default (HDA Intel PCH ALC255 Analog)
18:45:03.090 T:140175543027456 DEBUG: Sample Rate : 48000
18:45:03.090 T:140175543027456 DEBUG: Sample Format : AE_FMT_S32NE
18:45:03.090 T:140175543027456 DEBUG: Channel Count : 2
18:45:03.090 T:140175543027456 DEBUG: Channel Layout: FL,FR
18:45:03.090 T:140175543027456 DEBUG: Frames : 1024
18:45:03.090 T:140175543027456 DEBUG: Frame Size : 8
18:45:03.093 T:140175534360320 DEBUG: Thread RemoteControl start, auto delete: false
18:45:03.093 T:140175534360320 INFO: LIRC Process: using: /run/lirc/lircd
18:45:03.093 T:140175534360320 INFO: LIRC Connect: successfully started
18:45:03.094 T:140175534360320 DEBUG: Thread RemoteControl 140175534360320 terminating
18:45:03.096 T:140175580372288 INFO: CKeyboardLayoutManager: loading keyboard layouts from special://xbmc/system/keyboardlayouts...
18:45:03.100 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Arabic QWERTY" successfully loaded
18:45:03.100 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian ЯВЕРТЪ" successfully loaded
18:45:03.101 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian АБВ" successfully loaded
18:45:03.101 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BasePY" successfully loaded
18:45:03.101 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BaiduPY" successfully loaded
18:45:03.101 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Croatian QWERTY" successfully loaded
18:45:03.102 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Czech QWERTZ" successfully loaded
18:45:03.102 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Danish QWERTY" successfully loaded
18:45:03.102 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "English QWERTY" successfully loaded
18:45:03.103 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "English AZERTY" successfully loaded
18:45:03.103 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "English ABC" successfully loaded
18:45:03.103 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "French AZERTY" successfully loaded
18:45:03.103 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "German QWERTZ" successfully loaded
18:45:03.104 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "German ABC" successfully loaded
18:45:03.104 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Greek QWERTY" successfully loaded
18:45:03.104 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew QWERTY" successfully loaded
18:45:03.104 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew ABC" successfully loaded
18:45:03.105 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Hungarian QWERTZ" successfully loaded
18:45:03.105 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Icelandic QWERTY" successfully loaded
18:45:03.105 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Italian QWERTY" successfully loaded
18:45:03.106 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Korean ㄱㄴㄷ" successfully loaded
18:45:03.106 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian AZERTY" successfully loaded
18:45:03.106 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian QWERTY" successfully loaded
18:45:03.106 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Norwegian QWERTY" successfully loaded
18:45:03.107 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Polish QWERTY" successfully loaded
18:45:03.107 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Portuguese (Portugal) QWERTY" successfully loaded
18:45:03.107 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Romanian QWERTY" successfully loaded
18:45:03.108 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian ЙЦУКЕН" successfully loaded
18:45:03.108 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian АБВ" successfully loaded
18:45:03.108 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Silesian QWERTY" successfully loaded
18:45:03.109 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTZ" successfully loaded
18:45:03.109 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTY" successfully loaded
18:45:03.109 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak ABC" successfully loaded
18:45:03.110 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Spanish QWERTY" successfully loaded
18:45:03.110 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Swedish QWERTY" successfully loaded
18:45:03.111 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Turkish QWERTY" successfully loaded
18:45:03.111 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian ЙЦУКЕН" successfully loaded
18:45:03.111 T:140175580372288 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian АБВ" successfully loaded
18:45:03.112 T:140175580372288 DEBUG: UDisks: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UDisks was not provided by any .service files
18:45:03.112 T:140175580372288 DEBUG: DeviceKit.Disks: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.DeviceKit.Disks was not provided by any .service files
18:45:03.113 T:140175580372288 DEBUG: Selected UDev as storage provider
18:45:03.121 T:140175580372288 INFO: Available videomodes (xrandr):
18:45:03.121 T:140175580372288 INFO: Output 'DP2' has 26 modes
18:45:03.121 T:140175580372288 INFO: ID:0x48 Name:1920x1080 Refresh:60.000000 Width:1920 Height:1080
18:45:03.121 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.121 T:140175580372288 INFO: ID:0x102 Name:1920x1080 Refresh:60.000000 Width:1920 Height:1080
18:45:03.121 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.121 T:140175580372288 INFO: ID:0x103 Name:1920x1080 Refresh:50.000000 Width:1920 Height:1080
18:45:03.121 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.121 T:140175580372288 INFO: ID:0x104 Name:1920x1080 Refresh:59.940201 Width:1920 Height:1080
18:45:03.121 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.121 T:140175580372288 INFO: ID:0x107 Name:1920x1080 Refresh:24.000000 Width:1920 Height:1080
18:45:03.121 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.121 T:140175580372288 INFO: ID:0x109 Name:1920x1080 Refresh:23.976080 Width:1920 Height:1080
18:45:03.121 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.121 T:140175580372288 INFO: ID:0x105 Name:1920x1080i Refresh:30.000000 Width:1920 Height:1080
18:45:03.121 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.121 T:140175580372288 INFO: ID:0x106 Name:1920x1080i Refresh:25.000000 Width:1920 Height:1080
18:45:03.121 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.121 T:140175580372288 INFO: ID:0x108 Name:1920x1080i Refresh:29.970100 Width:1920 Height:1080
18:45:03.121 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.121 T:140175580372288 INFO: ID:0x10a Name:1680x1050 Refresh:59.883251 Width:1680 Height:1050
18:45:03.121 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.121 T:140175580372288 INFO: ID:0x10b Name:1280x1024 Refresh:60.019741 Width:1280 Height:1024
18:45:03.121 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.121 T:140175580372288 INFO: ID:0x10c Name:1280x960 Refresh:60.000000 Width:1280 Height:960
18:45:03.121 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.121 T:140175580372288 INFO: ID:0x10d Name:1360x768 Refresh:60.015160 Width:1360 Height:768
18:45:03.121 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.122 T:140175580372288 INFO: ID:0x10e Name:1280x800 Refresh:59.909550 Width:1280 Height:800
18:45:03.122 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.122 T:140175580372288 INFO: ID:0x10f Name:1280x720 Refresh:60.000000 Width:1280 Height:720
18:45:03.122 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.122 T:140175580372288 INFO: ID:0x110 Name:1280x720 Refresh:50.000000 Width:1280 Height:720
18:45:03.122 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.122 T:140175580372288 INFO: ID:0x111 Name:1280x720 Refresh:59.940201 Width:1280 Height:720
18:45:03.122 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.122 T:140175580372288 INFO: ID:0x112 Name:1024x768 Refresh:60.003841 Width:1024 Height:768
18:45:03.122 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.122 T:140175580372288 INFO: ID:0x113 Name:800x600 Refresh:60.316540 Width:800 Height:600
18:45:03.122 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.122 T:140175580372288 INFO: ID:0x114 Name:800x600 Refresh:56.250000 Width:800 Height:600
18:45:03.122 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.122 T:140175580372288 INFO: ID:0x115 Name:720x576 Refresh:50.000000 Width:720 Height:576
18:45:03.122 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.122 T:140175580372288 INFO: ID:0x116 Name:720x480 Refresh:60.000000 Width:720 Height:480
18:45:03.122 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.122 T:140175580372288 INFO: ID:0x117 Name:720x480 Refresh:59.940060 Width:720 Height:480
18:45:03.122 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.122 T:140175580372288 INFO: ID:0x118 Name:640x480 Refresh:60.000000 Width:640 Height:480
18:45:03.122 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.122 T:140175580372288 INFO: ID:0x119 Name:640x480 Refresh:59.940479 Width:640 Height:480
18:45:03.122 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.122 T:140175580372288 INFO: ID:0x11a Name:720x400 Refresh:70.081657 Width:720 Height:400
18:45:03.122 T:140175580372288 INFO: Pixel Ratio: 1.000000
18:45:03.122 T:140175580372288 NOTICE: Checking resolution 16
18:45:03.139 T:140175580372288 DEBUG: Window Manager Name: Fluxbox
18:45:03.188 T:140175580372288 NOTICE: Using visual 0x20
18:45:03.196 T:140175580372288 INFO: GL: Maximum texture width: 16384
18:45:03.197 T:140175580372288 DEBUG: EGL_EXTENSIONS: EGL_CHROMIUM_sync_control EGL_EXT_create_context_robustness EGL_EXT_image_dma_buf_import EGL_KHR_config_attribs EGL_KHR_create_context EGL_KHR_fence_sync EGL_KHR_get_all_proc_addresses 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_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
18:45:03.197 T:140175580372288 NOTICE: GL_VENDOR = Intel Open Source Technology Center
18:45:03.197 T:140175580372288 NOTICE: GL_RENDERER = Mesa DRI Intel(R) HD Graphics 620 (Kaby Lake GT2)
18:45:03.197 T:140175580372288 NOTICE: GL_VERSION = 3.0 Mesa 17.1.3
18:45:03.197 T:140175580372288 NOTICE: GL_SHADING_LANGUAGE_VERSION = 1.30
18:45:03.197 T:140175580372288 NOTICE: GL_EXTENSIONS = GL_ARB_multisample GL_EXT_abgr GL_EXT_bgra GL_EXT_blend_color GL_EXT_blend_minmax GL_EXT_blend_subtract GL_EXT_copy_texture GL_EXT_polygon_offset GL_EXT_subtexture GL_EXT_texture_object GL_EXT_vertex_array GL_EXT_compiled_vertex_array GL_EXT_texture GL_EXT_texture3D GL_IBM_rasterpos_clip GL_ARB_point_parameters GL_EXT_draw_range_elements GL_EXT_packed_pixels GL_EXT_point_parameters GL_EXT_rescale_normal GL_EXT_separate_specular_color GL_EXT_texture_edge_clamp GL_SGIS_generate_mipmap GL_SGIS_texture_border_clamp GL_SGIS_texture_edge_clamp GL_SGIS_texture_lod GL_ARB_framebuffer_sRGB GL_ARB_multitexture GL_EXT_framebuffer_sRGB GL_IBM_multimode_draw_arrays GL_IBM_texture_mirrored_repeat GL_3DFX_texture_compression_FXT1 GL_ARB_texture_cube_map GL_ARB_texture_env_add GL_ARB_transpose_matrix GL_EXT_blend_func_separate GL_EXT_fog_coord GL_EXT_multi_draw_arrays GL_EXT_secondary_color GL_EXT_texture_env_add GL_EXT_texture_filter_anisotropic GL_EXT_texture_lod_bias GL_INGR_blend_func_separate GL_NV_blend_square GL_NV_light_max_exponent GL_NV_texgen_reflection GL_NV_texture_env_combine4 GL_S3_s3tc GL_SUN_multi_draw_arrays GL_ARB_texture_border_clamp GL_ARB_texture_compression GL_EXT_framebuffer_object GL_EXT_texture_env_combine GL_EXT_texture_env_dot3 GL_MESA_window_pos GL_NV_packed_depth_stencil GL_NV_texture_rectangle GL_ARB_depth_texture GL_ARB_occlusion_query GL_ARB_shadow GL_ARB_texture_env_combine GL_ARB_texture_env_crossbar GL_ARB_texture_env_dot3 GL_ARB_texture_mirrored_repeat GL_ARB_window_pos GL_EXT_stencil_two_side GL_EXT_texture_cube_map GL_NV_depth_clamp GL_APPLE_packed_pixels GL_APPLE_vertex_array_object GL_ARB_draw_buffers GL_ARB_fragment_program GL_ARB_fragment_shader GL_ARB_shader_objects GL_ARB_vertex_program GL_ARB_vertex_shader GL_ATI_draw_buffers GL_ATI_texture_env_combine3 GL_ATI_texture_float GL_EXT_shadow_funcs GL_EXT_stencil_wrap GL_MESA_pack_invert GL_NV_primitive_restart GL_ARB_depth_clamp GL_ARB_fragment_program_shadow GL_ARB_half_float_pixel GL_ARB_occlusion_query2 GL_ARB_point_sprite GL_ARB_shading_language_100 GL_ARB_sync GL_ARB_texture_non_power_of_two GL_ARB_vertex_buffer_object GL_ATI_blend_equation_separate GL_EXT_blend_equation_separate GL_OES_read_format GL_ARB_color_buffer_float GL_ARB_pixel_buffer_object GL_ARB_texture_compression_rgtc GL_ARB_texture_float GL_ARB_texture_rectangle GL_EXT_packed_float GL_EXT_pixel_buffer_object GL_EXT_texture_compression_dxt1 GL_EXT_texture_compression_rgtc GL_EXT_texture_rectangle GL_EXT_texture_sRGB GL_EXT_texture_shared_exponent GL_ARB_framebuffer_object GL_EXT_framebuffer_blit GL_EXT_framebuffer_multisample GL_EXT_packed_depth_stencil GL_APPLE_object_purgeable GL_ARB_vertex_array_object GL_ATI_separate_stencil GL_EXT_draw_buffers2 GL_EXT_draw_instanced GL_EXT_gpu_program_parameters GL_EXT_texture_array GL_EXT_texture_integer GL_EXT_texture_sRGB_decode GL_EXT_timer_query GL_OES_EGL_image GL_ARB_copy_buffer GL_ARB_depth_buffer_float GL_ARB_draw_instanced GL_ARB_half_float_vertex GL_ARB_instanced_arrays GL_ARB_map_buffer_range GL_ARB_texture_rg GL_ARB_texture_swizzle GL_ARB_vertex_array_bgra GL_EXT_texture_swizzle GL_EXT_vertex_array_bgra GL_NV_conditional_render GL_AMD_conservative_depth GL_AMD_draw_buffers_blend GL_AMD_seamless_cubemap_per_texture GL_AMD_shader_stencil_export GL_ARB_ES2_compatibility GL_ARB_blend_func_extended GL_ARB_debug_output GL_ARB_draw_buffers_blend GL_ARB_draw_elements_base_vertex GL_ARB_explicit_attrib_location GL_ARB_fragment_coord_conventions GL_ARB_provoking_vertex GL_ARB_sample_shading GL_ARB_sampler_objects GL_ARB_seamless_cube_map GL_ARB_shader_stencil_export GL_ARB_shader_texture_lod GL_ARB_texture_cube_map_array GL_ARB_texture_gather GL_ARB_texture_multisample GL_ARB_texture_query_lod GL_ARB_texture_rgb10_a2ui GL_ARB_uniform_buffer_object GL_ARB_vertex_type_2_10_10_10_rev GL_EXT_provoking_vertex GL_EXT_texture_snorm GL_MESA_texture_signed_rgba GL_NV_texture_barrier GL_ARB_get_program_binary GL_ARB_robustness GL_ARB_separate_shader_objects GL_ARB_shader_bit_encoding GL_ARB_shader_precision GL_ARB_texture_compression_bptc GL_ARB_timer_query GL_ARB_transform_feedback2 GL_ARB_transform_feedback3 GL_ANGLE_texture_compression_dxt3 GL_ANGLE_texture_compression_dxt5 GL_ARB_compressed_texture_pixel_storage GL_ARB_conservative_depth GL_ARB_internalformat_query GL_ARB_map_buffer_alignment GL_ARB_shader_atomic_counters GL_ARB_shader_image_load_store GL_ARB_shading_language_420pack GL_ARB_shading_language_packing GL_ARB_texture_storage GL_ARB_transform_feedback_instanced GL_EXT_framebuffer_multisample_blit_scaled GL_EXT_transform_feedback GL_AMD_shader_trinary_minmax GL_ARB_ES3_compatibility GL_ARB_arrays_of_arrays GL_ARB_clear_buffer_object GL_ARB_compute_shader GL_ARB_copy_image GL_ARB_explicit_uniform_location GL_ARB_framebuffer_no_attachments GL_ARB_invalidate_subdata GL_ARB_program_interface_query GL_ARB_robust_buffer_access_behavior GL_ARB_shader_image_size GL_ARB_shader_storage_buffer_object GL_ARB_stencil_texturing GL_ARB_texture_query_levels GL_ARB_texture_storage_multisample GL_ARB_texture_view GL_ARB_vertex_attrib_binding GL_KHR_debug GL_KHR_robustness GL_KHR_texture_compression_astc_ldr GL_ARB_buffer_storage GL_ARB_clear_texture GL_ARB_internalformat_query2 GL_ARB_multi_bind GL_ARB_query_buffer_object GL_ARB_seamless_cubemap_per_texture GL_ARB_shader_draw_parameters GL_ARB_texture_mirror_clamp_to_edge GL_ARB_texture_stencil8 GL_ARB_vertex_type_10f_11f_11f_rev GL_EXT_shader_integer_mix GL_INTEL_performance_query GL_ARB_clip_control GL_ARB_conditional_render_inverted GL_ARB_cull_distance GL_ARB_derivative_control GL_ARB_get_texture_sub_image GL_ARB_pipeline_statistics_query GL_ARB_shader_texture_image_samples GL_ARB_texture_barrier GL_ARB_transform_feedback_overflow_query GL_EXT_polygon_offset_clamp GL_KHR_blend_equation_advanced GL_KHR_blend_equation_advanced_coherent GL_KHR_context_flush_control GL_KHR_robust_buffer_access_behavior GL_ARB_shader_atomic_counter_ops GL_ARB_shader_clock GL_EXT_shader_samples_identical GL_KHR_texture_compression_astc_sliced_3d GL_MESA_shader_integer_functions
18:45:03.197 T:140175580372288 INFO: GL: Maximum texture width: 16384
18:45:03.265 T:140175580372288 INFO: GL: Enabling VSYNC
18:45:03.267 T:140175580372288 INFO: load keymapping
18:45:03.268 T:140175580372288 INFO: Loading special://xbmc/system/keymaps/appcommand.xml
18:45:03.268 T:140175580372288 INFO: Loading special://xbmc/system/keymaps/customcontroller.AppleRemote.xml
18:45:03.269 T:140175580372288 INFO: Loading special://xbmc/system/keymaps/customcontroller.Harmony.xml
18:45:03.270 T:140175580372288 INFO: Loading special://xbmc/system/keymaps/gamepad.xml
18:45:03.270 T:140175580372288 INFO: Loading special://xbmc/system/keymaps/joystick.xml
18:45:03.271 T:140175580372288 INFO: Loading special://xbmc/system/keymaps/keyboard.xml
18:45:03.274 T:140175580372288 INFO: Loading special://xbmc/system/keymaps/mouse.xml
18:45:03.274 T:140175580372288 INFO: Loading special://xbmc/system/keymaps/remote.xml
18:45:03.276 T:140175580372288 INFO: Loading special://xbmc/system/keymaps/touchscreen.xml
18:45:03.277 T:140175580372288 INFO: Loading special://xbmc/system/Lircmap.xml
18:45:03.278 T:140175580372288 INFO: * Adding remote mapping for device 'mceusb'
18:45:03.278 T:140175580372288 INFO: * Adding remote mapping for device 'XboxDVDDongle'
18:45:03.278 T:140175580372288 INFO: * Adding remote mapping for device 'Microsoft_Xbox'
18:45:03.278 T:140175580372288 INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote'
18:45:03.278 T:140175580372288 INFO: * Adding remote mapping for device 'anysee'
18:45:03.278 T:140175580372288 INFO: * Adding remote mapping for device 'iMON-PAD'
18:45:03.278 T:140175580372288 INFO: * Adding remote mapping for device 'Antec_Veris_RM200'
18:45:03.278 T:140175580372288 INFO: * Adding remote mapping for device 'MCE_via_iMON'
18:45:03.278 T:140175580372288 INFO: * Adding remote mapping for device 'TwinHanRemote'
18:45:03.278 T:140175580372288 INFO: * Adding remote mapping for device 'linux-input-layer'
18:45:03.278 T:140175580372288 INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote'
18:45:03.278 T:140175580372288 INFO: * Adding remote mapping for device 'mediacenter'
18:45:03.278 T:140175580372288 INFO: * Adding remote mapping for device 'devinput'
18:45:03.278 T:140175580372288 DEBUG: CButtonTranslator::Load - no userdata Lircmap.xml found, skipping
18:45:03.278 T:140175580372288 INFO: GUI format 1920x1080, Display 1920x1080@ 60.00 - Full Screen
18:45:03.278 T:140175580372288 DEBUG: guilib: Fill viewport on change for solving rendering passes
18:45:03.278 T:140175580372288 INFO: CLangInfo: loading resource.language.en_gb language information...
18:45:03.279 T:140175580372288 DEBUG: trying to set locale to en_US.UTF-8
18:45:03.286 T:140175580372288 INFO: global locale set to C
18:45:03.286 T:140175580372288 INFO: CLangInfo: loading resource.language.en_gb language strings...
18:45:03.293 T:140175580372288 DEBUG: LocalizeStrings: loaded 3789 strings from file resource://resource.language.en_gb/strings.po
18:45:03.296 T:140175580372288 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.xbmc.builtin.aac/resources/language/English/strings.po
18:45:03.296 T:140175580372288 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.xbmc.builtin.wma/resources/language/English/strings.po
18:45:03.296 T:140175580372288 DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/game.controller.default/resources/language/resource.language.en_gb/strings.po
18:45:03.297 T:140175580372288 DEBUG: LocalizeStrings: loaded 13 strings from file /usr/share/kodi/addons/metadata.album.universal/resources/language/English/strings.po
18:45:03.299 T:140175580372288 DEBUG: LocalizeStrings: loaded 26 strings from file /storage/.kodi/addons/metadata.artists.universal/resources/language/English/strings.po
18:45:03.301 T:140175580372288 DEBUG: POParser: PO file has Win Style Line Endings. Converted in memory to Linux LF for file: /storage/.kodi/addons/metadata.themoviedb.org/resources/language/English/strings.po
18:45:03.301 T:140175580372288 DEBUG: LocalizeStrings: loaded 8 strings from file /storage/.kodi/addons/metadata.themoviedb.org/resources/language/English/strings.po
18:45:03.303 T:140175580372288 DEBUG: LocalizeStrings: loaded 10 strings from file /storage/.kodi/addons/metadata.tvdb.com/resources/language/English/strings.po
18:45:03.304 T:140175580372288 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.en_gb/strings.po
18:45:03.305 T:140175580372288 DEBUG: LocalizeStrings: loaded 206 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/English/strings.po
18:45:03.307 T:140175580372288 DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid"
18:45:03.307 T:140175580372288 DEBUG: LoadMappings - loaded node "CEC Adapter"
18:45:03.307 T:140175580372288 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter"
18:45:03.307 T:140175580372288 DEBUG: LoadMappings - loaded node "iMON HID device"
18:45:03.307 T:140175580372288 DEBUG: LoadMappings - loaded node "WETEK Play remote"
18:45:03.307 T:140175580372288 DEBUG: LoadMappings - loaded node ""
18:45:03.307 T:140175580372288 DEBUG: CPeripheralBusUSB - initialised udev monitor
18:45:03.307 T:140175580372288 DEBUG: SECTION:LoadDLL(libcec.so.4)
18:45:03.307 T:140175580372288 DEBUG: Loading: libcec.so.4
18:45:03.316 T:140175580372288 DEBUG: Add-on bus: Registering add-on peripheral.joystick
18:45:03.316 T:140175580372288 DEBUG: PERIPHERAL - CreateAddon - creating peripheral add-on instance 'Joystick Support'
18:45:03.316 T:140175580372288 DEBUG: ADDON: Dll Initializing - Joystick Support
18:45:03.316 T:140175580372288 DEBUG: SECTION:LoadDLL(/usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.3.4)
18:45:03.316 T:140175580372288 DEBUG: Loading: /usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.3.4
18:45:03.324 T:140175580372288 DEBUG: AddOnLog: Joystick Support: Loaded 14 joystick families with 97 total joysticks
18:45:03.324 T:140175580372288 DEBUG: Calling TransferSettings for: Joystick Support
18:45:03.325 T:140175417743104 DEBUG: Thread PeripBusUSBUdev start, auto delete: false
18:45:03.325 T:140175409350400 DEBUG: Thread PeripBusCEC start, auto delete: false
18:45:03.325 T:140175400957696 DEBUG: Thread PeripBusAddon start, auto delete: false
18:45:03.325 T:140175580372288 DEBUG: SECTION:LoadDLL(libcurl.so.4)
18:45:03.325 T:140174981854976 DEBUG: Thread PeripEventScanner start, auto delete: false
18:45:03.325 T:140175580372288 DEBUG: Loading: libcurl.so.4
18:45:03.331 T:140175561430784 NOTICE: Running database version Addons27
18:45:03.331 T:140175561430784 DEBUG: Initialize, updating databases...
18:45:03.332 T:140175561430784 NOTICE: Running database version ViewModes6
18:45:03.334 T:140175561430784 NOTICE: Running database version Textures13
18:45:03.337 T:140175561430784 NOTICE: Running database version MyMusic60
18:45:03.342 T:140175561430784 NOTICE: Running database version MyVideos107
18:45:03.343 T:140175561430784 NOTICE: Running database version TV29
18:45:03.345 T:140175561430784 NOTICE: Running database version Epg11
18:45:03.345 T:140175561430784 DEBUG: Initialize, updating databases... DONE
18:45:03.346 T:140175580372288 NOTICE: start dvd mediatype detection
18:45:03.346 T:140175520507648 DEBUG: Thread DetectDVDMedia start, auto delete: false
18:45:03.346 T:140175520507648 DEBUG: Compiled with libcdio Version 0.94
18:45:03.347 T:140175580372288 DEBUG: DPMS: supported power-saving modes: SUSPEND OFF STANDBY
18:45:03.347 T:140175520507648 DEBUG: Thread DetectDVDMedia 140175520507648 terminating
18:45:03.355 T:140175580358400 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
18:45:03.355 T:140175580358400 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
18:45:03.357 T:140175580372288 INFO: Unloading old skin ...
18:45:03.358 T:140175580372288 INFO: load skin from: /usr/share/kodi/addons/skin.estuary (version: 1.9.16)
18:45:03.358 T:140175580372288 INFO: load fonts for skin...
18:45:03.360 T:140175580372288 INFO: Loading fonts from /usr/share/kodi/addons/skin.estuary/xml/Font.xml
18:45:03.379 T:140175580372288 DEBUG: LocalizeStrings: loaded 132 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.en_gb/strings.po
18:45:03.379 T:140175580372288 INFO: Loading skin includes from /usr/share/kodi/addons/skin.estuary/xml/Includes.xml
18:45:03.398 T:140175580372288 INFO: load new skin...
18:45:03.398 T:140175580372288 INFO: Loading user windows, path /usr/share/kodi/addons/skin.estuary/xml
18:45:03.400 T:140175580372288 DEBUG: Load Skin XML: 2.86ms
18:45:03.400 T:140175580372288 INFO: initialize new skin...
18:45:03.400 T:140175580372288 DEBUG: guilib: Fill viewport on change for solving rendering passes
18:45:03.400 T:140175580372288 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT
18:45:03.402 T:140175580372288 DEBUG: OpenBundle - Opened bundle /usr/share/kodi/addons/skin.estuary/media/Textures.xbt
18:45:03.403 T:140175580372288 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT
18:45:03.404 T:140175580372288 INFO: Loading skin file: DialogNotification.xml, load type: LOAD_ON_GUI_INIT
18:45:03.404 T:140175580372288 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT
18:45:03.407 T:140175580372288 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
18:45:03.407 T:140175580372288 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT
18:45:03.409 T:140175580372288 INFO: Loading resource://resource.uisounds.kodi/sounds.xml
18:45:03.424 T:140175580372288 INFO: skin loaded...
18:45:03.424 T:140175580372288 DEBUG: Activating window ID: 12997
18:45:03.424 T:140175580372288 DEBUG: ------ Window Init () ------
18:45:03.424 T:140175580372288 INFO: load splash image: /usr/share/kodi/media/Splash.png
18:45:03.430 T:140175580372288 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting
18:45:03.430 T:140175580372288 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList"
18:45:03.430 T:140175580372288 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting")
18:45:03.430 T:140175580372288 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting
18:45:03.440 T:140175580372288 INFO: JSONRPC v8.0.0: Successfully initialized
18:45:03.440 T:140175580372288 DEBUG: ADDON: Starting service addons.
18:45:03.441 T:140175580372288 DEBUG: Activating window ID: 12999
18:45:03.441 T:140175580372288 DEBUG: ------ Window Init (Startup.xml) ------
18:45:03.441 T:140175580372288 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME
18:45:03.441 T:140175580372288 DEBUG: Activating window ID: 10000
18:45:03.441 T:140175580372288 DEBUG: ------ Window Deinit (Startup.xml) ------
18:45:03.441 T:140175580372288 DEBUG: ------ Window Init (Home.xml) ------
18:45:03.441 T:140175580372288 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY
18:45:03.472 T:140175580372288 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing..
18:45:03.472 T:140175580372288 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing..
18:45:03.472 T:140175580372288 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing..
18:45:03.472 T:140175580372288 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing..
18:45:03.472 T:140175580372288 DEBUG: CDirectoryProvider[library://video/]: refreshing..
18:45:03.472 T:140175580372288 DEBUG: CDirectoryProvider[sources://video/]: refreshing..
18:45:03.472 T:140175580372288 DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing..
18:45:03.472 T:140175580372288 DEBUG: CDirectoryProvider[favourites://]: refreshing..
18:45:03.472 T:140175580372288 DEBUG: CDirectoryProvider[sources://pictures/]: refreshing..
18:45:03.472 T:140174973462272 DEBUG: Thread JobWorker start, auto delete: true
18:45:03.476 T:140174965069568 DEBUG: Previous line repeats 1 times.
18:45:03.476 T:140174965069568 DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3a%2f%2fprofile%2fplaylists%2fvideo/special%3a%2f%2fprofile%2fplaylists%2fmixed/)
18:45:03.476 T:140175580372288 DEBUG: ContextMenuManager: addon menus reloaded.
18:45:03.476 T:140175580372288 INFO: removing tempfiles
18:45:03.476 T:140174965069568 DEBUG: Getting Directory (special://profile/playlists/video)
18:45:03.476 T:140175580372288 DEBUG: ADDON: Starting service addons.
18:45:03.476 T:140174965069568 DEBUG: Getting Directory (special://profile/playlists/mixed)
18:45:03.477 T:140174965069568 DEBUG: CMultiPathDirectory::MergeItems, items = 0
18:45:03.477 T:140174956676864 DEBUG: Thread LanguageInvoker start, auto delete: false
18:45:03.477 T:140174965069568 DEBUG: CFavourites::Load - no system favourites found, skipping
18:45:03.477 T:140174965069568 DEBUG: CFavourites::Load - no userdata favourites found, skipping
18:45:03.477 T:140174956676864 INFO: initializing python engine.
18:45:03.478 T:140174973462272 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update
18:45:03.479 T:140175580372288 DEBUG: CRepositoryUpdater: previous update at 06/21/2018 4:16:26 PM, next at 06/22/2018 4:16:26 PM
18:45:03.479 T:140175580372288 NOTICE: initialize done
18:45:03.479 T:140175580372288 NOTICE: Running the application...
18:45:03.479 T:140175580372288 DEBUG: no profile autoexec.py (/storage/.kodi/userdata/autoexec.py) found, skipping
18:45:03.479 T:140175580372288 DEBUG: NetworkMessage - Starting network services
18:45:03.480 T:140174948284160 DEBUG: Thread Timer start, auto delete: false
18:45:03.481 T:140175580372288 DEBUG: CZeroconfAvahi::clientCallback: client is up and running
18:45:03.481 T:140175580372288 NOTICE: starting zeroconf publishing
18:45:03.481 T:140174973462272 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
18:45:03.481 T:140175580372288 NOTICE: CWebServer[8080]: Started
18:45:03.481 T:140175580372288 NOTICE: starting upnp client
18:45:03.482 T:140175580372288 DEBUG: GetFirstConnectedInterface no connected interface found - requery list
18:45:03.483 T:140174973462272 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
18:45:03.484 T:140174973462272 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
18:45:03.484 T:140175561430784 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:Kodi (LibreELEC) port:8080
18:45:03.484 T:140174965069568 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:Kodi (LibreELEC) port:8080
18:45:03.484 T:140175561430784 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _http._tcp port:8080
18:45:03.485 T:140174965069568 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _xbmc-jsonrpc-h._tcp port:8080
18:45:03.485 T:140174939891456 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
18:45:03.500 T:140175580372288 DEBUG: Previous line repeats 1 times.
18:45:03.500 T:140175580372288 INFO: JSONRPC Server: Successfully initialized
18:45:03.500 T:140174478522112 DEBUG: Thread EventServer start, auto delete: false
18:45:03.500 T:140174478522112 NOTICE: ES: Starting UDP Event server on port 9777
18:45:03.500 T:140175561430784 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:Kodi (LibreELEC) port:9090
18:45:03.500 T:140175580372288 DEBUG: GetFirstConnectedInterface no connected interface found - requery list
18:45:03.501 T:140174470129408 DEBUG: Thread TCPServer start, auto delete: false
18:45:03.501 T:140175580372288 DEBUG: SECTION:LoadDLL(libshairplay.so.0)
18:45:03.502 T:140175580372288 DEBUG: Loading: libshairplay.so.0
18:45:03.503 T:140175561430784 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _xbmc-jsonrpc._tcp port:9090
18:45:03.503 T:140174478522112 NOTICE: UDP: Listening on port 9777 (ipv6 : false)
18:45:03.503 T:140174965069568 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:Kodi (LibreELEC) port:9777
18:45:03.505 T:140174965069568 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _xbmc-events._udp port:9777
18:45:03.506 T:140175580372288 DEBUG: GetFirstConnectedInterface no connected interface found - requery list
18:45:03.506 T:140175561430784 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airtunes type: _raop._tcp name:000102030405@Kodi (LibreELEC) port:36666
18:45:03.506 T:140175580372288 INFO: AIRPLAY: Cleaning up photoassetcache
18:45:03.507 T:140175580372288 INFO: AIRPLAY Server: Successfully initialized
18:45:03.507 T:140175580372288 DEBUG: GetFirstConnectedInterface no connected interface found - requery list
18:45:03.507 T:140174243657472 DEBUG: Thread AirPlayServer start, auto delete: false
18:45:03.508 T:140174965069568 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airplay type: _airplay._tcp name:Kodi (LibreELEC) port:36667
18:45:03.508 T:140174965069568 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _airplay._tcp port:36667
18:45:03.509 T:140174973462272 DEBUG: RunQuery took 0 ms for 0 items query: select * from movie_view ORDER BY dateAdded desc, idMovie desc LIMIT 10
18:45:03.510 T:140175561430784 DEBUG: CZeroconfAvahi::addService() named: 000102030405@Kodi (LibreELEC) type: _raop._tcp port:36666
18:45:03.510 T:140174973462272 DEBUG: RunQuery took 1 ms for 0 items query: select * from episode_view ORDER BY dateAdded desc, idEpisode desc LIMIT 10
18:45:03.511 T:140174973462272 DEBUG: RunQuery took 0 ms for 0 items query: select * from musicvideo_view ORDER BY dateAdded desc, idMVideo desc LIMIT 10
18:45:03.511 T:140174956676864 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): start processing
18:45:03.512 T:140174939891456 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
18:45:03.524 T:140174956676864 DEBUG: Previous line repeats 3 times.
18:45:03.524 T:140174956676864 DEBUG: -->Python Interpreter Initialized<--
18:45:03.524 T:140174956676864 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"
18:45:03.524 T:140174956676864 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
18:45:03.524 T:140174956676864 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): entering source directory /usr/share/kodi/addons/service.libreelec.settings
18:45:03.524 T:140174956676864 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
18:45:03.559 T:140175580372288 DEBUG: ------ Window Init () ------
18:45:03.560 T:140174973462272 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
18:45:03.561 T:140174973462272 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')
18:45:03.613 T:140174956676864 DEBUG: ## LibreELEC Addon ## 8.2.0
18:45:03.614 T:140174956676864 WARNING: CSkinInfo: failed to load skin settings
18:45:03.761 T:140174956676864 ERROR: ## LibreELEC Addon ## oe::load_url(http://releases.libreelec.tv/releases.json) ## ERROR: (URLError(gaierror(-3, 'Temporary failure in name resolution'),))
18:45:03.761 T:140174956676864 ERROR: Traceback (most recent call last):
File "/home/chewitt/LibreELEC.82-images/build.LibreELEC-Generic.x86_64-8.2.5/LibreELEC-settings-0768930/.install_pkg/usr/share/kodi/addons/service.libreelec.settings/oe.py", line 271, 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:
18:45:03.761 T:140174956676864 INFO: ## LibreELEC Addon ## system::set_hostname ## LibreELEC
18:45:03.761 T:140174956676864 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## us,us -model pc105
18:45:03.786 T:140174956676864 INFO: ## LibreELEC Addon ## system::updateThread ## Started
18:45:03.786 T:140174956676864 INFO: ## LibreELEC Addon ## system::set_auto_update ## auto
18:45:03.798 T:140174226118400 ERROR: ## LibreELEC Addon ## oe::load_url(https://update.libreelec.tv/updates.php?i=57093281262aae9c9158c84dd2f8aa65&d=LibreELEC&pa=Generic.x86_64&v=8.2.5&l=1
) ## ERROR: (URLError(gaierror(-3, 'Temporary failure in name resolution'),))
18:45:03.799 T:140174226118400 ERROR: Traceback (most recent call last):
File "/home/chewitt/LibreELEC.82-images/build.LibreELEC-Generic.x86_64-8.2.5/LibreELEC-settings-0768930/.install_pkg/usr/share/kodi/addons/service.libreelec.settings/oe.py", line 271, 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:
18:45:03.799 T:140174226118400 ERROR: ## LibreELEC Addon ## system::check_updates_v2 ## ERROR: (TypeError('expected string or buffer',))
18:45:03.799 T:140174226118400 ERROR: Traceback (most recent call last):
File "/home/chewitt/LibreELEC.82-images/build.LibreELEC-Generic.x86_64-8.2.5/LibreELEC-settings-0768930/.install_pkg/usr/share/kodi/addons/service.libreelec.settings/resources/lib/modules/system.py", line 768, 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
18:45:03.800 T:140174209332992 INFO: ## LibreELEC Addon ## _service_::run ## WAITING:
18:45:03.802 T:140174217725696 INFO: ## LibreELEC Addon ## xdbus Monitor started. ##
18:45:03.991 T:140175580372288 DEBUG: LogindUPowerSyscall - Received unknown signal NameAcquired
18:45:34.572 T:140174965069568 DEBUG: Thread JobWorker 140174965069568 terminating (autodelete)
18:45:34.572 T:140175561430784 DEBUG: Thread JobWorker 140175561430784 terminating (autodelete)
18:45:34.572 T:140174973462272 DEBUG: Thread JobWorker 140174973462272 terminating (autodelete)
18:48:04.850 T:140175580358400 DEBUG: CAnnouncementManager - Announcement: OnScreensaverActivated from xbmc
18:48:04.850 T:140175580358400 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverActivated
18:48:04.855 T:140175580372288 DEBUG: ------ Window Init () ------
18:49:18.343 T:140175580372288 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
18:49:18.343 T:140175580372288 DEBUG: OnKey: down (0xf081) pressed, screen saver/dpms woken up
18:49:18.343 T:140175580358400 DEBUG: CAnnouncementManager - Announcement: OnScreensaverDeactivated from xbmc
18:49:18.343 T:140175580358400 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverDeactivated
18:49:18.413 T:140175580372288 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
18:49:18.512 T:140175580372288 DEBUG: Previous line repeats 1 times.
18:49:18.512 T:140175580372288 DEBUG: OnKey: down (0xf081) pressed, action is Down
18:49:18.513 T:140175543027456 INFO: CActiveAESink::OpenSink - initialize sink
18:49:18.513 T:140175543027456 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:@
18:49:18.513 T:140175543027456 INFO: CAESinkALSA::Initialize - Attempting to open device "@"
18:49:18.519 T:140175543027456 INFO: CAESinkALSA::Initialize - Opened device "sysdefault"
18:49:18.520 T:140175543027456 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
18:49:18.520 T:140175543027456 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
18:49:18.520 T:140175543027456 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 1024, bufferSize 9600
18:49:18.520 T:140175543027456 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 1024, bufferSize 9216
18:49:18.520 T:140175543027456 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 192 ms
18:49:18.520 T:140175543027456 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
18:49:18.520 T:140175543027456 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
18:49:18.520 T:140175543027456 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR)
18:49:18.520 T:140175543027456 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
18:49:18.520 T:140175543027456 DEBUG: Output Device : Default (HDA Intel PCH ALC255 Analog)
18:49:18.520 T:140175543027456 DEBUG: Sample Rate : 48000
18:49:18.520 T:140175543027456 DEBUG: Sample Format : AE_FMT_S32NE
18:49:18.520 T:140175543027456 DEBUG: Channel Count : 2
18:49:18.520 T:140175543027456 DEBUG: Channel Layout: FL,FR
18:49:18.520 T:140175543027456 DEBUG: Frames : 1024
18:49:18.520 T:140175543027456 DEBUG: Frame Size : 8
18:49:18.563 T:140175580372288 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
18:49:18.646 T:140175580372288 DEBUG: Previous line repeats 1 times.
18:49:18.646 T:140175580372288 DEBUG: OnKey: down (0xf081) pressed, action is Down
18:49:18.698 T:140175580372288 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
18:49:18.795 T:140175580372288 DEBUG: Previous line repeats 1 times.
18:49:18.795 T:140175580372288 DEBUG: OnKey: down (0xf081) pressed, action is Down
18:49:18.847 T:140175580372288 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
18:49:18.997 T:140175580372288 DEBUG: Previous line repeats 1 times.
18:49:18.997 T:140175580372288 DEBUG: OnKey: down (0xf081) pressed, action is Down
18:49:19.014 T:140175580372288 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
18:49:19.131 T:140175580372288 DEBUG: Previous line repeats 1 times.
18:49:19.131 T:140175580372288 DEBUG: OnKey: down (0xf081) pressed, action is Down
18:49:19.165 T:140175580372288 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
18:49:19.265 T:140175580372288 DEBUG: Previous line repeats 1 times.
18:49:19.265 T:140175580372288 DEBUG: OnKey: down (0xf081) pressed, action is Down
18:49:19.266 T:140174973462272 DEBUG: Thread JobWorker start, auto delete: true
18:49:19.332 T:140175580372288 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
18:49:19.366 T:140175580372288 DEBUG: ------ Window Deinit () ------
18:49:19.433 T:140175580372288 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
18:49:19.433 T:140175580372288 DEBUG: OnKey: down (0xf081) pressed, action is Down
18:49:19.501 T:140175580372288 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
18:49:19.734 T:140175580372288 DEBUG: Previous line repeats 1 times.
18:49:19.734 T:140175580372288 DEBUG: OnKey: down (0xf081) pressed, action is Down
18:49:19.816 T:140175580372288 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
18:49:19.999 T:140175580372288 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0
18:49:20.065 T:140175580372288 DEBUG: OnKey: return (0xf00d) pressed, action is Select
18:49:20.065 T:140175580372288 DEBUG: Activating window ID: 10025
18:49:20.381 T:140175580372288 DEBUG: ------ Window Deinit (Home.xml) ------
18:49:20.391 T:140175580372288 DEBUG: ------ Window Init (MyVideoNav.xml) ------
18:49:20.391 T:140175580372288 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY
18:49:20.438 T:140175580372288 DEBUG: CDirectoryProvider[]: refreshing..
18:49:20.439 T:140174973462272 DEBUG: Previous line repeats 6 times.
18:49:20.439 T:140174973462272 ERROR: GetDirectory - Error getting
18:49:20.440 T:140175580372288 ERROR: Previous line repeats 6 times.
18:49:20.440 T:140175580372288 DEBUG: CGUIMediaWindow::GetDirectory ()
18:49:20.440 T:140175580372288 DEBUG: ParentPath = []
18:49:20.441 T:140175561430784 DEBUG: Thread BackgroundLoader start, auto delete: false
18:49:20.443 T:140175561430784 DEBUG: Thread BackgroundLoader 140175561430784 terminating
18:49:20.443 T:140175580372288 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x0000, modifier: 0x0
18:49:21.379 T:140175580372288 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0
18:49:21.445 T:140175580372288 DEBUG: OnKey: return (0xf00d) pressed, action is Select
18:49:21.446 T:140175580372288 DEBUG: CGUIMediaWindow::GetDirectory (library://video/files.xml/)
18:49:21.446 T:140175580372288 DEBUG: ParentPath = []
18:49:21.460 T:140175561430784 DEBUG: Thread BackgroundLoader start, auto delete: false
18:49:21.462 T:140175580372288 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x0000, modifier: 0x0
18:49:21.466 T:140175561430784 DEBUG: Thread BackgroundLoader 140175561430784 terminating
18:49:22.113 T:140175580372288 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
18:49:22.113 T:140175580372288 DEBUG: OnKey: down (0xf081) pressed, action is Down
18:49:22.196 T:140175580372288 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
18:49:22.279 T:140175580372288 DEBUG: Previous line repeats 1 times.
18:49:22.279 T:140175580372288 DEBUG: OnKey: down (0xf081) pressed, action is Down
18:49:22.346 T:140175580372288 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
18:49:22.562 T:140175580372288 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0
18:49:22.629 T:140175580372288 DEBUG: OnKey: return (0xf00d) pressed, action is Select
18:49:22.630 T:140175580372288 DEBUG: CGUIMediaWindow::GetDirectory (/storage/videos/)
18:49:22.630 T:140175580372288 DEBUG: ParentPath = [sources://video/]
18:49:22.633 T:140175561430784 DEBUG: Thread BackgroundLoader start, auto delete: false
18:49:22.635 T:140175580372288 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x0000, modifier: 0x0
18:49:22.640 T:140174973462272 DEBUG: DoWork - trying to extract thumb from video file /storage/videos/TEST.XVID.MP3.avi
18:49:22.641 T:140175561430784 DEBUG: Thread BackgroundLoader 140175561430784 terminating
18:49:22.642 T:140174973462272 DEBUG: Open - probing detected format [avi]
18:49:22.693 T:140174973462272 DEBUG: Open - avformat_find_stream_info starting
18:49:22.703 T:140174973462272 DEBUG: Open - av_find_stream_info finished
18:49:22.704 T:140174973462272 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0
18:49:22.704 T:140174973462272 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1
18:49:22.704 T:140174973462272 DEBUG: ScanForExternalSubtitles: Searching for subtitles...
18:49:22.704 T:140174973462272 DEBUG: ScanForExternalSubtitles: END (total time: 0 ms)
18:49:22.704 T:140174973462272 DEBUG: FactoryCodec - Video: - Opening
18:49:22.704 T:140174973462272 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-4 part 2
18:49:22.704 T:140174973462272 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-mpeg4
18:49:22.704 T:140174973462272 DEBUG: FactoryCodec - Video: ff-mpeg4 - Opened
18:49:22.704 T:140174973462272 DEBUG: ExtractThumb - seeking to pos 481400ms (total: 1444200ms) in /storage/videos/TEST.XVID.MP3.avi
18:49:22.704 T:140174973462272 DEBUG: SeekTime - unknown position after seek
18:49:22.712 T:140174973462272 DEBUG: cached image 'special://masterprofile/Thumbnails/f/ff22d26f.jpg' size 720x540
18:49:22.722 T:140174973462272 DEBUG: ExtractThumb - measured 81 ms to extract thumb from file in 21 packets.
18:49:23.269 T:140175580372288 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
18:49:23.269 T:140175580372288 DEBUG: OnKey: down (0xf081) pressed, action is Down
18:49:23.329 T:140175580372288 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
18:49:23.562 T:140175580372288 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0
18:49:23.629 T:140175580372288 DEBUG: OnKey: return (0xf00d) pressed, action is Select
18:49:23.635 T:140175580372288 DEBUG: OnPlayMedia /storage/videos/TEST.XVID.MP3.avi
18:49:23.644 T:140175580372288 DEBUG: Loading settings for /storage/videos/TEST.XVID.MP3.avi
18:49:23.644 T:140175580358400 DEBUG: GetMovieId (/storage/videos/TEST.XVID.MP3.avi), query = select idMovie from movie where idFile=1
18:49:23.644 T:140175580358400 DEBUG: GetEpisodeId (/storage/videos/TEST.XVID.MP3.avi), query = select idEpisode from episode where idFile=1
18:49:23.645 T:140175580358400 DEBUG: GetMusicVideoId (/storage/videos/TEST.XVID.MP3.avi), query = select idMVideo from musicvideo where idFile=1
18:49:23.647 T:140175580358400 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc
18:49:23.647 T:140175580358400 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd
18:49:23.649 T:140175580372288 DEBUG: CPlayerCoreFactory::GetPlayers(/storage/videos/TEST.XVID.MP3.avi)
18:49:23.650 T:140175580372288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
18:49:23.650 T:140175580372288 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
18:49:23.650 T:140175580372288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp
18:49:23.650 T:140175580372288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
18:49:23.650 T:140175580372288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
18:49:23.650 T:140175580372288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
18:49:23.650 T:140175580372288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
18:49:23.650 T:140175580372288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
18:49:23.650 T:140175580372288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
18:49:23.650 T:140175580372288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
18:49:23.650 T:140175580372288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
18:49:23.650 T:140175580372288 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
18:49:23.650 T:140175580372288 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
18:49:23.650 T:140175580372288 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer)
18:49:23.650 T:140175580372288 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
18:49:23.650 T:140175580372288 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
18:49:23.650 T:140175580372288 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
18:49:23.654 T:140175580372288 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData
18:49:23.654 T:140175580372288 NOTICE: VideoPlayer: Opening: /storage/videos/TEST.XVID.MP3.avi
18:49:23.654 T:140175580372288 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
18:49:23.654 T:140175580372288 DEBUG: LinuxRendererGL: Cleaning up GL resources
18:49:23.654 T:140175580372288 DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16
18:49:23.654 T:140173899720448 DEBUG: Thread VideoPlayer start, auto delete: false
18:49:23.654 T:140173899720448 NOTICE: Creating InputStream
18:49:23.654 T:140173899720448 DEBUG: ScanForExternalSubtitles: Searching for subtitles...
18:49:23.655 T:140173899720448 DEBUG: ScanForExternalSubtitles: END (total time: 0 ms)
18:49:23.655 T:140173899720448 NOTICE: Creating Demuxer
18:49:23.655 T:140173899720448 DEBUG: Open - probing detected format [avi]
18:49:23.711 T:140173899720448 DEBUG: Open - avformat_find_stream_info starting
18:49:23.714 T:140173899720448 DEBUG: Open - av_find_stream_info finished
18:49:23.714 T:140173899720448 INFO: ffmpeg[7F7CC77FE700]: Input #0, avi, /storage/videos/TEST.XVID.MP3.av':
18:49:23.714 T:140173899720448 INFO: ffmpeg[7F7CC77FE700]: Duration: 00:24:04.20, start: 0.000000, bitrate: 1134 kb/s
18:49:23.714 T:140173899720448 INFO: ffmpeg[7F7CC77FE700]: Stream #0:0: Video: mpeg4 (DX50 / 0x30355844), yuv420p, 640x480 [SAR 1:1 DAR 4:3], 989 kb/s, 25 fps, 25 tbr, 25 tbn, 30k tbc
18:49:23.714 T:140173899720448 INFO: ffmpeg[7F7CC77FE700]: Metadata:
18:49:23.714 T:140173899720448 INFO: ffmpeg[7F7CC77FE700]: title : Video
18:49:23.714 T:140173899720448 INFO: ffmpeg[7F7CC77FE700]: Stream #0:1: Audio: mp3 (U[0][0][0] / 0x0055), 44100 Hz, stereo, s16p, 128 kb/s
18:49:23.714 T:140173899720448 INFO: ffmpeg[7F7CC77FE700]: Metadata:
18:49:23.714 T:140173899720448 INFO: ffmpeg[7F7CC77FE700]: title : Audio
18:49:23.714 T:140173899720448 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0
18:49:23.714 T:140173899720448 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1
18:49:23.714 T:140173899720448 NOTICE: Opening stream: 0 source: 256
18:49:23.714 T:140173899720448 NOTICE: Creating video codec with codec id: 13
18:49:23.714 T:140173899720448 DEBUG: FactoryCodec - Video: - Opening
18:49:23.714 T:140173899720448 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-4 part 2
18:49:23.714 T:140173899720448 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-mpeg4
18:49:23.714 T:140173899720448 DEBUG: FactoryCodec - Video: ff-mpeg4 - Opened
18:49:23.714 T:140173899720448 DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 13
18:49:23.714 T:140173899720448 NOTICE: Creating video thread
18:49:23.714 T:140173899720448 NOTICE: Opening stream: 1 source: 256
18:49:23.714 T:140173899720448 NOTICE: Finding audio codec for: 86017
18:49:23.714 T:140173899720448 DEBUG: FactoryCodec - Audio: passthrough - Opening
18:49:23.714 T:140173899720448 DEBUG: FactoryCodec - Audio: passthrough - Failed
18:49:23.714 T:140173899720448 DEBUG: FactoryCodec - Audio: FFmpeg - Opening
18:49:23.714 T:140173908113152 DEBUG: Thread VideoPlayerVideo start, auto delete: false
18:49:23.714 T:140173908113152 NOTICE: running thread: video_thread
18:49:23.714 T:140173899720448 DEBUG: FactoryCodec - Audio: FFmpeg - Opened
18:49:23.714 T:140173899720448 NOTICE: Creating audio thread
18:49:23.714 T:140173899720448 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: /storage/videos/TEST.XVID.MP3.avi
18:49:23.714 T:140174190630656 DEBUG: Thread VideoPlayerAudio start, auto delete: false
18:49:23.714 T:140173899720448 DEBUG: OnPlayBackStarted: play state was 1, starting 1
18:49:23.714 T:140174190630656 NOTICE: running thread: CVideoPlayerAudio::Process()
18:49:23.714 T:140173899720448 DEBUG: CVideoPlayer::SetCaching - caching state 2
18:49:23.714 T:140175580372288 DEBUG: PlayFile: OpenFile succeed, play state 2
18:49:23.714 T:140173899720448 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
18:49:23.714 T:140175580372288 DEBUG: OnPlayBackStarted: play state was 2, starting 0
18:49:23.714 T:140173908113152 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback
18:49:23.714 T:140173908113152 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
18:49:23.714 T:140175580372288 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x0000, modifier: 0x0
18:49:23.714 T:140173908113152 DEBUG: VAAPI - open decoder
18:49:23.724 T:140173908113152 DEBUG: VAAPI - initialize version 0.39
18:49:23.724 T:140173908113152 DEBUG: VAAPI - driver in use: Intel i965 driver for Intel(R) Kabylake - 1.7.3
18:49:23.724 T:140173908113152 DEBUG: VAAPI - attrib 0 (get/set) min -100 max 100 value 0x0
18:49:23.724 T:140173908113152 DEBUG: VAAPI - attrib 1 (get/set) min 0 max 100 value 0x32
18:49:23.724 T:140173908113152 DEBUG: VAAPI - attrib 2 (get/set) min -180 max 180 value 0x0
18:49:23.724 T:140173908113152 DEBUG: VAAPI - attrib 3 (get/set) min 0 max 100 value 0x32
18:49:23.724 T:140173908113152 DEBUG: VAAPI - attrib 6 (get/set) min 0 max 3 value 0x0
18:49:23.724 T:140173908113152 DEBUG: VAAPI - profile 0
18:49:23.724 T:140173908113152 DEBUG: VAAPI - profile 1
18:49:23.724 T:140173908113152 DEBUG: VAAPI - profile 13
18:49:23.724 T:140173908113152 DEBUG: VAAPI - profile 6
18:49:23.724 T:140173908113152 DEBUG: VAAPI - profile 7
18:49:23.724 T:140173908113152 DEBUG: VAAPI - profile 15
18:49:23.724 T:140173908113152 DEBUG: VAAPI - profile 16
18:49:23.724 T:140173908113152 DEBUG: VAAPI - profile 8
18:49:23.724 T:140173908113152 DEBUG: VAAPI - profile 9
18:49:23.724 T:140173908113152 DEBUG: VAAPI - profile 10
18:49:23.724 T:140173908113152 DEBUG: VAAPI - profile -1
18:49:23.724 T:140173908113152 DEBUG: VAAPI - profile 12
18:49:23.724 T:140173908113152 DEBUG: VAAPI - profile 14
18:49:23.724 T:140173908113152 DEBUG: VAAPI - profile 17
18:49:23.724 T:140173908113152 DEBUG: VAAPI - profile 18
18:49:23.724 T:140173908113152 DEBUG: VAAPI - profile 19
18:49:23.724 T:140173908113152 DEBUG: VAAPI - profile 21
18:49:23.724 T:140173908113152 NOTICE: VAAPI::Close
18:49:23.724 T:140173908113152 NOTICE: VAAPI::Close - closing decoder context
18:49:23.724 T:140174190630656 DEBUG: CDVDAudio::Pause - pausing audio stream
18:49:23.724 T:140174190630656 NOTICE: Creating audio stream (codec id: 86017, channels: 2, sample rate: 44100, no pass-through)
18:49:23.724 T:140175551420160 INFO: CActiveAE::ApplySettings - Forcing samplerate to 48000
18:49:23.725 T:140174973462272 DEBUG: CGUIInfoManager::SetCurrentMovie(/storage/videos/TEST.XVID.MP3.avi)
18:49:23.726 T:140173908113152 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-4 part 2
18:49:23.726 T:140173908113152 DEBUG: CDVDVideoCodecFFmpeg - open frame threaded with 6 threads
18:49:23.726 T:140173908113152 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-mpeg4
18:49:23.726 T:140173908113152 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
18:49:23.727 T:140174973462272 DEBUG: Previous line repeats 1 times.
18:49:23.727 T:140174973462272 DEBUG: GetMovieId (/storage/videos/TEST.XVID.MP3.avi), query = select idMovie from movie where idFile=1
18:49:23.727 T:140174973462272 DEBUG: GetEpisodeId (/storage/videos/TEST.XVID.MP3.avi), query = select idEpisode from episode where idFile=1
18:49:23.728 T:140174973462272 DEBUG: GetMusicVideoId (/storage/videos/TEST.XVID.MP3.avi), query = select idMVideo from musicvideo where idFile=1
18:49:23.728 T:140175551420160 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
18:49:23.728 T:140174190630656 DEBUG: CVideoPlayerAudio:: synctype set to 0: clock feedback
18:49:23.728 T:140173899720448 DEBUG: CVideoPlayer::HandleMessages - player started 1
18:49:23.728 T:140173908113152 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
18:49:23.729 T:140175580358400 DEBUG: Previous line repeats 1 times.
18:49:23.729 T:140175580358400 DEBUG: GetMovieId (/storage/videos/TEST.XVID.MP3.avi), query = select idMovie from movie where idFile=1
18:49:23.729 T:140175580358400 DEBUG: GetEpisodeId (/storage/videos/TEST.XVID.MP3.avi), query = select idEpisode from episode where idFile=1
18:49:23.729 T:140175580358400 DEBUG: GetMusicVideoId (/storage/videos/TEST.XVID.MP3.avi), query = select idMVideo from musicvideo where idFile=1
18:49:23.730 T:140175580358400 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
18:49:23.730 T:140175580358400 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
18:49:23.730 T:140173908113152 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
18:49:23.732 T:140173908113152 DEBUG: Previous line repeats 3 times.
18:49:23.732 T:140173908113152 DEBUG: CRenderManager::Configure - change configuration. 640x480. display: 640x480. framerate: 25.00. format: YV12
18:49:23.744 T:140175580372288 DEBUG: DeleteRenderer - deleting renderer
18:49:23.744 T:140175580372288 DEBUG: LinuxRendererGL: Cleaning up GL resources
18:49:23.747 T:140175580372288 DEBUG: Previous line repeats 1 times.
18:49:23.747 T:140175580372288 DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16
18:49:23.747 T:140175580372288 DEBUG: GL: Requested render method: 0
18:49:23.747 T:140175580372288 DEBUG: GL: BaseYUV2RGBGLSLShader: defines:
#define XBMC_texture_rectangle 0
#define XBMC_texture_rectangle_hack 0
#define XBMC_STRETCH 0
#define XBMC_YV12
18:49:23.747 T:140175580372288 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader
18:49:23.751 T:140175580372288 DEBUG: GL: Vertex Shader compilation log:
18:49:23.751 T:140175580372288 DEBUG: GL: Vertex Shader compiled successfully
18:49:23.751 T:140175580372288 DEBUG: GL: Pixel Shader compilation log:
18:49:23.751 T:140175580372288 DEBUG: GL: Fragment Shader compiled successfully
18:49:23.759 T:140175580372288 DEBUG: GL: Vertex Shader compilation log:
18:49:23.759 T:140175580372288 DEBUG: GL: Vertex Shader compiled successfully
18:49:23.760 T:140175580372288 DEBUG: GL: Pixel Shader compilation log:
18:49:23.760 T:140175580372288 DEBUG: GL: Fragment Shader compiled successfully
18:49:23.763 T:140175580372288 NOTICE: GL: NPOT texture support detected
18:49:23.763 T:140175580372288 NOTICE: GL: Using GL_ARB_pixel_buffer_object
18:49:23.763 T:140175580372288 NOTICE: Using GL_TEXTURE_2D
18:49:23.764 T:140175580372288 DEBUG: CRenderManager::Configure - 4
18:49:23.769 T:140175580372288 DEBUG: GL: Requested render method: 0
18:49:23.769 T:140175580372288 DEBUG: GL: BaseYUV2RGBGLSLShader: defines:
#define XBMC_texture_rectangle 0
#define XBMC_texture_rectangle_hack 0
#define XBMC_STRETCH 0
#define XBMC_YV12
18:49:23.769 T:140175580372288 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader
18:49:23.770 T:140175580372288 DEBUG: GL: Vertex Shader compilation log:
18:49:23.770 T:140175580372288 DEBUG: GL: Vertex Shader compiled successfully
18:49:23.771 T:140175580372288 DEBUG: GL: Pixel Shader compilation log:
18:49:23.771 T:140175580372288 DEBUG: GL: Fragment Shader compiled successfully
18:49:23.772 T:140173899720448 DEBUG: CVideoPlayer::HandleMessages - player started 2
18:49:23.772 T:140173899720448 DEBUG: CVideoPlayer::SetCaching - caching state 3
18:49:23.772 T:140173899720448 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
18:49:23.772 T:140173899720448 DEBUG: CVideoPlayer::SetCaching - caching state 0
18:49:23.772 T:140173899720448 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
18:49:23.772 T:140173899720448 DEBUG: VideoPlayer::Sync - Audio - pts: 0.000000, cache: 344640.555299, totalcache: 592000.007629
18:49:23.772 T:140173899720448 DEBUG: VideoPlayer::Sync - Video - pts: 40000.000000, cache: 50000.000000, totalcache: 100000.000000
18:49:23.772 T:140173908113152 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(-344640.555299)
18:49:23.772 T:140174190630656 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(-344640.555299)
18:49:23.772 T:140173908113152 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
18:49:23.772 T:140174190630656 DEBUG: CDVDAudio::Resume - resume audio stream
18:49:23.772 T:140173908113152 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1
18:49:23.773 T:140175551420160 DEBUG: ActiveAE - start sync of audio stream
18:49:23.779 T:140175580372288 NOTICE: GL: NPOT texture support detected
18:49:23.779 T:140175580372288 NOTICE: GL: Using GL_ARB_pixel_buffer_object
18:49:23.784 T:140175580372288 DEBUG: Activating window ID: 12005
18:49:23.784 T:140175580372288 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
18:49:23.784 T:140175580372288 DEBUG: ------ Window Init (VideoFullScreen.xml) ------
18:49:23.784 T:140175580372288 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY
18:49:23.873 T:140175551420160 DEBUG: ActiveAE::SyncStream - average error of 69.413726, start adjusting
18:49:23.894 T:140175551420160 DEBUG: ActiveAE::SyncStream - average error 27.413726 below threshold of 30.000000
18:49:24.361 T:140173908113152 NOTICE: CDVDVideoCodecFFmpeg::CDropControl: calculated diff time: 40000
18:49:24.919 T:140174190630656 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:26638.000335, adjusted:26638.000335
18:49:26.545 T:140175580372288 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0
18:49:26.628 T:140175580372288 DEBUG: OnKey: up (0xf080) pressed, action is ChapterOrBigStepForward
18:49:26.634 T:140173899720448 DEBUG: CVideoPlayer::SetCaching - caching state 2
18:49:26.634 T:140173899720448 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
18:49:26.634 T:140173899720448 DEBUG: demuxer seek to: 602536.000000
18:49:26.634 T:140173899720448 DEBUG: SeekTime - unknown position after seek
18:49:26.634 T:140173899720448 DEBUG: demuxer seek to: 602536.000000, success
18:49:26.634 T:140173899720448 DEBUG: CVideoPlayer::FlushBuffers - flushing buffers
18:49:26.668 T:140174190630656 DEBUG: CDVDAudio::Pause - pausing audio stream
18:49:26.711 T:140174190630656 DEBUG: CDVDAudio::Flush - flush audio stream
18:49:26.711 T:140174190630656 DEBUG: CDVDAudio::Pause - pausing audio stream
18:49:26.711 T:140174190630656 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
18:49:26.711 T:140173908113152 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
18:49:26.711 T:140173899720448 DEBUG: CVideoPlayer - CDVDMsg::GENERAL_SYNCHRONIZE
18:49:26.711 T:140175580372288 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0
18:49:26.712 T:140175580372288 DEBUG: ------ Window Init (DialogSeekBar.xml) ------
18:49:26.713 T:140175580372288 DEBUG: ------ Window Init (Custom_1109_TopBarOverlay.xml) ------
18:49:26.713 T:140175580372288 INFO: Loading skin file: Custom_1109_TopBarOverlay.xml, load type: KEEP_IN_MEMORY
18:49:26.714 T:140173908113152 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback
18:49:26.717 T:140175580358400 DEBUG: GetMovieId (/storage/videos/TEST.XVID.MP3.avi), query = select idMovie from movie where idFile=1
18:49:26.717 T:140175580358400 DEBUG: GetEpisodeId (/storage/videos/TEST.XVID.MP3.avi), query = select idEpisode from episode where idFile=1
18:49:26.717 T:140175580358400 DEBUG: GetMusicVideoId (/storage/videos/TEST.XVID.MP3.avi), query = select idMVideo from musicvideo where idFile=1
18:49:26.719 T:140175580358400 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc
18:49:26.719 T:140175580358400 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek
18:49:26.721 T:140173908113152 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
18:49:26.725 T:140173899720448 DEBUG: Previous line repeats 1 times.
18:49:26.725 T:140173899720448 DEBUG: CVideoPlayer::HandleMessages - player started 1
18:49:26.727 T:140173908113152 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
18:49:26.746 T:140173899720448 DEBUG: Previous line repeats 3 times.
18:49:26.746 T:140173899720448 DEBUG: CVideoPlayer::HandleMessages - player started 2
18:49:26.746 T:140173899720448 DEBUG: CVideoPlayer::SetCaching - caching state 3
18:49:26.746 T:140173899720448 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
18:49:26.746 T:140173899720448 DEBUG: CVideoPlayer::SetCaching - caching state 0
18:49:26.746 T:140173899720448 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
18:49:26.746 T:140173899720448 DEBUG: VideoPlayer::Sync - Audio - pts: 605675102.000000, cache: 313469.380140, totalcache: 592000.007629
18:49:26.746 T:140173899720448 DEBUG: VideoPlayer::Sync - Video - pts: 605440000.000000, cache: 50000.000000, totalcache: 100000.000000
18:49:26.746 T:140173908113152 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(605340000.000000)
18:49:26.746 T:140174190630656 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(605340000.000000)
18:49:26.746 T:140173908113152 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
18:49:26.746 T:140174190630656 DEBUG: CDVDAudio::Resume - resume audio stream
18:49:26.746 T:140175551420160 DEBUG: ActiveAE - start sync of audio stream
18:49:26.746 T:140173908113152 DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1
18:49:26.860 T:140175551420160 DEBUG: ActiveAE::SyncStream - average error of -25.553550, start adjusting
18:49:26.860 T:140175551420160 DEBUG: ActiveAE::SyncStream - average error -4.553550 below threshold of 30.000000
18:49:27.863 T:140175551420160 DEBUG: ActiveAE::SyncStream - average error -131.074089 above threshold of 100.000000
18:49:27.864 T:140175551420160 DEBUG: ActiveAE::SyncStream - average error -26.074089 below threshold of 30.000000
18:49:28.887 T:140174190630656 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-24500.129312, adjusted:-24500.129312
18:49:29.462 T:140175580372288 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
18:49:29.462 T:140175580372288 DEBUG: ------ Window Deinit (Custom_1109_TopBarOverlay.xml) ------
18:49:30.395 T:140175580372288 DEBUG: Keyboard: scancode: 0x35, sym: 0x0078, unicode: 0x0078, modifier: 0x0
18:49:30.395 T:140175580372288 DEBUG: OnKey: x (0xf058) pressed, action is Stop
18:49:30.395 T:140175580372288 NOTICE: CVideoPlayer::CloseFile()
18:49:30.395 T:140175580372288 NOTICE: VideoPlayer: waiting for threads to exit
18:49:30.400 T:140173899720448 NOTICE: CVideoPlayer::OnExit()
18:49:30.400 T:140173899720448 NOTICE: Closing stream player 1
18:49:30.400 T:140173899720448 NOTICE: Waiting for audio thread to exit
18:49:30.402 T:140174190630656 NOTICE: thread end: CVideoPlayerAudio::OnExit()
18:49:30.402 T:140174190630656 DEBUG: Thread VideoPlayerAudio 140174190630656 terminating
18:49:30.402 T:140173899720448 NOTICE: Closing audio device
18:49:30.423 T:140173899720448 DEBUG: CDVDAudio::Flush - flush audio stream
18:49:30.434 T:140175551420160 DEBUG: CActiveAE::DiscardStream - audio stream deleted
18:49:30.434 T:140175551420160 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
18:49:30.451 T:140175551420160 DEBUG: Previous line repeats 2 times.
18:49:30.451 T:140175551420160 INFO: CActiveAE::ApplySettings - Forcing samplerate to 48000
18:49:30.451 T:140173899720448 NOTICE: Deleting audio codec
18:49:30.451 T:140173899720448 NOTICE: Closing stream player 2
18:49:30.451 T:140175551420160 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
18:49:30.451 T:140173899720448 NOTICE: waiting for video thread to exit
18:49:30.494 T:140173908113152 NOTICE: thread end: video_thread
18:49:30.494 T:140173908113152 DEBUG: Thread VideoPlayerVideo 140173908113152 terminating
18:49:30.494 T:140173899720448 NOTICE: deleting video codec
18:49:30.496 T:140173899720448 DEBUG: OnPlayBackStopped: play state was 2, starting 0
18:49:30.496 T:140173899720448 DEBUG: Thread VideoPlayer 140173899720448 terminating
18:49:30.496 T:140175580372288 NOTICE: VideoPlayer: finished waiting
18:49:30.496 T:140175580372288 DEBUG: DeleteRenderer - deleting renderer
18:49:30.496 T:140175580372288 DEBUG: LinuxRendererGL: Cleaning up GL resources
18:49:30.497 T:140175580372288 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
18:49:30.497 T:140175580372288 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------
18:49:30.500 T:140175580358400 DEBUG: GetMovieId (/storage/videos/TEST.XVID.MP3.avi), query = select idMovie from movie where idFile=1
18:49:30.501 T:140175580358400 DEBUG: GetEpisodeId (/storage/videos/TEST.XVID.MP3.avi), query = select idEpisode from episode where idFile=1
18:49:30.501 T:140175580358400 DEBUG: GetMusicVideoId (/storage/videos/TEST.XVID.MP3.avi), query = select idMVideo from musicvideo where idFile=1
18:49:30.501 T:140175580372288 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
18:49:30.501 T:140175580358400 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
18:49:30.501 T:140175580358400 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
18:49:30.502 T:140175580372288 DEBUG: ------ Window Init (MyVideoNav.xml) ------
18:49:30.503 T:140175580372288 DEBUG: CGUIMediaWindow::GetDirectory (/storage/videos/)
18:49:30.503 T:140175580372288 DEBUG: ParentPath = [/storage/videos/]
18:49:30.504 T:140175580372288 DEBUG: RunQuery took 0 ms for 1 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=1
18:49:30.504 T:140173899720448 DEBUG: Thread BackgroundLoader start, auto delete: false
18:49:30.506 T:140173899720448 DEBUG: Thread BackgroundLoader 140173899720448 terminating
18:49:30.544 T:140175580372288 NOTICE: CVideoPlayer::CloseFile()
18:49:30.544 T:140175580372288 NOTICE: VideoPlayer: waiting for threads to exit
18:49:30.544 T:140175580372288 NOTICE: VideoPlayer: finished waiting
18:49:30.544 T:140175580372288 NOTICE: CVideoPlayer::CloseFile()
18:49:30.544 T:140175580372288 NOTICE: VideoPlayer: waiting for threads to exit
18:49:30.544 T:140175580372288 NOTICE: VideoPlayer: finished waiting
18:49:30.545 T:140175580372288 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData
18:49:30.545 T:140175580372288 DEBUG: Keyboard: scancode: 0x35, sym: 0x0078, unicode: 0x0000, modifier: 0x0
18:49:30.830 T:140174973462272 DEBUG: DoWork - Saving file state for video item /storage/videos/TEST.XVID.MP3.avi
18:49:30.877 T:140175580358400 DEBUG: CAnnouncementManager - Announcement: OnUpdate from xbmc
18:49:30.877 T:140175580358400 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnUpdate
18:49:32.069 T:140175580372288 DEBUG: Keyboard: scancode: 0x09, sym: 0x001b, unicode: 0x001b, modifier: 0x0
18:49:32.163 T:140175580372288 DEBUG: OnKey: escape (0xf01b) pressed, action is PreviousMenu
18:49:32.163 T:140175580372288 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
18:49:32.480 T:140175580372288 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
18:49:32.481 T:140175580372288 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
18:49:32.481 T:140175580372288 DEBUG: ------ Window Init (Home.xml) ------
18:49:32.482 T:140175580372288 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing..
18:49:32.482 T:140175580372288 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing..
18:49:32.482 T:140175580372288 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing..
18:49:32.482 T:140175580372288 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing..
18:49:32.482 T:140173899720448 DEBUG: Thread JobWorker start, auto delete: true
18:49:32.485 T:140175580372288 DEBUG: Keyboard: scancode: 0x09, sym: 0x001b, unicode: 0x0000, modifier: 0x0
18:50:02.496 T:140174973462272 DEBUG: Thread JobWorker 140174973462272 terminating (autodelete)
18:50:02.496 T:140173899720448 DEBUG: Thread JobWorker 140173899720448 terminating (autodelete)
18:52:32.202 T:140175580358400 DEBUG: CAnnouncementManager - Announcement: OnScreensaverActivated from xbmc
18:52:32.202 T:140175580358400 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverActivated
18:52:32.203 T:140175580372288 DEBUG: ------ Window Init () ------