20:07:28 T:18446744072509948104  NOTICE: special://profile/ is mapped to: special://masterprofile/
20:07:28 T:18446744072509948104  NOTICE: -----------------------------------------------------------------------
20:07:28 T:18446744072509948104  NOTICE: Starting Kodi (15.2 Git:2015-10-19-02e7013). Platform: Android ARM 32-bit
20:07:28 T:18446744072509948104  NOTICE: Using Release Kodi x32 build
20:07:28 T:18446744072509948104  NOTICE: Kodi compiled Oct 19 2015 by GCC 4.8.0 for Android ARM 32-bit API level 17 (API level 17)
20:07:28 T:18446744072509948104  NOTICE: Running on Amazon AFTB with Android 5.1.1 API level 22, kernel: Linux ARM 32-bit version 3.4.0-perf-g9f39ecd
20:07:28 T:18446744072509948104  NOTICE: FFmpeg version: 2.6.4-kodi-2.6.4-Isengard
20:07:28 T:18446744072509948104  NOTICE: Host CPU: ARMv7 Processor rev 0 (v7l), 4 cores available
20:07:28 T:18446744072509948104  NOTICE: Product: bueller, Device: bueller, Board: MSM8960 - Manufacturer: Amazon, Brand: Amazon, Model: AFTB, Hardware: qcom
20:07:28 T:18446744072509948104  NOTICE: External storage path = /storage/emulated/0; status = ok
20:07:28 T:18446744072509948104  NOTICE: ARM Features: Neon enabled
20:07:28 T:18446744072509948104  NOTICE: special://xbmc/ is mapped to: /data/data/org.xbmc.kodi/cache/apk/assets
20:07:28 T:18446744072509948104  NOTICE: special://xbmcbin/ is mapped to: /data/data/org.xbmc.kodi/cache/apk/assets
20:07:28 T:18446744072509948104  NOTICE: special://masterprofile/ is mapped to: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/userdata
20:07:28 T:18446744072509948104  NOTICE: special://home/ is mapped to: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi
20:07:28 T:18446744072509948104  NOTICE: special://temp/ is mapped to: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/temp
20:07:28 T:18446744072509948104  NOTICE: The executable running is:
20:07:28 T:18446744072509948104  NOTICE: Local hostname: localhost
20:07:28 T:18446744072509948104  NOTICE: Log File is located: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/temp/kodi.log
20:07:28 T:18446744072509948104  NOTICE: -----------------------------------------------------------------------
20:07:28 T:18446744072509948104  NOTICE: load settings...
20:07:28 T:18446744072509948104   DEBUG: CSettings: loaded settings definition from special://xbmc/system/settings/settings.xml
20:07:28 T:18446744072509948104 WARNING: CSettingInt: unknown options filler "audiocdactions" of "audiocds.autoaction"
20:07:28 T:18446744072509948104   DEBUG: CSettings: loaded settings definition from special://xbmc/system/settings/android.xml
20:07:28 T:18446744072509948104   DEBUG: AESinkAUDIOTRACK - 44100 supported
20:07:28 T:18446744072509948104   DEBUG: AESinkAUDIOTRACK - 48000 supported
20:07:28 T:18446744072509948104   DEBUG: AESinkAUDIOTRACK - 96000 supported
20:07:28 T:18446744072509948104  NOTICE: Found 1 Lists of Devices
20:07:28 T:18446744072509948104  NOTICE: Enumerated AUDIOTRACK devices:
20:07:28 T:18446744072509948104  NOTICE:     Device 1
20:07:28 T:18446744072509948104  NOTICE:         m_deviceName      : AudioTrack
20:07:28 T:18446744072509948104  NOTICE:         m_displayName     : android
20:07:28 T:18446744072509948104  NOTICE:         m_displayNameExtra: audiotrack
20:07:28 T:18446744072509948104  NOTICE:         m_deviceType      : AE_DEVTYPE_HDMI
20:07:28 T:18446744072509948104  NOTICE:         m_channels        : FL,FR,FC,LFE,BL,BR,SL,SR
20:07:28 T:18446744072509948104  NOTICE:         m_sampleRates     : 44100,48000,96000
20:07:28 T:18446744072509948104  NOTICE:         m_dataFormats     : AE_FMT_S16LE,AE_FMT_AC3,AE_FMT_DTS
20:07:28 T:18446744072509948104  NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml)
20:07:28 T:18446744072509948104  NOTICE: Loaded settings file from special://profile/advancedsettings.xml
20:07:28 T:18446744072509948104  NOTICE: Contents of special://profile/advancedsettings.xml are...
                                            <advancedsettings>
                                              <network>
                                                <buffermode>1</buffermode>
                                                <cachemembuffersize>314572800</cachemembuffersize>
                                              </network>
                                              <video>
                                                <highqualityscaling>1</highqualityscaling>
                                                <highqualityscalingmethod>8</highqualityscalingmethod>
                                                <allowlanczos3>true</allowlanczos3>
                                                <timeseekforward>10</timeseekforward>
                                                <timeseekbackward>-10</timeseekbackward>
                                              </video>
                                              <videolibrary>
                                                <importwatchedstate>true</importwatchedstate>
                                              </videolibrary>
                                              <pathsubstitution>
                                                <substitute>
                                                  <from>/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/userdata/Thumbnails/</from>
                                                  <to>smb://Necromancer/Backup/XBMC - Bilder/Kodithumbs/</to>
                                                </substitute>
                                              </pathsubstitution>
                                              <loglevel>1</loglevel>
                                            </advancedsettings>
