2019-10-22 11:22:44.434 T:3011713504 NOTICE: -----------------------------------------------------------------------
2019-10-22 11:22:44.434 T:3011713504 NOTICE: Starting Kodi (18.4 Git:leia_pi4_18.4-Leia). Platform: Linux ARM 32-bit
2019-10-22 11:22:44.434 T:3011713504 NOTICE: Using Release Kodi x32 build
2019-10-22 11:22:44.434 T:3011713504 NOTICE: Kodi compiled 2019-09-03 by GCC 8.3.0 for Linux ARM 32-bit version 4.19.66 (267074)
2019-10-22 11:22:44.434 T:3011713504 NOTICE: Running on LibreELEC (official): 9.1.501, kernel: Linux ARM 32-bit version 4.19.66
2019-10-22 11:22:44.434 T:3011713504 NOTICE: FFmpeg version/source: 4.0.4-Kodi
2019-10-22 11:22:44.434 T:3011713504 NOTICE: Host CPU: ARMv7 Processor rev 3 (v7l), 4 cores available
2019-10-22 11:22:44.434 T:3011713504 NOTICE: ARM Features: Neon enabled
2019-10-22 11:22:44.434 T:3011713504 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi/
2019-10-22 11:22:44.434 T:3011713504 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi
2019-10-22 11:22:44.435 T:3011713504 NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons
2019-10-22 11:22:44.435 T:3011713504 NOTICE: special://masterprofile/ is mapped to: /storage/.kodi/userdata
2019-10-22 11:22:44.435 T:3011713504 NOTICE: special://envhome/ is mapped to: /storage
2019-10-22 11:22:44.435 T:3011713504 NOTICE: special://home/ is mapped to: /storage/.kodi
2019-10-22 11:22:44.435 T:3011713504 NOTICE: special://temp/ is mapped to: /storage/.kodi/temp
2019-10-22 11:22:44.435 T:3011713504 NOTICE: special://logpath/ is mapped to: /storage/.kodi/temp
2019-10-22 11:22:44.435 T:3011713504 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin
2019-10-22 11:22:44.435 T:3011713504 NOTICE: Local hostname: SonyKodi
2019-10-22 11:22:44.435 T:3011713504 NOTICE: Log File is located: /storage/.kodi/temp/kodi.log
2019-10-22 11:22:44.435 T:3011713504 NOTICE: -----------------------------------------------------------------------
2019-10-22 11:22:44.444 T:3011713504 INFO: loading settings
2019-10-22 11:22:44.447 T:3011713504 NOTICE: special://profile/ is mapped to: special://masterprofile/
2019-10-22 11:22:44.466 T:3011713504 DEBUG: CSkinSettings: no <skinsettings> tag found
2019-10-22 11:22:44.467 T:3011713504 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml
2019-10-22 11:22:44.467 T:3011713504 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are...
<?xml version="1.0" encoding="utf-8" ?>
<advancedsettings>
<cputempcommand>/usr/bin/cputemp</cputempcommand>
<gputempcommand>/usr/bin/gputemp</gputempcommand>
<showexitbutton>false</showexitbutton>
<remotedelay>1</remotedelay>
<samba>
<clienttimeout>30</clienttimeout>
</samba>
<fanartres>720</fanartres>
<imageres>540</imageres>
</advancedsettings>
2019-10-22 11:22:44.467 T:3011713504 WARNING: CSettingsManager: missing version attribute
2019-10-22 11:22:44.471 T:3011713504 NOTICE: Loaded settings file from special://profile/advancedsettings.xml
2019-10-22 11:22:44.471 T:3011713504 NOTICE: Contents of special://profile/advancedsettings.xml are...
<advancedsettings>
<gui>
<algorithmdirtyregions>3</algorithmdirtyregions>
<nofliptimeout>0</nofliptimeout>
</gui>
<videodatabase>
<type>mysql</type>
<host>10.11.12.13</host>
<port>3306</port>
<user>kodi</user>
<pass>*</pass>
<name>sassa</name>
<compression>true</compression>
</videodatabase>
<cache>
<buffermode>1</buffermode>
<memorysize>152428800</memorysize>
<readfactor>3</readfactor>
</cache>
</advancedsettings>
2019-10-22 11:22:44.471 T:3011713504 WARNING: VIDEO database configuration is experimental.
2019-10-22 11:22:44.471 T:3011713504 WARNING: CSettingsManager: missing version attribute
2019-10-22 11:22:44.471 T:3011713504 NOTICE: Default Video Player: VideoPlayer
2019-10-22 11:22:44.471 T:3011713504 NOTICE: Default Audio Player: paplayer
2019-10-22 11:22:44.471 T:3011713504 NOTICE: Enabled debug logging due to GUI setting (2)
2019-10-22 11:22:44.471 T:3011713504 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM"
2019-10-22 11:22:44.472 T:3011713504 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml
2019-10-22 11:22:44.482 T:3011713504 INFO: creating subdirectories
2019-10-22 11:22:44.482 T:3011713504 INFO: userdata folder: special://masterprofile/
2019-10-22 11:22:44.482 T:3011713504 INFO: recording folder:
2019-10-22 11:22:44.483 T:3011713504 INFO: screenshots folder: /storage/screenshots/
2019-10-22 11:22:44.571 T:3011713504 NOTICE: PulseAudio: Server found running - will try to use Pulse
2019-10-22 11:22:44.571 T:2934961008 DEBUG: Thread Lirc start, auto delete: false
2019-10-22 11:22:44.572 T:2934961008 INFO: Loading special://xbmc/system/Lircmap.xml
2019-10-22 11:22:44.572 T:3002069872 DEBUG: Thread libinput start, auto delete: false
2019-10-22 11:22:44.577 T:2934961008 INFO: * Adding remote mapping for device 'mceusb'
2019-10-22 11:22:44.577 T:2934961008 INFO: * Adding remote mapping for device 'XboxDVDDongle'
2019-10-22 11:22:44.577 T:2934961008 INFO: * Adding remote mapping for device 'Microsoft_Xbox'
2019-10-22 11:22:44.577 T:2934961008 INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote'
2019-10-22 11:22:44.577 T:2934961008 INFO: * Adding remote mapping for device 'anysee'
2019-10-22 11:22:44.577 T:2934961008 INFO: * Adding remote mapping for device 'iMON-PAD'
2019-10-22 11:22:44.577 T:2934961008 INFO: * Adding remote mapping for device 'Antec_Veris_RM200'
2019-10-22 11:22:44.578 T:2934961008 INFO: * Adding remote mapping for device 'MCE_via_iMON'
2019-10-22 11:22:44.578 T:2934961008 INFO: * Adding remote mapping for device 'TwinHanRemote'
2019-10-22 11:22:44.578 T:2934961008 INFO: * Adding remote mapping for device 'linux-input-layer'
2019-10-22 11:22:44.578 T:2934961008 INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote'
2019-10-22 11:22:44.578 T:2934961008 INFO: * Adding remote mapping for device 'mediacenter'
2019-10-22 11:22:44.578 T:2934961008 INFO: * Adding remote mapping for device 'devinput'
2019-10-22 11:22:44.578 T:2934961008 INFO: * Adding remote mapping for device 'devinput-32'
2019-10-22 11:22:44.578 T:2934961008 INFO: * Adding remote mapping for device 'devinput-64'
2019-10-22 11:22:44.578 T:2934961008 DEBUG: CIRTranslator::Load - no userdata Lircmap.xml found, skipping
2019-10-22 11:22:44.619 T:3011713504 NOTICE: Running database version Addons27
2019-10-22 11:22:44.719 T:3011713504 INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/kodi/addons: No such file or directory'
2019-10-22 11:22:44.719 T:3011713504 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.'
2019-10-22 11:22:44.719 T:3011713504 NOTICE: ADDON: audioencoder.kodi.builtin.aac v1.0.0 installed
2019-10-22 11:22:44.719 T:3011713504 NOTICE: ADDON: audioencoder.kodi.builtin.wma v1.0.0 installed
2019-10-22 11:22:44.719 T:3011713504 NOTICE: ADDON: driver.dvb.crazycat v9.1.901.0 installed
2019-10-22 11:22:44.719 T:3011713504 NOTICE: ADDON: driver.dvb.dvb-latest v9.1.901.0 installed
2019-10-22 11:22:44.719 T:3011713504 NOTICE: ADDON: game.controller.default v1.0.8 installed
2019-10-22 11:22:44.719 T:3011713504 NOTICE: ADDON: game.controller.snes v1.0.8 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: game.libretro v1.1.0.115 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: kodi.binary.global.audioengine v1.0.1 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: kodi.binary.global.filesystem v1.0.2 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: kodi.binary.global.general v1.0.3 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: kodi.binary.global.gui v5.12.0 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: kodi.binary.global.main v1.0.14 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: kodi.binary.global.network v1.0.0 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: kodi.binary.instance.audiodecoder v2.0.0 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: kodi.binary.instance.audioencoder v2.0.0 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: kodi.binary.instance.game v1.1.0 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: kodi.binary.instance.imagedecoder v2.0.0 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: kodi.binary.instance.inputstream v2.0.8 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: kodi.binary.instance.peripheral v1.3.7 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: kodi.binary.instance.pvr v5.10.3 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: kodi.binary.instance.screensaver v2.0.0 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: kodi.binary.instance.vfs v2.0.0 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: kodi.binary.instance.videocodec v1.0.1 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: kodi.binary.instance.visualization v2.0.1 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: kodi.resource v1.0.0 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: metadata.album.universal v3.1.2 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: metadata.artists.universal v4.3.2 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: metadata.common.allmusic.com v3.2.1 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: metadata.common.fanart.tv v3.6.2 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: metadata.common.imdb.com v3.1.4 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: metadata.common.musicbrainz.org v2.2.1 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: metadata.common.theaudiodb.com v2.0.3 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: metadata.common.themoviedb.org v3.1.10 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: metadata.local v1.0.0 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: metadata.themoviedb.org v5.1.9 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: metadata.tvshows.themoviedb.org v3.1.3 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: os.libreelec.tv v9.1 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: os.openelec.tv v9.1 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: peripheral.joystick v1.4.8 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: plugin.video.svtplay v5.0.4 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: plugin.video.youtube v6.5.1 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: pvr.iptvsimple v3.8.1.1 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: repository.kodi.game v1.0.0 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: repository.libreelec.tv v9.1.901 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: repository.xbmc.org v3.1.6 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: resource.images.weathericons.default v1.1.8 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: resource.language.en_gb v2.0.1 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: resource.language.sv_se v9.0.19 installed
2019-10-22 11:22:44.720 T:3011713504 NOTICE: ADDON: resource.uisounds.kodi v1.0.0 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: screensaver.xbmc.builtin.black v1.0.33 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: screensaver.xbmc.builtin.dim v1.0.57 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: script.module.certifi v2019.9.11 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: script.module.chardet v3.0.4 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: script.module.future v0.17.1 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: script.module.idna v2.8 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: script.module.pil v1.1.7 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: script.module.pycryptodome v3.4.3 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: script.module.requests v2.22.0 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: script.module.six v1.11.0 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: script.module.urllib3 v1.25.3 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: script.program.driverselect v0.1.6 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: service.libreelec.settings v9.0.0 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: service.subtitles.bsplayer v0.2.1 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: skin.estuary v2.0.25 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: weather.gismeteo v0.3.3 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: webinterface.default v18.x-2.4.6 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: xbmc.addon v18.4.0 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: xbmc.core v0.1.0 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: xbmc.gui v5.14.0 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: xbmc.json v10.3.0 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: xbmc.metadata v2.1.0 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: xbmc.python v2.26.0 installed
2019-10-22 11:22:44.721 T:3011713504 NOTICE: ADDON: xbmc.webinterface v1.0.0 installed
2019-10-22 11:22:44.753 T:3011713504 DEBUG: CFavourites::Load - no system favourites found, skipping
2019-10-22 11:22:44.753 T:3011713504 DEBUG: CFavourites::Load - no userdata favourites found, skipping
2019-10-22 11:22:44.756 T:3011713504 DEBUG: DBus method call to org.freedesktop.ConsoleKit.Manager.CanStop at /org/freedesktop/ConsoleKit/Manager of org.freedesktop.ConsoleKit failed: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.ConsoleKit was not provided by any .service files
2019-10-22 11:22:44.756 T:3011713504 INFO: Selected Logind/UPower as PowerSyscall
2019-10-22 11:22:44.757 T:3011713504 ERROR: DBus error: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files
2019-10-22 11:22:44.757 T:3011713504 INFO: LogindUPowerSyscall - UPower not found, battery information will not be available
2019-10-22 11:22:44.768 T:3011713504 DEBUG: LogindUPowerSyscall - inhibit lock taken, fd 18
2019-10-22 11:22:44.778 T:3011713504 DEBUG: DBus method call to org.freedesktop.UPower.EnumerateDevices at /org/freedesktop/UPower of org.freedesktop.UPower failed: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files
2019-10-22 11:22:44.784 T:2989863792 DEBUG: Thread ActiveAE start, auto delete: false
2019-10-22 11:22:44.784 T:2980049776 DEBUG: Thread AESink start, auto delete: false
2019-10-22 11:22:44.785 T:2969564016 DEBUG: Thread FDEventMonitor start, auto delete: false
2019-10-22 11:22:44.794 T:2989863792 INFO: CAESinkALSA - Unable to open device "default" for playback
2019-10-22 11:22:44.803 T:2989863792 DEBUG: PulseAudio: Context authorizing
2019-10-22 11:22:44.804 T:2989863792 DEBUG: PulseAudio: Context setting name
2019-10-22 11:22:44.804 T:2989863792 DEBUG: PulseAudio: Context ready
2019-10-22 11:22:44.805 T:2989863792 WARNING: Pulseaudio module module-allow-passthrough not loaded - opening PT devices might fail
2019-10-22 11:22:44.806 T:2989863792 NOTICE: Found 2 Lists of Devices
2019-10-22 11:22:44.806 T:2989863792 NOTICE: Enumerated PI devices:
2019-10-22 11:22:44.806 T:2989863792 NOTICE: Device 1
2019-10-22 11:22:44.806 T:2989863792 NOTICE: m_deviceName : HDMI
2019-10-22 11:22:44.806 T:2989863792 NOTICE: m_displayName : HDMI
2019-10-22 11:22:44.806 T:2989863792 NOTICE: m_displayNameExtra:
2019-10-22 11:22:44.806 T:2989863792 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
2019-10-22 11:22:44.806 T:2989863792 NOTICE: m_channels : FL, FR
2019-10-22 11:22:44.806 T:2989863792 NOTICE: m_sampleRates : 8000,11025,16000,22050,24000,32000,44100,48000,88200,96000,176400,192000
2019-10-22 11:22:44.806 T:2989863792 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP,AE_FMT_RAW
2019-10-22 11:22:44.806 T:2989863792 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_EAC3,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_512
2019-10-22 11:22:44.806 T:2989863792 NOTICE: Device 2
2019-10-22 11:22:44.806 T:2989863792 NOTICE: m_deviceName : Analogue
2019-10-22 11:22:44.806 T:2989863792 NOTICE: m_displayName : Analogue
2019-10-22 11:22:44.806 T:2989863792 NOTICE: m_displayNameExtra:
2019-10-22 11:22:44.806 T:2989863792 NOTICE: m_deviceType : AE_DEVTYPE_PCM
2019-10-22 11:22:44.806 T:2989863792 NOTICE: m_channels : FL, FR
2019-10-22 11:22:44.806 T:2989863792 NOTICE: m_sampleRates : 48000
2019-10-22 11:22:44.806 T:2989863792 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP
2019-10-22 11:22:44.806 T:2989863792 NOTICE: m_streamTypes : No passthrough capabilities
2019-10-22 11:22:44.806 T:2989863792 NOTICE: Device 3
2019-10-22 11:22:44.806 T:2989863792 NOTICE: m_deviceName : Both
2019-10-22 11:22:44.806 T:2989863792 NOTICE: m_displayName : HDMI and Analogue
2019-10-22 11:22:44.807 T:2989863792 NOTICE: m_displayNameExtra:
2019-10-22 11:22:44.807 T:2989863792 NOTICE: m_deviceType : AE_DEVTYPE_PCM
2019-10-22 11:22:44.807 T:2989863792 NOTICE: m_channels : FL, FR
2019-10-22 11:22:44.807 T:2989863792 NOTICE: m_sampleRates : 48000
2019-10-22 11:22:44.807 T:2989863792 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP
2019-10-22 11:22:44.807 T:2989863792 NOTICE: m_streamTypes : No passthrough capabilities
2019-10-22 11:22:44.807 T:2989863792 NOTICE: Enumerated PULSE devices:
2019-10-22 11:22:44.807 T:2989863792 NOTICE: Device 1
2019-10-22 11:22:44.807 T:2989863792 NOTICE: m_deviceName : Default
2019-10-22 11:22:44.807 T:2989863792 NOTICE: m_displayName : Default
2019-10-22 11:22:44.807 T:2989863792 NOTICE: m_displayNameExtra: Bluetooth Audio (PULSEAUDIO)
2019-10-22 11:22:44.807 T:2989863792 NOTICE: m_deviceType : AE_DEVTYPE_PCM
2019-10-22 11:22:44.807 T:2989863792 NOTICE: m_channels : FL, FR
2019-10-22 11:22:44.807 T:2989863792 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000
2019-10-22 11:22:44.807 T:2989863792 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT
2019-10-22 11:22:44.807 T:2989863792 NOTICE: m_streamTypes : No passthrough capabilities
2019-10-22 11:22:44.808 T:2980049776 INFO: CActiveAESink::OpenSink - initialize sink
2019-10-22 11:22:44.808 T:2980049776 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI
2019-10-22 11:22:44.808 T:2980049776 DEBUG: DllBcm: Using omx system library
2019-10-22 11:22:44.809 T:2980049776 DEBUG: SECTION:LoadDLL(libopenmaxil.so)
2019-10-22 11:22:44.810 T:2980049776 DEBUG: Loading: libopenmaxil.so
2019-10-22 11:22:44.820 T:2980049776 DEBUG: CSettingsManager: requested setting (videoscreen.limitgui) was not found.
2019-10-22 11:22:44.820 T:2980049776 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI
2019-10-22 11:22:44.820 T:2980049776 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008
2019-10-22 11:22:44.821 T:2980049776 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0xb100d308
2019-10-22 11:22:44.823 T:2980049776 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignment(16)
2019-10-22 11:22:44.823 T:2980049776 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized:
2019-10-22 11:22:44.823 T:2980049776 DEBUG: Output Device : HDMI
2019-10-22 11:22:44.823 T:2980049776 DEBUG: Sample Rate : 44100
2019-10-22 11:22:44.823 T:2980049776 DEBUG: Sample Format : AE_FMT_FLOAT
2019-10-22 11:22:44.823 T:2980049776 DEBUG: Channel Count : 2
2019-10-22 11:22:44.823 T:2980049776 DEBUG: Channel Layout: FL, FR
2019-10-22 11:22:44.823 T:2980049776 DEBUG: Frames : 2205
2019-10-22 11:22:44.823 T:2980049776 DEBUG: Frame Size : 8
2019-10-22 11:22:44.831 T:3011713504 INFO: CKeyboardLayoutManager: loading keyboard layouts from special://xbmc/system/keyboardlayouts...
2019-10-22 11:22:44.837 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Arabic QWERTY" successfully loaded
2019-10-22 11:22:44.837 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian ЯВЕРТЪ" successfully loaded
2019-10-22 11:22:44.838 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian АБВ" successfully loaded
2019-10-22 11:22:44.838 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BasePY" successfully loaded
2019-10-22 11:22:44.839 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BaiduPY" successfully loaded
2019-10-22 11:22:44.839 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Croatian QWERTY" successfully loaded
2019-10-22 11:22:44.840 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Czech QWERTZ" successfully loaded
2019-10-22 11:22:44.840 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Danish QWERTY" successfully loaded
2019-10-22 11:22:44.841 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "English QWERTY" successfully loaded
2019-10-22 11:22:44.841 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "English AZERTY" successfully loaded
2019-10-22 11:22:44.841 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "English ABC" successfully loaded
2019-10-22 11:22:44.842 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "French AZERTY" successfully loaded
2019-10-22 11:22:44.842 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "German QWERTZ" successfully loaded
2019-10-22 11:22:44.843 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "German ABC" successfully loaded
2019-10-22 11:22:44.843 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Greek QWERTY" successfully loaded
2019-10-22 11:22:44.844 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew QWERTY" successfully loaded
2019-10-22 11:22:44.844 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew ABC" successfully loaded
2019-10-22 11:22:44.845 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Hungarian QWERTZ" successfully loaded
2019-10-22 11:22:44.845 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Icelandic QWERTY" successfully loaded
2019-10-22 11:22:44.846 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Italian QWERTY" successfully loaded
2019-10-22 11:22:44.846 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Korean ㄱㄴㄷ" successfully loaded
2019-10-22 11:22:44.847 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian AZERTY" successfully loaded
2019-10-22 11:22:44.847 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian QWERTY" successfully loaded
2019-10-22 11:22:44.848 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Norwegian QWERTY" successfully loaded
2019-10-22 11:22:44.849 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Polish QWERTY" successfully loaded
2019-10-22 11:22:44.849 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Portuguese (Portugal) QWERTY" successfully loaded
2019-10-22 11:22:44.850 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Romanian QWERTY" successfully loaded
2019-10-22 11:22:44.850 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian ЙЦУКЕН" successfully loaded
2019-10-22 11:22:44.851 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian АБВ" successfully loaded
2019-10-22 11:22:44.851 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Silesian QWERTY" successfully loaded
2019-10-22 11:22:44.852 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTZ" successfully loaded
2019-10-22 11:22:44.852 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTY" successfully loaded
2019-10-22 11:22:44.852 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak ABC" successfully loaded
2019-10-22 11:22:44.853 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovenian QWERTZ" successfully loaded
2019-10-22 11:22:44.853 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Spanish QWERTY" successfully loaded
2019-10-22 11:22:44.854 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Swedish QWERTY" successfully loaded
2019-10-22 11:22:44.855 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Thai Kedmanee" successfully loaded
2019-10-22 11:22:44.855 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Turkish QWERTY" successfully loaded
2019-10-22 11:22:44.856 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian ЙЦУКЕН" successfully loaded
2019-10-22 11:22:44.856 T:3011713504 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian АБВ" successfully loaded
2019-10-22 11:22:44.857 T:3011713504 DEBUG: DBus method call to org.freedesktop.DBus.Peer.Ping at /org/freedesktop/UDisks2 of org.freedesktop.UDisks2 failed: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UDisks2 was not provided by any .service files
2019-10-22 11:22:44.858 T:3011713504 DEBUG: DBus method call to org.freedesktop.UDisks.EnumerateDevices at /org/freedesktop/UDisks of org.freedesktop.UDisks failed: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UDisks was not provided by any .service files
2019-10-22 11:22:44.860 T:3011713504 DEBUG: Selected UDev as storage provider
2019-10-22 11:22:44.861 T:3011713504 NOTICE: Raspberry PI firmware version: Aug 9 2019 17:25:57
Copyright (c) 2012 Broadcom
version 9f8431fb7839c7f00f52b81f5822ddab2b31d0db (clean) (release) (start_x)
2019-10-22 11:22:44.861 T:3011713504 NOTICE: ARM mem: 704MB GPU mem: 320MB MPG2:0 WVC1:0
2019-10-22 11:22:44.862 T:3011713504 NOTICE: Config:
arm_freq=1500
audio_pwm_mode=514
config_hdmi_boost=5
core_freq=550
core_freq_min=275
disable_commandline_tags=2
disable_l2cache=1
disable_overscan=1
display_hdmi_rotate=-1
display_lcd_rotate=-1
enable_gic=1
force_eeprom_read=1
force_pwm_open=1
framebuffer_ignore_alpha=1
framebuffer_swap=1
gpu_freq=500
gpu_freq_min=500
hdmi_channel_map=8
hdmi_enable_4kp60=1
hdmi_samples_limit=0x1f4000
init_uart_clock=0x2dc6c00
lcd_framerate=60
mask_gpu_interrupt0=1024
mask_gpu_interrupt1=0x10000
max_framebuffer_height=2160
max_framebuffer_width=3840
over_voltage_avs=10000
pause_burst_frames=1
program_serial_random=1
hdmi_force_cec_address:0=65535
hdmi_force_cec_address:1=65535
hdmi_ignore_cec_init:0=1
hdmi_pixel_freq_limit:0=0x23c34600
hdmi_pixel_freq_limit:1=0x9a7ec80
2019-10-22 11:22:44.862 T:3011713504 NOTICE: Config:
device_tree=-
hdmi_cvt:0=
hdmi_cvt:1=
hdmi_edid_filename:0=
hdmi_edid_filename:1=
hdmi_timings:0=
hdmi_timings:1=
2019-10-22 11:22:44.862 T:3011713504 INFO: RetroPlayer[PROCESS]: Registering process control for GBM
2019-10-22 11:22:44.862 T:3011713504 INFO: RetroPlayer[RENDER]: Registering renderer factory for OpenGLES
2019-10-22 11:22:45.022 T:3011713504 DEBUG: CDRMUtils::FindConnector - found connector: 51
2019-10-22 11:22:45.022 T:3011713504 DEBUG: CDRMUtils::OpenDrm - opened device: /dev/dri/card0 using module: vc4
2019-10-22 11:22:45.053 T:3011713504 DEBUG: CDRMUtils::FindConnector - found connector: 51
2019-10-22 11:22:45.053 T:3011713504 DEBUG: CDRMUtils::FindEncoder - found encoder: 50
2019-10-22 11:22:45.053 T:3011713504 DEBUG: CDRMUtils::FindCrtc - found crtc: 49
2019-10-22 11:22:45.053 T:3011713504 DEBUG: CDRMUtils::FindPlane - found video plane 28
2019-10-22 11:22:45.053 T:3011713504 WARNING: CDRMUtils::FindPlane - could not find plane
2019-10-22 11:22:45.054 T:3011713504 DEBUG: CDRMUtils::FindPlane - found gui plane 35
2019-10-22 11:22:45.054 T:3011713504 DEBUG: CDRMUtils::FindPreferredMode - found preferred mode: 1920x1080 @ 60 Hz
2019-10-22 11:22:45.054 T:3011713504 DEBUG: CDRMAtomic::InitDrm - initialized atomic DRM
2019-10-22 11:22:45.134 T:3011713504 DEBUG: CWinSystemGbm::InitWindowSystem - initialized DRM
2019-10-22 11:22:45.134 T:3011713504 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 60.000000 Hz
2019-10-22 11:22:45.134 T:3011713504 NOTICE: Found resolution 1920x1080 with 4096x2160 @ 60.000000 Hz
2019-10-22 11:22:45.134 T:3011713504 NOTICE: Found resolution 1920x1080 with 4096x2160 @ 59.940063 Hz
2019-10-22 11:22:45.134 T:3011713504 NOTICE: Found resolution 1920x1080 with 4096x2160 @ 50.000000 Hz
2019-10-22 11:22:45.134 T:3011713504 NOTICE: Found resolution 1920x1080 with 4096x2160 @ 24.000000 Hz
2019-10-22 11:22:45.134 T:3011713504 NOTICE: Found resolution 1920x1080 with 4096x2160 @ 23.976025 Hz
2019-10-22 11:22:45.134 T:3011713504 NOTICE: Found resolution 1920x1080 with 3840x2160 @ 60.000000 Hz
2019-10-22 11:22:45.134 T:3011713504 NOTICE: Found resolution 1920x1080 with 3840x2160 @ 59.940063 Hz
2019-10-22 11:22:45.134 T:3011713504 NOTICE: Found resolution 1920x1080 with 3840x2160 @ 50.000000 Hz
2019-10-22 11:22:45.134 T:3011713504 NOTICE: Found resolution 1920x1080 with 3840x2160 @ 30.000000 Hz
2019-10-22 11:22:45.134 T:3011713504 NOTICE: Found resolution 1920x1080 with 3840x2160 @ 29.970032 Hz
2019-10-22 11:22:45.134 T:3011713504 NOTICE: Found resolution 1920x1080 with 3840x2160 @ 25.000000 Hz
2019-10-22 11:22:45.134 T:3011713504 NOTICE: Found resolution 1920x1080 with 3840x2160 @ 24.000000 Hz
2019-10-22 11:22:45.134 T:3011713504 NOTICE: Found resolution 1920x1080 with 3840x2160 @ 23.976025 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 59.940063 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 50.000000 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 30.000000 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 29.970032 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 24.000000 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 23.976025 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 1680x1050 with 1680x1050 @ 60.000000 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 1600x900 with 1600x900 @ 60.000000 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 1280x1024 with 1280x1024 @ 60.000000 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 1152x864 with 1152x864 @ 75.000000 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 1280x720 with 1280x720 @ 60.000000 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 1280x720 with 1280x720 @ 59.940063 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 1280x720 with 1280x720 @ 50.000000 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 1280x720 with 1280x720 @ 30.000000 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 1280x720 with 1280x720 @ 29.970032 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 1280x720 with 1280x720 @ 24.000000 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 1280x720 with 1280x720 @ 23.976025 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 1024x768 with 1024x768 @ 60.000000 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 800x600 with 800x600 @ 60.000000 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 720x576 with 720x576 @ 50.000000 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 720x480 with 720x480 @ 59.940063 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 720x480 with 720x480 @ 60.000000 Hz
2019-10-22 11:22:45.135 T:3011713504 NOTICE: Found resolution 640x480 with 640x480 @ 60.000000 Hz
2019-10-22 11:22:45.137 T:3011713504 NOTICE: Previous line repeats 1 times.
2019-10-22 11:22:45.137 T:3011713504 NOTICE: EGL_VERSION = 1.4
2019-10-22 11:22:45.137 T:3011713504 NOTICE: EGL_VENDOR = Mesa Project
2019-10-22 11:22:45.137 T:3011713504 NOTICE: EGL_EXTENSIONS = EGL_EXT_buffer_age EGL_EXT_image_dma_buf_import EGL_EXT_image_dma_buf_import_modifiers EGL_KHR_cl_event2 EGL_KHR_config_attribs EGL_KHR_create_context EGL_KHR_create_context_no_error EGL_KHR_fence_sync EGL_KHR_get_all_proc_addresses EGL_KHR_gl_colorspace EGL_KHR_gl_renderbuffer_image EGL_KHR_gl_texture_2D_image EGL_KHR_gl_texture_3D_image EGL_KHR_gl_texture_cubemap_image EGL_KHR_image EGL_KHR_image_base EGL_KHR_image_pixmap EGL_KHR_no_config_context EGL_KHR_reusable_sync EGL_KHR_surfaceless_context EGL_EXT_pixel_format_float EGL_KHR_wait_sync EGL_MESA_configless_context EGL_MESA_drm_image EGL_MESA_image_dma_buf_export
2019-10-22 11:22:45.137 T:3011713504 NOTICE: EGL_CLIENT_EXTENSIONS = EGL_EXT_client_extensions EGL_EXT_device_base EGL_EXT_device_enumeration EGL_EXT_device_query EGL_EXT_platform_base EGL_KHR_client_get_all_proc_addresses EGL_KHR_debug EGL_MESA_platform_gbm
2019-10-22 11:22:45.137 T:3011713504 DEBUG: EGL Config Attributes:
2019-10-22 11:22:45.137 T:3011713504 DEBUG: EGL_BUFFER_SIZE: 32
2019-10-22 11:22:45.137 T:3011713504 DEBUG: EGL_ALPHA_SIZE: 8
2019-10-22 11:22:45.137 T:3011713504 DEBUG: EGL_BLUE_SIZE: 8
2019-10-22 11:22:45.137 T:3011713504 DEBUG: EGL_GREEN_SIZE: 8
2019-10-22 11:22:45.137 T:3011713504 DEBUG: EGL_RED_SIZE: 8
2019-10-22 11:22:45.137 T:3011713504 DEBUG: EGL_DEPTH_SIZE: 16
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_STENCIL_SIZE: 0
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_CONFIG_CAVEAT: 0x3038
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_CONFIG_ID: 10
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_LEVEL: 0
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_MAX_PBUFFER_HEIGHT: 4096
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_MAX_PBUFFER_PIXELS: 0
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_MAX_PBUFFER_WIDTH: 4096
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_NATIVE_RENDERABLE: 1
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_NATIVE_VISUAL_ID: 875713089
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_NATIVE_VISUAL_TYPE: 0x3038
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_SAMPLES: 0
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_SAMPLE_BUFFERS: 0
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_SURFACE_TYPE: 4
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_TRANSPARENT_TYPE: 0x3038
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_TRANSPARENT_BLUE_VALUE: 0
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_TRANSPARENT_GREEN_VALUE: 0
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_TRANSPARENT_RED_VALUE: 0
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_BIND_TO_TEXTURE_RGB: 0
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_BIND_TO_TEXTURE_RGBA: 0
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_MIN_SWAP_INTERVAL: 1
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_MAX_SWAP_INTERVAL: 1
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_LUMINANCE_SIZE: 0
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_ALPHA_MASK_SIZE: 0
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_COLOR_BUFFER_TYPE: 0x308e
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_RENDERABLE_TYPE: 77
2019-10-22 11:22:45.138 T:3011713504 DEBUG: EGL_CONFORMANT: 77
2019-10-22 11:22:45.142 T:3011713504 NOTICE: Checking resolution 24
2019-10-22 11:22:45.142 T:3011713504 DEBUG: OnLostDevice - notify display change event
2019-10-22 11:22:45.281 T:2980049776 DEBUG: CAESinkPi:Drain delay:100ms now:0ms
2019-10-22 11:22:45.281 T:2980049776 DEBUG: CAESinkPi:Deinitialize
2019-10-22 11:22:45.281 T:2980049776 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000
2019-10-22 11:22:45.285 T:2980049776 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0xb100d308
2019-10-22 11:22:45.285 T:3011713504 WARNING: CGBMUtils::DestroySurface - surface already destroyed
2019-10-22 11:22:45.285 T:3011713504 DEBUG: CWinSystemGbmEGLContext::DestroyWindow - deinitialized GBM
2019-10-22 11:22:45.315 T:3011713504 DEBUG: CDRMUtils::SetMode - found crtc mode: 3840x2160 @ 60 Hz
2019-10-22 11:22:45.315 T:3011713504 DEBUG: CGBMUtils::CreateSurface - created surface with size 1920x1080
2019-10-22 11:22:45.331 T:3011713504 DEBUG: CWinSystemGbmEGLContext::CreateNewWindow - initialized GBM
2019-10-22 11:22:45.331 T:3011713504 NOTICE: GL_VENDOR = Broadcom
2019-10-22 11:22:45.331 T:3011713504 NOTICE: GL_RENDERER = V3D 4.2
2019-10-22 11:22:45.331 T:3011713504 NOTICE: GL_VERSION = OpenGL ES 3.0 Mesa 19.1.5
2019-10-22 11:22:45.331 T:3011713504 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 3.00
2019-10-22 11:22:45.331 T:3011713504 NOTICE: GL_EXTENSIONS = GL_EXT_blend_minmax GL_EXT_multi_draw_arrays GL_EXT_texture_format_BGRA8888 GL_OES_compressed_ETC1_RGB8_texture GL_OES_depth24 GL_OES_element_index_uint GL_OES_fbo_render_mipmap GL_OES_mapbuffer GL_OES_rgb8_rgba8 GL_OES_standard_derivatives GL_OES_stencil8 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_EXT_texture_sRGB_decode GL_OES_EGL_image GL_OES_depth_texture GL_OES_packed_depth_stencil GL_EXT_texture_type_2_10_10_10_REV GL_OES_get_program_binary GL_APPLE_texture_max_level GL_EXT_discard_framebuffer GL_EXT_read_format_bgra GL_EXT_frag_depth GL_NV_fbo_color_attachments GL_OES_EGL_image_external GL_OES_EGL_sync GL_OES_vertex_array_object GL_EXT_occlusion_query_boolean GL_EXT_texture_rg GL_EXT_unpack_subimage GL_NV_draw_buffers GL_NV_read_buffer GL_NV_read_depth GL_NV_read_depth_stencil GL_NV_read_stencil GL_EXT_draw_buffers GL_EXT_map_buffer_range GL_KHR_debug GL_KHR_texture_compression_astc_ldr GL_OES_depth_texture_cube_map GL_OES_required_internalformat GL_OES_surfaceless_context GL_EXT_color_buffer_float GL_EXT_sRGB_write_control GL_EXT_separate_shader_objects GL_EXT_shader_integer_mix GL_EXT_base_instance GL_EXT_compressed_ETC1_RGB8_sub_texture GL_EXT_draw_elements_base_vertex GL_EXT_texture_border_clamp GL_KHR_context_flush_control GL_OES_draw_elements_base_vertex GL_OES_texture_border_clamp GL_OES_texture_stencil8 GL_EXT_float_blend GL_KHR_no_error GL_KHR_texture_compression_astc_sliced_3d GL_OES_EGL_image_external_essl3 GL_MESA_shader_integer_functions GL_KHR_parallel_shader_compile GL_EXT_texture_query_lod
2019-10-22 11:22:46.047 T:3011713504 DEBUG: OnLostDevice - notify display change event
2019-10-22 11:22:46.076 T:3011713504 DEBUG: CDRMUtils::SetMode - found crtc mode: 3840x2160 @ 60 Hz
2019-10-22 11:22:46.076 T:3011713504 INFO: GLES: Maximum texture width: 4096
2019-10-22 11:22:46.077 T:2989863792 DEBUG: CActiveAE - display reset event
2019-10-22 11:22:46.077 T:3011713504 DEBUG: guilib: Fill viewport on change for solving rendering passes
2019-10-22 11:22:46.077 T:2980049776 INFO: CActiveAESink::OpenSink - initialize sink
2019-10-22 11:22:46.077 T:2980049776 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI
2019-10-22 11:22:46.077 T:2980049776 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI
2019-10-22 11:22:46.077 T:2980049776 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008
2019-10-22 11:22:46.078 T:2980049776 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0xb100d308
2019-10-22 11:22:46.080 T:2980049776 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignment(16)
2019-10-22 11:22:46.081 T:2980049776 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized:
2019-10-22 11:22:46.081 T:2980049776 DEBUG: Output Device : HDMI
2019-10-22 11:22:46.081 T:2980049776 DEBUG: Sample Rate : 44100
2019-10-22 11:22:46.081 T:2980049776 DEBUG: Sample Format : AE_FMT_FLOAT
2019-10-22 11:22:46.081 T:2980049776 DEBUG: Channel Count : 2
2019-10-22 11:22:46.081 T:2980049776 DEBUG: Channel Layout: FL, FR
2019-10-22 11:22:46.081 T:2980049776 DEBUG: Frames : 2205
2019-10-22 11:22:46.081 T:2980049776 DEBUG: Frame Size : 8
2019-10-22 11:22:46.083 T:2989863792 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
2019-10-22 11:22:46.590 T:3011713504 DEBUG: EGL Debugging:
Error: EGL_BAD_SURFACE
Command: eglSwapBuffers
Type: EGL_DEBUG_MSG_ERROR_KHR
Message: dri2_swap_buffers
2019-10-22 11:22:46.761 T:3011713504 DEBUG: CRBP::OpenDisplay device:0 m_display:10000020 (0)
2019-10-22 11:22:46.761 T:3011713504 INFO: load keymapping
2019-10-22 11:22:46.763 T:3011713504 INFO: Loading special://xbmc/system/keymaps/appcommand.xml
2019-10-22 11:22:46.764 T:3011713504 INFO: Loading special://xbmc/system/keymaps/customcontroller.AppleRemote.xml
2019-10-22 11:22:46.765 T:3011713504 INFO: Loading special://xbmc/system/keymaps/customcontroller.Harmony.xml
2019-10-22 11:22:46.768 T:3011713504 INFO: Loading special://xbmc/system/keymaps/gamepad.xml
2019-10-22 11:22:46.770 T:3011713504 INFO: Loading special://xbmc/system/keymaps/joystick.xml
2019-10-22 11:22:46.772 T:3011713504 INFO: Loading special://xbmc/system/keymaps/keyboard.xml
2019-10-22 11:22:46.779 T:3011713504 INFO: Loading special://xbmc/system/keymaps/mouse.xml
2019-10-22 11:22:46.780 T:3011713504 INFO: Loading special://xbmc/system/keymaps/remote.xml
2019-10-22 11:22:46.784 T:3011713504 INFO: Loading special://xbmc/system/keymaps/touchscreen.xml
2019-10-22 11:22:46.789 T:3011713504 INFO: GUI format 1920x1080, Display 3840x2160 @ 59.940063 Hz
2019-10-22 11:22:46.789 T:3011713504 INFO: CLangInfo: loading resource.language.sv_se language information...
2019-10-22 11:22:46.790 T:3011713504 DEBUG: trying to set locale to sv_SE.UTF-8
2019-10-22 11:22:46.798 T:3011713504 INFO: global locale set to C
2019-10-22 11:22:46.798 T:3011713504 INFO: CLangInfo: loading resource.language.sv_se language strings...
2019-10-22 11:22:46.842 T:3011713504 DEBUG: LocalizeStrings: loaded 4000 strings from file resource://resource.language.sv_se/strings.po
2019-10-22 11:22:46.871 T:3011713504 DEBUG: LocalizeStrings: loaded 21 strings from file resource://resource.language.en_gb/strings.po
2019-10-22 11:22:46.883 T:3011713504 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.kodi.builtin.aac/resources/language/English/strings.po
2019-10-22 11:22:46.884 T:3011713504 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.kodi.builtin.wma/resources/language/English/strings.po
2019-10-22 11:22:46.886 T:3011713504 DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/game.controller.default/resources/language/resource.language.en_gb/strings.po
2019-10-22 11:22:46.889 T:3011713504 DEBUG: LocalizeStrings: loaded 13 strings from file /usr/share/kodi/addons/game.controller.snes/resources/language/resource.language.en_gb/strings.po
2019-10-22 11:22:46.894 T:3011713504 DEBUG: LocalizeStrings: loaded 11 strings from file /storage/.kodi/addons/metadata.album.universal/resources/language/resource.language.sv_se/strings.po
2019-10-22 11:22:46.895 T:3011713504 DEBUG: LocalizeStrings: loaded 6 strings from file /storage/.kodi/addons/metadata.album.universal/resources/language/resource.language.en_gb/strings.po
2019-10-22 11:22:46.898 T:3011713504 DEBUG: LocalizeStrings: loaded 23 strings from file /storage/.kodi/addons/metadata.artists.universal/resources/language/resource.language.sv_se/strings.po
2019-10-22 11:22:46.899 T:3011713504 DEBUG: LocalizeStrings: loaded 9 strings from file /storage/.kodi/addons/metadata.artists.universal/resources/language/resource.language.en_gb/strings.po
2019-10-22 11:22:46.909 T:3011713504 DEBUG: LocalizeStrings: loaded 7 strings from file /storage/.kodi/addons/metadata.themoviedb.org/resources/language/resource.language.sv_se/strings.po
2019-10-22 11:22:46.911 T:3011713504 DEBUG: POParser: id:30003 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead
2019-10-22 11:22:46.911 T:3011713504 DEBUG: LocalizeStrings: loaded 2 strings from file /storage/.kodi/addons/metadata.themoviedb.org/resources/language/resource.language.en_gb/strings.po
2019-10-22 11:22:46.913 T:3011713504 DEBUG: LocalizeStrings: loaded 3 strings from file /storage/.kodi/addons/metadata.tvshows.themoviedb.org/resources/language/resource.language.sv_se/strings.po
2019-10-22 11:22:46.914 T:3011713504 DEBUG: LocalizeStrings: loaded 2 strings from file /storage/.kodi/addons/metadata.tvshows.themoviedb.org/resources/language/resource.language.en_gb/strings.po
2019-10-22 11:22:46.917 T:3011713504 DEBUG: LocalizeStrings: loaded 9 strings from file /usr/share/kodi/addons/peripheral.joystick/resources/language/resource.language.en_gb/strings.po
2019-10-22 11:22:46.926 T:3011713504 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.sv_se/strings.po
2019-10-22 11:22:46.926 T:3011713504 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.en_gb/strings.po
2019-10-22 11:22:46.928 T:3011713504 DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/script.program.driverselect/resources/language/resource.language.en_gb/strings.po
2019-10-22 11:22:46.934 T:3011713504 DEBUG: LocalizeStrings: loaded 228 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/resource.language.sv_se/strings.po
2019-10-22 11:22:46.935 T:3011713504 DEBUG: POParser: id:722 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead
2019-10-22 11:22:46.935 T:3011713504 DEBUG: LocalizeStrings: loaded 21 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/resource.language.en_gb/strings.po
2019-10-22 11:22:46.943 T:3011713504 DEBUG: LocalizeStrings: loaded 57 strings from file /storage/.kodi/addons/weather.gismeteo/resources/language/English/strings.po
2019-10-22 11:22:46.947 T:3011713504 DEBUG: LocalizeStrings: loaded 22 strings from file /storage/.kodi/addons/pvr.iptvsimple/resources/language/resource.language.sv_se/strings.po
2019-10-22 11:22:46.949 T:3011713504 DEBUG: LocalizeStrings: loaded 0 strings from file /storage/.kodi/addons/pvr.iptvsimple/resources/language/resource.language.en_gb/strings.po
2019-10-22 11:22:46.962 T:3011713504 DEBUG: LocalizeStrings: loaded 290 strings from file /storage/.kodi/addons/plugin.video.youtube/resources/language/resource.language.en_gb/strings.po
2019-10-22 11:22:46.964 T:3011713504 DEBUG: LocalizeStrings: loaded 28 strings from file /storage/.kodi/addons/plugin.video.svtplay/resources/language/resource.language.sv_se/strings.po
2019-10-22 11:22:46.965 T:3011713504 DEBUG: LocalizeStrings: loaded 1 strings from file /storage/.kodi/addons/plugin.video.svtplay/resources/language/resource.language.en_gb/strings.po
2019-10-22 11:22:46.967 T:3011713504 DEBUG: LocalizeStrings: loaded 1 strings from file /storage/.kodi/addons/game.libretro/resources/language/English/strings.po
2019-10-22 11:22:46.970 T:3011713504 DEBUG: LocalizeStrings: loaded 2 strings from file /storage/.kodi/addons/service.subtitles.bsplayer/resources/language/English/strings.po
2019-10-22 11:22:46.970 T:2876646256 DEBUG: Thread JobWorker start, auto delete: true
2019-10-22 11:22:46.971 T:2876646256 DEBUG: Initialize, updating databases...
2019-10-22 11:22:46.973 T:2876646256 NOTICE: Running database version Addons27
2019-10-22 11:22:46.977 T:2876646256 NOTICE: Running database version ViewModes6
2019-10-22 11:22:47.018 T:2876646256 NOTICE: Running database version Textures13
2019-10-22 11:22:47.028 T:2876646256 NOTICE: Running database version MyMusic72
2019-10-22 11:22:47.177 T:2876646256 NOTICE: MYSQL: Connected to version 10.4.7-MariaDB-log
2019-10-22 11:22:47.350 T:2876646256 NOTICE: Running database version sassa116
2019-10-22 11:22:47.493 T:2876646256 NOTICE: Running database version TV32
2019-10-22 11:22:47.498 T:2876646256 NOTICE: Running database version Epg12
2019-10-22 11:22:47.498 T:2876646256 DEBUG: Initialize, updating databases... DONE
2019-10-22 11:22:47.513 T:3011713504 NOTICE: start dvd mediatype detection
2019-10-22 11:22:47.513 T:2992853872 DEBUG: Thread DetectDVDMedia start, auto delete: false
2019-10-22 11:22:47.513 T:3011713504 DEBUG: DPMS: supported power-saving modes: OFF
2019-10-22 11:22:47.513 T:2992853872 DEBUG: Compiled with libcdio Version 0.94
2019-10-22 11:22:47.515 T:2992853872 DEBUG: Thread DetectDVDMedia 2992853872 terminating
2019-10-22 11:22:47.541 T:3011699568 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
2019-10-22 11:22:47.541 T:3011699568 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
2019-10-22 11:22:47.564 T:3011713504 INFO: Unloading old skin ...
2019-10-22 11:22:47.567 T:3011713504 NOTICE: load skin from: /storage/.kodi/addons/skin.estuary (version: 2.0.25)
2019-10-22 11:22:47.567 T:3011713504 INFO: load fonts for skin...
2019-10-22 11:22:47.573 T:3011713504 INFO: Loading skin includes from /storage/.kodi/addons/skin.estuary/xml/Includes.xml
2019-10-22 11:22:47.718 T:3011713504 INFO: Loading fonts from /storage/.kodi/addons/skin.estuary/xml/Font.xml
2019-10-22 11:22:47.818 T:3011713504 DEBUG: LocalizeStrings: loaded 140 strings from file /storage/.kodi/addons/skin.estuary/language/resource.language.sv_se/strings.po
2019-10-22 11:22:47.821 T:3011713504 DEBUG: LocalizeStrings: loaded 0 strings from file /storage/.kodi/addons/skin.estuary/language/resource.language.en_gb/strings.po
2019-10-22 11:22:47.821 T:3011713504 INFO: load new skin...
2019-10-22 11:22:47.821 T:3011713504 INFO: Loading custom window XMLs from skin path /storage/.kodi/addons/skin.estuary/xml
2019-10-22 11:22:47.836 T:3011713504 DEBUG: Load Skin XML: 14.73ms
2019-10-22 11:22:47.836 T:3011713504 INFO: initialize new skin...
2019-10-22 11:22:47.836 T:3011713504 DEBUG: guilib: Fill viewport on change for solving rendering passes
2019-10-22 11:22:47.836 T:3011713504 INFO: Loading skin file: Custom_1109_TopBarOverlay.xml, load type: LOAD_ON_GUI_INIT
2019-10-22 11:22:47.840 T:3011713504 INFO: Loading skin file: DialogNotification.xml, load type: LOAD_ON_GUI_INIT
2019-10-22 11:22:47.841 T:3011713504 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT
2019-10-22 11:22:47.871 T:3011713504 DEBUG: OpenBundle - Opened bundle /storage/.kodi/addons/skin.estuary/media/Textures.xbt
2019-10-22 11:22:47.873 T:3011713504 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT
2019-10-22 11:22:47.876 T:3011713504 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
2019-10-22 11:22:47.878 T:3011713504 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT
2019-10-22 11:22:47.880 T:3011713504 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT
2019-10-22 11:22:47.882 T:3011713504 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
2019-10-22 11:22:47.885 T:3011713504 INFO: Loading resource://resource.uisounds.kodi/sounds.xml
2019-10-22 11:22:47.926 T:3011713504 INFO: skin loaded...
2019-10-22 11:22:47.926 T:3011713504 DEBUG: Activating window ID: 12997
2019-10-22 11:22:47.926 T:3011713504 DEBUG: ------ Window Init () ------
2019-10-22 11:22:47.926 T:3011713504 DEBUG: Activating window ID: 12999
2019-10-22 11:22:47.926 T:3011713504 DEBUG: ------ Window Init (Startup.xml) ------
2019-10-22 11:22:47.926 T:3011713504 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME
2019-10-22 11:22:47.929 T:3011713504 DEBUG: Activating window ID: 10000
2019-10-22 11:22:47.929 T:3011713504 DEBUG: ------ Window Deinit (Startup.xml) ------
2019-10-22 11:22:47.929 T:3011713504 DEBUG: ------ Window Init (Home.xml) ------
2019-10-22 11:22:47.929 T:3011713504 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY
2019-10-22 11:22:49.204 T:3011713504 DEBUG: CDirectoryProvider[library://video/movies/]: refreshing..
2019-10-22 11:22:49.204 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/rolf.inpro.xsp]: refreshing..
2019-10-22 11:22:49.204 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/rolf.recent.xsp]: refreshing..
2019-10-22 11:22:49.204 T:2868253552 DEBUG: Thread JobWorker start, auto delete: true
2019-10-22 11:22:49.204 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/rolf.unw.xsp]: refreshing..
2019-10-22 11:22:49.205 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/rolf.rand.xsp]: refreshing..
2019-10-22 11:22:49.205 T:2859860848 DEBUG: Thread JobWorker start, auto delete: true
2019-10-22 11:22:49.205 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/rolf.genre.xsp]: refreshing..
2019-10-22 11:22:49.205 T:3011713504 DEBUG: CDirectoryProvider[videodb://movies/sets/]: refreshing..
2019-10-22 11:22:49.205 T:3011713504 DEBUG: CDirectoryProvider[library://video/slasken/]: refreshing..
2019-10-22 11:22:49.205 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/slask.inpro.xsp]: refreshing..
2019-10-22 11:22:49.205 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/slask.recent.xsp]: refreshing..
2019-10-22 11:22:49.205 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/slask.unw.xsp]: refreshing..
2019-10-22 11:22:49.205 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/slask.rand.xsp]: refreshing..
2019-10-22 11:22:49.205 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/slask.genre.xsp]: refreshing..
2019-10-22 11:22:49.205 T:3011713504 DEBUG: CDirectoryProvider[videodb://movies/sets/]: refreshing..
2019-10-22 11:22:49.205 T:3011713504 DEBUG: CDirectoryProvider[library://video/barnfilm/]: refreshing..
2019-10-22 11:22:49.205 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/barnfilm.inpro.xsp]: refreshing..
2019-10-22 11:22:49.206 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/barnfilm.recent.xsp]: refreshing..
2019-10-22 11:22:49.206 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/barnfilm.unw.xsp]: refreshing..
2019-10-22 11:22:49.206 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/barnfilm.rand.xsp]: refreshing..
2019-10-22 11:22:49.206 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/barnfilm.genre.xsp]: refreshing..
2019-10-22 11:22:49.206 T:3011713504 DEBUG: CDirectoryProvider[videodb://movies/sets/]: refreshing..
2019-10-22 11:22:49.206 T:3011713504 DEBUG: CDirectoryProvider[library://video/tvshows/]: refreshing..
2019-10-22 11:22:49.206 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/rolftv.inpro.xsp]: refreshing..
2019-10-22 11:22:49.206 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/rolftv.recent.xsp]: refreshing..
2019-10-22 11:22:49.206 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/rolftv.unw.xsp]: refreshing..
2019-10-22 11:22:49.206 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/rolftv.genre.xsp]: refreshing..
2019-10-22 11:22:49.206 T:3011713504 DEBUG: CDirectoryProvider[videodb://tvshows/studios/]: refreshing..
2019-10-22 11:22:49.207 T:3011713504 DEBUG: CDirectoryProvider[library://video/barntv/]: refreshing..
2019-10-22 11:22:49.207 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/barntv.inpro.xsp]: refreshing..
2019-10-22 11:22:49.207 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/barntv.recent.xsp]: refreshing..
2019-10-22 11:22:49.207 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/barntv.unw.xsp]: refreshing..
2019-10-22 11:22:49.207 T:3011713504 DEBUG: CDirectoryProvider[special://profile/playlists/video/barntv.genre.xsp]: refreshing..
2019-10-22 11:22:49.207 T:3011713504 DEBUG: CDirectoryProvider[videodb://tvshows/studios/]: refreshing..
2019-10-22 11:22:49.218 T:3011713504 DEBUG: CDirectoryProvider[addons://]: refreshing..
2019-10-22 11:22:49.218 T:3011713504 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing..
2019-10-22 11:22:49.218 T:3011713504 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing..
2019-10-22 11:22:49.218 T:3011713504 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing..
2019-10-22 11:22:49.218 T:3011713504 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing..
2019-10-22 11:22:49.218 T:3011713504 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing..
2019-10-22 11:22:49.218 T:3011713504 DEBUG: CDirectoryProvider[library://video/]: refreshing..
2019-10-22 11:22:49.218 T:3011713504 DEBUG: CDirectoryProvider[sources://video/]: refreshing..
2019-10-22 11:22:49.218 T:3011713504 DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing..
2019-10-22 11:22:49.219 T:3011713504 DEBUG: CDirectoryProvider[pvr://channels/tv/?view=lastplayed]: refreshing..
2019-10-22 11:22:49.219 T:3011713504 DEBUG: CDirectoryProvider[pvr://recordings/tv/active?view=flat]: refreshing..
2019-10-22 11:22:49.219 T:3011713504 DEBUG: CDirectoryProvider[pvr://channels/radio/
?view=lastplayed]: refreshing..
2019-10-22 11:22:49.219 T:3011713504 DEBUG: CDirectoryProvider[pvr://recordings/radio/active?view=flat]: refreshing..
2019-10-22 11:22:49.219 T:3011713504 DEBUG: CDirectoryProvider[favourites://]: refreshing..
2019-10-22 11:22:49.219 T:3011713504 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing..
2019-10-22 11:22:49.245 T:3011713504 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting
2019-10-22 11:22:49.245 T:3011713504 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList"
2019-10-22 11:22:49.245 T:3011713504 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting")
2019-10-22 11:22:49.246 T:3011713504 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting
2019-10-22 11:22:49.274 T:3011713504 INFO: JSONRPC v10.3.0: Successfully initialized
2019-10-22 11:22:49.276 T:3011713504 DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid"
2019-10-22 11:22:49.276 T:3011713504 DEBUG: LoadMappings - loaded node "CEC Adapter"
2019-10-22 11:22:49.276 T:3011713504 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter"
2019-10-22 11:22:49.276 T:3011713504 DEBUG: LoadMappings - loaded node "iMON HID device"
2019-10-22 11:22:49.276 T:3011713504 DEBUG: LoadMappings - loaded node "WETEK Play remote"
2019-10-22 11:22:49.276 T:3011713504 DEBUG: LoadMappings - loaded node ""
2019-10-22 11:22:49.276 T:3011713504 DEBUG: CPeripheralBusUSB - initialised udev monitor
2019-10-22 11:22:49.277 T:3011713504 DEBUG: Add-on bus: Registering add-on peripheral.joystick
2019-10-22 11:22:49.277 T:3011713504 DEBUG: PERIPHERAL - CreateAddon - creating peripheral add-on instance 'Joystick Support'
2019-10-22 11:22:49.277 T:3011713504 DEBUG: ADDON: Dll Initializing - Joystick Support
2019-10-22 11:22:49.277 T:3011713504 DEBUG: SECTION:LoadDLL(/usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.4.8)
2019-10-22 11:22:49.277 T:3011713504 DEBUG: Loading: /usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.4.8
2019-10-22 11:22:49.290 T:3011713504 DEBUG: AddOnLog: Joystick Support: Loaded 14 joystick families with 97 total joysticks
2019-10-22 11:22:49.290 T:3011713504 DEBUG: Calling TransferSettings for: Joystick Support
2019-10-22 11:22:49.290 T:3011713504 DEBUG: CAddonSettings[peripheral.joystick]: loading setting definitions
2019-10-22 11:22:49.291 T:3011713504 INFO: AddOnLog: Joystick Support: Enabling joystick interface "linux"
2019-10-22 11:22:49.291 T:2843075440 DEBUG: Thread PeripBusUSBUdev start, auto delete: false
2019-10-22 11:22:49.292 T:2834682736 DEBUG: Thread PeripBusCEC start, auto delete: false
2019-10-22 11:22:49.295 T:2826290032 DEBUG: Thread PeripBusAddon start, auto delete: false
2019-10-22 11:22:49.299 T:3011713504 DEBUG: Initialise - initialised peripheral on 'keyboard' with 1 features and 0 sub devices
2019-10-22 11:22:49.299 T:3011713504 NOTICE: Register - new keyboard device registered on applicationkeyboard: Tangentbord (0000:0000)
2019-10-22 11:22:49.299 T:3011713504 DEBUG: Initialise - initialised peripheral on 'mouse' with 1 features and 0 sub devices
2019-10-22 11:22:49.299 T:3011713504 NOTICE: Register - new mouse device registered on application
mouse: Mus (0000:0000) 2019-10-22 11:22:49.303 T:3011713504 DEBUG: ContextMenuManager: addon menus reloaded.
2019-10-22 11:22:49.303 T:3011713504 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
2019-10-22 11:22:49.304 T:3011713504 DEBUG: CPlayerCoreConfig::<ctor>: created player VideoPlayer
2019-10-22 11:22:49.304 T:3011713504 DEBUG: CPlayerCoreConfig::<ctor>: created player PAPlayer
2019-10-22 11:22:49.304 T:3011713504 DEBUG: CPlayerCoreConfig::<ctor>: created player RetroPlayer
2019-10-22 11:22:49.304 T:3011713504 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules
2019-10-22 11:22:49.304 T:3011713504 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mms/udp
2019-10-22 11:22:49.304 T:3011713504 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout
2019-10-22 11:22:49.304 T:3011713504 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp
2019-10-22 11:22:49.304 T:3011713504 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp
2019-10-22 11:22:49.304 T:3011713504 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams
2019-10-22 11:22:49.304 T:3011713504 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp
2019-10-22 11:22:49.304 T:3011713504 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2
2019-10-22 11:22:49.304 T:3011713504 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd
2019-10-22 11:22:49.304 T:3011713504 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage
2019-10-22 11:22:49.304 T:3011713504 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf
2019-10-22 11:22:49.304 T:3011713504 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv
2019-10-22 11:22:49.304 T:3011713504 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio
2019-10-22 11:22:49.304 T:3011713504 NOTICE: Loaded playercorefactory configuration
2019-10-22 11:22:49.304 T:3011713504 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
2019-10-22 11:22:49.304 T:3011713504 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
2019-10-22 11:22:49.304 T:3011713504 INFO: removing tempfiles
2019-10-22 11:22:49.312 T:2817897328 DEBUG: Thread PeripEventScanner start, auto delete: false
2019-10-22 11:22:49.317 T:3011713504 DEBUG: CRepositoryUpdater: previous update at 2019-10-21 13:09:33, next at 2019-10-22 13:09:33
2019-10-22 11:22:49.317 T:2809504624 DEBUG: Thread Timer start, auto delete: false
2019-10-22 11:22:49.320 T:3011713504 DEBUG: CServiceAddonManager: starting service.libreelec.settings
2019-10-22 11:22:49.321 T:3011713504 DEBUG: CServiceAddonManager: starting plugin.video.youtube
2019-10-22 11:22:49.321 T:2801111920 DEBUG: Thread LanguageInvoker start, auto delete: false
2019-10-22 11:22:49.321 T:2801111920 INFO: initializing python engine.
2019-10-22 11:22:49.324 T:3011713504 NOTICE: initialize done
2019-10-22 11:22:49.324 T:3011713504 NOTICE: Running the application...
2019-10-22 11:22:49.324 T:3011713504 DEBUG: no profile autoexec.py (/storage/.kodi/userdata/autoexec.py) found, skipping
2019-10-22 11:22:49.324 T:3011713504 DEBUG: NetworkMessage - Starting network services
2019-10-22 11:22:49.326 T:2792719216 DEBUG: Thread LanguageInvoker start, auto delete: false
2019-10-22 11:22:49.326 T:2792719216 INFO: initializing python engine.
2019-10-22 11:22:49.328 T:3011713504 DEBUG: CZeroconfAvahi::clientCallback: client is up and running
2019-10-22 11:22:49.329 T:3011713504 NOTICE: starting zeroconf publishing
2019-10-22 11:22:49.330 T:3011713504 NOTICE: CWebServer[8080]: Started
2019-10-22 11:22:49.330 T:2759148400 DEBUG: Thread EventServer start, auto delete: false
2019-10-22 11:22:49.332 T:3011713504 INFO: JSONRPC Server: Successfully initialized
2019-10-22 11:22:49.332 T:2759148400 NOTICE: ES: Starting UDP Event server on port 9777
2019-10-22 11:22:49.332 T:3011713504 DEBUG: SECTION:LoadDLL(libshairplay.so.0)
2019-10-22 11:22:49.333 T:2750755696 DEBUG: Thread TCPServer start, auto delete: false
2019-10-22 11:22:49.339 T:3011713504 DEBUG: Loading: libshairplay.so.0
2019-10-22 11:22:49.343 T:2759148400 NOTICE: UDP: Listening on port 9777 (ipv6 : true)
2019-10-22 11:22:49.360 T:2801111920 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): start processing
2019-10-22 11:22:49.360 T:2792719216 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.youtube/resources/lib/startup.py): start processing
2019-10-22 11:22:49.391 T:2801111920 DEBUG: -Python Interpreter Initialized- 2019-10-22 11:22:49.391 T:2801111920 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): the source file to load is "/usr/share/kodi/addons/service.libreelec.settings/service.py"
2019-10-22 11:22:49.391 T:2801111920 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): setting the Python path to /usr/share/kodi/addons/service.libreelec.settings:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/gtk-2.0
2019-10-22 11:22:49.391 T:2801111920 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): entering source directory /usr/share/kodi/addons/service.libreelec.settings
2019-10-22 11:22:49.409 T:2801111920 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): instantiating addon using automatically obtained id of "service.libreelec.settings" dependent on version 2.1.0 of the xbmc.python api
2019-10-22 11:22:49.527 T:2868253552 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:22:49.560 T:2834682736 DEBUG: Previous line repeats 3 times.
2019-10-22 11:22:49.560 T:2834682736 DEBUG: GetMappingForDevice - device (2708:1001) mapped to CEC Adapter (type = cec)
2019-10-22 11:22:49.564 T:2834682736 DEBUG: InitialiseFeature - using libCEC v4.0.4
2019-10-22 11:22:49.565 T:2834682736 DEBUG: Initialise - initialised peripheral on 'RPI' with 2 features and 0 sub devices
2019-10-22 11:22:49.565 T:2709656432 DEBUG: Thread CECAdapter start, auto delete: false
2019-10-22 11:22:49.565 T:2834682736 NOTICE: Register - new cec device registered on cecRPI: CEC Adapter (2708:1001)
2019-10-22 11:22:49.565 T:2709656432 DEBUG: OpenConnection - opening a connection to the CEC adapter: RPI
2019-10-22 11:22:49.565 T:2834682736 DEBUG: Thread PeripBusCEC 2834682736 terminating
2019-10-22 11:22:49.631 T:3011713504 DEBUG: ------ Window Init () ------
2019-10-22 11:22:49.637 T:3011713504 DEBUG: ------ Window Init (Pointer.xml) ------
2019-10-22 11:22:49.776 T:2801111920 DEBUG: ## LibreELEC Addon ## 9.0.0
2019-10-22 11:22:49.781 T:2792719216 DEBUG: -
Python Interpreter Initialized<-- 2019-10-22 11:22:49.781 T:2792719216 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.youtube/resources/lib/startup.py): the source file to load is "/storage/.kodi/addons/plugin.video.youtube/resources/lib/startup.py"
2019-10-22 11:22:49.782 T:2792719216 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.youtube/resources/lib/startup.py): setting the Python path to /storage/.kodi/addons/plugin.video.youtube/resources/lib:/storage/.kodi/addons/script.module.certifi/lib:/storage/.kodi/addons/script.module.chardet/lib:/storage/.kodi/addons/script.module.idna/lib:/storage/.kodi/addons/script.module.requests/lib:/storage/.kodi/addons/script.module.six/lib:/storage/.kodi/addons/script.module.urllib3/lib:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/gtk-2.0
2019-10-22 11:22:49.782 T:2792719216 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.youtube/resources/lib/startup.py): entering source directory /storage/.kodi/addons/plugin.video.youtube/resources/lib
2019-10-22 11:22:49.782 T:2792719216 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.youtube/resources/lib/startup.py): instantiating addon using automatically obtained id of "plugin.video.youtube" dependent on version 2.20.0 of the xbmc.python api
2019-10-22 11:22:49.916 T:3011713504 DEBUG: LogindUPowerSyscall - Received unknown signal NameAcquired
2019-10-22 11:22:49.916 T:3011713504 DEBUG: ------ Window Init (DialogNotification.xml) ------
2019-10-22 11:22:49.948 T:2876646256 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:22:49.950 T:3011713504 DEBUG: Previous line repeats 1 times.
2019-10-22 11:22:49.950 T:3011713504 DEBUG: ------ Window Deinit (Pointer.xml) ------
2019-10-22 11:22:50.135 T:2674914160 DEBUG: Thread JobWorker start, auto delete: true
2019-10-22 11:22:50.148 T:2674914160 DEBUG: ffmpeg[9F6FF370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
2019-10-22 11:22:50.450 T:2868253552 DEBUG: Previous line repeats 2 times.
2019-10-22 11:22:50.450 T:2868253552 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:22:50.664 T:2674914160 DEBUG: Previous line repeats 1 times.
2019-10-22 11:22:50.664 T:2674914160 DEBUG: ffmpeg[9F6FF370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
2019-10-22 11:22:50.855 T:2792719216 DEBUG: Previous line repeats 5 times.
2019-10-22 11:22:50.855 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting definitions
2019-10-22 11:22:50.855 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: trying to load setting definitions from old format...
2019-10-22 11:22:50.860 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting values
2019-10-22 11:22:50.862 T:2792719216 DEBUG: [plugin.video.youtube] send_notification: |check_settings| |{"httpd_address": "0.0.0.0", "use_httpd": false, "whitelist": "", "httpd_port": 50152}|
2019-10-22 11:22:50.864 T:2792719216 DEBUG: [plugin.video.youtube] JSONStore Load |/storage/.kodi/userdata/addon_data/plugin.video.youtube/api_keys.json|
2019-10-22 11:22:50.865 T:2792719216 DEBUG: [plugin.video.youtube] JSONStore Load |/storage/.kodi/userdata/addon_data/plugin.video.youtube/access_manager.json|
2019-10-22 11:22:50.867 T:3011699568 DEBUG: CAnnouncementManager - Announcement: check_settings from plugin.video.youtube
2019-10-22 11:22:50.867 T:3011699568 DEBUG: GOT ANNOUNCEMENT, type: 512, from plugin.video.youtube, message check_settings
2019-10-22 11:22:50.870 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting definitions
2019-10-22 11:22:50.870 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: trying to load setting definitions from old format...
2019-10-22 11:22:50.874 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting values
2019-10-22 11:22:50.880 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting definitions
2019-10-22 11:22:50.880 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: trying to load setting definitions from old format...
2019-10-22 11:22:50.883 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting values
2019-10-22 11:22:50.891 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting definitions
2019-10-22 11:22:50.891 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: trying to load setting definitions from old format...
2019-10-22 11:22:50.894 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting values
2019-10-22 11:22:50.901 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting definitions
2019-10-22 11:22:50.901 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: trying to load setting definitions from old format...
2019-10-22 11:22:50.904 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting values
2019-10-22 11:22:50.907 T:2792719216 DEBUG: CSettingsManager: requested setting (kodion.access_token) was not found.
2019-10-22 11:22:50.907 T:2792719216 DEBUG: CSettingsManager: requested setting (kodion.refresh_token) was not found.
2019-10-22 11:22:50.907 T:2792719216 DEBUG: CSettingsManager: requested setting (kodion.access_token.expires) was not found.
2019-10-22 11:22:50.907 T:2792719216 DEBUG: CSettingsManager: requested setting (youtube.api.last.hash) was not found.
2019-10-22 11:22:50.908 T:2792719216 DEBUG: [plugin.video.youtube] User: |0| Using API key set: |1|
2019-10-22 11:22:50.929 T:2674914160 DEBUG: ffmpeg[9F6FF370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
2019-10-22 11:22:50.956 T:2859860848 DEBUG: Previous line repeats 1 times.
2019-10-22 11:22:50.956 T:2859860848 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:22:50.971 T:2674914160 DEBUG: Previous line repeats 1 times.
2019-10-22 11:22:50.971 T:2674914160 DEBUG: ffmpeg[9F6FF370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
2019-10-22 11:22:50.980 T:2792719216 DEBUG: [plugin.video.youtube] YouTube service initialization...
2019-10-22 11:22:50.982 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting definitions
2019-10-22 11:22:50.982 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: trying to load setting definitions from old format...
2019-10-22 11:22:50.987 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting values
2019-10-22 11:22:50.994 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting definitions
2019-10-22 11:22:50.994 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: trying to load setting definitions from old format...
2019-10-22 11:22:50.995 T:2674914160 DEBUG: ffmpeg[9F6FF370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
2019-10-22 11:22:50.998 T:2792719216 DEBUG: CAddonSettings[plugin.video.youtube]: loading setting values
2019-10-22 11:22:51.011 T:2674914160 DEBUG: ffmpeg[9F6FF370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
2019-10-22 11:22:51.016 T:2674914160 INFO: easy_acquire - Created session to http://image.tmdb.org
2019-10-22 11:22:51.189 T:2674914160 DEBUG: CCurlFile::GetMimeType - http://image.tmdb.org/t/p/original/u38NLUtWarEbv2gZGOnHhf6akWC.jpg
image/jpeg 2019-10-22 11:22:51.190 T:2674914160 DEBUG: CurlFile::Open(0xae51a228) http://image.tmdb.org/t/p/original/u38NLUtWarEbv2gZGOnHhf6akWC.jpg
2019-10-22 11:22:51.202 T:2801111920 INFO: ## LibreELEC Addon ## system::set_hostname ## SonyKodi
2019-10-22 11:22:51.203 T:2801111920 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## us
2019-10-22 11:22:51.203 T:2801111920 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## loadkmap < ls -1 /usr/lib/keymaps/*/us.bmap
2019-10-22 11:22:51.410 T:2674914160 DEBUG: ffmpeg[9F6FF370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
2019-10-22 11:22:51.448 T:2674914160 DEBUG: Caching image 'http://image.tmdb.org/t/p/original/u38NLUtWarEbv2gZGOnHhf6akWC.jpg' to 'b/b4d8d918.jpg':
2019-10-22 11:22:51.530 T:2868253552 DEBUG: ffmpeg[AAF61370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
2019-10-22 11:22:51.554 T:2674914160 DEBUG: Previous line repeats 1 times.
2019-10-22 11:22:51.554 T:2674914160 DEBUG: cached image 'special://masterprofile/Thumbnails/b/b4d8d918.jpg' size 360x540
2019-10-22 11:22:51.562 T:2868253552 DEBUG: ffmpeg[AAF61370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
2019-10-22 11:22:51.618 T:2709656432 DEBUG: Previous line repeats 2 times.
2019-10-22 11:22:51.618 T:2709656432 DEBUG: OpenConnection - connection to the CEC adapter opened
2019-10-22 11:22:51.618 T:2709656432 DEBUG: SetConfigurationFromLibCEC - settings updated by libCEC
2019-10-22 11:22:51.618 T:2644407152 DEBUG: Thread CECAdapterUpdate start, auto delete: false
2019-10-22 11:22:51.648 T:2868253552 DEBUG: ffmpeg[AAF61370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
2019-10-22 11:22:51.850 T:2801111920 INFO: ## LibreELEC Addon ## updates::updateThread ## Started
2019-10-22 11:22:51.850 T:2801111920 INFO: ## LibreELEC Addon ## updates::set_auto_update ## auto
2019-10-22 11:22:51.908 T:2597311344 INFO: ## LibreELEC Addon ## service::run ## WAITING:
2019-10-22 11:22:51.919 T:2605704048 INFO: ## LibreELEC Addon ## xdbus Monitor started. ##
2019-10-22 11:22:51.959 T:2674914160 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:22:52.009 T:2644407152 DEBUG: Previous line repeats 3 times.
2019-10-22 11:22:52.009 T:2644407152 DEBUG: UpdateMenuLanguage - using TV menu language is disabled
2019-10-22 11:22:52.202 T:2859860848 DEBUG: ffmpeg[AA760370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
2019-10-22 11:22:52.489 T:2876646256 DEBUG: Previous line repeats 5 times.
2019-10-22 11:22:52.489 T:2876646256 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:22:54.298 T:2718049136 DEBUG: Previous line repeats 5 times.
2019-10-22 11:22:54.298 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 0
2019-10-22 11:22:54.367 T:2674914160 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:22:54.478 T:2644407152 DEBUG: Previous line repeats 3 times.
2019-10-22 11:22:54.478 T:2644407152 DEBUG: UpdateAudioSystemStatus - no CEC capable amplifier found
2019-10-22 11:22:54.504 T:3011713504 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up
2019-10-22 11:22:54.540 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 242
2019-10-22 11:22:54.669 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 0
2019-10-22 11:22:54.687 T:3011713504 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up
2019-10-22 11:22:54.779 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 111
2019-10-22 11:22:55.260 T:2876646256 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:22:55.514 T:2718049136 DEBUG: Previous line repeats 1 times.
2019-10-22 11:22:55.515 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 0
2019-10-22 11:22:55.521 T:3011713504 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up
2019-10-22 11:22:55.602 T:2674914160 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:22:55.751 T:2718049136 DEBUG: Previous line repeats 3 times.
2019-10-22 11:22:55.751 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 236
2019-10-22 11:22:56.417 T:2718049136 DEBUG: PushCecKeypress - received key a7 duration 0
2019-10-22 11:22:56.422 T:3011713504 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down
2019-10-22 11:22:56.559 T:2718049136 DEBUG: PushCecKeypress - received key a7 duration 142
2019-10-22 11:22:56.617 T:2876646256 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:22:57.452 T:2718049136 DEBUG: Previous line repeats 3 times.
2019-10-22 11:22:57.452 T:2718049136 DEBUG: PushCecKeypress - received key b duration 0
2019-10-22 11:22:57.457 T:3011713504 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
2019-10-22 11:22:57.457 T:3011713504 DEBUG: Activating window ID: 10025
2019-10-22 11:22:57.509 T:2876646256 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:22:57.645 T:2718049136 DEBUG: Previous line repeats 1 times.
2019-10-22 11:22:57.646 T:2718049136 DEBUG: PushCecKeypress - received key b duration 194
2019-10-22 11:22:57.760 T:3011713504 DEBUG: ------ Window Deinit (Home.xml) ------
2019-10-22 11:22:57.760 T:3011713504 DEBUG: FreeVisualisation() done
2019-10-22 11:22:57.791 T:2868253552 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:22:58.086 T:3011713504 DEBUG: Previous line repeats 1 times.
2019-10-22 11:22:58.086 T:3011713504 DEBUG: ------ Window Init (MyVideoNav.xml) ------
2019-10-22 11:22:58.086 T:3011713504 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY
2019-10-22 11:22:58.193 T:3011713504 DEBUG: CGUIMediaWindow::GetDirectory ()
2019-10-22 11:22:58.193 T:3011713504 DEBUG: ParentPath = []
2019-10-22 11:22:58.224 T:2576348016 DEBUG: Thread BackgroundLoader start, auto delete: false
2019-10-22 11:22:58.437 T:2876646256 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:22:58.546 T:2576348016 DEBUG: Previous line repeats 1 times.
2019-10-22 11:22:58.546 T:2576348016 DEBUG: Thread BackgroundLoader 2576348016 terminating
2019-10-22 11:22:58.784 T:2868253552 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:22:59.829 T:3011713504 DEBUG: Previous line repeats 3 times.
2019-10-22 11:22:59.829 T:3011713504 DEBUG: ------ Window Deinit (DialogNotification.xml) ------
2019-10-22 11:23:00.408 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 0
2019-10-22 11:23:00.426 T:3011713504 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up
2019-10-22 11:23:00.599 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 192
2019-10-22 11:23:00.674 T:2876646256 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:23:00.785 T:2718049136 DEBUG: Previous line repeats 1 times.
2019-10-22 11:23:00.785 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 0
2019-10-22 11:23:00.793 T:3011713504 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up
2019-10-22 11:23:00.893 T:2674914160 DEBUG: CAddonMgr::GetAvailableUpdates took 20 ms
2019-10-22 11:23:00.999 T:2674914160 DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3a%2f%2fprofile%2fplaylists%2fvideo/special%3a%2f%2fprofile%2fplaylists%2fmixed/)
2019-10-22 11:23:00.999 T:2674914160 DEBUG: Getting Directory (special://profile/playlists/video)
2019-10-22 11:23:01.016 T:2674914160 DEBUG: Getting Directory (special://profile/playlists/mixed)
2019-10-22 11:23:01.017 T:2674914160 DEBUG: CMultiPathDirectory::MergeItems, items = 40
2019-10-22 11:23:01.018 T:2674914160 DEBUG: Testing path: [000] special://profile/playlists/video/barnfilm.xsp
2019-10-22 11:23:01.018 T:2674914160 DEBUG: Testing path: [001] special://profile/playlists/video/barnfilm.genre.xsp
2019-10-22 11:23:01.018 T:2674914160 DEBUG: Testing path: [002] special://profile/playlists/video/barnfilm.inpro.xsp
2019-10-22 11:23:01.018 T:2674914160 DEBUG: Testing path: [003] special://profile/playlists/video/barnfilm.latest.xsp
2019-10-22 11:23:01.018 T:2674914160 DEBUG: Testing path: [004] special://profile/playlists/video/barnfilm.recent.xsp
2019-10-22 11:23:01.018 T:2674914160 DEBUG: Testing path: [005] special://profile/playlists/video/barnfilm.rand.xsp
2019-10-22 11:23:01.018 T:2674914160 DEBUG: Testing path: [006] special://profile/playlists/video/barnfilm.unw.xsp
2019-10-22 11:23:01.018 T:2674914160 DEBUG: Testing path: [007] special://profile/playlists/video/barnfilm.watched.xsp
2019-10-22 11:23:01.018 T:2674914160 DEBUG: Testing path: [008] special://profile/playlists/video/barntv.xsp
2019-10-22 11:23:01.018 T:2674914160 DEBUG: Testing path: [009] special://profile/playlists/video/barntv.genre.xsp
2019-10-22 11:23:01.018 T:2674914160 DEBUG: Testing path: [010] special://profile/playlists/video/barntv.inpro.xsp
2019-10-22 11:23:01.018 T:2674914160 DEBUG: Testing path: [011] special://profile/playlists/video/barntv.latest.xsp
2019-10-22 11:23:01.018 T:2674914160 DEBUG: Testing path: [012] special://profile/playlists/video/barntv.rand.xsp
2019-10-22 11:23:01.018 T:2674914160 DEBUG: Testing path: [013] special://profile/playlists/video/barntv.recent.xsp
2019-10-22 11:23:01.018 T:2674914160 DEBUG: Testing path: [014] special://profile/playlists/video/barntv.unw.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [015] special://profile/playlists/video/barntv.watched.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [016] special://profile/playlists/video/rolf.genre.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [017] special://profile/playlists/video/rolf.inpro.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [018] special://profile/playlists/video/rolf.recent.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [019] special://profile/playlists/video/rolf.unw.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [020] special://profile/playlists/video/rolf.rand.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [021] special://profile/playlists/video/rolf.watched.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [022] special://profile/playlists/video/rolf.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [023] special://profile/playlists/video/rolf.latest.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [024] special://profile/playlists/video/rolftv.genre.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [025] special://profile/playlists/video/rolftv.inpro.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [026] special://profile/playlists/video/rolftv.latest.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [027] special://profile/playlists/video/rolftv.rand.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [028] special://profile/playlists/video/rolftv.unw.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [029] special://profile/playlists/video/rolftv.recent.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [030] special://profile/playlists/video/rolftv.watched.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [031] special://profile/playlists/video/slask.inpro.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [032] special://profile/playlists/video/slask.recent.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [033] special://profile/playlists/video/slask.unw.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [034] special://profile/playlists/video/slask.rand.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [035] special://profile/playlists/video/slask.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [036] special://profile/playlists/video/slask.watched.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [037] special://profile/playlists/video/slask.genre.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: Testing path: [038] special://profile/playlists/video/slask.latest.xsp
2019-10-22 11:23:01.019 T:2674914160 DEBUG: CMultiPathDirectory::MergeItems, items = 40, took 1 ms
2019-10-22 11:23:01.022 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 237
2019-10-22 11:23:01.123 T:2876646256 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update
2019-10-22 11:23:01.140 T:2876646256 DEBUG: GetRecentlyAddedAlbumSongs() query: SELECT songview., songartistview. FROM (SELECT idAlbum FROM album ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN songview ON songview.idAlbum = recentalbums.idAlbum JOIN songartistview ON songview.idSong = songartistview.idSong ORDER BY songview.idAlbum DESC, songview.idSong, songartistview.idRole, songartistview.iOrder
2019-10-22 11:23:01.144 T:2876646256 DEBUG: GetRecentlyAddedAlbums query: SELECT albumview., albumartistview. FROM (SELECT idAlbum FROM album WHERE strAlbum != '' ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN albumview ON albumview.idAlbum = recentalbums.idAlbum JOIN albumartistview ON albumview.idAlbum = albumartistview.idAlbum ORDER BY albumview.idAlbum desc, albumartistview.iOrder
2019-10-22 11:23:01.149 T:2876646256 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
2019-10-22 11:23:01.320 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 0
2019-10-22 11:23:01.327 T:3011713504 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up
2019-10-22 11:23:01.500 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 180
2019-10-22 11:23:01.635 T:2674914160 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:23:01.766 T:2868253552 DEBUG: Previous line repeats 1 times.
2019-10-22 11:23:01.766 T:2868253552 DEBUG: ADDON: Dll Initializing - PVR IPTV Simple Client
2019-10-22 11:23:01.766 T:2868253552 DEBUG: SECTION:LoadDLL(/storage/.kodi/addons/pvr.iptvsimple/pvr.iptvsimple.so.3.8.1)
2019-10-22 11:23:01.766 T:2868253552 DEBUG: Loading: /storage/.kodi/addons/pvr.iptvsimple/pvr.iptvsimple.so.3.8.1
2019-10-22 11:23:01.778 T:2868253552 DEBUG: AddOnLog: PVR IPTV Simple Client: ADDON_Create - Creating the PVR IPTV Simple add-on
2019-10-22 11:23:01.778 T:2868253552 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'PVR IPTV Simple Client' requests setting 'm3uPathType'
2019-10-22 11:23:01.781 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting definitions
2019-10-22 11:23:01.781 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: trying to load setting definitions from old format...
2019-10-22 11:23:01.782 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting values
2019-10-22 11:23:01.782 T:2868253552 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'PVR IPTV Simple Client' requests setting 'm3uPath'
2019-10-22 11:23:01.783 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting definitions
2019-10-22 11:23:01.783 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: trying to load setting definitions from old format...
2019-10-22 11:23:01.784 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting values
2019-10-22 11:23:01.784 T:2868253552 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'PVR IPTV Simple Client' requests setting 'startNum'
2019-10-22 11:23:01.784 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting definitions
2019-10-22 11:23:01.784 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: trying to load setting definitions from old format...
2019-10-22 11:23:01.785 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting values
2019-10-22 11:23:01.786 T:2868253552 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'PVR IPTV Simple Client' requests setting 'epgPathType'
2019-10-22 11:23:01.786 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting definitions
2019-10-22 11:23:01.786 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: trying to load setting definitions from old format...
2019-10-22 11:23:01.787 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting values
2019-10-22 11:23:01.787 T:2868253552 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'PVR IPTV Simple Client' requests setting 'epgUrl'
2019-10-22 11:23:01.788 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting definitions
2019-10-22 11:23:01.788 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: trying to load setting definitions from old format...
2019-10-22 11:23:01.789 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting values
2019-10-22 11:23:01.789 T:2868253552 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'PVR IPTV Simple Client' requests setting 'epgCache'
2019-10-22 11:23:01.789 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting definitions
2019-10-22 11:23:01.789 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: trying to load setting definitions from old format...
2019-10-22 11:23:01.790 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting values
2019-10-22 11:23:01.790 T:2868253552 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'PVR IPTV Simple Client' requests setting 'epgTimeShift'
2019-10-22 11:23:01.791 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting definitions
2019-10-22 11:23:01.791 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: trying to load setting definitions from old format...
2019-10-22 11:23:01.792 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting values
2019-10-22 11:23:01.792 T:2868253552 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'PVR IPTV Simple Client' requests setting 'epgTSOverride'
2019-10-22 11:23:01.792 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting definitions
2019-10-22 11:23:01.792 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: trying to load setting definitions from old format...
2019-10-22 11:23:01.793 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting values
2019-10-22 11:23:01.793 T:2868253552 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'PVR IPTV Simple Client' requests setting 'logoPathType'
2019-10-22 11:23:01.794 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting definitions
2019-10-22 11:23:01.794 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: trying to load setting definitions from old format...
2019-10-22 11:23:01.796 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting values
2019-10-22 11:23:01.796 T:2868253552 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'PVR IPTV Simple Client' requests setting 'logoBaseUrl'
2019-10-22 11:23:01.797 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting definitions
2019-10-22 11:23:01.797 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: trying to load setting definitions from old format...
2019-10-22 11:23:01.798 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting values
2019-10-22 11:23:01.798 T:2868253552 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'PVR IPTV Simple Client' requests setting 'logoFromEpg'
2019-10-22 11:23:01.799 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting definitions
2019-10-22 11:23:01.799 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: trying to load setting definitions from old format...
2019-10-22 11:23:01.800 T:2868253552 DEBUG: CAddonSettings[pvr.iptvsimple]: loading setting values
2019-10-22 11:23:01.800 T:2868253552 DEBUG: AddOnLog: PVR IPTV Simple Client: LoadPlayList PlayList Load Start
2019-10-22 11:23:01.859 T:2868253552 DEBUG: CSMBFile::Open - opened smb://USERNAME:[email protected]/IPTV-TEST1.m3u, fd=10000
2019-10-22 11:23:01.867 T:2868253552 DEBUG: CSMBFile::Close closing fd 10000
2019-10-22 11:23:01.867 T:2868253552 DEBUG: AddOnLog: PVR IPTV Simple Client: Read line: '#EXTM3U'
2019-10-22 11:23:01.867 T:2868253552 DEBUG: AddOnLog: PVR IPTV Simple Client: Read line: '#EXTINF:-1 tvg-name="testse" group-title="testse" tvg-logo="https://internal-pics/testsyd.png",testse'
2019-10-22 11:23:01.868 T:2868253552 DEBUG: AddOnLog: PVR IPTV Simple Client: Read line: 'http://iptv.local:2095/iptvusername/iptvpassword/8102'
2019-10-22 11:23:01.868 T:2868253552 DEBUG: AddOnLog: PVR IPTV Simple Client: Found URL: 'http://iptv.local:2095/iptvusername/iptvpassword/8102' (current channel name: 'testse')
2019-10-22 11:23:01.868 T:2868253552 DEBUG: AddOnLog: PVR IPTV Simple Client: Read line: '#EXTINF:-1 tvg-name="testsyd" group-title="testse" tvg-logo="http://internal-pics/testsyd.png",testsyd'
2019-10-22 11:23:01.868 T:2868253552 DEBUG: AddOnLog: PVR IPTV Simple Client: Read line: 'http://iptv.local:2095/iptvusername/iptvpassword/26592'
2019-10-22 11:23:01.868 T:2868253552 DEBUG: AddOnLog: PVR IPTV Simple Client: Found URL: 'http://iptv.local:2095/iptvusername/iptvpassword/26592' (current channel name: 'testsyd')
2019-10-22 11:23:01.956 T:2718049136 DEBUG: PushCecKeypress - received key b duration 0
2019-10-22 11:23:01.961 T:2868253552 DEBUG: AddOnLog: PVR IPTV Simple Client: Read line: '#EXTINF:-1 tvg-name="testno" group-title="testno" tvg-logo="https://internal-pics/testno.png",testno'
2019-10-22 11:23:01.961 T:3011713504 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
2019-10-22 11:23:01.961 T:2868253552 DEBUG: AddOnLog: PVR IPTV Simple Client: Read line: 'http://iptv.local:2095/iptvusername/iptvpassword/16455'
2019-10-22 11:23:01.961 T:2868253552 DEBUG: AddOnLog: PVR IPTV Simple Client: Found URL: 'http://iptv.local:2095/iptvusername/iptvpassword/16455' (current channel name: 'testno')
2019-10-22 11:23:01.961 T:2868253552 DEBUG: AddOnLog: PVR IPTV Simple Client: Read line: '#EXTINF:-1 tvg-name="testno" group-title="testno" tvg-logo="http://internal-pics/testno.png",testno'
2019-10-22 11:23:01.963 T:3011713504 DEBUG: CGUIMediaWindow::GetDirectory (library://video/files.xml/)
2019-10-22 11:23:01.963 T:3011713504 DEBUG: ParentPath = []
2019-10-22 11:23:01.964 T:2576348016 DEBUG: Thread waiting start, auto delete: false
2019-10-22 11:23:01.964 T:2868253552 DEBUG: AddOnLog: PVR IPTV Simple Client: Read line: 'http://iptv.local:2095/iptvusername/iptvpassword/42400'
2019-10-22 11:23:01.965 T:2868253552 DEBUG: AddOnLog: PVR IPTV Simple Client: Found URL: 'http://iptv.local:2095/iptvusername/iptvpassword/42400' (current channel name: 'testmulti')
2019-10-22 11:23:01.967 T:2868253552 DEBUG: AddOnLog: PVR IPTV Simple Client: Read line: '#EXTINF:-1 tvg-name="testmulti" group-title="testmulti" tvg-logo="http://internal-pics/testmulti.png",testmulti'
2019-10-22 11:23:01.967 T:2868253552 DEBUG: AddOnLog: PVR IPTV Simple Client: Read line: 'http://iptv.local:2095/iptvusername/iptvpassword/21268'
2019-10-22 11:23:01.967 T:2868253552 DEBUG: AddOnLog: PVR IPTV Simple Client: Found URL: 'http://iptv.local:2095/iptvusername/iptvpassword/21268' (current channel name: 'testmulti')
2019-10-22 11:23:01.967 T:2868253552 NOTICE: AddOnLog: PVR IPTV Simple Client: LoadPlayList PlayList Loaded - 167 (ms)
2019-10-22 11:23:01.968 T:2868253552 NOTICE: AddOnLog: PVR IPTV Simple Client: Loaded 563 channels.
2019-10-22 11:23:01.968 T:2868253552 NOTICE: PVR Manager: Starting
2019-10-22 11:23:01.968 T:2562818928 DEBUG: Thread PVRManager start, auto delete: false
2019-10-22 11:23:01.969 T:2868253552 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:SonyKodi port:8080
2019-10-22 11:23:01.969 T:2868253552 DEBUG: CZeroconfAvahi::addService() named: SonyKodi type: _http._tcp port:8080
2019-10-22 11:23:01.974 T:2554426224 DEBUG: Thread PVRGUIProgressHandler start, auto delete: true
2019-10-22 11:23:01.975 T:2868253552 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:SonyKodi port:8080
2019-10-22 11:23:01.975 T:2868253552 DEBUG: CZeroconfAvahi::addService() named: SonyKodi type: _xbmc-jsonrpc-h._tcp port:8080
2019-10-22 11:23:01.981 T:2868253552 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:SonyKodi port:9090
2019-10-22 11:23:01.981 T:2868253552 DEBUG: CZeroconfAvahi::addService() named: SonyKodi type: _xbmc-jsonrpc._tcp port:9090
2019-10-22 11:23:01.988 T:2868253552 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:SonyKodi port:9777
2019-10-22 11:23:01.988 T:2868253552 DEBUG: CZeroconfAvahi::addService() named: SonyKodi type: _xbmc-events._udp port:9777
2019-10-22 11:23:01.993 T:2868253552 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airtunes type: _raop._tcp name:DCA63222D790@SonyKodi port:36666
2019-10-22 11:23:01.994 T:2868253552 DEBUG: CZeroconfAvahi::addService() named: DCA63222D790@SonyKodi type: _raop._tcp port:36666
2019-10-22 11:23:02.000 T:2868253552 INFO: WEATHER: Downloading weather
2019-10-22 11:23:02.000 T:2541888368 DEBUG: Thread LanguageInvoker start, auto delete: false
2019-10-22 11:23:02.001 T:2541888368 INFO: initializing python engine.
2019-10-22 11:23:02.001 T:2541888368 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/weather.gismeteo/default.py): start processing
2019-10-22 11:23:02.028 T:2576348016 DEBUG: Thread waiting 2576348016 terminating
2019-10-22 11:23:02.034 T:2541888368 DEBUG: -Python Interpreter Initialized- 2019-10-22 11:23:02.034 T:2541888368 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/weather.gismeteo/default.py): the source file to load is "/storage/.kodi/addons/weather.gismeteo/default.py"
2019-10-22 11:23:02.035 T:2541888368 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/weather.gismeteo/default.py): setting the Python path to /storage/.kodi/addons/weather.gismeteo:/storage/.kodi/addons/script.module.future/libs:/usr/lib/python27.zip:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/gtk-2.0
2019-10-22 11:23:02.035 T:2541888368 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/weather.gismeteo/default.py): entering source directory /storage/.kodi/addons/weather.gismeteo
2019-10-22 11:23:02.035 T:2541888368 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/weather.gismeteo/default.py): instantiating addon using automatically obtained id of "weather.gismeteo" dependent on version 2.25.0 of the xbmc.python api
2019-10-22 11:23:02.098 T:2576348016 DEBUG: Thread BackgroundLoader start, auto delete: false
2019-10-22 11:23:02.144 T:3011713504 DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------
2019-10-22 11:23:02.147 T:2718049136 DEBUG: PushCecKeypress - received key b duration 191
2019-10-22 11:23:02.172 T:2674914160 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:23:02.202 T:2533495664 DEBUG: Previous line repeats 1 times.
2019-10-22 11:23:02.202 T:2533495664 DEBUG: Thread PVRGUIInfo start, auto delete: false
2019-10-22 11:23:02.202 T:2562818928 NOTICE: PVR Manager: Started
2019-10-22 11:23:02.245 T:2554426224 DEBUG: Thread PVRGUIProgressHandler 2554426224 terminating (autodelete)
2019-10-22 11:23:02.382 T:3011713504 DEBUG: ------ Window Deinit (DialogExtendedProgressBar.xml) ------
2019-10-22 11:23:02.414 T:2576348016 DEBUG: Thread BackgroundLoader 2576348016 terminating
2019-10-22 11:23:02.459 T:2541888368 DEBUG: CAddonSettings[weather.gismeteo]: loading setting definitions
2019-10-22 11:23:02.459 T:2541888368 DEBUG: CAddonSettings[weather.gismeteo]: trying to load setting definitions from old format...
2019-10-22 11:23:02.461 T:2541888368 DEBUG: CAddonSettings[weather.gismeteo]: loading setting values
2019-10-22 11:23:02.485 T:2541888368 DEBUG: CAddonSettings[weather.gismeteo]: loading setting definitions
2019-10-22 11:23:02.485 T:2541888368 DEBUG: CAddonSettings[weather.gismeteo]: trying to load setting definitions from old format...
2019-10-22 11:23:02.486 T:2541888368 DEBUG: CAddonSettings[weather.gismeteo]: loading setting values
2019-10-22 11:23:02.488 T:2541888368 DEBUG: weather.gismeteo [v.0.3.3]: <Weather ['/storage/.kodi/addons/weather.gismeteo/default.py', '1']>
2019-10-22 11:23:02.488 T:2541888368 DEBUG: weather.gismeteo [v.0.3.3]: Actions: ['root', 'location', 'clear_cache']
2019-10-22 11:23:02.488 T:2541888368 DEBUG: weather.gismeteo [v.0.3.3]: Called action root with params <Params {u'id': u'1'}>
2019-10-22 11:23:02.531 T:2541888368 INFO: CPythonInvoker(2, /storage/.kodi/addons/weather.gismeteo/default.py): script successfully run
2019-10-22 11:23:02.531 T:2541888368 DEBUG: onExecutionDone(2, /storage/.kodi/addons/weather.gismeteo/default.py)
2019-10-22 11:23:02.578 T:2541888368 INFO: Python interpreter stopped
2019-10-22 11:23:02.578 T:2541888368 DEBUG: Thread LanguageInvoker 2541888368 terminating
2019-10-22 11:23:02.582 T:2674914160 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:23:02.613 T:2868253552 DEBUG: Previous line repeats 1 times.
2019-10-22 11:23:02.613 T:2868253552 DEBUG: POParser: loaded 130 weather tokens
2019-10-22 11:23:02.614 T:2541888368 DEBUG: Thread EPGUpdater start, auto delete: false
2019-10-22 11:23:02.615 T:2868253552 NOTICE: EPG thread started
2019-10-22 11:23:02.615 T:2868253552 INFO: Starting PVR channel icon search
2019-10-22 11:23:02.824 T:2784326512 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
2019-10-22 11:23:03.093 T:2674914160 DEBUG: Previous line repeats 4 times.
2019-10-22 11:23:03.093 T:2674914160 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:23:03.244 T:2718049136 DEBUG: Previous line repeats 1 times.
2019-10-22 11:23:03.244 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 0
2019-10-22 11:23:03.246 T:3011713504 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up
2019-10-22 11:23:03.343 T:2876646256 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
2019-10-22 11:23:03.347 T:2876646256 DEBUG: GetArtistsByWhere query: SELECT COUNT(DISTINCT artistview.idArtist) FROM artistview WHERE (EXISTS (SELECT 1 FROM song_artist WHERE song_artist.idArtist = artistview.idArtist AND song_artist.idRole = 1) OR EXISTS (SELECT 1 FROM album_artist WHERE album_artist.idArtist = artistview.idArtist)) AND (artistview.strArtist != '')
2019-10-22 11:23:03.435 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 191
2019-10-22 11:23:03.583 T:2674914160 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:23:03.616 T:2576348016 DEBUG: Previous line repeats 1 times.
2019-10-22 11:23:03.616 T:2576348016 DEBUG: Thread PVRGUIProgressHandler start, auto delete: true
2019-10-22 11:23:03.616 T:2541888368 DEBUG: AddOnLog: PVR IPTV Simple Client: LoadEPG EPG Load Start
2019-10-22 11:23:03.617 T:2541888368 INFO: easy_acquire - Created session to http://iptv.local
2019-10-22 11:23:03.646 T:3011713504 DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------
2019-10-22 11:23:03.889 T:2541888368 DEBUG: CFileCache::Open - opening <xmltv.php> using cache
2019-10-22 11:23:03.889 T:2541888368 DEBUG: CurlFile::Open(0xa237ee50) http://iptv.local:2095/xmltv.php?username=iptvusername&password=iptvpassword
2019-10-22 11:23:04.059 T:2674914160 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:23:04.175 T:2554426224 DEBUG: Previous line repeats 1 times.
2019-10-22 11:23:04.175 T:2554426224 DEBUG: Thread FileCache start, auto delete: false
2019-10-22 11:23:04.249 T:2718049136 DEBUG: PushCecKeypress - received key a7 duration 0
2019-10-22 11:23:04.263 T:3011713504 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down
2019-10-22 11:23:04.446 T:2718049136 DEBUG: PushCecKeypress - received key a7 duration 197
2019-10-22 11:23:04.542 T:2674914160 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:23:04.565 T:2718049136 DEBUG: Previous line repeats 1 times.
2019-10-22 11:23:04.565 T:2718049136 DEBUG: PushCecKeypress - received key a7 duration 0
2019-10-22 11:23:04.580 T:3011713504 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down
2019-10-22 11:23:04.796 T:2718049136 DEBUG: PushCecKeypress - received key a7 duration 231
2019-10-22 11:23:04.906 T:2674914160 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:23:05.482 T:2718049136 DEBUG: Previous line repeats 3 times.
2019-10-22 11:23:05.482 T:2718049136 DEBUG: PushCecKeypress - received key b duration 0
2019-10-22 11:23:05.498 T:3011713504 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
2019-10-22 11:23:05.499 T:3011713504 DEBUG: CGUIMediaWindow::GetDirectory (/storage/videos/)
2019-10-22 11:23:05.499 T:3011713504 DEBUG: ParentPath = [sources://video/]
2019-10-22 11:23:05.499 T:2369389424 DEBUG: Thread waiting start, auto delete: false
2019-10-22 11:23:05.501 T:2369389424 DEBUG: Thread waiting 2369389424 terminating
2019-10-22 11:23:05.563 T:3011713504 WARNING: CreateLoader - unsupported protocol(sources) in sources://video/VIDEO_TS/VIDEO_TS.IFO
2019-10-22 11:23:05.564 T:3011713504 WARNING: CreateLoader - unsupported protocol(sources) in sources://video/BDMV/index.bdmv
2019-10-22 11:23:05.618 T:2554426224 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?)
2019-10-22 11:23:05.618 T:2554426224 DEBUG: Thread FileCache 2554426224 terminating
2019-10-22 11:23:05.623 T:2554426224 DEBUG: Thread BackgroundLoader start, auto delete: false
2019-10-22 11:23:05.656 T:2718049136 DEBUG: PushCecKeypress - received key b duration 174
2019-10-22 11:23:05.755 T:2674914160 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:23:05.939 T:2554426224 DEBUG: Previous line repeats 1 times.
2019-10-22 11:23:05.939 T:2554426224 DEBUG: Thread BackgroundLoader 2554426224 terminating
2019-10-22 11:23:06.177 T:2674914160 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:23:06.854 T:2718049136 DEBUG: Previous line repeats 3 times.
2019-10-22 11:23:06.854 T:2718049136 DEBUG: PushCecKeypress - received key b duration 0
2019-10-22 11:23:06.866 T:3011713504 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
2019-10-22 11:23:06.866 T:3011713504 DEBUG: CGUIMediaWindow::GetDirectory (sources://video/)
2019-10-22 11:23:06.866 T:3011713504 DEBUG: ParentPath = []
2019-10-22 11:23:06.867 T:2554426224 DEBUG: Thread waiting start, auto delete: false
2019-10-22 11:23:06.890 T:2554426224 DEBUG: Thread waiting 2554426224 terminating
2019-10-22 11:23:06.942 T:2554426224 DEBUG: Thread BackgroundLoader start, auto delete: false
2019-10-22 11:23:07.007 T:2674914160 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:23:07.095 T:2718049136 DEBUG: Previous line repeats 1 times.
2019-10-22 11:23:07.095 T:2718049136 DEBUG: PushCecKeypress - received key b duration 241
2019-10-22 11:23:07.256 T:2554426224 DEBUG: Thread BackgroundLoader 2554426224 terminating
2019-10-22 11:23:07.277 T:2541888368 NOTICE: AddOnLog: PVR IPTV Simple Client: LoadEPG EPG Loaded - 3660 (ms)
2019-10-22 11:23:07.359 T:2674914160 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:23:07.719 T:2718049136 DEBUG: Previous line repeats 3 times.
2019-10-22 11:23:07.719 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 0
2019-10-22 11:23:07.733 T:3011713504 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up
2019-10-22 11:23:07.935 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 216
2019-10-22 11:23:08.055 T:2674914160 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:23:08.339 T:2718049136 DEBUG: Previous line repeats 1 times.
2019-10-22 11:23:08.339 T:2718049136 DEBUG: PushCecKeypress - received key b duration 0
2019-10-22 11:23:08.351 T:3011713504 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
2019-10-22 11:23:08.351 T:3011713504 DEBUG: CGUIMediaWindow::GetDirectory ()
2019-10-22 11:23:08.351 T:3011713504 DEBUG: ParentPath = []
2019-10-22 11:23:08.358 T:2554426224 DEBUG: Thread waiting start, auto delete: false
2019-10-22 11:23:08.361 T:2554426224 DEBUG: Thread waiting 2554426224 terminating
2019-10-22 11:23:08.383 T:2554426224 DEBUG: Thread BackgroundLoader start, auto delete: false
2019-10-22 11:23:08.565 T:2718049136 DEBUG: PushCecKeypress - received key b duration 226
2019-10-22 11:23:08.713 T:2554426224 DEBUG: Thread BackgroundLoader 2554426224 terminating
2019-10-22 11:23:08.826 T:2674914160 DEBUG: This query part contains a like, we will double backslash in the next field: LIKE '
2019-10-22 11:23:09.951 T:2576348016 DEBUG: Previous line repeats 1 times.
2019-10-22 11:23:09.951 T:2576348016 DEBUG: Thread PVRGUIProgressHandler 2576348016 terminating (autodelete)
2019-10-22 11:23:10.173 T:3011713504 DEBUG: ------ Window Deinit (DialogExtendedProgressBar.xml) ------
2019-10-22 11:23:10.809 T:2718049136 DEBUG: PushCecKeypress - received key b duration 0
2019-10-22 11:23:10.820 T:3011713504 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
2019-10-22 11:23:10.821 T:3011713504 DEBUG: CGUIMediaWindow::GetDirectory (library://video/files.xml/)
2019-10-22 11:23:10.821 T:3011713504 DEBUG: ParentPath = []
2019-10-22 11:23:10.822 T:2576348016 DEBUG: Thread waiting start, auto delete: false
2019-10-22 11:23:10.877 T:2576348016 DEBUG: Thread waiting 2576348016 terminating
2019-10-22 11:23:10.946 T:2576348016 DEBUG: Thread BackgroundLoader start, auto delete: false
2019-10-22 11:23:11.044 T:2718049136 DEBUG: PushCecKeypress - received key b duration 235
2019-10-22 11:23:11.256 T:2576348016 DEBUG: Thread BackgroundLoader 2576348016 terminating
2019-10-22 11:23:11.724 T:2718049136 DEBUG: PushCecKeypress - received key a7 duration 0
2019-10-22 11:23:11.738 T:3011713504 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down
2019-10-22 11:23:11.913 T:2718049136 DEBUG: PushCecKeypress - received key a7 duration 189
2019-10-22 11:23:12.193 T:2718049136 DEBUG: PushCecKeypress - received key a7 duration 0
2019-10-22 11:23:12.205 T:3011713504 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down
2019-10-22 11:23:12.390 T:2718049136 DEBUG: PushCecKeypress - received key a7 duration 197
2019-10-22 11:23:12.509 T:2718049136 DEBUG: PushCecKeypress - received key a7 duration 0
2019-10-22 11:23:12.538 T:3011713504 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down
2019-10-22 11:23:12.706 T:2718049136 DEBUG: PushCecKeypress - received key a7 duration 197
2019-10-22 11:23:13.425 T:2718049136 DEBUG: PushCecKeypress - received key b duration 0
2019-10-22 11:23:13.427 T:3011713504 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
2019-10-22 11:23:13.430 T:3011713504 INFO: Loading skin file: DialogMediaSource.xml, load type: KEEP_IN_MEMORY
2019-10-22 11:23:13.446 T:3011713504 DEBUG: ------ Window Init (DialogMediaSource.xml) ------
2019-10-22 11:23:13.616 T:2718049136 DEBUG: PushCecKeypress - received key b duration 190
2019-10-22 11:23:14.919 T:2718049136 DEBUG: PushCecKeypress - received key a8 duration 0
2019-10-22 11:23:14.941 T:3011713504 DEBUG: HandleKey: 168 (0xa8, obc87) pressed, action is Right
2019-10-22 11:23:15.112 T:2718049136 DEBUG: PushCecKeypress - received key a8 duration 193
2019-10-22 11:23:15.463 T:2718049136 DEBUG: PushCecKeypress - received key b duration 0
2019-10-22 11:23:15.474 T:3011713504 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
2019-10-22 11:23:15.475 T:3011713504 INFO: Loading skin file: FileBrowser.xml, load type: KEEP_IN_MEMORY
2019-10-22 11:23:15.509 T:3011713504 DEBUG: ------ Window Init (FileBrowser.xml) ------
2019-10-22 11:23:15.661 T:2718049136 DEBUG: PushCecKeypress - received key b duration 198
2019-10-22 11:23:17.108 T:2718049136 DEBUG: PushCecKeypress - received key a7 duration 0
2019-10-22 11:23:17.108 T:3011713504 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down
2019-10-22 11:23:17.300 T:2718049136 DEBUG: PushCecKeypress - received key a7 duration 192
2019-10-22 11:23:17.755 T:2718049136 DEBUG: PushCecKeypress - received key b duration 0
2019-10-22 11:23:17.760 T:3011713504 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
2019-10-22 11:23:17.989 T:2718049136 DEBUG: PushCecKeypress - received key b duration 234
2019-10-22 11:23:21.901 T:3011713504 INFO: CheckIdle - Closing session to http://image.tmdb.org (easy=0xae556d50, multi=0xae53a850)
2019-10-22 11:23:22.229 T:2718049136 DEBUG: PushCecKeypress - received key a8 duration 0
2019-10-22 11:23:22.240 T:3011713504 DEBUG: HandleKey: 168 (0xa8, obc87) pressed, action is Right
2019-10-22 11:23:22.465 T:2718049136 DEBUG: PushCecKeypress - received key a8 duration 236
2019-10-22 11:23:24.283 T:2718049136 DEBUG: PushCecKeypress - received key b duration 0
2019-10-22 11:23:24.289 T:3011713504 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
2019-10-22 11:23:24.522 T:2718049136 DEBUG: PushCecKeypress - received key b duration 239
2019-10-22 11:23:24.546 T:3011713504 DEBUG: ------ Window Deinit (FileBrowser.xml) ------
2019-10-22 11:23:26.167 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 0
2019-10-22 11:23:26.176 T:3011713504 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up
2019-10-22 11:23:26.400 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 233
2019-10-22 11:23:27.094 T:2718049136 DEBUG: PushCecKeypress - received key a7 duration 0
2019-10-22 11:23:27.103 T:3011713504 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, action is Down
2019-10-22 11:23:27.331 T:2718049136 DEBUG: PushCecKeypress - received key a7 duration 237
2019-10-22 11:23:27.762 T:2718049136 DEBUG: PushCecKeypress - received key a7 duration 0
2019-10-22 11:23:27.770 T:3011713504 DEBUG: HandleKey: 167 (0xa7, obc88) pressed, trying keyboard action 4
2019-10-22 11:23:27.951 T:2718049136 DEBUG: PushCecKeypress - received key a7 duration 189
2019-10-22 11:23:28.373 T:2718049136 DEBUG: PushCecKeypress - received key b duration 0
2019-10-22 11:23:28.378 T:3011713504 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
2019-10-22 11:23:28.544 T:2718049136 DEBUG: PushCecKeypress - received key b duration 171
2019-10-22 11:23:28.646 T:3011713504 DEBUG: ------ Window Deinit (DialogMediaSource.xml) ------
2019-10-22 11:23:29.053 T:3011713504 DEBUG: ------ Window Init (DialogSettings.xml) ------
2019-10-22 11:23:29.053 T:3011713504 INFO: Loading skin file: DialogSettings.xml, load type: KEEP_IN_MEMORY
2019-10-22 11:23:29.062 T:3011713504 DEBUG: CSettingsManager: requested setting (contenttype) was not found.
2019-10-22 11:23:29.062 T:3011713504 DEBUG: CSettingsManager: requested setting (scraperlist) was not found.
2019-10-22 11:23:29.062 T:3011713504 DEBUG: CSettingsManager: requested setting (scrapersettings) was not found.
2019-10-22 11:23:29.062 T:3011713504 DEBUG: CSettingsManager: requested setting (exclude) was not found.
2019-10-22 11:23:30.461 T:2718049136 DEBUG: PushCecKeypress - received key a8 duration 0
2019-10-22 11:23:30.464 T:3011713504 DEBUG: HandleKey: 168 (0xa8, obc87) pressed, action is Right
2019-10-22 11:23:30.697 T:2718049136 DEBUG: PushCecKeypress - received key a8 duration 236
2019-10-22 11:23:30.978 T:2718049136 DEBUG: PushCecKeypress - received key b duration 0
2019-10-22 11:23:30.979 T:3011713504 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
2019-10-22 11:23:31.171 T:2718049136 DEBUG: PushCecKeypress - received key b duration 193
2019-10-22 11:23:31.248 T:3011713504 DEBUG: ------ Window Deinit (DialogSettings.xml) ------
2019-10-22 11:23:31.304 T:3011713504 DEBUG: Mysql execute: insert into path (idPath, strPath) values (NULL, '/storage/')
2019-10-22 11:23:31.319 T:3011713504 DEBUG: Mysql execute: update path set strContent='', strScraper='', scanRecursive=0, useFolderNames=0, strSettings='', noUpdate=0, exclude=0 where idPath=2433
2019-10-22 11:23:31.339 T:3011713504 DEBUG: CGUIMediaWindow::GetDirectory (sources://video/)
2019-10-22 11:23:31.340 T:3011713504 DEBUG: ParentPath = [sources://video/]
2019-10-22 11:23:31.340 T:2576348016 DEBUG: Thread waiting start, auto delete: false
2019-10-22 11:23:31.393 T:2576348016 DEBUG: Thread waiting 2576348016 terminating
2019-10-22 11:23:31.446 T:2576348016 DEBUG: Thread BackgroundLoader start, auto delete: false
2019-10-22 11:23:31.759 T:2576348016 DEBUG: Thread BackgroundLoader 2576348016 terminating
2019-10-22 11:23:32.202 T:2859860848 DEBUG: Thread JobWorker 2859860848 terminating (autodelete)
2019-10-22 11:23:32.697 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 0
2019-10-22 11:23:32.705 T:3011713504 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up
2019-10-22 11:23:32.888 T:2868253552 DEBUG: Thread JobWorker 2868253552 terminating (autodelete)
2019-10-22 11:23:32.891 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 194
2019-10-22 11:23:33.098 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 0
2019-10-22 11:23:33.126 T:3011713504 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up
2019-10-22 11:23:33.292 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 194
2019-10-22 11:23:33.862 T:2876646256 DEBUG: Thread JobWorker 2876646256 terminating (autodelete)
2019-10-22 11:23:34.003 T:2718049136 DEBUG: PushCecKeypress - received key b duration 0
2019-10-22 11:23:34.011 T:3011713504 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
2019-10-22 11:23:34.012 T:3011713504 DEBUG: CGUIMediaWindow::GetDirectory (/storage/)
2019-10-22 11:23:34.012 T:3011713504 DEBUG: ParentPath = [sources://video/]
2019-10-22 11:23:34.012 T:2876646256 DEBUG: Thread waiting start, auto delete: false
2019-10-22 11:23:34.053 T:2876646256 DEBUG: Thread waiting 2876646256 terminating
2019-10-22 11:23:34.117 T:3011713504 WARNING: CreateLoader - unsupported protocol(sources) in sources://video/VIDEO_TS/VIDEO_TS.IFO
2019-10-22 11:23:34.118 T:3011713504 WARNING: CreateLoader - unsupported protocol(sources) in sources://video/BDMV/index.bdmv
2019-10-22 11:23:34.195 T:2718049136 DEBUG: PushCecKeypress - received key b duration 192
2019-10-22 11:23:34.223 T:2876646256 DEBUG: Thread BackgroundLoader start, auto delete: false
2019-10-22 11:23:34.649 T:2674914160 DEBUG: DoWork - trying to extract thumb from video file /storage/testcar.mkv
2019-10-22 11:23:34.651 T:2674914160 DEBUG: CFileCache::Open - opening </storage/testcar.mkv> using cache
2019-10-22 11:23:34.651 T:2868253552 DEBUG: Thread FileCache start, auto delete: false
2019-10-22 11:23:34.652 T:2876646256 DEBUG: Thread BackgroundLoader 2876646256 terminating
2019-10-22 11:23:34.659 T:2674914160 DEBUG: Open - probing detected format [matroska,webm]
2019-10-22 11:23:34.662 T:2674914160 DEBUG: Seek - waiting for position 9873919048.
2019-10-22 11:23:34.669 T:2868253552 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?)
2019-10-22 11:23:34.680 T:2674914160 DEBUG: Open - avformat_find_stream_info starting
2019-10-22 11:23:34.717 T:2674914160 DEBUG: Open - av_find_stream_info finished
2019-10-22 11:23:34.718 T:2674914160 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0
2019-10-22 11:23:34.718 T:2674914160 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1
2019-10-22 11:23:34.718 T:2674914160 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 2
2019-10-22 11:23:34.718 T:2674914160 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 3
2019-10-22 11:23:34.718 T:2674914160 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 4
2019-10-22 11:23:34.718 T:2674914160 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 5
2019-10-22 11:23:34.718 T:2674914160 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 6
2019-10-22 11:23:34.718 T:2674914160 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 7
2019-10-22 11:23:34.718 T:2674914160 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 8
2019-10-22 11:23:34.718 T:2674914160 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 9
2019-10-22 11:23:34.718 T:2674914160 DEBUG: ScanForExternalSubtitles: Searching for subtitles...
2019-10-22 11:23:34.719 T:2674914160 DEBUG: ScanArchiveForAssociatedItems: Scanning archive /storage/koditweak.zip
2019-10-22 11:23:34.720 T:2674914160 DEBUG: ScanForExternalSubtitles: END (total time: 1 ms)
2019-10-22 11:23:34.722 T:2674914160 DEBUG: CMMALPool::CMMALPool Created pool 0x96631000 of size 26 x 0 for port vc.ril.video_decode:out:0(I420)
2019-10-22 11:23:34.722 T:2674914160 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
2019-10-22 11:23:34.722 T:2674914160 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264
2019-10-22 11:23:34.722 T:2674914160 DEBUG: ExtractThumb - seeking to pos 2332000ms (total: 6996000ms) in /storage/testcar.mkv
2019-10-22 11:23:34.727 T:2868253552 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?)
2019-10-22 11:23:34.733 T:2674914160 DEBUG: SeekTime - seek ended up on time 2327323
2019-10-22 11:23:34.950 T:2674914160 DEBUG: cached image 'special://masterprofile/Thumbnails/6/62877c16.jpg' size 540x225
2019-10-22 11:23:34.972 T:2674914160 DEBUG: CMMALPool::~CMMALPool Destroying pool 0x96631000 for port vc.ril.video_decode:out:0(I420)
2019-10-22 11:23:34.974 T:2674914160 DEBUG: ExtractThumb - measured 324 ms to extract thumb from file </storage/testcar.mkv> in 38 packets.
2019-10-22 11:23:34.975 T:2868253552 DEBUG: Thread FileCache 2868253552 terminating
2019-10-22 11:23:35.376 T:2674914160 DEBUG: Mysql execute: insert into files (idFile, idPath, strFileName) values(NULL, 2433, 'testcar.mkv')
2019-10-22 11:23:35.405 T:2674914160 DEBUG: Mysql Start transaction
2019-10-22 11:23:35.405 T:2674914160 DEBUG: Mysql execute: DELETE FROM streamdetails WHERE idFile = 10636
2019-10-22 11:23:35.420 T:2674914160 DEBUG: Mysql execute: INSERT INTO streamdetails (idFile, iStreamType, strVideoCodec, fVideoAspect, iVideoWidth, iVideoHeight, iVideoDuration, strStereoMode, strVideoLanguage) VALUES (10636,0,'h264',2.400000,1920,800,6996,'','eng')
2019-10-22 11:23:35.434 T:2674914160 DEBUG: Mysql execute: INSERT INTO streamdetails (idFile, iStreamType, strAudioCodec, iAudioChannels, strAudioLanguage) VALUES (10636,1,'ac3',6,'swe')
2019-10-22 11:23:35.449 T:2674914160 DEBUG: Mysql execute: INSERT INTO streamdetails (idFile, iStreamType, strAudioCodec, iAudioChannels, strAudioLanguage) VALUES (10636,1,'ac3',6,'eng')
2019-10-22 11:23:35.464 T:2674914160 DEBUG: Mysql execute: INSERT INTO streamdetails (idFile, iStreamType, strAudioCodec, iAudioChannels, strAudioLanguage) VALUES (10636,1,'ac3',6,'dan')
2019-10-22 11:23:35.479 T:2674914160 DEBUG: Mysql execute: INSERT INTO streamdetails (idFile, iStreamType, strAudioCodec, iAudioChannels, strAudioLanguage) VALUES (10636,1,'ac3',6,'fin')
2019-10-22 11:23:35.493 T:2674914160 DEBUG: Mysql execute: INSERT INTO streamdetails (idFile, iStreamType, strAudioCodec, iAudioChannels, strAudioLanguage) VALUES (10636,1,'ac3',6,'nor')
2019-10-22 11:23:35.508 T:2674914160 DEBUG: Mysql execute: INSERT INTO streamdetails (idFile, iStreamType, strSubtitleLanguage) VALUES (10636,2,'swe')
2019-10-22 11:23:35.523 T:2674914160 DEBUG: Mysql execute: INSERT INTO streamdetails (idFile, iStreamType, strSubtitleLanguage) VALUES (10636,2,'dan')
2019-10-22 11:23:35.537 T:2674914160 DEBUG: Mysql execute: INSERT INTO streamdetails (idFile, iStreamType, strSubtitleLanguage) VALUES (10636,2,'fin')
2019-10-22 11:23:35.552 T:2674914160 DEBUG: Mysql execute: INSERT INTO streamdetails (idFile, iStreamType, strSubtitleLanguage) VALUES (10636,2,'nor')
2019-10-22 11:23:35.567 T:2674914160 DEBUG: Mysql execute: update movie set c11=6996 where idFile=10636 and c11=''
2019-10-22 11:23:35.581 T:2674914160 DEBUG: Mysql execute: update episode set c09=6996 where idFile=10636 and c09=''
2019-10-22 11:23:35.596 T:2674914160 DEBUG: Mysql execute: update musicvideo set c04=6996 where idFile=10636 and c04=''
2019-10-22 11:23:35.640 T:2674914160 DEBUG: Mysql commit transaction
2019-10-22 11:23:35.795 T:3011713504 INFO: CheckIdle - Closing session to http://iptv.local (easy=0xa23f10c0, multi=0x9fde98f8)
2019-10-22 11:23:35.941 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 0
2019-10-22 11:23:35.954 T:3011713504 DEBUG: HandleKey: 166 (0xa6, obc89) pressed, action is Up
2019-10-22 11:23:36.130 T:2718049136 DEBUG: PushCecKeypress - received key a6 duration 189
2019-10-22 11:23:38.198 T:2718049136 DEBUG: PushCecKeypress - received key b duration 0
2019-10-22 11:23:38.209 T:3011713504 DEBUG: HandleKey: 11 (0x0b, obc244) pressed, action is Select
2019-10-22 11:23:38.421 T:3011713504 DEBUG: OnPlayMedia /storage/testcar.mkv
2019-10-22 11:23:38.430 T:2718049136 DEBUG: PushCecKeypress - received key b duration 232
2019-10-22 11:23:38.962 T:3011699568 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc
2019-10-22 11:23:38.962 T:3011699568 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd
2019-10-22 11:23:38.991 T:3011713504 DEBUG: CPlayerCoreFactory::GetPlayers(/storage/testcar.mkv)
2019-10-22 11:23:38.991 T:3011713504 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
2019-10-22 11:23:38.991 T:3011713504 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
2019-10-22 11:23:38.991 T:3011713504 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp
2019-10-22 11:23:38.991 T:3011713504 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
2019-10-22 11:23:38.991 T:3011713504 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
2019-10-22 11:23:38.991 T:3011713504 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
2019-10-22 11:23:38.991 T:3011713504 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
2019-10-22 11:23:38.991 T:3011713504 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
2019-10-22 11:23:38.991 T:3011713504 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
2019-10-22 11:23:38.991 T:3011713504 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
2019-10-22 11:23:38.991 T:3011713504 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
2019-10-22 11:23:38.991 T:3011713504 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
2019-10-22 11:23:38.991 T:3011713504 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
2019-10-22 11:23:38.991 T:3011713504 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer)
2019-10-22 11:23:38.991 T:3011713504 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
2019-10-22 11:23:38.991 T:3011713504 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
2019-10-22 11:23:38.991 T:3011713504 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
2019-10-22 11:23:38.994 T:3011713504 DEBUG: CMMALPool::CMMALPool Created pool 0x3a4fe40 of size 26 x 0 for port vc.ril.video_decode:out:0(I420)
2019-10-22 11:23:38.999 T:3011713504 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData
2019-10-22 11:23:38.999 T:3011713504 NOTICE: VideoPlayer::OpenFile: /storage/testcar.mkv
2019-10-22 11:23:38.999 T:3011713504 DEBUG: CMMALRenderer::CMMALRenderer
2019-10-22 11:23:39.000 T:2876646256 DEBUG: Thread MMALProcess start, auto delete: false
2019-10-22 11:23:39.000 T:3011713504 DEBUG: OnPlayBackStarted: CApplication::OnPlayBackStarted
2019-10-22 11:23:39.000 T:2876646256 DEBUG: CMMALRenderer::Run - starting
2019-10-22 11:23:39.000 T:2859860848 DEBUG: Thread VideoPlayer start, auto delete: false
2019-10-22 11:23:39.000 T:2576348016 DEBUG: Thread BackgroundLoader start, auto delete: false
2019-10-22 11:23:39.001 T:2859860848 NOTICE: Creating InputStream
2019-10-22 11:23:39.002 T:2859860848 DEBUG: ScanArchiveForAssociatedItems: Scanning archive /storage/koditweak.zip
2019-10-22 11:23:39.004 T:2859860848 DEBUG: CFileCache::Open - opening </storage/testcar.mkv> using cache
2019-10-22 11:23:39.004 T:2859860848 DEBUG: ScanForExternalSubtitles: Searching for subtitles...
2019-10-22 11:23:39.004 T:2554426224 DEBUG: Thread FileCache start, auto delete: false
2019-10-22 11:23:39.005 T:2859860848 DEBUG: ScanArchiveForAssociatedItems: Scanning archive /storage/koditweak.zip
2019-10-22 11:23:39.006 T:2859860848 DEBUG: ScanForExternalSubtitles: END (total time: 2 ms)
2019-10-22 11:23:39.006 T:2859860848 NOTICE: Creating Demuxer
2019-10-22 11:23:39.006 T:2859860848 DEBUG: Open - probing detected format [matroska,webm]
2019-10-22 11:23:39.007 T:2859860848 DEBUG: Seek - waiting for position 9873919048.
2019-10-22 11:23:39.010 T:2554426224 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?)
2019-10-22 11:23:39.015 T:2859860848 DEBUG: Open - avformat_find_stream_info starting
2019-10-22 11:23:39.031 T:3011713504 DEBUG: CVideoGUIInfo::InitCurrentItem(/storage/testcar.mkv)
2019-10-22 11:23:39.032 T:3011713504 DEBUG: CPlayerGUIInfo::InitCurrentItem(/storage/testcar.mkv)
2019-10-22 11:23:39.032 T:3011699568 DEBUG: CAnnouncementManager - Announcement: OnChanged from xbmc
2019-10-22 11:23:39.032 T:3011699568 DEBUG: GOT ANNOUNCEMENT, type: 1024, from xbmc, message OnChanged
2019-10-22 11:23:39.048 T:2859860848 DEBUG: Open - av_find_stream_info finished
2019-10-22 11:23:39.048 T:2859860848 INFO: ffmpeg[AA760370]: Input #0, matroska,webm, from '/storage/testcar.mkv':
2019-10-22 11:23:39.048 T:2859860848 INFO: ffmpeg[AA760370]: Metadata:
2019-10-22 11:23:39.048 T:2859860848 INFO: ffmpeg[AA760370]: title : testcar
2019-10-22 11:23:39.048 T:2859860848 INFO: ffmpeg[AA760370]: encoder : libebml v0.7.9 + libmatroska v0.8.1
2019-10-22 11:23:39.048 T:2859860848 INFO: ffmpeg[AA760370]: creation_time : 2010-04-08T07:05:17.000000Z
2019-10-22 11:23:39.048 T:2859860848 INFO: ffmpeg[AA760370]: Duration: 01:56:36.00, start: 0.000000, bitrate: 11291 kb/s
2019-10-22 11:23:39.048 T:2859860848 INFO: ffmpeg[AA760370]: Stream #0:0(eng): Video: h264 (High), yuv420p(progressive), 1920x800, SAR 1:1 DAR 12:5, 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc (default)
2019-10-22 11:23:39.048 T:2859860848 INFO: ffmpeg[AA760370]: Metadata:
2019-10-22 11:23:39.048 T:2859860848 INFO: ffmpeg[AA760370]: title : testcar
2019-10-22 11:23:39.049 T:2859860848 INFO: ffmpeg[AA760370]: Stream #0:1(swe): Audio: ac3, 48000 Hz, 5.1(side), fltp, 384 kb/s
2019-10-22 11:23:39.049 T:2859860848 INFO: ffmpeg[AA760370]: Metadata:
2019-10-22 11:23:39.049 T:2859860848 INFO: ffmpeg[AA760370]: title : Swedish AC3
2019-10-22 11:23:39.049 T:2859860848 INFO: ffmpeg[AA760370]: Stream #0:2(eng): Audio: ac3, 48000 Hz, 5.1(side), fltp, 640 kb/s (default)
2019-10-22 11:23:39.049 T:2859860848 INFO: ffmpeg[AA760370]: Metadata:
2019-10-22 11:23:39.049 T:2859860848 INFO: ffmpeg[AA760370]: title : English AC3
2019-10-22 11:23:39.049 T:2859860848 INFO: ffmpeg[AA760370]: Stream #0:3(dan): Audio: ac3, 48000 Hz, 5.1(side), fltp, 384 kb/s
2019-10-22 11:23:39.049 T:2859860848 INFO: ffmpeg[AA760370]: Metadata:
2019-10-22 11:23:39.049 T:2859860848 INFO: ffmpeg[AA760370]: title : Danish AC3
2019-10-22 11:23:39.049 T:2859860848 INFO: ffmpeg[AA760370]: Stream #0:4(fin): Audio: ac3, 48000 Hz, 5.1(side), fltp, 384 kb/s
2019-10-22 11:23:39.049 T:2859860848 INFO: ffmpeg[AA760370]: Metadata:
2019-10-22 11:23:39.049 T:2859860848 INFO: ffmpeg[AA760370]: title : Finnish AC3
2019-10-22 11:23:39.049 T:2859860848 INFO: ffmpeg[AA760370]: Stream #0:5(nor): Audio: ac3, 48000 Hz, 5.1(side), fltp, 384 kb/s
2019-10-22 11:23:39.049 T:2859860848 INFO: ffmpeg[AA760370]: Metadata:
2019-10-22 11:23:39.049 T:2859860848 INFO: ffmpeg[AA760370]: title : Norwegian AC3
2019-10-22 11:23:39.049 T:2859860848 INFO: ffmpeg[AA760370]: Stream #0:6(swe): Subtitle: subtitle (default)
2019-10-22 11:23:39.049 T:2859860848 INFO: ffmpeg[AA760370]: Metadata:
2019-10-22 11:23:39.050 T:2859860848 INFO: ffmpeg[AA760370]: title : Swedish
2019-10-22 11:23:39.050 T:2859860848 INFO: ffmpeg[AA760370]: Stream #0:7(dan): Subtitle: subtitle
2019-10-22 11:23:39.050 T:2859860848 INFO: ffmpeg[AA760370]: Metadata:
2019-10-22 11:23:39.050 T:2859860848 INFO: ffmpeg[AA760370]: title : Danish
2019-10-22 11:23:39.050 T:2859860848 INFO: ffmpeg[AA760370]: Stream #0:8(fin): Subtitle: subtitle
2019-10-22 11:23:39.050 T:2859860848 INFO: ffmpeg[AA760370]: Metadata:
2019-10-22 11:23:39.050 T:2859860848 INFO: ffmpeg[AA760370]: title : Finnish
2019-10-22 11:23:39.050 T:2859860848 INFO: ffmpeg[AA760370]: Stream #0:9(nor): Subtitle: subtitle
2019-10-22 11:23:39.050 T:2859860848 INFO: ffmpeg[AA760370]: Metadata:
2019-10-22 11:23:39.050 T:2859860848 INFO: ffmpeg[AA760370]: title : Norwegian
2019-10-22 11:23:39.050 T:2859860848 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0
2019-10-22 11:23:39.050 T:2859860848 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1
2019-10-22 11:23:39.050 T:2859860848 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 2
2019-10-22 11:23:39.050 T:2859860848 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 3
2019-10-22 11:23:39.050 T:2859860848 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 4
2019-10-22 11:23:39.050 T:2859860848 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 5
2019-10-22 11:23:39.050 T:2859860848 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 6
2019-10-22 11:23:39.050 T:2859860848 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 7
2019-10-22 11:23:39.050 T:2859860848 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 8
2019-10-22 11:23:39.050 T:2859860848 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 9
2019-10-22 11:23:39.051 T:2859860848 DEBUG: CDVDInputStreamFile::SetReadRate - set cache throttle rate to 1552520 bytes per second
2019-10-22 11:23:39.051 T:2859860848 NOTICE: Opening stream: 0 source: 256
2019-10-22 11:23:39.051 T:2859860848 NOTICE: Creating video codec with codec id: 27
2019-10-22 11:23:39.051 T:2859860848 DEBUG: CSettingsManager: requested setting (videoplayer.supportmvc) was not found.
2019-10-22 11:23:39.054 T:2859860848 DEBUG: CMMALPool::CMMALPool Created pool 0xb2fc7930 of size 26 x 128 for port vc.ril.video_decode:out:0(OPQV)
2019-10-22 11:23:39.059 T:2859860848 DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 27
2019-10-22 11:23:39.062 T:2859860848 DEBUG: CMMALPool::CMMALPool Created pool 0xb2fca720 of size 26 x 0 for port vc.ril.video_decode:out:0(I420)
2019-10-22 11:23:39.062 T:2859860848 DEBUG: CMMALPool::~CMMALPool Destroying pool 0x3a4fe40 for port vc.ril.video_decode:out:0(I420)
2019-10-22 11:23:39.062 T:2859860848 NOTICE: Creating video thread
2019-10-22 11:23:39.063 T:2868253552 DEBUG: Thread VideoPlayerVideo start, auto delete: false
2019-10-22 11:23:39.063 T:2859860848 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: /storage/testcar.mkv
2019-10-22 11:23:39.063 T:2868253552 NOTICE: running thread: video_thread
2019-10-22 11:23:39.063 T:2868253552 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: 0
2019-10-22 11:23:39.063 T:2859860848 NOTICE: Opening stream: 1 source: 256
2019-10-22 11:23:39.063 T:2859860848 NOTICE: Finding audio codec for: 86019
2019-10-22 11:23:39.064 T:2859860848 NOTICE: CDVDAudioCodecFFmpeg::Open() Successful opened audio decoder ac3
2019-10-22 11:23:39.064 T:2859860848 NOTICE: Creating audio thread
2019-10-22 11:23:39.065 T:2859860848 NOTICE: Opening stream: 6 source: 256
2019-10-22 11:23:39.065 T:2327434096 DEBUG: Thread VideoPlayerAudio start, auto delete: false
2019-10-22 11:23:39.065 T:2327434096 NOTICE: running thread: CVideoPlayerAudio::Process()
2019-10-22 11:23:39.065 T:2327434096 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_PAUSE: 0
2019-10-22 11:23:39.065 T:2859860848 DEBUG: CVideoPlayer::SetCaching - caching state 1
2019-10-22 11:23:39.065 T:2859860848 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
2019-10-22 11:23:39.065 T:2859860848 DEBUG: CVideoPlayer::HandleMessages - player 2 reported state: 0
2019-10-22 11:23:39.065 T:2859860848 DEBUG: CVideoPlayer::HandleMessages - player 1 reported state: 0
2019-10-22 11:23:39.066 T:2859860848 DEBUG: CVideoPlayer::SetCaching - caching state 1
2019-10-22 11:23:39.066 T:2868253552 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback
2019-10-22 11:23:39.066 T:2859860848 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
2019-10-22 11:23:39.066 T:2859860848 DEBUG: CVideoPlayer::SetCaching - caching state 2
2019-10-22 11:23:39.066 T:2859860848 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
2019-10-22 11:23:39.066 T:2859860848 DEBUG: CVideoPlayer::CheckContinuity - wrapback :2, prev:167000.000000, curr:0.000000, diff:-167000.000000
2019-10-22 11:23:39.075 T:2327434096 DEBUG: CDVDAudio::Pause - pausing audio stream
2019-10-22 11:23:39.082 T:2327434096 DEBUG: Previous line repeats 2 times.
2019-10-22 11:23:39.082 T:2327434096 NOTICE: Creating audio stream (codec id: 86019, channels: 6, sample rate: 48000, no pass-through)
2019-10-22 11:23:39.082 T:2327434096 DEBUG: CVideoPlayerAudio:: synctype set to 0: clock feedback
2019-10-22 11:23:39.091 T:2980049776 INFO: CActiveAESink::OpenSink - initialize sink
2019-10-22 11:23:39.091 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:23:39.110 T:2868253552 DEBUG: Previous line repeats 4 times.
2019-10-22 11:23:39.110 T:2868253552 DEBUG: CRenderManager::Configure - change configuration. 1920x800. display: 1920x800. framerate: 23.98.
2019-10-22 11:23:39.135 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:23:39.141 T:3011713504 DEBUG: Previous line repeats 1 times.
2019-10-22 11:23:39.141 T:3011713504 DEBUG: ------ Window Init (DialogBusy.xml) ------
2019-10-22 11:23:39.144 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:23:39.149 T:3011713504 DEBUG: Previous line repeats 1 times.
2019-10-22 11:23:39.150 T:3011713504 DEBUG: DeleteRenderer - deleting renderer
2019-10-22 11:23:39.150 T:3011713504 DEBUG: CMMALRenderer::~CMMALRenderer
2019-10-22 11:23:39.150 T:3011713504 DEBUG: CMMALRenderer::UnInitMMAL
2019-10-22 11:23:39.150 T:2876646256 DEBUG: CMMALRenderer::Run - stopping
2019-10-22 11:23:39.150 T:2876646256 DEBUG: Thread MMALProcess 2876646256 terminating
2019-10-22 11:23:39.150 T:3011713504 DEBUG: CMMALRenderer::CMMALRenderer
2019-10-22 11:23:39.150 T:2319041392 DEBUG: Thread MMALProcess start, auto delete: false
2019-10-22 11:23:39.150 T:3011713504 DEBUG: CMMALRenderer::Configure - 1920x800[email protected] flags:1 format:-1 orient:0
2019-10-22 11:23:39.150 T:2319041392 DEBUG: CMMALRenderer::Run - starting
2019-10-22 11:23:39.150 T:3011713504 DEBUG: CRenderManager::Configure - 4
2019-10-22 11:23:39.151 T:2859860848 DEBUG: CVideoPlayer::HandleMessages - player started 2
2019-10-22 11:23:39.162 T:2319041392 DEBUG: CMMALRenderer::CheckConfigurationVout Changing Vout dimensions from 0x0 (0x0) to 1920x800 (1920x800) OPQV
2019-10-22 11:23:39.165 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync -1 (+3143)
2019-10-22 11:23:39.165 T:3011713504 DEBUG: CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 60
2019-10-22 11:23:39.166 T:2319041392 DEBUG: CMMALRenderer::SetVideoRect 0,0,1920,800
0,140,1920,940 (o:0 v:0 d:0 i:0) 2019-10-22 11:23:39.166 T:2310648688 DEBUG: Thread MMALRenderer start, auto delete: false
2019-10-22 11:23:39.166 T:2310648688 DEBUG: CMMALRenderer::Process - starting
2019-10-22 11:23:39.166 T:2319041392 DEBUG: CMMALRenderer::SetVideoRect 0,0,1920,800 0,280,3840,1600 t:100000
2019-10-22 11:23:39.188 T:3011713504 DEBUG: CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 68
2019-10-22 11:23:39.190 T:2980049776 DEBUG: CAESinkPi:Drain delay:99ms now:0ms
2019-10-22 11:23:39.190 T:2980049776 DEBUG: CAESinkPi:Deinitialize
2019-10-22 11:23:39.190 T:2980049776 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000
2019-10-22 11:23:39.194 T:2980049776 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0xb100d308
2019-10-22 11:23:39.194 T:2980049776 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI
2019-10-22 11:23:39.195 T:2980049776 DEBUG: CAESinkPi:Initialize Format:24 Channels:2 Samplerate:48000 framesize:8 bufsize:19200 bytes/s=384000.00 dest=PI:HDMI
2019-10-22 11:23:39.195 T:2980049776 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008
2019-10-22 11:23:39.196 T:2980049776 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x9e595ba8
2019-10-22 11:23:39.197 T:2980049776 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(19200), nBufferAlignment(16)
2019-10-22 11:23:39.198 T:2980049776 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized:
2019-10-22 11:23:39.198 T:2980049776 DEBUG: Output Device : HDMI
2019-10-22 11:23:39.198 T:2980049776 DEBUG: Sample Rate : 48000
2019-10-22 11:23:39.198 T:2980049776 DEBUG: Sample Format : AE_FMT_FLOATP
2019-10-22 11:23:39.198 T:2980049776 DEBUG: Channel Count : 2
2019-10-22 11:23:39.198 T:2980049776 DEBUG: Channel Layout: FL, FR
2019-10-22 11:23:39.198 T:2980049776 DEBUG: Frames : 2400
2019-10-22 11:23:39.198 T:2980049776 DEBUG: Frame Size : 8
2019-10-22 11:23:39.204 T:2989863792 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
2019-10-22 11:23:39.207 T:2859860848 DEBUG: Previous line repeats 1 times.
2019-10-22 11:23:39.207 T:2859860848 DEBUG: CVideoPlayer::HandleMessages - player started 1
2019-10-22 11:23:39.208 T:2859860848 DEBUG: CVideoPlayer::SetCaching - caching state 3
2019-10-22 11:23:39.208 T:2859860848 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
2019-10-22 11:23:39.208 T:2859860848 DEBUG: CVideoPlayer::SetCaching - caching state 0
2019-10-22 11:23:39.208 T:2859860848 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
2019-10-22 11:23:39.208 T:2859860848 DEBUG: VideoPlayer::Sync - Audio - pts: 288000.000000, cache: 412921.348452, totalcache: 699999.988079
2019-10-22 11:23:39.208 T:2859860848 DEBUG: VideoPlayer::Sync - Video - pts: 0.000000, cache: 50000.000000, totalcache: 100000.000000
2019-10-22 11:23:39.208 T:2327434096 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(-124921.348452), level: 77, cache: 412017.978452
2019-10-22 11:23:39.208 T:2327434096 DEBUG: CDVDAudio::Resume - resume audio stream
2019-10-22 11:23:39.210 T:2989863792 DEBUG: ActiveAE - start sync of audio stream
2019-10-22 11:23:39.216 T:3011713504 DEBUG: Activating window ID: 12005
2019-10-22 11:23:39.319 T:2674914160 DEBUG: Loading settings for /storage/testcar.mkv
2019-10-22 11:23:39.349 T:2989863792 DEBUG: ActiveAE::SyncStream - average error of 16.183197, start adjusting
2019-10-22 11:23:39.350 T:2989863792 DEBUG: ActiveAE::SyncStream - average error 0.183197 below threshold of 30.000000
2019-10-22 11:23:39.352 T:2576348016 DEBUG: Thread BackgroundLoader 2576348016 terminating
2019-10-22 11:23:39.354 T:3011713504 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
2019-10-22 11:23:39.355 T:3011713504 DEBUG: FreeVisualisation() done
2019-10-22 11:23:39.356 T:3011713504 DEBUG: ------ Window Init (VideoFullScreen.xml) ------
2019-10-22 11:23:39.356 T:3011713504 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY
2019-10-22 11:23:39.362 T:3011713504 DEBUG: CMMALRenderer::SetVideoRect 0,0,1920,800
0,140,1920,940 (o:0 v:0 d:0 i:0) 2019-10-22 11:23:39.362 T:3011713504 DEBUG: CMMALRenderer::SetVideoRect 0,0,1920,800 -> 0,280,3840,1600 t:100000
2019-10-22 11:23:39.362 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 3144 (+9)
2019-10-22 11:23:39.366 T:2674914160 DEBUG: OnAVChange: CApplication::OnAVChange
2019-10-22 11:23:39.367 T:2576348016 DEBUG: Thread JobWorker start, auto delete: true
2019-10-22 11:23:39.367 T:2674914160 DEBUG: OnAVChange: CApplication::OnAVChange
2019-10-22 11:23:39.368 T:2674914160 DEBUG: Previous line repeats 1 times.
2019-10-22 11:23:39.368 T:2674914160 DEBUG: OnAVStarted: CApplication::OnAVStarted
2019-10-22 11:23:39.368 T:2576348016 DEBUG: OnAVChange: CApplication::OnAVChange
2019-10-22 11:23:39.384 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 3154 (+1)
2019-10-22 11:23:39.398 T:3011713504 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
2019-10-22 11:23:39.597 T:3011699568 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
2019-10-22 11:23:39.597 T:3011699568 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
2019-10-22 11:23:39.665 T:2868253552 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
2019-10-22 11:23:39.665 T:2868253552 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(-124921.348452)
2019-10-22 11:23:39.675 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:23:40.113 T:3011699568 DEBUG: Previous line repeats 14 times.
2019-10-22 11:23:40.113 T:3011699568 DEBUG: CAnnouncementManager - Announcement: OnAVChange from xbmc
2019-10-22 11:23:40.113 T:3011699568 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVChange
2019-10-22 11:23:40.136 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:23:40.367 T:2327434096 DEBUG: Previous line repeats 7 times.
2019-10-22 11:23:40.367 T:2327434096 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-33430.770865, adjusted:-33430.770865
2019-10-22 11:23:40.502 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:23:40.670 T:3011699568 DEBUG: Previous line repeats 4 times.
2019-10-22 11:23:40.670 T:3011699568 DEBUG: CAnnouncementManager - Announcement: OnAVChange from xbmc
2019-10-22 11:23:40.670 T:3011699568 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVChange
2019-10-22 11:23:40.687 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:23:41.192 T:3011699568 DEBUG: Previous line repeats 11 times.
2019-10-22 11:23:41.192 T:3011699568 DEBUG: CAnnouncementManager - Announcement: OnAVChange from xbmc
2019-10-22 11:23:41.192 T:3011699568 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVChange
2019-10-22 11:23:41.197 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:23:41.761 T:3011699568 DEBUG: Previous line repeats 17 times.
2019-10-22 11:23:41.761 T:3011699568 DEBUG: CAnnouncementManager - Announcement: OnAVStart from xbmc
2019-10-22 11:23:41.761 T:3011699568 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVStart
2019-10-22 11:23:41.793 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:23:42.309 T:3011699568 DEBUG: Previous line repeats 10 times.
2019-10-22 11:23:42.309 T:3011699568 DEBUG: CAnnouncementManager - Announcement: OnAVChange from xbmc
2019-10-22 11:23:42.309 T:3011699568 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVChange
2019-10-22 11:23:42.421 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:23:44.208 T:2868253552 DEBUG: Previous line repeats 43 times.
2019-10-22 11:23:44.208 T:2868253552 DEBUG: CPtsTracker: detected pattern of length 1: 41708.33, frameduration: 41708.333333
2019-10-22 11:23:44.209 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:23:47.258 T:3011713504 DEBUG: Previous line repeats 74 times.
2019-10-22 11:23:47.258 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 3626 (+1)
2019-10-22 11:23:47.376 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:09.368 T:2674914160 DEBUG: Previous line repeats 527 times.
2019-10-22 11:24:09.368 T:2674914160 DEBUG: Thread JobWorker 2674914160 terminating (autodelete)
2019-10-22 11:24:09.368 T:2576348016 DEBUG: Thread JobWorker 2576348016 terminating (autodelete)
2019-10-22 11:24:09.399 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:17.716 T:3011713504 DEBUG: Previous line repeats 198 times.
2019-10-22 11:24:17.716 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 5448 (+4)
2019-10-22 11:24:17.724 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:22.165 T:2750755696 DEBUG: Previous line repeats 109 times.
2019-10-22 11:24:22.165 T:2750755696 DEBUG: JSONRPC Server: New connection detected
2019-10-22 11:24:22.165 T:2750755696 INFO: JSONRPC Server: New connection added
2019-10-22 11:24:22.185 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:24:22.295 T:2344219504 DEBUG: Previous line repeats 2 times.
2019-10-22 11:24:22.295 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:22.324 T:2674914160 DEBUG: Previous line repeats 3 times.
2019-10-22 11:24:22.324 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:24:22.461 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:23.549 T:2750755696 DEBUG: Previous line repeats 27 times.
2019-10-22 11:24:23.549 T:2750755696 INFO: JSONRPC Server: Disconnection detected
2019-10-22 11:24:23.629 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:24.064 T:2674914160 DEBUG: Previous line repeats 13 times.
2019-10-22 11:24:24.064 T:2674914160 DEBUG: CWebServer[8080]: request received for /image/image%3A%2F%2Fvideo%40%252fstorage%252ftestcar.mkv%2F
2019-10-22 11:24:24.066 T:2674914160 DEBUG: CUtil::GetMatchingSource: no matching source found for [/storage/testcar.mkv]
2019-10-22 11:24:24.214 T:2344219504 DEBUG: Previous line repeats 3 times.
2019-10-22 11:24:24.215 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:27.828 T:2674914160 DEBUG: Previous line repeats 89 times.
2019-10-22 11:24:27.828 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:24:27.843 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:27.896 T:2674914160 DEBUG: Previous line repeats 2 times.
2019-10-22 11:24:27.896 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:24:28.083 T:2344219504 DEBUG: Previous line repeats 2 times.
2019-10-22 11:24:28.083 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:28.803 T:3011713504 DEBUG: Previous line repeats 19 times.
2019-10-22 11:24:28.803 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 6116 (+1)
2019-10-22 11:24:28.918 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:33.334 T:2674914160 DEBUG: Previous line repeats 108 times.
2019-10-22 11:24:33.334 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:24:33.456 T:2344219504 DEBUG: Previous line repeats 3 times.
2019-10-22 11:24:33.456 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:35.438 T:3011713504 DEBUG: Previous line repeats 47 times.
2019-10-22 11:24:35.438 T:3011713504 NOTICE: Samba is idle. Closing the remaining connections
2019-10-22 11:24:35.458 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:38.716 T:2674914160 DEBUG: Previous line repeats 77 times.
2019-10-22 11:24:38.716 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:24:38.729 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:38.751 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:24:38.754 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:38.770 T:2674914160 DEBUG: Previous line repeats 2 times.
2019-10-22 11:24:38.770 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:24:38.895 T:2344219504 DEBUG: Previous line repeats 1 times.
2019-10-22 11:24:38.896 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:44.140 T:2674914160 DEBUG: Previous line repeats 125 times.
2019-10-22 11:24:44.140 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:24:44.151 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:44.282 T:2674914160 DEBUG: Previous line repeats 3 times.
2019-10-22 11:24:44.282 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:24:44.317 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:44.342 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:24:44.343 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:44.369 T:2674914160 DEBUG: Previous line repeats 2 times.
2019-10-22 11:24:44.369 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:24:44.484 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:49.671 T:2674914160 DEBUG: Previous line repeats 124 times.
2019-10-22 11:24:49.671 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:24:49.682 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:49.695 T:2674914160 DEBUG: Previous line repeats 2 times.
2019-10-22 11:24:49.695 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:24:49.823 T:2344219504 DEBUG: Previous line repeats 2 times.
2019-10-22 11:24:49.824 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:55.069 T:2674914160 DEBUG: Previous line repeats 128 times.
2019-10-22 11:24:55.069 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:24:55.211 T:2344219504 DEBUG: Previous line repeats 1 times.
2019-10-22 11:24:55.211 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:24:55.223 T:2674914160 DEBUG: Previous line repeats 2 times.
2019-10-22 11:24:55.223 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:24:55.345 T:2344219504 DEBUG: Previous line repeats 1 times.
2019-10-22 11:24:55.345 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:00.675 T:2674914160 DEBUG: Previous line repeats 128 times.
2019-10-22 11:25:00.675 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:00.700 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:00.730 T:2674914160 DEBUG: Previous line repeats 2 times.
2019-10-22 11:25:00.730 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:00.827 T:2327434096 DEBUG: Previous line repeats 1 times.
2019-10-22 11:25:00.828 T:2327434096 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-10113.692667, adjusted:-10113.692667
2019-10-22 11:25:00.833 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:00.842 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:00.842 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:06.310 T:2674914160 DEBUG: Previous line repeats 131 times.
2019-10-22 11:25:06.312 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:06.312 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:06.369 T:2674914160 DEBUG: Previous line repeats 2 times.
2019-10-22 11:25:06.369 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:06.523 T:2344219504 DEBUG: Previous line repeats 2 times.
2019-10-22 11:25:06.524 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:11.959 T:2674914160 DEBUG: Previous line repeats 131 times.
2019-10-22 11:25:11.959 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:11.966 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:12.009 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:12.061 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:12.062 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:12.073 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:12.127 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:12.146 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:17.632 T:2674914160 DEBUG: Previous line repeats 134 times.
2019-10-22 11:25:17.632 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:17.790 T:2344219504 DEBUG: Previous line repeats 2 times.
2019-10-22 11:25:17.790 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:17.919 T:2674914160 DEBUG: Previous line repeats 4 times.
2019-10-22 11:25:17.919 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:18.000 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:23.515 T:2674914160 DEBUG: Previous line repeats 133 times.
2019-10-22 11:25:23.515 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:23.574 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:23.585 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:23.588 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:23.650 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:23.657 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:23.711 T:2674914160 DEBUG: Previous line repeats 1 times.
2019-10-22 11:25:23.712 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:23.740 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:29.215 T:2674914160 DEBUG: Previous line repeats 132 times.
2019-10-22 11:25:29.216 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:29.279 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:29.405 T:2674914160 DEBUG: Previous line repeats 3 times.
2019-10-22 11:25:29.405 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:29.446 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:29.509 T:2674914160 DEBUG: Previous line repeats 1 times.
2019-10-22 11:25:29.509 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:29.530 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:29.584 T:2674914160 DEBUG: Previous line repeats 1 times.
2019-10-22 11:25:29.584 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:29.612 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:35.093 T:2674914160 DEBUG: Previous line repeats 131 times.
2019-10-22 11:25:35.094 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:35.096 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:35.165 T:2674914160 DEBUG: Previous line repeats 1 times.
2019-10-22 11:25:35.165 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:35.201 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:35.246 T:2674914160 DEBUG: Previous line repeats 2 times.
2019-10-22 11:25:35.246 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:35.335 T:2344219504 DEBUG: Previous line repeats 1 times.
2019-10-22 11:25:35.335 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:35.390 T:3011713504 DEBUG: Previous line repeats 3 times.
2019-10-22 11:25:35.390 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 10107 (+1)
2019-10-22 11:25:35.504 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:36.068 T:3011713504 DEBUG: Previous line repeats 16 times.
2019-10-22 11:25:36.068 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 10148 (+1)
2019-10-22 11:25:36.202 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:37.000 T:3011713504 DEBUG: Previous line repeats 22 times.
2019-10-22 11:25:37.000 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 10204 (+1)
2019-10-22 11:25:37.170 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:37.834 T:3011713504 DEBUG: Previous line repeats 15 times.
2019-10-22 11:25:37.834 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 10254 (+1)
2019-10-22 11:25:37.855 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:38.720 T:3011713504 DEBUG: Previous line repeats 22 times.
2019-10-22 11:25:38.720 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 10307 (+1)
2019-10-22 11:25:38.789 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:40.854 T:2674914160 DEBUG: Previous line repeats 50 times.
2019-10-22 11:25:40.854 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:40.854 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:41.026 T:2674914160 DEBUG: Previous line repeats 3 times.
2019-10-22 11:25:41.026 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:41.091 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:41.166 T:2674914160 DEBUG: Previous line repeats 2 times.
2019-10-22 11:25:41.166 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:41.207 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:41.266 T:2674914160 DEBUG: Previous line repeats 1 times.
2019-10-22 11:25:41.266 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:41.291 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:41.339 T:3011713504 DEBUG: Previous line repeats 2 times.
2019-10-22 11:25:41.339 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 10464 (+1)
2019-10-22 11:25:41.424 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:46.733 T:2674914160 DEBUG: Previous line repeats 129 times.
2019-10-22 11:25:46.733 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:46.852 T:2344219504 DEBUG: Previous line repeats 1 times.
2019-10-22 11:25:46.852 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:46.874 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:46.878 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:46.926 T:2674914160 DEBUG: Previous line repeats 3 times.
2019-10-22 11:25:46.926 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:47.056 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:48.230 T:3011713504 DEBUG: Previous line repeats 31 times.
2019-10-22 11:25:48.230 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 10877 (+1)
2019-10-22 11:25:48.391 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:52.565 T:2674914160 DEBUG: Previous line repeats 100 times.
2019-10-22 11:25:52.565 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:52.603 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:52.652 T:2674914160 DEBUG: Previous line repeats 1 times.
2019-10-22 11:25:52.652 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:52.687 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:52.727 T:2674914160 DEBUG: Previous line repeats 2 times.
2019-10-22 11:25:52.727 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:52.804 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:25:52.828 T:2674914160 DEBUG: Previous line repeats 1 times.
2019-10-22 11:25:52.828 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:25:52.888 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:26:01.145 T:2674914160 DEBUG: Previous line repeats 198 times.
2019-10-22 11:26:01.146 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:26:01.195 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:26:01.298 T:2674914160 DEBUG: Previous line repeats 4 times.
2019-10-22 11:26:01.298 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:26:01.395 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:26:01.579 T:2674914160 DEBUG: Previous line repeats 5 times.
2019-10-22 11:26:01.580 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:26:01.645 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:26:01.832 T:2674914160 DEBUG: Previous line repeats 5 times.
2019-10-22 11:26:01.832 T:2674914160 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:26:01.895 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:26:21.229 T:3011713504 DEBUG: Previous line repeats 464 times.
2019-10-22 11:26:21.230 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 12855 (+1)
2019-10-22 11:26:21.288 T:2327434096 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-10050.541873, adjusted:-10050.541873
2019-10-22 11:26:21.302 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:27:02.253 T:3011713504 DEBUG: Previous line repeats 982 times.
2019-10-22 11:27:02.253 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 15314 (+1)
2019-10-22 11:27:02.305 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:27:04.927 T:3011713504 DEBUG: Previous line repeats 62 times.
2019-10-22 11:27:04.927 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 15474 (+1)
2019-10-22 11:27:04.946 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:27:06.024 T:3011713504 DEBUG: Previous line repeats 29 times.
2019-10-22 11:27:06.024 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 15540 (+1)
2019-10-22 11:27:06.046 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:27:20.622 T:3011713504 DEBUG: Previous line repeats 347 times.
2019-10-22 11:27:20.622 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 16415 (+1)
2019-10-22 11:27:20.691 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:27:35.553 T:3011713504 DEBUG: Previous line repeats 359 times.
2019-10-22 11:27:35.554 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 17310 (+1)
2019-10-22 11:27:35.576 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:27:41.749 T:2327434096 DEBUG: Previous line repeats 144 times.
2019-10-22 11:27:41.749 T:2327434096 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-10067.396010, adjusted:-10067.396010
2019-10-22 11:27:41.762 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:27:45.081 T:3011713504 DEBUG: Previous line repeats 82 times.
2019-10-22 11:27:45.081 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 17881 (+1)
2019-10-22 11:27:45.230 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:27:45.628 T:3011713504 DEBUG: Previous line repeats 13 times.
2019-10-22 11:27:45.629 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 17914 (+1)
2019-10-22 11:27:45.821 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:27:46.130 T:3011713504 DEBUG: Previous line repeats 11 times.
2019-10-22 11:27:46.130 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 17944 (+1)
2019-10-22 11:27:46.321 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:27:47.132 T:3011713504 DEBUG: Previous line repeats 22 times.
2019-10-22 11:27:47.132 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 18004 (+1)
2019-10-22 11:27:47.268 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:27:47.784 T:3011713504 DEBUG: Previous line repeats 15 times.
2019-10-22 11:27:47.784 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 18043 (+1)
2019-10-22 11:27:47.790 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:27:48.034 T:3011713504 DEBUG: Previous line repeats 5 times.
2019-10-22 11:27:48.035 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 18058 (+1)
2019-10-22 11:27:48.185 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:29:02.560 T:2327434096 DEBUG: Previous line repeats 1783 times.
2019-10-22 11:29:02.560 T:2327434096 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-10089.722911, adjusted:-10089.722911
2019-10-22 11:29:02.609 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:29:40.149 T:3011713504 DEBUG: Previous line repeats 903 times.
2019-10-22 11:29:40.149 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 24778 (+1)
2019-10-22 11:29:40.324 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:30:08.389 T:3011713504 DEBUG: Previous line repeats 677 times.
2019-10-22 11:30:08.390 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 26471 (+1)
2019-10-22 11:30:08.395 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:30:13.263 T:3011713504 DEBUG: Previous line repeats 115 times.
2019-10-22 11:30:13.263 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 26763 (+1)
2019-10-22 11:30:13.441 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:30:22.103 T:3011713504 DEBUG: Previous line repeats 210 times.
2019-10-22 11:30:22.103 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 27293 (+1)
2019-10-22 11:30:22.223 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:30:23.167 T:2327434096 DEBUG: Previous line repeats 26 times.
2019-10-22 11:30:23.167 T:2327434096 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-10030.425524, adjusted:-10030.425524
2019-10-22 11:30:23.377 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:30:52.453 T:3011713504 DEBUG: Previous line repeats 700 times.
2019-10-22 11:30:52.454 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 29112 (+1)
2019-10-22 11:30:52.456 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:30:52.704 T:3011713504 DEBUG: Previous line repeats 5 times.
2019-10-22 11:30:52.704 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 29127 (+1)
2019-10-22 11:30:52.706 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:31:05.580 T:3011713504 DEBUG: Previous line repeats 310 times.
2019-10-22 11:31:05.581 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 29899 (+1)
2019-10-22 11:31:05.653 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:31:06.229 T:3011713504 DEBUG: Previous line repeats 11 times.
2019-10-22 11:31:06.229 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 29938 (+1)
2019-10-22 11:31:06.231 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:31:06.998 T:3011713504 DEBUG: Previous line repeats 17 times.
2019-10-22 11:31:06.998 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 29984 (+1)
2019-10-22 11:31:07.085 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:31:08.048 T:3011713504 DEBUG: Previous line repeats 24 times.
2019-10-22 11:31:08.048 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 30047 (+1)
2019-10-22 11:31:08.117 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:31:31.205 T:3011713504 DEBUG: Previous line repeats 556 times.
2019-10-22 11:31:31.206 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 31435 (+1)
2019-10-22 11:31:31.366 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:31:43.728 T:2327434096 DEBUG: Previous line repeats 296 times.
2019-10-22 11:31:43.728 T:2327434096 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-10106.154582, adjusted:-10106.154582
2019-10-22 11:31:43.752 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:31:48.579 T:3011713504 DEBUG: Previous line repeats 120 times.
2019-10-22 11:31:48.579 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 32476 (+1)
2019-10-22 11:31:48.580 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:31:55.763 T:3011713504 DEBUG: Previous line repeats 168 times.
2019-10-22 11:31:55.763 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 32907 (+1)
2019-10-22 11:31:55.849 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:31:58.516 T:3011713504 DEBUG: Previous line repeats 65 times.
2019-10-22 11:31:58.516 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 33072 (+1)
2019-10-22 11:31:58.602 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:32:10.280 T:3011713504 DEBUG: Previous line repeats 282 times.
2019-10-22 11:32:10.280 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 33777 (+1)
2019-10-22 11:32:10.301 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:32:19.970 T:3011713504 DEBUG: Previous line repeats 228 times.
2019-10-22 11:32:19.971 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 34358 (+1)
2019-10-22 11:32:19.973 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:32:21.758 T:3011713504 DEBUG: Previous line repeats 46 times.
2019-10-22 11:32:21.758 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 34465 (+1)
2019-10-22 11:32:21.763 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:32:22.007 T:3011713504 DEBUG: Previous line repeats 5 times.
2019-10-22 11:32:22.007 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 34480 (+1)
2019-10-22 11:32:22.062 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:32:31.216 T:3011713504 DEBUG: Previous line repeats 218 times.
2019-10-22 11:32:31.216 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 35032 (+1)
2019-10-22 11:32:31.301 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:33:03.539 T:2327434096 DEBUG: Previous line repeats 772 times.
2019-10-22 11:33:03.539 T:2327434096 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-10010.850367, adjusted:-10010.850367
2019-10-22 11:33:03.547 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:33:03.787 T:3011713504 DEBUG: Previous line repeats 8 times.
2019-10-22 11:33:03.787 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 36984 (+1)
2019-10-22 11:33:03.820 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:33:11.273 T:3011713504 DEBUG: Previous line repeats 178 times.
2019-10-22 11:33:11.274 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 37433 (+1)
2019-10-22 11:33:11.281 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:33:13.225 T:3011713504 DEBUG: Previous line repeats 47 times.
2019-10-22 11:33:13.225 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 37550 (+1)
2019-10-22 11:33:13.403 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:33:18.062 T:3011713504 DEBUG: Previous line repeats 114 times.
2019-10-22 11:33:18.062 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 37840 (+1)
2019-10-22 11:33:18.085 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:33:25.287 T:3011713504 DEBUG: Previous line repeats 172 times.
2019-10-22 11:33:25.288 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 38273 (+1)
2019-10-22 11:33:25.297 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:33:29.127 T:3011713504 DEBUG: Previous line repeats 91 times.
2019-10-22 11:33:29.127 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 38503 (+1)
2019-10-22 11:33:29.130 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:33:33.761 T:3011713504 DEBUG: Previous line repeats 108 times.
2019-10-22 11:33:33.761 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 38781 (+1)
2019-10-22 11:33:33.781 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:33:39.268 T:3011713504 DEBUG: Previous line repeats 134 times.
2019-10-22 11:33:39.268 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 39111 (+1)
2019-10-22 11:33:39.420 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:33:52.123 T:2576348016 DEBUG: Previous line repeats 306 times.
2019-10-22 11:33:52.124 T:2576348016 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:33:52.225 T:2344219504 DEBUG: Previous line repeats 3 times.
2019-10-22 11:33:52.225 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:33:57.681 T:2576348016 DEBUG: Previous line repeats 133 times.
2019-10-22 11:33:57.681 T:2576348016 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:33:57.708 T:2344219504 DEBUG: Previous line repeats 1 times.
2019-10-22 11:33:57.708 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:33:57.723 T:2576348016 DEBUG: Previous line repeats 2 times.
2019-10-22 11:33:57.723 T:2576348016 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:33:57.938 T:2344219504 DEBUG: Previous line repeats 1 times.
2019-10-22 11:33:57.938 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:34:01.156 T:3011713504 DEBUG: Previous line repeats 79 times.
2019-10-22 11:34:01.157 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 40423 (+1)
2019-10-22 11:34:01.164 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:34:03.239 T:2576348016 DEBUG: Previous line repeats 49 times.
2019-10-22 11:34:03.239 T:2576348016 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:34:03.365 T:2344219504 DEBUG: Previous line repeats 3 times.
2019-10-22 11:34:03.365 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:34:03.411 T:3011713504 DEBUG: Previous line repeats 4 times.
2019-10-22 11:34:03.411 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 40558 (+1)
2019-10-22 11:34:03.568 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:34:04.076 T:3011713504 DEBUG: Previous line repeats 15 times.
2019-10-22 11:34:04.076 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 40598 (+1)
2019-10-22 11:34:04.237 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:34:04.275 T:3011713504 DEBUG: Previous line repeats 3 times.
2019-10-22 11:34:04.275 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 40610 (+1)
2019-10-22 11:34:04.299 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:34:04.925 T:3011713504 DEBUG: Previous line repeats 15 times.
2019-10-22 11:34:04.925 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 40649 (+1)
2019-10-22 11:34:05.071 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:34:06.527 T:3011713504 DEBUG: Previous line repeats 39 times.
2019-10-22 11:34:06.527 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 40745 (+1)
2019-10-22 11:34:06.583 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:34:08.667 T:2576348016 DEBUG: Previous line repeats 47 times.
2019-10-22 11:34:08.667 T:2576348016 DEBUG: CWebServer[8080]: request received for /jsonrpc
2019-10-22 11:34:08.731 T:2344219504 DEBUG: Previous line repeats 3 times.
2019-10-22 11:34:08.731 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:34:20.793 T:3011713504 DEBUG: Previous line repeats 291 times.
2019-10-22 11:34:20.793 T:3011713504 DEBUG: CMMALRenderer::RenderUpdate - vsync 41600 (+1)
2019-10-22 11:34:20.814 T:2344219504 DEBUG: CMMALPool::Configure pool:0xb2fc7930 1920x800 (1920x800) pix:-1 size:128 fmt:OPQV
2019-10-22 11:34:23.949 T:2327434096 DEBUG: Previous line repeats 75 times.
2019-10-22 11:34:23.949 T:2327434096 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-10023.004950, adjusted:-10023.004950

Edit

Pub: 30 Oct 2019 10:13 UTC

Views: 702