00:35:41.362 T:1945327264 NOTICE: special://profile/ is mapped to: special://masterprofile/ 00:35:41.362 T:1945327264 NOTICE: ----------------------------------------------------------------------- 00:35:41.362 T:1945327264 NOTICE: Starting Kodi (17.6 Git:a9a7a20). Platform: Linux ARM 32-bit 00:35:41.362 T:1945327264 NOTICE: Using Release Kodi x32 build (version for Raspberry Pi) 00:35:41.362 T:1945327264 NOTICE: Kodi compiled Apr 13 2018 by GCC 6.2.0 for Linux ARM 32-bit version 4.9.80 (264528) 00:35:41.362 T:1945327264 NOTICE: Running on LibreELEC (official): 8.2.5, kernel: Linux ARM 32-bit version 4.9.80 00:35:41.362 T:1945327264 NOTICE: FFmpeg version/source: ffmpeg-3.1-kodi 00:35:41.362 T:1945327264 NOTICE: Host CPU: ARMv7 Processor rev 4 (v7l), 4 cores available 00:35:41.362 T:1945327264 NOTICE: ARM Features: Neon enabled 00:35:41.362 T:1945327264 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi/ 00:35:41.362 T:1945327264 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi 00:35:41.362 T:1945327264 NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons 00:35:41.362 T:1945327264 NOTICE: special://masterprofile/ is mapped to: /storage/.kodi/userdata 00:35:41.362 T:1945327264 NOTICE: special://envhome/ is mapped to: /storage 00:35:41.362 T:1945327264 NOTICE: special://home/ is mapped to: /storage/.kodi 00:35:41.362 T:1945327264 NOTICE: special://temp/ is mapped to: /storage/.kodi/temp 00:35:41.362 T:1945327264 NOTICE: special://logpath/ is mapped to: /storage/.kodi/temp 00:35:41.362 T:1945327264 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin 00:35:41.363 T:1945327264 NOTICE: Local hostname: LibreELEC-S 00:35:41.363 T:1945327264 NOTICE: Log File is located: /storage/.kodi/temp//kodi.log 00:35:41.363 T:1945327264 NOTICE: ----------------------------------------------------------------------- 00:35:41.386 T:1945327264 ERROR: DBus: Error org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files 00:35:41.394 T:1945327264 NOTICE: load settings... 00:35:41.490 T:1945327264 NOTICE: Found 2 Lists of Devices 00:35:41.490 T:1945327264 NOTICE: Enumerated PI devices: 00:35:41.490 T:1945327264 NOTICE: Device 1 00:35:41.490 T:1945327264 NOTICE: m_deviceName : HDMI 00:35:41.490 T:1945327264 NOTICE: m_displayName : HDMI 00:35:41.490 T:1945327264 NOTICE: m_displayNameExtra: 00:35:41.490 T:1945327264 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 00:35:41.490 T:1945327264 NOTICE: m_channels : FL,FR 00:35:41.490 T:1945327264 NOTICE: m_sampleRates : 8000,11025,16000,22050,24000,32000,44100,48000,88200,96000,176400,192000 00:35:41.490 T:1945327264 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 00:35:41.490 T:1945327264 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 00:35:41.490 T:1945327264 NOTICE: Device 2 00:35:41.490 T:1945327264 NOTICE: m_deviceName : Analogue 00:35:41.490 T:1945327264 NOTICE: m_displayName : Analogue 00:35:41.490 T:1945327264 NOTICE: m_displayNameExtra: 00:35:41.491 T:1945327264 NOTICE: m_deviceType : AE_DEVTYPE_PCM 00:35:41.491 T:1945327264 NOTICE: m_channels : FL,FR 00:35:41.491 T:1945327264 NOTICE: m_sampleRates : 48000 00:35:41.491 T:1945327264 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 00:35:41.491 T:1945327264 NOTICE: m_streamTypes : No passthrough capabilities 00:35:41.491 T:1945327264 NOTICE: Device 3 00:35:41.491 T:1945327264 NOTICE: m_deviceName : Both 00:35:41.491 T:1945327264 NOTICE: m_displayName : HDMI and Analogue 00:35:41.491 T:1945327264 NOTICE: m_displayNameExtra: 00:35:41.491 T:1945327264 NOTICE: m_deviceType : AE_DEVTYPE_PCM 00:35:41.491 T:1945327264 NOTICE: m_channels : FL,FR 00:35:41.491 T:1945327264 NOTICE: m_sampleRates : 48000 00:35:41.491 T:1945327264 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 00:35:41.491 T:1945327264 NOTICE: m_streamTypes : No passthrough capabilities 00:35:41.491 T:1945327264 NOTICE: Enumerated PULSE devices: 00:35:41.491 T:1945327264 NOTICE: Device 1 00:35:41.491 T:1945327264 NOTICE: m_deviceName : Default 00:35:41.491 T:1945327264 NOTICE: m_displayName : Default 00:35:41.491 T:1945327264 NOTICE: m_displayNameExtra: Bluetooth Audio (PULSEAUDIO) 00:35:41.491 T:1945327264 NOTICE: m_deviceType : AE_DEVTYPE_PCM 00:35:41.491 T:1945327264 NOTICE: m_channels : FL,FR 00:35:41.491 T:1945327264 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000 00:35:41.491 T:1945327264 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT 00:35:41.491 T:1945327264 NOTICE: m_streamTypes : No passthrough capabilities 00:35:41.508 T:1945327264 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml 00:35:41.508 T:1945327264 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are... false 1 720 540 30 00:35:41.510 T:1945327264 NOTICE: Loaded settings file from special://profile/advancedsettings.xml 00:35:41.510 T:1945327264 NOTICE: Contents of special://profile/advancedsettings.xml are... 1 104857600 10 mysql 192.168.1.146 3306 kodi ***** mysql 192.168.1.146 3306 kodi ***** sed -e 's/\([0-9]*\)[0-9]\{3\}.*/\1 C/' /sys/class/thermal/thermal_zone0/temp /opt/vc/bin/vcgencmd measure_temp | sed -e "s/temp=//" -e "s/\..*'/ /" 00:35:41.510 T:1945327264 WARNING: VIDEO database configuration is experimental. 00:35:41.512 T:1945327264 NOTICE: Default Video Player: VideoPlayer 00:35:41.512 T:1945327264 NOTICE: Default Audio Player: paplayer 00:35:41.512 T:1945327264 NOTICE: Enabled debug logging due to GUI setting (2) 00:35:41.512 T:1945327264 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 00:35:41.512 T:1945327264 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml 00:35:41.516 T:1945327264 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 00:35:41.517 T:1945327264 DEBUG: CPlayerCoreConfig::: created player VideoPlayer 00:35:41.517 T:1945327264 DEBUG: CPlayerCoreConfig::: created player PAPlayer 00:35:41.517 T:1945327264 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules 00:35:41.517 T:1945327264 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mms/udp 00:35:41.517 T:1945327264 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout 00:35:41.517 T:1945327264 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp 00:35:41.517 T:1945327264 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp 00:35:41.517 T:1945327264 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams 00:35:41.517 T:1945327264 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp 00:35:41.517 T:1945327264 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2 00:35:41.517 T:1945327264 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd 00:35:41.517 T:1945327264 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage 00:35:41.517 T:1945327264 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf 00:35:41.517 T:1945327264 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv 00:35:41.518 T:1945327264 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio 00:35:41.518 T:1945327264 NOTICE: Loaded playercorefactory configuration 00:35:41.518 T:1945327264 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 00:35:41.518 T:1945327264 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 00:35:41.535 T:1945327264 INFO: creating subdirectories 00:35:41.535 T:1945327264 INFO: userdata folder: special://masterprofile/ 00:35:41.535 T:1945327264 INFO: recording folder: 00:35:41.535 T:1945327264 INFO: screenshots folder: 00:35:41.547 T:1945327264 NOTICE: Running database version Addons27 00:35:41.547 T:1945327264 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcpluff-arm.so) 00:35:41.547 T:1945327264 DEBUG: Loading: /usr/lib/kodi/system/libcpluff-arm.so 00:35:41.561 T:1945327264 DEBUG: ADDON: cpluff: 'Suspicious plug-in descriptor content in /storage/.kodi/addons/service.subtitles.subdivx/addon.xml, line 25, column 3 (ignoring unexpected element news and its contents).' 00:35:41.561 T:1945327264 DEBUG: ADDON: cpluff: 'Suspicious plug-in descriptor content in /storage/.kodi/addons/service.subtitles.subdivx/addon.xml, line 27, column 3 (ignoring unexpected element news and its contents).' 00:35:41.602 T:1945327264 INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/kodi/addons: No such file or directory' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in weather.gismeteo has been installed.' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in weather.openweathermap.extended has been installed.' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.autocompletion has been installed.' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.skin.helper.widgets has been installed.' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.games.rom.collection.browser has been installed.' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in service.subtitles.opensubtitles_by_opensubtitles has been installed.' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been installed.' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in resource.images.weathericons.default has been installed.' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.extendedinfo has been installed.' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in xbmc.audioencoder has been installed.' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.openweathermap.maps has been installed.' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in kodi.audiodecoder has been installed.' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.six has been installed.' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.thetvdb has been installed.' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in weather.yahoo has been installed.' 00:35:41.603 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in kodi.peripheral has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in kodi.guilib has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in peripheral.joystick has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in kodi.adsp has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.wma has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.chardet has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in game.controller.default has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in game.libretro.melonds has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.youtube.dl has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.simplejson has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in service.libreelec.settings has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in service.subtitles.supersubtitles has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.idna has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.favourites has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in kodi.game has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in service.subtitles.subscenter has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.urllib3 has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.kodi65 has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in pvr.hdhomerun has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.globalsearch has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in kodi.resource has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.beautifulsoup has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.' 00:35:41.604 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.common.plugin.cache has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.simplecache has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in skin.rapier has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in os.openelec.tv has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.keymap has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in service.nextup.notification has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in repository.kodi.game has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in service.subtitles.subscene has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in metadata.tvshows.themoviedb.org has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in os.libreelec.tv has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.arrow has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.requests has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in kodi.inputstream has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in service.subtitles.opensubtitles has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.certifi has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in repository.libreelec.tv has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in service.subtitles.divxplanet has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in game.controller.nds has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in service.subtitles.subdivx has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.aac has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.routing has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.dateutil has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in resource.language.en_gb has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.future has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.html2text has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in service.rom.collection.browser has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.musicbrainz has been installed.' 00:35:41.605 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in metadata.local has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.skin.helper.service has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in game.libretro has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in xbmc.webinterface has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in resource.images.studios.white has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in resource.uisounds.kodi has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.tv.show.next.aired has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in game.libretro.mame2014 has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.mms has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in xbmc.codec has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.metadatautils has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in skin.estuary has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Plug-in script.module.addon.signals has been installed.' 00:35:41.606 T:1945327264 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.' 00:35:41.651 T:1858073504 DEBUG: Thread JobWorker start, auto delete: true 00:35:41.665 T:1945327264 NOTICE: ADDONS: Using repository repository.kodi.game 00:35:41.665 T:1945327264 NOTICE: ADDONS: Using repository repository.libreelec.tv 00:35:41.665 T:1945327264 NOTICE: ADDONS: Using repository repository.xbmc.org 00:35:41.675 T:1923376032 DEBUG: Thread ActiveAE start, auto delete: false 00:35:41.676 T:1913648032 DEBUG: Thread AESink start, auto delete: false 00:35:41.676 T:1913648032 INFO: CActiveAESink::OpenSink - initialize sink 00:35:41.676 T:1913648032 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 00:35:41.676 T:1913648032 DEBUG: DllBcm: Using omx system library 00:35:41.678 T:1913648032 DEBUG: SECTION:LoadDLL(libopenmaxil.so) 00:35:41.679 T:1913648032 DEBUG: Loading: libopenmaxil.so 00:35:41.683 T:1913648032 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI 00:35:41.683 T:1841296288 DEBUG: Thread CRBPWorker start, auto delete: false 00:35:41.683 T:1913648032 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 00:35:41.684 T:1913648032 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x7170bed0 00:35:41.685 T:1913648032 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignmen(16) 00:35:41.686 T:1913648032 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 00:35:41.686 T:1913648032 DEBUG: Output Device : HDMI 00:35:41.686 T:1913648032 DEBUG: Sample Rate : 44100 00:35:41.686 T:1913648032 DEBUG: Sample Format : AE_FMT_FLOAT 00:35:41.686 T:1913648032 DEBUG: Channel Count : 2 00:35:41.686 T:1913648032 DEBUG: Channel Layout: FL,FR 00:35:41.686 T:1913648032 DEBUG: Frames : 2205 00:35:41.686 T:1913648032 DEBUG: Frame Size : 8 00:35:41.690 T:1832907680 DEBUG: Thread RemoteControl start, auto delete: false 00:35:41.690 T:1832907680 INFO: LIRC Process: using: /run/lirc/lircd 00:35:41.690 T:1832907680 INFO: LIRC Connect: successfully started 00:35:41.690 T:1832907680 DEBUG: Thread RemoteControl 1832907680 terminating 00:35:41.697 T:1945327264 INFO: CKeyboardLayoutManager: loading keyboard layouts from special://xbmc/system/keyboardlayouts... 00:35:41.700 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Arabic QWERTY" successfully loaded 00:35:41.701 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian ЯВЕРТЪ" successfully loaded 00:35:41.702 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian АБВ" successfully loaded 00:35:41.703 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BasePY" successfully loaded 00:35:41.703 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BaiduPY" successfully loaded 00:35:41.704 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Croatian QWERTY" successfully loaded 00:35:41.705 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Czech QWERTZ" successfully loaded 00:35:41.706 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Danish QWERTY" successfully loaded 00:35:41.707 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "English QWERTY" successfully loaded 00:35:41.708 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "English AZERTY" successfully loaded 00:35:41.708 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "English ABC" successfully loaded 00:35:41.709 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "French AZERTY" successfully loaded 00:35:41.710 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "German QWERTZ" successfully loaded 00:35:41.711 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "German ABC" successfully loaded 00:35:41.712 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Greek QWERTY" successfully loaded 00:35:41.713 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew QWERTY" successfully loaded 00:35:41.713 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew ABC" successfully loaded 00:35:41.714 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Hungarian QWERTZ" successfully loaded 00:35:41.715 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Icelandic QWERTY" successfully loaded 00:35:41.716 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Italian QWERTY" successfully loaded 00:35:41.717 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Korean ㄱㄴㄷ" successfully loaded 00:35:41.718 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian AZERTY" successfully loaded 00:35:41.718 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian QWERTY" successfully loaded 00:35:41.719 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Norwegian QWERTY" successfully loaded 00:35:41.720 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Polish QWERTY" successfully loaded 00:35:41.721 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Portuguese (Portugal) QWERTY" successfully loaded 00:35:41.722 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Romanian QWERTY" successfully loaded 00:35:41.723 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian ЙЦУКЕН" successfully loaded 00:35:41.724 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian АБВ" successfully loaded 00:35:41.725 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Silesian QWERTY" successfully loaded 00:35:41.726 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTZ" successfully loaded 00:35:41.727 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak QWERTY" successfully loaded 00:35:41.727 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Slovak ABC" successfully loaded 00:35:41.728 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Spanish QWERTY" successfully loaded 00:35:41.729 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Swedish QWERTY" successfully loaded 00:35:41.730 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Turkish QWERTY" successfully loaded 00:35:41.731 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian ЙЦУКЕН" successfully loaded 00:35:41.731 T:1945327264 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian АБВ" successfully loaded 00:35:41.732 T:1945327264 DEBUG: UDisks: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UDisks was not provided by any .service files 00:35:41.733 T:1945327264 DEBUG: DeviceKit.Disks: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.DeviceKit.Disks was not provided by any .service files 00:35:41.735 T:1945327264 DEBUG: Selected UDev as storage provider 00:35:41.735 T:1945327264 NOTICE: Raspberry PI firmware version: Apr 6 2018 18:05:06 Copyright (c) 2012 Broadcom version 6e5c0b2ea66e88157068fc38184b31a05a022892 (clean) (release) 00:35:41.735 T:1945327264 NOTICE: ARM mem: 768MB GPU mem: 256MB MPG2:0 WVC1:0 00:35:41.735 T:1945327264 NOTICE: cache.memorysize: 100MB libass.cache: 0MB 00:35:41.735 T:1945327264 NOTICE: Config: arm_freq=1200 audio_pwm_mode=514 config_hdmi_boost=9 core_freq=400 desired_osc_freq=0x36ee80 disable_commandline_tags=2 disable_l2cache=1 display_hdmi_rotate=-1 display_lcd_rotate=-1 force_eeprom_read=1 force_pwm_open=1 framebuffer_ignore_alpha=1 framebuffer_swap=1 gpu_freq=300 hdmi_channel_map=8 hdmi_force_cec_address=65535 hdmi_ignore_cec_init=1 init_uart_clock=0x2dc6c00 lcd_framerate=60 over_voltage_avs=0x10c8e overscan_bottom=48 overscan_left=48 overscan_right=48 overscan_top=48 pause_burst_frames=1 program_serial_random=1 sdram_freq=450 00:35:41.735 T:1945327264 NOTICE: Config: device_tree=- 00:35:41.735 T:1945327264 DEBUG: DllBcm: Using omx system library 00:35:41.735 T:1945327264 NOTICE: InitWindowSystem: Using EGL Implementation: raspberrypi 00:35:41.737 T:1945327264 DEBUG: EGL initial desktop resolution 1920x1080 (1920x1080) @ 60.00 - Full Screen (1.00) 00:35:41.737 T:1945327264 DEBUG: EGL get supported modes (2) = 18, prefer_group=1, prefer_mode=10 00:35:41.737 T:1945327264 DEBUG: EGL mode 0: 640x480 (640x480) @ 60.00 - Full Screen (1.00) :4 00:35:41.737 T:1945327264 DEBUG: EGL mode 1: 640x480 (640x480) @ 72.00 - Full Screen (1.00) :5 00:35:41.737 T:1945327264 DEBUG: EGL mode 2: 640x480 (640x480) @ 75.00 - Full Screen (1.00) :6 00:35:41.737 T:1945327264 DEBUG: EGL mode 3: 800x600 (800x600) @ 60.00 - Full Screen (1.00) :9 00:35:41.737 T:1945327264 DEBUG: EGL mode 4: 800x600 (800x600) @ 72.00 - Full Screen (1.00) :a 00:35:41.737 T:1945327264 DEBUG: EGL mode 5: 800x600 (800x600) @ 75.00 - Full Screen (1.00) :b 00:35:41.737 T:1945327264 DEBUG: EGL mode 6: 1024x768 (1024x768) @ 60.00 - Full Screen (1.00) :10 00:35:41.737 T:1945327264 DEBUG: EGL mode 7: 1024x768 (1024x768) @ 70.00 - Full Screen (1.00) :11 00:35:41.737 T:1945327264 DEBUG: EGL mode 8: 1024x768 (1024x768) @ 75.00 - Full Screen (1.00) :12 00:35:41.737 T:1945327264 DEBUG: EGL mode 9: 1152x864 (1152x864) @ 75.00 - Full Screen (1.00) :15 00:35:41.738 T:1945327264 DEBUG: EGL mode 10: 1280x800 (1280x800) @ 60.00 - Full Screen (1.00) :1c 00:35:41.738 T:1945327264 DEBUG: EGL mode 11: 1280x1024 (1280x1024) @ 60.00 - Full Screen (1.00) :23 00:35:41.738 T:1945327264 DEBUG: EGL mode 12: 1280x1024 (1280x1024) @ 75.00 - Full Screen (1.00) :24 00:35:41.738 T:1945327264 DEBUG: EGL mode 13: 1440x900 (1440x900) @ 60.00 - Full Screen (1.00) :2f 00:35:41.738 T:1945327264 DEBUG: EGL mode 14: 1680x1050 (1680x1050) @ 60.00 - Full Screen (1.00) :3a 00:35:41.738 T:1945327264 DEBUG: EGL mode 15: 1366x768 (1366x768) @ 60.00 - Full Screen (1.00) :51 00:35:41.738 T:1945327264 DEBUG: EGL mode 16: 1600x900 (1600x900) @ 60.00 - Full Screen (1.00) :53 00:35:41.738 T:1945327264 DEBUG: EGL mode 17: 1280x720 (1280x720) @ 60.00 - Full Screen (1.00) :55 00:35:41.738 T:1945327264 DEBUG: EGL get supported modes (1) = 9, prefer_group=1, prefer_mode=10 00:35:41.738 T:1945327264 DEBUG: EGL mode 0: 640x480 (640x480) @ 60.00 - Full Screen (1.00) :1 00:35:41.738 T:1945327264 DEBUG: EGL mode 1: 720x480 (720x480) @ 60.00 - Full Screen (0.89) :2 00:35:41.738 T:1945327264 DEBUG: EGL mode 2: 720x480 (720x480) @ 60.00 - Full Screen (1.19) :3 00:35:41.738 T:1945327264 DEBUG: EGL mode 3: 1280x720 (1280x720) @ 60.00 - Full Screen (1.00) :4 00:35:41.738 T:1945327264 DEBUG: EGL mode 4: 1920x1080 (1920x1080) @ 60.00i - Full Screen (1.00) I:5 00:35:41.738 T:1945327264 DEBUG: EGL mode 5: 720x480 (720x480) @ 60.00i - Full Screen (1.19) I:7 00:35:41.738 T:1945327264 DEBUG: EGL mode 6: 1920x1080 (1920x1080) @ 60.00 - Full Screen (1.00) N:10 00:35:41.738 T:1945327264 DEBUG: EGL mode 7: 1920x1080 (1920x1080) @ 24.00 - Full Screen (1.00) :20 00:35:41.738 T:1945327264 DEBUG: EGL mode 8: 1920x1080 (1920x1080) @ 30.00 - Full Screen (1.00) :22 00:35:41.738 T:1945327264 DEBUG: EGL probe resolution 1920x1080 (1920x1080) @ 60.00 - Full Screen:10010004 00:35:41.738 T:1945327264 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 60.000000 Hz 00:35:41.738 T:1945327264 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 59.940063 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 72.000000 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 71.928070 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 75.000000 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 60.000000 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 59.940063 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 72.000000 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 71.928070 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 75.000000 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 60.000000 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 59.940063 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 70.000000 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 75.000000 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1152 x 864 for display 0 with 1152 x 864 @ 75.000000 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1280 x 800 for display 0 with 1280 x 800 @ 60.000000 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1280 x 800 for display 0 with 1280 x 800 @ 59.940063 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1280 x 1024 for display 0 with 1280 x 1024 @ 60.000000 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1280 x 1024 for display 0 with 1280 x 1024 @ 59.940063 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1280 x 1024 for display 0 with 1280 x 1024 @ 75.000000 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1440 x 900 for display 0 with 1440 x 900 @ 60.000000 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1440 x 900 for display 0 with 1440 x 900 @ 59.940063 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1680 x 1050 for display 0 with 1680 x 1050 @ 60.000000 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1680 x 1050 for display 0 with 1680 x 1050 @ 59.940063 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1366 x 768 for display 0 with 1366 x 768 @ 60.000000 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1366 x 768 for display 0 with 1366 x 768 @ 59.940063 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1600 x 900 for display 0 with 1600 x 900 @ 60.000000 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1600 x 900 for display 0 with 1600 x 900 @ 59.940063 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 60.000000 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 59.940063 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 60.000000 Hz 00:35:41.739 T:1945327264 NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 59.940063 Hz 00:35:41.740 T:1945327264 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 60.000000 Hz 00:35:41.740 T:1945327264 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 59.940063 Hz 00:35:41.740 T:1945327264 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 24.000000 Hz 00:35:41.740 T:1945327264 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 23.976025 Hz 00:35:41.740 T:1945327264 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 30.000000 Hz 00:35:41.740 T:1945327264 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 29.970032 Hz 00:35:41.740 T:1945327264 NOTICE: Found (1920x1080@60.000000) at 48, setting to RES_DESKTOP at 16 00:35:41.740 T:1945327264 NOTICE: Checking resolution 16 00:35:41.840 T:1913648032 DEBUG: CAESinkPi:Drain delay:99ms now:0ms 00:35:41.840 T:1913648032 DEBUG: CAESinkPi:Deinitialize 00:35:41.840 T:1913648032 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 00:35:41.842 T:1913648032 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x7170bed0 00:35:41.848 T:1945327264 DEBUG: EGL set HDMI mode (1,16)=0 off 00:35:41.986 T:1886385056 DEBUG: EGL tv_service_callback (8,1,16) 00:35:41.987 T:1945327264 DEBUG: EGL set resolution 1920x1080 -> 1920x1080 @ 60.00 fps (1,16) flags:10010004 aspect:0.94 00:35:42.011 T:1945327264 DEBUG: CreateWindow: Created surface of size 1920x1080 00:35:42.011 T:1923376032 DEBUG: CActiveAE - display reset event 00:35:42.012 T:1913648032 INFO: CActiveAESink::OpenSink - initialize sink 00:35:42.012 T:1913648032 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 00:35:42.012 T:1945327264 NOTICE: GL_VENDOR = Broadcom 00:35:42.012 T:1945327264 NOTICE: GL_RENDERER = VideoCore IV HW 00:35:42.012 T:1945327264 NOTICE: GL_VERSION = OpenGL ES 2.0 00:35:42.012 T:1945327264 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 00:35:42.012 T:1913648032 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI 00:35:42.012 T:1945327264 DEBUG: GLES: Extension Support Test - GL_NVX_gpu_memory_info NO 00:35:42.012 T:1945327264 NOTICE: GL_EXTENSIONS = GL_OES_compressed_ETC1_RGB8_texture GL_OES_compressed_paletted_texture GL_OES_texture_npot GL_OES_depth24 GL_OES_vertex_half_float GL_OES_EGL_image GL_OES_EGL_image_external GL_EXT_discard_framebuffer GL_OES_rgb8_rgba8 GL_OES_depth32 GL_OES_mapbuffer GL_EXT_texture_format_BGRA8888 GL_APPLE_rgb_422 GL_EXT_debug_marker 00:35:42.012 T:1945327264 DEBUG: GLES: Extension Support Test - GL_EXT_texture_format_BGRA8888 YES 00:35:42.012 T:1945327264 DEBUG: GLES: Extension Support Test - GL_IMG_texture_format_BGRA8888 NO 00:35:42.012 T:1945327264 DEBUG: GLES: Extension Support Test - GL_APPLE_texture_format_BGRA8888 NO 00:35:42.012 T:1913648032 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 00:35:42.013 T:1913648032 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x7170bef8 00:35:42.013 T:1945327264 DEBUG: GL: Vertex Shader compilation log: 00:35:42.013 T:1945327264 DEBUG: Compiled 00:35:42.013 T:1945327264 DEBUG: GL: Vertex Shader compiled successfully 00:35:42.014 T:1913648032 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignmen(16) 00:35:42.014 T:1945327264 DEBUG: GL: Pixel Shader compilation log: 00:35:42.014 T:1945327264 DEBUG: Compiled 00:35:42.014 T:1945327264 DEBUG: GL: Fragment Shader compiled successfully 00:35:42.014 T:1913648032 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 00:35:42.014 T:1913648032 DEBUG: Output Device : HDMI 00:35:42.014 T:1913648032 DEBUG: Sample Rate : 44100 00:35:42.014 T:1913648032 DEBUG: Sample Format : AE_FMT_FLOAT 00:35:42.014 T:1913648032 DEBUG: Channel Count : 2 00:35:42.014 T:1913648032 DEBUG: Channel Layout: FL,FR 00:35:42.014 T:1913648032 DEBUG: Frames : 2205 00:35:42.014 T:1913648032 DEBUG: Frame Size : 8 00:35:42.017 T:1923376032 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 00:35:42.029 T:1945327264 DEBUG: GUI Shader [guishader_frag_default.glsl]- Initialise successful : 0x2647de8 00:35:42.029 T:1945327264 DEBUG: GL: Vertex Shader compilation log: 00:35:42.029 T:1945327264 DEBUG: Compiled 00:35:42.029 T:1945327264 DEBUG: GL: Vertex Shader compiled successfully 00:35:42.030 T:1945327264 DEBUG: GL: Pixel Shader compilation log: 00:35:42.030 T:1945327264 DEBUG: Compiled 00:35:42.030 T:1945327264 DEBUG: GL: Fragment Shader compiled successfully 00:35:42.042 T:1945327264 DEBUG: GUI Shader [guishader_frag_texture.glsl]- Initialise successful : 0x264e580 00:35:42.043 T:1945327264 DEBUG: GL: Vertex Shader compilation log: 00:35:42.043 T:1945327264 DEBUG: Compiled 00:35:42.043 T:1945327264 DEBUG: GL: Vertex Shader compiled successfully 00:35:42.043 T:1945327264 DEBUG: GL: Pixel Shader compilation log: 00:35:42.044 T:1945327264 DEBUG: Compiled 00:35:42.044 T:1945327264 DEBUG: GL: Fragment Shader compiled successfully 00:35:42.056 T:1945327264 DEBUG: GUI Shader [guishader_frag_multi.glsl]- Initialise successful : 0x264e1b8 00:35:42.057 T:1945327264 DEBUG: GL: Vertex Shader compilation log: 00:35:42.057 T:1945327264 DEBUG: Compiled 00:35:42.057 T:1945327264 DEBUG: GL: Vertex Shader compiled successfully 00:35:42.057 T:1945327264 DEBUG: GL: Pixel Shader compilation log: 00:35:42.058 T:1945327264 DEBUG: Compiled 00:35:42.058 T:1945327264 DEBUG: GL: Fragment Shader compiled successfully 00:35:42.072 T:1945327264 DEBUG: GUI Shader [guishader_frag_fonts.glsl]- Initialise successful : 0x264db20 00:35:42.073 T:1945327264 DEBUG: GL: Vertex Shader compilation log: 00:35:42.073 T:1945327264 DEBUG: Compiled 00:35:42.073 T:1945327264 DEBUG: GL: Vertex Shader compiled successfully 00:35:42.073 T:1945327264 DEBUG: GL: Pixel Shader compilation log: 00:35:42.073 T:1945327264 DEBUG: Compiled 00:35:42.073 T:1945327264 DEBUG: GL: Fragment Shader compiled successfully 00:35:42.085 T:1945327264 DEBUG: GUI Shader [guishader_frag_texture_noblend.glsl]- Initialise successful : 0x264e498 00:35:42.086 T:1945327264 DEBUG: GL: Vertex Shader compilation log: 00:35:42.086 T:1945327264 DEBUG: Compiled 00:35:42.086 T:1945327264 DEBUG: GL: Vertex Shader compiled successfully 00:35:42.087 T:1945327264 DEBUG: GL: Pixel Shader compilation log: 00:35:42.087 T:1945327264 DEBUG: Compiled 00:35:42.087 T:1945327264 DEBUG: GL: Fragment Shader compiled successfully 00:35:42.100 T:1945327264 DEBUG: GUI Shader [guishader_frag_multi_blendcolor.glsl]- Initialise successful : 0x264d7f8 00:35:42.100 T:1945327264 DEBUG: GL: Vertex Shader compilation log: 00:35:42.100 T:1945327264 DEBUG: Compiled 00:35:42.100 T:1945327264 DEBUG: GL: Vertex Shader compiled successfully 00:35:42.101 T:1945327264 DEBUG: GL: Pixel Shader compilation log: 00:35:42.101 T:1945327264 DEBUG: Compiled 00:35:42.101 T:1945327264 DEBUG: GL: Fragment Shader compiled successfully 00:35:42.114 T:1945327264 DEBUG: GUI Shader [guishader_frag_rgba.glsl]- Initialise successful : 0x264d870 00:35:42.114 T:1945327264 DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external YES 00:35:42.114 T:1945327264 DEBUG: GL: Vertex Shader compilation log: 00:35:42.114 T:1945327264 DEBUG: Compiled 00:35:42.114 T:1945327264 DEBUG: GL: Vertex Shader compiled successfully 00:35:42.115 T:1945327264 DEBUG: GL: Pixel Shader compilation log: 00:35:42.115 T:1945327264 DEBUG: Compiled 00:35:42.115 T:1945327264 DEBUG: GL: Fragment Shader compiled successfully 00:35:42.130 T:1945327264 DEBUG: GUI Shader [guishader_frag_rgba_oes.glsl]- Initialise successful : 0x26533a8 00:35:42.131 T:1945327264 DEBUG: GL: Vertex Shader compilation log: 00:35:42.131 T:1945327264 DEBUG: Compiled 00:35:42.131 T:1945327264 DEBUG: GL: Vertex Shader compiled successfully 00:35:42.131 T:1945327264 DEBUG: GL: Pixel Shader compilation log: 00:35:42.131 T:1945327264 DEBUG: Compiled 00:35:42.131 T:1945327264 DEBUG: GL: Fragment Shader compiled successfully 00:35:42.144 T:1945327264 DEBUG: GUI Shader [guishader_frag_rgba_blendcolor.glsl]- Initialise successful : 0x2653420 00:35:42.144 T:1945327264 DEBUG: GL: Vertex Shader compilation log: 00:35:42.145 T:1945327264 DEBUG: Compiled 00:35:42.145 T:1945327264 DEBUG: GL: Vertex Shader compiled successfully 00:35:42.145 T:1945327264 DEBUG: GL: Pixel Shader compilation log: 00:35:42.145 T:1945327264 DEBUG: Compiled 00:35:42.145 T:1945327264 DEBUG: GL: Fragment Shader compiled successfully 00:35:42.161 T:1945327264 DEBUG: GUI Shader [guishader_frag_rgba_bob.glsl]- Initialise successful : 0x2612e68 00:35:42.161 T:1945327264 DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external YES 00:35:42.161 T:1945327264 DEBUG: GL: Vertex Shader compilation log: 00:35:42.161 T:1945327264 DEBUG: Compiled 00:35:42.161 T:1945327264 DEBUG: GL: Vertex Shader compiled successfully 00:35:42.162 T:1945327264 DEBUG: GL: Pixel Shader compilation log: 00:35:42.162 T:1945327264 DEBUG: Compiled 00:35:42.162 T:1945327264 DEBUG: GL: Fragment Shader compiled successfully 00:35:42.181 T:1945327264 DEBUG: GUI Shader [guishader_frag_rgba_bob_oes.glsl]- Initialise successful : 0x2612ee0 00:35:42.181 T:1945327264 DEBUG: CWinSystemEGL::CreateNewWindow: No need to create a new window 00:35:42.181 T:1945327264 INFO: GLES: Maximum texture width: 2048 00:35:42.499 T:1945327264 INFO: GLES: Enabling VSYNC 00:35:42.499 T:1945327264 INFO: GLES: Selected vsync mode 10 00:35:42.499 T:1945327264 INFO: load keymapping 00:35:42.503 T:1945327264 INFO: Loading special://xbmc/system/keymaps/appcommand.xml 00:35:42.504 T:1945327264 INFO: Loading special://xbmc/system/keymaps/customcontroller.AppleRemote.xml 00:35:42.507 T:1945327264 INFO: Loading special://xbmc/system/keymaps/customcontroller.Harmony.xml 00:35:42.513 T:1945327264 INFO: Loading special://xbmc/system/keymaps/gamepad.xml 00:35:42.519 T:1945327264 INFO: Loading special://xbmc/system/keymaps/joystick.xml 00:35:42.525 T:1945327264 INFO: Loading special://xbmc/system/keymaps/keyboard.xml 00:35:42.543 T:1945327264 INFO: Loading special://xbmc/system/keymaps/mouse.xml 00:35:42.545 T:1945327264 INFO: Loading special://xbmc/system/keymaps/remote.xml 00:35:42.558 T:1945327264 INFO: Loading special://xbmc/system/keymaps/touchscreen.xml 00:35:42.562 T:1945327264 INFO: Loading special://masterprofile/keymaps/gen.xml 00:35:42.564 T:1945327264 INFO: Loading special://profile/keymaps/gen.xml 00:35:42.565 T:1945327264 INFO: Loading special://xbmc/system/Lircmap.xml 00:35:42.570 T:1945327264 INFO: * Adding remote mapping for device 'mceusb' 00:35:42.571 T:1945327264 INFO: * Adding remote mapping for device 'XboxDVDDongle' 00:35:42.571 T:1945327264 INFO: * Adding remote mapping for device 'Microsoft_Xbox' 00:35:42.571 T:1945327264 INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote' 00:35:42.571 T:1945327264 INFO: * Adding remote mapping for device 'anysee' 00:35:42.571 T:1945327264 INFO: * Adding remote mapping for device 'iMON-PAD' 00:35:42.571 T:1945327264 INFO: * Adding remote mapping for device 'Antec_Veris_RM200' 00:35:42.571 T:1945327264 INFO: * Adding remote mapping for device 'MCE_via_iMON' 00:35:42.571 T:1945327264 INFO: * Adding remote mapping for device 'TwinHanRemote' 00:35:42.571 T:1945327264 INFO: * Adding remote mapping for device 'linux-input-layer' 00:35:42.571 T:1945327264 INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote' 00:35:42.571 T:1945327264 INFO: * Adding remote mapping for device 'mediacenter' 00:35:42.571 T:1945327264 INFO: * Adding remote mapping for device 'devinput' 00:35:42.572 T:1945327264 DEBUG: CButtonTranslator::Load - no userdata Lircmap.xml found, skipping 00:35:42.572 T:1945327264 INFO: GUI format 1920x1080, Display 1920x1080 (1920x1080) @ 60.00 - Full Screen 00:35:42.572 T:1945327264 DEBUG: guilib: Fill viewport on change for solving rendering passes 00:35:42.573 T:1945327264 INFO: CLangInfo: loading resource.language.en_gb language information... 00:35:42.576 T:1945327264 DEBUG: trying to set locale to en_US.UTF-8 00:35:42.577 T:1945327264 INFO: global locale set to C 00:35:42.577 T:1945327264 INFO: CLangInfo: loading resource.language.en_gb language strings... 00:35:42.619 T:1945327264 DEBUG: LocalizeStrings: loaded 3800 strings from file resource://resource.language.en_gb/strings.po 00:35:42.639 T:1945327264 DEBUG: LocalizeStrings: loaded 18 strings from file /usr/share/kodi/addons/game.controller.default/resources/language/resource.language.en_gb/strings.po 00:35:42.640 T:1945327264 DEBUG: LocalizeStrings: loaded 13 strings from file /storage/.kodi/addons/metadata.album.universal/resources/language/English/strings.po 00:35:42.641 T:1945327264 DEBUG: LocalizeStrings: loaded 32 strings from file /storage/.kodi/addons/metadata.artists.universal/resources/language/English/strings.po 00:35:42.645 T:1945327264 DEBUG: LocalizeStrings: loaded 8 strings from file /storage/.kodi/addons/metadata.themoviedb.org/resources/language/resource.language.en_gb/strings.po 00:35:42.646 T:1945327264 DEBUG: LocalizeStrings: loaded 10 strings from file /storage/.kodi/addons/metadata.tvdb.com/resources/language/resource.language.en_gb/strings.po 00:35:42.651 T:1945327264 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/screensaver.xbmc.builtin.dim/resources/language/resource.language.en_gb/strings.po 00:35:42.654 T:1945327264 DEBUG: LocalizeStrings: loaded 206 strings from file /usr/share/kodi/addons/service.libreelec.settings/resources/language/English/strings.po 00:35:42.657 T:1945327264 DEBUG: LocalizeStrings: loaded 106 strings from file /storage/.kodi/addons/weather.openweathermap.extended/resources/language/resource.language.en_GB/strings.po 00:35:42.658 T:1945327264 DEBUG: LocalizeStrings: loaded 16 strings from file /storage/.kodi/addons/weather.yahoo/resources/language/resource.language.en_GB/strings.po 00:35:42.658 T:1945327264 DEBUG: LocalizeStrings: loaded 12 strings from file /storage/.kodi/addons/script.keymap/resources/language/English/strings.xml 00:35:42.660 T:1945327264 DEBUG: LocalizeStrings: loaded 57 strings from file /storage/.kodi/addons/weather.gismeteo/resources/language/English/strings.po 00:35:42.664 T:1945327264 DEBUG: LocalizeStrings: loaded 4 strings from file /storage/.kodi/addons/service.subtitles.supersubtitles/resources/language/English/strings.po 00:35:42.665 T:1945327264 DEBUG: LocalizeStrings: loaded 0 strings from file /storage/.kodi/addons/service.subtitles.divxplanet/resources/language/English/strings.po 00:35:42.665 T:1945327264 DEBUG: LocalizeStrings: loaded 5 strings from file /storage/.kodi/addons/service.subtitles.opensubtitles/resources/language/English/strings.po 00:35:42.666 T:1945327264 DEBUG: LocalizeStrings: loaded 4 strings from file /storage/.kodi/addons/service.subtitles.subscene/resources/language/English/strings.po 00:35:42.667 T:1945327264 DEBUG: LocalizeStrings: loaded 2 strings from file /storage/.kodi/addons/service.subtitles.subdivx/resources/language/English/strings.xml 00:35:42.668 T:1945327264 DEBUG: LocalizeStrings: loaded 7 strings from file /storage/.kodi/addons/script.common.plugin.cache/resources/language/English/strings.xml 00:35:42.669 T:1945327264 DEBUG: LocalizeStrings: loaded 10 strings from file /storage/.kodi/addons/service.subtitles.subscenter/resources/language/English/strings.po 00:35:42.670 T:1945327264 DEBUG: LocalizeStrings: loaded 4 strings from file /storage/.kodi/addons/service.subtitles.opensubtitles_by_opensubtitles/resources/language/English/strings.po 00:35:42.670 T:1945327264 DEBUG: LocalizeStrings: loaded 26 strings from file /storage/.kodi/addons/script.globalsearch/resources/language/resource.language.en_GB/strings.po 00:35:42.671 T:1945327264 DEBUG: LocalizeStrings: loaded 3 strings from file /storage/.kodi/addons/script.favourites/resources/language/resource.language.en_GB/strings.po 00:35:42.676 T:1945327264 DEBUG: LocalizeStrings: loaded 51 strings from file /storage/.kodi/addons/script.module.metadatautils/resources/language/resource.language.en_gb/strings.po 00:35:42.677 T:1945327264 DEBUG: LocalizeStrings: loaded 26 strings from file /storage/.kodi/addons/script.skin.helper.service/resources/language/resource.language.en_gb/strings.po 00:35:42.677 T:1945327264 DEBUG: LocalizeStrings: loaded 69 strings from file /storage/.kodi/addons/script.skin.helper.widgets/resources/language/resource.language.en_gb/strings.po 00:35:42.678 T:1945327264 DEBUG: LocalizeStrings: loaded 43 strings from file /storage/.kodi/addons/script.tv.show.next.aired/resources/language/English/strings.po 00:35:42.681 T:1945327264 DEBUG: LocalizeStrings: loaded 24 strings from file /storage/.kodi/addons/service.nextup.notification/resources/language/English/strings.xml 00:35:42.682 T:1945327264 DEBUG: LocalizeStrings: loaded 38 strings from file /storage/.kodi/addons/script.module.youtube.dl/resources/language/English/strings.po 00:35:42.685 T:1945327264 DEBUG: LocalizeStrings: loaded 167 strings from file /storage/.kodi/addons/script.extendedinfo/resources/language/resource.language.en_gb/strings.po 00:35:42.685 T:1945327264 DEBUG: LocalizeStrings: loaded 15 strings from file /storage/.kodi/addons/plugin.video.mms/resources/language/resource.language.en_gb/strings.po 00:35:42.686 T:1945327264 DEBUG: LocalizeStrings: loaded 5 strings from file /storage/.kodi/addons/metadata.tvshows.themoviedb.org/resources/language/English/strings.po 00:35:42.687 T:1945327264 DEBUG: LocalizeStrings: loaded 1 strings from file /storage/.kodi/addons/game.libretro/resources/language/English/strings.po 00:35:42.687 T:1945327264 DEBUG: LocalizeStrings: loaded 12 strings from file /storage/.kodi/addons/game.libretro.mame2014/resources/language/English/strings.po 00:35:42.688 T:1945327264 DEBUG: LocalizeStrings: loaded 17 strings from file /storage/.kodi/addons/game.controller.nds/resources/language/resource.language.en_gb/strings.po 00:35:42.699 T:1945327264 DEBUG: LocalizeStrings: loaded 536 strings from file /storage/.kodi/addons/script.games.rom.collection.browser/resources/language/English/strings.xml 00:35:42.701 T:1945327264 DEBUG: LocalizeStrings: loaded 5 strings from file /storage/.kodi/addons/pvr.hdhomerun/resources/language/resource.language.en_gb/strings.po 00:35:42.702 T:1945327264 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.xbmc.builtin.aac/resources/language/English/strings.po 00:35:42.702 T:1945327264 DEBUG: LocalizeStrings: loaded 1 strings from file /usr/share/kodi/addons/audioencoder.xbmc.builtin.wma/resources/language/English/strings.po 00:35:42.706 T:1945327264 DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid" 00:35:42.706 T:1945327264 DEBUG: LoadMappings - loaded node "CEC Adapter" 00:35:42.706 T:1945327264 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter" 00:35:42.706 T:1945327264 DEBUG: LoadMappings - loaded node "iMON HID device" 00:35:42.707 T:1945327264 DEBUG: LoadMappings - loaded node "WETEK Play remote" 00:35:42.707 T:1945327264 DEBUG: LoadMappings - loaded node "" 00:35:42.707 T:1945327264 DEBUG: CPeripheralBusUSB - initialised udev monitor 00:35:42.707 T:1945327264 DEBUG: SECTION:LoadDLL(libcec.so.4) 00:35:42.708 T:1945327264 DEBUG: Loading: libcec.so.4 00:35:42.745 T:1945327264 DEBUG: Add-on bus: Registering add-on peripheral.joystick 00:35:42.745 T:1945327264 DEBUG: PERIPHERAL - CreateAddon - creating peripheral add-on instance 'Joystick Support' 00:35:42.745 T:1945327264 DEBUG: ADDON: Dll Initializing - Joystick Support 00:35:42.745 T:1945327264 DEBUG: SECTION:LoadDLL(/usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.3.4) 00:35:42.745 T:1945327264 DEBUG: Loading: /usr/lib/kodi/addons/peripheral.joystick/peripheral.joystick.so.1.3.4 00:35:42.763 T:1945327264 DEBUG: AddOnLog: Joystick Support: Loaded 14 joystick families with 97 total joysticks 00:35:42.764 T:1945327264 DEBUG: Calling TransferSettings for: Joystick Support 00:35:42.764 T:1824519072 DEBUG: Thread PeripBusUSBUdev start, auto delete: false 00:35:42.764 T:1816130464 DEBUG: Thread PeripBusCEC start, auto delete: false 00:35:42.765 T:1807741856 DEBUG: Thread PeripBusAddon start, auto delete: false 00:35:42.765 T:1945327264 DEBUG: SECTION:LoadDLL(libcurl.so.4) 00:35:42.765 T:1799353248 DEBUG: Thread PeripEventScanner start, auto delete: false 00:35:42.766 T:1945327264 DEBUG: Loading: libcurl.so.4 00:35:42.774 T:1858073504 NOTICE: Running database version Addons27 00:35:42.775 T:1858073504 DEBUG: Initialize, updating databases... 00:35:42.776 T:1858073504 NOTICE: Running database version ViewModes6 00:35:42.779 T:1858073504 NOTICE: Running database version Textures13 00:35:42.804 T:1858073504 INFO: MYSQL: Connected to version 5.5.55-0+deb7u1 00:35:42.838 T:1858073504 NOTICE: Running database version MyMusic60 00:35:42.876 T:1816130464 DEBUG: GetMappingForDevice - device (2708:1001) mapped to CEC Adapter (type = cec) 00:35:42.878 T:1816130464 DEBUG: InitialiseFeature - using libCEC v4.0.1 00:35:42.878 T:1816130464 DEBUG: Initialise - initialised peripheral on 'RPI' with 2 features and 0 sub devices 00:35:42.878 T:1779430304 DEBUG: Thread CECAdapter start, auto delete: false 00:35:42.878 T:1816130464 NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001) 00:35:42.878 T:1779430304 DEBUG: OpenConnection - opening a connection to the CEC adapter: RPI 00:35:42.878 T:1858073504 NOTICE: Running database version MyVideos107 00:35:42.878 T:1816130464 DEBUG: Thread PeripBusCEC 1816130464 terminating 00:35:42.880 T:1858073504 NOTICE: Running database version TV29 00:35:42.882 T:1858073504 NOTICE: Running database version Epg11 00:35:42.884 T:1858073504 DEBUG: Initialize, updating databases... DONE 00:35:42.885 T:1945327264 NOTICE: start dvd mediatype detection 00:35:42.885 T:1945327264 INFO: DPMS: not supported on this platform 00:35:42.885 T:1860481952 DEBUG: Thread DetectDVDMedia start, auto delete: false 00:35:42.885 T:1860481952 DEBUG: Compiled with libcdio Version 0.94 00:35:42.887 T:1860481952 DEBUG: Thread DetectDVDMedia 1860481952 terminating 00:35:42.916 T:1945314208 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 00:35:42.917 T:1945314208 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 00:35:42.941 T:1945327264 INFO: Unloading old skin ... 00:35:42.943 T:1945327264 INFO: load skin from: /usr/share/kodi/addons/skin.estuary (version: 1.9.16) 00:35:42.943 T:1945327264 INFO: load fonts for skin... 00:35:42.947 T:1945327264 INFO: Loading fonts from /usr/share/kodi/addons/skin.estuary/xml/Font.xml 00:35:43.009 T:1945327264 DEBUG: LocalizeStrings: loaded 132 strings from file /usr/share/kodi/addons/skin.estuary/language/resource.language.en_gb/strings.po 00:35:43.009 T:1945327264 INFO: Loading skin includes from /usr/share/kodi/addons/skin.estuary/xml/Includes.xml 00:35:43.134 T:1945327264 INFO: load new skin... 00:35:43.134 T:1945327264 INFO: Loading user windows, path /usr/share/kodi/addons/skin.estuary/xml 00:35:43.150 T:1945327264 DEBUG: Load Skin XML: 16.00ms 00:35:43.150 T:1945327264 INFO: initialize new skin... 00:35:43.150 T:1945327264 DEBUG: guilib: Fill viewport on change for solving rendering passes 00:35:43.150 T:1945327264 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT 00:35:43.156 T:1945327264 DEBUG: OpenBundle - Opened bundle /usr/share/kodi/addons/skin.estuary/media/Textures.xbt 00:35:43.156 T:1945327264 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT 00:35:43.159 T:1945327264 INFO: Loading skin file: DialogNotification.xml, load type: LOAD_ON_GUI_INIT 00:35:43.162 T:1945327264 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT 00:35:43.178 T:1945327264 INFO: Loading skin file: DialogSettings.xml, load type: LOAD_ON_GUI_INIT 00:35:43.201 T:1945327264 INFO: Previous line repeats 1 times. 00:35:43.201 T:1945327264 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT 00:35:43.204 T:1945327264 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT 00:35:43.209 T:1945327264 INFO: Loading skin file: DialogSubtitles.xml, load type: LOAD_ON_GUI_INIT 00:35:43.223 T:1945327264 INFO: Loading skin file: DialogPVRChannelsOSD.xml, load type: LOAD_ON_GUI_INIT 00:35:43.234 T:1945327264 INFO: Loading skin file: DialogPVRGuideOSD.xml, load type: LOAD_ON_GUI_INIT 00:35:43.241 T:1945327264 INFO: Loading skin file: VideoOSD.xml, load type: LOAD_ON_GUI_INIT 00:35:43.269 T:1945327264 INFO: Loading resource://resource.uisounds.kodi/sounds.xml 00:35:43.328 T:1945327264 INFO: skin loaded... 00:35:43.328 T:1945327264 DEBUG: Activating window ID: 12997 00:35:43.328 T:1945327264 DEBUG: ------ Window Init () ------ 00:35:43.328 T:1945327264 INFO: load splash image: /usr/share/kodi/media/Splash.png 00:35:43.375 T:1945327264 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting 00:35:43.375 T:1945327264 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 00:35:43.375 T:1945327264 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting") 00:35:43.376 T:1945327264 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting 00:35:43.448 T:1945327264 INFO: JSONRPC v8.0.0: Successfully initialized 00:35:43.449 T:1945327264 DEBUG: ADDON: Starting service addons. 00:35:43.453 T:1762653088 DEBUG: Thread LanguageInvoker start, auto delete: false 00:35:43.453 T:1762653088 INFO: initializing python engine. 00:35:43.454 T:1945327264 DEBUG: Activating window ID: 12999 00:35:43.454 T:1945327264 DEBUG: ------ Window Init (Startup.xml) ------ 00:35:43.454 T:1945327264 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME 00:35:43.454 T:1945327264 DEBUG: Activating window ID: 10000 00:35:43.454 T:1945327264 DEBUG: ------ Window Deinit (Startup.xml) ------ 00:35:43.454 T:1945327264 DEBUG: ------ Window Init (Home.xml) ------ 00:35:43.454 T:1945327264 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY 00:35:43.499 T:1762653088 DEBUG: CPythonInvoker(0, /storage/.kodi/addons/service.rom.collection.browser/default.py): start processing 00:35:43.537 T:1762653088 DEBUG: -->Python Interpreter Initialized<-- 00:35:43.537 T:1762653088 DEBUG: CPythonInvoker(0, /storage/.kodi/addons/service.rom.collection.browser/default.py): the source file to load is "/storage/.kodi/addons/service.rom.collection.browser/default.py" 00:35:43.537 T:1762653088 DEBUG: CPythonInvoker(0, /storage/.kodi/addons/service.rom.collection.browser/default.py): setting the Python path to /storage/.kodi/addons/service.rom.collection.browser:/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 00:35:43.537 T:1762653088 DEBUG: CPythonInvoker(0, /storage/.kodi/addons/service.rom.collection.browser/default.py): entering source directory /storage/.kodi/addons/service.rom.collection.browser 00:35:43.537 T:1762653088 DEBUG: CPythonInvoker(0, /storage/.kodi/addons/service.rom.collection.browser/default.py): instantiating addon using automatically obtained id of "service.rom.collection.browser" dependent on version 2.1.0 of the xbmc.python api 00:35:43.539 T:1762653088 DEBUG: RCB Service: Start 00:35:43.542 T:1762653088 DEBUG: RCB Service: launch RCB on startup = 00:35:43.542 T:1762653088 DEBUG: RCB Service: scrape games on startup = false 00:35:43.542 T:1762653088 DEBUG: RCB Service: Done 00:35:43.542 T:1762653088 INFO: CPythonInvoker(0, /storage/.kodi/addons/service.rom.collection.browser/default.py): script successfully run 00:35:43.546 T:1762653088 INFO: Python script stopped 00:35:43.546 T:1762653088 DEBUG: Thread LanguageInvoker 1762653088 terminating 00:35:43.979 T:1945327264 DEBUG: CDirectoryProvider[library://video/movies/]: refreshing.. 00:35:43.979 T:1945327264 DEBUG: CDirectoryProvider[special://skin/playlists/inprogress_movies.xsp]: refreshing.. 00:35:43.979 T:1945327264 DEBUG: CDirectoryProvider[special://skin/playlists/recent_unwatched_movies.xsp]: refreshing.. 00:35:43.979 T:1762653088 DEBUG: Thread JobWorker start, auto delete: true 00:35:43.979 T:1945327264 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_movies.xsp]: refreshing.. 00:35:43.980 T:1945327264 DEBUG: CDirectoryProvider[special://skin/playlists/random_movies.xsp]: refreshing.. 00:35:43.980 T:1754264480 DEBUG: Thread JobWorker start, auto delete: true 00:35:43.980 T:1945327264 DEBUG: CDirectoryProvider[videodb://movies/genres/]: refreshing.. 00:35:43.980 T:1945327264 DEBUG: CDirectoryProvider[videodb://movies/sets/]: refreshing.. 00:35:43.980 T:1945327264 DEBUG: CDirectoryProvider[library://video/tvshows/]: refreshing.. 00:35:43.980 T:1945327264 DEBUG: CDirectoryProvider[videodb://inprogresstvshows]: refreshing.. 00:35:43.980 T:1945327264 DEBUG: CDirectoryProvider[special://skin/playlists/recent_unwatched_episodes.xsp]: refreshing.. 00:35:43.980 T:1945327264 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_tvshows.xsp]: refreshing.. 00:35:43.980 T:1945327264 DEBUG: CDirectoryProvider[videodb://tvshows/genres/]: refreshing.. 00:35:43.980 T:1945327264 DEBUG: CDirectoryProvider[videodb://tvshows/studios/]: refreshing.. 00:35:43.980 T:1945327264 DEBUG: CDirectoryProvider[library://music/]: refreshing.. 00:35:43.980 T:1945327264 DEBUG: CDirectoryProvider[musicdb://recentlyplayedalbums]: refreshing.. 00:35:43.980 T:1945327264 DEBUG: CDirectoryProvider[musicdb://recentlyaddedalbums/]: refreshing.. 00:35:43.980 T:1945327264 DEBUG: CDirectoryProvider[special://skin/playlists/random_albums.xsp]: refreshing.. 00:35:43.980 T:1945327264 DEBUG: CDirectoryProvider[special://skin/playlists/random_artists.xsp]: refreshing.. 00:35:43.980 T:1945327264 DEBUG: CDirectoryProvider[special://skin/playlists/unplayed_albums.xsp]: refreshing.. 00:35:43.980 T:1945327264 DEBUG: CDirectoryProvider[special://skin/playlists/mostplayed_albums.xsp]: refreshing.. 00:35:43.982 T:1945327264 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 00:35:43.982 T:1945327264 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 00:35:43.982 T:1945327264 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 00:35:43.982 T:1945327264 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 00:35:43.982 T:1945327264 DEBUG: CDirectoryProvider[library://video/]: refreshing.. 00:35:43.982 T:1945327264 DEBUG: CDirectoryProvider[sources://video/]: refreshing.. 00:35:43.982 T:1945327264 DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing.. 00:35:43.982 T:1945327264 DEBUG: CDirectoryProvider[favourites://]: refreshing.. 00:35:43.990 T:1945327264 DEBUG: ContextMenuManager: addon menus reloaded. 00:35:43.990 T:1945327264 INFO: removing tempfiles 00:35:43.992 T:1945327264 DEBUG: ADDON: Starting service addons. 00:35:43.996 T:1745875872 DEBUG: Thread LanguageInvoker start, auto delete: false 00:35:43.996 T:1745875872 INFO: initializing python engine. 00:35:43.996 T:1745875872 DEBUG: CPythonInvoker(1, /usr/share/kodi/addons/service.libreelec.settings/service.py): start processing 00:35:43.997 T:1737487264 DEBUG: Thread LanguageInvoker start, auto delete: false 00:35:43.997 T:1737487264 INFO: initializing python engine. 00:35:43.997 T:1737487264 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/script.common.plugin.cache/default.py): start processing 00:35:44.012 T:1945327264 DEBUG: CRepositoryUpdater: previous update at 05/03/2019 1:12:25 PM, next at 05/04/2019 1:12:25 PM 00:35:44.013 T:1945327264 NOTICE: initialize done 00:35:44.013 T:1729098656 DEBUG: Thread Timer start, auto delete: false 00:35:44.013 T:1945327264 NOTICE: Running the application... 00:35:44.033 T:1945327264 DEBUG: no profile autoexec.py (/storage/.kodi/userdata/autoexec.py) found, skipping 00:35:44.033 T:1945327264 DEBUG: NetworkMessage - Starting network services 00:35:44.038 T:1945327264 DEBUG: CZeroconfAvahi::clientCallback: client is up and running 00:35:44.039 T:1945327264 NOTICE: starting zeroconf publishing 00:35:44.039 T:1945327264 NOTICE: CWebServer[8080]: Started 00:35:44.040 T:1945327264 NOTICE: starting upnp client 00:35:44.041 T:1945327264 INFO: JSONRPC Server: Successfully initialized 00:35:44.042 T:1945327264 DEBUG: SECTION:LoadDLL(libshairplay.so.0) 00:35:44.043 T:1945327264 DEBUG: Loading: libshairplay.so.0 00:35:44.046 T:1945327264 INFO: AIRPLAY: Cleaning up photoassetcache 00:35:44.046 T:1661989792 DEBUG: Thread EventServer start, auto delete: false 00:35:44.046 T:1661989792 NOTICE: ES: Starting UDP Event server on port 9777 00:35:44.046 T:1661989792 NOTICE: UDP: Listening on port 9777 (ipv6 : false) 00:35:44.047 T:1653601184 DEBUG: Thread TCPServer start, auto delete: false 00:35:44.049 T:1945327264 INFO: AIRPLAY Server: Successfully initialized 00:35:44.049 T:1636823968 DEBUG: Thread AirPlayServer start, auto delete: false 00:35:44.050 T:1628435360 DEBUG: Thread CLinuxInputDevicesCheckHotplugged start, auto delete: false 00:35:44.052 T:1745875872 DEBUG: -->Python Interpreter Initialized<-- 00:35:44.052 T:1745875872 DEBUG: CPythonInvoker(1, /usr/share/kodi/addons/service.libreelec.settings/service.py): the source file to load is "/usr/share/kodi/addons/service.libreelec.settings/service.py" 00:35:44.052 T:1745875872 DEBUG: CPythonInvoker(1, /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 00:35:44.052 T:1745875872 DEBUG: CPythonInvoker(1, /usr/share/kodi/addons/service.libreelec.settings/service.py): entering source directory /usr/share/kodi/addons/service.libreelec.settings 00:35:44.064 T:1945327264 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x33126a0 00:35:44.065 T:1945327264 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(314128), nBufferAlignmen(16) 00:35:44.070 T:1945327264 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x31db418 00:35:44.071 T:1945327264 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x310fc98 00:35:44.072 T:1945327264 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:35:44.082 T:1745875872 DEBUG: CPythonInvoker(1, /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 00:35:44.099 T:1762653088 DEBUG: RunQuery took 46 ms for 9 items query: select * from movie_view WHERE (movie_view.idFile IN (SELECT DISTINCT idFile FROM bookmark WHERE type = 1)) 00:35:44.136 T:1779430304 DEBUG: OpenConnection - connection to the CEC adapter opened 00:35:44.136 T:1779430304 DEBUG: SetConfigurationFromLibCEC - settings updated by libCEC 00:35:44.136 T:1619784608 DEBUG: Thread CECAdapterUpdate start, auto delete: false 00:35:44.136 T:1619784608 DEBUG: UpdateMenuLanguage - using TV menu language is disabled 00:35:44.231 T:1945327264 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x33126a0 00:35:44.232 T:1945327264 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x31db418 00:35:44.233 T:1945327264 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x310fc98 00:35:44.233 T:1945327264 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/backgrounds/primary.jpg 1280x720 00:35:44.240 T:1945327264 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x33126a0 00:35:44.241 T:1945327264 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(93824), nBufferAlignmen(16) 00:35:44.244 T:1945327264 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x31db418 00:35:44.244 T:1945327264 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:35:44.259 T:1945327264 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x33126a0 00:35:44.260 T:1945327264 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x31db418 00:35:44.260 T:1945327264 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/backgrounds/pattern1.jpg 900x506 00:35:44.286 T:1945327264 DEBUG: ------ Window Init () ------ 00:35:44.292 T:1945327264 DEBUG: ------ Window Init (Pointer.xml) ------ 00:35:44.418 T:1745875872 DEBUG: ## LibreELEC Addon ## 8.2.0 00:35:44.426 T:1745875872 WARNING: CSkinInfo: failed to load skin settings 00:35:44.428 T:1737487264 DEBUG: -->Python Interpreter Initialized<-- 00:35:44.429 T:1737487264 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/script.common.plugin.cache/default.py): the source file to load is "/storage/.kodi/addons/script.common.plugin.cache/default.py" 00:35:44.429 T:1737487264 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/script.common.plugin.cache/default.py): setting the Python path to /storage/.kodi/addons/script.common.plugin.cache:/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 00:35:44.429 T:1737487264 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/script.common.plugin.cache/default.py): entering source directory /storage/.kodi/addons/script.common.plugin.cache 00:35:44.429 T:1737487264 DEBUG: CPythonInvoker(2, /storage/.kodi/addons/script.common.plugin.cache/default.py): instantiating addon using automatically obtained id of "script.common.plugin.cache" dependent on version 2.24.0 of the xbmc.python api 00:35:44.476 T:1945327264 DEBUG: ------ Window Init (DialogNotification.xml) ------ 00:35:44.521 T:1945327264 DEBUG: LogindUPowerSyscall - Received unknown signal NameAcquired 00:35:44.705 T:1737487264 DEBUG: StorageServer Module loaded RUN 00:35:44.705 T:1737487264 DEBUG: StorageClient-2.5.4 Starting server 00:35:46.017 T:1745875872 INFO: ## LibreELEC Addon ## system::set_hostname ## LibreELEC-S 00:35:46.019 T:1745875872 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## us 00:35:46.019 T:1745875872 INFO: ## LibreELEC Addon ## system::set_keyboard_layout ## loadkmap < `ls -1 /usr/lib/keymaps/*/us.bmap` 00:35:46.073 T:1521476512 DEBUG: Thread JobWorker start, auto delete: true 00:35:46.098 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x721e5a18 00:35:46.100 T:1521476512 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:35:46.104 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x721ef7c8 00:35:46.105 T:1521476512 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:35:46.111 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x721e5a18 00:35:46.113 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x721ef7c8 00:35:46.113 T:1521476512 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/0/09854ed9.jpg 360x540 00:35:46.122 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x72171850 00:35:46.122 T:1521476512 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(83664), nBufferAlignmen(16) 00:35:46.126 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x72156920 00:35:46.127 T:1521476512 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:35:46.136 T:1745875872 INFO: ## LibreELEC Addon ## system::updateThread ## Started 00:35:46.138 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x72171850 00:35:46.139 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x72156920 00:35:46.139 T:1521476512 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/2/2a1ae876.jpg 360x540 00:35:46.147 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x72171850 00:35:46.148 T:1521476512 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:35:46.153 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x72174e60 00:35:46.154 T:1521476512 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:35:46.184 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x72171850 00:35:46.185 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x72174e60 00:35:46.185 T:1521476512 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/6/64d7ca7c.jpg 360x540 00:35:46.192 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x72171850 00:35:46.193 T:1521476512 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:35:46.195 T:1745875872 INFO: ## LibreELEC Addon ## system::set_auto_update ## manual 00:35:46.199 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x721e5a18 00:35:46.201 T:1521476512 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:35:46.212 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x72171850 00:35:46.214 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x721e5a18 00:35:46.214 T:1521476512 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/3/33fc80c1.jpg 360x540 00:35:46.226 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x72171850 00:35:46.226 T:1521476512 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:35:46.230 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x721ef7c8 00:35:46.232 T:1521476512 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:35:46.242 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x72171850 00:35:46.243 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x721ef7c8 00:35:46.244 T:1521476512 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/b/b8b73071.jpg 360x540 00:35:46.252 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x72156920 00:35:46.253 T:1521476512 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:35:46.258 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x721ee570 00:35:46.260 T:1521476512 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:35:46.271 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x72156920 00:35:46.273 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x721ee570 00:35:46.273 T:1521476512 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/7/77ab575c.jpg 360x540 00:35:46.273 T:1586230176 INFO: ## LibreELEC Addon ## _service_::run ## WAITING: 00:35:46.297 T:1529865120 INFO: ## LibreELEC Addon ## xdbus Monitor started. ## 00:35:46.356 T:1945327264 DEBUG: ------ Window Deinit (Pointer.xml) ------ 00:35:46.497 T:1619784608 DEBUG: UpdateAudioSystemStatus - no CEC capable amplifier found 00:35:48.890 T:1754264480 DEBUG: RunQuery took 4844 ms for 4355 items query: select * from movie_view WHERE ((movie_view.dateAdded > '1900-01-01')) AND ((movie_view.playCount IS NULL OR movie_view.playCount < 1)) 00:35:51.097 T:1858073504 DEBUG: RunQuery took 6825 ms for 4355 items query: select * from movie_view WHERE ((movie_view.playCount IS NULL OR movie_view.playCount = 0)) 00:35:51.842 T:1945327264 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 00:35:53.168 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x72174e60 00:35:53.171 T:1521476512 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:35:53.175 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x721fd370 00:35:53.177 T:1521476512 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:35:53.190 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x72174e60 00:35:53.192 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x721fd370 00:35:53.192 T:1521476512 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/8/8ff824fa.jpg 360x540 00:35:53.192 T:1754264480 DEBUG: RunQuery took 4 ms for 20 items query: SELECT genre.genre_id, genre.name, count(1), count(files.playCount) FROM genre JOIN genre_link ON genre.genre_id = genre_link.genre_id JOIN movie_view ON genre_link.media_id = movie_view.idMovie AND genre_link.media_type='movie' JOIN files ON files.idFile = movie_view.idFile GROUP BY genre.genre_id 00:35:53.208 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x72174e60 00:35:53.209 T:1521476512 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(93488), nBufferAlignmen(16) 00:35:53.215 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x721750c8 00:35:53.216 T:1521476512 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:35:53.234 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x72174e60 00:35:53.235 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x721750c8 00:35:53.235 T:1521476512 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/f/fd160ac9.jpg 360x540 00:35:53.247 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x72156920 00:35:53.249 T:1521476512 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:35:53.253 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x721f7cd0 00:35:53.254 T:1521476512 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:35:53.266 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x72156920 00:35:53.267 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x721f7cd0 00:35:53.269 T:1521476512 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/6/6821478c.jpg 360x540 00:35:53.279 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x72156920 00:35:53.280 T:1521476512 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:35:53.284 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x721f7cd0 00:35:53.285 T:1521476512 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:35:53.296 T:1762653088 DEBUG: RunQuery took 5461 ms for 4611 items query: select * from movie_view 00:35:53.297 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x72156920 00:35:53.299 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x721f7cd0 00:35:53.299 T:1521476512 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/3/3036aab1.jpg 360x540 00:35:53.322 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x72156920 00:35:53.323 T:1521476512 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:35:53.326 T:1858073504 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x572d4848 00:35:53.328 T:1858073504 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:35:53.330 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x6aa3c6d0 00:35:53.332 T:1521476512 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:35:53.332 T:1754264480 INFO: easy_aquire - Created session to http://image.tmdb.org 00:35:53.338 T:1858073504 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x578d8c88 00:35:53.339 T:1858073504 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:35:53.344 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x72156920 00:35:53.346 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x6aa3c6d0 00:35:53.346 T:1521476512 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/e/e2100042.jpg 360x540 00:35:53.351 T:1858073504 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x572d4848 00:35:53.352 T:1858073504 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x578d8c88 00:35:53.352 T:1858073504 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/5/566945ee.jpg 360x540 00:35:53.353 T:1858073504 INFO: easy_aquire - Created session to http://image.tmdb.org 00:35:53.396 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x72156920 00:35:53.397 T:1521476512 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:35:53.400 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x721fff38 00:35:53.401 T:1521476512 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:35:53.411 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x72156920 00:35:53.412 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x721fff38 00:35:53.413 T:1521476512 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/d/d41b265d.jpg 360x540 00:35:53.414 T:1521476512 INFO: easy_aquire - Created session to http://image.tmdb.org 00:35:53.598 T:1858073504 DEBUG: CurlFile::Open(0x556b53b0) http://image.tmdb.org/t/p/original/m54c0mMcsQfNcRk2As2qH8Y5DQG.jpg 00:35:53.639 T:1754264480 DEBUG: CurlFile::Open(0x72c0b640) http://image.tmdb.org/t/p/original/dWl1YzSOSKWK8rK8BGPvdiitPfS.jpg 00:35:53.798 T:1762653088 INFO: easy_aquire - Created session to http://image.tmdb.org 00:35:54.173 T:1858073504 WARNING: COMXImageFile::GetCodingType progressive images not supported by decoder 00:35:54.174 T:1858073504 DEBUG: COMXImageFile::ReadFile http://image.tmdb.org/t/p/original/m54c0mMcsQfNcRk2As2qH8Y5DQG.jpg GetCodingType=0x7fffffff (800x1200) 00:35:54.204 T:1762653088 DEBUG: CurlFile::Open(0x556b53b0) http://image.tmdb.org/t/p/original/m9Cq5ueENbP16X7cJtOxGYbTUW8.jpg 00:35:54.204 T:1521476512 DEBUG: CCurlFile::GetMimeType - http://image.tmdb.org/t/p/original/c0dw1gTKOME7QyehTday1tdhRMa.jpg -> image/jpeg 00:35:54.205 T:1521476512 DEBUG: CurlFile::Open(0x72173da0) http://image.tmdb.org/t/p/original/c0dw1gTKOME7QyehTday1tdhRMa.jpg 00:35:54.350 T:1858073504 DEBUG: CCurlFile::GetMimeType - http://image.tmdb.org/t/p/original/m54c0mMcsQfNcRk2As2qH8Y5DQG.jpg -> image/jpeg 00:35:54.352 T:1858073504 DEBUG: CurlFile::Open(0x573e0068) http://image.tmdb.org/t/p/original/m54c0mMcsQfNcRk2As2qH8Y5DQG.jpg 00:35:54.733 T:1858073504 WARNING: COMXImageFile::GetCodingType progressive images not supported by decoder 00:35:54.733 T:1858073504 DEBUG: COMXImageFile::ReadFile http://image.tmdb.org/t/p/original/m54c0mMcsQfNcRk2As2qH8Y5DQG.jpg GetCodingType=0x7fffffff (800x1200) 00:35:54.733 T:1858073504 NOTICE: LoadJpeg: unable to load http://image.tmdb.org/t/p/original/m54c0mMcsQfNcRk2As2qH8Y5DQG.jpg 00:35:54.734 T:1858073504 DEBUG: CurlFile::Open(0x573e0068) http://image.tmdb.org/t/p/original/m54c0mMcsQfNcRk2As2qH8Y5DQG.jpg 00:35:55.346 T:1858073504 DEBUG: ffmpeg[6EBFF3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 00:35:55.364 T:1858073504 DEBUG: Caching image 'http://image.tmdb.org/t/p/original/m54c0mMcsQfNcRk2As2qH8Y5DQG.jpg' to 'f/fa79d9b6.jpg': 00:35:55.484 T:1762653088 WARNING: COMXImageFile::GetCodingType progressive images not supported by decoder 00:35:55.484 T:1762653088 DEBUG: COMXImageFile::ReadFile http://image.tmdb.org/t/p/original/m9Cq5ueENbP16X7cJtOxGYbTUW8.jpg GetCodingType=0x7fffffff (500x750) 00:35:55.534 T:1754264480 WARNING: COMXImageFile::GetCodingType progressive images not supported by decoder 00:35:55.534 T:1754264480 DEBUG: COMXImageFile::ReadFile http://image.tmdb.org/t/p/original/dWl1YzSOSKWK8rK8BGPvdiitPfS.jpg GetCodingType=0x7fffffff (1400x2100) 00:35:55.592 T:1762653088 DEBUG: CCurlFile::GetMimeType - http://image.tmdb.org/t/p/original/m9Cq5ueENbP16X7cJtOxGYbTUW8.jpg -> image/jpeg 00:35:55.593 T:1762653088 DEBUG: CurlFile::Open(0x556b53b0) http://image.tmdb.org/t/p/original/m9Cq5ueENbP16X7cJtOxGYbTUW8.jpg 00:35:55.600 T:1858073504 DEBUG: cached image 'special://masterprofile/Thumbnails/f/fa79d9b6.jpg' size 360x540 00:35:55.602 T:1858073504 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_encode input port 340 output port 341 m_handle 0x55d0aa60 00:35:55.603 T:1858073504 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_encode) - port(340), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(800768), nBufferAlignmen(16) 00:35:55.603 T:1858073504 DEBUG: COMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.image_encode) - port(341), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(195840) nBufferAlignmen(16) 00:35:55.638 T:1858073504 DEBUG: COMXImageEnc::CreateThumbnailFromSurface : special://masterprofile/Thumbnails/f/fa79d9b6.jpg width 360 height 540 00:35:55.639 T:1858073504 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_encode handle 0x55d0aa60 00:35:55.640 T:1754264480 DEBUG: CCurlFile::GetMimeType - http://image.tmdb.org/t/p/original/dWl1YzSOSKWK8rK8BGPvdiitPfS.jpg -> image/jpeg 00:35:55.641 T:1754264480 DEBUG: CurlFile::Open(0x72c00b08) http://image.tmdb.org/t/p/original/dWl1YzSOSKWK8rK8BGPvdiitPfS.jpg 00:35:55.688 T:1521476512 WARNING: COMXImageFile::GetCodingType progressive images not supported by decoder 00:35:55.688 T:1521476512 DEBUG: COMXImageFile::ReadFile http://image.tmdb.org/t/p/original/c0dw1gTKOME7QyehTday1tdhRMa.jpg GetCodingType=0x7fffffff (1000x1500) 00:35:55.688 T:1521476512 NOTICE: LoadJpeg: unable to load http://image.tmdb.org/t/p/original/c0dw1gTKOME7QyehTday1tdhRMa.jpg 00:35:55.689 T:1521476512 DEBUG: CurlFile::Open(0x72173da0) http://image.tmdb.org/t/p/original/c0dw1gTKOME7QyehTday1tdhRMa.jpg 00:35:55.739 T:1762653088 WARNING: COMXImageFile::GetCodingType progressive images not supported by decoder 00:35:55.739 T:1762653088 DEBUG: COMXImageFile::ReadFile http://image.tmdb.org/t/p/original/m9Cq5ueENbP16X7cJtOxGYbTUW8.jpg GetCodingType=0x7fffffff (500x750) 00:35:55.739 T:1762653088 NOTICE: LoadJpeg: unable to load http://image.tmdb.org/t/p/original/m9Cq5ueENbP16X7cJtOxGYbTUW8.jpg 00:35:55.739 T:1762653088 DEBUG: CurlFile::Open(0x556b53b0) http://image.tmdb.org/t/p/original/m9Cq5ueENbP16X7cJtOxGYbTUW8.jpg 00:35:55.842 T:1858073504 DEBUG: CurlFile::Open(0x573e0068) http://image.tmdb.org/t/p/original/oqbB3iiWXjDoQi1LGICBK3F7jDq.jpg 00:35:56.031 T:1762653088 DEBUG: ffmpeg[690FF3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 00:35:56.045 T:1762653088 DEBUG: Caching image 'http://image.tmdb.org/t/p/original/m9Cq5ueENbP16X7cJtOxGYbTUW8.jpg' to '9/91ade793.jpg': 00:35:56.164 T:1762653088 DEBUG: cached image 'special://masterprofile/Thumbnails/9/91ade793.jpg' size 360x540 00:35:56.166 T:1762653088 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_encode input port 340 output port 341 m_handle 0x5f098f98 00:35:56.167 T:1762653088 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_encode) - port(340), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(800768), nBufferAlignmen(16) 00:35:56.167 T:1762653088 DEBUG: COMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.image_encode) - port(341), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(195840) nBufferAlignmen(16) 00:35:56.191 T:1762653088 DEBUG: COMXImageEnc::CreateThumbnailFromSurface : special://masterprofile/Thumbnails/9/91ade793.jpg width 360 height 540 00:35:56.200 T:1762653088 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_encode handle 0x5f098f98 00:35:56.427 T:1521476512 DEBUG: ffmpeg[5AAFE3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 00:35:56.480 T:1521476512 DEBUG: Caching image 'http://image.tmdb.org/t/p/original/c0dw1gTKOME7QyehTday1tdhRMa.jpg' to '3/3343e4b3.jpg': 00:35:56.585 T:1762653088 DEBUG: CurlFile::Open(0x556b53b0) http://image.tmdb.org/t/p/original/uzVWJ3nSzytzpjWsbVTpzywNJaG.jpg 00:35:56.586 T:1754264480 WARNING: COMXImageFile::GetCodingType progressive images not supported by decoder 00:35:56.586 T:1754264480 DEBUG: COMXImageFile::ReadFile http://image.tmdb.org/t/p/original/dWl1YzSOSKWK8rK8BGPvdiitPfS.jpg GetCodingType=0x7fffffff (1400x2100) 00:35:56.586 T:1754264480 NOTICE: LoadJpeg: unable to load http://image.tmdb.org/t/p/original/dWl1YzSOSKWK8rK8BGPvdiitPfS.jpg 00:35:56.587 T:1754264480 DEBUG: CurlFile::Open(0x72c0b640) http://image.tmdb.org/t/p/original/dWl1YzSOSKWK8rK8BGPvdiitPfS.jpg 00:35:56.764 T:1521476512 DEBUG: cached image 'special://masterprofile/Thumbnails/3/3343e4b3.jpg' size 360x540 00:35:56.866 T:1858073504 WARNING: COMXImageFile::GetCodingType progressive images not supported by decoder 00:35:56.866 T:1858073504 DEBUG: COMXImageFile::ReadFile http://image.tmdb.org/t/p/original/oqbB3iiWXjDoQi1LGICBK3F7jDq.jpg GetCodingType=0x7fffffff (1000x1500) 00:35:56.920 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x7219d5c0 00:35:56.921 T:1521476512 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:35:56.923 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x721f7060 00:35:56.924 T:1521476512 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:35:56.933 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x7219d5c0 00:35:56.933 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x721f7060 00:35:56.934 T:1521476512 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/7/77fe03a9.jpg 360x540 00:35:56.942 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x721fe7c0 00:35:56.943 T:1521476512 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:35:56.946 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x721f7060 00:35:56.947 T:1521476512 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:35:56.956 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x721fe7c0 00:35:56.957 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x721f7060 00:35:56.957 T:1521476512 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/f/f34137a7.jpg 360x540 00:35:57.098 T:1858073504 DEBUG: CCurlFile::GetMimeType - http://image.tmdb.org/t/p/original/oqbB3iiWXjDoQi1LGICBK3F7jDq.jpg -> image/jpeg 00:35:57.099 T:1858073504 DEBUG: CurlFile::Open(0x573e0068) http://image.tmdb.org/t/p/original/oqbB3iiWXjDoQi1LGICBK3F7jDq.jpg 00:35:57.196 T:1521476512 DEBUG: CurlFile::Open(0x72173da0) http://image.tmdb.org/t/p/original/kcJ99AtUykDhpzfQOApsViQa3fj.jpg 00:35:57.250 T:1762653088 WARNING: COMXImageFile::GetCodingType progressive images not supported by decoder 00:35:57.250 T:1762653088 DEBUG: COMXImageFile::ReadFile http://image.tmdb.org/t/p/original/uzVWJ3nSzytzpjWsbVTpzywNJaG.jpg GetCodingType=0x7fffffff (1000x1500) 00:35:57.422 T:1762653088 DEBUG: CCurlFile::GetMimeType - http://image.tmdb.org/t/p/original/uzVWJ3nSzytzpjWsbVTpzywNJaG.jpg -> image/jpeg 00:35:57.423 T:1762653088 DEBUG: CurlFile::Open(0x556b53b0) http://image.tmdb.org/t/p/original/uzVWJ3nSzytzpjWsbVTpzywNJaG.jpg 00:35:57.803 T:1521476512 WARNING: COMXImageFile::GetCodingType progressive images not supported by decoder 00:35:57.803 T:1521476512 DEBUG: COMXImageFile::ReadFile http://image.tmdb.org/t/p/original/kcJ99AtUykDhpzfQOApsViQa3fj.jpg GetCodingType=0x7fffffff (1000x1500) 00:35:57.846 T:1858073504 WARNING: COMXImageFile::GetCodingType progressive images not supported by decoder 00:35:57.846 T:1858073504 DEBUG: COMXImageFile::ReadFile http://image.tmdb.org/t/p/original/oqbB3iiWXjDoQi1LGICBK3F7jDq.jpg GetCodingType=0x7fffffff (1000x1500) 00:35:57.846 T:1858073504 NOTICE: LoadJpeg: unable to load http://image.tmdb.org/t/p/original/oqbB3iiWXjDoQi1LGICBK3F7jDq.jpg 00:35:57.847 T:1858073504 DEBUG: CurlFile::Open(0x573e0068) http://image.tmdb.org/t/p/original/oqbB3iiWXjDoQi1LGICBK3F7jDq.jpg 00:35:57.903 T:1521476512 DEBUG: CCurlFile::GetMimeType - http://image.tmdb.org/t/p/original/kcJ99AtUykDhpzfQOApsViQa3fj.jpg -> image/jpeg 00:35:57.903 T:1521476512 DEBUG: CurlFile::Open(0x72156718) http://image.tmdb.org/t/p/original/kcJ99AtUykDhpzfQOApsViQa3fj.jpg 00:35:57.955 T:1762653088 WARNING: COMXImageFile::GetCodingType progressive images not supported by decoder 00:35:57.955 T:1762653088 DEBUG: COMXImageFile::ReadFile http://image.tmdb.org/t/p/original/uzVWJ3nSzytzpjWsbVTpzywNJaG.jpg GetCodingType=0x7fffffff (1000x1500) 00:35:57.955 T:1762653088 NOTICE: LoadJpeg: unable to load http://image.tmdb.org/t/p/original/uzVWJ3nSzytzpjWsbVTpzywNJaG.jpg 00:35:57.956 T:1762653088 DEBUG: CurlFile::Open(0x556b53b0) http://image.tmdb.org/t/p/original/uzVWJ3nSzytzpjWsbVTpzywNJaG.jpg 00:35:58.218 T:1754264480 DEBUG: Caching image 'http://image.tmdb.org/t/p/original/dWl1YzSOSKWK8rK8BGPvdiitPfS.jpg' to 'b/b2e2ad9e.jpg': 00:35:58.383 T:1858073504 DEBUG: ffmpeg[6EBFF3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 00:35:58.413 T:1521476512 WARNING: COMXImageFile::GetCodingType progressive images not supported by decoder 00:35:58.413 T:1521476512 DEBUG: COMXImageFile::ReadFile http://image.tmdb.org/t/p/original/kcJ99AtUykDhpzfQOApsViQa3fj.jpg GetCodingType=0x7fffffff (1000x1500) 00:35:58.413 T:1521476512 NOTICE: LoadJpeg: unable to load http://image.tmdb.org/t/p/original/kcJ99AtUykDhpzfQOApsViQa3fj.jpg 00:35:58.414 T:1521476512 DEBUG: CurlFile::Open(0x72156718) http://image.tmdb.org/t/p/original/kcJ99AtUykDhpzfQOApsViQa3fj.jpg 00:35:58.445 T:1858073504 DEBUG: Caching image 'http://image.tmdb.org/t/p/original/oqbB3iiWXjDoQi1LGICBK3F7jDq.jpg' to '1/1ee82d94.jpg': 00:35:58.630 T:1762653088 DEBUG: ffmpeg[690FF3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 00:35:58.688 T:1754264480 DEBUG: cached image 'special://masterprofile/Thumbnails/b/b2e2ad9e.jpg' size 360x540 00:35:58.691 T:1754264480 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_encode input port 340 output port 341 m_handle 0x57fab908 00:35:58.693 T:1754264480 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_encode) - port(340), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(800768), nBufferAlignmen(16) 00:35:58.693 T:1754264480 DEBUG: COMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.image_encode) - port(341), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(195840) nBufferAlignmen(16) 00:35:58.700 T:1762653088 DEBUG: Caching image 'http://image.tmdb.org/t/p/original/uzVWJ3nSzytzpjWsbVTpzywNJaG.jpg' to '2/2dd9ea40.jpg': 00:35:58.735 T:1754264480 DEBUG: COMXImageEnc::CreateThumbnailFromSurface : special://masterprofile/Thumbnails/b/b2e2ad9e.jpg width 360 height 540 00:35:58.738 T:1754264480 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_encode handle 0x57fab908 00:35:58.783 T:1858073504 DEBUG: cached image 'special://masterprofile/Thumbnails/1/1ee82d94.jpg' size 360x540 00:35:58.786 T:1858073504 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_encode input port 340 output port 341 m_handle 0x5f098f98 00:35:58.788 T:1858073504 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_encode) - port(340), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(800768), nBufferAlignmen(16) 00:35:58.789 T:1858073504 DEBUG: COMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.image_encode) - port(341), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(195840) nBufferAlignmen(16) 00:35:58.832 T:1754264480 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x57fc6348 00:35:58.833 T:1754264480 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:35:58.843 T:1754264480 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x59d52548 00:35:58.843 T:1754264480 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:35:58.845 T:1858073504 DEBUG: COMXImageEnc::CreateThumbnailFromSurface : special://masterprofile/Thumbnails/1/1ee82d94.jpg width 360 height 540 00:35:58.847 T:1858073504 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_encode handle 0x5f098f98 00:35:58.852 T:1754264480 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x57fc6348 00:35:58.853 T:1754264480 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x59d52548 00:35:58.853 T:1754264480 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/0/0eef8e23.jpg 364x540 00:35:58.894 T:1521476512 DEBUG: ffmpeg[5AAFE3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 00:35:58.948 T:1521476512 DEBUG: Caching image 'http://image.tmdb.org/t/p/original/kcJ99AtUykDhpzfQOApsViQa3fj.jpg' to '2/23a1255f.jpg': 00:35:58.992 T:1754264480 DEBUG: CurlFile::Open(0x72c0b640) http://image.tmdb.org/t/p/original/aHEpzwXvMtIEMBE13tWXS5oHZ7d.jpg 00:35:59.051 T:1762653088 DEBUG: cached image 'special://masterprofile/Thumbnails/2/2dd9ea40.jpg' size 360x540 00:35:59.053 T:1762653088 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_encode input port 340 output port 341 m_handle 0x56f6c430 00:35:59.054 T:1762653088 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_encode) - port(340), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(800768), nBufferAlignmen(16) 00:35:59.054 T:1762653088 DEBUG: COMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.image_encode) - port(341), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(195840) nBufferAlignmen(16) 00:35:59.072 T:1762653088 DEBUG: COMXImageEnc::CreateThumbnailFromSurface : special://masterprofile/Thumbnails/2/2dd9ea40.jpg width 360 height 540 00:35:59.074 T:1762653088 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_encode handle 0x56f6c430 00:35:59.239 T:1521476512 DEBUG: cached image 'special://masterprofile/Thumbnails/2/23a1255f.jpg' size 360x540 00:35:59.241 T:1521476512 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_encode input port 340 output port 341 m_handle 0x721ff958 00:35:59.242 T:1521476512 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_encode) - port(340), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(800768), nBufferAlignmen(16) 00:35:59.243 T:1521476512 DEBUG: COMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.image_encode) - port(341), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(195840) nBufferAlignmen(16) 00:35:59.278 T:1521476512 DEBUG: COMXImageEnc::CreateThumbnailFromSurface : special://masterprofile/Thumbnails/2/23a1255f.jpg width 360 height 540 00:35:59.281 T:1521476512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_encode handle 0x721ff958 00:35:59.440 T:1754264480 WARNING: COMXImageFile::GetCodingType progressive images not supported by decoder 00:35:59.441 T:1754264480 DEBUG: COMXImageFile::ReadFile http://image.tmdb.org/t/p/original/aHEpzwXvMtIEMBE13tWXS5oHZ7d.jpg GetCodingType=0x7fffffff (1400x2100) 00:35:59.598 T:1754264480 DEBUG: CCurlFile::GetMimeType - http://image.tmdb.org/t/p/original/aHEpzwXvMtIEMBE13tWXS5oHZ7d.jpg -> image/jpeg 00:35:59.598 T:1754264480 DEBUG: CurlFile::Open(0x72c0b640) http://image.tmdb.org/t/p/original/aHEpzwXvMtIEMBE13tWXS5oHZ7d.jpg 00:35:59.609 T:1521476512 DEBUG: RunQuery took 146 ms for 53 items query: SELECT * FROM tvshow_view WHERE watchedCount != 0 AND totalCount != watchedCount ORDER BY c00 00:35:59.989 T:1754264480 WARNING: COMXImageFile::GetCodingType progressive images not supported by decoder 00:35:59.989 T:1754264480 DEBUG: COMXImageFile::ReadFile http://image.tmdb.org/t/p/original/aHEpzwXvMtIEMBE13tWXS5oHZ7d.jpg GetCodingType=0x7fffffff (1400x2100) 00:35:59.989 T:1754264480 NOTICE: LoadJpeg: unable to load http://image.tmdb.org/t/p/original/aHEpzwXvMtIEMBE13tWXS5oHZ7d.jpg 00:35:59.989 T:1754264480 DEBUG: CurlFile::Open(0x72c0b640) http://image.tmdb.org/t/p/original/aHEpzwXvMtIEMBE13tWXS5oHZ7d.jpg 00:36:01.096 T:1762653088 DEBUG: RunQuery took 1873 ms for 1119 items query: select * from movie_view JOIN sets ON movie_view.idSet = sets.idSet ORDER BY sets.idSet 00:36:01.301 T:1754264480 DEBUG: Caching image 'http://image.tmdb.org/t/p/original/aHEpzwXvMtIEMBE13tWXS5oHZ7d.jpg' to 'c/c58a7f1a.jpg': 00:36:01.852 T:1754264480 DEBUG: cached image 'special://masterprofile/Thumbnails/c/c58a7f1a.jpg' size 360x540 00:36:01.854 T:1754264480 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_encode input port 340 output port 341 m_handle 0x59d52cb8 00:36:01.855 T:1754264480 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_encode) - port(340), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(800768), nBufferAlignmen(16) 00:36:01.855 T:1754264480 DEBUG: COMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.image_encode) - port(341), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(195840) nBufferAlignmen(16) 00:36:01.892 T:1754264480 DEBUG: COMXImageEnc::CreateThumbnailFromSurface : special://masterprofile/Thumbnails/c/c58a7f1a.jpg width 360 height 540 00:36:01.894 T:1754264480 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_encode handle 0x59d52cb8 00:36:02.387 T:1754264480 DEBUG: RunQuery took 337 ms for 135 items query: SELECT * FROM tvshow_view WHERE ((tvshow_view.watchedcount = 0)) AND ((tvshow_view.totalCount > 0)) 00:36:02.429 T:1858073504 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x56f5c0d8 00:36:02.431 T:1858073504 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:36:02.434 T:1858073504 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x566409a8 00:36:02.435 T:1858073504 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:36:02.444 T:1858073504 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x56f5c0d8 00:36:02.445 T:1858073504 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x566409a8 00:36:02.445 T:1858073504 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/9/90455023.jpg 360x540 00:36:02.473 T:1858073504 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x56f5c0d8 00:36:02.474 T:1858073504 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:36:02.477 T:1858073504 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x5f052188 00:36:02.477 T:1858073504 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:36:02.485 T:1858073504 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x56f5c0d8 00:36:02.486 T:1858073504 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x5f052188 00:36:02.486 T:1858073504 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/3/37dc0b3e.jpg 360x540 00:36:02.504 T:1858073504 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x56f5c0d8 00:36:02.504 T:1858073504 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:36:02.507 T:1858073504 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x566409a8 00:36:02.508 T:1858073504 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:36:02.516 T:1858073504 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x56f5c0d8 00:36:02.517 T:1858073504 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x566409a8 00:36:02.517 T:1858073504 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/a/af88b3d5.jpg 360x540 00:36:02.537 T:1858073504 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x56f5c0d8 00:36:02.537 T:1858073504 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:36:02.540 T:1858073504 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x5f052188 00:36:02.541 T:1858073504 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:36:02.547 T:1762653088 DEBUG: RunQuery took 6 ms for 24 items query: SELECT genre.genre_id, genre.name FROM genre JOIN genre_link ON genre.genre_id = genre_link.genre_id JOIN tvshow_view ON genre_link.media_id = tvshow_view.idShow AND genre_link.media_type='tvshow' GROUP BY genre.genre_id 00:36:02.551 T:1858073504 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x56f5c0d8 00:36:02.552 T:1858073504 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x5f052188 00:36:02.552 T:1858073504 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/7/7d04ca76.jpg 360x540 00:36:02.587 T:1858073504 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x556a54b0 00:36:02.588 T:1858073504 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:36:02.590 T:1858073504 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x566409a8 00:36:02.591 T:1858073504 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:36:02.599 T:1858073504 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x556a54b0 00:36:02.601 T:1858073504 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x566409a8 00:36:02.601 T:1858073504 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/5/56423aeb.jpg 360x540 00:36:02.626 T:1858073504 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x566409a8 00:36:02.628 T:1858073504 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 00:36:02.635 T:1858073504 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x56f5c0d8 00:36:02.636 T:1858073504 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 00:36:02.648 T:1858073504 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x566409a8 00:36:02.650 T:1858073504 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x56f5c0d8 00:36:02.650 T:1858073504 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/f/fe7c8d84.jpg 360x540 00:36:02.732 T:1754264480 DEBUG: RunQuery took 4 ms for 66 items query: SELECT studio.studio_id, studio.name FROM studio JOIN studio_link ON studio.studio_id = studio_link.studio_id JOIN tvshow_view ON studio_link.media_id = tvshow_view.idShow AND studio_link.media_type='tvshow' GROUP BY studio.studio_id 00:36:02.906 T:1754264480 DEBUG: GetRecentlyPlayedAlbums query: SELECT albumview.*, albumartistview.* FROM (SELECT idAlbum FROM albumview WHERE albumview.lastplayed IS NOT NULL AND albumview.strReleaseType = 'album' ORDER BY albumview.lastplayed DESC LIMIT 25) as playedalbums JOIN albumview ON albumview.idAlbum = playedalbums.idAlbum JOIN albumartistview ON albumview.idAlbum = albumartistview.idAlbum ORDER BY albumview.lastplayed DESC, albumartistview.iorder 00:36:02.911 T:1762653088 DEBUG: GetRecentlyAddedAlbums query: SELECT albumview.*, albumartistview.* FROM (SELECT idAlbum FROM album WHERE strAlbum != '' ORDER BY idAlbum DESC LIMIT 25) AS recentalbums JOIN albumview ON albumview.idAlbum = recentalbums.idAlbum JOIN albumartistview ON albumview.idAlbum = albumartistview.idAlbum ORDER BY albumview.idAlbum desc, albumartistview.iOrder 00:36:02.977 T:1762653088 DEBUG: This query part contains a like, we will double backslash in the next field: select idArtist from artist where artist.strArtist like ' 00:36:03.109 T:1754264480 DEBUG: Previous line repeats 11 times. 00:36:03.110 T:1754264480 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE albumview.strReleaseType = 'album' 00:36:03.116 T:1762653088 DEBUG: This query part contains a like, we will double backslash in the next field: select idArtist from artist where artist.strArtist like ' 00:36:03.125 T:1754264480 DEBUG: GetAlbumsByWhere - query took 15 ms 00:36:03.143 T:1762653088 DEBUG: This query part contains a like, we will double backslash in the next field: select idArtist from artist where artist.strArtist like ' 00:36:03.344 T:1762653088 DEBUG: Previous line repeats 4 times. 00:36:03.344 T:1762653088 DEBUG: GetArtistsByWhere query: SELECT artistview.* FROM artistview WHERE ((EXISTS (SELECT 1 FROM song_artist WHERE song_artist.idArtist = artistview.idArtist AND song_artist.idRole = 1) OR EXISTS (SELECT 1 FROM album_artist WHERE album_artist.idArtist = artistview.idArtist)) AND (artistview.strArtist != '')) AND (artistview.strArtist <> 'Various artists') 00:36:03.353 T:1762653088 DEBUG: Time to retrieve artists from dataset = 13 00:36:03.505 T:1754264480 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE (((CAST(albumview.iTimesPlayed as DECIMAL(5,1)) = 0))) AND (albumview.strReleaseType = 'album') 00:36:03.517 T:1754264480 DEBUG: GetAlbumsByWhere - query took 12 ms 00:36:03.553 T:1762653088 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE (((CAST(albumview.iTimesPlayed as DECIMAL(5,1)) > 0))) AND (albumview.strReleaseType = 'album') 00:36:03.557 T:1762653088 DEBUG: GetAlbumsByWhere - query took 3 ms 00:36:03.744 T:1754264480 DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3a%2f%2fprofile%2fplaylists%2fvideo/special%3a%2f%2fprofile%2fplaylists%2fmixed/) 00:36:03.744 T:1754264480 DEBUG: Getting Directory (special://profile/playlists/video) 00:36:03.745 T:1754264480 DEBUG: Getting Directory (special://profile/playlists/mixed) 00:36:03.746 T:1754264480 DEBUG: CMultiPathDirectory::MergeItems, items = 0 00:36:03.748 T:1754264480 DEBUG: CFavourites::Load - no system favourites found, skipping 00:36:03.748 T:1754264480 DEBUG: CFavourites::Load - no userdata favourites found, skipping 00:36:03.748 T:1754264480 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update 00:36:03.761 T:1762653088 DEBUG: SECTION:LoadDLL(libnfs.so.8) 00:36:03.763 T:1762653088 DEBUG: Loading: libnfs.so.8 00:36:03.824 T:1521476512 DEBUG: RunQuery took 3702 ms for 10394 items query: select * from episode_view WHERE ((episode_view.dateAdded > '1900-01-01')) AND ((episode_view.playCount IS NULL OR episode_view.playCount < 1)) 00:36:03.843 T:1754264480 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 00:36:03.884 T:1754264480 DEBUG: This query part contains a like, we will double backslash in the next field: select idArtist from artist where artist.strArtist like ' 00:36:03.895 T:1762653088 DEBUG: NFS: Context for 192.168.1.146/export/A4TB3 not open - get a new context. 00:36:03.904 T:1754264480 DEBUG: This query part contains a like, we will double backslash in the next field: select idArtist from artist where artist.strArtist like ' 00:36:04.023 T:1762653088 DEBUG: Previous line repeats 5 times. 00:36:04.023 T:1762653088 DEBUG: NFS: Connected to server 192.168.1.146 and export /export/A4TB3 00:36:04.023 T:1762653088 DEBUG: NFS: chunks: r/w 131072/131072 00:36:04.028 T:1762653088 DEBUG: NFS: Context for 192.168.1.146/export/A4TB1 not open - get a new context. 00:36:04.029 T:1754264480 DEBUG: This query part contains a like, we will double backslash in the next field: select idArtist from artist where artist.strArtist like ' 00:36:04.073 T:1754264480 DEBUG: Previous line repeats 2 times. 00:36:04.074 T:1754264480 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 00:36:04.130 T:1762653088 DEBUG: NFS: Connected to server 192.168.1.146 and export /export/A4TB1 00:36:04.130 T:1762653088 DEBUG: NFS: chunks: r/w 131072/131072 00:36:04.133 T:1762653088 DEBUG: NFS: Context for 192.168.1.146/export/A4TB4 not open - get a new context. 00:36:04.140 T:1754264480 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update 00:36:04.247 T:1762653088 DEBUG: NFS: Connected to server 192.168.1.146 and export /export/A4TB4 00:36:04.248 T:1762653088 DEBUG: NFS: chunks: r/w 131072/131072 00:36:04.261 T:1754264480 DEBUG: RunQuery took 31 ms for 10 items query: select * from movie_view ORDER BY dateAdded desc, idMovie desc LIMIT 10 00:36:04.264 T:1762653088 DEBUG: NFS: Context for 192.168.1.146/export/SSD not open - get a new context. 00:36:04.371 T:1762653088 DEBUG: NFS: Connected to server 192.168.1.146 and export /export/SSD 00:36:04.372 T:1762653088 DEBUG: NFS: chunks: r/w 131072/131072 00:36:04.375 T:1762653088 DEBUG: NFS: Context for 192.168.1.146/export/A4TB2 not open - get a new context. 00:36:04.383 T:1754264480 DEBUG: RunQuery took 7 ms for 10 items query: select * from episode_view ORDER BY dateAdded desc, idEpisode desc LIMIT 10 00:36:04.496 T:1762653088 DEBUG: NFS: Connected to server 192.168.1.146 and export /export/A4TB2 00:36:04.496 T:1762653088 DEBUG: NFS: chunks: r/w 131072/131072 00:36:04.500 T:1762653088 DEBUG: NFS: Context for 192.168.1.146/export/B4TB1 not open - get a new context. 00:36:04.611 T:1762653088 DEBUG: NFS: Connected to server 192.168.1.146 and export /export/B4TB1 00:36:04.612 T:1762653088 DEBUG: NFS: chunks: r/w 131072/131072 00:36:04.626 T:1754264480 DEBUG: RunQuery took 5 ms for 0 items query: select * from musicvideo_view ORDER BY dateAdded desc, idMVideo desc LIMIT 10 00:36:04.628 T:1754264480 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 00:36:04.678 T:1754264480 DEBUG: GetArtistsByWhere query: SELECT COUNT(DISTINCT artistview.idArtist) FROM artistview WHERE ((EXISTS (SELECT 1 FROM song_artist WHERE song_artist.idArtist = artistview.idArtist AND song_artist.idRole = 1) OR EXISTS (SELECT 1 FROM album_artist WHERE album_artist.idArtist = artistview.idArtist)) AND (artistview.strArtist != '')) AND (artistview.strArtist <> 'Various artists') 00:36:04.758 T:1754264480 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:Kodi (LibreELEC-S) port:8080 00:36:04.758 T:1754264480 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC-S) type: _http._tcp port:8080 00:36:04.762 T:1754264480 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:Kodi (LibreELEC-S) port:8080 00:36:04.762 T:1754264480 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC-S) type: _xbmc-jsonrpc-h._tcp port:8080 00:36:04.766 T:1754264480 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:Kodi (LibreELEC-S) port:9090 00:36:04.766 T:1754264480 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC-S) type: _xbmc-jsonrpc._tcp port:9090 00:36:04.770 T:1754264480 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airtunes type: _raop._tcp name:B827EBB9284A@Kodi (LibreELEC-S) port:36666 00:36:04.770 T:1754264480 DEBUG: CZeroconfAvahi::addService() named: B827EBB9284A@Kodi (LibreELEC-S) type: _raop._tcp port:36666 00:36:04.773 T:1754264480 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:Kodi (LibreELEC-S) port:9777 00:36:04.773 T:1754264480 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC-S) type: _xbmc-events._udp port:9777 00:36:04.776 T:1754264480 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airplay type: _airplay._tcp name:Kodi (LibreELEC-S) port:36667 00:36:04.777 T:1754264480 DEBUG: CZeroconfAvahi::addService() named: Kodi (LibreELEC-S) type: _airplay._tcp port:36667 00:36:05.665 T:1720710048 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 00:36:07.765 T:1762653088 DEBUG: Previous line repeats 5 times. 00:36:07.765 T:1762653088 DEBUG: NFS: Context for 192.168.1.167/export/SSD not open - get a new context. 00:36:07.905 T:1762653088 DEBUG: NFS: Connected to server 192.168.1.167 and export /export/SSD 00:36:07.905 T:1762653088 DEBUG: NFS: chunks: r/w 524288/524288 00:36:07.909 T:1762653088 DEBUG: NFS: Context for 192.168.1.167/export not open - get a new context. 00:36:08.024 T:1762653088 DEBUG: NFS: Connected to server 192.168.1.167 and export /export 00:36:08.024 T:1762653088 DEBUG: NFS: chunks: r/w 524288/524288 00:36:16.933 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 00:36:16.933 T:1787818912 DEBUG: PushCecKeypress - added key a6 00:36:16.945 T:1945327264 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 00:36:17.162 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 229 (rep:0 size:0) 00:36:17.162 T:1787818912 DEBUG: PushCecKeypress - ignored key a6 00:36:18.528 T:1787818912 DEBUG: PushCecKeypress - received key a8 duration 0 (rep:0 size:0) 00:36:18.528 T:1787818912 DEBUG: PushCecKeypress - added key a8 00:36:18.562 T:1945327264 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 00:36:18.758 T:1787818912 DEBUG: PushCecKeypress - received key a8 duration 231 (rep:0 size:0) 00:36:18.759 T:1787818912 DEBUG: PushCecKeypress - ignored key a8 00:36:28.821 T:1945327264 INFO: CheckIdle - Closing session to http://image.tmdb.org (easy=0x721f03a0, multi=0x721f6f58) 00:36:28.822 T:1945327264 INFO: CheckIdle - Closing session to http://image.tmdb.org (easy=0x5d86c0b0, multi=0x579d1e90) 00:36:29.331 T:1945327264 INFO: CheckIdle - Closing session to http://image.tmdb.org (easy=0x56200018, multi=0x72d1ce60) 00:36:31.434 T:1945327264 INFO: CheckIdle - Closing session to http://image.tmdb.org (easy=0x72c05430, multi=0x59d48a28) 00:36:32.547 T:1787818912 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 00:36:32.547 T:1787818912 DEBUG: PushCecKeypress - added key b 00:36:32.579 T:1945327264 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 00:36:32.579 T:1945327264 DEBUG: Activating window ID: 10004 00:36:32.650 T:1858073504 DEBUG: Thread JobWorker 1858073504 terminating (autodelete) 00:36:32.782 T:1787818912 DEBUG: PushCecKeypress - received key b duration 234 (rep:0 size:0) 00:36:32.782 T:1787818912 DEBUG: PushCecKeypress - ignored key b 00:36:32.894 T:1945327264 DEBUG: ------ Window Deinit (Home.xml) ------ 00:36:32.901 T:1945327264 DEBUG: ------ Window Init (Settings.xml) ------ 00:36:32.901 T:1945327264 INFO: Loading skin file: Settings.xml, load type: KEEP_IN_MEMORY 00:36:33.935 T:1787818912 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 00:36:33.935 T:1787818912 DEBUG: PushCecKeypress - added key b 00:36:33.971 T:1945327264 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 00:36:33.972 T:1945327264 DEBUG: Activating window ID: 10030 00:36:34.174 T:1787818912 DEBUG: PushCecKeypress - received key b duration 239 (rep:0 size:0) 00:36:34.174 T:1787818912 DEBUG: PushCecKeypress - ignored key b 00:36:34.309 T:1945327264 DEBUG: ------ Window Deinit (Settings.xml) ------ 00:36:34.318 T:1945327264 DEBUG: ------ Window Init (SettingsCategory.xml) ------ 00:36:34.318 T:1945327264 INFO: Loading skin file: SettingsCategory.xml, load type: KEEP_IN_MEMORY 00:36:34.780 T:1754264480 DEBUG: Thread JobWorker 1754264480 terminating (autodelete) 00:36:35.287 T:1521476512 DEBUG: Thread JobWorker 1521476512 terminating (autodelete) 00:36:36.184 T:1787818912 DEBUG: PushCecKeypress - received key a8 duration 0 (rep:0 size:0) 00:36:36.184 T:1787818912 DEBUG: PushCecKeypress - added key a8 00:36:36.203 T:1945327264 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 00:36:36.418 T:1787818912 DEBUG: PushCecKeypress - received key a8 duration 234 (rep:0 size:0) 00:36:36.418 T:1787818912 DEBUG: PushCecKeypress - ignored key a8 00:36:36.751 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:36.751 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:36.785 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:36.986 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 235 (rep:0 size:0) 00:36:36.987 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:36:37.107 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:37.107 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:37.118 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:37.331 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 224 (rep:0 size:0) 00:36:37.331 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:36:37.426 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:37.427 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:37.451 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:37.538 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 111 (rep:0 size:0) 00:36:37.538 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:36:37.719 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:37.719 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:37.735 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:37.842 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 122 (rep:0 size:0) 00:36:37.842 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:36:38.027 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:38.028 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:38.033 T:1762653088 DEBUG: Thread JobWorker 1762653088 terminating (autodelete) 00:36:38.035 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:38.271 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 243 (rep:0 size:0) 00:36:38.271 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:36:38.367 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:38.367 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:38.385 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:38.438 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 72 (rep:0 size:0) 00:36:38.438 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:36:38.572 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:38.572 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:38.585 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:38.702 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 130 (rep:0 size:0) 00:36:38.702 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:36:38.868 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:38.869 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:38.885 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:39.094 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 225 (rep:0 size:0) 00:36:39.094 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:36:39.719 T:1787818912 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 00:36:39.719 T:1787818912 DEBUG: PushCecKeypress - added key b 00:36:39.735 T:1945327264 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 00:36:39.958 T:1787818912 DEBUG: PushCecKeypress - received key b duration 239 (rep:0 size:0) 00:36:39.958 T:1787818912 DEBUG: PushCecKeypress - ignored key b 00:36:40.819 T:1787818912 DEBUG: PushCecKeypress - received key d8 duration 0 (rep:0 size:0) 00:36:40.819 T:1787818912 DEBUG: PushCecKeypress - added key d8 00:36:40.835 T:1945327264 DEBUG: OnKey: menu (0xd8) pressed, action is PreviousMenu 00:36:40.865 T:1945327264 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 00:36:41.156 T:1945327264 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------ 00:36:41.158 T:1787818912 DEBUG: PushCecKeypress - received key d8 duration 338 (rep:0 size:0) 00:36:41.158 T:1787818912 DEBUG: PushCecKeypress - ignored key d8 00:36:41.168 T:1945327264 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 00:36:41.168 T:1945327264 DEBUG: ------ Window Init (Settings.xml) ------ 00:36:43.275 T:1787818912 DEBUG: PushCecKeypress - received key d8 duration 0 (rep:0 size:0) 00:36:43.275 T:1787818912 DEBUG: PushCecKeypress - added key d8 00:36:43.295 T:1945327264 DEBUG: OnKey: menu (0xd8) pressed, action is PreviousMenu 00:36:43.295 T:1945327264 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 00:36:43.608 T:1945327264 DEBUG: ------ Window Deinit (Settings.xml) ------ 00:36:43.610 T:1787818912 DEBUG: PushCecKeypress - received key d8 duration 334 (rep:0 size:0) 00:36:43.610 T:1787818912 DEBUG: PushCecKeypress - ignored key d8 00:36:43.618 T:1945327264 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 00:36:43.618 T:1945327264 DEBUG: ------ Window Init (Home.xml) ------ 00:36:43.623 T:1762653088 DEBUG: Thread JobWorker start, auto delete: true 00:36:43.644 T:1762653088 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update 00:36:43.745 T:1762653088 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 00:36:43.787 T:1762653088 DEBUG: This query part contains a like, we will double backslash in the next field: select idArtist from artist where artist.strArtist like ' 00:36:43.968 T:1762653088 DEBUG: Previous line repeats 9 times. 00:36:43.969 T:1762653088 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 00:36:44.032 T:1762653088 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update 00:36:44.148 T:1762653088 DEBUG: RunQuery took 31 ms for 10 items query: select * from movie_view ORDER BY dateAdded desc, idMovie desc LIMIT 10 00:36:44.276 T:1762653088 DEBUG: RunQuery took 6 ms for 10 items query: select * from episode_view ORDER BY dateAdded desc, idEpisode desc LIMIT 10 00:36:44.477 T:1762653088 DEBUG: RunQuery took 3 ms for 0 items query: select * from musicvideo_view ORDER BY dateAdded desc, idMVideo desc LIMIT 10 00:36:44.480 T:1762653088 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 00:36:44.520 T:1762653088 DEBUG: GetArtistsByWhere query: SELECT COUNT(DISTINCT artistview.idArtist) FROM artistview WHERE ((EXISTS (SELECT 1 FROM song_artist WHERE song_artist.idArtist = artistview.idArtist AND song_artist.idRole = 1) OR EXISTS (SELECT 1 FROM album_artist WHERE album_artist.idArtist = artistview.idArtist)) AND (artistview.strArtist != '')) AND (artistview.strArtist <> 'Various artists') 00:36:45.271 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 00:36:45.271 T:1787818912 DEBUG: PushCecKeypress - added key a6 00:36:45.284 T:1945327264 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 00:36:45.501 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 231 (rep:0 size:0) 00:36:45.501 T:1787818912 DEBUG: PushCecKeypress - ignored key a6 00:36:45.707 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 00:36:45.707 T:1787818912 DEBUG: PushCecKeypress - added key a6 00:36:45.718 T:1945327264 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 00:36:45.941 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 234 (rep:0 size:0) 00:36:45.941 T:1787818912 DEBUG: PushCecKeypress - ignored key a6 00:36:46.179 T:1787818912 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 00:36:46.179 T:1787818912 DEBUG: PushCecKeypress - added key b 00:36:46.184 T:1945327264 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 00:36:46.185 T:1945327264 DEBUG: Activating window ID: 10025 00:36:46.414 T:1787818912 DEBUG: PushCecKeypress - received key b duration 234 (rep:0 size:0) 00:36:46.414 T:1787818912 DEBUG: PushCecKeypress - ignored key b 00:36:46.490 T:1945327264 DEBUG: ------ Window Deinit (Home.xml) ------ 00:36:46.553 T:1945327264 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 00:36:46.553 T:1945327264 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 00:36:46.783 T:1945327264 DEBUG: CDirectoryProvider[]: refreshing.. 00:36:46.784 T:1762653088 DEBUG: Previous line repeats 1 times. 00:36:46.784 T:1762653088 ERROR: GetDirectory - Error getting 00:36:46.784 T:1945327264 DEBUG: CDirectoryProvider[]: refreshing.. 00:36:46.784 T:1521476512 DEBUG: Thread JobWorker start, auto delete: true 00:36:46.784 T:1762653088 ERROR: GetDirectory - Error getting 00:36:46.784 T:1945327264 DEBUG: CDirectoryProvider[]: refreshing.. 00:36:46.784 T:1762653088 DEBUG: Previous line repeats 1 times. 00:36:46.784 T:1762653088 ERROR: GetDirectory - Error getting 00:36:46.784 T:1945327264 ERROR: Previous line repeats 1 times. 00:36:46.784 T:1945327264 DEBUG: CDirectoryProvider[]: refreshing.. 00:36:46.784 T:1754264480 DEBUG: Thread JobWorker start, auto delete: true 00:36:46.784 T:1521476512 ERROR: GetDirectory - Error getting 00:36:46.784 T:1945327264 DEBUG: CDirectoryProvider[]: refreshing.. 00:36:46.784 T:1762653088 ERROR: GetDirectory - Error getting 00:36:46.786 T:1945327264 ERROR: Previous line repeats 1 times. 00:36:46.786 T:1945327264 DEBUG: CGUIMediaWindow::GetDirectory () 00:36:46.786 T:1945327264 DEBUG: ParentPath = [] 00:36:46.797 T:1858073504 DEBUG: Thread BackgroundLoader start, auto delete: false 00:36:46.848 T:1858073504 DEBUG: Thread BackgroundLoader 1858073504 terminating 00:36:48.855 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:48.855 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:48.868 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:49.114 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 258 (rep:0 size:0) 00:36:49.114 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:36:49.215 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:49.215 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:49.218 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:49.450 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 234 (rep:0 size:0) 00:36:49.450 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:36:49.647 T:1787818912 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 00:36:49.647 T:1787818912 DEBUG: PushCecKeypress - added key b 00:36:49.651 T:1945327264 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 00:36:49.653 T:1945327264 DEBUG: CGUIMediaWindow::GetDirectory (library://video/files.xml/) 00:36:49.653 T:1945327264 DEBUG: ParentPath = [] 00:36:49.718 T:1858073504 DEBUG: Thread BackgroundLoader start, auto delete: false 00:36:49.773 T:1858073504 DEBUG: Thread BackgroundLoader 1858073504 terminating 00:36:49.881 T:1787818912 DEBUG: PushCecKeypress - received key b duration 235 (rep:0 size:0) 00:36:49.882 T:1787818912 DEBUG: PushCecKeypress - ignored key b 00:36:51.247 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 00:36:51.247 T:1787818912 DEBUG: PushCecKeypress - added key a6 00:36:51.251 T:1945327264 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 00:36:51.485 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 238 (rep:0 size:0) 00:36:51.486 T:1787818912 DEBUG: PushCecKeypress - ignored key a6 00:36:51.619 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 00:36:51.619 T:1787818912 DEBUG: PushCecKeypress - added key a6 00:36:51.634 T:1945327264 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 00:36:51.858 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 239 (rep:0 size:0) 00:36:51.858 T:1787818912 DEBUG: PushCecKeypress - ignored key a6 00:36:51.954 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 00:36:51.954 T:1787818912 DEBUG: PushCecKeypress - added key a6 00:36:51.967 T:1945327264 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 00:36:52.025 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 72 (rep:0 size:0) 00:36:52.025 T:1787818912 DEBUG: PushCecKeypress - ignored key a6 00:36:52.123 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 00:36:52.123 T:1787818912 DEBUG: PushCecKeypress - added key a6 00:36:52.134 T:1945327264 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 00:36:52.245 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 122 (rep:0 size:0) 00:36:52.246 T:1787818912 DEBUG: PushCecKeypress - ignored key a6 00:36:52.375 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 00:36:52.375 T:1787818912 DEBUG: PushCecKeypress - added key a6 00:36:52.384 T:1945327264 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 00:36:52.613 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 239 (rep:0 size:0) 00:36:52.614 T:1787818912 DEBUG: PushCecKeypress - ignored key a6 00:36:53.011 T:1787818912 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 00:36:53.011 T:1787818912 DEBUG: PushCecKeypress - added key b 00:36:53.017 T:1945327264 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 00:36:53.019 T:1945327264 DEBUG: CGUIMediaWindow::GetDirectory (nfs://192.168.1.167/export/SSD/) 00:36:53.019 T:1945327264 DEBUG: ParentPath = [sources://video/] 00:36:53.020 T:1762653088 DEBUG: NFS: Refreshing context for 192.168.1.167/export/SSD, old: 26419, new: 71675 00:36:53.020 T:1762653088 DEBUG: NFS: Using cached context. 00:36:53.052 T:1858073504 DEBUG: Thread BackgroundLoader start, auto delete: false 00:36:53.177 T:1858073504 DEBUG: Thread BackgroundLoader 1858073504 terminating 00:36:53.245 T:1787818912 DEBUG: PushCecKeypress - received key b duration 235 (rep:0 size:0) 00:36:53.245 T:1787818912 DEBUG: PushCecKeypress - ignored key b 00:36:54.203 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:54.203 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:54.213 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:54.329 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 127 (rep:0 size:0) 00:36:54.330 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:36:54.631 T:1787818912 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 00:36:54.631 T:1787818912 DEBUG: PushCecKeypress - added key b 00:36:54.649 T:1945327264 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 00:36:54.651 T:1945327264 DEBUG: CGUIMediaWindow::GetDirectory (nfs://192.168.1.167/export/SSD/sabnzbd/) 00:36:54.651 T:1945327264 DEBUG: ParentPath = [nfs://192.168.1.167/export/SSD/] 00:36:54.683 T:1858073504 DEBUG: Thread BackgroundLoader start, auto delete: false 00:36:54.866 T:1787818912 DEBUG: PushCecKeypress - received key b duration 236 (rep:0 size:0) 00:36:54.866 T:1787818912 DEBUG: PushCecKeypress - ignored key b 00:36:54.876 T:1858073504 DEBUG: Thread BackgroundLoader 1858073504 terminating 00:36:55.960 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:55.961 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:55.994 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:56.194 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 233 (rep:0 size:0) 00:36:56.194 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:36:56.338 T:1787818912 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 00:36:56.338 T:1787818912 DEBUG: PushCecKeypress - added key b 00:36:56.345 T:1945327264 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 00:36:56.347 T:1945327264 DEBUG: CGUIMediaWindow::GetDirectory (nfs://192.168.1.167/export/SSD/sabnzbd/complete/) 00:36:56.347 T:1945327264 DEBUG: ParentPath = [nfs://192.168.1.167/export/SSD/sabnzbd/] 00:36:56.411 T:1945327264 DEBUG: RunQuery took 3 ms for 3 items query: SELECT files.strFilename, files.playCount, bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files LEFT JOIN bookmark ON files.idFile = bookmark.idFile AND bookmark.type = 1 WHERE files.idPath=6451 00:36:56.422 T:1858073504 DEBUG: Thread BackgroundLoader start, auto delete: false 00:36:56.562 T:1787818912 DEBUG: PushCecKeypress - received key b duration 224 (rep:0 size:0) 00:36:56.562 T:1787818912 DEBUG: PushCecKeypress - ignored key b 00:36:57.154 T:1858073504 DEBUG: Thread BackgroundLoader 1858073504 terminating 00:36:57.819 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:57.819 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:57.840 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:58.054 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 235 (rep:0 size:0) 00:36:58.054 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:36:58.149 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:58.149 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:58.151 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:58.269 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 120 (rep:0 size:0) 00:36:58.269 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:36:58.454 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:58.455 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:58.459 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:58.582 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 128 (rep:0 size:0) 00:36:58.582 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:36:58.747 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:58.747 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:58.772 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:58.869 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 123 (rep:0 size:0) 00:36:58.869 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:36:59.003 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:59.003 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:59.030 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:59.125 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 123 (rep:0 size:0) 00:36:59.125 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:36:59.247 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:59.247 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:59.280 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:59.397 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 151 (rep:0 size:0) 00:36:59.397 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:36:59.500 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:36:59.500 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:36:59.500 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 00:36:59.733 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 234 (rep:0 size:0) 00:36:59.733 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:37:00.603 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 00:37:00.603 T:1787818912 DEBUG: PushCecKeypress - added key a6 00:37:00.634 T:1945327264 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 00:37:00.837 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 235 (rep:0 size:0) 00:37:00.838 T:1787818912 DEBUG: PushCecKeypress - ignored key a6 00:37:01.155 T:1787818912 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 00:37:01.155 T:1787818912 DEBUG: PushCecKeypress - added key b 00:37:01.167 T:1945327264 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 00:37:01.215 T:1945327264 DEBUG: OnPlayMedia nfs://192.168.1.167/export/SSD/sabnzbd/complete/#BigBuckBunny_320x180.mp4 00:37:01.216 T:1945314208 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 00:37:01.216 T:1945314208 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 00:37:01.258 T:1945327264 DEBUG: Loading settings for nfs://192.168.1.167/export/SSD/sabnzbd/complete/#BigBuckBunny_320x180.mp4 00:37:01.300 T:1945327264 DEBUG: CPlayerCoreFactory::GetPlayers(nfs://192.168.1.167/export/SSD/sabnzbd/complete/#BigBuckBunny_320x180.mp4) 00:37:01.300 T:1945327264 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 00:37:01.300 T:1945327264 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 00:37:01.300 T:1945327264 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 00:37:01.300 T:1945327264 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 00:37:01.300 T:1945327264 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 00:37:01.300 T:1945327264 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 00:37:01.300 T:1945327264 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 00:37:01.301 T:1945327264 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 00:37:01.301 T:1945327264 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 00:37:01.301 T:1945327264 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 00:37:01.301 T:1945327264 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 00:37:01.301 T:1945327264 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 00:37:01.301 T:1945327264 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 00:37:01.301 T:1945327264 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 00:37:01.301 T:1945327264 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 00:37:01.301 T:1945327264 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 00:37:01.301 T:1945327264 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 00:37:01.306 T:1945327264 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 00:37:01.306 T:1945327264 NOTICE: VideoPlayer: Opening: nfs://192.168.1.167/export/SSD/sabnzbd/complete/#BigBuckBunny_320x180.mp4 00:37:01.306 T:1945327264 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 00:37:01.306 T:1945327264 DEBUG: CMMALRenderer::CMMALRenderer 00:37:01.307 T:1945327264 DEBUG: CMMALRenderer::UnInitMMAL 00:37:01.307 T:1945327264 DEBUG: CMMALRenderer::PreInit 00:37:01.307 T:1538253728 DEBUG: Thread VideoPlayer start, auto delete: false 00:37:01.307 T:1858073504 DEBUG: Thread MMALProcess start, auto delete: false 00:37:01.307 T:1858073504 DEBUG: CMMALRenderer::Run - starting 00:37:01.307 T:1538253728 NOTICE: Creating InputStream 00:37:01.328 T:1538253728 DEBUG: CFileCache::Open - opening using cache 00:37:01.342 T:1538253728 DEBUG: CNFSFile::Open - opened export/SSD/sabnzbd/complete/#BigBuckBunny_320x180.mp4 00:37:01.353 T:1555030944 DEBUG: Thread FileCache start, auto delete: false 00:37:01.353 T:1538253728 DEBUG: ScanForExternalSubtitles: Searching for subtitles... 00:37:01.385 T:1787818912 DEBUG: PushCecKeypress - received key b duration 230 (rep:0 size:0) 00:37:01.385 T:1787818912 DEBUG: PushCecKeypress - ignored key b 00:37:01.430 T:1538253728 DEBUG: ScanForExternalSubtitles: END (total time: 77 ms) 00:37:01.430 T:1538253728 NOTICE: Creating Demuxer 00:37:01.431 T:1538253728 DEBUG: Open - probing detected format [mov,mp4,m4a,3gp,3g2,mj2] 00:37:01.527 T:1555030944 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 00:37:01.539 T:1538253728 INFO: ffmpeg[5BAFE3A0]: [mov,mp4,m4a,3gp,3g2,mj2] Protocol name not provided, cannot determine if input is local or a network protocol, buffers and access patterns cannot be configured optimally without knowing the protocol 00:37:01.563 T:1538253728 DEBUG: Open - avformat_find_stream_info starting 00:37:01.572 T:1538253728 DEBUG: Open - av_find_stream_info finished 00:37:01.572 T:1538253728 INFO: ffmpeg[5BAFE3A0]: Input #0, mov,mp4,m4a,3gp,3g2,mj2, nfs://192.168.1.167/export/SSD/sabnzbd/complete/#BigBuckBunny_320x180.mp': 00:37:01.572 T:1538253728 INFO: ffmpeg[5BAFE3A0]: Metadata: 00:37:01.572 T:1538253728 INFO: ffmpeg[5BAFE3A0]: major_brand : isom 00:37:01.572 T:1538253728 INFO: ffmpeg[5BAFE3A0]: minor_version : 512 00:37:01.572 T:1538253728 INFO: ffmpeg[5BAFE3A0]: compatible_brands: mp41 00:37:01.572 T:1538253728 INFO: ffmpeg[5BAFE3A0]: creation_time : 1970-01-01 00:00:00 00:37:01.572 T:1538253728 INFO: ffmpeg[5BAFE3A0]: title : Big Buck Bunny 00:37:01.572 T:1538253728 INFO: ffmpeg[5BAFE3A0]: artist : Blender Foundation 00:37:01.572 T:1538253728 INFO: ffmpeg[5BAFE3A0]: composer : Blender Foundation 00:37:01.572 T:1538253728 INFO: ffmpeg[5BAFE3A0]: date : 2008 00:37:01.572 T:1538253728 INFO: ffmpeg[5BAFE3A0]: encoder : Lavf52.14.0 00:37:01.573 T:1538253728 INFO: ffmpeg[5BAFE3A0]: Duration: 00:09:56.46, start: 0.000000, bitrate: 867 kb/s 00:37:01.573 T:1538253728 INFO: ffmpeg[5BAFE3A0]: Stream #0:0(und): Video: h264 (Constrained Baseline) (avc1 / 0x31637661), yuv420p, 320x180 [SAR 1:1 DAR 16:9], 702 kb/s, 24 fps, 24 tbr, 24 tbn, 48 tbc (default) 00:37:01.573 T:1538253728 INFO: ffmpeg[5BAFE3A0]: Metadata: 00:37:01.573 T:1538253728 INFO: ffmpeg[5BAFE3A0]: creation_time : 1970-01-01 00:00:00 00:37:01.573 T:1538253728 INFO: ffmpeg[5BAFE3A0]: handler_name : VideoHandler 00:37:01.573 T:1538253728 INFO: ffmpeg[5BAFE3A0]: Stream #0:1(und): Audio: aac (LC) (mp4a / 0x6134706D), 48000 Hz, stereo, fltp, 159 kb/s (default) 00:37:01.573 T:1538253728 INFO: ffmpeg[5BAFE3A0]: Metadata: 00:37:01.573 T:1538253728 INFO: ffmpeg[5BAFE3A0]: creation_time : 1970-01-01 00:00:00 00:37:01.573 T:1538253728 INFO: ffmpeg[5BAFE3A0]: handler_name : SoundHandler 00:37:01.573 T:1538253728 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0 00:37:01.573 T:1538253728 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1 00:37:01.574 T:1538253728 DEBUG: CDVDInputStreamFile::SetReadRate - set cache throttle rate to 119241 bytes per second 00:37:01.574 T:1538253728 NOTICE: Opening stream: 0 source: 256 00:37:01.575 T:1538253728 NOTICE: Creating video codec with codec id: 28 00:37:01.575 T:1538253728 DEBUG: FactoryCodec - Video: mmal-xxxx - Opening 00:37:01.575 T:1538253728 DEBUG: FactoryCodec - Video: mmal-xxxx - Failed 00:37:01.575 T:1538253728 DEBUG: FactoryCodec - Video: - Opening 00:37:01.575 T:1538253728 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 00:37:01.575 T:1538253728 DEBUG: CDVDVideoCodecFFmpeg - open frame threaded with 6 threads 00:37:01.577 T:1538253728 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264 00:37:01.578 T:1538253728 DEBUG: FactoryCodec - Video: ff-h264 - Opened 00:37:01.578 T:1538253728 DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 28 00:37:01.578 T:1538253728 NOTICE: Creating video thread 00:37:01.578 T:1173345184 DEBUG: Thread VideoPlayerVideo start, auto delete: false 00:37:01.578 T:1173345184 NOTICE: running thread: video_thread 00:37:01.578 T:1538253728 NOTICE: Opening stream: 1 source: 256 00:37:01.578 T:1538253728 NOTICE: Finding audio codec for: 86018 00:37:01.578 T:1538253728 DEBUG: FactoryCodec - Audio: passthrough - Opening 00:37:01.578 T:1538253728 DEBUG: FactoryCodec - Audio: passthrough - Failed 00:37:01.579 T:1538253728 DEBUG: FactoryCodec - Audio: FFmpeg - Opening 00:37:01.582 T:1538253728 DEBUG: FactoryCodec - Audio: FFmpeg - Opened 00:37:01.582 T:1538253728 NOTICE: Creating audio thread 00:37:01.582 T:1164956576 DEBUG: Thread VideoPlayerAudio start, auto delete: false 00:37:01.582 T:1164956576 NOTICE: running thread: CVideoPlayerAudio::Process() 00:37:01.583 T:1538253728 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: nfs://192.168.1.167/export/SSD/sabnzbd/complete/#BigBuckBunny_320x180.mp4 00:37:01.584 T:1538253728 DEBUG: OnPlayBackStarted: play state was 1, starting 1 00:37:01.584 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 1 00:37:01.584 T:1945327264 DEBUG: PlayFile: OpenFile succeed, play state 2 00:37:01.584 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:01.584 T:1945327264 DEBUG: OnPlayBackStarted: play state was 2, starting 0 00:37:01.584 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 2 00:37:01.584 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:01.584 T:1173345184 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 00:37:01.585 T:1173345184 NOTICE: CDecoder::Open - fmt:0 00:37:01.585 T:1173345184 DEBUG: CDecoder::Open MMAL - source requires 3 references 00:37:01.589 T:1173345184 DEBUG: CMMALPool::CMMALPool Created pool 0x6ed14de0 of size 26 x 0 for port vc.ril.video_decode:out:0(I420) 00:37:01.589 T:1173345184 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264-mmal 00:37:01.594 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:01.596 T:1164956576 DEBUG: Previous line repeats 1 times. 00:37:01.596 T:1164956576 NOTICE: Creating audio stream (codec id: 86018, channels: 2, sample rate: 48000, no pass-through) 00:37:01.597 T:1164956576 DEBUG: CVideoPlayerAudio:: synctype set to 0: clock feedback 00:37:01.605 T:1173345184 DEBUG: CRenderManager::Configure - change configuration. 320x180. display: 320x180. framerate: 24.00. format: MMAL 00:37:01.611 T:1762653088 DEBUG: CGUIInfoManager::SetCurrentMovie(nfs://192.168.1.167/export/SSD/sabnzbd/complete/#BigBuckBunny_320x180.mp4) 00:37:01.611 T:1945314208 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 00:37:01.611 T:1945314208 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 00:37:01.611 T:1945327264 DEBUG: DeleteRenderer - deleting renderer 00:37:01.612 T:1945327264 DEBUG: CMMALRenderer::~CMMALRenderer 00:37:01.612 T:1945327264 DEBUG: CMMALRenderer::UnInitMMAL 00:37:01.612 T:1858073504 DEBUG: CMMALRenderer::Run - stopping 00:37:01.612 T:1858073504 DEBUG: Thread MMALProcess 1858073504 terminating 00:37:01.612 T:1945327264 DEBUG: CMMALRenderer::CMMALRenderer 00:37:01.612 T:1945327264 DEBUG: CMMALRenderer::UnInitMMAL 00:37:01.612 T:1858073504 DEBUG: Thread MMALProcess start, auto delete: false 00:37:01.612 T:1945327264 DEBUG: CMMALRenderer::PreInit 00:37:01.612 T:1858073504 DEBUG: CMMALRenderer::Run - starting 00:37:01.612 T:1945327264 DEBUG: CMMALRenderer::Configure - 320x180->320x180@24.00 flags:112 format:18 ext:0 orient:0 00:37:01.612 T:1945327264 DEBUG: CRenderManager::Configure - 6 00:37:01.613 T:1538253728 DEBUG: CVideoPlayer::HandleMessages - player started 2 00:37:01.614 T:1858073504 DEBUG: CMMALRenderer::CheckConfigurationVout Changing Vout dimensions from 160x64 (160x64) to 320x192 (384x208) I420 00:37:01.614 T:1913648032 INFO: CActiveAESink::OpenSink - initialize sink 00:37:01.617 T:1945327264 DEBUG: CMMALRenderer::RenderUpdate - vsync -1 (+4779) 00:37:01.617 T:1945327264 DEBUG: Activating window ID: 12005 00:37:01.618 T:1945327264 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 00:37:01.621 T:1945327264 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 00:37:01.621 T:1945327264 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY 00:37:01.624 T:1858073504 DEBUG: CMMALRenderer::SetVideoRect 0,0,320,180 -> 0,0,0,0 (o:0 v:0 d:0 i:0) 00:37:01.624 T:1139790752 DEBUG: Thread MMALRenderer start, auto delete: false 00:37:01.624 T:1139790752 DEBUG: CMMALRenderer::Process - starting 00:37:01.625 T:1858073504 DEBUG: CMMALRenderer::SetVideoRect 0,0,320,180 -> 0,0,0,0 t:100000 00:37:01.627 T:1945327264 DEBUG: CMMALRenderer::SetVideoRect 0,0,320,180 -> 38,53,1878,1027 (o:0 v:0 d:0 i:0) 00:37:01.627 T:1945327264 DEBUG: CMMALRenderer::SetVideoRect 0,0,320,180 -> 38,53,1840,974 t:100000 00:37:01.715 T:1913648032 DEBUG: CAESinkPi:Drain delay:100ms now:0ms 00:37:01.715 T:1913648032 DEBUG: CAESinkPi:Deinitialize 00:37:01.715 T:1913648032 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 00:37:01.718 T:1913648032 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x7170bef8 00:37:01.719 T:1913648032 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 00:37:01.719 T:1913648032 DEBUG: CAESinkPi:Initialize Format:24 Channels:2 Samplerate:48000 framesize:8 bufsize:19200 bytes/s=384000.00 dest=PI:HDMI 00:37:01.719 T:1913648032 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 00:37:01.721 T:1913648032 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x71700470 00:37:01.724 T:1913648032 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(19200), nBufferAlignmen(16) 00:37:01.724 T:1913648032 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 00:37:01.724 T:1913648032 DEBUG: Output Device : HDMI 00:37:01.724 T:1913648032 DEBUG: Sample Rate : 48000 00:37:01.725 T:1913648032 DEBUG: Sample Format : AE_FMT_FLOATP 00:37:01.725 T:1913648032 DEBUG: Channel Count : 2 00:37:01.725 T:1913648032 DEBUG: Channel Layout: FL,FR 00:37:01.725 T:1913648032 DEBUG: Frames : 2400 00:37:01.725 T:1913648032 DEBUG: Frame Size : 8 00:37:01.732 T:1923376032 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 00:37:01.741 T:1538253728 DEBUG: Previous line repeats 1 times. 00:37:01.741 T:1538253728 DEBUG: CVideoPlayer::HandleMessages - player started 1 00:37:01.741 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 3 00:37:01.741 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:01.741 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 0 00:37:01.741 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:01.742 T:1538253728 DEBUG: VideoPlayer::Sync - Audio - pts: 213333.000000, cache: 260076.477734, totalcache: 500000.000000 00:37:01.742 T:1538253728 DEBUG: VideoPlayer::Sync - Video - pts: 0.000000, cache: 50000.000000, totalcache: 100000.000000 00:37:01.742 T:1164956576 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(-100000.000000) 00:37:01.742 T:1173345184 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(-100000.000000) 00:37:01.742 T:1164956576 DEBUG: CDVDAudio::Resume - resume audio stream 00:37:01.743 T:1923376032 DEBUG: CRBP::AdjustHDMIClock(1.00000) = 1.00000 00:37:01.743 T:1923376032 DEBUG: ActiveAE - start sync of audio stream 00:37:01.883 T:1923376032 DEBUG: ActiveAE::SyncStream - average error of 10.568771, start adjusting 00:37:01.883 T:1923376032 DEBUG: ActiveAE::SyncStream - average error 0.568771 below threshold of 30.000000 00:37:02.002 T:1173345184 NOTICE: CDVDVideoCodecFFmpeg::CDropControl: calculated diff time: 41666 00:37:02.893 T:1164956576 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-30020.481381, adjusted:-30020.481381 00:37:06.620 T:1173345184 DEBUG: CPullupCorrection: detected pattern of length 1: 41666.67, frameduration: 41666.666667 00:37:07.535 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 00:37:07.535 T:1787818912 DEBUG: PushCecKeypress - added key a6 00:37:07.551 T:1945327264 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is ChapterOrBigStepForward 00:37:07.552 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 1 00:37:07.552 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:07.552 T:1538253728 DEBUG: demuxer seek to: 65323.000000 00:37:07.552 T:1538253728 DEBUG: SeekTime - unknown position after seek 00:37:07.552 T:1538253728 DEBUG: demuxer seek to: 65323.000000, success 00:37:07.552 T:1538253728 DEBUG: CVideoPlayer::FlushBuffers - flushing buffers 00:37:07.593 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:07.693 T:1164956576 DEBUG: CDVDAudio::Flush - flush audio stream 00:37:07.693 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:07.694 T:1164956576 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:07.694 T:1173345184 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:07.694 T:1538253728 DEBUG: CVideoPlayer - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:07.694 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 2 00:37:07.694 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:07.694 T:1173345184 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 00:37:07.696 T:1173345184 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264 00:37:07.697 T:1173345184 NOTICE: CDecoder::Open - fmt:0 00:37:07.697 T:1945327264 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 00:37:07.697 T:1173345184 DEBUG: CDecoder::Open MMAL - source requires 3 references 00:37:07.701 T:1173345184 DEBUG: CMMALPool::CMMALPool Created pool 0x6ed2c310 of size 26 x 0 for port vc.ril.video_decode:out:0(I420) 00:37:07.701 T:1173345184 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264-mmal 00:37:07.701 T:1945327264 DEBUG: ------ Window Init (Custom_1109_TopBarOverlay.xml) ------ 00:37:07.701 T:1945327264 INFO: Loading skin file: Custom_1109_TopBarOverlay.xml, load type: KEEP_IN_MEMORY 00:37:07.704 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:07.708 T:1538253728 DEBUG: CVideoPlayer::HandleMessages - player started 1 00:37:07.752 T:1945327264 DEBUG: CMMALRenderer::RenderUpdate - vsync 5135 (+11) 00:37:07.753 T:1538253728 DEBUG: CVideoPlayer::HandleMessages - player started 2 00:37:07.753 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 3 00:37:07.754 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:07.754 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 0 00:37:07.754 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:07.754 T:1538253728 DEBUG: VideoPlayer::Sync - Audio - pts: 65749333.000000, cache: 256000.041962, totalcache: 500000.000000 00:37:07.754 T:1538253728 DEBUG: VideoPlayer::Sync - Video - pts: 65500000.000000, cache: 50000.000000, totalcache: 100000.000000 00:37:07.754 T:1164956576 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(65400000.000000) 00:37:07.754 T:1173345184 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(65400000.000000) 00:37:07.754 T:1164956576 DEBUG: CDVDAudio::Resume - resume audio stream 00:37:07.754 T:1923376032 DEBUG: ActiveAE - start sync of audio stream 00:37:07.770 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 234 (rep:0 size:0) 00:37:07.770 T:1787818912 DEBUG: PushCecKeypress - ignored key a6 00:37:07.779 T:1945314208 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 00:37:07.779 T:1945314208 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 00:37:07.817 T:1858073504 DEBUG: CMMALPool::~CMMALPool Destroying pool 0x6ed14de0 for port vc.ril.video_decode:out:0(I420) 00:37:07.893 T:1923376032 DEBUG: ActiveAE::SyncStream - average error of 58.442490, start adjusting 00:37:07.893 T:1923376032 DEBUG: ActiveAE::SyncStream - average error 8.442490 below threshold of 30.000000 00:37:08.894 T:1164956576 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-74402.851033, adjusted:-74402.851033 00:37:10.439 T:1945327264 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 00:37:10.439 T:1945327264 DEBUG: ------ Window Deinit (Custom_1109_TopBarOverlay.xml) ------ 00:37:12.685 T:1173345184 DEBUG: CPullupCorrection: detected pattern of length 1: 41666.67, frameduration: 41666.666667 00:37:13.647 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 00:37:13.647 T:1787818912 DEBUG: PushCecKeypress - added key a6 00:37:13.650 T:1945327264 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is ChapterOrBigStepForward 00:37:13.651 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 1 00:37:13.651 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:13.651 T:1538253728 DEBUG: demuxer seek to: 130866.000000 00:37:13.651 T:1538253728 DEBUG: SeekTime - unknown position after seek 00:37:13.651 T:1538253728 DEBUG: demuxer seek to: 130866.000000, success 00:37:13.651 T:1538253728 DEBUG: CVideoPlayer::FlushBuffers - flushing buffers 00:37:13.693 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:13.743 T:1164956576 DEBUG: CDVDAudio::Flush - flush audio stream 00:37:13.743 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:13.743 T:1164956576 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:13.743 T:1173345184 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:13.745 T:1538253728 DEBUG: CVideoPlayer - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:13.745 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 2 00:37:13.745 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:13.745 T:1173345184 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 00:37:13.746 T:1945327264 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 00:37:13.747 T:1173345184 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264 00:37:13.747 T:1173345184 NOTICE: CDecoder::Open - fmt:0 00:37:13.747 T:1173345184 DEBUG: CDecoder::Open MMAL - source requires 3 references 00:37:13.748 T:1945327264 DEBUG: ------ Window Init (Custom_1109_TopBarOverlay.xml) ------ 00:37:13.750 T:1173345184 DEBUG: CMMALPool::CMMALPool Created pool 0x6ed0f290 of size 26 x 0 for port vc.ril.video_decode:out:0(I420) 00:37:13.750 T:1173345184 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264-mmal 00:37:13.754 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:13.758 T:1538253728 DEBUG: CVideoPlayer::HandleMessages - player started 1 00:37:13.767 T:1945327264 DEBUG: CMMALRenderer::RenderUpdate - vsync 5501 (+6) 00:37:13.785 T:1538253728 DEBUG: CVideoPlayer::HandleMessages - player started 2 00:37:13.785 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 3 00:37:13.785 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:13.785 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 0 00:37:13.785 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:13.786 T:1538253728 DEBUG: VideoPlayer::Sync - Audio - pts: 131242666.000000, cache: 256000.041962, totalcache: 500000.000000 00:37:13.786 T:1538253728 DEBUG: VideoPlayer::Sync - Video - pts: 131000000.000000, cache: 50000.000000, totalcache: 100000.000000 00:37:13.786 T:1164956576 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(130900000.000000) 00:37:13.786 T:1173345184 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(130900000.000000) 00:37:13.786 T:1164956576 DEBUG: CDVDAudio::Resume - resume audio stream 00:37:13.793 T:1923376032 DEBUG: ActiveAE - start sync of audio stream 00:37:13.817 T:1858073504 DEBUG: CMMALPool::~CMMALPool Destroying pool 0x6ed2c310 for port vc.ril.video_decode:out:0(I420) 00:37:13.847 T:1945314208 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 00:37:13.847 T:1945314208 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 00:37:13.877 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 231 (rep:0 size:0) 00:37:13.877 T:1787818912 DEBUG: PushCecKeypress - ignored key a6 00:37:13.893 T:1923376032 DEBUG: ActiveAE::SyncStream - average error of 63.153177, start adjusting 00:37:13.893 T:1923376032 DEBUG: ActiveAE::SyncStream - average error 13.153177 below threshold of 30.000000 00:37:14.944 T:1164956576 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-98586.785825, adjusted:-98586.785825 00:37:16.572 T:1945327264 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 00:37:16.573 T:1945327264 DEBUG: ------ Window Deinit (Custom_1109_TopBarOverlay.xml) ------ 00:37:16.966 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 00:37:16.967 T:1787818912 DEBUG: PushCecKeypress - added key a6 00:37:16.967 T:1945327264 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is ChapterOrBigStepForward 00:37:16.976 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 1 00:37:16.976 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:16.976 T:1538253728 DEBUG: demuxer seek to: 193627.000000 00:37:16.976 T:1538253728 DEBUG: SeekTime - unknown position after seek 00:37:16.976 T:1538253728 DEBUG: demuxer seek to: 193627.000000, success 00:37:16.976 T:1538253728 DEBUG: CVideoPlayer::FlushBuffers - flushing buffers 00:37:16.992 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:17.092 T:1164956576 DEBUG: CDVDAudio::Flush - flush audio stream 00:37:17.092 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:17.092 T:1164956576 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:17.092 T:1173345184 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:17.093 T:1538253728 DEBUG: CVideoPlayer - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:17.093 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 2 00:37:17.093 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:17.094 T:1945327264 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 00:37:17.096 T:1945327264 DEBUG: ------ Window Init (Custom_1109_TopBarOverlay.xml) ------ 00:37:17.100 T:1945327264 DEBUG: CMMALRenderer::RenderUpdate - vsync 5700 (+7) 00:37:17.103 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:17.125 T:1173345184 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 00:37:17.127 T:1173345184 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264 00:37:17.127 T:1173345184 NOTICE: CDecoder::Open - fmt:0 00:37:17.127 T:1173345184 DEBUG: CDecoder::Open MMAL - source requires 3 references 00:37:17.130 T:1173345184 DEBUG: CMMALPool::CMMALPool Created pool 0x6ed38b20 of size 26 x 0 for port vc.ril.video_decode:out:0(I420) 00:37:17.130 T:1173345184 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264-mmal 00:37:17.143 T:1538253728 DEBUG: CVideoPlayer::HandleMessages - player started 1 00:37:17.170 T:1538253728 DEBUG: CVideoPlayer::HandleMessages - player started 2 00:37:17.171 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 3 00:37:17.171 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:17.171 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 0 00:37:17.171 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:17.171 T:1538253728 DEBUG: VideoPlayer::Sync - Audio - pts: 194240000.000000, cache: 256000.041962, totalcache: 500000.000000 00:37:17.171 T:1538253728 DEBUG: VideoPlayer::Sync - Video - pts: 194000000.000000, cache: 50000.000000, totalcache: 100000.000000 00:37:17.171 T:1164956576 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(193900000.000000) 00:37:17.171 T:1164956576 DEBUG: CDVDAudio::Resume - resume audio stream 00:37:17.171 T:1923376032 DEBUG: ActiveAE - start sync of audio stream 00:37:17.173 T:1173345184 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(193900000.000000) 00:37:17.234 T:1858073504 DEBUG: CMMALPool::~CMMALPool Destroying pool 0x6ed0f290 for port vc.ril.video_decode:out:0(I420) 00:37:17.279 T:1945314208 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 00:37:17.280 T:1945314208 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 00:37:17.293 T:1923376032 DEBUG: ActiveAE::SyncStream - average error of 56.365157, start adjusting 00:37:17.293 T:1923376032 DEBUG: ActiveAE::SyncStream - average error 6.365157 below threshold of 30.000000 00:37:17.305 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 339 (rep:0 size:0) 00:37:17.305 T:1787818912 DEBUG: PushCecKeypress - ignored key a6 00:37:17.955 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 00:37:17.955 T:1787818912 DEBUG: PushCecKeypress - added key a6 00:37:17.967 T:1945327264 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is ChapterOrBigStepForward 00:37:17.969 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 1 00:37:17.969 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:17.970 T:1538253728 DEBUG: demuxer seek to: 254340.000000 00:37:17.970 T:1538253728 DEBUG: SeekTime - unknown position after seek 00:37:17.970 T:1538253728 DEBUG: demuxer seek to: 254340.000000, success 00:37:17.970 T:1538253728 DEBUG: CVideoPlayer::FlushBuffers - flushing buffers 00:37:17.992 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:18.042 T:1164956576 DEBUG: CDVDAudio::Flush - flush audio stream 00:37:18.043 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:18.043 T:1164956576 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:18.043 T:1173345184 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:18.043 T:1538253728 DEBUG: CVideoPlayer - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:18.043 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 2 00:37:18.043 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:18.049 T:1945327264 DEBUG: CMMALRenderer::RenderUpdate - vsync 5760 (+3) 00:37:18.053 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:18.077 T:1173345184 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 00:37:18.079 T:1173345184 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264 00:37:18.079 T:1173345184 NOTICE: CDecoder::Open - fmt:0 00:37:18.080 T:1173345184 DEBUG: CDecoder::Open MMAL - source requires 3 references 00:37:18.082 T:1173345184 DEBUG: CMMALPool::CMMALPool Created pool 0x6ed38b80 of size 26 x 0 for port vc.ril.video_decode:out:0(I420) 00:37:18.082 T:1173345184 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264-mmal 00:37:18.096 T:1538253728 DEBUG: CVideoPlayer::HandleMessages - player started 1 00:37:18.115 T:1538253728 DEBUG: CVideoPlayer::HandleMessages - player started 2 00:37:18.115 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 3 00:37:18.115 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:18.115 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 0 00:37:18.115 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:18.116 T:1538253728 DEBUG: VideoPlayer::Sync - Audio - pts: 254741333.000000, cache: 256000.041962, totalcache: 500000.000000 00:37:18.116 T:1538253728 DEBUG: VideoPlayer::Sync - Video - pts: 254500000.000000, cache: 50000.000000, totalcache: 100000.000000 00:37:18.116 T:1164956576 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(254400000.000000) 00:37:18.116 T:1173345184 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(254400000.000000) 00:37:18.116 T:1164956576 DEBUG: CDVDAudio::Resume - resume audio stream 00:37:18.116 T:1923376032 DEBUG: ActiveAE - start sync of audio stream 00:37:18.150 T:1858073504 DEBUG: CMMALPool::~CMMALPool Destroying pool 0x6ed38b20 for port vc.ril.video_decode:out:0(I420) 00:37:18.221 T:1945314208 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 00:37:18.221 T:1945314208 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 00:37:18.243 T:1923376032 DEBUG: ActiveAE::SyncStream - average error of 55.612208, start adjusting 00:37:18.243 T:1923376032 DEBUG: ActiveAE::SyncStream - average error 5.612208 below threshold of 30.000000 00:37:18.301 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 346 (rep:0 size:0) 00:37:18.301 T:1787818912 DEBUG: PushCecKeypress - ignored key a6 00:37:18.519 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 00:37:18.519 T:1787818912 DEBUG: PushCecKeypress - added key a6 00:37:18.534 T:1945327264 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is ChapterOrBigStepForward 00:37:18.539 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 1 00:37:18.539 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:18.540 T:1538253728 DEBUG: demuxer seek to: 314462.000000 00:37:18.540 T:1538253728 DEBUG: SeekTime - unknown position after seek 00:37:18.540 T:1538253728 DEBUG: demuxer seek to: 314462.000000, success 00:37:18.540 T:1538253728 DEBUG: CVideoPlayer::FlushBuffers - flushing buffers 00:37:18.543 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:18.593 T:1164956576 DEBUG: CDVDAudio::Flush - flush audio stream 00:37:18.593 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:18.593 T:1164956576 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:18.593 T:1173345184 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:18.594 T:1538253728 DEBUG: CVideoPlayer - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:18.594 T:1945327264 DEBUG: CMMALRenderer::RenderUpdate - vsync 5794 (+2) 00:37:18.594 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 2 00:37:18.594 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:18.603 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:18.629 T:1173345184 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 00:37:18.631 T:1173345184 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264 00:37:18.631 T:1173345184 NOTICE: CDecoder::Open - fmt:0 00:37:18.631 T:1173345184 DEBUG: CDecoder::Open MMAL - source requires 3 references 00:37:18.634 T:1173345184 DEBUG: CMMALPool::CMMALPool Created pool 0x6ed3dd70 of size 26 x 0 for port vc.ril.video_decode:out:0(I420) 00:37:18.634 T:1173345184 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264-mmal 00:37:18.654 T:1538253728 DEBUG: CVideoPlayer::HandleMessages - player started 1 00:37:18.654 T:1538253728 DEBUG: CVideoPlayer::HandleMessages - player started 2 00:37:18.654 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 3 00:37:18.654 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:18.655 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 0 00:37:18.655 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:18.655 T:1538253728 DEBUG: VideoPlayer::Sync - Audio - pts: 314752000.000000, cache: 256000.041962, totalcache: 500000.000000 00:37:18.655 T:1538253728 DEBUG: VideoPlayer::Sync - Video - pts: 314500000.000000, cache: 50000.000000, totalcache: 100000.000000 00:37:18.655 T:1164956576 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(314400000.000000) 00:37:18.655 T:1164956576 DEBUG: CDVDAudio::Resume - resume audio stream 00:37:18.655 T:1923376032 DEBUG: ActiveAE - start sync of audio stream 00:37:18.659 T:1173345184 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(314400000.000000) 00:37:18.684 T:1858073504 DEBUG: CMMALPool::~CMMALPool Destroying pool 0x6ed38b80 for port vc.ril.video_decode:out:0(I420) 00:37:18.757 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 239 (rep:0 size:0) 00:37:18.757 T:1787818912 DEBUG: PushCecKeypress - ignored key a6 00:37:18.774 T:1945314208 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 00:37:18.774 T:1945314208 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 00:37:18.792 T:1923376032 DEBUG: ActiveAE::SyncStream - average error of 61.770052, start adjusting 00:37:18.792 T:1923376032 DEBUG: ActiveAE::SyncStream - average error 11.770052 below threshold of 30.000000 00:37:19.123 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 00:37:19.123 T:1787818912 DEBUG: PushCecKeypress - added key a6 00:37:19.134 T:1945327264 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is ChapterOrBigStepForward 00:37:19.138 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 1 00:37:19.138 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:19.138 T:1538253728 DEBUG: demuxer seek to: 374523.000000 00:37:19.138 T:1538253728 DEBUG: SeekTime - unknown position after seek 00:37:19.139 T:1538253728 DEBUG: demuxer seek to: 374523.000000, success 00:37:19.139 T:1538253728 DEBUG: CVideoPlayer::FlushBuffers - flushing buffers 00:37:19.143 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:19.192 T:1164956576 DEBUG: CDVDAudio::Flush - flush audio stream 00:37:19.192 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:19.192 T:1164956576 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:19.192 T:1173345184 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:19.193 T:1945327264 DEBUG: CMMALRenderer::RenderUpdate - vsync 5830 (+2) 00:37:19.194 T:1538253728 DEBUG: CVideoPlayer - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:19.194 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 2 00:37:19.194 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:19.202 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:19.228 T:1173345184 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 00:37:19.230 T:1173345184 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264 00:37:19.230 T:1173345184 NOTICE: CDecoder::Open - fmt:0 00:37:19.230 T:1173345184 DEBUG: CDecoder::Open MMAL - source requires 3 references 00:37:19.233 T:1173345184 DEBUG: CMMALPool::CMMALPool Created pool 0x6ed3b3e0 of size 26 x 0 for port vc.ril.video_decode:out:0(I420) 00:37:19.233 T:1173345184 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-h264-mmal 00:37:19.256 T:1538253728 DEBUG: CVideoPlayer::HandleMessages - player started 1 00:37:19.271 T:1538253728 DEBUG: CVideoPlayer::HandleMessages - player started 2 00:37:19.271 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 3 00:37:19.271 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:19.272 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 0 00:37:19.272 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:19.272 T:1538253728 DEBUG: VideoPlayer::Sync - Audio - pts: 375253333.000000, cache: 256000.041962, totalcache: 500000.000000 00:37:19.272 T:1538253728 DEBUG: VideoPlayer::Sync - Video - pts: 375000000.000000, cache: 50000.000000, totalcache: 100000.000000 00:37:19.272 T:1164956576 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(374900000.000000) 00:37:19.272 T:1173345184 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(374900000.000000) 00:37:19.272 T:1164956576 DEBUG: CDVDAudio::Resume - resume audio stream 00:37:19.272 T:1923376032 DEBUG: ActiveAE - start sync of audio stream 00:37:19.317 T:1858073504 DEBUG: CMMALPool::~CMMALPool Destroying pool 0x6ed3dd70 for port vc.ril.video_decode:out:0(I420) 00:37:19.357 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 235 (rep:0 size:0) 00:37:19.357 T:1787818912 DEBUG: PushCecKeypress - ignored key a6 00:37:19.369 T:1945314208 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 00:37:19.370 T:1945314208 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 00:37:19.392 T:1923376032 DEBUG: ActiveAE::SyncStream - average error of 70.067416, start adjusting 00:37:19.392 T:1923376032 DEBUG: ActiveAE::SyncStream - average error 20.067416 below threshold of 30.000000 00:37:19.839 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:37:19.839 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:37:19.850 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is ChapterOrBigStepBack 00:37:19.852 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 1 00:37:19.852 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:19.852 T:1538253728 DEBUG: demuxer seek to: 315832.000000 00:37:19.852 T:1538253728 DEBUG: SeekTime - unknown position after seek 00:37:19.852 T:1538253728 DEBUG: demuxer seek to: 315832.000000, success 00:37:19.852 T:1538253728 DEBUG: CVideoPlayer::FlushBuffers - flushing buffers 00:37:19.893 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:19.942 T:1164956576 DEBUG: CDVDAudio::Flush - flush audio stream 00:37:19.942 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:19.942 T:1164956576 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:19.942 T:1173345184 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:19.944 T:1538253728 DEBUG: CVideoPlayer - CDVDMsg::GENERAL_SYNCHRONIZE 00:37:19.944 T:1538253728 DEBUG: CVideoPlayer::SetCaching - caching state 2 00:37:19.944 T:1538253728 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 00:37:19.948 T:1945327264 DEBUG: CMMALRenderer::RenderUpdate - vsync 5873 (+4) 00:37:19.952 T:1164956576 DEBUG: CDVDAudio::Pause - pausing audio stream 00:37:20.012 T:1945314208 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 00:37:20.012 T:1945314208 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 00:37:20.181 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 343 (rep:0 size:0) 00:37:20.181 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:37:20.491 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 00:37:20.491 T:1787818912 DEBUG: PushCecKeypress - added key a6 00:37:20.500 T:1945327264 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is ChapterOrBigStepForward 00:37:20.833 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 342 (rep:0 size:0) 00:37:20.833 T:1787818912 DEBUG: PushCecKeypress - ignored key a6 00:37:21.001 T:1945327264 DEBUG: CDVDMsgGeneralSynchronize - global timeout 00:37:21.006 T:1945327264 DEBUG: CMMALRenderer::RenderUpdate - vsync 5912 (+29) 00:37:21.067 T:1945314208 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 00:37:21.067 T:1945314208 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 00:37:21.446 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:37:21.447 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:37:21.450 T:1945327264 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is ChapterOrBigStepBack 00:37:21.681 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 235 (rep:0 size:0) 00:37:21.681 T:1787818912 DEBUG: PushCecKeypress - ignored key a7 00:37:21.951 T:1945327264 DEBUG: CDVDMsgGeneralSynchronize - global timeout 00:37:21.956 T:1945327264 DEBUG: CMMALRenderer::RenderUpdate - vsync 5969 (+29) 00:37:22.021 T:1945314208 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 00:37:22.022 T:1945314208 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 00:37:22.471 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 00:37:22.471 T:1787818912 DEBUG: PushCecKeypress - added key a6 00:37:22.483 T:1945327264 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is ChapterOrBigStepForward 00:37:22.809 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 338 (rep:0 size:0) 00:37:22.809 T:1787818912 DEBUG: PushCecKeypress - ignored key a6 00:37:22.983 T:1945327264 DEBUG: CDVDMsgGeneralSynchronize - global timeout 00:37:22.989 T:1945327264 DEBUG: CMMALRenderer::RenderUpdate - vsync 6031 (+29) 00:37:23.054 T:1945314208 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 00:37:23.054 T:1945314208 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 00:37:25.437 T:1945327264 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 00:37:25.438 T:1945327264 DEBUG: ------ Window Deinit (Custom_1109_TopBarOverlay.xml) ------ 00:37:31.611 T:1754264480 DEBUG: Thread JobWorker 1754264480 terminating (autodelete) 00:37:31.611 T:1521476512 DEBUG: Thread JobWorker 1521476512 terminating (autodelete) 00:37:32.104 T:1762653088 DEBUG: Thread JobWorker 1762653088 terminating (autodelete) 00:38:20.090 T:1913648032 DEBUG: CAESinkPi:Drain delay:99ms now:0ms 00:38:30.090 T:1913648032 DEBUG: CAESinkPi:Deinitialize 00:38:30.091 T:1913648032 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 00:38:30.093 T:1913648032 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x71700470 00:40:25.679 T:1945327264 NOTICE: NFS: sending keep alive after 180 s. 00:41:06.555 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 00:41:06.555 T:1787818912 DEBUG: PushCecKeypress - added key a7 00:41:06.784 T:1787818912 DEBUG: PushCecKeypress - received key a7 duration 229 (rep:0 size:1) 00:41:06.784 T:1787818912 DEBUG: PushCecKeypress - replaced key a7 00:41:08.257 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:1) 00:41:08.258 T:1787818912 DEBUG: PushCecKeypress - added key a6 00:41:08.605 T:1787818912 DEBUG: PushCecKeypress - received key a6 duration 347 (rep:0 size:2) 00:41:08.605 T:1787818912 DEBUG: PushCecKeypress - ignored key a6 00:41:11.028 T:1787818912 DEBUG: PushCecKeypress - received key e0 duration 1000 (rep:0 size:2) 00:41:11.028 T:1787818912 DEBUG: PushCecKeypress - added key e0 00:41:13.719 T:1787818912 DEBUG: PushCecKeypress - received key e0 duration 900 (rep:0 size:3) 00:41:13.720 T:1787818912 DEBUG: PushCecKeypress - added key e0 00:41:14.720 T:1787818912 DEBUG: PushCecKeypress - received key e0 duration 1000 (rep:0 size:4) 00:41:14.720 T:1787818912 DEBUG: PushCecKeypress - added key e0