20:07:28 T:18446744072509948104  NOTICE: Log level changed to "LOG_LEVEL_DEBUG"
20:07:28 T:18446744072509948104   DEBUG: Configuring path substitutions
20:07:28 T:18446744072509948104   DEBUG:   Registering substition pair:
20:07:28 T:18446744072509948104   DEBUG:     From: [/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/userdata/Thumbnails/]
20:07:28 T:18446744072509948104   DEBUG:     To:   [smb://Necromancer/Backup/XBMC - Bilder/Kodithumbs/]
20:07:28 T:18446744072509948104  NOTICE: Default DVD Player: dvdplayer
20:07:28 T:18446744072509948104  NOTICE: Default Video Player: dvdplayer
20:07:28 T:18446744072509948104  NOTICE: Default Audio Player: paplayer
20:07:28 T:18446744072509948104  NOTICE: Disabled debug logging due to GUI setting. Level 1.
20:07:28 T:18446744072509948104  NOTICE: Log level changed to "LOG_LEVEL_DEBUG"
20:07:28 T:18446744072509948104  NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml
20:07:28 T:18446744072509948104  NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
20:07:28 T:18446744072509948104   DEBUG: CPlayerCoreConfig::<ctor>: created player DVDPlayer for core 1
20:07:28 T:18446744072509948104   DEBUG: CPlayerCoreConfig::<ctor>: created player oldmplayercore for core 1
20:07:28 T:18446744072509948104   DEBUG: CPlayerCoreConfig::<ctor>: created player PAPlayer for core 3
20:07:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules
20:07:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::Initialize: creating rule: hdhomerun/mms/udp
20:07:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout
20:07:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp
20:07:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp
20:07:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams
20:07:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp
20:07:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2
20:07:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd
20:07:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage
20:07:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf
20:07:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv
20:07:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio
20:07:28 T:18446744072509948104  NOTICE: Loaded playercorefactory configuration
20:07:28 T:18446744072509948104  NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
20:07:28 T:18446744072509948104  NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
20:07:28 T:18446744072509948104    INFO: creating subdirectories
20:07:28 T:18446744072509948104    INFO: userdata folder: special://masterprofile/
20:07:28 T:18446744072509948104    INFO: recording folder:
20:07:28 T:18446744072509948104    INFO: screenshots folder: smb://NECROMANCER/Backup/XBMC - Backup/
20:07:28 T:18446744072510119712  NOTICE: Thread ActiveAE start, auto delete: false
20:07:28 T:18446744072510386952  NOTICE: Thread AESink start, auto delete: false
20:07:28 T:18446744072510386952    INFO: CActiveAESink::OpenSink - initialize sink
20:07:28 T:18446744072510386952   DEBUG: CActiveAESink::OpenSink - trying to open device AUDIOTRACK:AudioTrack
20:07:28 T:18446744072510386952   DEBUG: CActiveAESink::OpenSink - AUDIOTRACK Initialized:
20:07:28 T:18446744072510386952   DEBUG:   Output Device : android
20:07:28 T:18446744072510386952   DEBUG:   Sample Rate   : 48000
20:07:28 T:18446744072510386952   DEBUG:   Sample Format : AE_FMT_S16NE
20:07:28 T:18446744072510386952   DEBUG:   Channel Count : 2
20:07:28 T:18446744072510386952   DEBUG:   Channel Layout: FL,FR
20:07:28 T:18446744072510386952   DEBUG:   Frames        : 1536
20:07:28 T:18446744072510386952   DEBUG:   Frame Samples : 3072
20:07:28 T:18446744072510386952   DEBUG:   Frame Size    : 4
20:07:28 T:18446744072509948104  NOTICE: Running database version Addons19
20:07:28 T:18446744072509948104   DEBUG: SECTION:LoadDLL(libcpluff-arm.so)
20:07:28 T:18446744072509948104   DEBUG: Loading: /data/app-lib/org.xbmc.kodi-1/libcpluff-arm.so
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.dokumonster has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in audiodecoder.nosefart has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.module.bigpictures has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in pvr.vbox has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in audiodecoder.timidity has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in xbmc.audioencoder has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.doku5.com has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.moviesetart has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in kodi.audiodecoder has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in weather.yahoo has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.module.six has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in pvr.vdr.vnsi has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in kodi.guilib has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in audiodecoder.modplug has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in pvr.argustv has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in visualization.vortex has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.wma has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in pvr.mediaportal.tvserver has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in audioencoder.vorbis has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in repository.kodinerds has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in audioencoder.wav has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.module.simplejson has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in pvr.wmc has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in plugin.audio.radio_de has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in service.xbmc.versioncheck has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in pvr.dvblink has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in audioencoder.flac has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in skin.confluence has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.module.httplib2 has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in audiodecoder.ym has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in plugin.program.FTVtweaks has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in service.nfo.watchedstate.updater has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in kodi.resource has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in visualization.glspectrum has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.module.beautifulsoup has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in skin.moddedconfluence.4 has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.common.plugin.cache has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.screensaver.multi_slideshow has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.keymap has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.skinshortcuts has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.module.unidecode has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.screensaver.bigpictures has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in pvr.vuplus has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in pvr.mythtv has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.module.uritemplate has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in metadata.musicvideos.theaudiodb.com has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.youtube has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in audiodecoder.sidplay has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in pvr.demo has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in skin.re-touched has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.grab.fanart has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.module.requests has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in pvr.pctv has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.artwork.downloader has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in pvr.iptvsimple has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in screensaver.picture.slideshow has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in pvr.njoy has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.module.oauth2client has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in pvr.nextpvr has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in service.library.data.provider has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.br3 has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.module.yaml has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.aac has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in audiodecoder.vgmstream has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.xbmcbackup has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in xbmc.repo.elmerohueso has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in pvr.dvbviewer has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in resource.language.en_gb has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in plugin.library.node.editor has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in pvr.stalker has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in audiodecoder.snesapu has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in metadata.local has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in audioencoder.lame has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in xbmc.webinterface has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.last.fm has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in resource.uisounds.confluence has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in metadata.fernsehserien.de has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.module.googleapi has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in resource.language.de_de has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.module.parsedom has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.module.xbmcswift2 has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in pvr.filmon has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in pvr.hts has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in visualization.waveform has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in xbmc.codec has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Plug-in script.module.addon.signals has been installed.'
20:07:28 T:18446744072509948104   DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.'
20:07:28 T:18446744072509948104  NOTICE: ADDONS: Using repository repository.xbmc.org
20:07:28 T:18446744072509948104  NOTICE: ADDONS: Using repository repository.kodinerds
20:07:28 T:18446744072509948104  NOTICE: ADDONS: Using repository xbmc.repo.elmerohueso
20:07:28 T:18446744072509948104    INFO: CKeyboardLayoutManager: loading keyboard layouts from special://xbmc/system/keyboardlayouts...
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Russian ЙЦУКЕН" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Russian АБВ" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian ЙЦУКЕН" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian АБВ" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "English QWERTY" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "English AZERTY" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "English ABC" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Danish QWERTY" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Swedish QWERTY" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Portuguese (Portugal) QWERTY" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Norwegian QWERTY" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Polish QWERTY" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Romanian QWERTY" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Spanish QWERTY" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "German QWERTZ" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Arabic QWERTY" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Turkish QWERTY" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew QWERTY" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew ABC" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian AZERTY" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian QWERTY" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Greek QWERTY" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Hungarian QWERTZ" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian ЯВЕРТЪ" successfully loaded
20:07:28 T:18446744072509948104   DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian АБВ" successfully loaded
20:07:29 T:18446744072509948104  NOTICE: virtual bool CWinSystemEGL::InitWindowSystem(): Using EGL Implementation: android
20:07:29 T:18446744072509948104   DEBUG: CEGLNativeTypeAndroid: SetNativeResolution: 0x0
20:07:29 T:18446744072509948104   DEBUG: bool CWinSystemEGL::CreateWindow(RESOLUTION_INFO&): Created surface of size 1920x1080
20:07:29 T:18446744072509948104  NOTICE: Current resolution: 1920x1080 @ 60.00 - Full Screen
20:07:29 T:18446744072509948104  NOTICE: Previous line repeats 1 times.
20:07:29 T:18446744072509948104  NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 60.000000 Hz
20:07:29 T:18446744072509948104  NOTICE: Found (1920x1080@60.000000) at 16, setting to RES_DESKTOP at 16
20:07:29 T:18446744072509948104  NOTICE: Checking resolution 16
20:07:29 T:18446744072509948104  NOTICE: Current resolution: 1920x1080 @ 60.00 - Full Screen
20:07:29 T:18446744072509948104   DEBUG: CEGLNativeTypeAndroid: SetNativeResolution: 0x0
20:07:29 T:18446744072509948104   DEBUG: bool CWinSystemEGL::CreateWindow(RESOLUTION_INFO&): Created surface of size 1920x1080
20:07:29 T:18446744072509948104  NOTICE: GL_VENDOR = Qualcomm
20:07:29 T:18446744072509948104  NOTICE: GL_RENDERER = Adreno (TM) 320
20:07:29 T:18446744072509948104  NOTICE: GL_VERSION = OpenGL ES 3.0 V@84.0 AU@05.00.02.006.020 (CL@)
20:07:29 T:18446744072509948104  NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 3.00
20:07:29 T:18446744072509948104   DEBUG: GLES: Extension Support Test - GL_NVX_gpu_memory_info NO
20:07:29 T:18446744072509948104  NOTICE: GL_EXTENSIONS = GL_AMD_compressed_ATC_texture GL_AMD_performance_monitor GL_AMD_program_binary_Z400 GL_EXT_debug_label GL_EXT_debug_marker GL_EXT_discard_framebuffer GL_EXT_robustness GL_EXT_texture_format_BGRA8888 GL_EXT_texture_type_2_10_10_10_REV GL_NV_fence GL_OES_compressed_ETC1_RGB8_texture GL_OES_depth_texture GL_OES_depth24 GL_OES_EGL_image GL_OES_EGL_sync GL_OES_EGL_image_external GL_OES_element_index_uint GL_OES_fbo_render_mipmap GL_OES_fragment_precision_high GL_OES_get_program_binary GL_OES_packed_depth_stencil GL_OES_depth_texture_cube_map GL_OES_rgb8_rgba8 GL_OES_standard_derivatives GL_OES_texture_3D GL_OES_texture_float GL_OES_texture_half_float GL_OES_texture_half_float_linear GL_OES_texture_npot GL_OES_vertex_half_float GL_OES_vertex_type_10_10_10_2 GL_OES_vertex_array_object GL_QCOM_alpha_test GL_QCOM_binning_control GL_QCOM_driver_control GL_QCOM_perfmon_global_mode GL_QCOM_extended_get GL_QCOM_extended_get2 GL_QCOM_tiled_rendering GL_QCOM_writeonly_rendering GL_EXT_sRGB GL_EXT_sRGB_write_control GL_EXT_texture_sRGB_decode GL_EXT_texture_filter_anisotropic GL_EXT_multisampled_render_to_texture GL_EXT_color_buffer_float GL_EXT_color_buffer_half_float GL_EXT_disjoint_timer_query
20:07:29 T:18446744072509948104   DEBUG: GLES: Extension Support Test - GL_EXT_texture_format_BGRA8888 YES
20:07:29 T:18446744072509948104   DEBUG: GLES: Extension Support Test - GL_IMG_texture_format_BGRA8888 NO
20:07:29 T:18446744072509948104   DEBUG: GLES: Extension Support Test - GL_APPLE_texture_format_BGRA8888 NO
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GL: Pixel Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Fragment Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GUI Shader [guishader_frag_default.glsl]- Initialise successful : 0xb8adde90
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GL: Pixel Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Fragment Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GUI Shader [guishader_frag_texture.glsl]- Initialise successful : 0xb8b09f00
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GL: Pixel Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Fragment Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GUI Shader [guishader_frag_multi.glsl]- Initialise successful : 0xb8aecc08
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GL: Pixel Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Fragment Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GUI Shader [guishader_frag_fonts.glsl]- Initialise successful : 0xb8b1c068
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GL: Pixel Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Fragment Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GUI Shader [guishader_frag_texture_noblend.glsl]- Initialise successful : 0xb8b26898
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GL: Pixel Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Fragment Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GUI Shader [guishader_frag_multi_blendcolor.glsl]- Initialise successful : 0xb8b1f628
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GL: Pixel Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Fragment Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GUI Shader [guishader_frag_rgba.glsl]- Initialise successful : 0xb8b2ca60
20:07:29 T:18446744072509948104   DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external YES
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GL: Pixel Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Fragment Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GUI Shader [guishader_frag_rgba_oes.glsl]- Initialise successful : 0xb8b3b878
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GL: Pixel Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Fragment Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GUI Shader [guishader_frag_rgba_blendcolor.glsl]- Initialise successful : 0xb8b4f7d8
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GL: Pixel Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Fragment Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GUI Shader [guishader_frag_rgba_bob.glsl]- Initialise successful : 0xb8b598f8
20:07:29 T:18446744072509948104   DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external YES
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Vertex Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GL: Pixel Shader compilation log:
20:07:29 T:18446744072509948104   DEBUG: GL: Fragment Shader compiled successfully
20:07:29 T:18446744072509948104   DEBUG: GUI Shader [guishader_frag_rgba_bob_oes.glsl]- Initialise successful : 0xb8afb258
20:07:29 T:18446744072509948104  NOTICE: Current resolution: 1920x1080 @ 60.00 - Full Screen
20:07:29 T:18446744072509948104   DEBUG: CWinSystemEGL::CreateNewWindow: No need to create a new window
20:07:29 T:18446744072509948104    INFO: GLES: Maximum texture width: 4096
20:07:29 T:18446744072509948104   DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
20:07:29 T:18446744072509948104   DEBUG: SECTION:LoadDLL(libImageLib-arm.so)
20:07:29 T:18446744072509948104   DEBUG: Loading: /data/app-lib/org.xbmc.kodi-1/libImageLib-arm.so
20:07:29 T:18446744072509948104    INFO: load keymapping
20:07:29 T:18446744072509948104    INFO: Loading special://xbmc/system/keymaps/appcommand.xml
20:07:29 T:18446744072509948104    INFO: Loading special://xbmc/system/keymaps/gamepad.xml
20:07:29 T:18446744072509948104    INFO: Loading special://xbmc/system/keymaps/joystick.xml
20:07:29 T:18446744072509948104    INFO: Loading special://xbmc/system/keymaps/keyboard.xml
20:07:29 T:18446744072509948104    INFO: Loading special://xbmc/system/keymaps/mouse.xml
20:07:29 T:18446744072509948104    INFO: Loading special://xbmc/system/keymaps/remote.xml
20:07:29 T:18446744072509948104    INFO: Loading special://xbmc/system/keymaps/touchscreen.xml
20:07:29 T:18446744072509948104    INFO: Loading special://masterprofile/keymaps/gen.xml
20:07:29 T:18446744072509948104    INFO: Loading special://profile/keymaps/gen.xml
20:07:29 T:18446744072509948104    INFO: GUI format 1920x1080, Display 1920x1080 @ 60.00 - Full Screen
20:07:29 T:18446744072509948104   DEBUG: guilib: Fill viewport on change for solving rendering passes
20:07:29 T:18446744072509948104    INFO: CLangInfo: loading resource.language.de_de language information...
20:07:29 T:18446744072509948104   DEBUG: trying to set locale to de_DE.UTF-8
20:07:29 T:18446744072509948104    INFO: global locale set to C
20:07:29 T:18446744072509948104    INFO: CLangInfo: loading resource.language.de_de language strings...
20:07:29 T:18446744072509948104   DEBUG: POParser: loaded 3312 strings from file resource://resource.language.de_de/strings.po
20:07:29 T:18446744072509948104   DEBUG: POParser: loaded 0 strings from file resource://resource.language.en_gb/strings.po
20:07:29 T:18446744072509948104   DEBUG: bool PERIPHERALS::CPeripherals::LoadMappings() - loaded node "Motorola Nyxboard Hybrid"
20:07:29 T:18446744072509948104   DEBUG: bool PERIPHERALS::CPeripherals::LoadMappings() - loaded node "CEC Adapter"
20:07:29 T:18446744072509948104   DEBUG: bool PERIPHERALS::CPeripherals::LoadMappings() - loaded node "Pulse-Eight CEC Adapter"
20:07:29 T:18446744072509948104   DEBUG: bool PERIPHERALS::CPeripherals::LoadMappings() - loaded node "iMON HID device"
20:07:29 T:18446744072509948104   DEBUG: PERIPHERALS::CPeripheralBusUSB::CPeripheralBusUSB(PERIPHERALS::CPeripherals*) - using libusb peripheral scanning
20:07:29 T:18446744072509948104   DEBUG: SECTION:LoadDLL(libcec.so)
20:07:29 T:18446744072509948104   DEBUG: Loading: libcec.so
20:07:29 T:18446744072509948104   ERROR: Unable to load libcec.so, reason: dlopen failed: library "/vendor/lib/egl/libGLESv2S3D_adreno.so" not found
20:07:29 T:18446744072509948104   DEBUG: Dll libcec.so was not found in path
20:07:29 T:18446744072509948104   ERROR: virtual void PERIPHERALS::CPeripherals::Initialise() - failed to initialise bus cec
20:07:29 T:18446744072514096488  NOTICE: Thread PeripBusUSB start, auto delete: false
20:07:29 T:18446744072509948104   DEBUG: SECTION:LoadDLL(libcurl.so)
20:07:29 T:18446744072509948104   DEBUG: Loading: /data/app-lib/org.xbmc.kodi-1/libcurl.so
20:07:29 T:18446744072509948104  NOTICE: Running database version Addons19
20:07:29 T:18446744072509948104   DEBUG: void CDatabaseManager::Initialize(bool), updating databases...
20:07:29 T:18446744072509948104  NOTICE: Running database version ViewModes6
20:07:29 T:18446744072509948104  NOTICE: Running database version Textures13
20:07:29 T:18446744072509948104  NOTICE: Running database version MyMusic52
20:07:29 T:18446744072509948104  NOTICE: Running database version MyVideos93
20:07:29 T:18446744072509948104  NOTICE: Running database version TV29
20:07:29 T:18446744072509948104  NOTICE: Running database version Epg10
20:07:29 T:18446744072509948104   DEBUG: void CDatabaseManager::Initialize(bool), updating databases... DONE
20:07:29 T:18446744072509948104    INFO: DPMS: not supported on this platform
20:07:29 T:18446744072509948104   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
20:07:29 T:18446744072509948104   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
20:07:29 T:18446744072509948104   DEBUG: Activating window ID: 12997
20:07:29 T:18446744072509948104   DEBUG: ------ Window Init () ------
20:07:29 T:18446744072509948104    INFO: load splash image: /data/data/org.xbmc.kodi/cache/apk/assets/media/Splash.png
20:07:29 T:18446744072509948104    INFO: Unloading old skin ...
20:07:29 T:18446744072509948104    INFO:   load skin from: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/skin.moddedconfluence.4 (version: 1.1.1)
20:07:29 T:18446744072509948104    INFO:   load fonts for skin...
20:07:29 T:18446744072509948104    INFO: Loading fonts from /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/skin.moddedconfluence.4/720p/Font.xml
20:07:29 T:18446744072509948104   DEBUG: POParser: loaded 197 strings from file /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/skin.moddedconfluence.4/language/German/strings.po
20:07:29 T:18446744072509948104   DEBUG: POParser: loaded 0 strings from file /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/skin.moddedconfluence.4/language/English/strings.po
20:07:29 T:18446744072509948104    INFO: Loading skin includes from /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/skin.moddedconfluence.4/720p/includes.xml
20:07:29 T:18446744072509948104    INFO:   load new skin...
20:07:29 T:18446744072509948104    INFO: Loading user windows, path /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/skin.moddedconfluence.4/720p
20:07:29 T:18446744072509948104   DEBUG: Load Skin XML: 55.82ms
20:07:29 T:18446744072509948104    INFO:   initialize new skin...
20:07:29 T:18446744072509948104   DEBUG: guilib: Fill viewport on change for solving rendering passes
20:07:29 T:18446744072509948104    INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT
20:07:29 T:18446744072509948104   DEBUG: bool CTextureBundleXBT::OpenBundle() - Opened bundle /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/skin.moddedconfluence.4/media/Textures.xbt
20:07:29 T:18446744072509948104    INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT
20:07:29 T:18446744072509948104    INFO: Loading skin file: DialogKaiToast.xml, load type: LOAD_ON_GUI_INIT
20:07:29 T:18446744072509948104    INFO: Loading skin file: DialogMuteBug.xml, load type: LOAD_ON_GUI_INIT
20:07:29 T:18446744072509948104    INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT
20:07:29 T:18446744072509948104    INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
20:07:29 T:18446744072509948104    INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT
20:07:29 T:18446744072509948104    INFO: Loading resource://resource.uisounds.confluence/sounds.xml
20:07:29 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: Format wav probed with size=2048 and score=99
20:07:29 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] Format wav probed with size=2048 and score=99
20:07:29 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] Before avformat_find_stream_info() pos: 44 bytes read:1402 seeks:0
20:07:29 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] After avformat_find_stream_info() pos: 1402 bytes read:1402 seeks:0 frames:1
20:07:29 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: Format wav probed with size=2048 and score=99
20:07:29 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] Format wav probed with size=2048 and score=99
20:07:29 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] Before avformat_find_stream_info() pos: 44 bytes read:9842 seeks:0
20:07:29 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] After avformat_find_stream_info() pos: 9842 bytes read:9842 seeks:0 frames:3
20:07:29 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: Format wav probed with size=2048 and score=99
20:07:29 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] Format wav probed with size=2048 and score=99
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] Before avformat_find_stream_info() pos: 44 bytes read:4572 seeks:0
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] After avformat_find_stream_info() pos: 4572 bytes read:4572 seeks:0 frames:2
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: Format wav probed with size=2048 and score=99
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] Format wav probed with size=2048 and score=99
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] Before avformat_find_stream_info() pos: 44 bytes read:20480 seeks:0
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:32
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:31
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:30
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:29
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:28
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:27
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:26
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probed stream 0
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] After avformat_find_stream_info() pos: 20780 bytes read:20780 seeks:0 frames:6
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: Format wav probed with size=2048 and score=99
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] Format wav probed with size=2048 and score=99
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] Before avformat_find_stream_info() pos: 46 bytes read:20480 seeks:0
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:32
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:31
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:30
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:29
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:28
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:27
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:26
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:25
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:24
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:23
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:22
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:21
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probed stream 0
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] After avformat_find_stream_info() pos: 43822 bytes read:43822 seeks:0 frames:11
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: Format wav probed with size=2048 and score=99
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] Format wav probed with size=2048 and score=99
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] Before avformat_find_stream_info() pos: 46 bytes read:18478 seeks:0
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:32
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:31
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:30
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:29
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:28
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probing stream 0 pp:27
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] probed stream 0
20:07:30 T:18446744072509948104   DEBUG: ffmpeg[B87F80C8]: [wav] After avformat_find_stream_info() pos: 18478 bytes read:18478 seeks:0 frames:5
20:07:30 T:18446744072509948104    INFO:   skin loaded...
20:07:30 T:18446744072509948104   DEBUG: Activating window ID: 12997
20:07:30 T:18446744072509948104   DEBUG: ------ Window Init () ------
20:07:30 T:18446744072509948104    INFO: load splash image: /data/data/org.xbmc.kodi/cache/apk/assets/media/Splash.png
20:07:30 T:18446744072509948104   DEBUG: JSONRPC: JSON schema type broadcastnext references an unknown type PVR.Details.Broadcast
20:07:30 T:18446744072509948104 WARNING: JSONRPC: Could not parse type "PVR.Details.Channel"
20:07:30 T:18446744072509948104    INFO: JSONRPC: Adding type "PVR.Details.Channel" to list of incomplete definitions (waiting for "PVR.Details.Broadcast")
20:07:30 T:18446744072509948104   DEBUG: JSONRPC: JSON schema type  references an unknown type PVR.Details.Channel
20:07:30 T:18446744072509948104   DEBUG: Invalid item definition in "items" for type channels
20:07:30 T:18446744072509948104 WARNING: JSONRPC: Could not parse type "PVR.Details.ChannelGroup.Extended"
20:07:30 T:18446744072509948104    INFO: JSONRPC: Adding type "PVR.Details.ChannelGroup.Extended" to list of incomplete definitions (waiting for "PVR.Details.Channel")
20:07:30 T:18446744072509948104    INFO: JSONRPC: Resolving incomplete types/methods referencing PVR.Details.Broadcast
20:07:30 T:18446744072509948104    INFO: JSONRPC: Resolving incomplete types/methods referencing PVR.Details.Channel
20:07:30 T:18446744072509948104   DEBUG: JSONRPC: JSON schema type stereoscopicmode references an unknown type GUI.Stereoscopy.Mode
20:07:30 T:18446744072509948104 WARNING: JSONRPC: Could not parse type "GUI.Property.Value"
20:07:30 T:18446744072509948104    INFO: JSONRPC: Adding type "GUI.Property.Value" to list of incomplete definitions (waiting for "GUI.Stereoscopy.Mode")
20:07:30 T:18446744072509948104    INFO: JSONRPC: Resolving incomplete types/methods referencing GUI.Stereoscopy.Mode
20:07:30 T:18446744072509948104   DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting
20:07:30 T:18446744072509948104 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList"
20:07:30 T:18446744072509948104    INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting")
20:07:30 T:18446744072509948104    INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting
20:07:30 T:18446744072510119712   DEBUG: ffmpeg[B8821F20]: 0.707107
20:07:30 T:18446744072509948104   DEBUG: Previous line repeats 1 times.
20:07:30 T:18446744072509948104    INFO: JSONRPC v6.25.2: Successfully initialized
20:07:30 T:18446744072509948104   DEBUG: ADDON: Starting service addons.
20:07:30 T:18446744072520605136  NOTICE: Thread LanguageInvoker start, auto delete: false
20:07:30 T:18446744072520605136    INFO: initializing python engine.
20:07:30 T:18446744072520606696  NOTICE: Thread LanguageInvoker start, auto delete: false
20:07:30 T:18446744072520606696    INFO: initializing python engine.
20:07:30 T:18446744072520609656  NOTICE: Thread LanguageInvoker start, auto delete: false
20:07:30 T:18446744072509948104  NOTICE: Previous line repeats 1 times.
20:07:30 T:18446744072509948104   DEBUG: Activating window ID: 12999
20:07:30 T:18446744072520607280    INFO: initializing python engine.
20:07:30 T:18446744072509948104    INFO: Previous line repeats 1 times.
20:07:30 T:18446744072509948104   DEBUG: ------ Window Init (Startup.xml) ------
20:07:30 T:18446744072509948104    INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME
20:07:30 T:18446744072509948104    INFO: removing tempfiles
20:07:30 T:18446744072509948104   DEBUG: ADDON: Starting service addons.
20:07:30 T:18446744072520900024  NOTICE: Thread LanguageInvoker start, auto delete: false
20:07:30 T:18446744072509948104  NOTICE: initialize done
20:07:30 T:18446744072520900024    INFO: initializing python engine.
20:07:30 T:18446744072509948104  NOTICE: Running the application...
20:07:30 T:18446744072509948104   DEBUG: Activating window ID: 10000
20:07:30 T:18446744072509948104   DEBUG: ------ Window Deinit (Startup.xml) ------
20:07:30 T:18446744072509948104   DEBUG: ------ Window Init (Home.xml) ------
20:07:30 T:18446744072509948104    INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY
20:07:30 T:18446744072520903240  NOTICE: Thread LanguageInvoker start, auto delete: false
20:07:30 T:18446744072520903240    INFO: initializing python engine.
20:07:30 T:18446744072510119712   DEBUG: ffmpeg[B8821F20]: 0.707107
20:07:30 T:18446744072522310360   DEBUG: Previous line repeats 3 times.
20:07:30 T:18446744072522310360  NOTICE: Thread JobWorker start, auto delete: true
20:07:30 T:18446744072522310360   DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update
20:07:30 T:18446744072520605136   DEBUG: CPythonInvoker(0, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.xbmc.versioncheck/service.py): start processing
20:07:30 T:18446744072520607280   DEBUG: CPythonInvoker(3, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.library.data.provider/service.py): start processing
20:07:30 T:18446744072520606696   DEBUG: CPythonInvoker(1, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.nfo.watchedstate.updater/default.py): start processing
20:07:30 T:18446744072520609656   DEBUG: CPythonInvoker(2, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.grab.fanart/service.py): start processing
20:07:30 T:18446744072520900024   DEBUG: CPythonInvoker(4, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.common.plugin.cache/default.py): start processing
20:07:30 T:18446744072520903240   DEBUG: CPythonInvoker(5, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.xbmcbackup/scheduler.py): start processing
20:07:30 T:18446744072522310360   DEBUG: GetRecentlyAddedAlbumSongs() query: SELECT songview.* FROM (SELECT idAlbum FROM albumview ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN songview ON songview.idAlbum=recentalbums.idAlbum
20:07:30 T:18446744072522310360   DEBUG: bool CMusicDatabase::GetRecentlyAddedAlbums(VECALBUMS&, unsigned int) query: select * from albumview where strAlbum != '' order by idAlbum desc limit 10
20:07:30 T:18446744072522310360   DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
20:07:30 T:18446744072509948104   DEBUG: no profile autoexec.py (/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/userdata/autoexec.py) found, skipping
20:07:30 T:18446744072509948104   DEBUG: void CNetwork::NetworkMessage(CNetwork::EMESSAGE, int) - Starting network services
20:07:30 T:18446744072509948104  NOTICE: starting zeroconf publishing
20:07:30 T:18446744072509948104  NOTICE: Webserver: Starting...
20:07:30 T:18446744072509948104   DEBUG: CWebServer [MHD]: Failed to bind to port 8080: Address already in use
20:07:30 T:18446744072509948104  NOTICE: WebServer: Started the webserver
20:07:30 T:18446744072509948104  NOTICE: starting upnp client
20:07:30 T:18446744072525461104  NOTICE: Thread JobWorker start, auto delete: true
20:07:30 T:18446744072525461104   DEBUG: ZeroconfMDNS: identifier: servers.webserver type: _http._tcp name:Kodi (localhost) port:8080
20:07:30 T:18446744072525461104   DEBUG: ZeroconfMDNS: identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:Kodi (localhost) port:8080
20:07:30 T:18446744072520605136  NOTICE: -->Python Interpreter Initialized<--
20:07:30 T:18446744072520605136   DEBUG: CPythonInvoker(0, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.xbmc.versioncheck/service.py): the source file to load is "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.xbmc.versioncheck/service.py"
20:07:30 T:18446744072520609656  NOTICE: -->Python Interpreter Initialized<--
20:07:30 T:18446744072520609656   DEBUG: CPythonInvoker(2, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.grab.fanart/service.py): the source file to load is "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.grab.fanart/service.py"
20:07:30 T:18446744072525180120  NOTICE: Thread ZerocconfEmbedded start, auto delete: false
20:07:30 T:18446744072509948104  NOTICE: Platinum [platinum.core.upnp]: Starting UPnP...
20:07:30 T:18446744072509948104    INFO: Platinum [neptune.sockets.bsd]: setting SO_REUSEADDR option on socket
20:07:30 T:18446744072509948104    INFO: Platinum [neptune.sockets.bsd]: leaving multicast addr 192.168.0.115 group 239.255.255.250
20:07:30 T:18446744072509948104    INFO: Platinum [neptune.sockets.bsd]: setsockopt error -22099
20:07:30 T:18446744072525180120   DEBUG: ZeroconfEmbedded - processing...
20:07:30 T:18446744072509948104    INFO: Platinum [neptune.sockets.bsd]: joining multicast addr 192.168.0.115 group 239.255.255.250
20:07:30 T:18446744072509948104    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072509948104  NOTICE: Platinum [platinum.core.upnp]: Starting Ctrlpoint...
20:07:30 T:18446744072509948104    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072509948104  NOTICE: Platinum [platinum.core.http.server]: HttpServer listening on 0.0.0.0:1486
20:07:30 T:18446744072509948104    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072509948104    INFO: Platinum [neptune.sockets.bsd]: setting multicast interface 192.168.0.115
20:07:30 T:18446744072509948104    INFO: Platinum [neptune.sockets.bsd]: setting multicast TTL to 2
20:07:30 T:18446744072509948104    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072509948104  NOTICE: starting upnp server
20:07:30 T:18446744072509948104  NOTICE: Platinum [platinum.core.upnp]: Starting Device...
20:07:30 T:18446744072509948104    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072509948104  NOTICE: Platinum [platinum.core.http.server]: HttpServer listening on 0.0.0.0:1480
20:07:30 T:18446744072509948104    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072527075032  NOTICE: Platinum [platinum.core.ctrlpoint]: Inspecting device "00000000-0000-1000-8000-60128B472E0A" detected @ http://192.168.0.118/Canon_basic.xml
20:07:30 T:18446744072527075032    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072509948104  NOTICE: starting upnp renderer
20:07:30 T:18446744072525870832    INFO: Platinum [neptune.sockets.bsd]: setting multicast interface 192.168.0.115
20:07:30 T:18446744072525870832    INFO: Platinum [neptune.sockets.bsd]: setting multicast TTL to 2
20:07:30 T:18446744072509948104  NOTICE: Platinum [platinum.core.upnp]: Starting Device...
20:07:30 T:18446744072509948104    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072509948104  NOTICE: Platinum [platinum.core.http.server]: HttpServer listening on 0.0.0.0:1036
20:07:30 T:18446744072524294120    INFO: Platinum [platinum.core.ctrlpoint]: Received a NOTIFY request from ourselves (68298a16-2c03-342e-b90d-a115252cb136)
20:07:30 T:18446744072527075032    INFO: Previous line repeats 3 times.
20:07:30 T:18446744072527075032  NOTICE: Platinum [platinum.core.ctrlpoint]: Inspecting device "0d4a5572-53bb-4b26-9f92-39264db28933" detected @ http://192.168.0.103:2869/upnphost/udhisapi.dll?content=uuid:0d4a5572-53bb-4b26-9f92-39264db28933
20:07:30 T:18446744072527075032    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072524294120    INFO: Platinum [platinum.core.ctrlpoint]: Received a NOTIFY request from ourselves (68298a16-2c03-342e-b90d-a115252cb136)
20:07:30 T:18446744072522310360   DEBUG: int CVideoDatabase::RunQuery(const string&) took 62 ms for 10 items query: select * from movie_view  ORDER BY dateAdded desc, idMovie desc LIMIT 10
20:07:30 T:18446744072524294120    INFO: Platinum [platinum.core.ctrlpoint]: Received a NOTIFY request from ourselves (68298a16-2c03-342e-b90d-a115252cb136)
20:07:30 T:18446744072509948104    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072509948104  NOTICE: ES: Starting event server
20:07:30 T:18446744072509948104    INFO: JSONRPC Server: Successfully initialized
20:07:30 T:18446744072525461104   DEBUG: ZeroconfMDNS: identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:Kodi (localhost) port:9090
20:07:30 T:18446744072528196240  NOTICE: Thread EventServer start, auto delete: false
20:07:30 T:18446744072528197736  NOTICE: Thread TCPServer start, auto delete: false
20:07:30 T:18446744072509948104  NOTICE: Current resolution: 1920x1080 @ 60.00 - Full Screen
20:07:30 T:18446744072509948104   DEBUG: CWinSystemEGL::CreateNewWindow: No need to create a new window
20:07:30 T:18446744072509948104  NOTICE: GL_VENDOR = Qualcomm
20:07:30 T:18446744072528196240  NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777
20:07:30 T:18446744072509948104  NOTICE: GL_RENDERER = Adreno (TM) 320
20:07:30 T:18446744072509948104  NOTICE: GL_VERSION = OpenGL ES 3.0 V@84.0 AU@05.00.02.006.020 (CL@)
20:07:30 T:18446744072509948104  NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 3.00
20:07:30 T:18446744072509948104   DEBUG: GLES: Extension Support Test - GL_NVX_gpu_memory_info NO
20:07:30 T:18446744072509948104  NOTICE: GL_EXTENSIONS = GL_AMD_compressed_ATC_texture GL_AMD_performance_monitor GL_AMD_program_binary_Z400 GL_EXT_debug_label GL_EXT_debug_marker GL_EXT_discard_framebuffer GL_EXT_robustness GL_EXT_texture_format_BGRA8888 GL_EXT_texture_type_2_10_10_10_REV GL_NV_fence GL_OES_compressed_ETC1_RGB8_texture GL_OES_depth_texture GL_OES_depth24 GL_OES_EGL_image GL_OES_EGL_sync GL_OES_EGL_image_external GL_OES_element_index_uint GL_OES_fbo_render_mipmap GL_OES_fragment_precision_high GL_OES_get_program_binary GL_OES_packed_depth_stencil GL_OES_depth_texture_cube_map GL_OES_rgb8_rgba8 GL_OES_standard_derivatives GL_OES_texture_3D GL_OES_texture_float GL_OES_texture_half_float GL_OES_texture_half_float_linear GL_OES_texture_npot GL_OES_vertex_half_float GL_OES_vertex_type_10_10_10_2 GL_OES_vertex_array_object GL_QCOM_alpha_test GL_QCOM_binning_control GL_QCOM_driver_control GL_QCOM_perfmon_global_mode GL_QCOM_extended_get GL_QCOM_extended_get2 GL_QCOM_tiled_rendering GL_QCOM_writeonly_rendering GL_EXT_sRGB GL_EXT_sRGB_write_control GL_EXT_texture_sRGB_decode GL_EXT_texture_filter_anisotropic GL_EXT_multisampled_render_to_texture GL_EXT_color_buffer_float GL_EXT_color_buffer_half_float GL_EXT_disjoint_timer_query
20:07:30 T:18446744072509948104   DEBUG: GLES: Extension Support Test - GL_EXT_texture_format_BGRA8888 YES
20:07:30 T:18446744072509948104   DEBUG: GLES: Extension Support Test - GL_IMG_texture_format_BGRA8888 NO
20:07:30 T:18446744072528196240  NOTICE: UDP: Listening on port 9777
20:07:30 T:18446744072509948104   DEBUG: GLES: Extension Support Test - GL_APPLE_texture_format_BGRA8888 NO
20:07:30 T:18446744072520609656   DEBUG: CPythonInvoker(2, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.grab.fanart/service.py): setting the Python path to /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.grab.fanart:/:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python26.zip:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/plat-linux3:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-tk:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-old:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-dynload
20:07:30 T:18446744072525461104   DEBUG: ZeroconfMDNS: identifier: servers.eventserver type: _xbmc-events._udp name:Kodi (localhost) port:9777
20:07:30 T:18446744072509948104   DEBUG: GUI Shader - Tried to Initialise again. Was this intentional?
20:07:30 T:18446744072520609656   DEBUG: CPythonInvoker(2, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.grab.fanart/service.py): entering source directory /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.grab.fanart
20:07:30 T:18446744072520609656   DEBUG: CPythonInvoker(2, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.grab.fanart/service.py): instantiating addon using automatically obtained id of "script.grab.fanart" dependent on version 2.19.0 of the xbmc.python api
20:07:30 T:18446744072527075032  NOTICE: Platinum [platinum.core.ctrlpoint]: Inspecting device "b0351498-1dd1-11b2-98fc-ae52fa5c9393" detected @ http://192.168.0.116:49152/description.xml
20:07:30 T:18446744072527075032    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072509948104   DEBUG: ------ Window Init (Custom_Overlay.xml) ------
20:07:30 T:18446744072509948104    INFO: Loading skin file: Custom_Overlay.xml, load type: KEEP_IN_MEMORY
20:07:30 T:18446744072528161392    INFO: Platinum [neptune.sockets.bsd]: setting multicast interface 192.168.0.115
20:07:30 T:18446744072528161392    INFO: Platinum [neptune.sockets.bsd]: setting multicast TTL to 2
20:07:30 T:18446744072524294120    INFO: Platinum [platinum.core.ctrlpoint]: Received a NOTIFY request from ourselves (ac6dce5a-6047-7862-fd41-e5596960f57a)
20:07:30 T:18446744072520605136    INFO: Previous line repeats 5 times.
20:07:30 T:18446744072520605136   DEBUG: CPythonInvoker(0, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.xbmc.versioncheck/service.py): setting the Python path to /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.xbmc.versioncheck:/:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python26.zip:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/plat-linux3:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-tk:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-old:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-dynload
20:07:30 T:18446744072520605136   DEBUG: CPythonInvoker(0, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.xbmc.versioncheck/service.py): entering source directory /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.xbmc.versioncheck
20:07:30 T:18446744072520605136   DEBUG: CPythonInvoker(0, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.xbmc.versioncheck/service.py): instantiating addon using automatically obtained id of "service.xbmc.versioncheck" dependent on version 2.1.0 of the xbmc.python api
20:07:30 T:18446744072525870832    INFO: Platinum [neptune.sockets.bsd]: setting multicast interface 192.168.0.115
20:07:30 T:18446744072525870832    INFO: Platinum [neptune.sockets.bsd]: setting multicast TTL to 2
20:07:30 T:18446744072524294120    INFO: Platinum [platinum.core.ctrlpoint]: Received a NOTIFY request from ourselves (68298a16-2c03-342e-b90d-a115252cb136)
20:07:30 T:18446744072520606696  NOTICE: -->Python Interpreter Initialized<--
20:07:30 T:18446744072520606696   DEBUG: CPythonInvoker(1, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.nfo.watchedstate.updater/default.py): the source file to load is "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.nfo.watchedstate.updater/default.py"
20:07:30 T:18446744072520607280  NOTICE: -->Python Interpreter Initialized<--
20:07:30 T:18446744072520607280   DEBUG: CPythonInvoker(3, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.library.data.provider/service.py): the source file to load is "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.library.data.provider/service.py"
20:07:30 T:18446744072509948104    INFO: GLES: Enabling VSYNC
20:07:30 T:18446744072509948104    INFO: GLES: Selected vsync mode 10
20:07:30 T:18446744072527188720    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072524294120    INFO: Platinum [platinum.core.ctrlpoint]: Received a NOTIFY request from ourselves (68298a16-2c03-342e-b90d-a115252cb136)
20:07:30 T:18446744072528519064    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.116:58288 for "http://192.168.0.115:1480/DeviceDescription.xml"
                                            GET /DeviceDescription.xml HTTP/1.1
                                            HOST: 192.168.0.115:1480
                                            DATE: Sun, 26 Jun 2016 18:05:58 GMT
                                            CONNECTION: close
                                            USER-AGENT: UPnP/1.0 DLNADOC/1.50
20:07:30 T:18446744072528519064    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:30 GMT
                                            Content-Length: 3434
                                            Content-Type: text/xml; charset="utf-8"
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:30 T:18446744072528519064    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 3434 bytes
20:07:30 T:18446744072527188720    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072529423552    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse SUBSCRIBE request from 192.168.0.116:58289 for "http://192.168.0.115:1480/ConnectionManager/68298a16-2c03-342e-b90d-a115252cb136/event.xml"
                                            SUBSCRIBE /ConnectionManager/68298a16-2c03-342e-b90d-a115252cb136/event.xml HTTP/1.1
                                            HOST: 192.168.0.115:1480
                                            CALLBACK: <http://192.168.0.116:49152/>
                                            NT: upnp:event
                                            TIMEOUT: Second-1801
20:07:30 T:18446744072527188720    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072529423552    INFO: Platinum [platinum.core.service]: New subscription for ConnectionManager/68298a16-2c03-342e-b90d-a115252cb136/event.xml (timeout = 1800)
20:07:30 T:18446744072529423552    INFO: Platinum [platinum.core.event]: Creating new subscriber (uuid:ac6dce5a-6047-7862-fd41-e5596960f57a)
20:07:30 T:18446744072529423552    INFO: Platinum [platinum.core.event]: subscriber (uuid:ac6dce5a-6047-7862-fd41-e5596960f57a) expiring in 1800 seconds
20:07:30 T:18446744072529423552    INFO: Platinum [platinum.core.event]: Adding callback "http://192.168.0.116:49152/" to subscriber uuid:ac6dce5a-6047-7862-fd41-e5596960f57a
20:07:30 T:18446744072529423552    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072529003264    INFO: Previous line repeats 1 times.
20:07:30 T:18446744072529003264    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.116:49152/
20:07:30 T:18446744072529003264    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.116:49152/)
20:07:30 T:18446744072529003264    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072529423552    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            SID: uuid:ac6dce5a-6047-7862-fd41-e5596960f57a
                                            TIMEOUT: Second-1800
                                            Date: Sun, 26 Jun 2016 18:07:30 GMT
                                            Content-Length: 0
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:30 T:18446744072529003264    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:30 T:18446744072529003264    INFO: Platinum [neptune.tls]: TLS connector will connect to 192.168.0.116:49152
20:07:30 T:18446744072529423552    INFO: Platinum [neptune.sockets.bsd]: socket end of stream
20:07:30 T:18446744072528967600    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.115:43782 for "http://192.168.0.115:1480/DeviceDescription.xml"
                                            GET /DeviceDescription.xml HTTP/1.1
                                            Host: 192.168.0.115:1480
                                            Connection: Keep-Alive
                                            User-Agent: Android/5.1.1 UPnP/1.0 Cling/2.0
