rendered paste body14:42:53 T:139718301390912 NOTICE: special://profile/ is mapped to: special://masterprofile/
14:42:53 T:139718301390912 NOTICE: -----------------------------------------------------------------------
14:42:53 T:139718301390912 NOTICE: Starting Kodi (16.1 Git:c327c53). Platform: Linux x86 64-bit
14:42:53 T:139718301390912 NOTICE: Using Release Kodi x64 build
14:42:53 T:139718301390912 NOTICE: Kodi compiled Dec 29 2016 by GCC 5.3.0 for Linux x86 64-bit version 4.4.13 (263181)
14:42:53 T:139718301390912 NOTICE: Running on LibreELEC (official) - Version: 7.0.3, kernel: Linux x86 64-bit version 4.4.13
14:42:53 T:139718301390912 NOTICE: FFmpeg version: 2.8.6
14:42:53 T:139718301390912 NOTICE: WARNING: unsupported ffmpeg version detected
14:42:53 T:139718301390912 NOTICE: Host CPU: Intel(R) Pentium(R) CPU N3700 @ 1.60GHz, 4 cores available
14:42:53 T:139718301390912 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi
14:42:53 T:139718301390912 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi
14:42:53 T:139718301390912 NOTICE: special://masterprofile/ is mapped to: /storage/.kodi/userdata
14:42:53 T:139718301390912 NOTICE: special://home/ is mapped to: /storage/.kodi
14:42:53 T:139718301390912 NOTICE: special://temp/ is mapped to: /storage/.kodi/temp
14:42:53 T:139718301390912 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin
14:42:53 T:139718301390912 NOTICE: Local hostname: LibreELEC
14:42:53 T:139718301390912 NOTICE: Log File is located: /storage/.kodi/temp/kodi.log
14:42:53 T:139718301390912 NOTICE: -----------------------------------------------------------------------
14:42:53 T:139718301390912 ERROR: DBus: Error org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files
14:42:53 T:139718301390912 NOTICE: load settings...
14:42:53 T:139718301390912 NOTICE: Found 2 Lists of Devices
14:42:53 T:139718301390912 NOTICE: Enumerated ALSA devices:
14:42:53 T:139718301390912 NOTICE: Device 1
14:42:53 T:139718301390912 NOTICE: m_deviceName : @
14:42:53 T:139718301390912 NOTICE: m_displayName : Default (HDA Intel PCH ALC283 Analog)
14:42:53 T:139718301390912 NOTICE: m_displayNameExtra:
14:42:53 T:139718301390912 NOTICE: m_deviceType : AE_DEVTYPE_PCM
14:42:53 T:139718301390912 NOTICE: m_channels : FL,FR,BL,BR
14:42:53 T:139718301390912 NOTICE: m_sampleRates : 48000
14:42:53 T:139718301390912 NOTICE: m_dataFormats : AE_FMT_S32NE
14:42:53 T:139718301390912 NOTICE: Device 2
14:42:53 T:139718301390912 NOTICE: m_deviceName : @:CARD=PCH,DEV=0
14:42:53 T:139718301390912 NOTICE: m_displayName : HDA Intel PCH
14:42:53 T:139718301390912 NOTICE: m_displayNameExtra: ALC283 Analog
14:42:53 T:139718301390912 NOTICE: m_deviceType : AE_DEVTYPE_PCM
14:42:53 T:139718301390912 NOTICE: m_channels : FL,FR,BL,BR
14:42:53 T:139718301390912 NOTICE: m_sampleRates : 48000
14:42:53 T:139718301390912 NOTICE: m_dataFormats : AE_FMT_S32NE
14:42:53 T:139718301390912 NOTICE: Device 3
14:42:53 T:139718301390912 NOTICE: m_deviceName : iec958:CARD=PCH,DEV=0
14:42:53 T:139718301390912 NOTICE: m_displayName : HDA Intel PCH
14:42:53 T:139718301390912 NOTICE: m_displayNameExtra: ALC283 Digital S/PDIF
14:42:53 T:139718301390912 NOTICE: m_deviceType : AE_DEVTYPE_IEC958
14:42:53 T:139718301390912 NOTICE: m_channels : FL,FR
14:42:53 T:139718301390912 NOTICE: m_sampleRates : 44100,48000,88200,96000,192000
14:42:53 T:139718301390912 NOTICE: m_dataFormats : AE_FMT_AC3,AE_FMT_DTS,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE
14:42:53 T:139718301390912 NOTICE: Device 4
14:42:53 T:139718301390912 NOTICE: m_deviceName : hdmi:CARD=PCH,DEV=0
14:42:53 T:139718301390912 NOTICE: m_displayName : HDA Intel PCH
14:42:53 T:139718301390912 NOTICE: m_displayNameExtra: SNY SONY TV *01 on HDMI
14:42:53 T:139718301390912 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
14:42:53 T:139718301390912 NOTICE: m_channels : FL,FR
14:42:53 T:139718301390912 NOTICE: m_sampleRates : 32000,44100,48000
14:42:53 T:139718301390912 NOTICE: m_dataFormats : AE_FMT_LPCM,AE_FMT_AC3,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_DTSHD,AE_FMT_TRUEHD,AE_FMT_EAC3,AE_FMT_DTS,AE_FMT_AAC
14:42:53 T:139718301390912 NOTICE: Enumerated PULSE devices:
14:42:53 T:139718301390912 NOTICE: Device 1
14:42:53 T:139718301390912 NOTICE: m_deviceName : Default
14:42:53 T:139718301390912 NOTICE: m_displayName : Default
14:42:53 T:139718301390912 NOTICE: m_displayNameExtra: Bluetooth Audio (PULSEAUDIO)
14:42:53 T:139718301390912 NOTICE: m_deviceType : AE_DEVTYPE_PCM
14:42:53 T:139718301390912 NOTICE: m_channels : FL,FR
14:42:53 T:139718301390912 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000
14:42:53 T:139718301390912 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT
14:42:53 T:139718301390912 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml
14:42:53 T:139718301390912 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are...
<?xml version="1.0" encoding="UTF-8" ?>
<advancedsettings>
<showexitbutton>false</showexitbutton>
<cputempcommand>cputemp</cputempcommand>
<gputempcommand>gputemp</gputempcommand>
<video>
<latency>
<delay>0</delay>
<refresh>
<min>23</min>
<max>24</max>
<delay>175</delay>
</refresh>
</latency>
<busydialogdelayms>750</busydialogdelayms>
</video>
<samba>
<clienttimeout>30</clienttimeout>
</samba>
<network>
<readbufferfactor>4.0</readbufferfactor>
</network>
</advancedsettings>
14:42:53 T:139718301390912 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml)
14:42:53 T:139718301390912 NOTICE: Default DVD Player: dvdplayer
14:42:53 T:139718301390912 NOTICE: Default Video Player: dvdplayer
14:42:53 T:139718301390912 NOTICE: Default Audio Player: paplayer
14:42:53 T:139718301390912 NOTICE: Enabled debug logging due to GUI setting (2)
14:42:53 T:139718301390912 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM"
14:42:53 T:139718301390912 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml
14:42:53 T:139718301390912 DEBUG: CMediaSourceSettings: <programs> tag is missing or sources.xml is malformed
14:42:53 T:139718301390912 DEBUG: CMediaSourceSettings: <files> tag is missing or sources.xml is malformed
14:42:53 T:139718301390912 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
14:42:53 T:139718301390912 DEBUG: CPlayerCoreConfig::<ctor>: created player DVDPlayer for core 1
14:42:53 T:139718301390912 DEBUG: CPlayerCoreConfig::<ctor>: created player oldmplayercore for core 1
14:42:53 T:139718301390912 DEBUG: CPlayerCoreConfig::<ctor>: created player PAPlayer for core 3
14:42:53 T:139718301390912 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules
14:42:53 T:139718301390912 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mms/udp
14:42:53 T:139718301390912 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout
14:42:53 T:139718301390912 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp
14:42:53 T:139718301390912 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp
14:42:53 T:139718301390912 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams
14:42:53 T:139718301390912 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp
14:42:53 T:139718301390912 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2
14:42:53 T:139718301390912 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd
14:42:53 T:139718301390912 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage
14:42:53 T:139718301390912 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf
14:42:53 T:139718301390912 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv
14:42:53 T:139718301390912 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio
14:42:53 T:139718301390912 NOTICE: Loaded playercorefactory configuration
14:42:53 T:139718301390912 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
14:42:53 T:139718301390912 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
14:42:53 T:139718301390912 INFO: creating subdirectories
14:42:53 T:139718301390912 INFO: userdata folder: special://masterprofile/
14:42:53 T:139718301390912 INFO: recording folder:
14:42:53 T:139718301390912 INFO: screenshots folder: /storage/screenshots/
14:42:53 T:139718290847488 DEBUG: Thread ActiveAE start, auto delete: false
14:42:53 T:139718282454784 DEBUG: Thread AESink start, auto delete: false
14:42:53 T:139718282454784 INFO: CActiveAESink::OpenSink - initialize sink
14:42:53 T:139718282454784 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:@
14:42:53 T:139718282454784 INFO: CAESinkALSA::Initialize - Attempting to open device "@"
14:42:53 T:139718282454784 INFO: CAESinkALSA::Initialize - Opened device "sysdefault"
14:42:53 T:139718282454784 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
14:42:53 T:139718282454784 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
14:42:53 T:139718282454784 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 1024, bufferSize 9600
14:42:53 T:139718282454784 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 1024, bufferSize 9216
14:42:53 T:139718282454784 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 192 ms
14:42:53 T:139718282454784 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
14:42:53 T:139718282454784 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
14:42:53 T:139718282454784 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR)
14:42:53 T:139718282454784 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
14:42:53 T:139718282454784 DEBUG: Output Device : Default (HDA Intel PCH ALC283 Analog)
14:42:53 T:139718282454784 DEBUG: Sample Rate : 48000
14:42:53 T:139718282454784 DEBUG: Sample Format : AE_FMT_S32NE
14:42:53 T:139718282454784 DEBUG: Channel Count : 2
14:42:53 T:139718282454784 DEBUG: Channel Layout: FL,FR
14:42:53 T:139718282454784 DEBUG: Frames : 1024
14:42:53 T:139718282454784 DEBUG: Frame Samples : 2048
14:42:53 T:139718282454784 DEBUG: Frame Size : 8
14:42:53 T:139718301390912 NOTICE: Running database version Addons20
14:42:53 T:139718301390912 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcpluff-x86_64-linux.so)
14:42:53 T:139718301390912 DEBUG: Loading: /usr/lib/kodi/system/libcpluff-x86_64-linux.so
14:42:53 T:139718301390912 INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/kodi/addons: No such file or directory'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in resource.images.weathericons.default has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in xbmc.audioencoder has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in kodi.audiodecoder has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in kodi.guilib has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in kodi.adsp has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.wma has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in service.libreelec.settings has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in skin.confluence has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in kodi.resource has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in os.openelec.tv has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.youtube has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in os.libreelec.tv has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in repository.libreelec.tv has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.aac has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in resource.language.en_gb has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in metadata.local has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in xbmc.webinterface has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in resource.uisounds.confluence has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Plug-in xbmc.codec has been installed.'
14:42:53 T:139718301390912 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.'
14:42:53 T:139718301390912 NOTICE: ADDONS: Using repository repository.xbmc.org
14:42:53 T:139718301390912 NOTICE: ADDONS: Using repository repository.libreelec.tv
14:42:53 T:139718272788224 DEBUG: Thread RemoteControl start, auto delete: false
14:42:53 T:139718272788224 INFO: LIRC Process: using: /run/lirc/lircd
14:42:53 T:139718272788224 INFO: LIRC Connect: successfully started
14:42:53 T:139718272788224 DEBUG: Thread RemoteControl 139718272788224 terminating
14:42:53 T:139718301390912 INFO: CKeyboardLayoutManager: loading keyboard layouts from special://xbmc/system/keyboardlayouts...
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Arabic QWERTY" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian " successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian " successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BasePY" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BaiduPY" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Czech QWERTZ" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Danish QWERTY" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "English QWERTY" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "English AZERTY" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "English ABC" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "French AZERTY" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "German QWERTZ" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Greek QWERTY" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew QWERTY" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew ABC" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Hungarian QWERTZ" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Korean " successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian AZERTY" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian QWERTY" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Norwegian QWERTY" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Polish QWERTY" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Portuguese (Portugal) QWERTY" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Romanian QWERTY" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian " successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian " successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Spanish QWERTY" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Swedish QWERTY" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Turkish QWERTY" successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian " successfully loaded
14:42:53 T:139718301390912 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian " successfully loaded
14:42:53 T:139718301390912 DEBUG: UDisks: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UDisks was not provided by any .service files
14:42:53 T:139718301390912 DEBUG: DeviceKit.Disks: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.DeviceKit.Disks was not provided by any .service files
14:42:53 T:139718301390912 DEBUG: Selected UDev as storage provider
14:42:53 T:139718301390912 NOTICE: Setup SDL
14:42:53 T:139718301390912 INFO: Available videomodes (xrandr):
14:42:53 T:139718301390912 INFO: Output 'HDMI2' has 29 modes
14:42:53 T:139718301390912 INFO: ID:0x49 Name:1920x1080 Refresh:60.000000 Width:1920 Height:1080
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.000182
14:42:53 T:139718301390912 INFO: ID:0x104 Name:1920x1080 Refresh:50.000000 Width:1920 Height:1080
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.000182
14:42:53 T:139718301390912 INFO: ID:0x105 Name:1920x1080 Refresh:59.940201 Width:1920 Height:1080
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.000182
14:42:53 T:139718301390912 INFO: ID:0x108 Name:1920x1080 Refresh:30.000000 Width:1920 Height:1080
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.000182
14:42:53 T:139718301390912 INFO: ID:0x109 Name:1920x1080 Refresh:24.000000 Width:1920 Height:1080
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.000182
14:42:53 T:139718301390912 INFO: ID:0x10b Name:1920x1080 Refresh:29.970100 Width:1920 Height:1080
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.000182
14:42:53 T:139718301390912 INFO: ID:0x10c Name:1920x1080 Refresh:23.976080 Width:1920 Height:1080
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.000182
14:42:53 T:139718301390912 INFO: ID:0x106 Name:1920x1080i Refresh:30.000000 Width:1920 Height:1080
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.000182
14:42:53 T:139718301390912 INFO: ID:0x107 Name:1920x1080i Refresh:25.000000 Width:1920 Height:1080
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.000182
14:42:53 T:139718301390912 INFO: ID:0x10a Name:1920x1080i Refresh:29.970100 Width:1920 Height:1080
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.000182
14:42:53 T:139718301390912 INFO: ID:0x10d Name:1600x900 Refresh:60.000000 Width:1600 Height:900
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.000183
14:42:53 T:139718301390912 INFO: ID:0x10e Name:1280x1024 Refresh:60.019741 Width:1280 Height:1024
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.422482
14:42:53 T:139718301390912 INFO: ID:0x10f Name:1280x720 Refresh:60.000000 Width:1280 Height:720
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.000183
14:42:53 T:139718301390912 INFO: ID:0x110 Name:1280x720 Refresh:50.000000 Width:1280 Height:720
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.000183
14:42:53 T:139718301390912 INFO: ID:0x111 Name:1280x720 Refresh:30.000000 Width:1280 Height:720
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.000183
14:42:53 T:139718301390912 INFO: ID:0x112 Name:1280x720 Refresh:59.940201 Width:1280 Height:720
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.000183
14:42:53 T:139718301390912 INFO: ID:0x113 Name:1280x720 Refresh:29.970100 Width:1280 Height:720
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.000183
14:42:53 T:139718301390912 INFO: ID:0x114 Name:1280x720 Refresh:24.000000 Width:1280 Height:720
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.000183
14:42:53 T:139718301390912 INFO: ID:0x115 Name:1280x720 Refresh:23.976160 Width:1280 Height:720
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.000183
14:42:53 T:139718301390912 INFO: ID:0x116 Name:1024x768 Refresh:60.003841 Width:1024 Height:768
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.333577
14:42:53 T:139718301390912 INFO: ID:0x117 Name:800x600 Refresh:60.316540 Width:800 Height:600
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.333577
14:42:53 T:139718301390912 INFO: ID:0x118 Name:720x576 Refresh:50.000000 Width:720 Height:576
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.422482
14:42:53 T:139718301390912 INFO: ID:0x119 Name:720x576i Refresh:25.000000 Width:720 Height:576
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.422482
14:42:53 T:139718301390912 INFO: ID:0x11a Name:720x480 Refresh:60.000000 Width:720 Height:480
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.185401
14:42:53 T:139718301390912 INFO: ID:0x11b Name:720x480 Refresh:59.940060 Width:720 Height:480
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.185401
14:42:53 T:139718301390912 INFO: ID:0x11c Name:720x480i Refresh:30.001110 Width:720 Height:480
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.185401
14:42:53 T:139718301390912 INFO: ID:0x11d Name:720x480i Refresh:29.970030 Width:720 Height:480
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.185401
14:42:53 T:139718301390912 INFO: ID:0x11e Name:640x480 Refresh:60.000000 Width:640 Height:480
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.333577
14:42:53 T:139718301390912 INFO: ID:0x11f Name:640x480 Refresh:59.940479 Width:640 Height:480
14:42:53 T:139718301390912 INFO: Pixel Ratio: 1.333577
14:42:53 T:139718301390912 NOTICE: Checking resolution 16
14:42:53 T:139718301390912 DEBUG: Window Manager Name: Fluxbox
14:42:53 T:139718301390912 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib-x86_64-linux.so)
14:42:53 T:139718301390912 DEBUG: Loading: /usr/lib/kodi/system/ImageLib-x86_64-linux.so
14:42:53 T:139718301390912 NOTICE: Using visual 0x20
14:42:53 T:139718301390912 INFO: GL: Maximum texture width: 8192
14:42:53 T:139718301390912 DEBUG: GLX_EXTENSIONS: GLX_ARB_create_context GLX_ARB_create_context_profile GLX_ARB_create_context_robustness GLX_ARB_fbconfig_float GLX_ARB_framebuffer_sRGB GLX_ARB_get_proc_address GLX_ARB_multisample GLX_EXT_import_context GLX_EXT_visual_info GLX_EXT_visual_rating GLX_EXT_fbconfig_packed_float GLX_EXT_framebuffer_sRGB GLX_EXT_create_context_es2_profile GLX_EXT_create_context_es_profile GLX_MESA_copy_sub_buffer GLX_MESA_multithread_makecurrent GLX_MESA_query_renderer GLX_MESA_swap_control GLX_OML_swap_method GLX_OML_sync_control GLX_SGI_make_current_read GLX_SGI_swap_control GLX_SGI_video_sync GLX_SGIS_multisample GLX_SGIX_fbconfig GLX_SGIX_pbuffer GLX_SGIX_visual_select_group GLX_EXT_texture_from_pixmap GLX_INTEL_swap_event
14:42:53 T:139718301390912 NOTICE: GL_VENDOR = Intel Open Source Technology Center
14:42:53 T:139718301390912 NOTICE: GL_RENDERER = Mesa DRI Intel(R) HD Graphics (Cherryview)
14:42:53 T:139718301390912 NOTICE: GL_VERSION = 3.0 Mesa 11.2.0
14:42:53 T:139718301390912 NOTICE: GL_SHADING_LANGUAGE_VERSION = 1.30
14:42:53 T:139718301390912 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_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_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_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_copy_image GL_ARB_explicit_uniform_location GL_ARB_framebuffer_no_attachments GL_ARB_invalidate_subdata GL_ARB_program_interface_query 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_ARB_buffer_storage GL_ARB_clear_texture GL_ARB_multi_bind GL_ARB_seamless_cubemap_per_texture GL_ARB_shader_draw_parameters GL_ARB_texture_mirror_clamp_to_edge GL_ARB_vertex_type_10f_11f_11f_rev GL_EXT_shader_integer_mix GL_ARB_clip_control GL_ARB_conditional_render_inverted 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_EXT_polygon_offset_clamp GL_KHR_context_flush_control GL_ARB_shader_clock GL_EXT_shader_samples_identical
14:42:53 T:139718301390912 INFO: GL: Maximum texture width: 8192
14:42:53 T:139718301390912 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
14:42:53 T:139718301390912 INFO: load keymapping
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/appcommand.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/gamepad.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/joystick.Alienware.Dual.Compatible.Controller.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/joystick.AppleRemote.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/joystick.Harmony.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/joystick.Interact.AxisPad.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/joystick.Logitech.RumblePad.2.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.360.Controller.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.Controller.S.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/joystick.Nintendo.Wii.U.Pro.Controller.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/joystick.Ouya.Controller.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/joystick.PS3.Remote.Keyboard.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/joystick.PS4.Controller.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/joystick.Sony.PLAYSTATION(R)3.Controller.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/joystick.WiiRemote.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/keyboard.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/mouse.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/remote.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/keymaps/touchscreen.xml
14:42:53 T:139718301390912 INFO: Loading special://xbmc/system/Lircmap.xml
14:42:53 T:139718301390912 INFO: * Adding remote mapping for device 'mceusb'
14:42:53 T:139718301390912 INFO: * Adding remote mapping for device 'XboxDVDDongle'
14:42:53 T:139718301390912 INFO: * Adding remote mapping for device 'Microsoft_Xbox'
14:42:53 T:139718301390912 INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote'
14:42:53 T:139718301390912 INFO: * Adding remote mapping for device 'anysee'
14:42:53 T:139718301390912 INFO: * Adding remote mapping for device 'iMON-PAD'
14:42:53 T:139718301390912 INFO: * Adding remote mapping for device 'Antec_Veris_RM200'
14:42:53 T:139718301390912 INFO: * Adding remote mapping for device 'MCE_via_iMON'
14:42:53 T:139718301390912 INFO: * Adding remote mapping for device 'TwinHanRemote'
14:42:53 T:139718301390912 INFO: * Adding remote mapping for device 'linux-input-layer'
14:42:53 T:139718301390912 INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote'
14:42:53 T:139718301390912 INFO: * Adding remote mapping for device 'mediacenter'
14:42:53 T:139718301390912 INFO: * Adding remote mapping for device 'devinput'
14:42:53 T:139718301390912 DEBUG: CButtonTranslator::Load - no userdata Lircmap.xml found, skipping
14:42:53 T:139718301390912 INFO: GUI format 1920x1080, Display 1920x1080@ 60.00 - Full Screen
14:42:53 T:139718301390912 DEBUG: guilib: Fill viewport on change for solving rendering passes
14:42:53 T:139718301390912 INFO: CLangInfo: loading resource.language.en_gb language information...
14:42:53 T:139718301390912 DEBUG: trying to set locale to en_US.UTF-8
14:42:54 T:139718301390912 INFO: global locale set to C
14:42:54 T:139718301390912 INFO: CLangInfo: loading resource.language.en_gb language strings...
14:42:54 T:139718301390912 DEBUG: POParser: loaded 3535 strings from file resource://resource.language.en_gb/strings.po
14:42:54 T:139718301390912 DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid"
14:42:54 T:139718301390912 DEBUG: LoadMappings - loaded node "CEC Adapter"
14:42:54 T:139718301390912 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter"
14:42:54 T:139718301390912 DEBUG: LoadMappings - loaded node "iMON HID device"
14:42:54 T:139718301390912 DEBUG: CPeripheralBusUSB - initialised udev monitor
14:42:54 T:139718301390912 DEBUG: SECTION:LoadDLL(libcec.so.3.0)
14:42:54 T:139718301390912 DEBUG: Loading: libcec.so.3.0
14:42:54 T:139717967668992 DEBUG: Thread PeripBusCEC start, auto delete: false
14:42:54 T:139717944760064 DEBUG: Thread PeripBusUSBUdev start, auto delete: false
14:42:54 T:139718301390912 DEBUG: SECTION:LoadDLL(libcurl.so.4)
14:42:54 T:139718301390912 DEBUG: Loading: libcurl.so.4
14:42:54 T:139718301390912 NOTICE: Running database version Addons20
14:42:54 T:139718301390912 DEBUG: Initialize, updating databases...
14:42:54 T:139718301390912 NOTICE: Running database version ViewModes6
14:42:54 T:139718301390912 NOTICE: Running database version Textures13
14:42:54 T:139718301390912 NOTICE: Running database version MyMusic56
14:42:54 T:139718301390912 NOTICE: Running database version MyVideos99
14:42:54 T:139718301390912 NOTICE: Running database version TV29
14:42:54 T:139718301390912 NOTICE: Running database version Epg11
14:42:54 T:139718301390912 DEBUG: Initialize, updating databases... DONE
14:42:54 T:139718301390912 NOTICE: start dvd mediatype detection
14:42:54 T:139718239127296 DEBUG: Thread DetectDVDMedia start, auto delete: false
14:42:54 T:139718239127296 DEBUG: Compiled with libcdio Version 0.93
14:42:54 T:139718301390912 DEBUG: DPMS: supported power-saving modes: SUSPEND OFF STANDBY
14:42:54 T:139718239127296 DEBUG: Thread DetectDVDMedia 139718239127296 terminating
14:42:54 T:139718301390912 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
14:42:54 T:139718301390912 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
14:42:54 T:139718301390912 DEBUG: Activating window ID: 12997
14:42:54 T:139718301390912 DEBUG: ------ Window Init () ------
14:42:54 T:139718301390912 INFO: load splash image: /usr/share/kodi/media/Splash.png
14:42:54 T:139718301390912 INFO: Unloading old skin ...
14:42:54 T:139718301390912 INFO: load skin from: /usr/share/kodi/addons/skin.confluence (version: 2.8.8)
14:42:54 T:139718301390912 INFO: load fonts for skin...
14:42:54 T:139718301390912 INFO: Loading fonts from /usr/share/kodi/addons/skin.confluence/720p/Font.xml
14:42:54 T:139718301390912 DEBUG: POParser: loaded 147 strings from file /usr/share/kodi/addons/skin.confluence/language/resource.language.en_gb/strings.po
14:42:54 T:139718301390912 INFO: Loading skin includes from /usr/share/kodi/addons/skin.confluence/720p/includes.xml
14:42:54 T:139718301390912 INFO: load new skin...
14:42:54 T:139718301390912 INFO: Loading user windows, path /usr/share/kodi/addons/skin.confluence/720p
14:42:54 T:139718301390912 DEBUG: Load Skin XML: 5.63ms
14:42:54 T:139718301390912 INFO: initialize new skin...
14:42:54 T:139718301390912 DEBUG: guilib: Fill viewport on change for solving rendering passes
14:42:54 T:139718301390912 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT
14:42:54 T:139718301390912 DEBUG: OpenBundle - Opened bundle /usr/share/kodi/addons/skin.confluence/media/Textures.xbt
14:42:54 T:139718301390912 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT
14:42:54 T:139718301390912 INFO: Loading skin file: DialogKaiToast.xml, load type: LOAD_ON_GUI_INIT
14:42:54 T:139718301390912 INFO: Loading skin file: DialogMuteBug.xml, load type: LOAD_ON_GUI_INIT
14:42:54 T:139718301390912 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT
14:42:54 T:139718301390912 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
14:42:54 T:139718301390912 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT
14:42:54 T:139718301390912 INFO: Loading resource://resource.uisounds.confluence/sounds.xml
14:42:54 T:139718301390912 INFO: skin loaded...
14:42:54 T:139718301390912 DEBUG: Activating window ID: 12997
14:42:54 T:139718301390912 DEBUG: ------ Window Init () ------
14:42:54 T:139718301390912 INFO: load splash image: /usr/share/kodi/media/Splash.png
14:42:54 T:139718301390912 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting
14:42:54 T:139718301390912 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList"
14:42:54 T:139718301390912 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting")
14:42:54 T:139718301390912 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting
14:42:54 T:139718301390912 INFO: JSONRPC v6.32.5: Successfully initialized
14:42:54 T:139718301390912 DEBUG: ADDON: Starting service addons.
14:42:54 T:139718301390912 DEBUG: Activating window ID: 12999
14:42:54 T:139718301390912 DEBUG: ------ Window Init (Startup.xml) ------
14:42:54 T:139718301390912 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME
14:42:54 T:139718301390912 NOTICE: ActiveAE DSP - starting
14:42:54 T:139718301390912 INFO: removing tempfiles
14:42:54 T:139718301390912 DEBUG: ADDON: Starting service addons.
14:42:54 T:139717936367360 DEBUG: Thread LanguageInvoker start, auto delete: false
14:42:54 T:139717936367360 INFO: initializing python engine.
14:42:54 T:139718301390912 DEBUG: CRepositoryUpdater: previous update at 01/07/2017 2:29:39 PM, next at 01/08/2017 2:29:39 PM
14:42:54 T:139718301390912 NOTICE: initialize done
14:42:54 T:139718301390912 NOTICE: Running the application...
14:42:54 T:139718301390912 DEBUG: Activating window ID: 10000
14:42:54 T:139717927974656 DEBUG: Thread Timer start, auto delete: false
14:42:54 T:139717936367360 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): start processing
14:42:54 T:139718301390912 DEBUG: ------ Window Init () ------
14:42:54 T:139717936367360 DEBUG: -->Python Interpreter Initialized<--
14:42:54 T:139717936367360 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"
14:42:54 T:139717936367360 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
14:42:54 T:139717936367360 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): entering source directory /usr/share/kodi/addons/service.libreelec.settings
14:42:54 T:139717936367360 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
14:42:54 T:139718301390912 DEBUG: ------ Window Deinit (Startup.xml) ------
14:42:54 T:139718301390912 DEBUG: ------ Window Init (Home.xml) ------
14:42:54 T:139718301390912 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY
14:42:54 T:139717919581952 DEBUG: Thread JobWorker start, auto delete: true
14:42:54 T:139717919581952 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update
14:42:54 T:139718301390912 DEBUG: no profile autoexec.py (/storage/.kodi/userdata/autoexec.py) found, skipping
14:42:54 T:139718301390912 DEBUG: NetworkMessage - Starting network services
14:42:54 T:139718301390912 DEBUG: CZeroconfAvahi::clientCallback: client is up and running
14:42:54 T:139718301390912 NOTICE: starting zeroconf publishing
14:42:54 T:139718301390912 NOTICE: WebServer: Started the webserver
14:42:54 T:139718301390912 NOTICE: starting upnp client
14:42:54 T:139718301390912 DEBUG: GetFirstConnectedInterface no connected interface found - requery list
14:42:54 T:139717919581952 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.itrack, songartistview.iOrder
14:42:54 T:139717919581952 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 LEFT JOIN albumartistview ON albumview.idAlbum = albumartistview.idAlbum ORDER BY albumview.idAlbum desc, albumartistview.iOrder
14:42:54 T:139717919581952 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
14:42:54 T:139717693662976 DEBUG: Thread JobWorker start, auto delete: true
14:42:54 T:139717693662976 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:Kodi (LibreELEC) port:8080
14:42:54 T:139717693662976 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _http._tcp port:8080
14:42:54 T:139717693662976 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:Kodi (LibreELEC) port:8080
14:42:54 T:139717693662976 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _xbmc-jsonrpc-h._tcp port:8080
14:42:54 T:139717919581952 DEBUG: RunQuery took 0 ms for 0 items query: select * from movie_view ORDER BY dateAdded desc, idMovie desc LIMIT 10
14:42:54 T:139717919581952 DEBUG: RunQuery took 1 ms for 0 items query: select * from episode_view ORDER BY dateAdded desc, idEpisode desc LIMIT 10
14:42:54 T:139717919581952 DEBUG: RunQuery took 0 ms for 0 items query: select * from musicvideo_view ORDER BY dateAdded desc, idMVideo desc LIMIT 10
14:42:54 T:139717702055680 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
14:42:54 T:139717919581952 DEBUG: Previous line repeats 1 times.
14:42:54 T:139717919581952 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
14:42:54 T:139718301390912 INFO: JSONRPC Server: Successfully initialized
14:42:54 T:139718301390912 DEBUG: GetFirstConnectedInterface no connected interface found - requery list
14:42:54 T:139718301390912 DEBUG: SECTION:LoadDLL(libshairplay.so.0)
14:42:54 T:139718301390912 DEBUG: Loading: libshairplay.so.0
14:42:54 T:139717693662976 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:Kodi (LibreELEC) port:9090
14:42:54 T:139717693662976 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _xbmc-jsonrpc._tcp port:9090
14:42:54 T:139718301390912 DEBUG: GetFirstConnectedInterface no connected interface found - requery list
14:42:54 T:139718301390912 INFO: AIRPLAY: Cleaning up photoassetcache
14:42:54 T:139717341333248 DEBUG: Thread JobWorker start, auto delete: true
14:42:54 T:139717341333248 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airtunes type: _raop._tcp name:000102030405@Kodi (LibreELEC) port:36666
14:42:54 T:139718301390912 INFO: AIRPLAY Server: Successfully initialized
14:42:54 T:139717358118656 DEBUG: Thread TCPServer start, auto delete: false
14:42:54 T:139717366511360 DEBUG: Thread EventServer start, auto delete: false
14:42:54 T:139718301390912 DEBUG: GetFirstConnectedInterface no connected interface found - requery list
14:42:54 T:139717332940544 DEBUG: Thread AirPlayServer start, auto delete: false
14:42:54 T:139717702055680 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
14:42:54 T:139717366511360 NOTICE: ES: Starting UDP Event server on 127.0.0.1:9777
14:42:54 T:139717341333248 DEBUG: CZeroconfAvahi::addService() named: 000102030405@Kodi (LibreELEC) type: _raop._tcp port:36666
14:42:54 T:139717366511360 NOTICE: UDP: Listening on port 9777
14:42:54 T:139717919581952 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airplay type: _airplay._tcp name:Kodi (LibreELEC) port:36667
14:42:54 T:139717693662976 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:Kodi (LibreELEC) port:9777
14:42:54 T:139717702055680 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
14:42:54 T:139717919581952 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _airplay._tcp port:36667
14:42:54 T:139717693662976 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _xbmc-events._udp port:9777
14:42:54 T:139717702055680 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
14:42:54 T:139717936367360 DEBUG: Previous line repeats 1 times.
14:42:54 T:139717936367360 NOTICE: ## LibreELEC Addon ## 0.7.5
14:42:54 T:139717936367360 WARNING: CSkinInfo: failed to load skin settings
14:42:55 T:139718301390912 DEBUG: LogindUPowerSyscall - Received unknown signal NameAcquired
14:43:00 T:139718301390912 DEBUG: Keyboard: scancode: 0x71, sym: 0x0114, unicode: 0x0000, modifier: 0x0
14:43:00 T:139718301390912 DEBUG: OnKey: left (0xf082) pressed, action is Left
14:43:01 T:139718301390912 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
14:43:01 T:139718301390912 DEBUG: OnKey: down (0xf081) pressed, action is Down
14:43:02 T:139718301390912 DEBUG: Keyboard: scancode: 0x72, sym: 0x0113, unicode: 0x0000, modifier: 0x0
14:43:02 T:139718301390912 DEBUG: OnKey: right (0xf083) pressed, action is Right
14:43:02 T:139718301390912 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0
14:43:03 T:139718301390912 DEBUG: OnKey: return (0xf00d) pressed, action is Select
14:43:03 T:139718301390912 DEBUG: Activating window ID: 10025
14:43:03 T:139718301390912 DEBUG: ------ Window Deinit (Home.xml) ------
14:43:03 T:139718301390912 DEBUG: ------ Window Init (MyVideoNav.xml) ------
14:43:03 T:139718301390912 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY
14:43:03 T:139718301390912 DEBUG: CGUIMediaWindow::GetDirectory (addons://sources/video/)
14:43:03 T:139718301390912 DEBUG: ParentPath = [addons://sources/video/]
14:43:03 T:139717223900928 DEBUG: Thread BackgroundLoader start, auto delete: false
14:43:03 T:139717223900928 DEBUG: Thread BackgroundLoader 139717223900928 terminating
14:43:05 T:139718301390912 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
14:43:05 T:139718301390912 DEBUG: OnKey: down (0xf081) pressed, action is Down
14:43:05 T:139717693662976 DEBUG: Caching image '/storage/.kodi/addons/plugin.video.youtube/icon.png' to 'e/e3a9d01a.jpg':
14:43:05 T:139717693662976 DEBUG: cached image 'special://masterprofile/Thumbnails/e/e3a9d01a.jpg' size 256x256
14:43:05 T:139717341333248 DEBUG: Caching image '/storage/.kodi/addons/plugin.video.youtube/fanart.jpg' to 'c/c2981b84.jpg':
14:43:05 T:139717341333248 DEBUG: cached image 'special://masterprofile/Thumbnails/c/c2981b84.jpg' size 1280x720
14:43:06 T:139718301390912 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0
14:43:06 T:139718301390912 DEBUG: OnKey: return (0xf00d) pressed, action is Select
14:43:06 T:139718301390912 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.youtube/)
14:43:06 T:139718301390912 DEBUG: ParentPath = [addons://sources/video]
14:43:06 T:139717919581952 DEBUG: StartScript - calling plugin YouTube('plugin://plugin.video.youtube/','1','')
14:43:06 T:139717919581952 DEBUG: WaitOnScriptResult - waiting on the YouTube (id=1) plugin...
14:43:06 T:139717223900928 DEBUG: Thread LanguageInvoker start, auto delete: false
14:43:06 T:139717223900928 INFO: initializing python engine.
14:43:06 T:139717223900928 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.youtube/default.py): start processing
14:43:06 T:139717223900928 DEBUG: -->Python Interpreter Initialized<--
14:43:06 T:139717223900928 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.youtube/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.youtube/default.py"
14:43:06 T:139717223900928 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.youtube/default.py): setting the Python path to /storage/.kodi/addons/plugin.video.youtube:/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
14:43:06 T:139717223900928 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.youtube/default.py): entering source directory /storage/.kodi/addons/plugin.video.youtube
14:43:06 T:139717223900928 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.youtube/default.py): instantiating addon using automatically obtained id of "plugin.video.youtube" dependent on version 2.1.0 of the xbmc.python api
14:43:06 T:139717223900928 DEBUG: [plugin.video.youtube] Using API key set: 1
14:43:06 T:139717223900928 DEBUG: [plugin.video.youtube] Starting Kodion framework by bromix...
14:43:06 T:139717223900928 NOTICE: [plugin.video.youtube] Running: YouTube (5.3.6) on Jarvis (16.1) with Python 2.7.11
14:43:06 T:139717223900928 DEBUG: [plugin.video.youtube] Path: "/
14:43:06 T:139717223900928 DEBUG: [plugin.video.youtube] Params: "{}"
14:43:06 T:139717223900928 DEBUG: [plugin.video.youtube] Selecting YouTube config "All"
14:43:06 T:139717223900928 DEBUG: [plugin.video.youtube] User is not logged in
14:43:06 T:139717223900928 DEBUG: [plugin.video.youtube] Selecting YouTube config "All"
14:43:06 T:139717223900928 DEBUG: [plugin.video.youtube] User is not logged in
14:43:06 T:139717223900928 DEBUG: POParser: loaded 141 strings from file /storage/.kodi/addons/plugin.video.youtube/resources/language/English/strings.po
14:43:06 T:139717223900928 DEBUG: [plugin.video.youtube] Shutdown of Kodion
14:43:06 T:139717919581952 DEBUG: WaitOnScriptResult- plugin returned successfully
14:43:06 T:139717223900928 INFO: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.youtube/default.py): script successfully run
14:43:06 T:139717208639232 DEBUG: Thread BackgroundLoader start, auto delete: false
14:43:06 T:139717208639232 DEBUG: Thread BackgroundLoader 139717208639232 terminating
14:43:06 T:139717223900928 INFO: Python script stopped
14:43:06 T:139717223900928 DEBUG: Thread LanguageInvoker 139717223900928 terminating
14:43:08 T:139718301390912 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
14:43:08 T:139718301390912 DEBUG: OnKey: down (0xf081) pressed, action is Down
14:43:08 T:139718301390912 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
14:43:08 T:139718301390912 DEBUG: OnKey: down (0xf081) pressed, action is Down
14:43:08 T:139718301390912 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
14:43:08 T:139718301390912 DEBUG: OnKey: down (0xf081) pressed, action is Down
14:43:08 T:139717693662976 DEBUG: Caching image '/storage/.kodi/addons/plugin.video.youtube/resources/media/search.png' to '1/14179ba8.jpg':
14:43:08 T:139717693662976 DEBUG: cached image 'special://masterprofile/Thumbnails/1/14179ba8.jpg' size 256x256
14:43:09 T:139718301390912 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0
14:43:09 T:139718301390912 DEBUG: OnKey: up (0xf080) pressed, action is Up
14:43:13 T:139718301390912 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0
14:43:13 T:139718301390912 DEBUG: OnKey: return (0xf00d) pressed, action is Select
14:43:13 T:139718301390912 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.youtube/special/popular_right_now/)
14:43:13 T:139718301390912 DEBUG: ParentPath = [plugin://plugin.video.youtube/]
14:43:13 T:139717341333248 DEBUG: StartScript - calling plugin YouTube('plugin://plugin.video.youtube/special/popular_right_now/','2','')
14:43:13 T:139717341333248 DEBUG: WaitOnScriptResult - waiting on the YouTube (id=2) plugin...
14:43:13 T:139717223900928 DEBUG: Thread LanguageInvoker start, auto delete: false
14:43:13 T:139717223900928 INFO: initializing python engine.
14:43:13 T:139717223900928 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.youtube/default.py): start processing
14:43:13 T:139717223900928 DEBUG: -->Python Interpreter Initialized<--
14:43:13 T:139717223900928 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.youtube/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.youtube/default.py"
14:43:13 T:139717223900928 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.youtube/default.py): setting the Python path to /storage/.kodi/addons/plugin.video.youtube:/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
14:43:13 T:139717223900928 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.youtube/default.py): entering source directory /storage/.kodi/addons/plugin.video.youtube
14:43:13 T:139717223900928 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.youtube/default.py): instantiating addon using automatically obtained id of "plugin.video.youtube" dependent on version 2.1.0 of the xbmc.python api
14:43:13 T:139717223900928 DEBUG: [plugin.video.youtube] Using API key set: 1
14:43:13 T:139717223900928 DEBUG: [plugin.video.youtube] Starting Kodion framework by bromix...
14:43:13 T:139717223900928 NOTICE: [plugin.video.youtube] Running: YouTube (5.3.6) on Jarvis (16.1) with Python 2.7.11
14:43:13 T:139717223900928 DEBUG: [plugin.video.youtube] Path: "/special/popular_right_now/
14:43:13 T:139717223900928 DEBUG: [plugin.video.youtube] Params: "{}"
14:43:13 T:139717223900928 DEBUG: [plugin.video.youtube] Selecting YouTube config "All"
14:43:13 T:139717223900928 DEBUG: [plugin.video.youtube] User is not logged in
14:43:13 T:139717223900928 DEBUG: [plugin.video.youtube] Setting content-type: "videos" for "/special/popular_right_now/"
14:43:13 T:139717223900928 DEBUG: [plugin.video.youtube] Selecting YouTube config "All"
14:43:13 T:139717223900928 DEBUG: [plugin.video.youtube] User is not logged in
14:43:14 T:139718301390912 DEBUG: ------ Window Init (DialogBusy.xml) ------
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Selecting YouTube config "All"
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] User is not logged in
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video '9Rjz9DlQ5gw'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'd2TAPu2T-LU'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'VH60-R8MOKo'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'EOmRy7qcLZA'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'ppNYZq-hYTw'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'zeOKBklM_5s'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'o2EJ0sz9qX0'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'GzgOFhWJ29g'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'p17DJbPRLc0'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'PPyEjQLS85s'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'bCEPdlhmWow'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'xTGDrpr4jOA'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'NkUTGpegZN0'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video '0zW2NGgAPQQ'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'M2VvFXCR3II'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'pPHyNsBua_E'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'lUU8roJFSNg'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'uEJuoEs1UxY'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'P0LlVtlXEEA'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'RI8it5tUDuY'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'C6ATJIclkaU'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'l6f1_1vTzLk'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'r_cdHEU8Et8'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video '-F_8qaQ3DD0'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'pFlIqpFzjU4'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'pglMl92P-OA'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video '1SP0Cl_5L7k'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video '7Qp5vcuMIlk'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video '7cIkC7s3d2o'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 's8w2TbYhGtk'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'rI1KfI7oMJA'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'LUPZdti-bKc'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'Io5J8cFEeSg'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'Xq_33ze3hPk'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'govKYxJ4IxY'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'slbWLXIpCv8'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'rUKBZ3o0ltc'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'lBHqdKAlYq4'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video '6948o2zvUcg'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'nwpj9_hrK_A'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'E_SeMqLaL6o'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'oGa1brzAP6o'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'Ytb7J0ciBcE'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'MS00-mxtF70'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'S8a737LCBBI'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'UJFb8jDbWl0'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'l2l5sBLhUCY'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'chf5gj0HCqg'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'nM5eiunbDzQ'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video '2J5wTsYAh94'
14:43:14 T:139717223900928 DEBUG: POParser: loaded 141 strings from file /storage/.kodi/addons/plugin.video.youtube/resources/language/English/strings.po
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCy1JumjE9UMSoz1WGlfJSVQ'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCBi2mrWuNuyYy4gbM6fU18Q'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCLx8uTY2GZaYIv-cUAcNzwQ'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCP1iRaFlS5EYjJBryFV9JPw'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC22zQ9nBEk6KOjUWqR5XXZg'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCupvZG-5ko_eiXAupbDfxWw'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCKOLuamac8v0jhY9RID3syg'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCrZhVeobsmmsLJbkVK9rUMA'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCnGyCSPDOud1roNmhCbEdsw'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCajXeitgFL-rb5-gXI-aG8Q'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCF9imwPMSGz4Vq1NiTWCC7g'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC9j1JBJcMCMg40sZxcm9QDg'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC5jkXpfnBhlDjqh0ir5FsIQ'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCaXkIU1QidjPwiAYu6GcHjg'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCCxIjIp19PmZVBr7RdpBHTQ'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC-FQUIVQ-bZiefzBiQAa8Fw'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCv7YFWATebnJ1ty4cwMKgsQ'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCKZo4N0lVPccBkSiuyVh4yg'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCsooa4yRKGN_zEE8iknghZA'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UClFSU9_bUb4Rc6OYfTt5SPw'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCBJycsmduvYEL83R_U4JriQ'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC1-szPBG7Oh4icM1FcQakQg'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCaFGDBmGK_jw66u3av2Ysjw'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UClewyZDUM373scZY2fveeww'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCcHl3bzvpMh74okqhV5UPOw'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC7zOpx9wgvGBCDEjujnAPQA'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCDR8cvjALazMm2j9hOar8_g'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCa6vGFO9ty8v5KZJXQxdhaw'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC06E4Y_-ybJgBUMtXx8uNNw'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCo_IB5145EVNcf8hw1Kku7w'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCZC45sBWNdkqSQ9Bwtt5lfA'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC6ZFN9Tx6xh-skXCuRHCDpQ'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCWOA1ZGywLbqmigxE4Qlvuw'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCp0hYYBW6IMayGgR-WeoCvQ'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC5-gWZXAQqSGVfPHkA7NRiQ'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCo6DJdltbIub80bLiyJRv3w'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC9k-yiEpRHMNVOnOi_aQK8w'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCeH6qE4V7n5tVwP7NkdrtJg'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCshoKvlZGZ20rVgazZp5vnQ'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCMtFAi84ehTSYSE9XoHefig'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCMh30naOxjDTxd6Rigg6JjQ'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCk20cSRhH_ms_Yk1AZItFqA'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCUK0HBIBWgM2c4vsPhkYY4w'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCgyMPfJl7ynJRfE2jQ18rJw'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC0C-w0YjGpqDXGB8IHb662A'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCjPsvugkwOr9oOk8D7icstQ'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC_ciHdbUh6NR2yAAjb5XKfw'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC6E2mP01ZLH_kbAyeazCNdg'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCTHsQd-vRXK1bp4vpifl6yA'
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCVcoho9uaKUkDOYQxH5XNGA'
14:43:14 T:139717223900928 DEBUG: POParser: loaded 141 strings from file /storage/.kodi/addons/plugin.video.youtube/resources/language/English/strings.po
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Converting VideoItem
14:43:14 T:139717341333248 DEBUG: Previous line repeats 49 times.
14:43:14 T:139717341333248 DEBUG: WaitOnScriptResult- plugin returned successfully
14:43:14 T:139717223900928 DEBUG: [plugin.video.youtube] Shutdown of Kodion
14:43:14 T:139717223900928 INFO: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.youtube/default.py): script successfully run
14:43:14 T:139718301390912 DEBUG: RunQuery took 0 ms for 2 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
14:43:14 T:139717208639232 DEBUG: Thread BackgroundLoader start, auto delete: false
14:43:14 T:139717223900928 INFO: Python script stopped
14:43:14 T:139717223900928 DEBUG: Thread LanguageInvoker 139717223900928 terminating
14:43:14 T:139717208639232 DEBUG: Thread BackgroundLoader 139717208639232 terminating
14:43:14 T:139718301390912 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
14:43:17 T:139718301390912 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
14:43:17 T:139718301390912 DEBUG: OnKey: down (0xf081) pressed, action is Down
14:43:18 T:139718301390912 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
14:43:18 T:139718301390912 DEBUG: OnKey: down (0xf081) pressed, action is Down
14:43:18 T:139718301390912 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
14:43:18 T:139718301390912 DEBUG: OnKey: down (0xf081) pressed, action is Down
14:43:18 T:139718301390912 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
14:43:18 T:139718301390912 DEBUG: OnKey: down (0xf081) pressed, action is Down
14:43:18 T:139718301390912 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
14:43:18 T:139718301390912 DEBUG: OnKey: down (0xf081) pressed, action is Down
14:43:18 T:139718301390912 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
14:43:18 T:139718301390912 DEBUG: OnKey: down (0xf081) pressed, action is Down
14:43:18 T:139717919581952 INFO: easy_aquire - Created session to https://i.ytimg.com
14:43:19 T:139718301390912 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
14:43:19 T:139718301390912 DEBUG: OnKey: down (0xf081) pressed, action is Down
14:43:19 T:139717919581952 DEBUG: CCurlFile::GetMimeType - https://i.ytimg.com/vi/rUKBZ3o0ltc/hqdefault.jpg -> image/jpeg
14:43:19 T:139717919581952 DEBUG: CurlFile::Open(0x7f1288000910) https://i.ytimg.com/vi/rUKBZ3o0ltc/hqdefault.jpg
14:43:19 T:139718301390912 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
14:43:19 T:139718301390912 DEBUG: OnKey: down (0xf081) pressed, action is Down
14:43:19 T:139718301390912 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
14:43:19 T:139718301390912 DEBUG: OnKey: down (0xf081) pressed, action is Down
14:43:19 T:139717919581952 DEBUG: Caching image 'https://i.ytimg.com/vi/rUKBZ3o0ltc/hqdefault.jpg' to 'd/df0bfd33.jpg':
14:43:19 T:139717919581952 DEBUG: cached image 'special://masterprofile/Thumbnails/d/df0bfd33.jpg' size 480x360
14:43:19 T:139718301390912 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0
14:43:19 T:139718301390912 DEBUG: OnKey: down (0xf081) pressed, action is Down
14:43:20 T:139718301390912 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0
14:43:20 T:139718301390912 DEBUG: OnKey: return (0xf00d) pressed, action is Select
14:43:20 T:139718301390912 DEBUG: OnPlayMedia plugin://plugin.video.youtube/play/?video_id=pPHyNsBua_E
14:43:20 T:139718301390912 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc
14:43:20 T:139718301390912 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd
14:43:20 T:139718301390912 DEBUG: StartScript - calling plugin YouTube('plugin://plugin.video.youtube/play/','3','?video_id=pPHyNsBua_E')
14:43:20 T:139718301390912 DEBUG: WaitOnScriptResult - waiting on the YouTube (id=3) plugin...
14:43:20 T:139717208639232 DEBUG: Thread LanguageInvoker start, auto delete: false
14:43:20 T:139717208639232 INFO: initializing python engine.
14:43:20 T:139717208639232 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.youtube/default.py): start processing
14:43:20 T:139717208639232 DEBUG: -->Python Interpreter Initialized<--
14:43:20 T:139717208639232 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.youtube/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.youtube/default.py"
14:43:20 T:139717208639232 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.youtube/default.py): setting the Python path to /storage/.kodi/addons/plugin.video.youtube:/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
14:43:20 T:139717208639232 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.youtube/default.py): entering source directory /storage/.kodi/addons/plugin.video.youtube
14:43:20 T:139717208639232 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.youtube/default.py): instantiating addon using automatically obtained id of "plugin.video.youtube" dependent on version 2.1.0 of the xbmc.python api
14:43:20 T:139717208639232 DEBUG: [plugin.video.youtube] Using API key set: 1
14:43:20 T:139717208639232 DEBUG: [plugin.video.youtube] Starting Kodion framework by bromix...
14:43:20 T:139717208639232 NOTICE: [plugin.video.youtube] Running: YouTube (5.3.6) on Jarvis (16.1) with Python 2.7.11
14:43:20 T:139717208639232 DEBUG: [plugin.video.youtube] Path: "/play/
14:43:20 T:139717208639232 DEBUG: [plugin.video.youtube] Params: "{'video_id': u'pPHyNsBua_E'}"
14:43:20 T:139717208639232 DEBUG: [plugin.video.youtube] Selecting YouTube config "All"
14:43:20 T:139717208639232 DEBUG: [plugin.video.youtube] User is not logged in
14:43:21 T:139717208639232 DEBUG: [plugin.video.youtube] selectable streams: 5
14:43:21 T:139717208639232 DEBUG: [plugin.video.youtube] selectable stream: {'sort': [720, 0], 'meta': {'images': {'high': 'https://i.ytimg.com/vi/pPHyNsBua_E/hqdefault.jpg', 'default': 'https://i.ytimg.com/vi/pPHyNsBua_E/default.jpg', 'medium': 'https://i.ytimg.com/vi/pPHyNsBua_E/mqdefault.jpg', 'standard': 'https://i.ytimg.com/vi/pPHyNsBua_E/sddefault.jpg'}, 'video': {'id': 'pPHyNsBua_E', 'title': u"Watch first lady Michelle Obama's final White House speech"}, 'subtitles': [], 'channel': {'id': 'UC', 'author': u'PBS NewsHour'}}, 'video': {'encoding': 'h.264', 'height': 720}, 'title': '[B]720p[/B] (mp4;h.264 / aac@192)', 'url': 'https://r2---sn-uxap5nvoxg5-ixhe.googlevideo.com/videoplayback?itag=22&lmt=1483723678625776&id=o-ABvogQAMW8PuP03h6Tw0H9JXByeqVPT9EnpWPH23Sj8K&pl=16&mm=31&mn=sn-uxap5nvoxg5-ixhe&mime=video%2Fmp4&key=yt6&mt=1483800105&mv=m&sparams=dur%2Cid%2Cinitcwndbps%2Cip%2Cipbits%2Citag%2Clmt%2Cmime%2Cmm%2Cmn%2Cms%2Cmv%2Cpl%2Cratebypass%2Crequiressl%2Csource%2Cupn%2Cexpire&ip=188.238.154.181&requiressl=yes&ratebypass=yes&expire=1483821801&ipbits=0&dur=1285.387&signature=0E8986A48FD57CB3207F36C0534A5FB81857127C.B164A2B0216783B54D4DD3F31D60749CD4C9CC1D&ms=au&source=youtube&upn=lRw6nk9Bd88&initcwndbps=1352500', 'container': 'mp4', 'audio': {'bitrate': 192, 'encoding': 'aac'}}
14:43:21 T:139717208639232 DEBUG: [plugin.video.youtube] selectable stream: {'sort': [360, 0], 'meta': {'images': {'high': 'https://i.ytimg.com/vi/pPHyNsBua_E/hqdefault.jpg', 'default': 'https://i.ytimg.com/vi/pPHyNsBua_E/default.jpg', 'medium': 'https://i.ytimg.com/vi/pPHyNsBua_E/mqdefault.jpg', 'standard': 'https://i.ytimg.com/vi/pPHyNsBua_E/sddefault.jpg'}, 'video': {'id': 'pPHyNsBua_E', 'title': u"Watch first lady Michelle Obama's final White House speech"}, 'subtitles': [], 'channel': {'id': 'UC', 'author': u'PBS NewsHour'}}, 'video': {'encoding': 'h.264', 'height': 360}, 'title': '[B]360p[/B] (mp4;h.264 / aac@96)', 'url': 'https://r2---sn-uxap5nvoxg5-ixhe.googlevideo.com/videoplayback?itag=18&lmt=1483723560662386&id=o-ABvogQAMW8PuP03h6Tw0H9JXByeqVPT9EnpWPH23Sj8K&pl=16&mm=31&mn=sn-uxap5nvoxg5-ixhe&mime=video%2Fmp4&key=yt6&mt=1483800105&mv=m&sparams=dur%2Cid%2Cinitcwndbps%2Cip%2Cipbits%2Citag%2Clmt%2Cmime%2Cmm%2Cmn%2Cms%2Cmv%2Cpl%2Cratebypass%2Crequiressl%2Csource%2Cupn%2Cexpire&ip=188.238.154.181&requiressl=yes&ratebypass=yes&expire=1483821801&ipbits=0&dur=1285.387&signature=86D4DAE877B17CB70011D41A93C206C2F3F07C9B.55E9F57C0557FAFFCBA33BD9092C4A9C5AF0F1FE&ms=au&source=youtube&upn=lRw6nk9Bd88&initcwndbps=1352500', 'container': 'mp4', 'audio': {'bitrate': 96, 'encoding': 'aac'}}
14:43:21 T:139717208639232 DEBUG: [plugin.video.youtube] selectable stream: {'sort': [360, -1], 'meta': {'images': {'high': 'https://i.ytimg.com/vi/pPHyNsBua_E/hqdefault.jpg', 'default': 'https://i.ytimg.com/vi/pPHyNsBua_E/default.jpg', 'medium': 'https://i.ytimg.com/vi/pPHyNsBua_E/mqdefault.jpg', 'standard': 'https://i.ytimg.com/vi/pPHyNsBua_E/sddefault.jpg'}, 'video': {'id': 'pPHyNsBua_E', 'title': u"Watch first lady Michelle Obama's final White House speech"}, 'subtitles': [], 'channel': {'id': 'UC', 'author': u'PBS NewsHour'}}, 'video': {'encoding': 'vp8', 'height': 360}, 'title': '[B]360p[/B] (webm;vp8 / vorbis@128)', 'url': 'https://r2---sn-uxap5nvoxg5-ixhe.googlevideo.com/videoplayback?itag=43&lmt=1483729005742540&id=o-ABvogQAMW8PuP03h6Tw0H9JXByeqVPT9EnpWPH23Sj8K&pl=16&mm=31&mn=sn-uxap5nvoxg5-ixhe&mime=video%2Fwebm&key=yt6&mt=1483800105&mv=m&sparams=dur%2Cid%2Cinitcwndbps%2Cip%2Cipbits%2Citag%2Clmt%2Cmime%2Cmm%2Cmn%2Cms%2Cmv%2Cpl%2Cratebypass%2Crequiressl%2Csource%2Cupn%2Cexpire&ip=188.238.154.181&requiressl=yes&ratebypass=yes&expire=1483821801&ipbits=0&dur=0.000&signature=23AB9D64F4B508C7A40E9D3BB71730418E54AC46.74C1EA119B7EAF1A6ACE23A8EE4426870ED506A2&ms=au&source=youtube&upn=lRw6nk9Bd88&initcwndbps=1352500', 'container': 'webm', 'audio': {'bitrate': 128, 'encoding': 'vorbis'}}
14:43:21 T:139717208639232 DEBUG: [plugin.video.youtube] selectable stream: {'sort': [240, -20], 'meta': {'images': {'high': 'https://i.ytimg.com/vi/pPHyNsBua_E/hqdefault.jpg', 'default': 'https://i.ytimg.com/vi/pPHyNsBua_E/default.jpg', 'medium': 'https://i.ytimg.com/vi/pPHyNsBua_E/mqdefault.jpg', 'standard': 'https://i.ytimg.com/vi/pPHyNsBua_E/sddefault.jpg'}, 'video': {'id': 'pPHyNsBua_E', 'title': u"Watch first lady Michelle Obama's final White House speech"}, 'subtitles': [], 'channel': {'id': 'UC', 'author': u'PBS NewsHour'}}, 'video': {'encoding': 'mpeg-4', 'height': 240}, 'title': '[B]240p[/B] (3gp;mpeg-4 / aac@32)', 'url': 'https://r2---sn-uxap5nvoxg5-ixhe.googlevideo.com/videoplayback?itag=36&expire=1483821801&mt=1483800105&id=o-ABvogQAMW8PuP03h6Tw0H9JXByeqVPT9EnpWPH23Sj8K&sparams=dur%2Cid%2Cinitcwndbps%2Cip%2Cipbits%2Citag%2Clmt%2Cmime%2Cmm%2Cmn%2Cms%2Cmv%2Cpl%2Crequiressl%2Csource%2Cupn%2Cexpire&pl=16&ipbits=0&mm=31&mn=sn-uxap5nvoxg5-ixhe&dur=1285.456&key=yt6&mime=video%2F3gpp&signature=069B28929FD55BA7486066E0C41BFB0365C89B69.9C5EDA0C28A5E3F964FEE01797BC7D3CC30D977B&ms=au&source=youtube&upn=lRw6nk9Bd88&mv=m&initcwndbps=1352500&lmt=1483723552658442&ip=188.238.154.181&requiressl=yes', 'container': '3gp', 'audio': {'bitrate': 32, 'encoding': 'aac'}}
14:43:21 T:139717208639232 DEBUG: [plugin.video.youtube] selectable stream: {'sort': [144, -20], 'meta': {'images': {'high': 'https://i.ytimg.com/vi/pPHyNsBua_E/hqdefault.jpg', 'default': 'https://i.ytimg.com/vi/pPHyNsBua_E/default.jpg', 'medium': 'https://i.ytimg.com/vi/pPHyNsBua_E/mqdefault.jpg', 'standard': 'https://i.ytimg.com/vi/pPHyNsBua_E/sddefault.jpg'}, 'video': {'id': 'pPHyNsBua_E', 'title': u"Watch first lady Michelle Obama's final White House speech"}, 'subtitles': [], 'channel': {'id': 'UC', 'author': u'PBS NewsHour'}}, 'video': {'encoding': 'mpeg-4', 'height': 144}, 'title': '[B]144p[/B] (3gp;mpeg-4 / aac@24)', 'url': 'https://r2---sn-uxap5nvoxg5-ixhe.googlevideo.com/videoplayback?itag=17&expire=1483821801&mt=1483800105&id=o-ABvogQAMW8PuP03h6Tw0H9JXByeqVPT9EnpWPH23Sj8K&sparams=dur%2Cid%2Cinitcwndbps%2Cip%2Cipbits%2Citag%2Clmt%2Cmime%2Cmm%2Cmn%2Cms%2Cmv%2Cpl%2Crequiressl%2Csource%2Cupn%2Cexpire&pl=16&ipbits=0&mm=31&mn=sn-uxap5nvoxg5-ixhe&dur=1285.456&key=yt6&mime=video%2F3gpp&signature=27305A90FAD056654CEE10A2270A4571695DFC89.021599ECDBE0330FF598B4A5AA59194800DC083C&ms=au&source=youtube&upn=lRw6nk9Bd88&mv=m&initcwndbps=1352500&lmt=1483723549550192&ip=188.238.154.181&requiressl=yes', 'container': '3gp', 'audio': {'bitrate': 24, 'encoding': 'aac'}}
14:43:21 T:139717208639232 DEBUG: [plugin.video.youtube] selected stream: {'sort': [720, 0], 'meta': {'images': {'high': 'https://i.ytimg.com/vi/pPHyNsBua_E/hqdefault.jpg', 'default': 'https://i.ytimg.com/vi/pPHyNsBua_E/default.jpg', 'medium': 'https://i.ytimg.com/vi/pPHyNsBua_E/mqdefault.jpg', 'standard': 'https://i.ytimg.com/vi/pPHyNsBua_E/sddefault.jpg'}, 'video': {'id': 'pPHyNsBua_E', 'title': u"Watch first lady Michelle Obama's final White House speech"}, 'subtitles': [], 'channel': {'id': 'UC', 'author': u'PBS NewsHour'}}, 'video': {'encoding': 'h.264', 'height': 720}, 'title': '[B]720p[/B] (mp4;h.264 / aac@192)', 'url': 'https://r2---sn-uxap5nvoxg5-ixhe.googlevideo.com/videoplayback?itag=22&lmt=1483723678625776&id=o-ABvogQAMW8PuP03h6Tw0H9JXByeqVPT9EnpWPH23Sj8K&pl=16&mm=31&mn=sn-uxap5nvoxg5-ixhe&mime=video%2Fmp4&key=yt6&mt=1483800105&mv=m&sparams=dur%2Cid%2Cinitcwndbps%2Cip%2Cipbits%2Citag%2Clmt%2Cmime%2Cmm%2Cmn%2Cms%2Cmv%2Cpl%2Cratebypass%2Crequiressl%2Csource%2Cupn%2Cexpire&ip=188.238.154.181&requiressl=yes&ratebypass=yes&expire=1483821801&ipbits=0&dur=1285.387&signature=0E8986A48FD57CB3207F36C0534A5FB81857127C.B164A2B0216783B54D4DD3F31D60749CD4C9CC1D&ms=au&source=youtube&upn=lRw6nk9Bd88&initcwndbps=1352500', 'container': 'mp4', 'audio': {'bitrate': 192, 'encoding': 'aac'}}
14:43:21 T:139717208639232 DEBUG: [plugin.video.youtube] Selecting YouTube config "All"
14:43:21 T:139717208639232 DEBUG: [plugin.video.youtube] User is not logged in
14:43:21 T:139717208639232 DEBUG: [plugin.video.youtube] Found cached data for video 'pPHyNsBua_E'
14:43:21 T:139717208639232 DEBUG: POParser: loaded 141 strings from file /storage/.kodi/addons/plugin.video.youtube/resources/language/English/strings.po
14:43:21 T:139717208639232 DEBUG: [plugin.video.youtube] Converting VideoItem
14:43:21 T:139717208639232 DEBUG: [plugin.video.youtube] Shutdown of Kodion
14:43:21 T:139717208639232 INFO: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.youtube/default.py): script successfully run
14:43:21 T:139718301390912 DEBUG: WaitOnScriptResult- plugin returned successfully
14:43:21 T:139718301390912 INFO: easy_aquire - Created session to https://r2---sn-uxap5nvoxg5-ixhe.googlevideo.com
14:43:21 T:139717208639232 INFO: Python script stopped
14:43:21 T:139717208639232 DEBUG: Thread LanguageInvoker 139717208639232 terminating
14:43:21 T:139718301390912 DEBUG: CCurlFile::GetMimeType - https://r2---sn-uxap5nvoxg5-ixhe.googlevideo.com/videoplayback?itag=22&lmt=1483723678625776&id=o-ABvogQAMW8PuP03h6Tw0H9JXByeqVPT9EnpWPH23Sj8K&pl=16&mm=31&mn=sn-uxap5nvoxg5-ixhe&mime=video%2Fmp4&key=yt6&mt=1483800105&mv=m&sparams=dur%2Cid%2Cinitcwndbps%2Cip%2Cipbits%2Citag%2Clmt%2Cmime%2Cmm%2Cmn%2Cms%2Cmv%2Cpl%2Cratebypass%2Crequiressl%2Csource%2Cupn%2Cexpire&ip=188.238.154.181&requiressl=yes&ratebypass=yes&expire=1483821801&ipbits=0&dur=1285.387&signature=0E8986A48FD57CB3207F36C0534A5FB81857127C.B164A2B0216783B54D4DD3F31D60749CD4C9CC1D&ms=au&source=youtube&upn=lRw6nk9Bd88&initcwndbps=1352500 -> video/mp4
14:43:21 T:139718301390912 DEBUG: Loading settings for https://r2---sn-uxap5nvoxg5-ixhe.googlevideo.com/videoplayback?itag=22&lmt=1483723678625776&id=o-ABvogQAMW8PuP03h6Tw0H9JXByeqVPT9EnpWPH23Sj8K&pl=16&mm=31&mn=sn-uxap5nvoxg5-ixhe&mime=video%2Fmp4&key=yt6&mt=1483800105&mv=m&sparams=dur%2Cid%2Cinitcwndbps%2Cip%2Cipbits%2Citag%2Clmt%2Cmime%2Cmm%2Cmn%2Cms%2Cmv%2Cpl%2Cratebypass%2Crequiressl%2Csource%2Cupn%2Cexpire&ip=188.238.154.181&requiressl=yes&ratebypass=yes&expire=1483821801&ipbits=0&dur=1285.387&signature=0E8986A48FD57CB3207F36C0534A5FB81857127C.B164A2B0216783B54D4DD3F31D60749CD4C9CC1D&ms=au&source=youtube&upn=lRw6nk9Bd88&initcwndbps=1352500
14:43:21 T:139718301390912 DEBUG: CPlayerCoreFactory::GetPlayers(https://r2---sn-uxap5nvoxg5-ixhe.googlevideo.com/videoplayback?itag=22&lmt=1483723678625776&id=o-ABvogQAMW8PuP03h6Tw0H9JXByeqVPT9EnpWPH23Sj8K&pl=16&mm=31&mn=sn-uxap5nvoxg5-ixhe&mime=video%2Fmp4&key=yt6&mt=1483800105&mv=m&sparams=dur%2Cid%2Cinitcwndbps%2Cip%2Cipbits%2Citag%2Clmt%2Cmime%2Cmm%2Cmn%2Cms%2Cmv%2Cpl%2Cratebypass%2Crequiressl%2Csource%2Cupn%2Cexpire&ip=188.238.154.181&requiressl=yes&ratebypass=yes&expire=1483821801&ipbits=0&dur=1285.387&signature=0E8986A48FD57CB3207F36C0534A5FB81857127C.B164A2B0216783B54D4DD3F31D60749CD4C9CC1D&ms=au&source=youtube&upn=lRw6nk9Bd88&initcwndbps=1352500)
14:43:21 T:139718301390912 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
14:43:21 T:139718301390912 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
14:43:21 T:139718301390912 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp
14:43:21 T:139718301390912 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
14:43:21 T:139718301390912 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
14:43:21 T:139718301390912 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
14:43:21 T:139718301390912 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
14:43:21 T:139718301390912 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams
14:43:21 T:139718301390912 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp
14:43:21 T:139718301390912 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2
14:43:21 T:139718301390912 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
14:43:21 T:139718301390912 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
14:43:21 T:139718301390912 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
14:43:21 T:139718301390912 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
14:43:21 T:139718301390912 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
14:43:21 T:139718301390912 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
14:43:21 T:139718301390912 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
14:43:21 T:139718301390912 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
14:43:21 T:139718301390912 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
14:43:21 T:139718301390912 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
14:43:21 T:139718301390912 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
14:43:21 T:139718301390912 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData
14:43:21 T:139718301390912 NOTICE: DVDPlayer: Opening: https://r2---sn-uxap5nvoxg5-ixhe.googlevideo.com/videoplayback?itag=22&lmt=1483723678625776&id=o-ABvogQAMW8PuP03h6Tw0H9JXByeqVPT9EnpWPH23Sj8K&pl=16&mm=31&mn=sn-uxap5nvoxg5-ixhe&mime=video%2Fmp4&key=yt6&mt=1483800105&mv=m&sparams=dur%2Cid%2Cinitcwndbps%2Cip%2Cipbits%2Citag%2Clmt%2Cmime%2Cmm%2Cmn%2Cms%2Cmv%2Cpl%2Cratebypass%2Crequiressl%2Csource%2Cupn%2Cexpire&ip=188.238.154.181&requiressl=yes&ratebypass=yes&expire=1483821801&ipbits=0&dur=1285.387&signature=0E8986A48FD57CB3207F36C0534A5FB81857127C.B164A2B0216783B54D4DD3F31D60749CD4C9CC1D&ms=au&source=youtube&upn=lRw6nk9Bd88&initcwndbps=1352500
14:43:21 T:139718301390912 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
14:43:21 T:139718301390912 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
14:43:21 T:139718301390912 DEBUG: LinuxRendererGL: Cleaning up GL resources
14:43:21 T:139718301390912 DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16
14:43:21 T:139717223900928 DEBUG: Thread DVDPlayer start, auto delete: false
14:43:21 T:139717223900928 NOTICE: Creating InputStream
14:43:21 T:139717223900928 DEBUG: CCurlFile::GetMimeType - https://r2---sn-uxap5nvoxg5-ixhe.googlevideo.com/videoplayback?itag=22&lmt=1483723678625776&id=o-ABvogQAMW8PuP03h6Tw0H9JXByeqVPT9EnpWPH23Sj8K&pl=16&mm=31&mn=sn-uxap5nvoxg5-ixhe&mime=video%2Fmp4&key=yt6&mt=1483800105&mv=m&sparams=dur%2Cid%2Cinitcwndbps%2Cip%2Cipbits%2Citag%2Clmt%2Cmime%2Cmm%2Cmn%2Cms%2Cmv%2Cpl%2Cratebypass%2Crequiressl%2Csource%2Cupn%2Cexpire&ip=188.238.154.181&requiressl=yes&ratebypass=yes&expire=1483821801&ipbits=0&dur=1285.387&signature=0E8986A48FD57CB3207F36C0534A5FB81857127C.B164A2B0216783B54D4DD3F31D60749CD4C9CC1D&ms=au&source=youtube&upn=lRw6nk9Bd88&initcwndbps=1352500 -> video/mp4
14:43:21 T:139717223900928 DEBUG: CFileCache::Open - opening <videoplayback> using cache
14:43:21 T:139717223900928 DEBUG: CurlFile::Open(0x7f125032ed20) https://r2---sn-uxap5nvoxg5-ixhe.googlevideo.com/videoplayback?itag=22&lmt=1483723678625776&id=o-ABvogQAMW8PuP03h6Tw0H9JXByeqVPT9EnpWPH23Sj8K&pl=16&mm=31&mn=sn-uxap5nvoxg5-ixhe&mime=video%2Fmp4&key=yt6&mt=1483800105&mv=m&sparams=dur%2Cid%2Cinitcwndbps%2Cip%2Cipbits%2Citag%2Clmt%2Cmime%2Cmm%2Cmn%2Cms%2Cmv%2Cpl%2Cratebypass%2Crequiressl%2Csource%2Cupn%2Cexpire&ip=188.238.154.181&requiressl=yes&ratebypass=yes&expire=1483821801&ipbits=0&dur=1285.387&signature=0E8986A48FD57CB3207F36C0534A5FB81857127C.B164A2B0216783B54D4DD3F31D60749CD4C9CC1D&ms=au&source=youtube&upn=lRw6nk9Bd88&initcwndbps=1352500
14:43:22 T:139717208639232 DEBUG: Thread FileCache start, auto delete: false
14:43:22 T:139717223900928 NOTICE: Creating Demuxer
14:43:22 T:139717223900928 DEBUG: Open - probing detected format [mov,mp4,m4a,3gp,3g2,mj2]
14:43:22 T:139718301390912 DEBUG: ------ Window Init (DialogBusy.xml) ------
14:43:23 T:139717223900928 DEBUG: Open - avformat_find_stream_info starting
14:43:24 T:139717223900928 DEBUG: Open - av_find_stream_info finished
14:43:24 T:139717223900928 INFO: ffmpeg[7F12737FE700]: Input #0, mov,mp4,m4a,3gp,3g2,mj2, https://r2---sn-uxap5nvoxg5-ixhe.googlevideo.com/videoplayback?itag=22&lmt=1483723678625776&id=o-ABvogQAMW8PuP03h6Tw0H9JXByeqVPT9EnpWPH23Sj8K&pl=16&mm=31&mn=sn-uxap5nvoxg5-ixhe&mime=video%2Fmp4&key=yt6&mt=1483800105&mv=m&sparams=dur%2Cid%2Cinitcwndbps%2Cip%2Cipbits%2Citag%2Clmt%2Cmime%2Cmm%2Cmn%2Cms%2Cmv%2Cpl%2Cratebypass%2Crequiressl%2Csource%2Cupn%2Cexpire&ip=188.238.154.181&requiressl=yes&ratebypass=yes&expire=1483821801&ipbits=0&dur=1285.387&signature=0E8986A48FD57CB3207F36C0534A5FB81857127C.B164A2B0216783B54D4DD3F31D60749CD4C9CC1D&ms=au&source=youtube&upn=lRw6nk9Bd88&initcwndbps=135250':
14:43:24 T:139717223900928 INFO: ffmpeg[7F12737FE700]: Metadata:
14:43:24 T:139717223900928 INFO: ffmpeg[7F12737FE700]: major_brand : mp42
14:43:24 T:139717223900928 INFO: ffmpeg[7F12737FE700]: minor_version : 0
14:43:24 T:139717223900928 INFO: ffmpeg[7F12737FE700]: compatible_brands: isommp42
14:43:24 T:139717223900928 INFO: ffmpeg[7F12737FE700]: creation_time : 2017-01-06 17:26:52
14:43:24 T:139717223900928 INFO: ffmpeg[7F12737FE700]: Duration: 00:21:25.29, start: 0.000000, bitrate: 1572 kb/s
14:43:24 T:139717223900928 INFO: ffmpeg[7F12737FE700]: Stream #0:0(und): Video: h264 (Main) (avc1 / 0x31637661), yuv420p(tv, bt709), 1280x720 [SAR 1:1 DAR 16:9], 1441 kb/s, 29.88 fps, 29.92 tbr, 90k tbn, 59.75 tbc (default)
14:43:24 T:139717223900928 INFO: ffmpeg[7F12737FE700]: Metadata:
14:43:24 T:139717223900928 INFO: ffmpeg[7F12737FE700]: creation_time : 2017-01-06 17:26:52
14:43:24 T:139717223900928 INFO: ffmpeg[7F12737FE700]: handler_name : ISO Media file produced by Google Inc.
14:43:24 T:139717223900928 INFO: ffmpeg[7F12737FE700]: Stream #0:1(und): Audio: aac (LC) (mp4a / 0x6134706D), 44100 Hz, stereo, fltp, 125 kb/s (default)
14:43:24 T:139717223900928 INFO: ffmpeg[7F12737FE700]: Metadata:
14:43:24 T:139717223900928 INFO: ffmpeg[7F12737FE700]: creation_time : 2017-01-06 17:26:52
14:43:24 T:139717223900928 INFO: ffmpeg[7F12737FE700]: handler_name : ISO Media file produced by Google Inc.
14:43:24 T:139717223900928 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0
14:43:24 T:139717223900928 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1
14:43:24 T:139717223900928 DEBUG: CDVDInputStreamFile::SetReadRate - set cache throttle rate to 327690 bytes per second
14:43:24 T:139717223900928 NOTICE: Opening stream: 0 source: 256
14:43:24 T:139717223900928 NOTICE: Creating video codec with codec id: 28
14:43:24 T:139717223900928 DEBUG: CDVDFactoryCodec: compiled in hardware support: AMCodec:no MediaCodec:no OpenMax:no libstagefright:no VDPAU:yes VAAPI:yes iMXVPU:no MMAL:no
14:43:24 T:139717223900928 DEBUG: FactoryCodec - Video: - Opening
14:43:24 T:139717223900928 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
14:43:24 T:139717223900928 DEBUG: FactoryCodec - Video: ff-h264 - Opened
14:43:24 T:139717223900928 NOTICE: Creating video thread
14:43:24 T:139717223900928 NOTICE: Opening stream: 1 source: 256
14:43:24 T:139717223900928 NOTICE: Finding audio codec for: 86018
14:43:24 T:139717223900928 DEBUG: FactoryCodec - Audio: passthrough - Opening
14:43:24 T:139717223900928 DEBUG: FactoryCodec - Audio: passthrough - Failed
14:43:24 T:139717223900928 DEBUG: FactoryCodec - Audio: FFmpeg - Opening
14:43:24 T:139717199984384 DEBUG: Thread DVDPlayerVideo start, auto delete: false
14:43:24 T:139717199984384 NOTICE: running thread: video_thread
14:43:24 T:139717223900928 DEBUG: FactoryCodec - Audio: FFmpeg - Opened
14:43:24 T:139717223900928 NOTICE: Creating audio thread
14:43:24 T:139717199984384 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
14:43:24 T:139717191591680 DEBUG: Thread DVDPlayerAudio start, auto delete: false
14:43:24 T:139717191591680 NOTICE: running thread: CDVDPlayerAudio::Process()
14:43:24 T:139717191591680 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
14:43:24 T:139717223900928 DEBUG: OnPlayBackStarted: play state was 1, starting 1
14:43:24 T:139717223900928 DEBUG: CDVDPlayer::SetCaching - caching state 1
14:43:24 T:139717223900928 DEBUG: CDVDPlayer::SetCaching - caching state 3
14:43:24 T:139717199984384 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(0.000000, 1)
14:43:24 T:139717199984384 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
14:43:24 T:139717199984384 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
14:43:24 T:139717223900928 DEBUG: CDVDPlayer::CheckContinuity - wrapback :2, prev:100422.222222, curr:33477.777778, diff:-66944.444444
14:43:24 T:139717199984384 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating VDPAU(1280x720)
14:43:24 T:139717199984384 NOTICE: VDPAU::Open: required extension GL_NV_vdpau_interop not found
14:43:24 T:139717199984384 NOTICE: (VDPAU) Close
14:43:24 T:139717191591680 NOTICE: Creating audio stream (codec id: 86018, channels: 2, sample rate: 44100, no pass-through)
14:43:24 T:139717191591680 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback
14:43:24 T:139717191591680 NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 23
14:43:24 T:139718282454784 INFO: CActiveAESink::OpenSink - initialize sink
14:43:24 T:139717199984384 DEBUG: VAAPI - open decoder
14:43:24 T:139717199984384 DEBUG: VAAPI - initialize version 0.39
14:43:24 T:139717199984384 DEBUG: VAAPI - driver in use: Intel i965 driver for Intel(R) CherryView - 1.7.0
14:43:24 T:139717199984384 DEBUG: VAAPI - attrib 0 (get/set) min -100 max 100 value 0x0
14:43:24 T:139717199984384 DEBUG: VAAPI - attrib 1 (get/set) min 0 max 100 value 0x32
14:43:24 T:139717199984384 DEBUG: VAAPI - attrib 2 (get/set) min -180 max 180 value 0x0
14:43:24 T:139717199984384 DEBUG: VAAPI - attrib 3 (get/set) min 0 max 100 value 0x32
14:43:24 T:139717199984384 DEBUG: VAAPI - attrib 6 (get/set) min 0 max 3 value 0x0
14:43:24 T:139717199984384 DEBUG: VAAPI - profile 0
14:43:24 T:139717199984384 DEBUG: VAAPI - profile 1
14:43:24 T:139717199984384 DEBUG: VAAPI - profile 13
14:43:24 T:139717199984384 DEBUG: VAAPI - profile 6
14:43:24 T:139717199984384 DEBUG: VAAPI - profile 7
14:43:24 T:139717199984384 DEBUG: VAAPI - profile 15
14:43:24 T:139717199984384 DEBUG: VAAPI - profile 16
14:43:24 T:139717199984384 DEBUG: VAAPI - profile 8
14:43:24 T:139717199984384 DEBUG: VAAPI - profile 9
14:43:24 T:139717199984384 DEBUG: VAAPI - profile 10
14:43:24 T:139717199984384 DEBUG: VAAPI - profile -1
14:43:24 T:139717199984384 DEBUG: VAAPI - profile 12
14:43:24 T:139717199984384 DEBUG: VAAPI - profile 14
14:43:24 T:139717199984384 DEBUG: VAAPI - profile 17
14:43:24 T:139718301390912 DEBUG: PlayFile: OpenFile succeed, play state 2
14:43:24 T:139718301390912 DEBUG: OnPlayBackStarted: play state was 2, starting 0
14:43:24 T:139717183198976 DEBUG: Thread Vaapi-Output start, auto delete: false
14:43:24 T:139717183198976 NOTICE: COutput::OnStartup: Output Thread created
14:43:24 T:139717183198976 DEBUG: VAAPI::COutput::CreateGlxContext - created context
14:43:24 T:139717183198976 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libsse4-x86_64-linux.so)
14:43:24 T:139717183198976 DEBUG: Loading: /usr/lib/kodi/system/libsse4-x86_64-linux.so
14:43:24 T:139717183198976 DEBUG: VAAPI::COutput::InitBufferPool - Surfaces created
14:43:24 T:139717199984384 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
14:43:24 T:139717199984384 DEBUG: Previous line repeats 10 times.
14:43:24 T:139717199984384 NOTICE: fps: 29.916667, pwidth: 1280, pheight: 720, dwidth: 1280, dheight: 720
14:43:24 T:139717199984384 DEBUG: OutputPicture - change configuration. 1280x720. framerate: 29.92. format: VAAPI
14:43:24 T:139717199984384 NOTICE: Display resolution DESKTOP : 1920x1080@ 60.00 - Full Screen (16)
14:43:24 T:139717199984384 DEBUG: CXBMCRenderManager::Configure - 4
14:43:24 T:139718301390912 DEBUG: CGUIInfoManager::SetCurrentMovie(https://r2---sn-uxap5nvoxg5-ixhe.googlevideo.com/videoplayback?itag=22&lmt=1483723678625776&id=o-ABvogQAMW8PuP03h6Tw0H9JXByeqVPT9EnpWPH23Sj8K&pl=16&mm=31&mn=sn-uxap5nvoxg5-ixhe&mime=video%2Fmp4&key=yt6&mt=1483800105&mv=m&sparams=dur%2Cid%2Cinitcwndbps%2Cip%2Cipbits%2Citag%2Clmt%2Cmime%2Cmm%2Cmn%2Cms%2Cmv%2Cpl%2Cratebypass%2Crequiressl%2Csource%2Cupn%2Cexpire&ip=188.238.154.181&requiressl=yes&ratebypass=yes&expire=1483821801&ipbits=0&dur=1285.387&signature=0E8986A48FD57CB3207F36C0534A5FB81857127C.B164A2B0216783B54D4DD3F31D60749CD4C9CC1D&ms=au&source=youtube&upn=lRw6nk9Bd88&initcwndbps=1352500)
14:43:24 T:139718301390912 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
14:43:24 T:139718301390912 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
14:43:24 T:139718301390912 DEBUG: Activating window ID: 12005
14:43:24 T:139718301390912 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
14:43:24 T:139718301390912 DEBUG: ------ Window Init (VideoFullScreen.xml) ------
14:43:24 T:139718301390912 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY
14:43:24 T:139718301390912 NOTICE: Using GL_TEXTURE_2D
14:43:24 T:139718301390912 NOTICE: GL: Using VAAPI render method
14:43:24 T:139718301390912 NOTICE: GL: NPOT texture support detected
14:43:24 T:139718301390912 NOTICE: GL: Using GL_ARB_pixel_buffer_object
14:43:24 T:139717199984384 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1
14:43:24 T:139717223900928 DEBUG: CDVDPlayer::HandleMessages - player started 2
14:43:24 T:139717199984384 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1
14:43:24 T:139718301390912 DEBUG: GL: Vertex Shader compilation log:
14:43:24 T:139718301390912 DEBUG: GL: Vertex Shader compiled successfully
14:43:24 T:139718301390912 DEBUG: GL: Pixel Shader compilation log:
14:43:24 T:139718301390912 DEBUG: GL: Fragment Shader compiled successfully
14:43:24 T:139718282454784 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:@
14:43:24 T:139718282454784 INFO: CAESinkALSA::Initialize - Attempting to open device "@"
14:43:24 T:139718282454784 INFO: CAESinkALSA::Initialize - Opened device "sysdefault"
14:43:24 T:139718282454784 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
14:43:24 T:139718282454784 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
14:43:24 T:139718282454784 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 1024, bufferSize 9600
14:43:24 T:139718282454784 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 1024, bufferSize 9216
14:43:24 T:139718282454784 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 192 ms
14:43:24 T:139718282454784 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
14:43:24 T:139718282454784 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
14:43:24 T:139718282454784 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR)
14:43:24 T:139718282454784 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
14:43:24 T:139718282454784 DEBUG: Output Device : Default (HDA Intel PCH ALC283 Analog)
14:43:24 T:139718282454784 DEBUG: Sample Rate : 48000
14:43:24 T:139718282454784 DEBUG: Sample Format : AE_FMT_S32NE
14:43:24 T:139718282454784 DEBUG: Channel Count : 2
14:43:24 T:139718282454784 DEBUG: Channel Layout: FL,FR
14:43:24 T:139718282454784 DEBUG: Frames : 1024
14:43:24 T:139718282454784 DEBUG: Frame Samples : 2048
14:43:24 T:139718282454784 DEBUG: Frame Size : 8
14:43:24 T:139718290847488 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
14:43:24 T:139717223900928 DEBUG: CDVDPlayer::HandleMessages - player started 1
14:43:24 T:139717223900928 DEBUG: CDVDPlayer::SetCaching - caching state 0
14:43:24 T:139717199984384 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
14:43:24 T:139717191591680 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_DELAY(23219.954649)
14:43:24 T:139717199984384 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
14:43:24 T:139717199984384 DEBUG: Previous line repeats 1 times.
14:43:24 T:139717199984384 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1
14:43:24 T:139718301390912 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
14:43:24 T:139717191591680 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(23219.954649, 1)
14:43:24 T:139717191591680 DEBUG: CDVDPlayerAudio::HandleSyncError - average error -6004.085495 below threshold of 50000.000000
14:43:25 T:139717191591680 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:955603.764827, should be:932998.598006, error:-22605.166820
14:43:28 T:139717199984384 DEBUG: CPullupCorrection: detected pattern of length 1: 33472.78, frameduration: 33472.783333
14:43:49 T:139717919581952 DEBUG: Thread JobWorker 139717919581952 terminating (autodelete)
14:43:49 T:139717693662976 DEBUG: Thread JobWorker 139717693662976 terminating (autodelete)
14:43:49 T:139717341333248 DEBUG: Thread JobWorker 139717341333248 terminating (autodelete)
14:43:50 T:139718301390912 INFO: CheckIdle - Closing session to https://i.ytimg.com (easy=0x7f1288162260, multi=0x7f1288192bc0)
14:43:54 T:139717191591680 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
14:43:55 T:139717199984384 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
14:43:55 T:139717199984384 INFO: CDVDPlayerVideo - Stillframe detected, switching to forced 29.916667 fps
14:43:55 T:139717199984384 DEBUG: CPullupCorrection: pattern lost on diff 167130.919220, number of losses 1
14:43:57 T:139717223900928 DEBUG: CDVDPlayer::SetCaching - caching state 1
14:43:57 T:139717223900928 DEBUG: CDVDPlayer::HandleMessages - player started 1
14:43:57 T:139718301390912 DEBUG: ------ Window Init (DialogSeekBar.xml) ------
14:44:07 T:139717223900928 ERROR: ffmpeg[7F12737FE700]: [mov,mp4,m4a,3gp,3g2,mj2] stream 0, offset 0x8d0817: partial file
14:44:07 T:139717223900928 DEBUG: CDVDPlayer::SetCaching - caching state 0
14:44:07 T:139717199984384 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
14:44:07 T:139717191591680 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_EOF
14:44:07 T:139717199984384 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
14:44:07 T:139717199984384 ERROR: ffmpeg[7F127212F700]: [h264] AVC: nal size 826
14:44:07 T:139717199984384 ERROR: ffmpeg[7F127212F700]: [h264] no frame!
14:44:07 T:139717199984384 ERROR: Decode - avcodec_decode_video returned failure
14:44:07 T:139717199984384 DEBUG: CDVDPlayerVideo - video decoder returned error
14:44:07 T:139717223900928 DEBUG: CDVDPlayer::HandleMessages - player started 2
14:44:07 T:139718301390912 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
14:44:07 T:139717199984384 INFO: CDVDPlayerVideo - Stillframe detected, switching to forced 29.916667 fps
14:44:11 T:139717199984384 DEBUG: CPullupCorrection: detected pattern of length 1: 33426.18, frameduration: 33426.183844
14:44:17 T:139717223900928 ERROR: ffmpeg[7F12737FE700]: [mov,mp4,m4a,3gp,3g2,mj2] stream 0, offset 0x8d083b: partial file
14:44:17 T:139717223900928 NOTICE: CDVDPlayer::OnExit()
14:44:17 T:139717223900928 NOTICE: DVDPlayer: eof, waiting for queues to empty
14:44:17 T:139717223900928 NOTICE: Closing stream player 1
14:44:17 T:139717223900928 NOTICE: CDVDMessageQueue(audio)::WaitUntilEmpty
14:44:17 T:139717191591680 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
14:44:17 T:139717223900928 NOTICE: Waiting for audio thread to exit
14:44:17 T:139717191591680 DEBUG: CDVDPlayerAudio::Process - Abort received, exiting thread
14:44:17 T:139717191591680 NOTICE: thread end: CDVDPlayerAudio::OnExit()
14:44:17 T:139717191591680 DEBUG: Thread DVDPlayerAudio 139717191591680 terminating
14:44:17 T:139717223900928 NOTICE: Closing audio device
14:44:17 T:139717223900928 NOTICE: Deleting audio codec
14:44:17 T:139718290847488 DEBUG: CActiveAE::DiscardStream - audio stream deleted
14:44:17 T:139718290847488 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
14:44:17 T:139717223900928 NOTICE: Closing stream player 2
14:44:17 T:139717223900928 NOTICE: CDVDMessageQueue(video)::WaitUntilEmpty
14:44:17 T:139717199984384 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
14:44:17 T:139717199984384 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true
14:44:17 T:139717199984384 NOTICE: thread end: video_thread
14:44:17 T:139717199984384 DEBUG: Thread DVDPlayerVideo 139717199984384 terminating
14:44:17 T:139717223900928 NOTICE: waiting for video thread to exit
14:44:17 T:139717223900928 NOTICE: deleting video codec
14:44:17 T:139717223900928 DEBUG: VAAPI::Release pre-cleanup
14:44:17 T:139718290847488 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
14:44:17 T:139718282454784 INFO: CActiveAESink::OpenSink - initialize sink
14:44:17 T:139718282454784 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:@
14:44:17 T:139718282454784 INFO: CAESinkALSA::Initialize - Attempting to open device "@"
14:44:17 T:139718282454784 INFO: CAESinkALSA::Initialize - Opened device "sysdefault"
14:44:17 T:139718282454784 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
14:44:17 T:139718282454784 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
14:44:17 T:139718282454784 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 1024, bufferSize 9600
14:44:17 T:139718282454784 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 1024, bufferSize 9216
14:44:17 T:139718282454784 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 192 ms
14:44:17 T:139718282454784 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
14:44:17 T:139718282454784 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
14:44:17 T:139718282454784 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR)
14:44:17 T:139718282454784 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
14:44:17 T:139718282454784 DEBUG: Output Device : Default (HDA Intel PCH ALC283 Analog)
14:44:17 T:139718282454784 DEBUG: Sample Rate : 48000
14:44:17 T:139718282454784 DEBUG: Sample Format : AE_FMT_S32NE
14:44:17 T:139718282454784 DEBUG: Channel Count : 2
14:44:17 T:139718282454784 DEBUG: Channel Layout: FL,FR
14:44:17 T:139718282454784 DEBUG: Frames : 1024
14:44:17 T:139718282454784 DEBUG: Frame Samples : 2048
14:44:17 T:139718282454784 DEBUG: Frame Size : 8
14:44:27 T:139717183198976 WARNING: COutput::StateMachine - signal: 3 form port: timer not handled for state: 2
14:44:52 T:139717208639232 WARNING: Previous line repeats 2 times.
14:44:52 T:139717208639232 ERROR: CCurlFile::FillBuffer - Failed: Timeout was reached(28)
14:44:52 T:139717208639232 NOTICE: CCurlFile::FillBuffer - Reconnect, (re)try 1
14:44:57 T:139717183198976 WARNING: COutput::StateMachine - signal: 3 form port: timer not handled for state: 2
14:44:58 T:139717208639232 DEBUG: Thread FileCache 139717208639232 terminating
14:44:58 T:139717223900928 DEBUG: OnPlayBackEnded: play state was 2, starting 0
14:44:58 T:139717223900928 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
14:44:58 T:139717223900928 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
14:44:58 T:139717223900928 DEBUG: Thread DVDPlayer 139717223900928 terminating
14:44:58 T:139718301390912 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
14:44:58 T:139718301390912 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------
14:44:58 T:139718301390912 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
14:44:58 T:139718301390912 DEBUG: ------ Window Init (MyVideoNav.xml) ------
14:44:58 T:139718301390912 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.youtube/special/popular_right_now/)
14:44:58 T:139718301390912 DEBUG: ParentPath = [plugin://plugin.video.youtube/special/popular_right_now/]
14:44:58 T:139718301390912 DEBUG: StartScript - calling plugin YouTube('plugin://plugin.video.youtube/special/popular_right_now/','4','')
14:44:58 T:139718301390912 DEBUG: WaitOnScriptResult - waiting on the YouTube (id=4) plugin...
14:44:58 T:139717223900928 DEBUG: Thread LanguageInvoker start, auto delete: false
14:44:58 T:139717223900928 INFO: initializing python engine.
14:44:58 T:139717223900928 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.youtube/default.py): start processing
14:44:58 T:139717223900928 DEBUG: -->Python Interpreter Initialized<--
14:44:58 T:139717223900928 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.youtube/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.youtube/default.py"
14:44:58 T:139717223900928 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.youtube/default.py): setting the Python path to /storage/.kodi/addons/plugin.video.youtube:/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
14:44:58 T:139717223900928 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.youtube/default.py): entering source directory /storage/.kodi/addons/plugin.video.youtube
14:44:58 T:139717223900928 DEBUG: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.youtube/default.py): instantiating addon using automatically obtained id of "plugin.video.youtube" dependent on version 2.1.0 of the xbmc.python api
14:44:58 T:139718301390912 NOTICE: CDVDPlayer::CloseFile()
14:44:58 T:139718301390912 NOTICE: DVDPlayer: waiting for threads to exit
14:44:58 T:139718301390912 NOTICE: DVDPlayer: finished waiting
14:44:58 T:139718301390912 DEBUG: LinuxRendererGL: Cleaning up GL resources
14:44:58 T:139718301390912 NOTICE: VAAPI::Close
14:44:58 T:139717183198976 NOTICE: COutput::OnExit: Output Thread terminated
14:44:58 T:139717183198976 DEBUG: Thread Vaapi-Output 139717183198976 terminating
14:44:58 T:139718301390912 DEBUG: VAAPI::FiniVAAPIOutput destroying 0 video surfaces
14:44:58 T:139718301390912 NOTICE: VAAPI::Close - closing decoder context
14:44:58 T:139718301390912 NOTICE: CDVDPlayer::CloseFile()
14:44:58 T:139718301390912 NOTICE: DVDPlayer: waiting for threads to exit
14:44:58 T:139718301390912 NOTICE: DVDPlayer: finished waiting
14:44:58 T:139718301390912 DEBUG: LinuxRendererGL: Cleaning up GL resources
14:44:58 T:139718301390912 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Using API key set: 1
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Starting Kodion framework by bromix...
14:44:58 T:139718301390912 ERROR: Control 50 in window 10025 has been asked to focus, but it can't
14:44:58 T:139717223900928 NOTICE: [plugin.video.youtube] Running: YouTube (5.3.6) on Jarvis (16.1) with Python 2.7.11
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Path: "/special/popular_right_now/
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Params: "{}"
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Selecting YouTube config "All"
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] User is not logged in
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Setting content-type: "videos" for "/special/popular_right_now/"
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Selecting YouTube config "All"
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] User is not logged in
14:44:58 T:139718301390912 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/ImageLib-x86_64-linux.so)
14:44:58 T:139717183198976 DEBUG: Thread JobWorker start, auto delete: true
14:44:58 T:139717183198976 DEBUG: DoWork - Saving file state for video item plugin://plugin.video.youtube/play/?video_id=pPHyNsBua_E
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Selecting YouTube config "All"
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] User is not logged in
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video '9Rjz9DlQ5gw'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'd2TAPu2T-LU'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'VH60-R8MOKo'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'EOmRy7qcLZA'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'ppNYZq-hYTw'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'zeOKBklM_5s'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'o2EJ0sz9qX0'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'GzgOFhWJ29g'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'p17DJbPRLc0'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'PPyEjQLS85s'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'bCEPdlhmWow'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'xTGDrpr4jOA'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'NkUTGpegZN0'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video '0zW2NGgAPQQ'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'M2VvFXCR3II'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'pPHyNsBua_E'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'lUU8roJFSNg'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'uEJuoEs1UxY'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'P0LlVtlXEEA'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'RI8it5tUDuY'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'C6ATJIclkaU'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'l6f1_1vTzLk'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'r_cdHEU8Et8'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video '-F_8qaQ3DD0'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'pFlIqpFzjU4'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'pglMl92P-OA'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video '1SP0Cl_5L7k'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video '7Qp5vcuMIlk'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video '7cIkC7s3d2o'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 's8w2TbYhGtk'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'rI1KfI7oMJA'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'LUPZdti-bKc'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'Io5J8cFEeSg'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'Xq_33ze3hPk'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'govKYxJ4IxY'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'slbWLXIpCv8'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'rUKBZ3o0ltc'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'lBHqdKAlYq4'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video '6948o2zvUcg'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'nwpj9_hrK_A'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'E_SeMqLaL6o'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'oGa1brzAP6o'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'Ytb7J0ciBcE'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'MS00-mxtF70'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'S8a737LCBBI'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'UJFb8jDbWl0'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'l2l5sBLhUCY'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'chf5gj0HCqg'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video 'nM5eiunbDzQ'
14:44:58 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for video '2J5wTsYAh94'
14:44:58 T:139717223900928 DEBUG: POParser: loaded 141 strings from file /storage/.kodi/addons/plugin.video.youtube/resources/language/English/strings.po
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCy1JumjE9UMSoz1WGlfJSVQ'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCBi2mrWuNuyYy4gbM6fU18Q'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCLx8uTY2GZaYIv-cUAcNzwQ'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCP1iRaFlS5EYjJBryFV9JPw'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC22zQ9nBEk6KOjUWqR5XXZg'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCupvZG-5ko_eiXAupbDfxWw'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCKOLuamac8v0jhY9RID3syg'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCrZhVeobsmmsLJbkVK9rUMA'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCnGyCSPDOud1roNmhCbEdsw'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCajXeitgFL-rb5-gXI-aG8Q'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCF9imwPMSGz4Vq1NiTWCC7g'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC9j1JBJcMCMg40sZxcm9QDg'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC5jkXpfnBhlDjqh0ir5FsIQ'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCaXkIU1QidjPwiAYu6GcHjg'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCCxIjIp19PmZVBr7RdpBHTQ'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC-FQUIVQ-bZiefzBiQAa8Fw'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCv7YFWATebnJ1ty4cwMKgsQ'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCKZo4N0lVPccBkSiuyVh4yg'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCsooa4yRKGN_zEE8iknghZA'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UClFSU9_bUb4Rc6OYfTt5SPw'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCBJycsmduvYEL83R_U4JriQ'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC1-szPBG7Oh4icM1FcQakQg'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCaFGDBmGK_jw66u3av2Ysjw'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UClewyZDUM373scZY2fveeww'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCcHl3bzvpMh74okqhV5UPOw'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC7zOpx9wgvGBCDEjujnAPQA'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCDR8cvjALazMm2j9hOar8_g'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCa6vGFO9ty8v5KZJXQxdhaw'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC06E4Y_-ybJgBUMtXx8uNNw'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCo_IB5145EVNcf8hw1Kku7w'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCZC45sBWNdkqSQ9Bwtt5lfA'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC6ZFN9Tx6xh-skXCuRHCDpQ'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCWOA1ZGywLbqmigxE4Qlvuw'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCp0hYYBW6IMayGgR-WeoCvQ'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC5-gWZXAQqSGVfPHkA7NRiQ'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCo6DJdltbIub80bLiyJRv3w'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC9k-yiEpRHMNVOnOi_aQK8w'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCeH6qE4V7n5tVwP7NkdrtJg'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCshoKvlZGZ20rVgazZp5vnQ'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCMtFAi84ehTSYSE9XoHefig'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCMh30naOxjDTxd6Rigg6JjQ'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCk20cSRhH_ms_Yk1AZItFqA'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCUK0HBIBWgM2c4vsPhkYY4w'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCgyMPfJl7ynJRfE2jQ18rJw'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC0C-w0YjGpqDXGB8IHb662A'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCjPsvugkwOr9oOk8D7icstQ'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC_ciHdbUh6NR2yAAjb5XKfw'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UC6E2mP01ZLH_kbAyeazCNdg'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCTHsQd-vRXK1bp4vpifl6yA'
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Found cached data for channel 'UCVcoho9uaKUkDOYQxH5XNGA'
14:44:59 T:139717223900928 DEBUG: POParser: loaded 141 strings from file /storage/.kodi/addons/plugin.video.youtube/resources/language/English/strings.po
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Converting VideoItem
14:44:59 T:139717223900928 DEBUG: Previous line repeats 49 times.
14:44:59 T:139717223900928 DEBUG: [plugin.video.youtube] Shutdown of Kodion
14:44:59 T:139717223900928 INFO: CPythonInvoker(4, /storage/.kodi/addons/plugin.video.youtube/default.py): script successfully run
14:44:59 T:139718301390912 DEBUG: WaitOnScriptResult- plugin returned successfully
14:44:59 T:139718301390912 DEBUG: RunQuery took 0 ms for 3 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
14:44:59 T:139717208639232 DEBUG: Thread BackgroundLoader start, auto delete: false
14:44:59 T:139717223900928 INFO: Python script stopped
14:44:59 T:139717223900928 DEBUG: Thread LanguageInvoker 139717223900928 terminating
14:44:59 T:139717208639232 DEBUG: Thread BackgroundLoader 139717208639232 terminating
14:44:59 T:139717199984384 DEBUG: Thread JobWorker start, auto delete: true
14:44:59 T:139718301390912 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/libsse4-x86_64-linux.so)
14:45:28 T:139718301390912 INFO: CheckIdle - Closing session to https://r2---sn-uxap5nvoxg5-ixhe.googlevideo.com (easy=0x3f54990, multi=0x7f12502640a0)
14:45:29 T:139717183198976 DEBUG: Thread JobWorker 139717183198976 terminating (autodelete)
14:45:29 T:139717199984384 DEBUG: Thread JobWorker 139717199984384 terminating (autodelete)