2019-04-11 16:28:39.595 T:3011338256 NOTICE: ----------------------------------------------------------------------- 2019-04-11 16:28:39.595 T:3011338256 NOTICE: Starting Kodi (18.6 Git:leia_pi4_18.6-Leia). Platform: Linux ARM 32-bit 2019-04-11 16:28:39.595 T:3011338256 NOTICE: Using Release Kodi x32 build 2019-04-11 16:28:39.595 T:3011338256 NOTICE: Kodi compiled 2020-03-03 by GCC 8.3.0 for Linux ARM 32-bit version 4.19.106 (267114) 2019-04-11 16:28:39.595 T:3011338256 NOTICE: Running on LibreELEC (official): 9.2.1, kernel: Linux ARM 32-bit version 4.19.106 2019-04-11 16:28:39.595 T:3011338256 NOTICE: FFmpeg version/source: 4.0.4-Kodi 2019-04-11 16:28:39.596 T:3011338256 NOTICE: Host CPU: ARMv7 Processor rev 3 (v7l), 4 cores available 2019-04-11 16:28:39.596 T:3011338256 NOTICE: ARM Features: Neon enabled 2019-04-11 16:28:39.596 T:3011338256 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi/ 2019-04-11 16:28:39.596 T:3011338256 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi 2019-04-11 16:28:39.596 T:3011338256 NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons 2019-04-11 16:28:39.596 T:3011338256 NOTICE: special://masterprofile/ is mapped to: /storage/.kodi/userdata 2019-04-11 16:28:39.596 T:3011338256 NOTICE: special://envhome/ is mapped to: /storage 2019-04-11 16:28:39.596 T:3011338256 NOTICE: special://home/ is mapped to: /storage/.kodi 2019-04-11 16:28:39.596 T:3011338256 NOTICE: special://temp/ is mapped to: /storage/.kodi/temp 2019-04-11 16:28:39.596 T:3011338256 NOTICE: special://logpath/ is mapped to: /storage/.kodi/temp 2019-04-11 16:28:39.596 T:3011338256 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin 2019-04-11 16:28:39.596 T:3011338256 NOTICE: Local hostname: LibreELEC 2019-04-11 16:28:39.596 T:3011338256 NOTICE: Log File is located: /storage/.kodi/temp/kodi.log 2019-04-11 16:28:39.596 T:3011338256 NOTICE: ----------------------------------------------------------------------- 2019-04-11 16:28:39.608 T:3011338256 INFO: loading settings 2019-04-11 16:28:39.612 T:3011338256 NOTICE: special://profile/ is mapped to: special://masterprofile/ 2019-04-11 16:28:39.637 T:3011338256 DEBUG: CSkinSettings: no tag found 2019-04-11 16:28:39.638 T:3011338256 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml 2019-04-11 16:28:39.638 T:3011338256 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are... /usr/bin/cputemp /usr/bin/gputemp false 1 30 720 540 2019-04-11 16:28:39.638 T:3011338256 WARNING: CSettingsManager: missing version attribute 2019-04-11 16:28:39.639 T:3011338256 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 2019-04-11 16:28:39.639 T:3011338256 NOTICE: Default Video Player: VideoPlayer 2019-04-11 16:28:39.639 T:3011338256 NOTICE: Default Audio Player: paplayer 2019-04-11 16:28:39.639 T:3011338256 NOTICE: Enabled debug logging due to GUI setting (2) 2019-04-11 16:28:39.639 T:3011338256 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 2019-04-11 16:28:39.639 T:3011338256 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml 2019-04-11 16:28:39.642 T:3011338256 DEBUG: CMediaSourceSettings: tag is missing or sources.xml is malformed 2019-04-11 16:28:39.642 T:3011338256 DEBUG: CMediaSourceSettings: tag is missing or sources.xml is malformed 2019-04-11 16:28:39.642 T:3011338256 DEBUG: CMediaSourceSettings: tag is missing or sources.xml is malformed 2019-04-11 16:28:39.650 T:3011338256 INFO: creating subdirectories 2019-04-11 16:28:39.650 T:3011338256 INFO: userdata folder: special://masterprofile/ 2019-04-11 16:28:39.650 T:3011338256 INFO: recording folder: 2019-04-11 16:28:39.650 T:3011338256 INFO: screenshots folder: /storage/screenshots/ 2019-04-11 16:28:39.754 T:3011338256 NOTICE: PulseAudio: Server found running - will try to use Pulse 2019-04-11 16:28:39.755 T:2933912432 DEBUG: Thread Lirc start, auto delete: false 2019-04-11 16:28:39.755 T:3001021296 DEBUG: Thread libinput start, auto delete: false 2019-04-11 16:28:39.756 T:2933912432 INFO: Loading special://xbmc/system/Lircmap.xml 2019-04-11 16:28:39.764 T:2933912432 INFO: * Adding remote mapping for device 'mceusb' 2019-04-11 16:28:39.764 T:2933912432 INFO: * Adding remote mapping for device 'XboxDVDDongle' 2019-04-11 16:28:39.764 T:2933912432 INFO: * Adding remote mapping for device 'Microsoft_Xbox' 2019-04-11 16:28:39.764 T:2933912432 INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote' 2019-04-11 16:28:39.764 T:2933912432 INFO: * Adding remote mapping for device 'anysee' 2019-04-11 16:28:39.764 T:2933912432 INFO: * Adding remote mapping for device 'iMON-PAD' 2019-04-11 16:28:39.764 T:2933912432 INFO: * Adding remote mapping for device 'Antec_Veris_RM200' 2019-04-11 16:28:39.764 T:2933912432 INFO: * Adding remote mapping for device 'MCE_via_iMON' 2019-04-11 16:28:39.764 T:2933912432 INFO: * Adding remote mapping for device 'TwinHanRemote' 2019-04-11 16:28:39.764 T:2933912432 INFO: * Adding remote mapping for device 'linux-input-layer' 2019-04-11 16:28:39.764 T:2933912432 INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote' 2019-04-11 16:28:39.764 T:2933912432 INFO: * Adding remote mapping for device 'mediacenter' 2019-04-11 16:28:39.764 T:2933912432 INFO: * Adding remote mapping for device 'devinput' 2019-04-11 16:28:39.764 T:2933912432 INFO: * Adding remote mapping for device 'devinput-32' 2019-04-11 16:28:39.765 T:2933912432 INFO: * Adding remote mapping for device 'devinput-64' 2019-04-11 16:28:39.765 T:2933912432 DEBUG: CIRTranslator::Load - no userdata Lircmap.xml found, skipping 2019-04-11 16:28:39.804 T:3011338256 NOTICE: Running database version Addons27 2019-04-11 16:28:39.956 T:3001021296 DEBUG: CLibInputHandler::DeviceAdded - keyboard type device added: CHICONY HP Basic USB Keyboard (event0) 2019-04-11 16:28:39.957 T:3001021296 DEBUG: CLibInputKeyboard::GetRepeat - delay: 500ms repeat: 33ms for CHICONY HP Basic USB Keyboard (event0) 2019-04-11 16:28:39.966 T:3011338256 INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/kodi/addons: No such file or directory' 2019-04-11 16:28:39.967 T:3011338256 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.' 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: audioencoder.kodi.builtin.aac v1.0.0 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: audioencoder.kodi.builtin.wma v1.0.0 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: driver.dvb.crazycat v9.2.0.0 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: driver.dvb.dvb-latest v9.2.0.0 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: game.controller.default v1.0.8 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: game.controller.snes v1.0.8 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: inputstream.adaptive v2.4.3.1 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: kodi.binary.global.audioengine v1.0.1 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: kodi.binary.global.filesystem v1.0.2 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: kodi.binary.global.general v1.0.3 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: kodi.binary.global.gui v5.12.0 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: kodi.binary.global.main v1.0.14 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: kodi.binary.global.network v1.0.0 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: kodi.binary.instance.audiodecoder v2.0.0 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: kodi.binary.instance.audioencoder v2.0.0 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: kodi.binary.instance.game v1.1.0 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: kodi.binary.instance.imagedecoder v2.0.0 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: kodi.binary.instance.inputstream v2.0.8 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: kodi.binary.instance.peripheral v1.3.7 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: kodi.binary.instance.pvr v5.10.3 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: kodi.binary.instance.screensaver v2.0.0 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: kodi.binary.instance.vfs v2.0.0 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: kodi.binary.instance.videocodec v1.0.1 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: kodi.binary.instance.visualization v2.0.1 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: kodi.resource v1.0.0 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: metadata.album.universal v3.1.2 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: metadata.artists.universal v4.3.2 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: metadata.common.allmusic.com v3.2.1 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: metadata.common.fanart.tv v3.6.2 installed 2019-04-11 16:28:39.967 T:3011338256 NOTICE: ADDON: metadata.common.imdb.com v3.1.4 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: metadata.common.musicbrainz.org v2.2.1 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: metadata.common.theaudiodb.com v2.0.3 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: metadata.common.themoviedb.org v3.1.10 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: metadata.local v1.0.0 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: metadata.themoviedb.org v5.1.10 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: metadata.tvshows.themoviedb.org v3.5.2 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: os.libreelec.tv v9.2 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: os.openelec.tv v9.2 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: peripheral.joystick v1.4.9 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: plugin.video.amazon-test v0.8.2 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: repository.kodi.game v1.0.0 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: repository.libreelec.tv v9.2.0 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: repository.sandmann79.plugins v1.0.2 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: repository.xbmc.org v3.1.6 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: resource.images.weathericons.default v1.1.8 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: resource.language.en_gb v2.0.1 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: resource.uisounds.kodi v1.0.0 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: screensaver.xbmc.builtin.black v1.0.33 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: screensaver.xbmc.builtin.dim v1.0.59 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: script.module.beautifulsoup4 v4.6.2 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: script.module.certifi v2019.9.11 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: script.module.chardet v3.0.4 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: script.module.idna v2.8 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: script.module.inputstreamhelper v0.4.4 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: script.module.kodi-six v0.1.3 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: script.module.mechanicalsoup v0.12.0 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: script.module.pil v1.1.7 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: script.module.pycryptodome v3.4.3 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: script.module.pydes v2.0.1 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: script.module.pyxbmct v1.3.1 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: script.module.requests v2.22.0 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: script.module.six v1.13.0 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: script.module.urllib3 v1.25.6 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: script.program.driverselect v0.1.6 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: service.libreelec.settings v9.0.0 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: skin.estuary v2.0.27 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: webinterface.default v18.x-2.4.6 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: xbmc.addon v18.6.0 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: xbmc.core v0.1.0 installed 2019-04-11 16:28:39.968 T:3011338256 NOTICE: ADDON: xbmc.gui v5.14.0 installed 2019-04-11 16:28:39.969 T:3011338256 NOTICE: ADDON: xbmc.json v10.3.0 installed 2019-04-11 16:28:39.969 T:3011338256 NOTICE: ADDON: xbmc.metadata v2.1.0 installed 2019-04-11 16:28:39.969 T:3011338256 NOTICE: ADDON: xbmc.python v2.26.0 installed 2019-04-11 16:28:39.969 T:3011338256 NOTICE: ADDON: xbmc.webinterface v1.0.0 installed 2019-04-11 16:28:39.999 T:3011338256 DEBUG: CFavourites::Load - no system favourites found, skipping 2019-04-11 16:28:40.000 T:3011338256 DEBUG: CFavourites::Load - no userdata favourites found, skipping 2019-04-11 16:28:40.002 T:3011338256 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-04-11 16:28:40.002 T:3011338256 INFO: Selected Logind/UPower as PowerSyscall 2019-04-11 16:28:40.002 T:3011338256 ERROR: DBus error: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files 2019-04-11 16:28:40.002 T:3011338256 INFO: LogindUPowerSyscall - UPower not found, battery information will not be available 2019-04-11 16:28:40.009 T:3011338256 DEBUG: LogindUPowerSyscall - inhibit lock taken, fd 19 2019-04-11 16:28:40.011 T:3011338256 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-04-11 16:28:40.011 T:2988688240 DEBUG: Thread ActiveAE start, auto delete: false 2019-04-11 16:28:40.012 T:2979001200 DEBUG: Thread AESink start, auto delete: false 2019-04-11 16:28:40.012 T:2968515440 DEBUG: Thread FDEventMonitor start, auto delete: false 2019-04-11 16:28:40.020 T:2988688240 INFO: CAESinkALSA - Unable to open device "default" for playback 2019-04-11 16:28:40.029 T:2988688240 DEBUG: PulseAudio: Context authorizing 2019-04-11 16:28:40.030 T:2988688240 DEBUG: PulseAudio: Context setting name 2019-04-11 16:28:40.030 T:2988688240 DEBUG: PulseAudio: Context ready 2019-04-11 16:28:40.030 T:2988688240 WARNING: Pulseaudio module module-allow-passthrough not loaded - opening PT devices might fail 2019-04-11 16:28:40.031 T:2988688240 NOTICE: Found 2 Lists of Devices 2019-04-11 16:28:40.031 T:2988688240 NOTICE: Enumerated PI devices: 2019-04-11 16:28:40.031 T:2988688240 NOTICE: Device 1 2019-04-11 16:28:40.031 T:2988688240 NOTICE: m_deviceName : HDMI 2019-04-11 16:28:40.031 T:2988688240 NOTICE: m_displayName : HDMI 2019-04-11 16:28:40.031 T:2988688240 NOTICE: m_displayNameExtra: 2019-04-11 16:28:40.031 T:2988688240 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 2019-04-11 16:28:40.031 T:2988688240 NOTICE: m_channels : FL, FR 2019-04-11 16:28:40.031 T:2988688240 NOTICE: m_sampleRates : 8000,11025,16000,22050,24000,32000,44100,48000,88200,96000,176400,192000 2019-04-11 16:28:40.031 T:2988688240 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-04-11 16:28:40.031 T:2988688240 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-04-11 16:28:40.031 T:2988688240 NOTICE: Device 2 2019-04-11 16:28:40.031 T:2988688240 NOTICE: m_deviceName : Analogue 2019-04-11 16:28:40.031 T:2988688240 NOTICE: m_displayName : Analogue 2019-04-11 16:28:40.031 T:2988688240 NOTICE: m_displayNameExtra: 2019-04-11 16:28:40.031 T:2988688240 NOTICE: m_deviceType : AE_DEVTYPE_PCM 2019-04-11 16:28:40.031 T:2988688240 NOTICE: m_channels : FL, FR 2019-04-11 16:28:40.031 T:2988688240 NOTICE: m_sampleRates : 48000 2019-04-11 16:28:40.032 T:2988688240 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 2019-04-11 16:28:40.032 T:2988688240 NOTICE: m_streamTypes : No passthrough capabilities 2019-04-11 16:28:40.032 T:2988688240 NOTICE: Device 3 2019-04-11 16:28:40.032 T:2988688240 NOTICE: m_deviceName : Both 2019-04-11 16:28:40.032 T:2988688240 NOTICE: m_displayName : HDMI and Analogue 2019-04-11 16:28:40.032 T:2988688240 NOTICE: m_displayNameExtra: 2019-04-11 16:28:40.032 T:2988688240 NOTICE: m_deviceType : AE_DEVTYPE_PCM 2019-04-11 16:28:40.032 T:2988688240 NOTICE: m_channels : FL, FR 2019-04-11 16:28:40.032 T:2988688240 NOTICE: m_sampleRates : 48000 2019-04-11 16:28:40.032 T:2988688240 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 2019-04-11 16:28:40.032 T:2988688240 NOTICE: m_streamTypes : No passthrough capabilities 2019-04-11 16:28:40.032 T:2988688240 NOTICE: Enumerated PULSE devices: 2019-04-11 16:28:40.032 T:2988688240 NOTICE: Device 1 2019-04-11 16:28:40.032 T:2988688240 NOTICE: m_deviceName : Default 2019-04-11 16:28:40.032 T:2988688240 NOTICE: m_displayName : Default 2019-04-11 16:28:40.032 T:2988688240 NOTICE: m_displayNameExtra: Bluetooth Audio (PULSEAUDIO) 2019-04-11 16:28:40.032 T:2988688240 NOTICE: m_deviceType : AE_DEVTYPE_PCM 2019-04-11 16:28:40.032 T:2988688240 NOTICE: m_channels : FL, FR 2019-04-11 16:28:40.032 T:2988688240 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000 2019-04-11 16:28:40.032 T:2988688240 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT 2019-04-11 16:28:40.032 T:2988688240 NOTICE: m_streamTypes : No passthrough capabilities 2019-04-11 16:28:40.032 T:2979001200 INFO: CActiveAESink::OpenSink - initialize sink 2019-04-11 16:28:40.032 T:2979001200 DEBUG: CActiveAESink::OpenSink - trying to open device Default 2019-04-11 16:28:40.032 T:2979001200 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 2019-04-11 16:28:40.032 T:2979001200 DEBUG: DllBcm: Using omx system library 2019-04-11 16:28:40.034 T:2979001200 DEBUG: SECTION:LoadDLL(libopenmaxil.so) 2019-04-11 16:28:40.035 T:2979001200 DEBUG: Loading: libopenmaxil.so 2019-04-11 16:28:40.044 T:2979001200 DEBUG: CSettingsManager: requested setting (videoscreen.limitgui) was not found. 2019-04-11 16:28:40.044 T:2979001200 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=Default 2019-04-11 16:28:40.044 T:2979001200 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 2019-04-11 16:28:40.045 T:2979001200 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0xb0f0d2e0 2019-04-11 16:28:40.047 T:2979001200 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignment(16) 2019-04-11 16:28:40.047 T:2979001200 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 2019-04-11 16:28:40.047 T:2979001200 DEBUG: Output Device : HDMI 2019-04-11 16:28:40.047 T:2979001200 DEBUG: Sample Rate : 44100 2019-04-11 16:28:40.047 T:2979001200 DEBUG: Sample Format : AE_FMT_FLOAT 2019-04-11 16:28:40.047 T:2979001200 DEBUG: Channel Count : 2 2019-04-11 16:28:40.047 T:2979001200 DEBUG: Channel Layout: FL, FR 2019-04-11 16:28:40.047 T:2979001200 DEBUG: Frames : 2205 2019-04-11 16:28:40.047 T:2979001200 DEBUG: Frame Size : 8 2019-04-11 16:28:40.055 T:3011338256 INFO: CKeyboardLayoutManager: loading keyboard layouts from special://xbmc/system/keyboardlayouts... 2019-04-11 16:28:40.059 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Arabic QWERTY" successfully loaded 2019-04-11 16:28:40.060 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian ЯВЕРТЪ" successfully loaded 2019-04-11 16:28:40.060 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian АБВ" successfully loaded 2019-04-11 16:28:40.061 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BasePY" successfully loaded 2019-04-11 16:28:40.061 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BaiduPY" successfully loaded 2019-04-11 16:28:40.062 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Croatian QWERTY" successfully loaded 2019-04-11 16:28:40.062 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Czech QWERTZ" successfully loaded 2019-04-11 16:28:40.063 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Danish QWERTY" successfully loaded 2019-04-11 16:28:40.063 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "English QWERTY" successfully loaded 2019-04-11 16:28:40.064 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "English AZERTY" successfully loaded 2019-04-11 16:28:40.064 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "English ABC" successfully loaded 2019-04-11 16:28:40.064 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "French AZERTY" successfully loaded 2019-04-11 16:28:40.065 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "German QWERTZ" successfully loaded 2019-04-11 16:28:40.065 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "German ABC" successfully loaded 2019-04-11 16:28:40.066 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Greek QWERTY" successfully loaded 2019-04-11 16:28:40.066 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew QWERTY" successfully loaded 2019-04-11 16:28:40.066 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew ABC" successfully loaded 2019-04-11 16:28:40.067 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Hungarian QWERTZ" successfully loaded 2019-04-11 16:28:40.067 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Icelandic QWERTY" successfully loaded 2019-04-11 16:28:40.068 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Italian QWERTY" successfully loaded 2019-04-11 16:28:40.068 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Korean ㄱㄴㄷ" successfully loaded 2019-04-11 16:28:40.069 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian AZERTY" successfully loaded 2019-04-11 16:28:40.069 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian QWERTY" successfully loaded 2019-04-11 16:28:40.070 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Norwegian QWERTY" successfully loaded 2019-04-11 16:28:40.070 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Polish QWERTY" successfully loaded 2019-04-11 16:28:40.071 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Portuguese (Portugal) QWERTY" successfully loaded 2019-04-11 16:28:40.071 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Romanian QWERTY" successfully loaded 2019-04-11 16:28:40.072 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian ЙЦУКЕН" successfully loaded 2019-04-11 16:28:40.072 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian АБВ" successfully loaded 2019-04-11 16:28:40.072 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Silesian QWERTY" successfully loaded 2019-04-11 16:28:40.073 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTZ" successfully loaded 2019-04-11 16:28:40.073 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTY" successfully loaded 2019-04-11 16:28:40.074 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak ABC" successfully loaded 2019-04-11 16:28:40.074 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovenian QWERTZ" successfully loaded 2019-04-11 16:28:40.075 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Spanish QWERTY" successfully loaded 2019-04-11 16:28:40.075 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Swedish QWERTY" successfully loaded 2019-04-11 16:28:40.076 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Thai Kedmanee" successfully loaded 2019-04-11 16:28:40.076 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Turkish QWERTY" successfully loaded 2019-04-11 16:28:40.077 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian ЙЦУКЕН" successfully loaded 2019-04-11 16:28:40.077 T:3011338256 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian АБВ" successfully loaded 2019-04-11 16:28:40.078 T:3011338256 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-04-11 16:28:40.078 T:3011338256 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-04-11 16:28:40.080 T:3011338256 DEBUG: Selected UDev as storage provider 2019-04-11 16:28:40.080 T:3011338256 NOTICE: Raspberry PI firmware version: Feb 20 2020 16:43:11 Copyright (c) 2012 Broadcom version 00f355997ccdacfaac70e6e07803eccc0a6f1d6e (clean) (release) (start_x) 2019-04-11 16:28:40.080 T:3011338256 NOTICE: ARM mem: 704MB GPU mem: 320MB MPG2:0 WVC1:0 2019-04-11 16:28:40.080 T:3011338256 NOTICE: Config: arm_freq=1500 audio_pwm_mode=514 config_hdmi_boost=5 core_freq=500 core_freq_min=200 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=250 hdmi_channel_map=8 init_uart_clock=0x2dc6c00 lcd_framerate=60 mask_gpu_interrupt0=1024 mask_gpu_interrupt1=0x10000 over_voltage_avs=-23750 pause_burst_frames=1 program_serial_random=1 total_mem=4096 hdmi_force_cec_address:0=65535 hdmi_force_cec_address:1=65535 hdmi_ignore_cec_init:0=1 hdmi_pixel_freq_limit:0=0x11e1a300 hdmi_pixel_freq_limit:1=0x11e1a300 2019-04-11 16:28:40.081 T:3011338256 NOTICE: Config: device_tree=- overlay_prefix=overlays/ hdmi_cvt:0= hdmi_cvt:1= hdmi_edid_filename:0= hdmi_edid_filename:1= hdmi_timings:0= hdmi_timings:1= 2019-04-11 16:28:40.081 T:3011338256 INFO: RetroPlayer[PROCESS]: Registering process control for GBM 2019-04-11 16:28:40.081 T:3011338256 INFO: RetroPlayer[RENDER]: Registering renderer factory for OpenGLES 2019-04-11 16:28:40.269 T:3011338256 DEBUG: CDRMUtils::FindConnector - found connector: 51 2019-04-11 16:28:40.270 T:3011338256 DEBUG: CDRMUtils::OpenDrm - opened device: /dev/dri/card0 using module: vc4 2019-04-11 16:28:40.300 T:3011338256 DEBUG: CDRMUtils::FindConnector - found connector: 51 2019-04-11 16:28:40.300 T:3011338256 DEBUG: CDRMUtils::FindEncoder - found encoder: 50 2019-04-11 16:28:40.300 T:3011338256 DEBUG: CDRMUtils::FindCrtc - found crtc: 49 2019-04-11 16:28:40.300 T:3011338256 DEBUG: CDRMUtils::FindPlane - found video plane 28 2019-04-11 16:28:40.301 T:3011338256 WARNING: CDRMUtils::FindPlane - could not find plane 2019-04-11 16:28:40.301 T:3011338256 DEBUG: CDRMUtils::FindPlane - found gui plane 35 2019-04-11 16:28:40.301 T:3011338256 DEBUG: CDRMUtils::FindPreferredMode - found preferred mode: 1280x720 @ 50 Hz 2019-04-11 16:28:40.302 T:3011338256 DEBUG: CDRMAtomic::InitDrm - initialized atomic DRM 2019-04-11 16:28:40.418 T:3011338256 DEBUG: CWinSystemGbm::InitWindowSystem - initialized DRM 2019-04-11 16:28:40.418 T:3011338256 NOTICE: Found resolution 1280x720 with 1280x720 @ 50.000000 Hz 2019-04-11 16:28:40.418 T:3011338256 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 60.000000 Hz 2019-04-11 16:28:40.418 T:3011338256 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 59.940063 Hz 2019-04-11 16:28:40.418 T:3011338256 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 50.000000 Hz 2019-04-11 16:28:40.418 T:3011338256 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 24.000000 Hz 2019-04-11 16:28:40.418 T:3011338256 NOTICE: Found resolution 1920x1080 with 1920x1080 @ 23.976025 Hz 2019-04-11 16:28:40.418 T:3011338256 NOTICE: Found resolution 1280x720 with 1280x720 @ 60.000000 Hz 2019-04-11 16:28:40.418 T:3011338256 NOTICE: Found resolution 1280x720 with 1280x720 @ 59.940063 Hz 2019-04-11 16:28:40.418 T:3011338256 NOTICE: Found resolution 720x576 with 720x576 @ 50.000000 Hz 2019-04-11 16:28:40.419 T:3011338256 NOTICE: Found resolution 720x480 with 720x480 @ 59.940063 Hz 2019-04-11 16:28:40.419 T:3011338256 NOTICE: Found resolution 720x480 with 720x480 @ 60.000000 Hz 2019-04-11 16:28:40.419 T:3011338256 NOTICE: Found resolution 640x480 with 640x480 @ 60.000000 Hz 2019-04-11 16:28:40.420 T:3011338256 NOTICE: Previous line repeats 1 times. 2019-04-11 16:28:40.421 T:3011338256 NOTICE: EGL_VERSION = 1.4 2019-04-11 16:28:40.421 T:3011338256 NOTICE: EGL_VENDOR = Mesa Project 2019-04-11 16:28:40.421 T:3011338256 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-04-11 16:28:40.421 T:3011338256 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-04-11 16:28:40.421 T:3011338256 DEBUG: EGL Config Attributes: 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_BUFFER_SIZE: 32 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_ALPHA_SIZE: 8 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_BLUE_SIZE: 8 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_GREEN_SIZE: 8 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_RED_SIZE: 8 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_DEPTH_SIZE: 16 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_STENCIL_SIZE: 0 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_CONFIG_CAVEAT: 0x3038 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_CONFIG_ID: 10 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_LEVEL: 0 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_MAX_PBUFFER_HEIGHT: 4096 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_MAX_PBUFFER_PIXELS: 0 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_MAX_PBUFFER_WIDTH: 4096 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_NATIVE_RENDERABLE: 1 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_NATIVE_VISUAL_ID: 875713089 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_NATIVE_VISUAL_TYPE: 0x3038 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_SAMPLES: 0 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_SAMPLE_BUFFERS: 0 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_SURFACE_TYPE: 4 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_TRANSPARENT_TYPE: 0x3038 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_TRANSPARENT_BLUE_VALUE: 0 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_TRANSPARENT_GREEN_VALUE: 0 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_TRANSPARENT_RED_VALUE: 0 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_BIND_TO_TEXTURE_RGB: 0 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_BIND_TO_TEXTURE_RGBA: 0 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_MIN_SWAP_INTERVAL: 1 2019-04-11 16:28:40.421 T:3011338256 DEBUG: EGL_MAX_SWAP_INTERVAL: 1 2019-04-11 16:28:40.422 T:3011338256 DEBUG: EGL_LUMINANCE_SIZE: 0 2019-04-11 16:28:40.422 T:3011338256 DEBUG: EGL_ALPHA_MASK_SIZE: 0 2019-04-11 16:28:40.422 T:3011338256 DEBUG: EGL_COLOR_BUFFER_TYPE: 0x308e 2019-04-11 16:28:40.422 T:3011338256 DEBUG: EGL_RENDERABLE_TYPE: 77 2019-04-11 16:28:40.422 T:3011338256 DEBUG: EGL_CONFORMANT: 77 2019-04-11 16:28:40.425 T:3011338256 NOTICE: Checking resolution 16 2019-04-11 16:28:40.425 T:3011338256 DEBUG: OnLostDevice - notify display change event 2019-04-11 16:28:40.425 T:3011338256 WARNING: CGBMUtils::DestroySurface - surface already destroyed 2019-04-11 16:28:40.425 T:3011338256 DEBUG: CWinSystemGbmEGLContext::DestroyWindow - deinitialized GBM 2019-04-11 16:28:40.454 T:3011338256 DEBUG: CDRMUtils::SetMode - found crtc mode: 1280x720 @ 50 Hz 2019-04-11 16:28:40.454 T:3011338256 DEBUG: CGBMUtils::CreateSurface - created surface with size 1280x720 2019-04-11 16:28:40.462 T:3011338256 DEBUG: CWinSystemGbmEGLContext::CreateNewWindow - initialized GBM 2019-04-11 16:28:40.462 T:3011338256 NOTICE: GL_VENDOR = Broadcom 2019-04-11 16:28:40.462 T:3011338256 NOTICE: GL_RENDERER = V3D 4.2 2019-04-11 16:28:40.462 T:3011338256 NOTICE: GL_VERSION = OpenGL ES 3.0 Mesa 19.1.7 2019-04-11 16:28:40.462 T:3011338256 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 3.00 2019-04-11 16:28:40.462 T:3011338256 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-04-11 16:28:41.175 T:3011338256 DEBUG: OnLostDevice - notify display change event 2019-04-11 16:28:41.205 T:3011338256 DEBUG: CDRMUtils::SetMode - found crtc mode: 1280x720 @ 50 Hz 2019-04-11 16:28:41.205 T:3011338256 INFO: GLES: Maximum texture width: 4096 2019-04-11 16:28:41.205 T:3011338256 DEBUG: guilib: Fill viewport on change for solving rendering passes 2019-04-11 16:28:41.781 T:3011338256 DEBUG: EGL Debugging: Error: EGL_BAD_SURFACE Command: eglSwapBuffers Type: EGL_DEBUG_MSG_ERROR_KHR Message: dri2_swap_buffers 2019-04-11 16:28:41.800 T:3011338256 DEBUG: CRBP::OpenDisplay device:0 m_display:10000020 (0) 2019-04-11 16:28:41.800 T:3011338256 INFO: load keymapping 2019-04-11 16:28:41.802 T:3011338256 INFO: Loading special://xbmc/system/keymaps/appcommand.xml 2019-04-11 16:28:41.803 T:3011338256 INFO: Loading special://xbmc/system/keymaps/customcontroller.AppleRemote.xml 2019-04-11 16:28:41.804 T:3011338256 INFO: Loading special://xbmc/system/keymaps/customcontroller.Harmony.xml 2019-04-11 16:28:41.807 T:3011338256 INFO: Loading special://xbmc/system/keymaps/gamepad.xml 2019-04-11 16:28:41.809 T:3011338256 INFO: Loading special://xbmc/system/keymaps/joystick.xml 2019-04-11 16:28:41.812 T:3011338256 INFO: Loading special://xbmc/system/keymaps/keyboard.xml 2019-04-11 16:28:41.818 T:3011338256 INFO: Loading special://xbmc/system/keymaps/mouse.xml 2019-04-11 16:28:41.819 T:3011338256 INFO: Loading special://xbmc/system/keymaps/remote.xml 2019-04-11 16:28:41.824 T:3011338256 INFO: Loading special://xbmc/system/keymaps/touchscreen.xml 2019-04-11 16:28:41.828 T:3011338256 INFO: GUI format 1280x720, Display 1280x720 @ 50.000000 Hz 2019-04-11 16:28:41.828 T:3011338256 WARNING: CLangInfo: could not find language add-on 'resource.language.de_de', loading default.. 2019-04-11 16:28:41.828 T:3011338256 INFO: CLangInfo: loading resource.language.en_gb language information... 2019-04-11 16:28:41.832 T:3011338256 DEBUG: trying to set locale to en_US.UTF-8 2019-04-11 16:28:41.842 T:3011338256 INFO: global locale set to C 2019-04-11 16:28:41.842 T:3011338256 INFO: CLangInfo: loading resource.language.en_gb language strings... 2019-04-11 16:28:41.873 T:3011338256 DEBUG: LocalizeStrings: loaded 4022 strings from file resource://resource.language.en_gb/strings.po 2019-04-11 16:28:41.886 T:3011338256 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.kodi.builtin.aac/resources/language/English/strings.po 2019-04-11 16:28:41.886 T:3011338256 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.kodi.builtin.wma/resources/language/English/strings.po 2019-04-11 16:28:41.888 T:3011338256 DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/game.controller.default/resources/language/resource.language.en_gb/strings.po 2019-04-11 16:28:41.891 T:3011338256 DEBUG: LocalizeStrings: loaded 13 strings from file /usr/share/kodi/addons/game.controller.snes/resources/language/resource.language.en_gb/strings.po 2019-04-11 16:28:41.895 T:3011338256 DEBUG: LocalizeStrings: loaded 11 strings from file /storage/.kodi/addons/metadata.album.universal/resources/language/resource.language.de_de/strings.po 2019-04-11 16:28:41.896 T:3011338256 DEBUG: LocalizeStrings: loaded 6 strings from file /storage/.kodi/addons/metadata.album.universal/resources/language/resource.language.en_gb/strings.po 2019-04-11 16:28:41.898 T:3011338256 DEBUG: LocalizeStrings: loaded 23 strings from file /storage/.kodi/addons/metadata.artists.universal/resources/language/resource.language.de_de/strings.po 2019-04-11 16:28:41.899 T:3011338256 DEBUG: LocalizeStrings: loaded 9 strings from file /storage/.kodi/addons/metadata.artists.universal/resources/language/resource.language.en_gb/strings.po 2019-04-11 16:28:41.905 T:3011338256 DEBUG: LocalizeStrings: loaded 7 strings from file /storage/.kodi/addons/metadata.themoviedb.org/resources/language/resource.language.de_de/strings.po 2019-04-11 16:28:41.906 T:3011338256 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-04-11 16:28:41.906 T:3011338256 DEBUG: LocalizeStrings: loaded 2 strings from file /storage/.kodi/addons/metadata.themoviedb.org/resources/language/resource.language.en_gb/strings.po 2019-04-11 16:28:41.908 T:3011338256 DEBUG: LocalizeStrings: loaded 3 strings from file /storage/.kodi/addons/metadata.tvshows.themoviedb.org/resources/language/resource.language.de_de/strings.po 2019-04-11 16:28:41.909 T:3011338256 DEBUG: LocalizeStrings: loaded 8 strings from file /storage/.kodi/addons/metadata.tvshows.themoviedb.org/resources/language/resource.language.en_gb/strings.po 2019-04-11 16:28:41.911 T:3011338256 DEBUG: LocalizeStrings: loaded 9 strings from file /usr/share/kodi/addons/peripheral.joystick/resources/language/resource.language.en_gb/strings.po 2019-04-11 16:28:41.918 T:3011338256 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.de_de/strings.po 2019-04-11 16:28:41.919 T:3011338256 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.en_gb/strings.po 2019-04-11 16:28:41.920 T:3011338256 DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/script.program.driverselect/resources/language/resource.language.de_de/strings.po 2019-04-11 16:28:41.921 T:3011338256 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/script.program.driverselect/resources/language/resource.language.en_gb/strings.po 2019-04-11 16:28:41.923 T:3011338256 DEBUG: LocalizeStrings: loaded 230 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/resource.language.de_de/strings.po 2019-04-11 16:28:41.924 T:3011338256 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-04-11 16:28:41.925 T:3011338256 DEBUG: LocalizeStrings: loaded 27 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/resource.language.en_gb/strings.po 2019-04-11 16:28:41.939 T:3011338256 DEBUG: LocalizeStrings: loaded 78 strings from file /storage/.kodi/addons/script.module.inputstreamhelper/resources/language/resource.language.de_de/strings.po 2019-04-11 16:28:41.940 T:3011338256 DEBUG: LocalizeStrings: loaded 0 strings from file /storage/.kodi/addons/script.module.inputstreamhelper/resources/language/resource.language.en_gb/strings.po 2019-04-11 16:28:41.942 T:3011338256 DEBUG: POParser: PO file has Win Style Line Endings. Converted in memory to Linux LF for file: /storage/.kodi/addons/plugin.video.amazon-test/resources/language/resource.language.de_de/strings.po 2019-04-11 16:28:41.943 T:3011338256 DEBUG: LocalizeStrings: loaded 146 strings from file /storage/.kodi/addons/plugin.video.amazon-test/resources/language/resource.language.de_de/strings.po 2019-04-11 16:28:41.944 T:3011338256 DEBUG: POParser: PO file has Win Style Line Endings. Converted in memory to Linux LF for file: /storage/.kodi/addons/plugin.video.amazon-test/resources/language/resource.language.en_gb/strings.po 2019-04-11 16:28:41.945 T:3011338256 DEBUG: LocalizeStrings: loaded 0 strings from file /storage/.kodi/addons/plugin.video.amazon-test/resources/language/resource.language.en_gb/strings.po 2019-04-11 16:28:41.947 T:3011338256 DEBUG: LocalizeStrings: loaded 23 strings from file /storage/.kodi/addons/inputstream.adaptive/resources/language/resource.language.de_de/strings.po 2019-04-11 16:28:41.948 T:3011338256 DEBUG: LocalizeStrings: loaded 1 strings from file /storage/.kodi/addons/inputstream.adaptive/resources/language/resource.language.en_gb/strings.po 2019-04-11 16:28:41.948 T:2875597680 DEBUG: Thread JobWorker start, auto delete: true 2019-04-11 16:28:41.948 T:2875597680 DEBUG: Initialize, updating databases... 2019-04-11 16:28:41.951 T:2875597680 NOTICE: Running database version Addons27 2019-04-11 16:28:41.955 T:2875597680 NOTICE: Running database version ViewModes6 2019-04-11 16:28:41.960 T:2875597680 NOTICE: Running database version Textures13 2019-04-11 16:28:41.969 T:2875597680 NOTICE: Running database version MyMusic72 2019-04-11 16:28:41.985 T:2875597680 NOTICE: Running database version MyVideos116 2019-04-11 16:28:41.989 T:2875597680 NOTICE: Running database version TV32 2019-04-11 16:28:41.992 T:2875597680 NOTICE: Running database version Epg12 2019-04-11 16:28:41.992 T:2875597680 DEBUG: Initialize, updating databases... DONE 2019-04-11 16:28:41.999 T:3011338256 NOTICE: start dvd mediatype detection 2019-04-11 16:28:42.000 T:3002237808 DEBUG: Thread DetectDVDMedia start, auto delete: false 2019-04-11 16:28:42.000 T:3011338256 DEBUG: DPMS: supported power-saving modes: OFF 2019-04-11 16:28:42.000 T:3002237808 DEBUG: Compiled with libcdio Version 0.94 2019-04-11 16:28:42.001 T:3002237808 DEBUG: Thread DetectDVDMedia 3002237808 terminating 2019-04-11 16:28:42.060 T:3011338256 INFO: Unloading old skin ... 2019-04-11 16:28:42.064 T:3011338256 NOTICE: load skin from: /usr/share/kodi/addons/skin.estuary (version: 2.0.27) 2019-04-11 16:28:42.064 T:3011338256 INFO: load fonts for skin... 2019-04-11 16:28:42.069 T:3011338256 INFO: Loading skin includes from /usr/share/kodi/addons/skin.estuary/xml/Includes.xml 2019-04-11 16:28:42.151 T:3011338256 INFO: Loading fonts from /usr/share/kodi/addons/skin.estuary/xml/Font.xml 2019-04-11 16:28:42.265 T:3011338256 DEBUG: LocalizeStrings: loaded 140 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.de_de/strings.po 2019-04-11 16:28:42.266 T:3011338256 DEBUG: LocalizeStrings: loaded 0 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.en_gb/strings.po 2019-04-11 16:28:42.266 T:3011338256 INFO: load new skin... 2019-04-11 16:28:42.266 T:3011338256 INFO: Loading custom window XMLs from skin path /usr/share/kodi/addons/skin.estuary/xml 2019-04-11 16:28:42.280 T:3011338256 DEBUG: Load Skin XML: 14.32ms 2019-04-11 16:28:42.281 T:3011338256 INFO: initialize new skin... 2019-04-11 16:28:42.281 T:3011338256 DEBUG: guilib: Fill viewport on change for solving rendering passes 2019-04-11 16:28:42.281 T:3011338256 INFO: Loading skin file: Custom_1109_TopBarOverlay.xml, load type: LOAD_ON_GUI_INIT 2019-04-11 16:28:42.284 T:3011338256 INFO: Loading skin file: DialogNotification.xml, load type: LOAD_ON_GUI_INIT 2019-04-11 16:28:42.286 T:3011338256 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT 2019-04-11 16:28:42.317 T:3011338256 DEBUG: OpenBundle - Opened bundle /usr/share/kodi/addons/skin.estuary/media/Textures.xbt 2019-04-11 16:28:42.328 T:3011338256 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT 2019-04-11 16:28:42.331 T:3011338256 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT 2019-04-11 16:28:42.332 T:3011338256 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT 2019-04-11 16:28:42.334 T:3011338256 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT 2019-04-11 16:28:42.336 T:3011338256 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT 2019-04-11 16:28:42.339 T:3011338256 INFO: Loading resource://resource.uisounds.kodi/sounds.xml 2019-04-11 16:28:42.386 T:3011338256 INFO: skin loaded... 2019-04-11 16:28:42.386 T:3011338256 DEBUG: Activating window ID: 12997 2019-04-11 16:28:42.386 T:3011338256 DEBUG: ------ Window Init () ------ 2019-04-11 16:28:42.387 T:3011338256 DEBUG: Activating window ID: 12999 2019-04-11 16:28:42.387 T:3011338256 DEBUG: ------ Window Init (Startup.xml) ------ 2019-04-11 16:28:42.387 T:3011338256 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME 2019-04-11 16:28:42.387 T:3011338256 DEBUG: Activating window ID: 10000 2019-04-11 16:28:42.387 T:3011338256 DEBUG: ------ Window Deinit (Startup.xml) ------ 2019-04-11 16:28:42.387 T:3011338256 DEBUG: ------ Window Init (Home.xml) ------ 2019-04-11 16:28:42.387 T:3011338256 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY 2019-04-11 16:28:42.500 T:3011338256 DEBUG: CDirectoryProvider[addons://]: refreshing.. 2019-04-11 16:28:42.500 T:3011338256 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 2019-04-11 16:28:42.500 T:3011338256 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 2019-04-11 16:28:42.500 T:2867204976 DEBUG: Thread JobWorker start, auto delete: true 2019-04-11 16:28:42.500 T:3011338256 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing.. 2019-04-11 16:28:42.500 T:3011338256 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 2019-04-11 16:28:42.500 T:3011338256 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 2019-04-11 16:28:42.500 T:3011338256 DEBUG: CDirectoryProvider[library://video/]: refreshing.. 2019-04-11 16:28:42.500 T:3011338256 DEBUG: CDirectoryProvider[sources://video/]: refreshing.. 2019-04-11 16:28:42.500 T:3011338256 DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing.. 2019-04-11 16:28:42.501 T:2858812272 DEBUG: Thread JobWorker start, auto delete: true 2019-04-11 16:28:42.501 T:3011338256 DEBUG: CDirectoryProvider[favourites://]: refreshing.. 2019-04-11 16:28:42.501 T:3011338256 DEBUG: CDirectoryProvider[sources://pictures/]: refreshing.. 2019-04-11 16:28:42.501 T:3011338256 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing.. 2019-04-11 16:28:42.521 T:2875597680 DEBUG: CAddonMgr::GetAvailableUpdates took 21 ms 2019-04-11 16:28:42.545 T:3011338256 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting 2019-04-11 16:28:42.545 T:3011338256 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 2019-04-11 16:28:42.545 T:3011338256 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting") 2019-04-11 16:28:42.545 T:3011338256 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting 2019-04-11 16:28:42.574 T:3011338256 INFO: JSONRPC v10.3.0: Successfully initialized 2019-04-11 16:28:42.577 T:3011338256 DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid" 2019-04-11 16:28:42.577 T:3011338256 DEBUG: LoadMappings - loaded node "CEC Adapter" 2019-04-11 16:28:42.577 T:3011338256 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter" 2019-04-11 16:28:42.577 T:3011338256 DEBUG: LoadMappings - loaded node "iMON HID device" 2019-04-11 16:28:42.577 T:3011338256 DEBUG: LoadMappings - loaded node "WETEK Play remote" 2019-04-11 16:28:42.577 T:3011338256 DEBUG: LoadMappings - loaded node "" 2019-04-11 16:28:42.578 T:3011338256 DEBUG: Add-on bus: Registering add-on peripheral.joystick 2019-04-11 16:28:42.578 T:3011338256 DEBUG: PERIPHERAL - CreateAddon - creating peripheral add-on instance 'Joystick Support' 2019-04-11 16:28:42.578 T:3011338256 DEBUG: ADDON: Dll Initializing - Joystick Support 2019-04-11 16:28:42.578 T:3011338256 DEBUG: SECTION:LoadDLL(/usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.4.9) 2019-04-11 16:28:42.578 T:3011338256 DEBUG: Loading: /usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.4.9 2019-04-11 16:28:42.591 T:3011338256 DEBUG: AddOnLog: Joystick Support: Loaded 14 joystick families with 97 total joysticks 2019-04-11 16:28:42.591 T:3011338256 DEBUG: Calling TransferSettings for: Joystick Support 2019-04-11 16:28:42.591 T:3011338256 DEBUG: CAddonSettings[peripheral.joystick]: loading setting definitions 2019-04-11 16:28:42.592 T:3011338256 INFO: AddOnLog: Joystick Support: Enabling joystick interface "linux" 2019-04-11 16:28:42.592 T:2842026864 DEBUG: Thread PeripBusUSBUdev start, auto delete: false 2019-04-11 16:28:42.592 T:2842026864 DEBUG: Process - initialised udev monitor 2019-04-11 16:28:42.592 T:2833634160 DEBUG: Thread PeripBusCEC start, auto delete: false 2019-04-11 16:28:42.594 T:2825241456 DEBUG: Thread PeripBusAddon start, auto delete: false 2019-04-11 16:28:42.595 T:3011338256 DEBUG: Initialise - initialised peripheral on 'keyboard' with 1 features and 0 sub devices 2019-04-11 16:28:42.595 T:3011338256 NOTICE: Register - new keyboard device registered on application->keyboard: Keyboard (0000:0000) 2019-04-11 16:28:42.596 T:3011338256 DEBUG: Initialise - initialised peripheral on 'mouse' with 1 features and 0 sub devices 2019-04-11 16:28:42.596 T:3011338256 NOTICE: Register - new mouse device registered on application->mouse: Mouse (0000:0000) 2019-04-11 16:28:42.597 T:2816848752 DEBUG: Thread PeripEventScanner start, auto delete: false 2019-04-11 16:28:42.601 T:2867204976 DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3a%2f%2fprofile%2fplaylists%2fvideo/special%3a%2f%2fprofile%2fplaylists%2fmixed/) 2019-04-11 16:28:42.601 T:2867204976 DEBUG: Getting Directory (special://profile/playlists/video) 2019-04-11 16:28:42.602 T:2867204976 DEBUG: Getting Directory (special://profile/playlists/mixed) 2019-04-11 16:28:42.603 T:2867204976 DEBUG: CMultiPathDirectory::MergeItems, items = 0 2019-04-11 16:28:42.605 T:3011338256 DEBUG: ContextMenuManager: addon menus reloaded. 2019-04-11 16:28:42.605 T:3011338256 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 2019-04-11 16:28:42.606 T:3011338256 DEBUG: CPlayerCoreConfig::: created player VideoPlayer 2019-04-11 16:28:42.606 T:3011338256 DEBUG: CPlayerCoreConfig::: created player PAPlayer 2019-04-11 16:28:42.606 T:3011338256 DEBUG: CPlayerCoreConfig::: created player RetroPlayer 2019-04-11 16:28:42.606 T:3011338256 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules 2019-04-11 16:28:42.606 T:3011338256 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mms/udp 2019-04-11 16:28:42.606 T:3011338256 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout 2019-04-11 16:28:42.606 T:3011338256 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp 2019-04-11 16:28:42.606 T:3011338256 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp 2019-04-11 16:28:42.606 T:3011338256 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams 2019-04-11 16:28:42.606 T:3011338256 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp 2019-04-11 16:28:42.606 T:3011338256 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2 2019-04-11 16:28:42.606 T:3011338256 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd 2019-04-11 16:28:42.606 T:3011338256 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage 2019-04-11 16:28:42.606 T:3011338256 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf 2019-04-11 16:28:42.606 T:3011338256 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv 2019-04-11 16:28:42.606 T:3011338256 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio 2019-04-11 16:28:42.606 T:3011338256 NOTICE: Loaded playercorefactory configuration 2019-04-11 16:28:42.607 T:3011338256 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 2019-04-11 16:28:42.607 T:3011338256 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 2019-04-11 16:28:42.607 T:3011338256 INFO: removing tempfiles 2019-04-11 16:28:42.633 T:2875597680 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update 2019-04-11 16:28:42.641 T:3011338256 DEBUG: CRepositoryUpdater: previous update at 03/25/2020 11:57:13 AM, next at 03/26/2020 11:57:13 AM 2019-04-11 16:28:42.642 T:2808456048 DEBUG: Thread Timer start, auto delete: false 2019-04-11 16:28:42.651 T:3011338256 DEBUG: CServiceAddonManager: starting service.libreelec.settings 2019-04-11 16:28:42.652 T:3011338256 DEBUG: CServiceAddonManager: starting plugin.video.amazon-test 2019-04-11 16:28:42.652 T:2800063344 DEBUG: Thread LanguageInvoker start, auto delete: false 2019-04-11 16:28:42.653 T:2800063344 INFO: initializing python engine. 2019-04-11 16:28:42.653 T:3011338256 NOTICE: initialize done 2019-04-11 16:28:42.653 T:2791670640 DEBUG: Thread LanguageInvoker start, auto delete: false 2019-04-11 16:28:42.654 T:3011338256 NOTICE: Running the application... 2019-04-11 16:28:42.654 T:2791670640 INFO: initializing python engine. 2019-04-11 16:28:42.654 T:3011338256 DEBUG: no profile autoexec.py (/storage/.kodi/userdata/autoexec.py) found, skipping 2019-04-11 16:28:42.655 T:3011338256 DEBUG: NetworkMessage - Starting network services 2019-04-11 16:28:42.659 T:3011338256 DEBUG: CZeroconfAvahi::clientCallback: client is up and running 2019-04-11 16:28:42.659 T:2875597680 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-04-11 16:28:42.660 T:3011338256 NOTICE: starting zeroconf publishing 2019-04-11 16:28:42.661 T:3011338256 NOTICE: CWebServer[8080]: Started 2019-04-11 16:28:42.661 T:2858812272 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:Kodi (LibreELEC) port:8080 2019-04-11 16:28:42.661 T:2858812272 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _http._tcp port:8080 2019-04-11 16:28:42.662 T:2875597680 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-04-11 16:28:42.664 T:2758099824 DEBUG: Thread EventServer start, auto delete: false 2019-04-11 16:28:42.665 T:2758099824 NOTICE: ES: Starting UDP Event server on port 9777 2019-04-11 16:28:42.665 T:2758099824 NOTICE: UDP: Listening on port 9777 (ipv6 : false) 2019-04-11 16:28:42.667 T:2858812272 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:Kodi (LibreELEC) port:8080 2019-04-11 16:28:42.667 T:2858812272 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _xbmc-jsonrpc-h._tcp port:8080 2019-04-11 16:28:42.669 T:2875597680 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update 2019-04-11 16:28:42.671 T:3011338256 DEBUG: GetFirstConnectedInterface no connected interface found - requery list 2019-04-11 16:28:42.672 T:3011338256 DEBUG: SECTION:LoadDLL(libshairplay.so.0) 2019-04-11 16:28:42.672 T:3011338256 DEBUG: Loading: libshairplay.so.0 2019-04-11 16:28:42.673 T:2858812272 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:Kodi (LibreELEC) port:9777 2019-04-11 16:28:42.673 T:2858812272 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC) type: _xbmc-events._udp port:9777 2019-04-11 16:28:42.679 T:3011338256 DEBUG: GetFirstConnectedInterface no connected interface found - requery list 2019-04-11 16:28:42.680 T:2783277936 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 2019-04-11 16:28:42.680 T:2858812272 DEBUG: Previous line repeats 2 times. 2019-04-11 16:28:42.681 T:2858812272 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airtunes type: _raop._tcp name:000102030405@Kodi (LibreELEC) port:36666 2019-04-11 16:28:42.681 T:2858812272 DEBUG: CZeroconfAvahi::addService() named: 000102030405@Kodi (LibreELEC) type: _raop._tcp port:36666 2019-04-11 16:28:42.690 T:2783277936 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 2019-04-11 16:28:42.728 T:2791670640 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.amazon-test/service.py): start processing 2019-04-11 16:28:42.728 T:2800063344 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): start processing 2019-04-11 16:28:42.757 T:2791670640 DEBUG: -->Python Interpreter Initialized<-- 2019-04-11 16:28:42.757 T:2791670640 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.amazon-test/service.py): the source file to load is "/storage/.kodi/addons/plugin.video.amazon-test/service.py" 2019-04-11 16:28:42.760 T:2791670640 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.amazon-test/service.py): setting the Python path to /storage/.kodi/addons/plugin.video.amazon-test:/storage/.kodi/addons/script.module.beautifulsoup4/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.inputstreamhelper/lib:/storage/.kodi/addons/script.module.kodi-six/libs:/storage/.kodi/addons/script.module.mechanicalsoup/lib:/storage/.kodi/addons/script.module.pydes/lib:/storage/.kodi/addons/script.module.pyxbmct/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-04-11 16:28:42.760 T:2791670640 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.amazon-test/service.py): entering source directory /storage/.kodi/addons/plugin.video.amazon-test 2019-04-11 16:28:42.768 T:2791670640 DEBUG: CPythonInvoker(1, /storage/.kodi/addons/plugin.video.amazon-test/service.py): instantiating addon using automatically obtained id of "plugin.video.amazon-test" dependent on version 2.24.0 of the xbmc.python api 2019-04-11 16:28:42.879 T:2800063344 DEBUG: -->Python Interpreter Initialized<-- 2019-04-11 16:28:42.879 T:2800063344 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-04-11 16:28:42.879 T:2800063344 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-04-11 16:28:42.880 T:2800063344 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): entering source directory /usr/share/kodi/addons/service.libreelec.settings 2019-04-11 16:28:42.880 T:2800063344 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-04-11 16:28:42.954 T:2833634160 DEBUG: GetMappingForDevice - device (2708:1001) mapped to CEC Adapter (type = cec) 2019-04-11 16:28:42.959 T:2833634160 DEBUG: InitialiseFeature - using libCEC v4.0.4 2019-04-11 16:28:42.959 T:2833634160 DEBUG: Initialise - initialised peripheral on 'RPI' with 2 features and 0 sub devices 2019-04-11 16:28:42.959 T:2833634160 NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001) 2019-04-11 16:28:42.959 T:2833634160 DEBUG: Thread PeripBusCEC 2833634160 terminating 2019-04-11 16:28:42.965 T:2718344048 DEBUG: Thread CECAdapter start, auto delete: false 2019-04-11 16:28:42.965 T:2718344048 DEBUG: OpenConnection - opening a connection to the CEC adapter: RPI 2019-04-11 16:28:42.984 T:3011338256 DEBUG: ------ Window Init () ------ 2019-04-11 16:28:42.988 T:3011338256 DEBUG: ------ Window Init (Pointer.xml) ------ 2019-04-11 16:28:42.989 T:2875597680 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 2019-04-11 16:28:42.993 T:2875597680 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-04-11 16:28:43.260 T:3011338256 DEBUG: LogindUPowerSyscall - Received unknown signal NameAcquired 2019-04-11 16:28:43.260 T:3011338256 DEBUG: ------ Window Init (DialogNotification.xml) ------ 2019-04-11 16:28:43.541 T:2800063344 DEBUG: ## LibreELEC Addon ## 9.0.0 2019-04-11 16:28:43.889 T:2791670640 DEBUG: CAddonSettings[plugin.video.amazon-test]: loading setting definitions 2019-04-11 16:28:43.889 T:2791670640 DEBUG: CAddonSettings[plugin.video.amazon-test]: trying to load setting definitions from old format... 2019-04-11 16:28:43.892 T:2791670640 DEBUG: CAddonSettings[plugin.video.amazon-test]: loading setting values 2019-04-11 16:28:43.893 T:2791670640 NOTICE: [Amazon VOD] Service: Proxy bound to 127.0.0.1:50869 2019-04-11 16:28:43.919 T:2791670640 NOTICE: [Amazon VOD] Service: Proxy server started 2019-04-11 16:28:43.920 T:2791670640 NOTICE: [Amazon VOD] Service started 2019-04-11 16:28:43.945 T:2800063344 INFO: ## LibreELEC Addon ## system::set_hostname ## LibreELEC 2019-04-11 16:28:43.946 T:2800063344 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## us 2019-04-11 16:28:43.946 T:2800063344 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## loadkmap < `ls -1 /usr/lib/keymaps/*/us.bmap` 2019-04-11 16:28:44.069 T:2800063344 ERROR: ## LibreELEC Addon ## oe::load_url(http://releases.libreelec.tv/releases.json) ## ERROR: (URLError(gaierror(-3, 'Temporary failure in name resolution'),)) 2019-04-11 16:28:44.069 T:2800063344 ERROR: Traceback (most recent call last): File "/var/lib/jenkins/LE/build5/workspace/RPi4/build.LibreELEC-RPi4.arm-9.2.1/LibreELEC-settings-6f6ca1e46c230d1e5045e6bb92a03889e1f1c71a/.install_pkg/usr/share/kodi/addons/service.libreelec.settings/oe.py", line 361, in load_url File "/usr/lib/python2.7/urllib2.py", line 154, in urlopen File "/usr/lib/python2.7/urllib2.py", line 429, in open File "/usr/lib/python2.7/urllib2.py", line 447, in _open File "/usr/lib/python2.7/urllib2.py", line 407, in _call_chain File "/usr/lib/python2.7/urllib2.py", line 1228, in http_open File "/usr/lib/python2.7/urllib2.py", line 1198, in do_open URLError: 2019-04-11 16:28:44.336 T:2718344048 DEBUG: OpenConnection - connection to the CEC adapter opened 2019-04-11 16:28:44.336 T:2718344048 DEBUG: SetConfigurationFromLibCEC - settings updated by libCEC 2019-04-11 16:28:44.337 T:2683298672 DEBUG: Thread CECAdapterUpdate start, auto delete: false 2019-04-11 16:28:44.545 T:3011338256 DEBUG: ------ Window Deinit (Pointer.xml) ------ 2019-04-11 16:28:45.000 T:2683298672 DEBUG: UpdateMenuLanguage - using TV menu language is disabled 2019-04-11 16:28:45.169 T:2800063344 INFO: ## LibreELEC Addon ## updates::updateThread ## Started 2019-04-11 16:28:45.169 T:2800063344 INFO: ## LibreELEC Addon ## updates::set_auto_update ## auto 2019-04-11 16:28:45.207 T:2674905968 ERROR: ## LibreELEC Addon ## oe::load_url(https://update.libreelec.tv/updates.php?i=17fc13d6dd11dfd48edfbe925caf6b34&d=LibreELEC&pa=RPi4.arm&v=9.2.1&f=00c03112) ## ERROR: (URLError(gaierror(-3, 'Temporary failure in name resolution'),)) 2019-04-11 16:28:45.208 T:2674905968 ERROR: Traceback (most recent call last): File "/var/lib/jenkins/LE/build5/workspace/RPi4/build.LibreELEC-RPi4.arm-9.2.1/LibreELEC-settings-6f6ca1e46c230d1e5045e6bb92a03889e1f1c71a/.install_pkg/usr/share/kodi/addons/service.libreelec.settings/oe.py", line 361, in load_url File "/usr/lib/python2.7/urllib2.py", line 154, in urlopen File "/usr/lib/python2.7/urllib2.py", line 429, in open File "/usr/lib/python2.7/urllib2.py", line 447, in _open File "/usr/lib/python2.7/urllib2.py", line 407, in _call_chain File "/usr/lib/python2.7/urllib2.py", line 1241, in https_open File "/usr/lib/python2.7/urllib2.py", line 1198, in do_open URLError: 2019-04-11 16:28:45.211 T:2674905968 ERROR: ## LibreELEC Addon ## updates::check_updates_v2 ## ERROR: (TypeError('expected string or buffer',)) 2019-04-11 16:28:45.213 T:2674905968 ERROR: Traceback (most recent call last): File "/var/lib/jenkins/LE/build5/workspace/RPi4/build.LibreELEC-RPi4.arm-9.2.1/LibreELEC-settings-6f6ca1e46c230d1e5045e6bb92a03889e1f1c71a/.install_pkg/usr/share/kodi/addons/service.libreelec.settings/resources/lib/modules/updates.py", line 564, in check_updates_v2 File "/usr/lib/python2.7/json/__init__.py", line 339, in loads File "/usr/lib/python2.7/json/decoder.py", line 364, in decode TypeError: expected string or buffer 2019-04-11 16:28:45.231 T:2658120560 INFO: ## LibreELEC Addon ## _service_::run ## WAITING: 2019-04-11 16:28:45.234 T:2666513264 INFO: ## LibreELEC Addon ## xdbus Monitor started. ## 2020-03-25 12:26:14.077 T:2683298672 DEBUG: UpdateAudioSystemStatus - no CEC capable amplifier found 2020-03-25 12:26:14.323 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:14.324 T:2649727856 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:14.336 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:14.336 T:3011338256 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-03-25 12:26:14.467 T:2649727856 DEBUG: Thread Timer 2649727856 terminating 2020-03-25 12:26:14.476 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:14.603 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:14.604 T:2649727856 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:14.616 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:14.616 T:3011338256 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-03-25 12:26:14.731 T:2649727856 DEBUG: Thread Timer 2649727856 terminating 2020-03-25 12:26:14.736 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:14.875 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:14.876 T:2649727856 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:14.876 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:14.876 T:3011338256 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-03-25 12:26:14.987 T:2649727856 DEBUG: Thread Timer 2649727856 terminating 2020-03-25 12:26:14.996 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:15.123 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:15.124 T:2649727856 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:15.136 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:15.136 T:3011338256 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-03-25 12:26:15.252 T:2649727856 DEBUG: Thread Timer 2649727856 terminating 2020-03-25 12:26:15.256 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:15.364 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:15.364 T:2649727856 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:15.376 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:15.376 T:3011338256 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-03-25 12:26:15.476 T:2649727856 DEBUG: Thread Timer 2649727856 terminating 2020-03-25 12:26:15.496 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:15.620 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:15.620 T:2649727856 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:15.656 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:15.656 T:3011338256 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-03-25 12:26:15.732 T:2649727856 DEBUG: Thread Timer 2649727856 terminating 2020-03-25 12:26:15.736 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:15.860 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:15.860 T:2649727856 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:15.876 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:15.876 T:3011338256 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-03-25 12:26:15.890 T:2641335152 DEBUG: Thread JobWorker start, auto delete: true 2020-03-25 12:26:15.911 T:2641335152 DEBUG: ffmpeg[9D6F9370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2020-03-25 12:26:15.913 T:2867204976 DEBUG: ffmpeg[AAE61370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2020-03-25 12:26:15.919 T:2875597680 DEBUG: ffmpeg[AB662370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2020-03-25 12:26:15.980 T:2649727856 DEBUG: Thread Timer 2649727856 terminating 2020-03-25 12:26:16.056 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:16.652 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:16.652 T:2649727856 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:16.656 T:3011338256 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:16.656 T:3011338256 DEBUG: HandleKey: right (0xf083) pressed, action is Right 2020-03-25 12:26:16.836 T:2649727856 DEBUG: Thread Timer 2649727856 terminating 2020-03-25 12:26:16.856 T:3011338256 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:17.164 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:17.164 T:2649727856 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:17.176 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:17.176 T:3011338256 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-03-25 12:26:17.215 T:2641335152 DEBUG: ffmpeg[9D6F9370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2020-03-25 12:26:17.292 T:2649727856 DEBUG: Thread Timer 2649727856 terminating 2020-03-25 12:26:17.316 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:18.660 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:18.660 T:2649727856 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:18.666 T:3011338256 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 2020-03-25 12:26:18.820 T:2649727856 DEBUG: Thread Timer 2649727856 terminating 2020-03-25 12:26:18.831 T:3011338256 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 2020-03-25 12:26:18.831 T:3011338256 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2020-03-25 12:26:18.831 T:3011338256 DEBUG: Activating window ID: 10025 2020-03-25 12:26:19.128 T:3011338256 DEBUG: ------ Window Deinit (Home.xml) ------ 2020-03-25 12:26:19.128 T:3011338256 DEBUG: FreeVisualisation() done 2020-03-25 12:26:19.185 T:3011338256 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 2020-03-25 12:26:19.185 T:3011338256 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 2020-03-25 12:26:19.356 T:3011338256 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.amazon-test/) 2020-03-25 12:26:19.356 T:3011338256 DEBUG: ParentPath = [plugin://plugin.video.amazon-test/] 2020-03-25 12:26:19.356 T:2649727856 DEBUG: Thread waiting start, auto delete: false 2020-03-25 12:26:19.369 T:2875597680 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.amazon-test] took 13 ms 2020-03-25 12:26:19.369 T:2649727856 DEBUG: StartScript - calling plugin Amazon VOD('plugin://plugin.video.amazon-test/','1','','resume:false') 2020-03-25 12:26:19.370 T:2625565552 DEBUG: Thread LanguageInvoker start, auto delete: false 2020-03-25 12:26:19.370 T:2625565552 INFO: initializing python engine. 2020-03-25 12:26:19.370 T:2625565552 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): start processing 2020-03-25 12:26:19.390 T:2625565552 DEBUG: -->Python Interpreter Initialized<-- 2020-03-25 12:26:19.390 T:2625565552 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.amazon-test/default.py" 2020-03-25 12:26:19.392 T:2625565552 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): setting the Python path to /storage/.kodi/addons/plugin.video.amazon-test:/storage/.kodi/addons/script.module.beautifulsoup4/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.inputstreamhelper/lib:/storage/.kodi/addons/script.module.kodi-six/libs:/storage/.kodi/addons/script.module.mechanicalsoup/lib:/storage/.kodi/addons/script.module.pydes/lib:/storage/.kodi/addons/script.module.pyxbmct/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 2020-03-25 12:26:19.392 T:2625565552 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): entering source directory /storage/.kodi/addons/plugin.video.amazon-test 2020-03-25 12:26:19.392 T:2625565552 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): instantiating addon using automatically obtained id of "plugin.video.amazon-test" dependent on version 2.24.0 of the xbmc.python api 2020-03-25 12:26:19.456 T:3011338256 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2020-03-25 12:26:19.480 T:3011338256 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 2020-03-25 12:26:20.305 T:2625565552 DEBUG: CAddonSettings[plugin.video.amazon-test]: loading setting definitions 2020-03-25 12:26:20.305 T:2625565552 DEBUG: CAddonSettings[plugin.video.amazon-test]: trying to load setting definitions from old format... 2020-03-25 12:26:20.308 T:2625565552 DEBUG: CAddonSettings[plugin.video.amazon-test]: loading setting values 2020-03-25 12:26:20.379 T:2625565552 DEBUG: [Amazon VOD] Requested {} 2020-03-25 12:26:20.408 T:2625565552 NOTICE: [Amazon VOD] Version: 0.8.2 2020-03-25 12:26:20.408 T:2625565552 NOTICE: [Amazon VOD] Unicode filename support: False 2020-03-25 12:26:20.409 T:2625565552 NOTICE: [Amazon VOD] Locale: en-us / Language: en 2020-03-25 12:26:20.519 T:2625565552 INFO: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): script successfully run 2020-03-25 12:26:20.519 T:2649727856 DEBUG: Thread waiting 2649727856 terminating 2020-03-25 12:26:20.536 T:3011338256 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2020-03-25 12:26:20.536 T:3011338256 DEBUG: Saving fileitems [plugin://plugin.video.amazon-test/] 2020-03-25 12:26:20.536 T:3011338256 DEBUG: -- items: 7, sort method: 0, ascending: false 2020-03-25 12:26:20.540 T:2649727856 DEBUG: Thread BackgroundLoader start, auto delete: false 2020-03-25 12:26:20.549 T:2649727856 DEBUG: Thread BackgroundLoader 2649727856 terminating 2020-03-25 12:26:22.213 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:22.213 T:2649727856 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:22.216 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:22.216 T:3011338256 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-03-25 12:26:22.405 T:2649727856 DEBUG: Thread Timer 2649727856 terminating 2020-03-25 12:26:22.416 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:22.541 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:22.541 T:2649727856 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:22.576 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:22.576 T:3011338256 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-03-25 12:26:22.677 T:2649727856 DEBUG: Thread Timer 2649727856 terminating 2020-03-25 12:26:22.696 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:22.813 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:22.813 T:2649727856 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:22.816 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:22.816 T:3011338256 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-03-25 12:26:22.909 T:2649727856 DEBUG: Thread Timer 2649727856 terminating 2020-03-25 12:26:22.936 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:23.045 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:23.045 T:2649727856 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:23.056 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:23.056 T:3011338256 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-03-25 12:26:23.141 T:2649727856 DEBUG: Thread Timer 2649727856 terminating 2020-03-25 12:26:23.176 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:23.877 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:23.878 T:2649727856 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:23.896 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:23.896 T:3011338256 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-03-25 12:26:24.013 T:2649727856 DEBUG: Thread Timer 2649727856 terminating 2020-03-25 12:26:24.016 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:24.413 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:24.413 T:2649727856 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:24.421 T:3011338256 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 2020-03-25 12:26:24.509 T:2649727856 DEBUG: Thread Timer 2649727856 terminating 2020-03-25 12:26:24.516 T:3011338256 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 2020-03-25 12:26:24.516 T:3011338256 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2020-03-25 12:26:24.517 T:3011338256 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.amazon-test/?cat=Browse&mode=Recent&opt&page=1&url) 2020-03-25 12:26:24.517 T:3011338256 DEBUG: ParentPath = [plugin://plugin.video.amazon-test/] 2020-03-25 12:26:24.518 T:2649727856 DEBUG: Thread waiting start, auto delete: false 2020-03-25 12:26:24.535 T:2858812272 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.amazon-test] took 19 ms 2020-03-25 12:26:24.536 T:2649727856 DEBUG: StartScript - calling plugin Amazon VOD('plugin://plugin.video.amazon-test/','1','?cat=Browse&mode=Recent&opt&page=1&url','resume:false') 2020-03-25 12:26:24.536 T:2649727856 DEBUG: GetLanguageInvoker - Reusing LanguageInvokerThread 2 for script /storage/.kodi/addons/plugin.video.amazon-test/default.py 2020-03-25 12:26:24.536 T:2625565552 INFO: initializing python engine. 2020-03-25 12:26:24.536 T:2625565552 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): start processing 2020-03-25 12:26:24.536 T:2625565552 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): entering source directory /storage/.kodi/addons/plugin.video.amazon-test 2020-03-25 12:26:24.536 T:2625565552 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): instantiating addon using automatically obtained id of "plugin.video.amazon-test" dependent on version 2.24.0 of the xbmc.python api 2020-03-25 12:26:24.537 T:2625565552 DEBUG: [Amazon VOD] Requested {'page': '1', 'mode': 'Recent', 'cat': 'Browse'} 2020-03-25 12:26:24.549 T:2625565552 NOTICE: [Amazon VOD] getURL: https://atv-ps-eu.amazon.de/cdp/catalog/GetASINDetails?firmware=fmw:26-app:3.0.265.20347&deviceTypeID=A43PXU4ZN2AL1&deviceID=fbbe44a507076598cf92e2ecff09f45b136ef438b4988099467b3aef&format=json&version=2&formatVersion=3&marketplaceId=A1PA6795UKMFR9&IncludeAll=T&AID=1&asinlist=B01N0MF27Z&NumberOfResults=40&StartIndex=0&Detailed=T 2020-03-25 12:26:24.618 T:3011338256 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2020-03-25 12:26:25.118 T:2649727856 DEBUG: Thread waiting 2649727856 terminating 2020-03-25 12:26:25.118 T:2625565552 INFO: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): script successfully run 2020-03-25 12:26:25.136 T:3011338256 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2020-03-25 12:26:25.139 T:2649727856 DEBUG: Thread BackgroundLoader start, auto delete: false 2020-03-25 12:26:25.147 T:2649727856 DEBUG: Thread BackgroundLoader 2649727856 terminating 2020-03-25 12:26:25.176 T:3011338256 DEBUG: RunScriptWithParams - calling plugin Amazon VOD('plugin://plugin.video.amazon-test/','-1','?mode=checkMissing','resume:false') 2020-03-25 12:26:25.176 T:3011338256 DEBUG: GetLanguageInvoker - Reusing LanguageInvokerThread 2 for script /storage/.kodi/addons/plugin.video.amazon-test/default.py 2020-03-25 12:26:25.177 T:2625565552 INFO: initializing python engine. 2020-03-25 12:26:25.177 T:2625565552 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): start processing 2020-03-25 12:26:25.177 T:2625565552 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): entering source directory /storage/.kodi/addons/plugin.video.amazon-test 2020-03-25 12:26:25.177 T:2625565552 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): instantiating addon using automatically obtained id of "plugin.video.amazon-test" dependent on version 2.24.0 of the xbmc.python api 2020-03-25 12:26:25.179 T:2625565552 DEBUG: [Amazon VOD] Requested {'mode': 'checkMissing'} 2020-03-25 12:26:25.198 T:2625565552 NOTICE: [Amazon VOD] Starting Fanart Update 2020-03-25 12:26:25.232 T:2625565552 NOTICE: [Amazon VOD] Finished Fanart Update 2020-03-25 12:26:25.233 T:2625565552 INFO: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): script successfully run 2020-03-25 12:26:26.333 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:26.334 T:2649727856 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:26.341 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:26.341 T:3011338256 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-03-25 12:26:26.371 T:2858812272 DEBUG: ffmpeg[AA660370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2020-03-25 12:26:26.401 T:2875597680 DEBUG: ffmpeg[AB662370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2020-03-25 12:26:26.509 T:2649727856 DEBUG: Thread Timer 2649727856 terminating 2020-03-25 12:26:26.516 T:3011338256 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:26.933 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:26.933 T:2649727856 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:26.942 T:3011338256 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 2020-03-25 12:26:27.037 T:2649727856 DEBUG: Thread Timer 2649727856 terminating 2020-03-25 12:26:27.040 T:3011338256 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 2020-03-25 12:26:27.041 T:3011338256 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2020-03-25 12:26:27.047 T:3011338256 DEBUG: OnPlayMedia plugin://plugin.video.amazon-test/?asin=B01N5AYAJM&mode=PlayVideo&adult=0&name=Arrival&trailer=0&selbitrate=0 2020-03-25 12:26:27.048 T:3011338256 DEBUG: StartScript - calling plugin Amazon VOD('plugin://plugin.video.amazon-test/','1','?asin=B01N5AYAJM&mode=PlayVideo&adult=0&name=Arrival&trailer=0&selbitrate=0','resume:false') 2020-03-25 12:26:27.049 T:3011338256 DEBUG: GetLanguageInvoker - Reusing LanguageInvokerThread 2 for script /storage/.kodi/addons/plugin.video.amazon-test/default.py 2020-03-25 12:26:27.049 T:2625565552 INFO: initializing python engine. 2020-03-25 12:26:27.049 T:2625565552 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): start processing 2020-03-25 12:26:27.049 T:2625565552 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): entering source directory /storage/.kodi/addons/plugin.video.amazon-test 2020-03-25 12:26:27.049 T:2625565552 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): instantiating addon using automatically obtained id of "plugin.video.amazon-test" dependent on version 2.24.0 of the xbmc.python api 2020-03-25 12:26:27.050 T:2625565552 DEBUG: [Amazon VOD] Requested {'asin': 'B01N5AYAJM', 'name': 'Arrival', 'mode': 'PlayVideo', 'selbitrate': '0', 'trailer': '0', 'adult': '0'} 2020-03-25 12:26:27.065 T:2625565552 DEBUG: [script.module.inputstreamhelper] Platform information: ('Linux', 'LibreELEC', '4.19.106', '#1 SMP Tue Mar 3 15:40:36 EST 2020', 'armv7l', '') 2020-03-25 12:26:27.067 T:2625565552 DEBUG: CAddonSettings[script.module.inputstreamhelper]: loading setting definitions 2020-03-25 12:26:27.067 T:2625565552 DEBUG: CAddonSettings[script.module.inputstreamhelper]: trying to load setting definitions from old format... 2020-03-25 12:26:27.068 T:2625565552 DEBUG: CAddonSettings[script.module.inputstreamhelper]: loading setting values 2020-03-25 12:26:27.068 T:2625565552 DEBUG: CSettingsManager: requested setting (label6) was not found. 2020-03-25 12:26:27.068 T:2625565552 DEBUG: CAddonSettings[script.module.inputstreamhelper]: failed to find definition for setting label6. Creating a setting on-the-fly... 2020-03-25 12:26:27.069 T:2649727856 DEBUG: Thread scriptobs start, auto delete: false 2020-03-25 12:26:27.269 T:3011338256 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2020-03-25 12:26:27.296 T:2625565552 DEBUG: [script.module.inputstreamhelper] inputstream.adaptive is installed. 2020-03-25 12:26:27.298 T:2625565552 DEBUG: [script.module.inputstreamhelper] inputstream.adaptive 2.4.3.1 is enabled. 2020-03-25 12:26:27.299 T:2625565552 DEBUG: [script.module.inputstreamhelper] inputstream.adaptive 2.4.3.1 is installed and enabled. 2020-03-25 12:26:27.303 T:2625565552 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 2020-03-25 12:26:27.316 T:2625565552 DEBUG: Previous line repeats 3 times. 2020-03-25 12:26:27.316 T:2625565552 DEBUG: [script.module.inputstreamhelper] Found Widevine binary at /storage/.kodi/cdm/libwidevinecdm.so 2020-03-25 12:26:27.319 T:2625565552 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 2020-03-25 12:26:27.463 T:2625565552 DEBUG: Previous line repeats 4 times. 2020-03-25 12:26:27.463 T:2625565552 DEBUG: [script.module.inputstreamhelper] [u'ldd', u'/storage/.kodi/cdm/libwidevinecdm.so'] cmd executed successfully. 2020-03-25 12:26:27.463 T:2625565552 DEBUG: [script.module.inputstreamhelper] [u'ldd', u'/storage/.kodi/cdm/libwidevinecdm.so'] cmd output: linux-vdso.so.1 (0xbed7a000) /usr/lib/libarmmem-v7l.so (0xb677e000) libpthread.so.0 => /usr/lib/libpthread.so.0 (0xb6755000) libm.so.6 => /usr/lib/libm.so.6 (0xb66eb000) libdl.so.2 => /usr/lib/libdl.so.2 (0xb66d8000) librt.so.1 => /usr/lib/librt.so.1 (0xb66c1000) libnss3.so => /usr/lib/libnss3.so (0xb65cc000) libnssutil3.so => /usr/lib/libnssutil3.so (0xb659a000) libnspr4.so => /usr/lib/libnspr4.so (0xb6566000) libc.so.6 => /usr/lib/libc.so.6 (0xb642b000) /usr/lib/ld-linux-armhf.so.3 (0xb6f58000) libplc4.so => /usr/lib/libplc4.so (0xb6f7e000) libplds4.so => /usr/lib/libplds4.so (0xb6f7a000) 2020-03-25 12:26:27.463 T:2625565552 DEBUG: [script.module.inputstreamhelper] There are no missing Widevine libraries! :-) 2020-03-25 12:26:27.464 T:2625565552 ERROR: EXCEPTION: Invalid setting type 2020-03-25 12:26:27.464 T:2625565552 ERROR: Previous line repeats 1 times. 2020-03-25 12:26:27.464 T:2625565552 DEBUG: [script.module.inputstreamhelper] Widevine update check was made on 2020-03-25T12:10:43 2020-03-25 12:26:27.471 T:2625565552 NOTICE: [Amazon VOD] postURL: http://127.0.0.1:50869/gpr/https%3A%2F%2Fatv-ps-eu.amazon.de%2Fcdp%2Fcatalog%2FGetPlaybackResources%3Fasin%3DB01N5AYAJM%26deviceTypeID%3DAOAGZA014O5RE%26firmware%3D1%26deviceID%3Dfbbe44a507076598cf92e2ecff09f45b136ef438b4988099467b3aef%26marketplaceID%3DA1PA6795UKMFR9%26format%3Djson%26version%3D1%26gascEnabled%3Dfalse%26subtitleFormat%3DTTMLv2%26resourceUsage%3DImmediateConsumption%26consumptionType%3DStreaming%26deviceDrmOverride%3DCENC%26deviceStreamingTechnologyOverride%3DDASH%26deviceProtocolOverride%3DHttps%26deviceBitrateAdaptationsOverride%3DCVBR%252CCBR%26audioTrackId%3Dall%26languageFeature%3DMLFv2%26videoMaterialType%3DFeature%26desiredResources%3DPlaybackUrls%2CSubtitleUrls%2CForcedNarratives%26supportedDRMKeyScheme%3DDUAL_KEY 2020-03-25 12:26:27.501 T:2594300784 DEBUG: [Amazon VOD] [PS] Requested POST path [u'gpr', u'https%3A%2F%2Fatv-ps-eu.amazon.de%2Fcdp%2Fcatalog%2FGetPlaybackResources%3Fasin%3DB01N5AYAJM%26deviceTypeID%3DAOAGZA014O5RE%26firmware%3D1%26deviceID%3Dfbbe44a507076598cf92e2ecff09f45b136ef438b4988099467b3aef%26marketplaceID%3DA1PA6795UKMFR9%26format%3Djson%26version%3D1%26gascEnabled%3Dfalse%26subtitleFormat%3DTTMLv2%26resourceUsage%3DImmediateConsumption%26consumptionType%3DStreaming%26deviceDrmOverride%3DCENC%26deviceStreamingTechnologyOverride%3DDASH%26deviceProtocolOverride%3DHttps%26deviceBitrateAdaptationsOverride%3DCVBR%252CCBR%26audioTrackId%3Dall%26languageFeature%3DMLFv2%26videoMaterialType%3DFeature%26desiredResources%3DPlaybackUrls%2CSubtitleUrls%2CForcedNarratives%26supportedDRMKeyScheme%3DDUAL_KEY'] 2020-03-25 12:26:27.851 T:2594300784 DEBUG: [Amazon VOD] [PS] Forwarding the GET request towards https://atv-ps-eu.amazon.de/cdp/catalog/GetPlaybackResources?asin=B01N5AYAJM&deviceTypeID=AOAGZA014O5RE&firmware=1&deviceID=fbbe44a507076598cf92e2ecff09f45b136ef438b4988099467b3aef&marketplaceID=A1PA6795UKMFR9&format=json&version=1&gascEnabled=false&subtitleFormat=TTMLv2&resourceUsage=ImmediateConsumption&consumptionType=Streaming&deviceDrmOverride=CENC&deviceStreamingTechnologyOverride=DASH&deviceProtocolOverride=Https&deviceBitrateAdaptationsOverride=CVBR%2CCBR&audioTrackId=all&languageFeature=MLFv2&videoMaterialType=Feature&desiredResources=PlaybackUrls,SubtitleUrls,ForcedNarratives&supportedDRMKeyScheme=DUAL_KEY 2020-03-25 12:26:28.341 T:2625565552 NOTICE: [Amazon VOD] Using Host: Cloudfront 2020-03-25 12:26:28.342 T:2625565552 NOTICE: [Amazon VOD] checkURL: https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4~/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_corrected.mpd 2020-03-25 12:26:28.860 T:2625565552 DEBUG: [Amazon VOD] http://127.0.0.1:50869/mpd/https%3A%2F%2Fs3-dub-2.cf.dash.row.aiv-cdn.net%2Fdm%2F2%24YSdY1TkveuR6jDwNlGb4A_4iuP4%2Fee14%2F0190%2Fb184%2F4a73-80a8-aa51b5617156%2Fd5e9192b-bc82-4796-8fc4-b23682983b4f_corrected.mpd 2020-03-25 12:26:28.897 T:2625565552 NOTICE: [Amazon VOD] Using inputstream.adaptive Version: 2.4.3.1 2020-03-25 12:26:29.076 T:3011338256 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2020-03-25 12:26:29.076 T:2649727856 DEBUG: Thread scriptobs 2649727856 terminating 2020-03-25 12:26:29.082 T:3011338256 DEBUG: CPlayerCoreFactory::GetPlayers(http://127.0.0.1:50869/mpd/https%3A%2F%2Fs3-dub-2.cf.dash.row.aiv-cdn.net%2Fdm%2F2%24YSdY1TkveuR6jDwNlGb4A_4iuP4%2Fee14%2F0190%2Fb184%2F4a73-80a8-aa51b5617156%2Fd5e9192b-bc82-4796-8fc4-b23682983b4f_corrected.mpd) 2020-03-25 12:26:29.082 T:3011338256 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 2020-03-25 12:26:29.082 T:3011338256 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 2020-03-25 12:26:29.082 T:3011338256 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 2020-03-25 12:26:29.083 T:3011338256 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 2020-03-25 12:26:29.083 T:3011338256 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 2020-03-25 12:26:29.083 T:3011338256 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 2020-03-25 12:26:29.083 T:3011338256 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 2020-03-25 12:26:29.083 T:3011338256 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams 2020-03-25 12:26:29.083 T:3011338256 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp 2020-03-25 12:26:29.083 T:3011338256 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2 2020-03-25 12:26:29.083 T:3011338256 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 2020-03-25 12:26:29.083 T:3011338256 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 2020-03-25 12:26:29.083 T:3011338256 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 2020-03-25 12:26:29.083 T:3011338256 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 2020-03-25 12:26:29.083 T:3011338256 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 2020-03-25 12:26:29.083 T:3011338256 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 2020-03-25 12:26:29.083 T:3011338256 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 2020-03-25 12:26:29.083 T:3011338256 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 2020-03-25 12:26:29.083 T:3011338256 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 2020-03-25 12:26:29.083 T:3011338256 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 2020-03-25 12:26:29.085 T:3011338256 DEBUG: CMMALPool::CMMALPool Created pool 0x2fb7c40 of size 26 x 0 for port vc.ril.video_decode:out:0(I420) 2020-03-25 12:26:29.091 T:3011338256 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 2020-03-25 12:26:29.091 T:3011338256 NOTICE: VideoPlayer::OpenFile: plugin://plugin.video.amazon-test/?asin=B01N5AYAJM&mode=PlayVideo&adult=0&name=Arrival&trailer=0&selbitrate=0 2020-03-25 12:26:29.091 T:3011338256 DEBUG: CMMALRenderer::CMMALRenderer 2020-03-25 12:26:29.091 T:3011338256 DEBUG: OnPlayBackStarted: CApplication::OnPlayBackStarted 2020-03-25 12:26:29.091 T:2585908080 DEBUG: Thread MMALProcess start, auto delete: false 2020-03-25 12:26:29.091 T:2577515376 DEBUG: Thread VideoPlayer start, auto delete: false 2020-03-25 12:26:29.091 T:2585908080 DEBUG: CMMALRenderer::Run - starting 2020-03-25 12:26:29.092 T:2569122672 DEBUG: Thread BackgroundLoader start, auto delete: false 2020-03-25 12:26:29.092 T:2577515376 NOTICE: Creating InputStream 2020-03-25 12:26:29.092 T:2577515376 DEBUG: ADDON: Dll Initializing - InputStream Adaptive 2020-03-25 12:26:29.092 T:2577515376 DEBUG: SECTION:LoadDLL(/storage/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.2.4.3) 2020-03-25 12:26:29.092 T:2577515376 DEBUG: Loading: /storage/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.2.4.3 2020-03-25 12:26:29.098 T:2867204976 DEBUG: Loading settings for plugin://plugin.video.amazon-test/?asin=B01N5AYAJM&mode=PlayVideo&adult=0&name=Arrival&trailer=0&selbitrate=0 2020-03-25 12:26:29.105 T:2569122672 DEBUG: Thread BackgroundLoader 2569122672 terminating 2020-03-25 12:26:29.116 T:3011338256 DEBUG: CVideoGUIInfo::InitCurrentItem(plugin://plugin.video.amazon-test/?asin=B01N5AYAJM&mode=PlayVideo&adult=0&name=Arrival&trailer=0&selbitrate=0) 2020-03-25 12:26:29.116 T:3011338256 DEBUG: CPlayerGUIInfo::InitCurrentItem(plugin://plugin.video.amazon-test/?asin=B01N5AYAJM&mode=PlayVideo&adult=0&name=Arrival&trailer=0&selbitrate=0) 2020-03-25 12:26:29.151 T:2577515376 INFO: AddOnLog: InputStream Adaptive: SetVideoResolution (1280 x 720) 2020-03-25 12:26:29.151 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Open() 2020-03-25 12:26:29.151 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_key: [not shown] 2020-03-25 12:26:29.151 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.license_type: com.widevine.alpha 2020-03-25 12:26:29.151 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.manifest_type: mpd 2020-03-25 12:26:29.152 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: found inputstream.adaptive.stream_headers: user-agent=Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/70.0.3538.102 Safari/537.36 Edge/18.18362 2020-03-25 12:26:29.153 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Initial bandwidth: 4000000 2020-03-25 12:26:29.153 T:2577515376 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 2020-03-25 12:26:29.154 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: MAXRESOLUTION selected: 0 2020-03-25 12:26:29.154 T:2577515376 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 2020-03-25 12:26:29.155 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: MAXRESOLUTIONSECURE selected: 0 2020-03-25 12:26:29.155 T:2577515376 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 2020-03-25 12:26:29.156 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: STREAMSELECTION selected: 0 2020-03-25 12:26:29.156 T:2577515376 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 2020-03-25 12:26:29.160 T:2577515376 DEBUG: Previous line repeats 3 times. 2020-03-25 12:26:29.160 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Searching for decrypters in: /usr/lib/kodi/addons/inputstream.adaptive/ 2020-03-25 12:26:29.160 T:2577515376 ERROR: GetDirectory - Error getting /usr/lib/kodi/addons/inputstream.adaptive/ 2020-03-25 12:26:29.160 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Searching for decrypters in: /storage/.kodi/addons/inputstream.adaptive 2020-03-25 12:26:29.187 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Found decrypter: /storage/.kodi/addons/inputstream.adaptive/libssd_wv.so 2020-03-25 12:26:29.187 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Supported URN: urn:uuid:EDEF8BA9-79D6-4ACE-A3C8-27DCD51D21ED 2020-03-25 12:26:29.188 T:2577515376 DEBUG: CurlFile::Open(0xb1950a80) http://127.0.0.1:50869/mpd/https%3A%2F%2Fs3-dub-2.cf.dash.row.aiv-cdn.net%2Fdm%2F2%24YSdY1TkveuR6jDwNlGb4A_4iuP4%2Fee14%2F0190%2Fb184%2F4a73-80a8-aa51b5617156%2Fd5e9192b-bc82-4796-8fc4-b23682983b4f_corrected.mpd 2020-03-25 12:26:29.188 T:2577515376 INFO: easy_acquire - Created session to http://127.0.0.1 2020-03-25 12:26:29.191 T:2569122672 DEBUG: [Amazon VOD] [PS] Requested GET path [u'mpd', u'https%3A%2F%2Fs3-dub-2.cf.dash.row.aiv-cdn.net%2Fdm%2F2%24YSdY1TkveuR6jDwNlGb4A_4iuP4%2Fee14%2F0190%2Fb184%2F4a73-80a8-aa51b5617156%2Fd5e9192b-bc82-4796-8fc4-b23682983b4f_corrected.mpd'] 2020-03-25 12:26:29.194 T:2569122672 DEBUG: [Amazon VOD] [PS] Forwarding the GET request towards https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_corrected.mpd 2020-03-25 12:26:29.224 T:3011338256 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2020-03-25 12:26:29.407 T:2569122672 DEBUG: [Amazon VOD] [PS] Chunked transfer: prepping 2020-03-25 12:26:29.412 T:2569122672 DEBUG: [Amazon VOD] [PS] Loading MPD and rebasing as https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/ 2020-03-25 12:26:29.431 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Effective URL http://127.0.0.1:50869/mpd/https%3A%2F%2Fs3-dub-2.cf.dash.row.aiv-cdn.net%2Fdm%2F2%24YSdY1TkveuR6jDwNlGb4A_4iuP4%2Fee14%2F0190%2Fb184%2F4a73-80a8-aa51b5617156%2Fd5e9192b-bc82-4796-8fc4-b23682983b4f_corrected.mpd 2020-03-25 12:26:32.928 T:2569122672 DEBUG: [Amazon VOD] [PS] Parsing languages 2020-03-25 12:26:32.953 T:2569122672 DEBUG: [Amazon VOD] [PS] Altering s 2020-03-25 12:26:35.160 T:2569122672 DEBUG: [Amazon VOD] [PS] Chunked transfer: last chunks 2020-03-25 12:26:35.201 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Download http://127.0.0.1:50869/mpd/https%3A%2F%2Fs3-dub-2.cf.dash.row.aiv-cdn.net%2Fdm%2F2%24YSdY1TkveuR6jDwNlGb4A_4iuP4%2Fee14%2F0190%2Fb184%2F4a73-80a8-aa51b5617156%2Fd5e9192b-bc82-4796-8fc4-b23682983b4f_corrected.mpd finished 2020-03-25 12:26:35.202 T:2577515376 INFO: AddOnLog: InputStream Adaptive: Successfully parsed .mpd file. #Periods: 1, #Streams in first period: 7, Type: VOD, Download speed: 0.0000 Bytes/s 2020-03-25 12:26:35.202 T:2577515376 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 2020-03-25 12:26:35.204 T:2577515376 DEBUG: Previous line repeats 1 times. 2020-03-25 12:26:35.204 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Entering encryption section 2020-03-25 12:26:35.303 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: CDM version: 4.10.1610.6 2020-03-25 12:26:35.374 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: cdm::OnInitialized: true 2020-03-25 12:26:35.379 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Initializing stream with KID: 1A2B316633304A4097358D488A0BD61A 2020-03-25 12:26:35.856 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 1 arrived! 2020-03-25 12:26:35.858 T:2577515376 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Content-Type: application/x-www-form-urlencoded' 2020-03-25 12:26:35.858 T:2577515376 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Expect: ' 2020-03-25 12:26:35.859 T:2577515376 DEBUG: CurlFile::Open(0xb194b438) https://atv-ps-eu.amazon.de/cdp/catalog/GetPlaybackResources?asin=B01N5AYAJM&deviceTypeID=AOAGZA014O5RE&firmware=1&deviceID=fbbe44a507076598cf92e2ecff09f45b136ef438b4988099467b3aef&marketplaceID=A1PA6795UKMFR9&format=json&version=1&gascEnabled=false&resourceUsage=ImmediateConsumption&consumptionType=Streaming&deviceDrmOverride=CENC&deviceStreamingTechnologyOverride=DASH&deviceProtocolOverride=Https&deviceBitrateAdaptationsOverride=CVBR%2CCBR&audioTrackId=all&languageFeature=MLFv2&videoMaterialType=Feature&desiredResources=Widevine2License 2020-03-25 12:26:35.859 T:2577515376 INFO: easy_acquire - Created session to https://atv-ps-eu.amazon.de 2020-03-25 12:26:36.553 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 2 arrived! 2020-03-25 12:26:36.553 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Sessionkey:1A2B316633304A4097358D488A0BD61A status: 0 syscode: 0 2020-03-25 12:26:36.553 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 3 arrived! 2020-03-25 12:26:36.553 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Sessionkey:42FC4408633C4DA99B2FF1D72B5FC4C1 status: 0 syscode: 0 2020-03-25 12:26:36.553 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 3 arrived! 2020-03-25 12:26:36.553 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Sessionkey:B770D5B4BB6B594DAF985845AAE9AA5F status: 0 syscode: 0 2020-03-25 12:26:36.553 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 3 arrived! 2020-03-25 12:26:36.554 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: License update successful 2020-03-25 12:26:36.563 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Sessionkey:1A2B316633304A4097358D488A0BD61A status: 1 syscode: 5 2020-03-25 12:26:36.563 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 3 arrived! 2020-03-25 12:26:36.563 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Sessionkey:42FC4408633C4DA99B2FF1D72B5FC4C1 status: 0 syscode: 0 2020-03-25 12:26:36.563 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 3 arrived! 2020-03-25 12:26:36.563 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Sessionkey:B770D5B4BB6B594DAF985845AAE9AA5F status: 0 syscode: 0 2020-03-25 12:26:36.563 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 3 arrived! 2020-03-25 12:26:36.563 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: DecryptSampleData: Decrypt failed with error: 2 and key: 1A2B316633304A4097358D488A0BD61A 2020-03-25 12:26:36.566 T:2577515376 DEBUG: Previous line repeats 1 times. 2020-03-25 12:26:36.566 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Initializing stream with KID: 1A2B316633304A4097358D488A0BD61A 2020-03-25 12:26:36.566 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: DecryptSampleData: Decrypt failed with error: 2 and key: 1A2B316633304A4097358D488A0BD61A 2020-03-25 12:26:36.567 T:2577515376 DEBUG: Previous line repeats 1 times. 2020-03-25 12:26:36.567 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Initializing stream with KID: 42FC4408633C4DA99B2FF1D72B5FC4C1 2020-03-25 12:26:36.567 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: DecryptSampleData: Decrypt failed with error: 2 and key: 42FC4408633C4DA99B2FF1D72B5FC4C1 2020-03-25 12:26:36.569 T:2577515376 DEBUG: CAddonSettings[inputstream.adaptive]: loading setting definitions 2020-03-25 12:26:36.570 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: UpdateStream: Convert avc -> annexb 2020-03-25 12:26:36.570 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: GetCapabilities() 2020-03-25 12:26:36.570 T:2577515376 DEBUG: GetExternalStreamDetailsFromFilename - Language = 'eng' / Name = '(External)' / Flag = '0' from http://127.0.0.1:50869/subtitles/https%3A%2F%2Fdmqdd6hw24ucf.cloudfront.net%2F93b5%2F7481%2Fead4%2F4f3e-85c2-31579d586453%2Ff58bb74f-6202-4384-a0bc-3a074d247d21.ttml2/en.srt 2020-03-25 12:26:36.570 T:2577515376 DEBUG: GetExternalStreamDetailsFromFilename - Language = 'ger' / Name = '(External)' / Flag = '0' from http://127.0.0.1:50869/subtitles/https%3A%2F%2Fdmqdd6hw24ucf.cloudfront.net%2F9ea1%2Fe4a5%2Ffe72%2F403d-b724-baa3b3faf7a8%2F701350d1-1d71-47c9-a560-7bbc1b9a6fcc.ttml2/de.srt 2020-03-25 12:26:36.570 T:2577515376 NOTICE: Creating Demuxer 2020-03-25 12:26:36.571 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: GetStreamIds() 2020-03-25 12:26:36.571 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: GetStream(1001) 2020-03-25 12:26:36.571 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: GetStream(1001): initalizing crypto session 2020-03-25 12:26:36.571 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: GetStream(1002) 2020-03-25 12:26:36.571 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: GetStream(1003) 2020-03-25 12:26:36.571 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: GetStream(1004) 2020-03-25 12:26:36.571 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: GetStream(1005) 2020-03-25 12:26:36.571 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: GetStream(1006) 2020-03-25 12:26:36.571 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: GetStream(1007) 2020-03-25 12:26:36.571 T:2577515376 DEBUG: CDVDDemuxClient::RequestStream(): added/updated stream 1001 with codec_id 27 2020-03-25 12:26:36.571 T:2577515376 DEBUG: CDVDDemuxClient::RequestStream(): added/updated stream 1002 with codec_id 86056 2020-03-25 12:26:36.571 T:2577515376 DEBUG: CDVDDemuxClient::RequestStream(): added/updated stream 1003 with codec_id 86018 2020-03-25 12:26:36.571 T:2577515376 DEBUG: CDVDDemuxClient::RequestStream(): added/updated stream 1004 with codec_id 86018 2020-03-25 12:26:36.571 T:2577515376 DEBUG: CDVDDemuxClient::RequestStream(): added/updated stream 1005 with codec_id 86056 2020-03-25 12:26:36.571 T:2577515376 DEBUG: CDVDDemuxClient::RequestStream(): added/updated stream 1006 with codec_id 86018 2020-03-25 12:26:36.571 T:2577515376 DEBUG: CDVDDemuxClient::RequestStream(): added/updated stream 1007 with codec_id 86018 2020-03-25 12:26:36.572 T:2577515376 NOTICE: Opening stream: 1001 source: 256 2020-03-25 12:26:36.572 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: OpenStream(1001) 2020-03-25 12:26:36.572 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Selecting stream with conditions: w: 1280, h: 720, bw: 3600000 2020-03-25 12:26:36.572 T:2577515376 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=0-1615' 2020-03-25 12:26:36.573 T:2577515376 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:36.573 T:2577515376 DEBUG: CurlFile::Open(0xb194b350) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 2020-03-25 12:26:36.573 T:2577515376 INFO: easy_acquire - Created session to https://s3-dub-2.cf.dash.row.aiv-cdn.net 2020-03-25 12:26:36.764 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 finished, avg speed: 13.04byte/s, current speed: 8460.00byte/s 2020-03-25 12:26:36.766 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: UpdateSampleDescription: codec 1635148593 2020-03-25 12:26:36.766 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: GetStream(1001) 2020-03-25 12:26:36.766 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: GetStream(1001): initalizing crypto session 2020-03-25 12:26:36.766 T:2577515376 DEBUG: CDVDDemuxClient::RequestStream(): added/updated stream 1001 with codec_id 27 2020-03-25 12:26:36.772 T:2577515376 NOTICE: Creating video codec with codec id: 27 2020-03-25 12:26:36.772 T:2577515376 INFO: AddOnLog: InputStream Adaptive: VideoCodec::Open 2020-03-25 12:26:36.779 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: WVDecoder initialization returned status 0 2020-03-25 12:26:36.779 T:2577515376 DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 27 2020-03-25 12:26:36.781 T:2577515376 DEBUG: CMMALPool::CMMALPool Created pool 0x9adb21a0 of size 26 x 0 for port vc.ril.video_decode:out:0(I420) 2020-03-25 12:26:36.781 T:2577515376 DEBUG: CMMALPool::~CMMALPool Destroying pool 0x2fb7c40 for port vc.ril.video_decode:out:0(I420) 2020-03-25 12:26:36.782 T:2577515376 NOTICE: Creating video thread 2020-03-25 12:26:36.782 T:2649727856 DEBUG: Thread VideoPlayerVideo start, auto delete: false 2020-03-25 12:26:36.782 T:2649727856 NOTICE: running thread: video_thread 2020-03-25 12:26:36.782 T:2577515376 NOTICE: Opening stream: 1002 source: 256 2020-03-25 12:26:36.782 T:2649727856 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: 0 2020-03-25 12:26:36.782 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: OpenStream(1002) 2020-03-25 12:26:36.782 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Selecting stream with conditions: w: 0, h: 0, bw: 400000 2020-03-25 12:26:36.783 T:2577515376 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=0-1501' 2020-03-25 12:26:36.783 T:2577515376 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:36.783 T:2577515376 DEBUG: CurlFile::Open(0xb194b350) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:26:36.847 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 46.64byte/s, current speed: 23468.00byte/s 2020-03-25 12:26:36.848 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: UpdateSampleDescription: codec 1700998451 2020-03-25 12:26:36.848 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: GetStream(1002) 2020-03-25 12:26:36.848 T:2577515376 DEBUG: CDVDDemuxClient::RequestStream(): added/updated stream 1002 with codec_id 86056 2020-03-25 12:26:36.848 T:2577515376 NOTICE: Finding audio codec for: 86056 2020-03-25 12:26:36.849 T:2577515376 NOTICE: CDVDAudioCodecFFmpeg::Open() Successful opened audio decoder eac3 2020-03-25 12:26:36.849 T:2577515376 NOTICE: Creating audio thread 2020-03-25 12:26:36.850 T:2577515376 NOTICE: Opening stream: 0 source: 1025 2020-03-25 12:26:36.850 T:2577515376 DEBUG: CFileCache::Open - opening using cache 2020-03-25 12:26:36.850 T:2577515376 DEBUG: CurlFile::Open(0x9adb24d0) http://127.0.0.1:50869/subtitles/https%3A%2F%2Fdmqdd6hw24ucf.cloudfront.net%2F9ea1%2Fe4a5%2Ffe72%2F403d-b724-baa3b3faf7a8%2F701350d1-1d71-47c9-a560-7bbc1b9a6fcc.ttml2/de.srt 2020-03-25 12:26:36.851 T:2510619504 DEBUG: Thread VideoPlayerAudio start, auto delete: false 2020-03-25 12:26:36.851 T:2510619504 NOTICE: running thread: CVideoPlayerAudio::Process() 2020-03-25 12:26:36.851 T:2510619504 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_PAUSE: 0 2020-03-25 12:26:36.852 T:2569122672 DEBUG: [Amazon VOD] [PS] Requested GET path [u'subtitles', u'https%3A%2F%2Fdmqdd6hw24ucf.cloudfront.net%2F9ea1%2Fe4a5%2Ffe72%2F403d-b724-baa3b3faf7a8%2F701350d1-1d71-47c9-a560-7bbc1b9a6fcc.ttml2', u'de.srt'] 2020-03-25 12:26:36.854 T:2569122672 DEBUG: [Amazon VOD] [PS] Forwarding the GET request towards https://dmqdd6hw24ucf.cloudfront.net/9ea1/e4a5/fe72/403d-b724-baa3b3faf7a8/701350d1-1d71-47c9-a560-7bbc1b9a6fcc.ttml2 2020-03-25 12:26:37.531 T:2498753392 DEBUG: Thread FileCache start, auto delete: false 2020-03-25 12:26:37.533 T:2498753392 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 2020-03-25 12:26:37.585 T:2498753392 DEBUG: Thread FileCache 2498753392 terminating 2020-03-25 12:26:37.614 T:2577515376 DEBUG: CVideoPlayer::SetCaching - caching state 2 2020-03-25 12:26:37.614 T:2577515376 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 2020-03-25 12:26:37.614 T:2577515376 DEBUG: CVideoPlayer::HandleMessages - player 2 reported state: 0 2020-03-25 12:26:37.614 T:2867204976 DEBUG: OnAVChange: CApplication::OnAVChange 2020-03-25 12:26:37.614 T:2577515376 DEBUG: CVideoPlayer::HandleMessages - player 1 reported state: 0 2020-03-25 12:26:37.617 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=19744-516034' 2020-03-25 12:26:37.617 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:37.617 T:2552583024 DEBUG: CurlFile::Open(0x94507450) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 2020-03-25 12:26:37.617 T:2510619504 DEBUG: CDVDAudio::Pause - pausing audio stream 2020-03-25 12:26:37.720 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=43474-92526' 2020-03-25 12:26:37.720 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:37.720 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:26:37.720 T:2519012208 INFO: easy_acquire - Created session to https://s3-dub-2.cf.dash.row.aiv-cdn.net 2020-03-25 12:26:37.730 T:2625565552 NOTICE: [Amazon VOD] Starting Playback: 0.0/6989.00048828 2020-03-25 12:26:37.731 T:2625565552 NOTICE: [Amazon VOD] postURL: https://atv-ps-eu.amazon.de/cdp/usage/UpdateStream?asin=B01N5AYAJM&deviceTypeID=AOAGZA014O5RE&firmware=1&deviceID=fbbe44a507076598cf92e2ecff09f45b136ef438b4988099467b3aef&marketplaceID=A1PA6795UKMFR9&format=json&version=1&gascEnabled=false&subtitleFormat=TTMLv2&event=START&timecode=0.0 2020-03-25 12:26:37.867 T:2552583024 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 finished, avg speed: 939602.64byte/s, current speed: 1985164.00byte/s 2020-03-25 12:26:37.981 T:2577515376 DEBUG: CVideoPlayer::SetCaching - caching state 1 2020-03-25 12:26:37.982 T:2649727856 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 2020-03-25 12:26:37.982 T:2577515376 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 2020-03-25 12:26:37.982 T:2649727856 DEBUG: AddOnLog: InputStream Adaptive: Sessionkey:1A2B316633304A4097358D488A0BD61A status: 0 syscode: 0 2020-03-25 12:26:37.982 T:2649727856 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 3 arrived! 2020-03-25 12:26:37.982 T:2649727856 DEBUG: AddOnLog: InputStream Adaptive: Sessionkey:42FC4408633C4DA99B2FF1D72B5FC4C1 status: 0 syscode: 0 2020-03-25 12:26:37.982 T:2649727856 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 3 arrived! 2020-03-25 12:26:37.983 T:2649727856 DEBUG: AddOnLog: InputStream Adaptive: Sessionkey:B770D5B4BB6B594DAF985845AAE9AA5F status: 0 syscode: 0 2020-03-25 12:26:37.983 T:2649727856 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 3 arrived! 2020-03-25 12:26:37.989 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 0x0 (0x0) pix:0 size:678160 fmt:I420 2020-03-25 12:26:37.989 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 904241.96byte/s, current speed: 183719.00byte/s 2020-03-25 12:26:37.991 T:2510619504 DEBUG: CDVDAudio::Pause - pausing audio stream 2020-03-25 12:26:37.992 T:2510619504 NOTICE: Creating audio stream (codec id: 86056, channels: 6, sample rate: 48000, no pass-through) 2020-03-25 12:26:37.992 T:2510619504 DEBUG: CVideoPlayerAudio:: synctype set to 0: clock feedback 2020-03-25 12:26:37.995 T:2979001200 INFO: CActiveAESink::OpenSink - initialize sink 2020-03-25 12:26:38.018 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I420 2020-03-25 12:26:38.019 T:2649727856 DEBUG: CRenderManager::Configure - change configuration. 720x576. display: 720x300. framerate: 23.98. 2020-03-25 12:26:38.038 T:3011338256 DEBUG: DeleteRenderer - deleting renderer 2020-03-25 12:26:38.038 T:3011338256 DEBUG: CMMALRenderer::~CMMALRenderer 2020-03-25 12:26:38.038 T:3011338256 DEBUG: CMMALRenderer::UnInitMMAL 2020-03-25 12:26:38.038 T:2585908080 DEBUG: CMMALRenderer::Run - stopping 2020-03-25 12:26:38.038 T:2585908080 DEBUG: Thread MMALProcess 2585908080 terminating 2020-03-25 12:26:38.038 T:3011338256 DEBUG: CMMALRenderer::CMMALRenderer 2020-03-25 12:26:38.038 T:3011338256 DEBUG: CMMALRenderer::Configure - 720x576->720x300@23.98 flags:2 format:-1 orient:0 2020-03-25 12:26:38.038 T:2498753392 DEBUG: Thread MMALProcess start, auto delete: false 2020-03-25 12:26:38.039 T:3011338256 DEBUG: CRenderManager::Configure - 6 2020-03-25 12:26:38.039 T:2498753392 DEBUG: CMMALRenderer::Run - starting 2020-03-25 12:26:38.039 T:2867204976 DEBUG: OnAVChange: CApplication::OnAVChange 2020-03-25 12:26:38.039 T:2577515376 DEBUG: CVideoPlayer::HandleMessages - player started 2 2020-03-25 12:26:38.041 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=92527-140803' 2020-03-25 12:26:38.041 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:38.041 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:26:38.044 T:2498753392 DEBUG: CMMALRenderer::CheckConfigurationVout Changing Vout dimensions from 0x0 (0x0) to 720x576 (784x576) I42S 2020-03-25 12:26:38.049 T:2498753392 DEBUG: CMMALRenderer::SetVideoRect 0,0,720,576 -> 0,93,1280,626 (o:0 v:0 d:0 i:0) 2020-03-25 12:26:38.049 T:2479002480 DEBUG: Thread MMALRenderer start, auto delete: false 2020-03-25 12:26:38.049 T:2479002480 DEBUG: CMMALRenderer::Process - starting 2020-03-25 12:26:38.049 T:2498753392 DEBUG: CMMALRenderer::SetVideoRect 0,0,720,576 -> 0,93,1280,533 t:100000 2020-03-25 12:26:38.056 T:3011338256 DEBUG: CMMALRenderer::RenderUpdate - vsync -1 (+1482) 2020-03-25 12:26:38.056 T:3011338256 DEBUG: CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 61 2020-03-25 12:26:38.081 T:3011338256 DEBUG: CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 60 2020-03-25 12:26:38.087 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 912003.48byte/s, current speed: 1072822.00byte/s 2020-03-25 12:26:38.095 T:2979001200 DEBUG: CAESinkPi:Drain delay:100ms now:0ms 2020-03-25 12:26:38.095 T:2979001200 DEBUG: CAESinkPi:Deinitialize 2020-03-25 12:26:38.095 T:2979001200 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 2020-03-25 12:26:38.101 T:2979001200 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0xb0f0d2e0 2020-03-25 12:26:38.101 T:2979001200 DEBUG: CActiveAESink::OpenSink - trying to open device SinkPi:Default 2020-03-25 12:26:38.101 T:2979001200 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 2020-03-25 12:26:38.101 T:2979001200 DEBUG: CAESinkPi:Initialize Format:24 Channels:2 Samplerate:48000 framesize:8 bufsize:19200 bytes/s=384000.00 dest=Default 2020-03-25 12:26:38.101 T:2979001200 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 2020-03-25 12:26:38.102 T:2979001200 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0xb0f94630 2020-03-25 12:26:38.104 T:2979001200 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(19200), nBufferAlignment(16) 2020-03-25 12:26:38.104 T:2979001200 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 2020-03-25 12:26:38.104 T:2979001200 DEBUG: Output Device : HDMI 2020-03-25 12:26:38.104 T:2979001200 DEBUG: Sample Rate : 48000 2020-03-25 12:26:38.104 T:2979001200 DEBUG: Sample Format : AE_FMT_FLOATP 2020-03-25 12:26:38.104 T:2979001200 DEBUG: Channel Count : 2 2020-03-25 12:26:38.105 T:2979001200 DEBUG: Channel Layout: FL, FR 2020-03-25 12:26:38.105 T:2979001200 DEBUG: Frames : 2400 2020-03-25 12:26:38.105 T:2979001200 DEBUG: Frame Size : 8 2020-03-25 12:26:38.112 T:2988688240 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2020-03-25 12:26:38.115 T:2577515376 DEBUG: Previous line repeats 1 times. 2020-03-25 12:26:38.115 T:2577515376 DEBUG: CVideoPlayer::HandleMessages - player started 1 2020-03-25 12:26:38.115 T:2867204976 DEBUG: OnAVChange: CApplication::OnAVChange 2020-03-25 12:26:38.115 T:2577515376 DEBUG: VideoPlayer::Sync - Audio - pts: 288000.000000, cache: 412459.792785, totalcache: 699999.988079 2020-03-25 12:26:38.115 T:2577515376 DEBUG: VideoPlayer::Sync - Video - pts: 83416.000000, cache: 50000.000000, totalcache: 100000.000000 2020-03-25 12:26:38.115 T:2649727856 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(-124459.792785) 2020-03-25 12:26:38.115 T:2510619504 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(-124459.792785), level: 38, cache: 412004.107785 2020-03-25 12:26:38.116 T:2577515376 DEBUG: CVideoPlayer::SetCaching - caching state 0 2020-03-25 12:26:38.116 T:2577515376 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 2020-03-25 12:26:38.116 T:2510619504 DEBUG: CDVDAudio::Resume - resume audio stream 2020-03-25 12:26:38.117 T:3011338256 DEBUG: Activating window ID: 12005 2020-03-25 12:26:38.121 T:2988688240 DEBUG: ActiveAE - start sync of audio stream 2020-03-25 12:26:38.121 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:38.123 T:3011338256 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 2020-03-25 12:26:38.124 T:3011338256 DEBUG: FreeVisualisation() done 2020-03-25 12:26:38.124 T:2641335152 DEBUG: OnAVStarted: CApplication::OnAVStarted 2020-03-25 12:26:38.125 T:3011338256 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 2020-03-25 12:26:38.125 T:3011338256 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY 2020-03-25 12:26:38.126 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:38.131 T:3011338256 DEBUG: CMMALRenderer::SetVideoRect 0,0,720,576 -> 0,93,1280,626 (o:0 v:0 d:0 i:0) 2020-03-25 12:26:38.131 T:3011338256 DEBUG: CMMALRenderer::SetVideoRect 0,0,720,576 -> 0,93,1280,533 t:100000 2020-03-25 12:26:38.132 T:2867204976 DEBUG: OnAVChange: CApplication::OnAVChange 2020-03-25 12:26:38.133 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:38.145 T:2519012208 DEBUG: Previous line repeats 1 times. 2020-03-25 12:26:38.145 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=140804-189856' 2020-03-25 12:26:38.145 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:38.145 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:26:38.148 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:38.156 T:3011338256 DEBUG: Previous line repeats 1 times. 2020-03-25 12:26:38.156 T:3011338256 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2020-03-25 12:26:38.189 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 922705.17byte/s, current speed: 1140767.00byte/s 2020-03-25 12:26:38.240 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=516035-841584' 2020-03-25 12:26:38.240 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:38.240 T:2552583024 DEBUG: CurlFile::Open(0x94507450) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 2020-03-25 12:26:38.257 T:2988688240 DEBUG: ActiveAE::SyncStream - average error of 16.439836, start adjusting 2020-03-25 12:26:38.258 T:2988688240 DEBUG: ActiveAE::SyncStream - average error 0.439836 below threshold of 30.000000 2020-03-25 12:26:38.323 T:2552583024 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 finished, avg speed: 1868832.32byte/s, current speed: 3970121.00byte/s 2020-03-25 12:26:38.341 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:38.344 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=189857-238133' 2020-03-25 12:26:38.344 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:38.344 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:26:38.361 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:38.390 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1832183.58byte/s, current speed: 1072822.00byte/s 2020-03-25 12:26:38.404 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:38.428 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=238134-287186' 2020-03-25 12:26:38.428 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:38.429 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:26:38.438 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:38.478 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1793304.11byte/s, current speed: 1001081.00byte/s 2020-03-25 12:26:38.479 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:39.275 T:2510619504 DEBUG: Previous line repeats 18 times. 2020-03-25 12:26:39.275 T:2510619504 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-33506.235484, adjusted:-33506.235484 2020-03-25 12:26:39.301 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:39.645 T:2552583024 DEBUG: Previous line repeats 8 times. 2020-03-25 12:26:39.646 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=841585-965129' 2020-03-25 12:26:39.646 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:39.646 T:2552583024 DEBUG: CurlFile::Open(0x94507450) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 2020-03-25 12:26:39.656 T:3011338256 DEBUG: Keyboard: scancode: 0x1d, sym: 0x0132, unicode: 0x0000, modifier: 0xc0 2020-03-25 12:26:39.656 T:3011338256 DEBUG: HandleKey: ctrl-leftctrl (0x1f0d0) pressed, action is 2020-03-25 12:26:39.702 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:39.743 T:2519012208 DEBUG: Previous line repeats 1 times. 2020-03-25 12:26:39.743 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=287187-335463' 2020-03-25 12:26:39.744 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:39.744 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:26:39.749 T:2552583024 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 finished, avg speed: 1723337.10byte/s, current speed: 1199466.00byte/s 2020-03-25 12:26:39.764 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:39.791 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:39.792 T:2463466352 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:39.796 T:3011338256 DEBUG: Keyboard: scancode: 0x1f, sym: 0x0073, unicode: 0x0013, modifier: 0xc0 2020-03-25 12:26:39.797 T:3011338256 DEBUG: HandleKey: ctrl-s (0x1f053) pressed, action is Screenshot 2020-03-25 12:26:39.806 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1680431.42byte/s, current speed: 791426.00byte/s 2020-03-25 12:26:39.877 T:3011338256 DEBUG: Saving screenshot /storage/screenshots/screenshot004.png 2020-03-25 12:26:39.884 T:2858812272 DEBUG: cached image '/storage/screenshots/screenshot004.png' size 1280x720 2020-03-25 12:26:39.890 T:3011338256 DEBUG: CMMALRenderer::RenderUpdate - vsync 1568 (+4) 2020-03-25 12:26:39.892 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:39.983 T:2463466352 DEBUG: Previous line repeats 4 times. 2020-03-25 12:26:39.983 T:2463466352 DEBUG: Thread Timer 2463466352 terminating 2020-03-25 12:26:39.996 T:3011338256 DEBUG: Keyboard: scancode: 0x1f, sym: 0x0073, unicode: 0x0013, modifier: 0xc0 2020-03-25 12:26:40.019 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:40.136 T:3011338256 DEBUG: Previous line repeats 2 times. 2020-03-25 12:26:40.136 T:3011338256 DEBUG: Keyboard: scancode: 0x1d, sym: 0x0132, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:40.139 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:41.641 T:2519012208 DEBUG: Previous line repeats 36 times. 2020-03-25 12:26:41.641 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=335464-384516' 2020-03-25 12:26:41.641 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:41.641 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:26:41.679 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:41.696 T:3011338256 DEBUG: Keyboard: scancode: 0x1d, sym: 0x0132, unicode: 0x0000, modifier: 0xc0 2020-03-25 12:26:41.696 T:3011338256 DEBUG: HandleKey: ctrl-leftctrl (0x1f0d0) pressed, action is 2020-03-25 12:26:41.739 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:41.764 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1620629.06byte/s, current speed: 402073.00byte/s 2020-03-25 12:26:41.786 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:42.520 T:3001021296 DEBUG: Previous line repeats 17 times. 2020-03-25 12:26:42.520 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:26:42.520 T:2463466352 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:26:42.520 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:42.536 T:3011338256 DEBUG: Keyboard: scancode: 0x1f, sym: 0x0073, unicode: 0x0013, modifier: 0xc0 2020-03-25 12:26:42.536 T:3011338256 DEBUG: HandleKey: ctrl-s (0x1f053) pressed, action is Screenshot 2020-03-25 12:26:42.577 T:3011338256 DEBUG: Saving screenshot /storage/screenshots/screenshot005.png 2020-03-25 12:26:42.581 T:2641335152 DEBUG: cached image '/storage/screenshots/screenshot005.png' size 1280x720 2020-03-25 12:26:42.589 T:3011338256 DEBUG: CMMALRenderer::RenderUpdate - vsync 1705 (+2) 2020-03-25 12:26:42.591 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:42.744 T:2463466352 DEBUG: Previous line repeats 3 times. 2020-03-25 12:26:42.744 T:2463466352 DEBUG: Thread Timer 2463466352 terminating 2020-03-25 12:26:42.755 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:42.756 T:3011338256 DEBUG: Keyboard: scancode: 0x1f, sym: 0x0073, unicode: 0x0013, modifier: 0xc0 2020-03-25 12:26:42.756 T:3011338256 DEBUG: Keyboard: scancode: 0x1d, sym: 0x0132, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:42.800 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:43.100 T:2649727856 DEBUG: Previous line repeats 8 times. 2020-03-25 12:26:43.100 T:2649727856 DEBUG: CPtsTracker: detected pattern of length 1: 41708.33, frameduration: 41708.333333 2020-03-25 12:26:43.160 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:43.702 T:2519012208 DEBUG: Previous line repeats 13 times. 2020-03-25 12:26:43.702 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=384517-432793' 2020-03-25 12:26:43.702 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:43.702 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:26:43.740 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:43.786 T:2519012208 DEBUG: Previous line repeats 1 times. 2020-03-25 12:26:43.786 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1572793.91byte/s, current speed: 581650.00byte/s 2020-03-25 12:26:43.824 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:44.680 T:2552583024 DEBUG: Previous line repeats 20 times. 2020-03-25 12:26:44.680 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=965130-1413906' 2020-03-25 12:26:44.680 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:44.680 T:2552583024 DEBUG: CurlFile::Open(0x94507450) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 2020-03-25 12:26:44.699 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:44.949 T:2552583024 DEBUG: Previous line repeats 6 times. 2020-03-25 12:26:44.949 T:2552583024 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 finished, avg speed: 1616340.35byte/s, current speed: 1674541.00byte/s 2020-03-25 12:26:44.982 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:45.688 T:2519012208 DEBUG: Previous line repeats 16 times. 2020-03-25 12:26:45.688 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=432794-481846' 2020-03-25 12:26:45.688 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:45.688 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:26:45.700 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:45.745 T:2519012208 DEBUG: Previous line repeats 1 times. 2020-03-25 12:26:45.746 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1581704.27byte/s, current speed: 875946.00byte/s 2020-03-25 12:26:45.800 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:46.538 T:3011338256 DEBUG: Previous line repeats 16 times. 2020-03-25 12:26:46.538 T:3011338256 DEBUG: CMMALRenderer::RenderUpdate - vsync 1903 (+2) 2020-03-25 12:26:46.540 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:47.436 T:3011338256 DEBUG: Previous line repeats 22 times. 2020-03-25 12:26:47.436 T:3011338256 DEBUG: Keyboard: scancode: 0x1d, sym: 0x0132, unicode: 0x0000, modifier: 0xc0 2020-03-25 12:26:47.436 T:3011338256 DEBUG: HandleKey: ctrl-leftctrl (0x1f0d0) pressed, action is 2020-03-25 12:26:47.458 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:47.723 T:2519012208 DEBUG: Previous line repeats 6 times. 2020-03-25 12:26:47.723 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=481847-530123' 2020-03-25 12:26:47.723 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:47.723 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:26:47.758 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:47.779 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1549294.44byte/s, current speed: 877763.00byte/s 2020-03-25 12:26:47.782 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:48.156 T:3011338256 DEBUG: Previous line repeats 8 times. 2020-03-25 12:26:48.156 T:3011338256 DEBUG: Keyboard: scancode: 0x1d, sym: 0x0132, unicode: 0x0000, modifier: 0x0 2020-03-25 12:26:48.166 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:49.680 T:2519012208 DEBUG: Previous line repeats 36 times. 2020-03-25 12:26:49.680 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=530124-579176' 2020-03-25 12:26:49.680 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:49.681 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:26:49.701 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:49.735 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=1413907-1664135' 2020-03-25 12:26:49.735 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:49.736 T:2552583024 DEBUG: CurlFile::Open(0x94507450) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 2020-03-25 12:26:49.737 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1517794.80byte/s, current speed: 875946.00byte/s 2020-03-25 12:26:49.740 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:49.879 T:2552583024 DEBUG: Previous line repeats 3 times. 2020-03-25 12:26:49.879 T:2552583024 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 finished, avg speed: 1573172.47byte/s, current speed: 1749853.00byte/s 2020-03-25 12:26:49.900 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:51.725 T:2519012208 DEBUG: Previous line repeats 43 times. 2020-03-25 12:26:51.725 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=579177-627453' 2020-03-25 12:26:51.726 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:51.726 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:26:51.760 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:51.785 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1539065.16byte/s, current speed: 832362.00byte/s 2020-03-25 12:26:51.799 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:53.663 T:2519012208 DEBUG: Previous line repeats 45 times. 2020-03-25 12:26:53.663 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=627454-676506' 2020-03-25 12:26:53.663 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:53.663 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:26:53.700 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:53.720 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=1664136-2820930' 2020-03-25 12:26:53.720 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:53.720 T:2552583024 DEBUG: CurlFile::Open(0x94507450) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 2020-03-25 12:26:53.724 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1505312.26byte/s, current speed: 817550.00byte/s 2020-03-25 12:26:53.739 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:54.300 T:2552583024 DEBUG: Previous line repeats 13 times. 2020-03-25 12:26:54.300 T:2552583024 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 finished, avg speed: 1994474.00byte/s, current speed: 1994474.00byte/s 2020-03-25 12:26:54.320 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:55.665 T:2519012208 DEBUG: Previous line repeats 32 times. 2020-03-25 12:26:55.665 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=676507-724783' 2020-03-25 12:26:55.665 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:55.666 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:26:55.700 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:55.720 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1943808.42byte/s, current speed: 894018.00byte/s 2020-03-25 12:26:55.758 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:57.661 T:2519012208 DEBUG: Previous line repeats 45 times. 2020-03-25 12:26:57.661 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=724784-773836' 2020-03-25 12:26:57.661 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:57.661 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:26:57.665 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:57.715 T:2519012208 DEBUG: Previous line repeats 1 times. 2020-03-25 12:26:57.715 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1895370.84byte/s, current speed: 908388.00byte/s 2020-03-25 12:26:57.739 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:58.703 T:2552583024 DEBUG: Previous line repeats 23 times. 2020-03-25 12:26:58.703 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=2820931-4474539' 2020-03-25 12:26:58.710 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:58.710 T:2552583024 DEBUG: CurlFile::Open(0x94507450) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 2020-03-25 12:26:58.739 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:59.301 T:2552583024 DEBUG: Previous line repeats 13 times. 2020-03-25 12:26:59.301 T:2552583024 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 finished, avg speed: 2797984.00byte/s, current speed: 2797984.00byte/s 2020-03-25 12:26:59.340 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:59.668 T:2519012208 DEBUG: Previous line repeats 8 times. 2020-03-25 12:26:59.668 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=773837-822113' 2020-03-25 12:26:59.668 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:26:59.668 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:26:59.706 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:26:59.720 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 2712745.61byte/s, current speed: 946607.00byte/s 2020-03-25 12:26:59.738 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:01.689 T:2519012208 DEBUG: Previous line repeats 46 times. 2020-03-25 12:27:01.689 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=822114-871166' 2020-03-25 12:27:01.689 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:01.689 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:01.702 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:01.741 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 2630836.43byte/s, current speed: 961823.00byte/s 2020-03-25 12:27:01.758 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:03.665 T:2519012208 DEBUG: Previous line repeats 46 times. 2020-03-25 12:27:03.666 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=871167-919443' 2020-03-25 12:27:03.666 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:03.666 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:03.715 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 2555072.47byte/s, current speed: 985244.00byte/s 2020-03-25 12:27:03.722 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:03.724 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=4474540-4710904' 2020-03-25 12:27:03.724 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:03.724 T:2552583024 DEBUG: CurlFile::Open(0x94507450) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 2020-03-25 12:27:03.761 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:03.822 T:2552583024 DEBUG: Previous line repeats 1 times. 2020-03-25 12:27:03.822 T:2552583024 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 finished, avg speed: 2528401.23byte/s, current speed: 2436752.00byte/s 2020-03-25 12:27:03.845 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:05.705 T:2519012208 DEBUG: Previous line repeats 44 times. 2020-03-25 12:27:05.705 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=919444-968496' 2020-03-25 12:27:05.705 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:05.705 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:05.730 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:05.756 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 2455115.79byte/s, current speed: 961823.00byte/s 2020-03-25 12:27:05.794 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:06.696 T:3011338256 DEBUG: Previous line repeats 22 times. 2020-03-25 12:27:06.696 T:3011338256 INFO: CheckIdle - Closing session to https://atv-ps-eu.amazon.de (easy=0xb196bbd8, multi=0xb1972210) 2020-03-25 12:27:06.740 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:06.741 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=4710905-5496692' 2020-03-25 12:27:06.741 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:06.741 T:2552583024 DEBUG: CurlFile::Open(0x94507450) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 2020-03-25 12:27:06.767 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:06.992 T:2552583024 DEBUG: Previous line repeats 5 times. 2020-03-25 12:27:06.992 T:2552583024 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 finished, avg speed: 2961335.82byte/s, current speed: 3130629.00byte/s 2020-03-25 12:27:07.014 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:07.683 T:2519012208 DEBUG: Previous line repeats 15 times. 2020-03-25 12:27:07.683 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=968497-1016773' 2020-03-25 12:27:07.683 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:07.683 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:07.694 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:07.736 T:3011338256 DEBUG: Previous line repeats 1 times. 2020-03-25 12:27:07.736 T:3011338256 INFO: CheckIdle - Closing session to http://127.0.0.1 (easy=0xb19525e8, multi=0xb1957690) 2020-03-25 12:27:07.738 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 2866155.40byte/s, current speed: 894018.00byte/s 2020-03-25 12:27:07.761 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:09.536 T:3011338256 DEBUG: Previous line repeats 42 times. 2020-03-25 12:27:09.541 T:3011338256 DEBUG: Keyboard: scancode: 0x1d, sym: 0x0132, unicode: 0x0000, modifier: 0xc0 2020-03-25 12:27:09.541 T:3011338256 DEBUG: HandleKey: ctrl-leftctrl (0x1f0d0) pressed, action is 2020-03-25 12:27:09.551 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:09.705 T:2519012208 DEBUG: Previous line repeats 3 times. 2020-03-25 12:27:09.705 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=1016774-1065826' 2020-03-25 12:27:09.705 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:09.705 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:09.729 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:09.871 T:2519012208 DEBUG: Previous line repeats 3 times. 2020-03-25 12:27:09.871 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 2745982.37byte/s, current speed: 297290.00byte/s 2020-03-25 12:27:09.885 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:11.116 T:3001021296 DEBUG: Previous line repeats 28 times. 2020-03-25 12:27:11.116 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:27:11.116 T:2569122672 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:27:11.126 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:11.136 T:3011338256 DEBUG: Keyboard: scancode: 0x1f, sym: 0x0073, unicode: 0x0013, modifier: 0xc0 2020-03-25 12:27:11.136 T:3011338256 DEBUG: HandleKey: ctrl-s (0x1f053) pressed, action is Screenshot 2020-03-25 12:27:11.179 T:3011338256 DEBUG: Saving screenshot /storage/screenshots/screenshot006.png 2020-03-25 12:27:11.183 T:2875597680 DEBUG: cached image '/storage/screenshots/screenshot006.png' size 1280x720 2020-03-25 12:27:11.185 T:3011338256 DEBUG: CMMALRenderer::RenderUpdate - vsync 3136 (+1) 2020-03-25 12:27:11.195 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:11.340 T:2569122672 DEBUG: Previous line repeats 4 times. 2020-03-25 12:27:11.340 T:2569122672 DEBUG: Thread Timer 2569122672 terminating 2020-03-25 12:27:11.341 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:11.356 T:3011338256 DEBUG: Keyboard: scancode: 0x1f, sym: 0x0073, unicode: 0x0013, modifier: 0xc0 2020-03-25 12:27:11.396 T:3011338256 DEBUG: Keyboard: scancode: 0x1d, sym: 0x0132, unicode: 0x0000, modifier: 0x0 2020-03-25 12:27:11.406 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:11.686 T:2519012208 DEBUG: Previous line repeats 7 times. 2020-03-25 12:27:11.686 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=1065827-1114103' 2020-03-25 12:27:11.686 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:11.686 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:11.733 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:11.982 T:2552583024 DEBUG: Previous line repeats 6 times. 2020-03-25 12:27:11.982 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=5496693-6487781' 2020-03-25 12:27:11.982 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:11.982 T:2552583024 DEBUG: CurlFile::Open(0x94507450) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 2020-03-25 12:27:11.983 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 2627039.67byte/s, current speed: 162548.00byte/s 2020-03-25 12:27:12.024 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:12.444 T:2552583024 DEBUG: Previous line repeats 10 times. 2020-03-25 12:27:12.444 T:2552583024 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 finished, avg speed: 2176027.46byte/s, current speed: 2149867.00byte/s 2020-03-25 12:27:12.458 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:13.703 T:2519012208 DEBUG: Previous line repeats 29 times. 2020-03-25 12:27:13.703 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=1114104-1163156' 2020-03-25 12:27:13.703 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:13.703 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:13.736 T:3011338256 DEBUG: Keyboard: scancode: 0x1d, sym: 0x0132, unicode: 0x0000, modifier: 0xc0 2020-03-25 12:27:13.736 T:3011338256 DEBUG: HandleKey: ctrl-leftctrl (0x1f0d0) pressed, action is 2020-03-25 12:27:13.738 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:13.754 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 2120126.18byte/s, current speed: 981060.00byte/s 2020-03-25 12:27:13.758 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:14.876 T:3001021296 DEBUG: Previous line repeats 26 times. 2020-03-25 12:27:14.877 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:27:14.877 T:2569122672 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:27:14.878 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:14.896 T:3011338256 DEBUG: Keyboard: scancode: 0x1f, sym: 0x0073, unicode: 0x0013, modifier: 0xc0 2020-03-25 12:27:14.896 T:3011338256 DEBUG: HandleKey: ctrl-s (0x1f053) pressed, action is Screenshot 2020-03-25 12:27:14.937 T:3011338256 DEBUG: Saving screenshot /storage/screenshots/screenshot007.png 2020-03-25 12:27:14.941 T:2867204976 DEBUG: cached image '/storage/screenshots/screenshot007.png' size 1280x720 2020-03-25 12:27:14.945 T:3011338256 DEBUG: CMMALRenderer::RenderUpdate - vsync 3324 (+1) 2020-03-25 12:27:14.947 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:15.109 T:2569122672 DEBUG: Previous line repeats 3 times. 2020-03-25 12:27:15.109 T:2569122672 DEBUG: Thread Timer 2569122672 terminating 2020-03-25 12:27:15.116 T:3011338256 DEBUG: Keyboard: scancode: 0x1f, sym: 0x0073, unicode: 0x0013, modifier: 0xc0 2020-03-25 12:27:15.118 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:15.176 T:3011338256 DEBUG: Previous line repeats 1 times. 2020-03-25 12:27:15.176 T:3011338256 DEBUG: Keyboard: scancode: 0x1d, sym: 0x0132, unicode: 0x0000, modifier: 0x0 2020-03-25 12:27:15.198 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:15.683 T:2519012208 DEBUG: Previous line repeats 12 times. 2020-03-25 12:27:15.683 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=1163157-1211433' 2020-03-25 12:27:15.683 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:15.683 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:15.720 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:15.738 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 2064452.11byte/s, current speed: 910886.00byte/s 2020-03-25 12:27:15.758 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:16.710 T:2552583024 DEBUG: Previous line repeats 22 times. 2020-03-25 12:27:16.710 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=6487782-7006952' 2020-03-25 12:27:16.710 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:16.710 T:2552583024 DEBUG: CurlFile::Open(0x94507450) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 2020-03-25 12:27:16.802 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:16.883 T:2552583024 DEBUG: Previous line repeats 3 times. 2020-03-25 12:27:16.883 T:2552583024 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 finished, avg speed: 2536788.66byte/s, current speed: 3018436.00byte/s 2020-03-25 12:27:16.898 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:17.685 T:2519012208 DEBUG: Previous line repeats 18 times. 2020-03-25 12:27:17.685 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=1211434-1260486' 2020-03-25 12:27:17.685 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:17.685 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:17.710 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:17.735 T:2519012208 DEBUG: Previous line repeats 1 times. 2020-03-25 12:27:17.735 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 2464947.36byte/s, current speed: 1001081.00byte/s 2020-03-25 12:27:17.761 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:19.686 T:2519012208 DEBUG: Previous line repeats 46 times. 2020-03-25 12:27:19.686 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=1260487-1308763' 2020-03-25 12:27:19.686 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:19.686 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:19.771 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 2377609.23byte/s, current speed: 567964.00byte/s 2020-03-25 12:27:19.799 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:21.665 T:2519012208 DEBUG: Previous line repeats 46 times. 2020-03-25 12:27:21.665 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=1308764-1357816' 2020-03-25 12:27:21.665 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:21.665 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:21.707 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:21.767 T:2519012208 DEBUG: Previous line repeats 1 times. 2020-03-25 12:27:21.767 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 2289330.56byte/s, current speed: 490530.00byte/s 2020-03-25 12:27:21.768 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=7006953-7684415' 2020-03-25 12:27:21.768 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:21.768 T:2552583024 DEBUG: CurlFile::Open(0x94507450) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 2020-03-25 12:27:21.778 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:22.271 T:2552583024 DEBUG: Previous line repeats 11 times. 2020-03-25 12:27:22.271 T:2552583024 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 finished, avg speed: 1680409.72byte/s, current speed: 1346844.00byte/s 2020-03-25 12:27:22.279 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:23.704 T:2519012208 DEBUG: Previous line repeats 34 times. 2020-03-25 12:27:23.704 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=1357817-1406093' 2020-03-25 12:27:23.704 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:23.704 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:23.756 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1646625.05byte/s, current speed: 946607.00byte/s 2020-03-25 12:27:23.759 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:25.666 T:2519012208 DEBUG: Previous line repeats 46 times. 2020-03-25 12:27:25.666 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=1406094-1455146' 2020-03-25 12:27:25.666 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:25.666 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:25.721 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:25.722 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1611317.26byte/s, current speed: 891872.00byte/s 2020-03-25 12:27:25.766 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:26.708 T:2552583024 DEBUG: Previous line repeats 23 times. 2020-03-25 12:27:26.709 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=7684416-7812530' 2020-03-25 12:27:26.714 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:26.715 T:2552583024 DEBUG: CurlFile::Open(0x94507450) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 2020-03-25 12:27:26.742 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:26.785 T:2552583024 DEBUG: Previous line repeats 1 times. 2020-03-25 12:27:26.785 T:2552583024 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 finished, avg speed: 1638062.06byte/s, current speed: 1830214.00byte/s 2020-03-25 12:27:26.820 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:27.722 T:2519012208 DEBUG: Previous line repeats 21 times. 2020-03-25 12:27:27.722 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=1455147-1503423' 2020-03-25 12:27:27.722 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:27.722 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:27.762 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:27.768 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1612038.11byte/s, current speed: 1072822.00byte/s 2020-03-25 12:27:27.781 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:29.536 T:2552583024 DEBUG: Previous line repeats 42 times. 2020-03-25 12:27:29.536 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=7812531-7827871' 2020-03-25 12:27:29.536 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:29.537 T:2552583024 DEBUG: CurlFile::Open(0x94507450) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 2020-03-25 12:27:29.582 T:2552583024 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 finished, avg speed: 1593441.12byte/s, current speed: 340911.00byte/s 2020-03-25 12:27:29.599 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:29.665 T:2519012208 DEBUG: Previous line repeats 2 times. 2020-03-25 12:27:29.665 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=1503424-1552476' 2020-03-25 12:27:29.665 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:29.666 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:29.704 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:29.710 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1571051.87byte/s, current speed: 1114840.00byte/s 2020-03-25 12:27:29.739 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:31.723 T:2519012208 DEBUG: Previous line repeats 46 times. 2020-03-25 12:27:31.724 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=1552477-1600753' 2020-03-25 12:27:31.724 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:31.724 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:31.724 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:31.762 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:31.817 T:2519012208 DEBUG: Previous line repeats 1 times. 2020-03-25 12:27:31.817 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1522879.58byte/s, current speed: 524750.00byte/s 2020-03-25 12:27:31.819 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:33.662 T:2519012208 DEBUG: Previous line repeats 44 times. 2020-03-25 12:27:33.662 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=1600754-1649806' 2020-03-25 12:27:33.662 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:33.662 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:33.699 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:33.746 T:2519012208 DEBUG: Previous line repeats 1 times. 2020-03-25 12:27:33.746 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1478956.56byte/s, current speed: 583964.00byte/s 2020-03-25 12:27:33.780 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:34.549 T:2552583024 DEBUG: Previous line repeats 18 times. 2020-03-25 12:27:34.550 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=7827872-7842534' 2020-03-25 12:27:34.550 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:34.550 T:2552583024 DEBUG: CurlFile::Open(0x94507450) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 2020-03-25 12:27:34.600 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:34.600 T:2552583024 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 finished, avg speed: 1462459.78byte/s, current speed: 299244.00byte/s 2020-03-25 12:27:34.639 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:35.728 T:2519012208 DEBUG: Previous line repeats 26 times. 2020-03-25 12:27:35.728 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=1649807-1698083' 2020-03-25 12:27:35.728 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:35.728 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:35.759 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:35.819 T:2519012208 DEBUG: Previous line repeats 1 times. 2020-03-25 12:27:35.819 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1419824.00byte/s, current speed: 536411.00byte/s 2020-03-25 12:27:35.840 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:35.916 T:3011338256 DEBUG: Previous line repeats 1 times. 2020-03-25 12:27:35.916 T:3011338256 DEBUG: Keyboard: scancode: 0x1d, sym: 0x0132, unicode: 0x0000, modifier: 0xc0 2020-03-25 12:27:35.916 T:3011338256 DEBUG: HandleKey: ctrl-leftctrl (0x1f0d0) pressed, action is 2020-03-25 12:27:35.919 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:36.472 T:3001021296 DEBUG: Previous line repeats 12 times. 2020-03-25 12:27:36.472 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:27:36.472 T:2569122672 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:27:36.476 T:3011338256 DEBUG: Keyboard: scancode: 0x1f, sym: 0x0073, unicode: 0x0013, modifier: 0xc0 2020-03-25 12:27:36.476 T:3011338256 DEBUG: HandleKey: ctrl-s (0x1f053) pressed, action is Screenshot 2020-03-25 12:27:36.561 T:3011338256 DEBUG: Saving screenshot /storage/screenshots/screenshot008.png 2020-03-25 12:27:36.566 T:2641335152 DEBUG: cached image '/storage/screenshots/screenshot008.png' size 1280x720 2020-03-25 12:27:36.568 T:3011338256 DEBUG: CMMALRenderer::RenderUpdate - vsync 4402 (+4) 2020-03-25 12:27:36.571 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:36.601 T:3011338256 DEBUG: Previous line repeats 2 times. 2020-03-25 12:27:36.601 T:3011338256 DEBUG: CMMALRenderer::RenderUpdate - vsync 4407 (+1) 2020-03-25 12:27:36.607 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:36.664 T:2569122672 DEBUG: Previous line repeats 2 times. 2020-03-25 12:27:36.664 T:2569122672 DEBUG: Thread Timer 2569122672 terminating 2020-03-25 12:27:36.676 T:3011338256 DEBUG: Keyboard: scancode: 0x1f, sym: 0x0073, unicode: 0x0013, modifier: 0xc0 2020-03-25 12:27:36.699 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:37.096 T:3011338256 DEBUG: Previous line repeats 8 times. 2020-03-25 12:27:37.096 T:3011338256 DEBUG: Keyboard: scancode: 0x1d, sym: 0x0132, unicode: 0x0000, modifier: 0x0 2020-03-25 12:27:37.098 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:37.663 T:2519012208 DEBUG: Previous line repeats 14 times. 2020-03-25 12:27:37.663 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=1698084-1747136' 2020-03-25 12:27:37.663 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:37.664 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:37.699 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:37.757 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1378078.26byte/s, current speed: 527451.00byte/s 2020-03-25 12:27:37.759 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:38.985 T:2552583024 DEBUG: Previous line repeats 29 times. 2020-03-25 12:27:38.985 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=7842535-7852496' 2020-03-25 12:27:38.985 T:2552583024 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:38.985 T:2552583024 DEBUG: CurlFile::Open(0x94507450) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 2020-03-25 12:27:39.020 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:39.030 T:2552583024 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_video_10.mp4 finished, avg speed: 1367136.83byte/s, current speed: 226409.00byte/s 2020-03-25 12:27:39.040 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:39.681 T:2519012208 DEBUG: Previous line repeats 15 times. 2020-03-25 12:27:39.681 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'Range: bytes=1747137-1795413' 2020-03-25 12:27:39.681 T:2519012208 DEBUG: CurlFile::ParseAndCorrectUrl() adding custom header option 'connection: keep-alive' 2020-03-25 12:27:39.682 T:2519012208 DEBUG: CurlFile::Open(0x9b550638) https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 2020-03-25 12:27:39.719 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:39.758 T:2519012208 DEBUG: AddOnLog: InputStream Adaptive: Download https://s3-dub-2.cf.dash.row.aiv-cdn.net/dm/2$YSdY1TkveuR6jDwNlGb4A_4iuP4/ee14/0190/b184/4a73-80a8-aa51b5617156/d5e9192b-bc82-4796-8fc4-b23682983b4f_audio_38.mp4 finished, avg speed: 1333829.09byte/s, current speed: 643693.00byte/s 2020-03-25 12:27:39.758 T:2649727856 DEBUG: CMMALPool::Configure pool:0x9adb21a0 720x576 (784x576) pix:-1 size:0 fmt:I42S 2020-03-25 12:27:40.568 T:3001021296 DEBUG: Previous line repeats 19 times. 2020-03-25 12:27:40.569 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-03-25 12:27:40.569 T:2569122672 DEBUG: Thread Timer start, auto delete: false 2020-03-25 12:27:40.576 T:3011338256 DEBUG: Keyboard: scancode: 0x2d, sym: 0x0078, unicode: 0x0078, modifier: 0x0 2020-03-25 12:27:40.576 T:3011338256 DEBUG: HandleKey: x (0xf058) pressed, action is Stop 2020-03-25 12:27:40.576 T:3011338256 NOTICE: CVideoPlayer::CloseFile() 2020-03-25 12:27:40.576 T:3011338256 DEBUG: DeleteRenderer - deleting renderer 2020-03-25 12:27:40.576 T:3011338256 DEBUG: CMMALRenderer::~CMMALRenderer 2020-03-25 12:27:40.576 T:3011338256 DEBUG: CMMALRenderer::UnInitMMAL 2020-03-25 12:27:40.579 T:2577515376 NOTICE: CVideoPlayer::OnExit() 2020-03-25 12:27:40.580 T:2577515376 NOTICE: Closing stream player 1 2020-03-25 12:27:40.580 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(1002: false) 2020-03-25 12:27:40.582 T:2510619504 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true 2020-03-25 12:27:40.582 T:2577515376 NOTICE: Waiting for audio thread to exit 2020-03-25 12:27:40.582 T:2510619504 NOTICE: thread end: CVideoPlayerAudio::OnExit() 2020-03-25 12:27:40.582 T:2510619504 DEBUG: Thread VideoPlayerAudio 2510619504 terminating 2020-03-25 12:27:40.582 T:2577515376 NOTICE: Closing audio device 2020-03-25 12:27:40.632 T:2577515376 DEBUG: CDVDAudio::Flush - flush audio stream 2020-03-25 12:27:40.632 T:2988688240 DEBUG: CActiveAE::DiscardStream - audio stream deleted 2020-03-25 12:27:40.633 T:2988688240 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2020-03-25 12:27:40.635 T:2979001200 DEBUG: Previous line repeats 2 times. 2020-03-25 12:27:40.635 T:2979001200 INFO: CActiveAESink::OpenSink - initialize sink 2020-03-25 12:27:40.635 T:2577515376 NOTICE: Deleting audio codec 2020-03-25 12:27:40.635 T:2577515376 NOTICE: Closing stream player 2 2020-03-25 12:27:40.635 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: EnableStream(1001: false) 2020-03-25 12:27:40.636 T:2479002480 DEBUG: CMMALRenderer::Process - stopping 2020-03-25 12:27:40.636 T:2479002480 DEBUG: Thread MMALRenderer 2479002480 terminating 2020-03-25 12:27:40.636 T:2577515376 NOTICE: waiting for video thread to exit 2020-03-25 12:27:40.659 T:2498753392 DEBUG: CMMALRenderer::Run - stopping 2020-03-25 12:27:40.659 T:2498753392 DEBUG: Thread MMALProcess 2498753392 terminating 2020-03-25 12:27:40.659 T:3011338256 NOTICE: VideoPlayer: waiting for threads to exit 2020-03-25 12:27:40.665 T:2649727856 NOTICE: thread end: video_thread 2020-03-25 12:27:40.665 T:2649727856 DEBUG: Thread VideoPlayerVideo 2649727856 terminating 2020-03-25 12:27:40.666 T:2577515376 NOTICE: deleting video codec 2020-03-25 12:27:40.666 T:2577515376 DEBUG: CAddonVideoCodec: Reset 2020-03-25 12:27:40.697 T:2569122672 DEBUG: Thread Timer 2569122672 terminating 2020-03-25 12:27:40.731 T:2979001200 DEBUG: CAESinkPi:Drain delay:96ms now:0ms 2020-03-25 12:27:40.731 T:2979001200 DEBUG: CAESinkPi:Deinitialize 2020-03-25 12:27:40.732 T:2979001200 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 2020-03-25 12:27:40.740 T:2979001200 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0xb0f94630 2020-03-25 12:27:40.740 T:2979001200 DEBUG: CActiveAESink::OpenSink - trying to open device SinkPi:Default 2020-03-25 12:27:40.740 T:2979001200 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 2020-03-25 12:27:40.740 T:2979001200 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=Default 2020-03-25 12:27:40.741 T:2979001200 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 2020-03-25 12:27:40.743 T:2979001200 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0xb0f2f108 2020-03-25 12:27:40.746 T:2979001200 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignment(16) 2020-03-25 12:27:40.746 T:2979001200 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 2020-03-25 12:27:40.746 T:2979001200 DEBUG: Output Device : HDMI 2020-03-25 12:27:40.746 T:2979001200 DEBUG: Sample Rate : 44100 2020-03-25 12:27:40.746 T:2979001200 DEBUG: Sample Format : AE_FMT_FLOAT 2020-03-25 12:27:40.747 T:2979001200 DEBUG: Channel Count : 2 2020-03-25 12:27:40.747 T:2979001200 DEBUG: Channel Layout: FL, FR 2020-03-25 12:27:40.747 T:2979001200 DEBUG: Frames : 2205 2020-03-25 12:27:40.747 T:2979001200 DEBUG: Frame Size : 8 2020-03-25 12:27:40.751 T:2988688240 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2020-03-25 12:27:41.003 T:2577515376 DEBUG: Previous line repeats 1 times. 2020-03-25 12:27:41.003 T:2577515376 NOTICE: Closing stream player 3 2020-03-25 12:27:41.004 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Close() 2020-03-25 12:27:41.004 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: Session::~Session() 2020-03-25 12:27:41.010 T:2875597680 DEBUG: DoWork - Saving file state for video item plugin://plugin.video.amazon-test/?asin=B01N5AYAJM&mode=PlayVideo&adult=0&name=Arrival&trailer=0&selbitrate=0 2020-03-25 12:27:41.021 T:2577515376 DEBUG: AddOnLog: InputStream Adaptive: CDMMessage: 4 arrived! 2020-03-25 12:27:41.034 T:2577515376 DEBUG: SECTION:UnloadDll(/storage/.kodi/addons/inputstream.adaptive/inputstream.adaptive.so.2.4.3) 2020-03-25 12:27:41.034 T:2577515376 INFO: ADDON: Dll Destroyed - InputStream Adaptive 2020-03-25 12:27:41.034 T:2577515376 DEBUG: Thread VideoPlayer 2577515376 terminating 2020-03-25 12:27:41.034 T:3011338256 NOTICE: VideoPlayer: finished waiting 2020-03-25 12:27:41.034 T:3011338256 NOTICE: CVideoPlayer::CloseFile() 2020-03-25 12:27:41.034 T:3011338256 NOTICE: VideoPlayer: waiting for threads to exit 2020-03-25 12:27:41.034 T:3011338256 NOTICE: VideoPlayer: finished waiting 2020-03-25 12:27:41.036 T:3011338256 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 2020-03-25 12:27:41.066 T:2858812272 DEBUG: OnPlayBackStopped: CApplication::OnPlayBackStopped 2020-03-25 12:27:41.076 T:3011338256 DEBUG: CMMALPool::~CMMALPool Destroying pool 0x9adb21a0 for port vc.ril.video_decode:out:0(I420) 2020-03-25 12:27:41.079 T:3011338256 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 2020-03-25 12:27:41.079 T:3011338256 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 2020-03-25 12:27:41.086 T:3011338256 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 2020-03-25 12:27:41.086 T:3011338256 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 2020-03-25 12:27:41.089 T:3011338256 ERROR: Control 50 in window 10025 has been asked to focus, but it can't 2020-03-25 12:27:41.089 T:3011338256 DEBUG: Keyboard: scancode: 0x2d, sym: 0x0078, unicode: 0x0078, modifier: 0x0 2020-03-25 12:27:41.404 T:3011338256 DEBUG: CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 61 2020-03-25 12:27:41.419 T:3011338256 DEBUG: CGUIMediaWindow::GetDirectory (plugin://plugin.video.amazon-test/?cat=Browse&mode=Recent&opt&page=1&url) 2020-03-25 12:27:41.419 T:3011338256 DEBUG: ParentPath = [plugin://plugin.video.amazon-test/?cat=Browse&mode=Recent&opt&page=1&url] 2020-03-25 12:27:41.420 T:2527404912 DEBUG: Thread waiting start, auto delete: false 2020-03-25 12:27:41.430 T:2867204976 DEBUG: CAddonDatabase::SetLastUsed[plugin.video.amazon-test] took 12 ms 2020-03-25 12:27:41.431 T:2527404912 DEBUG: StartScript - calling plugin Amazon VOD('plugin://plugin.video.amazon-test/','2','?cat=Browse&mode=Recent&opt&page=1&url','resume:false') 2020-03-25 12:27:41.431 T:2577515376 DEBUG: Thread LanguageInvoker start, auto delete: false 2020-03-25 12:27:41.431 T:2577515376 INFO: initializing python engine. 2020-03-25 12:27:41.431 T:2577515376 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.amazon-test/default.py): start processing 2020-03-25 12:27:41.447 T:2577515376 DEBUG: -->Python Interpreter Initialized<-- 2020-03-25 12:27:41.447 T:2577515376 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.amazon-test/default.py): the source file to load is "/storage/.kodi/addons/plugin.video.amazon-test/default.py" 2020-03-25 12:27:41.449 T:2577515376 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.amazon-test/default.py): setting the Python path to /storage/.kodi/addons/plugin.video.amazon-test:/storage/.kodi/addons/script.module.beautifulsoup4/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.inputstreamhelper/lib:/storage/.kodi/addons/script.module.kodi-six/libs:/storage/.kodi/addons/script.module.mechanicalsoup/lib:/storage/.kodi/addons/script.module.pydes/lib:/storage/.kodi/addons/script.module.pyxbmct/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 2020-03-25 12:27:41.449 T:2577515376 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.amazon-test/default.py): entering source directory /storage/.kodi/addons/plugin.video.amazon-test 2020-03-25 12:27:41.449 T:2577515376 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.amazon-test/default.py): instantiating addon using automatically obtained id of "plugin.video.amazon-test" dependent on version 2.24.0 of the xbmc.python api 2020-03-25 12:27:41.520 T:3011338256 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2020-03-25 12:27:41.538 T:3011338256 DEBUG: CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 60 2020-03-25 12:27:42.183 T:2577515376 DEBUG: CAddonSettings[plugin.video.amazon-test]: loading setting definitions 2020-03-25 12:27:42.183 T:2577515376 DEBUG: CAddonSettings[plugin.video.amazon-test]: trying to load setting definitions from old format... 2020-03-25 12:27:42.186 T:2577515376 DEBUG: CAddonSettings[plugin.video.amazon-test]: loading setting values 2020-03-25 12:27:42.188 T:2625565552 NOTICE: [Amazon VOD] postURL: https://atv-ps-eu.amazon.de/cdp/usage/UpdateStream?asin=B01N5AYAJM&deviceTypeID=AOAGZA014O5RE&firmware=1&deviceID=fbbe44a507076598cf92e2ecff09f45b136ef438b4988099467b3aef&marketplaceID=A1PA6795UKMFR9&format=json&version=1&gascEnabled=false&subtitleFormat=TTMLv2&event=STOP&timecode=61.4340019226 2020-03-25 12:27:42.270 T:2577515376 DEBUG: [Amazon VOD] Requested {'page': '1', 'mode': 'Recent', 'cat': 'Browse'} 2020-03-25 12:27:42.286 T:2577515376 NOTICE: [Amazon VOD] getURL: https://atv-ps-eu.amazon.de/cdp/catalog/GetASINDetails?firmware=fmw:26-app:3.0.265.20347&deviceTypeID=A43PXU4ZN2AL1&deviceID=fbbe44a507076598cf92e2ecff09f45b136ef438b4988099467b3aef&format=json&version=2&formatVersion=3&marketplaceId=A1PA6795UKMFR9&IncludeAll=T&AID=1&asinlist=B01N0MF27Z&NumberOfResults=40&StartIndex=0&Detailed=T 2020-03-25 12:27:42.312 T:2625565552 NOTICE: [Amazon VOD] postURL: https://atv-ps-eu.amazon.de/cdp/usage/UpdateStream?asin=B01N5AYAJM&deviceTypeID=AOAGZA014O5RE&firmware=1&deviceID=fbbe44a507076598cf92e2ecff09f45b136ef438b4988099467b3aef&marketplaceID=A1PA6795UKMFR9&format=json&version=1&gascEnabled=false&subtitleFormat=TTMLv2&event=STOP&timecode=61.4340019226 2020-03-25 12:27:42.417 T:2625565552 INFO: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): script successfully run 2020-03-25 12:27:42.417 T:2625565552 DEBUG: onExecutionDone(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py) 2020-03-25 12:27:42.493 T:2625565552 WARNING: CPythonInvoker(2, /storage/.kodi/addons/plugin.video.amazon-test/default.py): the python script "/storage/.kodi/addons/plugin.video.amazon-test/default.py" has left several classes in memory that we couldn't clean up. The classes include: N9XBMCAddon9xbmcaddon5AddonE,N9XBMCAddon7xbmcgui6DialogE,N14PythonBindings31XBMCAddon_xbmc_Monitor_DirectorE 2020-03-25 12:27:42.494 T:2625565552 INFO: Python interpreter stopped 2020-03-25 12:27:42.494 T:2625565552 INFO: Previous line repeats 3 times. 2020-03-25 12:27:42.494 T:2625565552 DEBUG: Thread LanguageInvoker 2625565552 terminating 2020-03-25 12:27:42.577 T:3011338256 INFO: CheckIdle - Closing session to https://s3-dub-2.cf.dash.row.aiv-cdn.net (easy=0x9b54f288, multi=0x9b565160) 2020-03-25 12:27:42.897 T:2577515376 INFO: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.amazon-test/default.py): script successfully run 2020-03-25 12:27:42.898 T:2527404912 DEBUG: Thread waiting 2527404912 terminating 2020-03-25 12:27:42.916 T:3011338256 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2020-03-25 12:27:42.916 T:3011338256 DEBUG: Saving fileitems [plugin://plugin.video.amazon-test/?cat=Browse&mode=Recent&opt&page=1&url] 2020-03-25 12:27:42.916 T:3011338256 DEBUG: -- items: 1, sort method: 0, ascending: false 2020-03-25 12:27:42.921 T:2527404912 DEBUG: Thread BackgroundLoader start, auto delete: false 2020-03-25 12:27:42.926 T:3011338256 DEBUG: RunScriptWithParams - calling plugin Amazon VOD('plugin://plugin.video.amazon-test/','-1','?mode=checkMissing','resume:false') 2020-03-25 12:27:42.926 T:3011338256 DEBUG: GetLanguageInvoker - Reusing LanguageInvokerThread 3 for script /storage/.kodi/addons/plugin.video.amazon-test/default.py 2020-03-25 12:27:42.926 T:2577515376 INFO: initializing python engine. 2020-03-25 12:27:42.926 T:2577515376 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.amazon-test/default.py): start processing 2020-03-25 12:27:42.926 T:2577515376 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.amazon-test/default.py): entering source directory /storage/.kodi/addons/plugin.video.amazon-test 2020-03-25 12:27:42.926 T:2577515376 DEBUG: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.amazon-test/default.py): instantiating addon using automatically obtained id of "plugin.video.amazon-test" dependent on version 2.24.0 of the xbmc.python api 2020-03-25 12:27:42.928 T:2577515376 DEBUG: [Amazon VOD] Requested {'mode': 'checkMissing'} 2020-03-25 12:27:42.937 T:2858812272 DEBUG: ffmpeg[AA660370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2020-03-25 12:27:42.938 T:2577515376 NOTICE: [Amazon VOD] Starting Fanart Update 2020-03-25 12:27:42.941 T:2527404912 DEBUG: Thread BackgroundLoader 2527404912 terminating 2020-03-25 12:27:42.950 T:2641335152 DEBUG: ffmpeg[9D6F9370]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2020-03-25 12:27:42.972 T:2577515376 NOTICE: [Amazon VOD] Finished Fanart Update 2020-03-25 12:27:42.972 T:2577515376 INFO: CPythonInvoker(3, /storage/.kodi/addons/plugin.video.amazon-test/default.py): script successfully run