20:07:30 T:18446744072527188720    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072529423552    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse SUBSCRIBE request from 192.168.0.116:58290 for "http://192.168.0.115:1480/ContentDirectory/68298a16-2c03-342e-b90d-a115252cb136/event.xml"
                                            SUBSCRIBE /ContentDirectory/68298a16-2c03-342e-b90d-a115252cb136/event.xml HTTP/1.1
                                            HOST: 192.168.0.115:1480
                                            CALLBACK: <http://192.168.0.116:49152/>
                                            NT: upnp:event
                                            TIMEOUT: Second-1801
20:07:30 T:18446744072529423552    INFO: Platinum [platinum.core.service]: New subscription for ContentDirectory/68298a16-2c03-342e-b90d-a115252cb136/event.xml (timeout = 1800)
20:07:30 T:18446744072529003264    INFO: Platinum [neptune.http]: got connection (reused: false)
20:07:30 T:18446744072529423552    INFO: Platinum [platinum.core.event]: Creating new subscriber (uuid:24e546d2-e8cf-f0ea-75c9-6dd1e1e87df2)
20:07:30 T:18446744072529003264    INFO: Platinum [neptune.http]: sending body stream, 325 bytes
20:07:30 T:18446744072529423552    INFO: Platinum [platinum.core.event]: subscriber (uuid:24e546d2-e8cf-f0ea-75c9-6dd1e1e87df2) expiring in 1800 seconds
20:07:30 T:18446744072529423552    INFO: Platinum [platinum.core.event]: Adding callback "http://192.168.0.116:49152/" to subscriber uuid:24e546d2-e8cf-f0ea-75c9-6dd1e1e87df2
20:07:30 T:18446744072529423552    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072529003264    INFO: Platinum [platinum.core.http.clienttask]: PLT_HttpClientSocketTask::ProcessResponse (result=0)
20:07:30 T:18446744072529423552    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072530408968    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.116:49152/
20:07:30 T:18446744072530408968    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.116:49152/)
20:07:30 T:18446744072530408968    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:30 T:18446744072530408968    INFO: Platinum [neptune.tls]: TLS connector will connect to 192.168.0.116:49152
20:07:30 T:18446744072529423552    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            SID: uuid:24e546d2-e8cf-f0ea-75c9-6dd1e1e87df2
                                            TIMEOUT: Second-1800
                                            Date: Sun, 26 Jun 2016 18:07:30 GMT
                                            Content-Length: 0
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:30 T:18446744072528967600    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:30 GMT
                                            Content-Length: 3434
                                            Content-Type: text/xml; charset="utf-8"
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:30 T:18446744072528967600    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 3434 bytes
20:07:30 T:18446744072529423552    INFO: Platinum [neptune.sockets.bsd]: socket end of stream
20:07:30 T:18446744072530408968    INFO: Platinum [neptune.http]: got connection (reused: false)
20:07:30 T:18446744072530408968    INFO: Platinum [neptune.http]: sending body stream, 532 bytes
20:07:30 T:18446744072530408968    INFO: Platinum [platinum.core.http.clienttask]: PLT_HttpClientSocketTask::ProcessResponse (result=0)
20:07:30 T:18446744072524294120    INFO: Platinum [platinum.core.ctrlpoint]: Received a NOTIFY request from ourselves (68298a16-2c03-342e-b90d-a115252cb136)
20:07:30 T:18446744072528967600    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.115:43782 for "http://192.168.0.115:1480/X_MS_MediaReceiverRegistrar/68298a16-2c03-342e-b90d-a115252cb136/scpd.xml"
                                            GET /X_MS_MediaReceiverRegistrar/68298a16-2c03-342e-b90d-a115252cb136/scpd.xml HTTP/1.1
                                            Host: 192.168.0.115:1480
                                            Connection: Keep-Alive
                                            User-Agent: Android/5.1.1 UPnP/1.0 Cling/2.0
20:07:30 T:18446744072528967600    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:30 GMT
                                            Content-Length: 2855
                                            Content-Type: text/xml; charset="utf-8"
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:30 T:18446744072528967600    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 2855 bytes
20:07:30 T:18446744072528161392    INFO: Platinum [neptune.sockets.bsd]: setting multicast interface 192.168.0.115
20:07:30 T:18446744072528161392    INFO: Platinum [neptune.sockets.bsd]: setting multicast TTL to 2
20:07:30 T:18446744072524294120    INFO: Platinum [platinum.core.ctrlpoint]: Received a NOTIFY request from ourselves (ac6dce5a-6047-7862-fd41-e5596960f57a)
20:07:30 T:18446744072527188720    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:30 T:18446744072532337376    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.103:49271 for "http://192.168.0.115:1480/DeviceDescription.xml"
                                            GET /DeviceDescription.xml HTTP/1.1
                                            Cache-Control: no-cache
                                            Connection: Close
                                            Pragma: no-cache
                                            Accept: text/xml, application/xml
                                            Host: 192.168.0.115:1480
                                            User-Agent: Microsoft-Windows/6.1 UPnP/1.0 Windows-Media-Player-DMS/12.0.7601.17514 DLNADOC/1.50
20:07:31 T:18446744072532337376    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 3461
                                            Content-Type: text/xml; charset="utf-8"
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072532337376    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 3461 bytes
20:07:31 T:18446744072524294120    INFO: Platinum [platinum.core.ctrlpoint]: Received a NOTIFY request from ourselves (68298a16-2c03-342e-b90d-a115252cb136)
20:07:31 T:18446744072520900024  NOTICE: -->Python Interpreter Initialized<--
20:07:31 T:18446744072520900024   DEBUG: CPythonInvoker(4, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.common.plugin.cache/default.py): the source file to load is "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.common.plugin.cache/default.py"
20:07:31 T:18446744072520606696   DEBUG: CPythonInvoker(1, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.nfo.watchedstate.updater/default.py): setting the Python path to /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.nfo.watchedstate.updater:/:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python26.zip:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/plat-linux3:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-tk:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-old:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-dynload
20:07:31 T:18446744072520606696   DEBUG: CPythonInvoker(1, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.nfo.watchedstate.updater/default.py): entering source directory /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.nfo.watchedstate.updater
20:07:31 T:18446744072520606696   DEBUG: CPythonInvoker(1, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.nfo.watchedstate.updater/default.py): instantiating addon using automatically obtained id of "service.nfo.watchedstate.updater" dependent on version 2.1.0 of the xbmc.python api
20:07:31 T:18446744072524294120    INFO: Platinum [platinum.core.ctrlpoint]: Received a NOTIFY request from ourselves (ac6dce5a-6047-7862-fd41-e5596960f57a)
20:07:31 T:18446744072528967600    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.115:43782 for "http://192.168.0.115:1480/ContentDirectory/68298a16-2c03-342e-b90d-a115252cb136/scpd.xml"
                                            GET /ContentDirectory/68298a16-2c03-342e-b90d-a115252cb136/scpd.xml HTTP/1.1
                                            Host: 192.168.0.115:1480
                                            Connection: Keep-Alive
                                            User-Agent: Android/5.1.1 UPnP/1.0 Cling/2.0
20:07:31 T:18446744072527188720    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072528967600    INFO: Previous line repeats 1 times.
20:07:31 T:18446744072528967600    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 7848
                                            Content-Type: text/xml; charset="utf-8"
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072532777616    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.116:37448 for "http://192.168.0.115:1036/"
                                            GET / HTTP/1.1
                                            HOST: 192.168.0.115:1036
                                            DATE: Sun, 26 Jun 2016 18:05:58 GMT
                                            CONNECTION: close
                                            USER-AGENT: UPnP/1.0 DLNADOC/1.50
20:07:31 T:18446744072532838464    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.116:58291 for "http://192.168.0.115:1480/DeviceDescription.xml"
                                            GET /DeviceDescription.xml HTTP/1.1
                                            HOST: 192.168.0.115:1480
                                            DATE: Sun, 26 Jun 2016 18:05:58 GMT
                                            CONNECTION: close
                                            USER-AGENT: UPnP/1.0 DLNADOC/1.50
20:07:31 T:18446744072528967600    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 7848 bytes
20:07:31 T:18446744072532777616    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 3355
                                            Content-Type: text/xml; charset="utf-8"
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072532777616    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 3355 bytes
20:07:31 T:18446744072527188720    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072532682584    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.103:49272 for "http://192.168.0.115:1480/icon48x48.png"
                                            GET /icon48x48.png HTTP/1.1
                                            Connection: Keep-Alive
                                            User-Agent: Windows-Media-Player-DMS/12.0.7601.17514
                                            Host: 192.168.0.115:1480
20:07:31 T:18446744072532838464    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 3440
                                            Content-Type: text/xml; charset="utf-8"
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072532682584    INFO: Platinum [neptune.http]: filename = /data/data/org.xbmc.kodi/cache/apk/assets/media//icon48x48.png
20:07:31 T:18446744072532682584    INFO: Platinum [neptune.http]: extension=png
20:07:31 T:18446744072532682584    INFO: Platinum [neptune.http]: using type from default list: image/png
20:07:31 T:18446744072532682584    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Accept-Ranges: bytes
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 16843
                                            Content-Type: image/png
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072532682584    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 16843 bytes
20:07:31 T:18446744072532838464    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 3440 bytes
20:07:31 T:18446744072524294120    INFO: Platinum [platinum.core.ctrlpoint]: Received a NOTIFY request from ourselves (68298a16-2c03-342e-b90d-a115252cb136)
20:07:31 T:18446744072524294120    INFO: Platinum [platinum.core.ctrlpoint]: Received a NOTIFY request from ourselves (ac6dce5a-6047-7862-fd41-e5596960f57a)
20:07:31 T:18446744072524577560    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072532642640    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.115:56595 for "http://192.168.0.115:1036/"
                                            GET / HTTP/1.1
                                            Host: 192.168.0.115:1036
                                            Connection: Keep-Alive
                                            User-Agent: Android/5.1.1 UPnP/1.0 Cling/2.0
20:07:31 T:18446744072532642640    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 3355
                                            Content-Type: text/xml; charset="utf-8"
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072532642640    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 3355 bytes
20:07:31 T:18446744072532642640    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.115:56595 for "http://192.168.0.115:1036/AVTransport/ac6dce5a-6047-7862-fd41-e5596960f57a/scpd.xml"
                                            GET /AVTransport/ac6dce5a-6047-7862-fd41-e5596960f57a/scpd.xml HTTP/1.1
                                            Host: 192.168.0.115:1036
                                            Connection: Keep-Alive
                                            User-Agent: Android/5.1.1 UPnP/1.0 Cling/2.0
20:07:31 T:18446744072524294120    INFO: Platinum [platinum.core.ctrlpoint]: Received a NOTIFY request from ourselves (68298a16-2c03-342e-b90d-a115252cb136)
20:07:31 T:18446744072532642640    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 17638
                                            Content-Type: text/xml; charset="utf-8"
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072532642640    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 17638 bytes
20:07:31 T:18446744072524294120    INFO: Platinum [platinum.core.ctrlpoint]: Received a NOTIFY request from ourselves (ac6dce5a-6047-7862-fd41-e5596960f57a)
20:07:31 T:18446744072524577560    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072533851864    INFO: Previous line repeats 1 times.
20:07:31 T:18446744072533851864    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.116:37449 for "http://192.168.0.115:1036/"
                                            GET / HTTP/1.1
                                            HOST: 192.168.0.115:1036
                                            DATE: Sun, 26 Jun 2016 18:05:59 GMT
                                            CONNECTION: close
                                            USER-AGENT: UPnP/1.0 DLNADOC/1.50
20:07:31 T:18446744072533851864    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 3355
                                            Content-Type: text/xml; charset="utf-8"
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072533851864    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 3355 bytes
20:07:31 T:18446744072533857432    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.116:58294 for "http://192.168.0.115:1480/DeviceDescription.xml"
                                            GET /DeviceDescription.xml HTTP/1.1
                                            HOST: 192.168.0.115:1480
                                            DATE: Sun, 26 Jun 2016 18:05:59 GMT
                                            CONNECTION: close
                                            USER-AGENT: UPnP/1.0 DLNADOC/1.50
20:07:31 T:18446744072533857432    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 3440
                                            Content-Type: text/xml; charset="utf-8"
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072533857432    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 3440 bytes
20:07:31 T:18446744072527317616    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.118/Canon_basic.xml
20:07:31 T:18446744072527317616    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.118:80/Canon_basic.xml)
20:07:31 T:18446744072527317616    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:31 T:18446744072527317616    INFO: Platinum [neptune.tls]: TLS connector will connect to 192.168.0.118:80
20:07:31 T:18446744072527317616    INFO: Platinum [neptune.http]: got connection (reused: false)
20:07:31 T:18446744072520900024   DEBUG: CPythonInvoker(4, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.common.plugin.cache/default.py): setting the Python path to /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.common.plugin.cache:/:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python26.zip:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/plat-linux3:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-tk:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-old:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-dynload
20:07:31 T:18446744072520900024   DEBUG: CPythonInvoker(4, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.common.plugin.cache/default.py): entering source directory /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.common.plugin.cache
20:07:31 T:18446744072520903240  NOTICE: -->Python Interpreter Initialized<--
20:07:31 T:18446744072520903240   DEBUG: CPythonInvoker(5, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.xbmcbackup/scheduler.py): the source file to load is "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.xbmcbackup/scheduler.py"
20:07:31 T:18446744072527301936    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.103:2869/upnphost/udhisapi.dll?content=uuid:0d4a5572-53bb-4b26-9f92-39264db28933
20:07:31 T:18446744072527301936    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.103:2869/upnphost/udhisapi.dll?content=uuid:0d4a5572-53bb-4b26-9f92-39264db28933)
20:07:31 T:18446744072527301936    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:31 T:18446744072527301936    INFO: Platinum [neptune.tls]: TLS connector will connect to 192.168.0.103:2869
20:07:31 T:18446744072527301936    INFO: Platinum [neptune.http]: got connection (reused: false)
20:07:31 T:18446744072520900024   DEBUG: CPythonInvoker(4, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.common.plugin.cache/default.py): instantiating addon using automatically obtained id of "script.common.plugin.cache" dependent on version 2.1.0 of the xbmc.python api
20:07:31 T:18446744072527301936  NOTICE: Platinum [platinum.core.ctrlpoint]: Device "0d4a5572-53bb-4b26-9f92-39264db28933" is now known as "NECROMANCER: Artaios:" (http://192.168.0.103:2869/upnphost/udhisapi.dll?content=uuid:0d4a5572-53bb-4b26-9f92-39264db28933)
20:07:31 T:18446744072527301936    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072527317616  NOTICE: Platinum [platinum.core.ctrlpoint]: Device "00000000-0000-1000-8000-60128B472E0A" is now known as "Canon-Fax UPnP" (http://192.168.0.118/Canon_basic.xml)
20:07:31 T:18446744072527317616    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072524294120    INFO: Platinum [platinum.core.ctrlpoint]: Received a NOTIFY request from ourselves (ac6dce5a-6047-7862-fd41-e5596960f57a)
20:07:31 T:18446744072520607280   DEBUG: CPythonInvoker(3, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.library.data.provider/service.py): setting the Python path to /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.library.data.provider:/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.module.simplejson/lib:/:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python26.zip:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/plat-linux3:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-tk:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-old:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-dynload
20:07:31 T:18446744072520607280   DEBUG: CPythonInvoker(3, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.library.data.provider/service.py): entering source directory /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.library.data.provider
20:07:31 T:18446744072520607280   DEBUG: CPythonInvoker(3, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.library.data.provider/service.py): instantiating addon using automatically obtained id of "service.library.data.provider" dependent on version 2.1.0 of the xbmc.python api
20:07:31 T:18446744072524577560    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072535269712    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.116:37451 for "http://192.168.0.115:1036/"
                                            GET / HTTP/1.1
                                            HOST: 192.168.0.115:1036
                                            DATE: Sun, 26 Jun 2016 18:05:59 GMT
                                            CONNECTION: close
                                            USER-AGENT: UPnP/1.0 DLNADOC/1.50
20:07:31 T:18446744072528999768    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.116:49152/description.xml
20:07:31 T:18446744072528999768    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.116:49152/description.xml)
20:07:31 T:18446744072528999768    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:31 T:18446744072528999768    INFO: Platinum [neptune.tls]: TLS connector will connect to 192.168.0.116:49152
20:07:31 T:18446744072524294120    INFO: Platinum [platinum.core.ctrlpoint]: Received a NOTIFY request from ourselves (ac6dce5a-6047-7862-fd41-e5596960f57a)
20:07:31 T:18446744072528999768    INFO: Platinum [neptune.http]: got connection (reused: false)
20:07:31 T:18446744072535269712    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 3355
                                            Content-Type: text/xml; charset="utf-8"
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072535269712    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 3355 bytes
20:07:31 T:18446744072528999768  NOTICE: Platinum [platinum.core.ctrlpoint]: Device "b0351498-1dd1-11b2-98fc-ae52fa5c9393" is now known as "NT667_EU(192.168.0.116)" (http://192.168.0.116:49152/description.xml)
20:07:31 T:18446744072528999768    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072520903240   DEBUG: CPythonInvoker(5, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.xbmcbackup/scheduler.py): setting the Python path to /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.xbmcbackup:/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.module.googleapi/lib:/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.module.httplib2/lib:/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.module.oauth2client/lib:/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.module.six/lib:/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.module.uritemplate/lib:/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.module.yaml/lib:/:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python26.zip:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/plat-linux3:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-tk:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-old:/data/app/org.xbmc.kodi-1.apk/assets/python2.6/lib/python2.6/lib-dynload
20:07:31 T:18446744072520903240   DEBUG: CPythonInvoker(5, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.xbmcbackup/scheduler.py): entering source directory /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.xbmcbackup
20:07:31 T:18446744072520605136   DEBUG: Version Check: Version 0.3.19 started
20:07:31 T:18446744072520903240   DEBUG: CPythonInvoker(5, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.xbmcbackup/scheduler.py): instantiating addon using automatically obtained id of "script.xbmcbackup" dependent on version 2.19.0 of the xbmc.python api
20:07:31 T:18446744072534639472    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.103:2869/upnphost/udhisapi.dll?content=uuid:f3aaf942-aeed-4105-874e-d09e29f8c94c
20:07:31 T:18446744072534639472    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.103:2869/upnphost/udhisapi.dll?content=uuid:f3aaf942-aeed-4105-874e-d09e29f8c94c)
20:07:31 T:18446744072534639472    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:31 T:18446744072534639472    INFO: Platinum [neptune.tls]: reusing connection
20:07:31 T:18446744072534639472    INFO: Platinum [neptune.http]: got connection (reused: true)
20:07:31 T:18446744072522310360   DEBUG: int CVideoDatabase::RunQuery(const string&) took 564 ms for 10 items query: select * from episode_view  ORDER BY dateAdded desc, idEpisode desc LIMIT 10
20:07:31 T:18446744072534589208    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.118/DPSConnectionManagerSCPD.xml
20:07:31 T:18446744072534589208    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.118:80/DPSConnectionManagerSCPD.xml)
20:07:31 T:18446744072534589208    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:31 T:18446744072534589208    INFO: Platinum [neptune.tls]: TLS connector will connect to 192.168.0.118:80
20:07:31 T:18446744072534639472    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.103:2869/upnphost/udhisapi.dll?content=uuid:af746415-9dc1-4ee5-b40a-81281bd6a86e
20:07:31 T:18446744072534639472    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.103:2869/upnphost/udhisapi.dll?content=uuid:af746415-9dc1-4ee5-b40a-81281bd6a86e)
20:07:31 T:18446744072534639472    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:31 T:18446744072534639472    INFO: Platinum [neptune.tls]: reusing connection
20:07:31 T:18446744072534589208    INFO: Platinum [neptune.http]: got connection (reused: false)
20:07:31 T:18446744072534639472    INFO: Platinum [neptune.http]: got connection (reused: true)
20:07:31 T:18446744072534639472    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.103:2869/upnphost/udhisapi.dll?content=uuid:de22dd15-68c1-417e-bdc8-e7ea1750a4cc
20:07:31 T:18446744072534639472    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.103:2869/upnphost/udhisapi.dll?content=uuid:de22dd15-68c1-417e-bdc8-e7ea1750a4cc)
20:07:31 T:18446744072534639472    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:31 T:18446744072534639472    INFO: Platinum [neptune.tls]: reusing connection
20:07:31 T:18446744072534639472    INFO: Platinum [neptune.http]: got connection (reused: true)
20:07:31 T:18446744072534639472    INFO: Platinum [platinum.media.server.browser]: Device Found: Device GUID: 0d4a5572-53bb-4b26-9f92-39264db28933Device Type: urn:schemas-upnp-org:device:MediaServer:1Device Base Url: http://192.168.0.103:2869/upnphost/Device Friendly Name: NECROMANCER: Artaios:
20:07:31 T:18446744072534639472  NOTICE: Platinum [platinum.core.ctrlpoint]: Subscribing to service "urn:upnp-org:serviceId:ContentDirectory" of device "NECROMANCER: Artaios:"
20:07:31 T:18446744072534639472    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072535295840    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.103:2869/upnphost/udhisapi.dll?event=uuid:0d4a5572-53bb-4b26-9f92-39264db28933+urn:upnp-org:serviceId:ContentDirectory
20:07:31 T:18446744072534639472  NOTICE: Platinum [platinum.core.ctrlpoint]: Subscribing to service "urn:upnp-org:serviceId:ConnectionManager" of device "NECROMANCER: Artaios:"
20:07:31 T:18446744072535295840    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.103:2869/upnphost/udhisapi.dll?event=uuid:0d4a5572-53bb-4b26-9f92-39264db28933+urn:upnp-org:serviceId:ContentDirectory)
20:07:31 T:18446744072534639472    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072535295840    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:31 T:18446744072535295840    INFO: Platinum [neptune.tls]: reusing connection
20:07:31 T:18446744072536054784    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.103:2869/upnphost/udhisapi.dll?event=uuid:0d4a5572-53bb-4b26-9f92-39264db28933+urn:upnp-org:serviceId:ConnectionManager
20:07:31 T:18446744072535295840    INFO: Platinum [neptune.http]: got connection (reused: true)
20:07:31 T:18446744072536054784    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.103:2869/upnphost/udhisapi.dll?event=uuid:0d4a5572-53bb-4b26-9f92-39264db28933+urn:upnp-org:serviceId:ConnectionManager)
20:07:31 T:18446744072536054784    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:31 T:18446744072536054784    INFO: Platinum [neptune.tls]: TLS connector will connect to 192.168.0.103:2869
20:07:31 T:18446744072536054784    INFO: Platinum [neptune.http]: got connection (reused: false)
20:07:31 T:18446744072535295840  NOTICE: Platinum [platinum.core.ctrlpoint]: Creating new subscriber "uuid:7e1892a4-c463-4cae-83d8-0154807ad2ec" for service "urn:upnp-org:serviceId:ContentDirectory" of device "NECROMANCER: Artaios:" (timeout = 300)
20:07:31 T:18446744072535295840    INFO: Platinum [platinum.core.event]: Creating new subscriber (uuid:7e1892a4-c463-4cae-83d8-0154807ad2ec)
20:07:31 T:18446744072535295840    INFO: Platinum [platinum.core.event]: subscriber (uuid:7e1892a4-c463-4cae-83d8-0154807ad2ec) expiring in 300 seconds
20:07:31 T:18446744072536054784  NOTICE: Platinum [platinum.core.ctrlpoint]: Creating new subscriber "uuid:f8020c51-752e-48a4-9082-dce035cf6a18" for service "urn:upnp-org:serviceId:ConnectionManager" of device "NECROMANCER: Artaios:" (timeout = 300)
20:07:31 T:18446744072527031824    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072536054784    INFO: Platinum [platinum.core.event]: Creating new subscriber (uuid:f8020c51-752e-48a4-9082-dce035cf6a18)
20:07:31 T:18446744072536054784    INFO: Platinum [platinum.core.event]: subscriber (uuid:f8020c51-752e-48a4-9082-dce035cf6a18) expiring in 300 seconds
20:07:31 T:18446744072527031824    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072536050608    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse NOTIFY request from 192.168.0.103:49273 for "http://192.168.0.115:1486/0d4a5572-53bb-4b26-9f92-39264db28933/urn:upnp-org:serviceId:ContentDirectory"
                                            NOTIFY /0d4a5572-53bb-4b26-9f92-39264db28933/urn:upnp-org:serviceId:ContentDirectory HTTP/1.1
                                            Cache-Control: no-cache
                                            Connection: Close
                                            Pragma: no-cache
                                            Content-Type: text/xml; charset="utf-8"
                                            User-Agent: Microsoft-Windows/6.1 UPnP/1.0
                                            NT: upnp:event
                                            NTS: upnp:propchange
                                            SID: uuid:7e1892a4-c463-4cae-83d8-0154807ad2ec
                                            SEQ: 0
                                            Content-Length: 481
                                            Host: 192.168.0.115:1486
20:07:31 T:18446744072536050608    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 0
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072536059536    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse NOTIFY request from 192.168.0.103:49274 for "http://192.168.0.115:1486/0d4a5572-53bb-4b26-9f92-39264db28933/urn:upnp-org:serviceId:ConnectionManager"
                                            NOTIFY /0d4a5572-53bb-4b26-9f92-39264db28933/urn:upnp-org:serviceId:ConnectionManager HTTP/1.1
                                            Cache-Control: no-cache
                                            Connection: Close
                                            Pragma: no-cache
                                            Content-Type: text/xml; charset="utf-8"
                                            User-Agent: Microsoft-Windows/6.1 UPnP/1.0
                                            NT: upnp:event
                                            NTS: upnp:propchange
                                            SID: uuid:f8020c51-752e-48a4-9082-dce035cf6a18
                                            SEQ: 0
                                            Content-Length: 883
                                            Host: 192.168.0.115:1486
20:07:31 T:18446744072536059536    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 0
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072524577560    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072536170328    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.116:37452 for "http://192.168.0.115:1036/"
                                            GET / HTTP/1.1
                                            HOST: 192.168.0.115:1036
                                            DATE: Sun, 26 Jun 2016 18:05:59 GMT
                                            CONNECTION: close
                                            USER-AGENT: UPnP/1.0 DLNADOC/1.50
20:07:31 T:18446744072536170328    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 3355
                                            Content-Type: text/xml; charset="utf-8"
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072536170328    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 3355 bytes
20:07:31 T:18446744072528967600    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.115:43782 for "http://192.168.0.115:1480/ConnectionManager/68298a16-2c03-342e-b90d-a115252cb136/scpd.xml"
                                            GET /ConnectionManager/68298a16-2c03-342e-b90d-a115252cb136/scpd.xml HTTP/1.1
                                            Host: 192.168.0.115:1480
                                            Connection: Keep-Alive
                                            User-Agent: Android/5.1.1 UPnP/1.0 Cling/2.0
20:07:31 T:18446744072528967600    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 4541
                                            Content-Type: text/xml; charset="utf-8"
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072528967600    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 4541 bytes
20:07:31 T:18446744072535434496    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.116:49152/rcr.xml
20:07:31 T:18446744072535434496    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.116:49152/rcr.xml)
20:07:31 T:18446744072535434496    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:31 T:18446744072535434496    INFO: Platinum [neptune.tls]: TLS connector will connect to 192.168.0.116:49152
20:07:31 T:18446744072535434496    INFO: Platinum [neptune.http]: got connection (reused: false)
20:07:31 T:18446744072522310360   DEBUG: int CVideoDatabase::RunQuery(const string&) took 2 ms for 0 items query: select * from musicvideo_view  ORDER BY dateAdded desc, idMVideo desc LIMIT 10
20:07:31 T:18446744072535434496    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.116:49152/cmr.xml
20:07:31 T:18446744072535434496    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.116:49152/cmr.xml)
20:07:31 T:18446744072535434496    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:31 T:18446744072535434496    INFO: Platinum [neptune.tls]: TLS connector will connect to 192.168.0.116:49152
20:07:31 T:18446744072535434496    INFO: Platinum [neptune.http]: got connection (reused: false)
20:07:31 T:18446744072522310360   DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
20:07:31 T:18446744072535434496    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.116:49152/avt.xml
20:07:31 T:18446744072535434496    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.116:49152/avt.xml)
20:07:31 T:18446744072535434496    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:31 T:18446744072535434496    INFO: Platinum [neptune.tls]: TLS connector will connect to 192.168.0.116:49152
20:07:31 T:18446744072535434496    INFO: Platinum [neptune.http]: got connection (reused: false)
20:07:31 T:18446744072528197736   DEBUG: JSONRPC Server: New connection detected
20:07:31 T:18446744072528197736    INFO: JSONRPC Server: New connection added
20:07:31 T:18446744072524577560    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072524630776    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.103:49275 for "http://192.168.0.115:1036/"
                                            GET / HTTP/1.1
                                            Cache-Control: no-cache
                                            Connection: Close
                                            Pragma: no-cache
                                            Accept: text/xml, application/xml
                                            Host: 192.168.0.115:1036
                                            User-Agent: Microsoft-Windows/6.1 UPnP/1.0 Windows-Media-Player-DMS/12.0.7601.17514 DLNADOC/1.50
20:07:31 T:18446744072524630776    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 3355
                                            Content-Type: text/xml; charset="utf-8"
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072524630776    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 3355 bytes
20:07:31 T:18446744072524577560    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072524630776    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.103:49276 for "http://192.168.0.115:1036/AVTransport/ac6dce5a-6047-7862-fd41-e5596960f57a/scpd.xml"
                                            GET /AVTransport/ac6dce5a-6047-7862-fd41-e5596960f57a/scpd.xml HTTP/1.1
                                            Cache-Control: no-cache
                                            Connection: Close
                                            Pragma: no-cache
                                            Accept: text/xml, application/xml
                                            User-Agent: Microsoft-Windows/6.1 UPnP/1.0 Windows-Media-Player-DMS/12.0.7601.17514 DLNADOC/1.50
                                            Host: 192.168.0.115:1036
20:07:31 T:18446744072524630776    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 17638
                                            Content-Type: text/xml; charset="utf-8"
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072524630776    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 17638 bytes
20:07:31 T:18446744072524577560    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072535849296    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse SUBSCRIBE request from 192.168.0.103:49277 for "http://192.168.0.115:1036/AVTransport/ac6dce5a-6047-7862-fd41-e5596960f57a/event.xml"
                                            SUBSCRIBE /AVTransport/ac6dce5a-6047-7862-fd41-e5596960f57a/event.xml HTTP/1.1
                                            Cache-Control: no-cache
                                            Connection: Close
                                            Pragma: no-cache
                                            User-Agent: Microsoft-Windows/6.1 UPnP/1.0
                                            NT: upnp:event
                                            Callback: <http://192.168.0.103:2869/upnp/eventing/tcunnwoueu>
                                            Timeout: Second-1800
                                            Host: 192.168.0.115:1036
20:07:31 T:18446744072535849296    INFO: Platinum [platinum.core.service]: New subscription for AVTransport/ac6dce5a-6047-7862-fd41-e5596960f57a/event.xml (timeout = 1800)
20:07:31 T:18446744072535849296    INFO: Platinum [platinum.core.event]: Creating new subscriber (uuid:24e546d2-e8cf-f0ea-75c9-6dd1e1e87df2)
20:07:31 T:18446744072535849296    INFO: Platinum [platinum.core.event]: subscriber (uuid:24e546d2-e8cf-f0ea-75c9-6dd1e1e87df2) expiring in 1800 seconds
20:07:31 T:18446744072535849296    INFO: Platinum [platinum.core.event]: Adding callback "http://192.168.0.103:2869/upnp/eventing/tcunnwoueu" to subscriber uuid:24e546d2-e8cf-f0ea-75c9-6dd1e1e87df2
20:07:31 T:18446744072535849296    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072534212456    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.103:2869/upnp/eventing/tcunnwoueu
20:07:31 T:18446744072535849296    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072534212456    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.103:2869/upnp/eventing/tcunnwoueu)
20:07:31 T:18446744072534212456    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:31 T:18446744072534212456    INFO: Platinum [neptune.tls]: reusing connection
20:07:31 T:18446744072534212456    INFO: Platinum [neptune.http]: got connection (reused: true)
20:07:31 T:18446744072534212456    INFO: Platinum [neptune.http]: sending body stream, 1243 bytes
20:07:31 T:18446744072535849296    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            SID: uuid:24e546d2-e8cf-f0ea-75c9-6dd1e1e87df2
                                            TIMEOUT: Second-1800
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 0
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072534212456    INFO: Platinum [platinum.core.http.clienttask]: PLT_HttpClientSocketTask::ProcessResponse (result=0)
20:07:31 T:18446744072524577560    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072535849296    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.103:49278 for "http://192.168.0.115:1036/ConnectionManager/ac6dce5a-6047-7862-fd41-e5596960f57a/scpd.xml"
                                            GET /ConnectionManager/ac6dce5a-6047-7862-fd41-e5596960f57a/scpd.xml HTTP/1.1
                                            Cache-Control: no-cache
                                            Connection: Close
                                            Pragma: no-cache
                                            Accept: text/xml, application/xml
                                            User-Agent: Microsoft-Windows/6.1 UPnP/1.0 Windows-Media-Player-DMS/12.0.7601.17514 DLNADOC/1.50
                                            Host: 192.168.0.115:1036
20:07:31 T:18446744072532642640    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.115:56595 for "http://192.168.0.115:1036/ConnectionManager/ac6dce5a-6047-7862-fd41-e5596960f57a/scpd.xml"
                                            GET /ConnectionManager/ac6dce5a-6047-7862-fd41-e5596960f57a/scpd.xml HTTP/1.1
                                            Host: 192.168.0.115:1036
                                            Connection: Keep-Alive
                                            User-Agent: Android/5.1.1 UPnP/1.0 Cling/2.0
20:07:31 T:18446744072535849296    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 4541
                                            Content-Type: text/xml; charset="utf-8"
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072535849296    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 4541 bytes
20:07:31 T:18446744072532642640    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 4541
                                            Content-Type: text/xml; charset="utf-8"
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072532642640    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 4541 bytes
20:07:31 T:18446744072524577560    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072532508200    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse SUBSCRIBE request from 192.168.0.103:49279 for "http://192.168.0.115:1036/ConnectionManager/ac6dce5a-6047-7862-fd41-e5596960f57a/event.xml"
                                            SUBSCRIBE /ConnectionManager/ac6dce5a-6047-7862-fd41-e5596960f57a/event.xml HTTP/1.1
                                            Cache-Control: no-cache
                                            Connection: Close
                                            Pragma: no-cache
                                            User-Agent: Microsoft-Windows/6.1 UPnP/1.0
                                            NT: upnp:event
                                            Callback: <http://192.168.0.103:2869/upnp/eventing/xhbpzxnisk>
                                            Timeout: Second-1800
                                            Host: 192.168.0.115:1036
20:07:31 T:18446744072532508200    INFO: Platinum [platinum.core.service]: New subscription for ConnectionManager/ac6dce5a-6047-7862-fd41-e5596960f57a/event.xml (timeout = 1800)
20:07:31 T:18446744072532508200    INFO: Platinum [platinum.core.event]: Creating new subscriber (uuid:e0a1029e-a48b-bca6-3185-299dada439be)
20:07:31 T:18446744072532508200    INFO: Platinum [platinum.core.event]: subscriber (uuid:e0a1029e-a48b-bca6-3185-299dada439be) expiring in 1800 seconds
20:07:31 T:18446744072532508200    INFO: Platinum [platinum.core.event]: Adding callback "http://192.168.0.103:2869/upnp/eventing/xhbpzxnisk" to subscriber uuid:e0a1029e-a48b-bca6-3185-299dada439be
20:07:31 T:18446744072532508200    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072535849296    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.103:2869/upnp/eventing/xhbpzxnisk
20:07:31 T:18446744072532508200    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072535849296    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.103:2869/upnp/eventing/xhbpzxnisk)
20:07:31 T:18446744072535849296    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:31 T:18446744072535849296    INFO: Platinum [neptune.tls]: reusing connection
20:07:31 T:18446744072535849296    INFO: Platinum [neptune.http]: got connection (reused: true)
20:07:31 T:18446744072535849296    INFO: Platinum [neptune.http]: sending body stream, 2608 bytes
20:07:31 T:18446744072532508200    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            SID: uuid:e0a1029e-a48b-bca6-3185-299dada439be
                                            TIMEOUT: Second-1800
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 0
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072535849296    INFO: Platinum [platinum.core.http.clienttask]: PLT_HttpClientSocketTask::ProcessResponse (result=0)
20:07:31 T:18446744072524577560    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072532508200    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.103:49280 for "http://192.168.0.115:1036/RenderingControl/ac6dce5a-6047-7862-fd41-e5596960f57a/scpd.xml"
                                            GET /RenderingControl/ac6dce5a-6047-7862-fd41-e5596960f57a/scpd.xml HTTP/1.1
                                            Cache-Control: no-cache
                                            Connection: Close
                                            Pragma: no-cache
                                            Accept: text/xml, application/xml
                                            User-Agent: Microsoft-Windows/6.1 UPnP/1.0 Windows-Media-Player-DMS/12.0.7601.17514 DLNADOC/1.50
                                            Host: 192.168.0.115:1036
20:07:31 T:18446744072532508200    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 6959
                                            Content-Type: text/xml; charset="utf-8"
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072532508200    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 6959 bytes
20:07:31 T:18446744072525180120   DEBUG: ZeroconfMDNS: Kodi (localhost)._http._tcp.local. registration removed
20:07:31 T:18446744072525180120   DEBUG: ZeroconfMDNS: Kodi (localhost)._xbmc-jsonrpc-h._tcp.local. registration removed
20:07:31 T:18446744072525180120   DEBUG: ZeroconfMDNS: Kodi (localhost)._xbmc-jsonrpc._tcp.local. registration removed
20:07:31 T:18446744072525180120   DEBUG: ZeroconfMDNS: Kodi (localhost)._xbmc-events._udp.local. registration removed
20:07:31 T:18446744072524577560    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072532508200    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse SUBSCRIBE request from 192.168.0.103:49281 for "http://192.168.0.115:1036/RenderingControl/ac6dce5a-6047-7862-fd41-e5596960f57a/event.xml"
                                            SUBSCRIBE /RenderingControl/ac6dce5a-6047-7862-fd41-e5596960f57a/event.xml HTTP/1.1
                                            Cache-Control: no-cache
                                            Connection: Close
                                            Pragma: no-cache
                                            User-Agent: Microsoft-Windows/6.1 UPnP/1.0
                                            NT: upnp:event
                                            Callback: <http://192.168.0.103:2869/upnp/eventing/gpjslouvjx>
                                            Timeout: Second-1800
                                            Host: 192.168.0.115:1036
20:07:31 T:18446744072532508200    INFO: Platinum [platinum.core.service]: New subscription for RenderingControl/ac6dce5a-6047-7862-fd41-e5596960f57a/event.xml (timeout = 1800)
20:07:31 T:18446744072532508200    INFO: Platinum [platinum.core.event]: Creating new subscriber (uuid:e0a1029e-a48b-bca6-3185-299dada439be)
20:07:31 T:18446744072532508200    INFO: Platinum [platinum.core.event]: subscriber (uuid:e0a1029e-a48b-bca6-3185-299dada439be) expiring in 1800 seconds
20:07:31 T:18446744072532508200    INFO: Platinum [platinum.core.event]: Adding callback "http://192.168.0.103:2869/upnp/eventing/gpjslouvjx" to subscriber uuid:e0a1029e-a48b-bca6-3185-299dada439be
20:07:31 T:18446744072532508200    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072537235528    INFO: Previous line repeats 1 times.
20:07:31 T:18446744072537235528    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.103:2869/upnp/eventing/gpjslouvjx
20:07:31 T:18446744072537235528    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.103:2869/upnp/eventing/gpjslouvjx)
20:07:31 T:18446744072532508200    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            SID: uuid:e0a1029e-a48b-bca6-3185-299dada439be
                                            TIMEOUT: Second-1800
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 0
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072537235528    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:31 T:18446744072537235528    INFO: Platinum [neptune.tls]: TLS connector will connect to 192.168.0.103:2869
20:07:31 T:18446744072537235528    INFO: Platinum [neptune.http]: got connection (reused: false)
20:07:31 T:18446744072537235528    INFO: Platinum [neptune.http]: sending body stream, 448 bytes
20:07:31 T:18446744072537235528    INFO: Platinum [platinum.core.http.clienttask]: PLT_HttpClientSocketTask::ProcessResponse (result=0)
20:07:31 T:18446744072520609656  NOTICE: script.grab.fanart: Grab Fanart Service Started
20:07:31 T:18446744072520609656   DEBUG: script.grab.fanart: media type is: random
20:07:31 T:18446744072520609656   DEBUG: JSONRPC: Incoming request: { "jsonrpc" : "2.0" , "method" : "VideoLibrary.GetMovies" , "params" : {"properties":["title","art","year","file","plot"]} , "id":1 }
20:07:31 T:18446744072520900024  NOTICE:  StorageServer Module loaded RUN
20:07:31 T:18446744072524577560    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:31 T:18446744072520900024  NOTICE: StorageClient-2.5.4 Starting server
20:07:31 T:18446744072537569552    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.103:49282 for "http://192.168.0.115:1036/icon48x48.png"
                                            GET /icon48x48.png HTTP/1.1
                                            Connection: Keep-Alive
                                            User-Agent: Windows-Media-Player-DMS/12.0.7601.17514
                                            Host: 192.168.0.115:1036
20:07:31 T:18446744072537569552    INFO: Platinum [neptune.http]: filename = /data/data/org.xbmc.kodi/cache/apk/assets/media//icon48x48.png
20:07:31 T:18446744072537569552    INFO: Platinum [neptune.http]: extension=png
20:07:31 T:18446744072537569552    INFO: Platinum [neptune.http]: using type from default list: image/png
20:07:31 T:18446744072537569552    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Accept-Ranges: bytes
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 16843
                                            Content-Type: image/png
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072537569552    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 16843 bytes
20:07:31 T:18446744072532642640    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.115:56595 for "http://192.168.0.115:1036/RenderingControl/ac6dce5a-6047-7862-fd41-e5596960f57a/scpd.xml"
                                            GET /RenderingControl/ac6dce5a-6047-7862-fd41-e5596960f57a/scpd.xml HTTP/1.1
                                            Host: 192.168.0.115:1036
                                            Connection: Keep-Alive
                                            User-Agent: Android/5.1.1 UPnP/1.0 Cling/2.0
20:07:31 T:18446744072532642640    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:31 GMT
                                            Content-Length: 6959
                                            Content-Type: text/xml; charset="utf-8"
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:31 T:18446744072532642640    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 6959 bytes
20:07:31 T:18446744072520609656   DEBUG: int CVideoDatabase::RunQuery(const string&) took 92 ms for 443 items query: select * from movie_view
20:07:32 T:18446744072520607280   DEBUG: Library Data Provider: service version 0.1.5 started
20:07:32 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "random"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "properties": ["title", "originaltitle", "votes", "playcount", "year", "genre", "studio", "country", "tagline", "plot", "runtime", "file", "plotoutline", "lastplayed", "trailer", "rating", "resume", "art", "streamdetails", "mpaa", "director", "writer", "cast", "dateadded", "imdbnumber"], "limits": {"end": 20}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetMovies"}
20:07:32 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 48 ms for 298 items query: select * from movie_view  WHERE ((movie_view.playCount IS NULL OR movie_view.playCount < 1))
20:07:32 T:18446744072524577560    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:32 T:18446744072529569568    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse UNSUBSCRIBE request from 192.168.0.103:49283 for "http://192.168.0.115:1036/AVTransport/ac6dce5a-6047-7862-fd41-e5596960f57a/event.xml"
                                            UNSUBSCRIBE /AVTransport/ac6dce5a-6047-7862-fd41-e5596960f57a/event.xml HTTP/1.1
                                            Cache-Control: no-cache
                                            Connection: Close
                                            Pragma: no-cache
                                            User-Agent: Microsoft-Windows/6.1 UPnP/1.0
                                            SID: uuid:24e546d2-e8cf-f0ea-75c9-6dd1e1e87df2
                                            Host: 192.168.0.115:1036
20:07:32 T:18446744072529569568    INFO: Platinum [platinum.core.service]: Cancelling subscription for AVTransport/ac6dce5a-6047-7862-fd41-e5596960f57a/event.xml (sub=uuid:24e546d2-e8cf-f0ea-75c9-6dd1e1e87df2)
20:07:32 T:18446744072529569568    INFO: Platinum [platinum.core.event]: Deleting subscriber (uuid:24e546d2-e8cf-f0ea-75c9-6dd1e1e87df2)
20:07:32 T:18446744072524577560    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:32 T:18446744072529299304    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse UNSUBSCRIBE request from 192.168.0.103:49284 for "http://192.168.0.115:1036/ConnectionManager/ac6dce5a-6047-7862-fd41-e5596960f57a/event.xml"
                                            UNSUBSCRIBE /ConnectionManager/ac6dce5a-6047-7862-fd41-e5596960f57a/event.xml HTTP/1.1
                                            Cache-Control: no-cache
                                            Connection: Close
                                            Pragma: no-cache
                                            User-Agent: Microsoft-Windows/6.1 UPnP/1.0
                                            SID: uuid:e0a1029e-a48b-bca6-3185-299dada439be
                                            Host: 192.168.0.115:1036
20:07:32 T:18446744072529299304    INFO: Platinum [platinum.core.service]: Cancelling subscription for ConnectionManager/ac6dce5a-6047-7862-fd41-e5596960f57a/event.xml (sub=uuid:e0a1029e-a48b-bca6-3185-299dada439be)
20:07:32 T:18446744072529299304    INFO: Platinum [platinum.core.event]: Deleting subscriber (uuid:e0a1029e-a48b-bca6-3185-299dada439be)
20:07:32 T:18446744072524577560    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:32 T:18446744072530491176    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse UNSUBSCRIBE request from 192.168.0.103:49285 for "http://192.168.0.115:1036/RenderingControl/ac6dce5a-6047-7862-fd41-e5596960f57a/event.xml"
                                            UNSUBSCRIBE /RenderingControl/ac6dce5a-6047-7862-fd41-e5596960f57a/event.xml HTTP/1.1
                                            Cache-Control: no-cache
                                            Connection: Close
                                            Pragma: no-cache
                                            User-Agent: Microsoft-Windows/6.1 UPnP/1.0
                                            SID: uuid:e0a1029e-a48b-bca6-3185-299dada439be
                                            Host: 192.168.0.115:1036
20:07:32 T:18446744072530491176    INFO: Platinum [platinum.core.service]: Cancelling subscription for RenderingControl/ac6dce5a-6047-7862-fd41-e5596960f57a/event.xml (sub=uuid:e0a1029e-a48b-bca6-3185-299dada439be)
20:07:32 T:18446744072530491176    INFO: Platinum [platinum.core.event]: Deleting subscriber (uuid:e0a1029e-a48b-bca6-3185-299dada439be)
20:07:32 T:18446744072529569568    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:32 GMT
                                            Content-Length: 0
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:32 T:18446744072520607280    INFO: Previous line repeats 2 times.
20:07:32 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "random"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 20}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:33 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 264 ms for 1297 items query: select * from episode_view  WHERE ((episode_view.playCount IS NULL OR episode_view.playCount < 1))
20:07:33 T:18446744072527075032  NOTICE: Platinum [platinum.core.ctrlpoint]: Inspecting device "3156c940-21de-8b41-0000-000045b607a7" detected @ http://192.168.0.115:33584/upnp/dev/3156c940-21de-8b41-0000-000045b607a7/desc
20:07:33 T:18446744072527075032    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:33 T:18446744072534538800    INFO: Previous line repeats 4 times.
20:07:33 T:18446744072534538800    INFO: Platinum [platinum.core.devicehost]: Responding to a M-SEARCH request for urn:schemas-upnp-org:device:MediaServer:1
20:07:33 T:18446744072527188720    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:33 T:18446744072542339000    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.116:58297 for "http://192.168.0.115:1480/DeviceDescription.xml"
                                            GET /DeviceDescription.xml HTTP/1.1
                                            HOST: 192.168.0.115:1480
                                            DATE: Sun, 26 Jun 2016 18:06:01 GMT
                                            CONNECTION: close
                                            USER-AGENT: UPnP/1.0 DLNADOC/1.50
20:07:33 T:18446744072542339000    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:33 GMT
                                            Content-Length: 3440
                                            Content-Type: text/xml; charset="utf-8"
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:33 T:18446744072542339000    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 3440 bytes
20:07:33 T:18446744072533492368    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.115:33584/upnp/dev/3156c940-21de-8b41-0000-000045b607a7/desc
20:07:33 T:18446744072533492368    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.115:33584/upnp/dev/3156c940-21de-8b41-0000-000045b607a7/desc)
20:07:33 T:18446744072533492368    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:33 T:18446744072533492368    INFO: Platinum [neptune.tls]: TLS connector will connect to 192.168.0.115:33584
20:07:33 T:18446744072533492368    INFO: Platinum [neptune.http]: got connection (reused: false)
20:07:33 T:18446744072533492368  NOTICE: Platinum [platinum.core.ctrlpoint]: Device "3156c940-21de-8b41-0000-000045b607a7" is now known as "Artaios's Fire TV" (http://192.168.0.115:33584/upnp/dev/3156c940-21de-8b41-0000-000045b607a7/desc)
20:07:33 T:18446744072533492368    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:33 T:18446744072524364344    INFO: Platinum [neptune.http]: requesting URL http://192.168.0.115:33584/upnp/dev/3156c940-21de-8b41-0000-000045b607a7/svc/dial-multiscreen-org/dial/desc
20:07:33 T:18446744072524364344    INFO: Platinum [neptune.http]: calling connector (proxy:no) (http 1.1:yes) (url:http://192.168.0.115:33584/upnp/dev/3156c940-21de-8b41-0000-000045b607a7/svc/dial-multiscreen-org/dial/desc)
20:07:33 T:18446744072524364344    INFO: Platinum [neptune.tls]: looking for a connection to reuse
20:07:33 T:18446744072524364344    INFO: Platinum [neptune.tls]: reusing connection
20:07:33 T:18446744072524364344    INFO: Platinum [neptune.http]: got connection (reused: true)
20:07:33 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "random"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "properties": ["title", "playcount", "genre", "artist", "album", "year", "file", "thumbnail", "fanart", "rating", "lastplayed"], "limits": {"end": 20}}, "jsonrpc": "2.0", "id": 1, "method": "AudioLibrary.GetSongs"}
20:07:33 T:18446744072520607280   DEBUG: bool CMusicDatabase::GetSongsByWhere(const string&, const CDatabase::Filter&, CFileItemList&, const SortDescription&) query = SELECT songview.* FROM songview  WHERE ((CAST(songview.iTimesPlayed as DECIMAL(5,1)) < 1))
20:07:33 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "random"}, "properties": ["title", "description", "albumlabel", "theme", "mood", "style", "type", "artist", "genre", "year", "thumbnail", "fanart", "rating", "playcount"], "limits": {"end": 20}}, "jsonrpc": "2.0", "id": 1, "method": "AudioLibrary.GetAlbums"}
20:07:33 T:18446744072520607280   DEBUG: bool CMusicDatabase::GetAlbumsByWhere(const string&, const CDatabase::Filter&, CFileItemList&, const SortDescription&, bool) query: SELECT albumview.* FROM albumview  WHERE albumview.strReleaseType = 'album'
20:07:33 T:18446744072520607280   DEBUG: bool CMusicDatabase::GetAlbumsByWhere(const string&, const CDatabase::Filter&, CFileItemList&, const SortDescription&, bool) - query took 2 ms
20:07:34 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "random"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "properties": ["title", "artist", "playcount", "studio", "director", "year", "plot", "genre", "runtime", "art", "file", "streamdetails", "resume"], "limits": {"end": 20}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetMusicVideos"}
20:07:34 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 2 ms for 0 items query: select * from musicvideo_view  WHERE ((musicvideo_view.playCount IS NULL OR musicvideo_view.playCount < 1))
20:07:34 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"order": "descending", "method": "dateadded"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "properties": ["title", "originaltitle", "votes", "playcount", "year", "genre", "studio", "country", "tagline", "plot", "runtime", "file", "plotoutline", "lastplayed", "trailer", "rating", "resume", "art", "streamdetails", "mpaa", "director", "writer", "cast", "dateadded", "imdbnumber"], "limits": {"end": 20}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetMovies"}
20:07:34 T:18446744072535276448    INFO: Platinum [platinum.core.devicehost]: Responding to a M-SEARCH request for urn:schemas-upnp-org:device:MediaServer:1
20:07:34 T:18446744072527188720    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:07:34 T:18446744072529124504    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.116:58298 for "http://192.168.0.115:1480/DeviceDescription.xml"
                                            GET /DeviceDescription.xml HTTP/1.1
                                            HOST: 192.168.0.115:1480
                                            DATE: Sun, 26 Jun 2016 18:06:01 GMT
                                            CONNECTION: close
                                            USER-AGENT: UPnP/1.0 DLNADOC/1.50
20:07:34 T:18446744072529124504    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:07:34 GMT
                                            Content-Length: 3440
                                            Content-Type: text/xml; charset="utf-8"
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:07:34 T:18446744072529124504    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 3440 bytes
20:07:34 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 64 ms for 298 items query: select * from movie_view  WHERE ((movie_view.playCount IS NULL OR movie_view.playCount < 1))
20:07:34 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"order": "descending", "method": "dateadded"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 20}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:34 T:18446744072520609656   DEBUG: script.grab.fanart: found 429 movies files
20:07:34 T:18446744072520609656   DEBUG: JSONRPC: Incoming request: { "jsonrpc" : "2.0" , "method" : "VideoLibrary.GetTVShows" , "params" : {"properties":["title","art","year","file","plot"]} , "id":1 }
20:07:35 T:18446744072520903240  NOTICE: script.xbmcbackup-1.0.6: scheduler enabled, finding next run time
20:07:35 T:18446744072520903240   DEBUG: LocalizeStrings: no strings.po file exist at /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.xbmcbackup/resources/language/German, fallback to strings.xml
20:07:35 T:18446744072520609656   DEBUG: int CVideoDatabase::RunQuery(const string&) took 148 ms for 123 items query: SELECT * FROM tvshow_view
20:07:35 T:18446744072520903240   DEBUG: LocalizeStrings: no strings.po file exist at /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.xbmcbackup/resources/language/English, fallback to strings.xml
20:07:35 T:18446744072520903240  NOTICE: script.xbmcbackup-1.0.6: scheduler will run again on 06-27-2016 02:00
20:07:35 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 240 ms for 1297 items query: select * from episode_view  WHERE ((episode_view.playCount IS NULL OR episode_view.playCount < 1))
20:07:35 T:18446744072509948104   DEBUG: ------ Window Init (DialogKaiToast.xml) ------
20:07:35 T:18446744072527075032    INFO: Platinum [platinum.core.ctrlpoint]: Device "Artaios's Fire TV" expiration time renewed..
20:07:35 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"order": "descending", "method": "dateadded"}, "properties": ["title", "description", "albumlabel", "theme", "mood", "style", "type", "artist", "genre", "year", "thumbnail", "fanart", "rating", "playcount"], "limits": {"end": 20}}, "jsonrpc": "2.0", "id": 1, "method": "AudioLibrary.GetAlbums"}
20:07:35 T:18446744072520607280   DEBUG: bool CMusicDatabase::GetAlbumsByWhere(const string&, const CDatabase::Filter&, CFileItemList&, const SortDescription&, bool) query: SELECT albumview.* FROM albumview  WHERE albumview.strReleaseType = 'album'
20:07:35 T:18446744072520607280   DEBUG: bool CMusicDatabase::GetAlbumsByWhere(const string&, const CDatabase::Filter&, CFileItemList&, const SortDescription&, bool) - query took 1 ms
20:07:35 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"order": "descending", "method": "dateadded"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "properties": ["title", "artist", "playcount", "studio", "director", "year", "plot", "genre", "runtime", "art", "file", "streamdetails", "resume"], "limits": {"end": 20}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetMusicVideos"}
20:07:35 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 3 ms for 0 items query: select * from musicvideo_view  WHERE ((musicvideo_view.playCount IS NULL OR musicvideo_view.playCount < 1))
20:07:35 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "random"}, "filter": {"operator": "true", "field": "inprogress", "value": ""}, "properties": ["title", "originaltitle", "votes", "playcount", "year", "genre", "studio", "country", "tagline", "plot", "runtime", "file", "plotoutline", "lastplayed", "trailer", "rating", "resume", "art", "streamdetails", "mpaa", "director", "writer", "cast", "dateadded", "imdbnumber"], "limits": {"end": 20}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetMovies"}
20:07:35 T:18446744072520609656   DEBUG: script.grab.fanart: found 110 tv files
20:07:35 T:18446744072520609656   DEBUG: JSONRPC: Incoming request: { "jsonrpc" : "2.0" , "method" : "AudioLibrary.GetArtists" , "params" : { "properties":["fanart","description"] } , "id":1 }
20:07:35 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 4 ms for 0 items query: select * from movie_view  WHERE (movie_view.idFile  IN (SELECT DISTINCT idFile FROM bookmark WHERE type = 1))
20:07:35 T:18446744072520609656   DEBUG: bool CMusicDatabase::GetArtistsByWhere(const string&, const CDatabase::Filter&, CFileItemList&, const SortDescription&, bool) query: SELECT artistview.* FROM artistview  WHERE (artistview.idArtist IN (SELECT album_artist.idArtist FROM album_artist JOIN album ON album.idAlbum = album_artist.idAlbum WHERE album.bCompilation = 0 )) and artistview.strArtist != ''
20:07:35 T:18446744072520609656   DEBUG: Time to retrieve artists from dataset = 2
20:07:35 T:18446744072520609656   DEBUG: script.grab.fanart: found 0 music files
20:07:35 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"order": "descending", "method": "lastplayed"}, "filter": {"and": [{"operator": "lessthan", "field": "playcount", "value": "1"}, {"operator": "true", "field": "inprogress", "value": ""}]}, "properties": ["title", "studio", "mpaa", "file", "art"], "limits": {"end": 20}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetTVShows"}
20:07:36 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 142 ms for 40 items query: SELECT * FROM tvshow_view  WHERE ((CASE WHEN COALESCE(tvshow_view.totalCount - tvshow_view.watchedcount, 0) > 0 THEN 0 ELSE 1 END  < 1)) AND ( ((tvshow_view.watchedcount > 0 AND tvshow_view.watchedcount < tvshow_view.totalCount) OR (tvshow_view.watchedcount = 0 AND EXISTS (SELECT 1 FROM episode_view WHERE episode_view.idShow = tvshow_view.idShow AND episode_view.resumeTimeInSeconds > 0))))
20:07:36 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 159, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:36 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 5 ms for 4 items query: select * from episode_view  WHERE (episode_view.idShow = 159) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:36 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:36 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 209, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:36 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 7 ms for 1 items query: select * from episode_view  WHERE (episode_view.idShow = 209) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:36 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:36 T:18446744072520605136   DEBUG: JSONRPC: Incoming request: { "jsonrpc": "2.0", "method": "Application.GetProperties", "params": {"properties": ["version", "name"]}, "id": 1 }
20:07:36 T:18446744072520605136   DEBUG: Version Check: Version installed {u'major': 15, u'tag': u'stable', u'minor': 2, u'revision': u'2015-10-19-02e7013'}
20:07:36 T:18446744072520605136   DEBUG: Version Check: Version available  {u'major': u'16', u'extrainfo': u'final', u'tagversion': u'', u'tag': u'stable', u'addon_support': u'yes', u'minor': u'1', u'revision': u'20160424-c327c53'}
20:07:36 T:18446744072520605136   DEBUG: Version Check: You are running an older version
20:07:36 T:18446744072520605136   DEBUG: POParser: loaded 21 strings from file /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.xbmc.versioncheck/resources/language/German/strings.po
20:07:36 T:18446744072520605136   DEBUG: POParser: loaded 0 strings from file /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.xbmc.versioncheck/resources/language/English/strings.po
20:07:36 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 261, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:36 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 4 ms for 8 items query: select * from episode_view  WHERE (episode_view.idShow = 261) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:36 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:36 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 189, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:36 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 8 ms for 32 items query: select * from episode_view  WHERE (episode_view.idShow = 189) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:36 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:36 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 151, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:36 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 4 ms for 2 items query: select * from episode_view  WHERE (episode_view.idShow = 151) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:36 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:36 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 262, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:36 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 6 ms for 1 items query: select * from episode_view  WHERE (episode_view.idShow = 262) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:36 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:36 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 196, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:36 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 6 ms for 9 items query: select * from episode_view  WHERE (episode_view.idShow = 196) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:36 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:36 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 133, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:36 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 5 ms for 6 items query: select * from episode_view  WHERE (episode_view.idShow = 133) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:36 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:36 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 205, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:36 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 7 ms for 1 items query: select * from episode_view  WHERE (episode_view.idShow = 205) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:36 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:36 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 242, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:36 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 6 ms for 7 items query: select * from episode_view  WHERE (episode_view.idShow = 242) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:36 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:36 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 173, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:37 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 4 ms for 3 items query: select * from episode_view  WHERE (episode_view.idShow = 173) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:37 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:37 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 6, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:37 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 5 ms for 1 items query: select * from episode_view  WHERE (episode_view.idShow = 6) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:37 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:37 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 236, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:37 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 5 ms for 17 items query: select * from episode_view  WHERE (episode_view.idShow = 236) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:37 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:37 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 250, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:37 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 7 ms for 3 items query: select * from episode_view  WHERE (episode_view.idShow = 250) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:37 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:37 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 187, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:37 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 4 ms for 2 items query: select * from episode_view  WHERE (episode_view.idShow = 187) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:37 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:37 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 190, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:37 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 4 ms for 3 items query: select * from episode_view  WHERE (episode_view.idShow = 190) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:37 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:37 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 141, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:37 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 11 ms for 27 items query: select * from episode_view  WHERE (episode_view.idShow = 141) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:37 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:37 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 171, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:37 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 4 ms for 5 items query: select * from episode_view  WHERE (episode_view.idShow = 171) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:37 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:37 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 234, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:37 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 4 ms for 7 items query: select * from episode_view  WHERE (episode_view.idShow = 234) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:37 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:37 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"method": "episode"}, "filter": {"operator": "lessthan", "field": "playcount", "value": "1"}, "tvshowid": 231, "properties": ["title", "playcount", "season", "episode", "showtitle", "plot", "file", "rating", "resume", "tvshowid", "art", "streamdetails", "firstaired", "runtime", "director", "writer", "cast", "dateadded", "lastplayed"], "limits": {"end": 1}}, "jsonrpc": "2.0", "id": 1, "method": "VideoLibrary.GetEpisodes"}
20:07:37 T:18446744072520607280   DEBUG: int CVideoDatabase::RunQuery(const string&) took 5 ms for 11 items query: select * from episode_view  WHERE (episode_view.idShow = 231) AND (((episode_view.playCount IS NULL OR episode_view.playCount < 1)))
20:07:37 T:18446744072520607280   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25
20:07:37 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"sort": {"order": "descending", "method": "playcount"}, "properties": ["title", "description", "albumlabel", "theme", "mood", "style", "type", "artist", "genre", "year", "thumbnail", "fanart", "rating", "playcount"], "limits": {"end": 20}}, "jsonrpc": "2.0", "id": 1, "method": "AudioLibrary.GetAlbums"}
20:07:37 T:18446744072520607280   DEBUG: bool CMusicDatabase::GetAlbumsByWhere(const string&, const CDatabase::Filter&, CFileItemList&, const SortDescription&, bool) query: SELECT albumview.* FROM albumview  WHERE albumview.strReleaseType = 'album'
20:07:37 T:18446744072520607280   DEBUG: bool CMusicDatabase::GetAlbumsByWhere(const string&, const CDatabase::Filter&, CFileItemList&, const SortDescription&, bool) - query took 1 ms
20:07:37 T:18446744072520607280   DEBUG: JSONRPC: Incoming request: {"params": {"properties": []}, "jsonrpc": "2.0", "id": 1, "method": "Favourites.GetFavourites"}
20:07:37 T:18446744072520607280   DEBUG: CFavourites::Load - no system favourites found, skipping
20:07:37 T:18446744072520607280   DEBUG: CFavourites::Load - no userdata favourites found, skipping
20:07:37 T:18446744072520607280   DEBUG: Library Data Provider: Total time needed for all queries: 0:00:05.659698
20:07:39 T:18446744072509948104   DEBUG: ------ Window Deinit (DialogKaiToast.xml) ------
20:07:40 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
20:07:40 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): right (0xf083) pressed, action is Right
20:07:40 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
20:07:40 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): right (0xf083) pressed, action is Right
20:07:41 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
20:07:41 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): down (0xf081) pressed, action is Down
20:07:42 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
20:07:42 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): right (0xf083) pressed, action is Right
20:07:42 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
20:07:42 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): right (0xf083) pressed, action is Right
20:07:43 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
20:07:43 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): right (0xf083) pressed, action is Right
20:07:43 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0
20:07:43 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): left (0xf082) pressed, action is Left
20:07:44 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
20:07:44 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): return (0xf00d) pressed, action is Select
20:07:44 T:18446744072509948104   DEBUG: Activating window ID: 10003
20:07:44 T:18446744072509948104   DEBUG: ------ Window Deinit (Home.xml) ------
20:07:44 T:18446744072509948104    INFO: Attempting to default to:
20:07:44 T:18446744072509948104   DEBUG: ------ Window Init (FileManager.xml) ------
20:07:44 T:18446744072509948104    INFO: Loading skin file: FileManager.xml, load type: KEEP_IN_MEMORY
20:07:45 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
20:07:45 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): return (0xf00d) pressed, action is Select
20:07:46 T:18446744072520605136   DEBUG: Version Check: Already notified one time for upgrading.
20:07:46 T:18446744072520605136    INFO: CPythonInvoker(0, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.xbmc.versioncheck/service.py): script successfully run
20:07:46 T:18446744072520605136    INFO: Python script stopped
20:07:46 T:18446744072520605136   DEBUG: Thread LanguageInvoker 18446744072520605136 terminating
20:07:48 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
20:07:48 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): up (0xf080) pressed, action is Up
20:07:48 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
20:07:48 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): up (0xf080) pressed, action is Up
20:07:48 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
20:07:48 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): return (0xf00d) pressed, action is Select
20:07:49 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
20:07:49 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): up (0xf080) pressed, action is Up
20:07:51 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
20:07:51 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): right (0xf083) pressed, action is Right
20:07:52 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
20:07:52 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): down (0xf081) pressed, action is Down
20:07:52 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
20:07:52 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): down (0xf081) pressed, action is Down
20:07:53 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
20:07:53 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): down (0xf081) pressed, action is Down
20:07:53 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
20:07:53 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): return (0xf00d) pressed, action is Select
20:07:53 T:18446744072525461104   DEBUG: int XFILE::CSMBDirectory::OpenDir(const CURL&, std::string&): Using authentication url smb://NECROMANCER/Programm%20Archiv/XBMC
20:07:58 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
20:07:58 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): return (0xf00d) pressed, action is Select
20:07:58 T:18446744072522310360   DEBUG: int XFILE::CSMBDirectory::OpenDir(const CURL&, std::string&): Using authentication url smb://NECROMANCER/Programm%20Archiv/XBMC/1
20:08:02 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0
20:08:02 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): backspace (0xf008) pressed, action is Back
20:08:02 T:18446744072525461104   DEBUG: int XFILE::CSMBDirectory::OpenDir(const CURL&, std::string&): Using authentication url smb://NECROMANCER/Programm%20Archiv/XBMC
20:08:04 T:18446744072524294120    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:08:04 T:18446744072509948104    INFO: Previous line repeats 1 times.
20:08:04 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x52, sym: 0x013f, unicode: 0x0000, modifier: 0x0
20:08:04 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): menu (0xf0d8) pressed, action is ContextMenu
20:08:04 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers(smb://NECROMANCER/Programm Archiv/XBMC/1/)
20:08:04 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
20:08:04 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
20:08:04 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/mms/udp
20:08:04 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
20:08:04 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
20:08:04 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
20:08:04 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
20:08:04 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
20:08:04 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
20:08:04 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
20:08:04 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
20:08:04 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
20:08:04 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
20:08:04 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
20:08:04 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
20:08:04 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
20:08:04 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
20:08:04 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
20:08:04 T:18446744072509948104   DEBUG: CFavourites::Load - no system favourites found, skipping
20:08:04 T:18446744072509948104   DEBUG: CFavourites::Load - no userdata favourites found, skipping
20:08:04 T:18446744072509948104    INFO: Loading skin file: DialogContextMenu.xml, load type: KEEP_IN_MEMORY
20:08:04 T:18446744072509948104   DEBUG: ------ Window Init (DialogContextMenu.xml) ------
20:08:04 T:18446744072524294120    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:08:05 T:18446744072509948104    INFO: Previous line repeats 1 times.
20:08:05 T:18446744072509948104   DEBUG: SECTION:UnloadDelayed(DLL: libImageLib-arm.so)
20:08:05 T:18446744072509948104   DEBUG: Unloading: /libImageLib-arm.so
20:08:07 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
20:08:07 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): down (0xf081) pressed, action is Down
20:08:07 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
20:08:07 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): down (0xf081) pressed, action is Down
20:08:07 T:18446744072540208504    INFO: Platinum [platinum.core.devicehost]: Responding to a M-SEARCH request for urn:schemas-upnp-org:device:MediaServer:1
20:08:07 T:18446744072527188720    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:08:07 T:18446744072527026752    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.116:58301 for "http://192.168.0.115:1480/DeviceDescription.xml"
                                            GET /DeviceDescription.xml HTTP/1.1
                                            HOST: 192.168.0.115:1480
                                            DATE: Sun, 26 Jun 2016 18:06:35 GMT
                                            CONNECTION: close
                                            USER-AGENT: UPnP/1.0 DLNADOC/1.50
20:08:07 T:18446744072527026752    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:08:07 GMT
                                            Content-Length: 3440
                                            Content-Type: text/xml; charset="utf-8"
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:08:07 T:18446744072527026752    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 3440 bytes
20:08:07 T:18446744072542187768    INFO: Platinum [platinum.core.devicehost]: Responding to a M-SEARCH request for urn:schemas-upnp-org:device:MediaServer:1
20:08:07 T:18446744072527188720    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:08:07 T:18446744072527050512    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.116:58302 for "http://192.168.0.115:1480/DeviceDescription.xml"
                                            GET /DeviceDescription.xml HTTP/1.1
                                            HOST: 192.168.0.115:1480
                                            DATE: Sun, 26 Jun 2016 18:06:35 GMT
                                            CONNECTION: close
                                            USER-AGENT: UPnP/1.0 DLNADOC/1.50
20:08:07 T:18446744072527050512    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:08:07 GMT
                                            Content-Length: 3440
                                            Content-Type: text/xml; charset="utf-8"
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:08:07 T:18446744072527050512    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 3440 bytes
20:08:07 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
20:08:07 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): down (0xf081) pressed, action is Down
20:08:07 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
20:08:07 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): down (0xf081) pressed, action is Down
20:08:07 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
20:08:07 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): down (0xf081) pressed, action is Down
20:08:08 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
20:08:08 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): down (0xf081) pressed, action is Down
20:08:08 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
20:08:08 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): return (0xf00d) pressed, action is Select
20:08:08 T:18446744072509948104   DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------
20:08:08 T:18446744072509948104    INFO: Loading skin file: DialogKeyboard.xml, load type: KEEP_IN_MEMORY
20:08:09 T:18446744072509948104   DEBUG: ------ Window Init (DialogKeyboard.xml) ------
20:08:09 T:18446744072509948104   DEBUG: CAnnouncementManager - Announcement: OnInputRequested from xbmc
20:08:09 T:18446744072509948104   DEBUG: GOT ANNOUNCEMENT, type: 128, from xbmc, message OnInputRequested
20:08:11 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
20:08:11 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): up (0xf080) pressed, trying keyboard action 3
20:08:11 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
20:08:11 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): up (0xf080) pressed, trying keyboard action 3
20:08:12 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
20:08:12 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): up (0xf080) pressed, trying keyboard action 3
20:08:12 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
20:08:12 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): return (0xf00d) pressed, trying keyboard action 7
20:08:13 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
20:08:13 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): right (0xf083) pressed, trying keyboard action 2
20:08:13 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
20:08:13 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): right (0xf083) pressed, trying keyboard action 2
20:08:13 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
20:08:13 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): right (0xf083) pressed, trying keyboard action 2
20:08:14 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
20:08:14 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): right (0xf083) pressed, trying keyboard action 2
20:08:14 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
20:08:14 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): right (0xf083) pressed, trying keyboard action 2
20:08:14 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
20:08:14 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): right (0xf083) pressed, trying keyboard action 2
20:08:15 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
20:08:15 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): right (0xf083) pressed, trying keyboard action 2
20:08:15 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
20:08:15 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): right (0xf083) pressed, trying keyboard action 2
20:08:15 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x16, sym: 0x0113, unicode: 0x0000, modifier: 0x0
20:08:15 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): right (0xf083) pressed, trying keyboard action 2
20:08:16 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
20:08:16 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): down (0xf081) pressed, trying keyboard action 4
20:08:16 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
20:08:16 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): return (0xf00d) pressed, trying keyboard action 7
20:08:17 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
20:08:17 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): up (0xf080) pressed, trying keyboard action 3
20:08:17 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
20:08:17 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): return (0xf00d) pressed, trying keyboard action 7
20:08:17 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0
20:08:17 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): left (0xf082) pressed, trying keyboard action 1
20:08:18 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0
20:08:18 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): left (0xf082) pressed, trying keyboard action 1
20:08:18 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0
20:08:18 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): left (0xf082) pressed, trying keyboard action 1
20:08:19 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0
20:08:19 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): left (0xf082) pressed, trying keyboard action 1
20:08:19 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
20:08:19 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): down (0xf081) pressed, trying keyboard action 4
20:08:19 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
20:08:19 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): return (0xf00d) pressed, trying keyboard action 7
20:08:21 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
20:08:21 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): down (0xf081) pressed, trying keyboard action 4
20:08:21 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
20:08:21 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): down (0xf081) pressed, trying keyboard action 4
20:08:22 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0
20:08:22 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): left (0xf082) pressed, trying keyboard action 1
20:08:22 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0
20:08:22 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): left (0xf082) pressed, trying keyboard action 1
20:08:23 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
20:08:23 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): return (0xf00d) pressed, trying keyboard action 7
20:08:23 T:18446744072509948104   DEBUG: ------ Window Deinit (DialogKeyboard.xml) ------
20:08:23 T:18446744072509948104   DEBUG: CAnnouncementManager - Announcement: OnInputFinished from xbmc
20:08:23 T:18446744072509948104   DEBUG: GOT ANNOUNCEMENT, type: 128, from xbmc, message OnInputFinished
20:08:23 T:18446744072522310360   DEBUG: int XFILE::CSMBDirectory::OpenDir(const CURL&, std::string&): Using authentication url smb://NECROMANCER/Programm%20Archiv/XBMC
20:08:25 T:18446744072527075032    INFO: Platinum [neptune.http]: NPT_CHECK failed, result=-20014 (NPT_ERROR_TIMEOUT) [(result)]
20:08:25 T:18446744072524294120    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:08:25 T:18446744072527075032    INFO: Previous line repeats 1 times.
20:08:25 T:18446744072527075032    INFO: Platinum [platinum.core.ctrlpoint]: Device "Canon-Fax UPnP" expiration time renewed..
20:08:25 T:18446744072524294120    INFO: Previous line repeats 3 times.
20:08:25 T:18446744072524294120    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:08:25 T:18446744072527075032    INFO: Previous line repeats 1 times.
20:08:25 T:18446744072527075032    INFO: Platinum [platinum.core.ctrlpoint]: Device "NT667_EU(192.168.0.116)" expiration time renewed..
20:08:25 T:18446744072509948104    INFO: Previous line repeats 1 times.
20:08:25 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
20:08:25 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): return (0xf00d) pressed, action is Select
20:08:25 T:18446744072525461104   DEBUG: int XFILE::CSMBDirectory::OpenDir(const CURL&, std::string&): Using authentication url smb://NECROMANCER/Programm%20Archiv/XBMC/Log
20:08:25 T:18446744072527075032    INFO: Platinum [platinum.core.ctrlpoint]: Device "Artaios's Fire TV" expiration time renewed..
20:08:25 T:18446744072527075032    INFO: Platinum [platinum.core.ctrlpoint]: Device "NECROMANCER: Artaios:" expiration time renewed..
20:08:25 T:18446744072529111168    INFO: Platinum [neptune.http]: cleaning up connection (1 remain)
20:08:26 T:18446744072525968752    INFO: Platinum [platinum.core.devicehost]: Responding to a M-SEARCH request for upnp:rootdevice
20:08:26 T:18446744072527075032    INFO: Platinum [platinum.core.ctrlpoint]: CtrlPoint received a search response from ourselves (68298a16-2c03-342e-b90d-a115252cb136)
20:08:26 T:18446744072530261552    INFO: Platinum [platinum.core.devicehost]: Responding to a M-SEARCH request for upnp:rootdevice
20:08:26 T:18446744072527075032    INFO: Platinum [platinum.core.ctrlpoint]: CtrlPoint received a search response from ourselves (ac6dce5a-6047-7862-fd41-e5596960f57a)
20:08:27 T:18446744072524968016    INFO: Platinum [platinum.core.devicehost]: Responding to a M-SEARCH request for upnp:rootdevice
20:08:27 T:18446744072527075032    INFO: Platinum [platinum.core.ctrlpoint]: CtrlPoint received a search response from ourselves (68298a16-2c03-342e-b90d-a115252cb136)
20:08:27 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0
20:08:27 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): left (0xf082) pressed, action is Left
20:08:27 T:18446744072527075032    INFO: Platinum [platinum.core.ctrlpoint]: Device "NECROMANCER: Artaios:" expiration time renewed..
20:08:28 T:18446744072534888896    INFO: Platinum [platinum.core.devicehost]: Responding to a M-SEARCH request for upnp:rootdevice
20:08:28 T:18446744072527075032    INFO: Platinum [platinum.core.ctrlpoint]: CtrlPoint received a search response from ourselves (ac6dce5a-6047-7862-fd41-e5596960f57a)
20:08:28 T:18446744072527075032    INFO: Platinum [platinum.core.ctrlpoint]: Device "Artaios's Fire TV" expiration time renewed..
20:08:28 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x52, sym: 0x013f, unicode: 0x0000, modifier: 0x0
20:08:28 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): menu (0xf0d8) pressed, action is ContextMenu
20:08:28 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers(/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/temp/kodi.old.log)
20:08:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
20:08:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
20:08:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/mms/udp
20:08:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
20:08:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
20:08:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
20:08:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
20:08:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
20:08:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
20:08:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
20:08:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
20:08:28 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
20:08:28 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
20:08:28 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
20:08:28 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
20:08:28 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
20:08:28 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
20:08:28 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
20:08:28 T:18446744072509948104   DEBUG: CFavourites::Load - no system favourites found, skipping
20:08:28 T:18446744072509948104   DEBUG: CFavourites::Load - no userdata favourites found, skipping
20:08:28 T:18446744072509948104   DEBUG: ------ Window Init (DialogContextMenu.xml) ------
20:08:30 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
20:08:30 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): down (0xf081) pressed, action is Down
20:08:31 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
20:08:31 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): down (0xf081) pressed, action is Down
20:08:31 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
20:08:31 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): down (0xf081) pressed, action is Down
20:08:31 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0
20:08:31 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): down (0xf081) pressed, action is Down
20:08:32 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
20:08:32 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): return (0xf00d) pressed, action is Select
20:08:32 T:18446744072509948104   DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------
20:08:32 T:18446744072509948104   DEBUG: ------ Window Init (DialogYesNo.xml) ------
20:08:32 T:18446744072509948104    INFO: Loading skin file: DialogYesNo.xml, load type: KEEP_IN_MEMORY
20:08:33 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0
20:08:33 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): left (0xf082) pressed, action is Left
20:08:34 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
20:08:34 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): return (0xf00d) pressed, action is Select
20:08:34 T:18446744072509948104   DEBUG: ------ Window Deinit (DialogYesNo.xml) ------
20:08:34 T:18446744072509948104   DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------
20:08:34 T:18446744072522310360   DEBUG: FileManager: copy /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/temp/kodi.old.log -> smb://NECROMANCER/Programm Archiv/XBMC/Log/kodi.old.log
20:08:34 T:18446744072522310360 WARNING: SMBFile::OpenForWrite() called with overwriting enabled! - smb://NECROMANCER/Programm%20Archiv/XBMC/Log/kodi.old.log
20:08:35 T:18446744072524294120    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:08:35 T:18446744072534902664    INFO: Previous line repeats 3 times.
20:08:35 T:18446744072534902664    INFO: Platinum [platinum.core.devicehost]: Responding to a M-SEARCH request for urn:schemas-upnp-org:device:MediaServer:1
20:08:35 T:18446744072527188720    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:08:35 T:18446744072528967600    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.116:58305 for "http://192.168.0.115:1480/DeviceDescription.xml"
                                            GET /DeviceDescription.xml HTTP/1.1
                                            HOST: 192.168.0.115:1480
                                            DATE: Sun, 26 Jun 2016 18:07:03 GMT
                                            CONNECTION: close
                                            USER-AGENT: UPnP/1.0 DLNADOC/1.50
20:08:35 T:18446744072528967600    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:08:35 GMT
                                            Content-Length: 3440
                                            Content-Type: text/xml; charset="utf-8"
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:08:35 T:18446744072528967600    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 3440 bytes
20:08:37 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
20:08:37 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): up (0xf080) pressed, action is Up
20:08:37 T:18446744072534803800    INFO: Platinum [platinum.core.devicehost]: Responding to a M-SEARCH request for urn:schemas-upnp-org:device:MediaServer:1
20:08:37 T:18446744072527188720    INFO: Platinum [neptune.threads.posix]: NPT_PosixThread::NPT_PosixThread
20:08:37 T:18446744072537569552    INFO: Platinum [platinum.core.http.server]: PLT_HttpServer::SetupResponse GET request from 192.168.0.116:58306 for "http://192.168.0.115:1480/DeviceDescription.xml"
                                            GET /DeviceDescription.xml HTTP/1.1
                                            HOST: 192.168.0.115:1480
                                            DATE: Sun, 26 Jun 2016 18:07:05 GMT
                                            CONNECTION: close
                                            USER-AGENT: UPnP/1.0 DLNADOC/1.50
20:08:37 T:18446744072537569552    INFO: Platinum [platinum.core.http.servertask]: PLT_HttpServerSocketTask::Write
                                            HTTP/1.1 200 OK
                                            Date: Sun, 26 Jun 2016 18:08:37 GMT
                                            Content-Length: 3440
                                            Content-Type: text/xml; charset="utf-8"
                                            Connection: close
                                            Server: UPnP/1.0 DLNADOC/1.50 Kodi
20:08:37 T:18446744072537569552    INFO: Platinum [platinum.core.http.servertask]: sending body stream, 3440 bytes
20:08:43 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x52, sym: 0x013f, unicode: 0x0000, modifier: 0x0
20:08:43 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): menu (0xf0d8) pressed, action is ContextMenu
20:08:43 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers(/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/temp/kodi.log)
20:08:43 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
20:08:43 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
20:08:43 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/mms/udp
20:08:43 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
20:08:43 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
20:08:43 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
20:08:43 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
20:08:43 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
20:08:43 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
20:08:43 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
20:08:43 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
20:08:43 T:18446744072509948104   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
20:08:43 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
20:08:43 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
20:08:43 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
20:08:43 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
20:08:43 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
20:08:43 T:18446744072509948104   DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
20:08:43 T:18446744072509948104   DEBUG: CFavourites::Load - no system favourites found, skipping
20:08:43 T:18446744072509948104   DEBUG: CFavourites::Load - no userdata favourites found, skipping
20:08:43 T:18446744072509948104   DEBUG: ------ Window Init (DialogContextMenu.xml) ------
20:08:44 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
20:08:44 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): up (0xf080) pressed, action is Up
20:08:45 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
20:08:45 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): up (0xf080) pressed, action is Up
20:08:45 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
20:08:45 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): up (0xf080) pressed, action is Up
20:08:45 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
20:08:45 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): up (0xf080) pressed, action is Up
20:08:45 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
20:08:45 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): up (0xf080) pressed, action is Up
20:08:46 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0
20:08:46 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): up (0xf080) pressed, action is Up
20:08:46 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
20:08:46 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): return (0xf00d) pressed, action is Select
20:08:46 T:18446744072509948104   DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------
20:08:46 T:18446744072509948104   DEBUG: ------ Window Init (DialogYesNo.xml) ------
20:08:47 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0
20:08:47 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): left (0xf082) pressed, action is Left
20:08:48 T:18446744072509948104   DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0
20:08:48 T:18446744072509948104   DEBUG: bool CInputManager::OnKey(const CKey&): return (0xf00d) pressed, action is Select
20:08:48 T:18446744072509948104   DEBUG: ------ Window Deinit (DialogYesNo.xml) ------
20:08:48 T:18446744072525461104   DEBUG: FileManager: copy /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/temp/kodi.log -> smb://NECROMANCER/Programm Archiv/XBMC/Log/kodi.log
20:08:48 T:18446744072525461104 WARNING: SMBFile::OpenForWrite() called with overwriting enabled! - smb://NECROMANCER/Programm%20Archiv/XBMC/Log/kodi.log