2019-02-26 11:14:59.221 T:3131 NOTICE: ----------------------------------------------------------------------- 2019-02-26 11:14:59.222 T:3131 NOTICE: Starting Kodi (18.1 Git:20190217-8cfdc89). Platform: Android ARM 32-bit 2019-02-26 11:14:59.222 T:3131 NOTICE: Using Release Kodi x32 build 2019-02-26 11:14:59.222 T:3131 NOTICE: Kodi compiled 2019-02-17 by Clang 7.0.2 (https://android.googlesource.com/toolchain/clang 003100370607242ddd5815e4a043907ea9004281) (https://android.googlesource.com/toolchain/llvm 1d739ffb0366421d383e04ff80ec2ee591315116) for Android ARM 32-bit API level 21 (API level 21) 2019-02-26 11:14:59.223 T:3131 NOTICE: Running on Amazon AFTT with Android 5.1.1 API level 22, kernel: Linux ARM 32-bit version 3.10.54+ 2019-02-26 11:14:59.224 T:3131 NOTICE: FFmpeg version/source: 4.0.3-Kodi 2019-02-26 11:14:59.225 T:3131 NOTICE: Host CPU: ARMv7 Processor rev 3 (v7l), 4 cores available 2019-02-26 11:14:59.225 T:3131 NOTICE: Product: full_tank, Device: tank, Board: tank - Manufacturer: Amazon, Brand: Amazon, Model: AFTT, Hardware: mt8127 2019-02-26 11:14:59.227 T:3131 NOTICE: External storage path = /storage/emulated/0; status = ok 2019-02-26 11:14:59.228 T:3131 NOTICE: ARM Features: Neon enabled 2019-02-26 11:14:59.228 T:3131 NOTICE: special://xbmc/ is mapped to: /data/data/org.xbmc.kodi/cache/apk/assets 2019-02-26 11:14:59.228 T:3131 NOTICE: special://xbmcbin/ is mapped to: /data/data/org.xbmc.kodi/cache/apk/assets 2019-02-26 11:14:59.228 T:3131 NOTICE: special://xbmcbinaddons/ is mapped to: /data/data/org.xbmc.kodi/cache/apk/assets/addons 2019-02-26 11:14:59.229 T:3131 NOTICE: special://masterprofile/ is mapped to: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/userdata 2019-02-26 11:14:59.229 T:3131 NOTICE: special://envhome/ is mapped to: /storage/emulated/0/Android/data/org.xbmc.kodi/files 2019-02-26 11:14:59.229 T:3131 NOTICE: special://home/ is mapped to: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi 2019-02-26 11:14:59.229 T:3131 NOTICE: special://temp/ is mapped to: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/temp 2019-02-26 11:14:59.229 T:3131 NOTICE: special://logpath/ is mapped to: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/temp 2019-02-26 11:14:59.230 T:3131 NOTICE: The executable running is: /data/app/org.xbmc.kodi-2/lib/arm/libkodi.so 2019-02-26 11:14:59.238 T:3131 NOTICE: Local hostname: FireTVStick.fritz.box 2019-02-26 11:14:59.239 T:3131 NOTICE: Log File is located: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/temp/kodi.log 2019-02-26 11:14:59.239 T:3131 NOTICE: ----------------------------------------------------------------------- 2019-02-26 11:14:59.247 T:3131 INFO: loading settings 2019-02-26 11:14:59.251 T:3131 NOTICE: special://profile/ is mapped to: special://masterprofile/ 2019-02-26 11:14:59.325 T:3131 DEBUG: CSkinSettings: no tag found 2019-02-26 11:14:59.326 T:3131 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml 2019-02-26 11:14:59.334 T:3131 NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml) 2019-02-26 11:14:59.335 T:3131 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 2019-02-26 11:14:59.336 T:3131 NOTICE: Default Video Player: VideoPlayer 2019-02-26 11:14:59.336 T:3131 NOTICE: Default Audio Player: paplayer 2019-02-26 11:14:59.336 T:3131 NOTICE: Disabled debug logging due to GUI setting. Level 0. 2019-02-26 11:14:59.346 T:3131 NOTICE: Log level changed to "LOG_LEVEL_NORMAL" 2019-02-26 11:14:59.421 T:3131 NOTICE: Running database version Addons27 2019-02-26 11:14:59.627 T:3131 NOTICE: ADDON: audioencoder.kodi.builtin.aac v1.0.0 installed 2019-02-26 11:14:59.627 T:3131 NOTICE: ADDON: audioencoder.kodi.builtin.wma v1.0.0 installed 2019-02-26 11:14:59.627 T:3131 NOTICE: ADDON: game.controller.default v1.0.8 installed 2019-02-26 11:14:59.628 T:3131 NOTICE: ADDON: game.controller.snes v1.0.8 installed 2019-02-26 11:14:59.628 T:3131 NOTICE: ADDON: inputstream.adaptive v2.3.15 installed 2019-02-26 11:14:59.628 T:3131 NOTICE: ADDON: kodi.binary.global.audioengine v1.0.1 installed 2019-02-26 11:14:59.628 T:3131 NOTICE: ADDON: kodi.binary.global.filesystem v1.0.2 installed 2019-02-26 11:14:59.629 T:3131 NOTICE: ADDON: kodi.binary.global.general v1.0.3 installed 2019-02-26 11:14:59.629 T:3131 NOTICE: ADDON: kodi.binary.global.gui v5.12.0 installed 2019-02-26 11:14:59.629 T:3131 NOTICE: ADDON: kodi.binary.global.main v1.0.14 installed 2019-02-26 11:14:59.630 T:3131 NOTICE: ADDON: kodi.binary.global.network v1.0.0 installed 2019-02-26 11:14:59.630 T:3131 NOTICE: ADDON: kodi.binary.instance.audiodecoder v2.0.0 installed 2019-02-26 11:14:59.630 T:3131 NOTICE: ADDON: kodi.binary.instance.audioencoder v2.0.0 installed 2019-02-26 11:14:59.630 T:3131 NOTICE: ADDON: kodi.binary.instance.game v1.1.0 installed 2019-02-26 11:14:59.630 T:3131 NOTICE: ADDON: kodi.binary.instance.imagedecoder v2.0.0 installed 2019-02-26 11:14:59.630 T:3131 NOTICE: ADDON: kodi.binary.instance.inputstream v2.0.8 installed 2019-02-26 11:14:59.631 T:3131 NOTICE: ADDON: kodi.binary.instance.peripheral v1.3.7 installed 2019-02-26 11:14:59.631 T:3131 NOTICE: ADDON: kodi.binary.instance.pvr v5.10.3 installed 2019-02-26 11:14:59.631 T:3131 NOTICE: ADDON: kodi.binary.instance.screensaver v2.0.0 installed 2019-02-26 11:14:59.631 T:3131 NOTICE: ADDON: kodi.binary.instance.vfs v2.0.0 installed 2019-02-26 11:14:59.631 T:3131 NOTICE: ADDON: kodi.binary.instance.videocodec v1.0.1 installed 2019-02-26 11:14:59.631 T:3131 NOTICE: ADDON: kodi.binary.instance.visualization v2.0.1 installed 2019-02-26 11:14:59.632 T:3131 NOTICE: ADDON: kodi.resource v1.0.0 installed 2019-02-26 11:14:59.632 T:3131 NOTICE: ADDON: metadata.album.universal v3.1.1 installed 2019-02-26 11:14:59.632 T:3131 NOTICE: ADDON: metadata.artists.universal v4.2.1 installed 2019-02-26 11:14:59.632 T:3131 NOTICE: ADDON: metadata.common.allmusic.com v3.2.0 installed 2019-02-26 11:14:59.632 T:3131 NOTICE: ADDON: metadata.common.fanart.tv v3.6.0 installed 2019-02-26 11:14:59.632 T:3131 NOTICE: ADDON: metadata.common.imdb.com v3.1.4 installed 2019-02-26 11:14:59.633 T:3131 NOTICE: ADDON: metadata.common.musicbrainz.org v2.2.1 installed 2019-02-26 11:14:59.633 T:3131 NOTICE: ADDON: metadata.common.theaudiodb.com v2.0.1 installed 2019-02-26 11:14:59.633 T:3131 NOTICE: ADDON: metadata.common.themoviedb.org v3.1.9 installed 2019-02-26 11:14:59.633 T:3131 NOTICE: ADDON: metadata.local v1.0.0 installed 2019-02-26 11:14:59.633 T:3131 NOTICE: ADDON: metadata.themoviedb.org v5.1.5 installed 2019-02-26 11:14:59.634 T:3131 NOTICE: ADDON: metadata.tvdb.com v3.0.14 installed 2019-02-26 11:14:59.634 T:3131 NOTICE: ADDON: metadata.tvshows.themoviedb.org v3.1.0 installed 2019-02-26 11:14:59.634 T:3131 NOTICE: ADDON: peripheral.joystick v1.4.7 installed 2019-02-26 11:14:59.634 T:3131 NOTICE: ADDON: plugin.video.eurosportplayer v2.2.1 installed 2019-02-26 11:14:59.634 T:3131 NOTICE: ADDON: plugin.video.skygo.de v1.13.4 installed 2019-02-26 11:14:59.634 T:3131 NOTICE: ADDON: pvr.iptvsimple v3.5.7 installed 2019-02-26 11:14:59.635 T:3131 NOTICE: ADDON: repository.kodinerds v6.0.0 installed 2019-02-26 11:14:59.635 T:3131 NOTICE: ADDON: repository.xbmc.org v3.1.5 installed 2019-02-26 11:14:59.635 T:3131 NOTICE: ADDON: resource.images.weathericons.default v1.1.8 installed 2019-02-26 11:14:59.635 T:3131 NOTICE: ADDON: resource.language.de_de v9.0.17 installed 2019-02-26 11:14:59.635 T:3131 NOTICE: ADDON: resource.language.en_gb v2.0.1 installed 2019-02-26 11:14:59.635 T:3131 NOTICE: ADDON: resource.uisounds.kodi v1.0.0 installed 2019-02-26 11:14:59.636 T:3131 NOTICE: ADDON: screensaver.xbmc.builtin.black v1.0.32 installed 2019-02-26 11:14:59.636 T:3131 NOTICE: ADDON: screensaver.xbmc.builtin.dim v1.0.53 installed 2019-02-26 11:14:59.636 T:3131 NOTICE: ADDON: script.common.plugin.cache v2.5.10 installed 2019-02-26 11:14:59.636 T:3131 NOTICE: ADDON: script.kodi.android.update v1.1.1 installed 2019-02-26 11:14:59.636 T:3131 NOTICE: ADDON: script.module.beautifulsoup4 v4.5.3 installed 2019-02-26 11:14:59.637 T:3131 NOTICE: ADDON: script.module.certifi v2017.07.27.1 installed 2019-02-26 11:14:59.637 T:3131 NOTICE: ADDON: script.module.chardet v3.0.4 installed 2019-02-26 11:14:59.637 T:3131 NOTICE: ADDON: script.module.cryptopy v1.2.6 installed 2019-02-26 11:14:59.637 T:3131 NOTICE: ADDON: script.module.idna v2.6 installed 2019-02-26 11:14:59.637 T:3131 NOTICE: ADDON: script.module.inputstreamhelper v0.3.3 installed 2019-02-26 11:14:59.637 T:3131 NOTICE: ADDON: script.module.pil v1.1.7 installed 2019-02-26 11:14:59.637 T:3131 NOTICE: ADDON: script.module.pycryptodome v3.4.3 installed 2019-02-26 11:14:59.638 T:3131 NOTICE: ADDON: script.module.pydes v2.0.1 installed 2019-02-26 11:14:59.638 T:3131 NOTICE: ADDON: script.module.requests v2.19.1 installed 2019-02-26 11:14:59.638 T:3131 NOTICE: ADDON: script.module.routing v0.2.1 installed 2019-02-26 11:14:59.638 T:3131 NOTICE: ADDON: script.module.simplecache v1.0.11 installed 2019-02-26 11:14:59.638 T:3131 NOTICE: ADDON: script.module.urllib3 v1.22 installed 2019-02-26 11:14:59.638 T:3131 NOTICE: ADDON: service.xbmc.versioncheck v0.4.6 installed 2019-02-26 11:14:59.639 T:3131 NOTICE: ADDON: skin.estouchy v2.0.22 installed 2019-02-26 11:14:59.639 T:3131 NOTICE: ADDON: skin.estuary v2.0.21 installed 2019-02-26 11:14:59.639 T:3131 NOTICE: ADDON: webinterface.default v18.x-2.4.6 installed 2019-02-26 11:14:59.640 T:3131 NOTICE: ADDON: xbmc.addon v18.1.0 installed 2019-02-26 11:14:59.640 T:3131 NOTICE: ADDON: xbmc.core v0.1.0 installed 2019-02-26 11:14:59.640 T:3131 NOTICE: ADDON: xbmc.gui v5.14.0 installed 2019-02-26 11:14:59.640 T:3131 NOTICE: ADDON: xbmc.json v10.1.2 installed 2019-02-26 11:14:59.640 T:3131 NOTICE: ADDON: xbmc.metadata v2.1.0 installed 2019-02-26 11:14:59.641 T:3131 NOTICE: ADDON: xbmc.python v2.26.0 installed 2019-02-26 11:14:59.641 T:3131 NOTICE: ADDON: xbmc.webinterface v1.0.0 installed 2019-02-26 11:15:00.055 T:3180 NOTICE: Float is supported 2019-02-26 11:15:00.077 T:3180 NOTICE: Found 1 Lists of Devices 2019-02-26 11:15:00.077 T:3180 NOTICE: Enumerated AUDIOTRACK devices: 2019-02-26 11:15:00.077 T:3180 NOTICE: Device 1 2019-02-26 11:15:00.079 T:3180 NOTICE: m_deviceName : AudioTrack 2019-02-26 11:15:00.080 T:3180 NOTICE: m_displayName : android 2019-02-26 11:15:00.080 T:3180 NOTICE: m_displayNameExtra: audiotrack 2019-02-26 11:15:00.080 T:3180 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 2019-02-26 11:15:00.080 T:3180 NOTICE: m_channels : FL, FR, FC, LFE, SL, SR, BL, BR, BC, BLOC, BROC 2019-02-26 11:15:00.080 T:3180 NOTICE: m_sampleRates : 32000,44100,48000,88200,96000 2019-02-26 11:15:00.081 T:3180 NOTICE: m_dataFormats : AE_FMT_S16LE,AE_FMT_FLOAT,AE_FMT_RAW 2019-02-26 11:15:00.081 T:3180 NOTICE: m_streamTypes : No passthrough capabilities 2019-02-26 11:15:00.082 T:3181 NOTICE: Trying to open: samplerate: 44100, channelMask: 12, encoding: 4 2019-02-26 11:15:00.090 T:3181 NOTICE: CAESinkAUDIOTRACK::Initializing with: m_sampleRate: 44100 format: AE_FMT_FLOAT (AE) method: PCM stream-type: PCM-STREAM min_buffer_size: 60208 m_frames: 3763 m_frameSize: 8 channels: 2 2019-02-26 11:15:00.280 T:3131 NOTICE: CAndroidUtils: window resolution: 1920x1080 2019-02-26 11:15:00.289 T:3131 NOTICE: CAndroidUtils: Current resolution: 1920x1080 1920x1080 @ 59.939999 - Full Screen 2019-02-26 11:15:00.504 T:3131 NOTICE: Previous line repeats 1 times. 2019-02-26 11:15:00.504 T:3131 NOTICE: Mediacodec: OMX.MTK.AUDIO.DECODER.MP3 2019-02-26 11:15:00.505 T:3131 NOTICE: Mediacodec: OMX.MTK.VIDEO.DECODER.MPEG4 2019-02-26 11:15:00.505 T:3131 NOTICE: Mediacodec: OMX.MTK.VIDEO.DECODER.H263 2019-02-26 11:15:00.505 T:3131 NOTICE: Mediacodec: OMX.MTK.VIDEO.DECODER.MPEG2 2019-02-26 11:15:00.506 T:3131 NOTICE: Mediacodec: OMX.MTK.VIDEO.DECODER.AVC 2019-02-26 11:15:00.506 T:3131 NOTICE: Mediacodec: OMX.MTK.VIDEO.DECODER.HEVC 2019-02-26 11:15:00.506 T:3131 NOTICE: Mediacodec: OMX.dolby.ac3.decoder 2019-02-26 11:15:00.506 T:3131 NOTICE: Mediacodec: OMX.dolby.eac3.decoder 2019-02-26 11:15:00.507 T:3131 NOTICE: Mediacodec: OMX.dolby.eac3_joc.decoder 2019-02-26 11:15:00.507 T:3131 NOTICE: Mediacodec: OMX.google.mp3.decoder 2019-02-26 11:15:00.507 T:3131 NOTICE: Mediacodec: OMX.google.amrnb.decoder 2019-02-26 11:15:00.507 T:3131 NOTICE: Mediacodec: OMX.google.amrwb.decoder 2019-02-26 11:15:00.508 T:3131 NOTICE: Mediacodec: OMX.google.aac.decoder 2019-02-26 11:15:00.508 T:3131 NOTICE: Mediacodec: OMX.google.g711.alaw.decoder 2019-02-26 11:15:00.508 T:3131 NOTICE: Mediacodec: OMX.google.g711.mlaw.decoder 2019-02-26 11:15:00.509 T:3131 NOTICE: Mediacodec: OMX.google.vorbis.decoder 2019-02-26 11:15:00.509 T:3131 NOTICE: Mediacodec: OMX.google.opus.decoder 2019-02-26 11:15:00.509 T:3131 NOTICE: Mediacodec: OMX.google.raw.decoder 2019-02-26 11:15:00.510 T:3131 NOTICE: Mediacodec: OMX.google.gsm.decoder 2019-02-26 11:15:00.510 T:3131 NOTICE: Mediacodec: OMX.google.mpeg4.decoder 2019-02-26 11:15:00.510 T:3131 NOTICE: Mediacodec: OMX.google.h263.decoder 2019-02-26 11:15:00.511 T:3131 NOTICE: Mediacodec: OMX.google.h264.decoder 2019-02-26 11:15:00.511 T:3131 NOTICE: Mediacodec: OMX.google.vp8.decoder 2019-02-26 11:15:00.511 T:3131 NOTICE: Mediacodec: OMX.google.vp9.decoder 2019-02-26 11:15:00.512 T:3131 NOTICE: EGL_VERSION = 1.4 Android META-EGL 2019-02-26 11:15:00.512 T:3131 NOTICE: EGL_VENDOR = Android 2019-02-26 11:15:00.512 T:3131 NOTICE: EGL_EXTENSIONS = EGL_KHR_get_all_proc_addresses EGL_ANDROID_presentation_time EGL_KHR_image EGL_KHR_image_base EGL_KHR_image_pixmap EGL_KHR_gl_texture_2D_image EGL_KHR_gl_texture_cubemap_image EGL_KHR_gl_renderbuffer_image EGL_KHR_fence_sync EGL_EXT_create_context_robustness EGL_ANDROID_image_native_buffer EGL_ANDROID_recordable 2019-02-26 11:15:00.514 T:3131 NOTICE: EGL_CLIENT_EXTENSIONS = NULL 2019-02-26 11:15:00.516 T:3131 NOTICE: Checking resolution 16 2019-02-26 11:15:00.533 T:3131 NOTICE: GL_VENDOR = ARM 2019-02-26 11:15:00.534 T:3131 NOTICE: GL_RENDERER = Mali-450 MP 2019-02-26 11:15:00.534 T:3131 NOTICE: GL_VERSION = OpenGL ES 2.0 2019-02-26 11:15:00.534 T:3131 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 2019-02-26 11:15:00.534 T:3131 NOTICE: GL_EXTENSIONS = GL_EXT_debug_marker GL_OES_texture_npot GL_OES_compressed_ETC1_RGB8_texture GL_OES_standard_derivatives GL_OES_EGL_image GL_OES_depth24 GL_ARM_rgba8 GL_ARM_mali_shader_binary GL_OES_depth_texture GL_OES_packed_depth_stencil GL_EXT_texture_format_BGRA8888 GL_OES_vertex_half_float GL_EXT_blend_minmax GL_OES_EGL_image_external GL_OES_EGL_sync GL_OES_rgb8_rgba8 GL_EXT_multisampled_render_to_texture GL_EXT_discard_framebuffer GL_OES_get_program_binary GL_ARM_mali_program_binary GL_EXT_shader_texture_lod GL_EXT_robustness GL_OES_depth_texture_cube_map GL_KHR_debug 2019-02-26 11:15:02.404 T:3283 NOTICE: Running database version Addons27 2019-02-26 11:15:02.414 T:3283 NOTICE: Running database version ViewModes6 2019-02-26 11:15:02.429 T:3283 NOTICE: Running database version Textures13 2019-02-26 11:15:02.452 T:3283 NOTICE: Running database version MyMusic72 2019-02-26 11:15:02.482 T:3283 NOTICE: Running database version MyVideos116 2019-02-26 11:15:02.492 T:3283 NOTICE: Running database version TV32 2019-02-26 11:15:02.510 T:3283 NOTICE: Running database version Epg12 2019-02-26 11:15:02.921 T:3131 NOTICE: load skin from: /data/data/org.xbmc.kodi/cache/apk/assets/addons/skin.estuary (version: 2.0.21) 2019-02-26 11:15:04.119 T:3131 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 2019-02-26 11:15:04.538 T:3131 WARNING: CAndroidJoystickState: ignoring unknown axis 32 on input device "ELMCU 2.4GHz receiver" with ID 1 2019-02-26 11:15:05.805 T:3131 ERROR: AddOnLog: Joystick Support: Device "Sony Interactive Entertainment Wireless Controller": can't find tag 2019-02-26 11:15:06.113 T:3131 NOTICE: Register - new joystick device registered on android->android/inputdevice/1: ELMCU 2.4GHz receiver (0C40:8000) 2019-02-26 11:15:06.145 T:3131 NOTICE: Register - new keyboard device registered on application->keyboard: Tastatur (0000:0000) 2019-02-26 11:15:06.150 T:3131 NOTICE: Register - new mouse device registered on application->mouse: Maus (0000:0000) 2019-02-26 11:15:06.225 T:3131 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 2019-02-26 11:15:06.230 T:3131 NOTICE: Loaded playercorefactory configuration 2019-02-26 11:15:06.232 T:3131 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 2019-02-26 11:15:06.232 T:3131 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 2019-02-26 11:15:06.467 T:3131 NOTICE: initialize done 2019-02-26 11:15:06.467 T:3131 NOTICE: Running the application... 2019-02-26 11:15:06.735 T:3131 NOTICE: starting zeroconf publishing 2019-02-26 11:15:06.738 T:3732 NOTICE: ES: Starting UDP Event server on port 9777 2019-02-26 11:15:06.739 T:3732 NOTICE: UDP: Listening on port 9777 (ipv6 : false) 2019-02-26 11:15:06.878 T:3574 NOTICE: AddOnLog: PVR IPTV Simple Client: Loaded 102 channels. 2019-02-26 11:15:06.878 T:3574 NOTICE: PVR Manager: Starting 2019-02-26 11:15:07.061 T:3742 NOTICE: PVR Manager: Started 2019-02-26 11:15:07.303 T:3574 NOTICE: EPG thread started 2019-02-26 11:15:08.308 T:3782 NOTICE: AddOnLog: PVR IPTV Simple Client: EPG file path is not configured. EPG not loaded. 2019-02-26 11:15:21.179 T:3131 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 2019-02-26 11:15:21.180 T:3131 NOTICE: Enabled debug logging due to GUI setting. Level 2. 2019-02-26 11:15:21.184 T:3131 DEBUG: ------ Window Init () ------ 2019-02-26 11:15:28.001 T:5171 DEBUG: GetAlbumsByWhereJSON query: SELECT albumview.idAlbum, strAlbum, strArtists, art.url AS thumbnail FROM albumview LEFT JOIN art ON art.media_id = idAlbum AND art.media_type = 'album' AND art.type = 'thumb' WHERE albumview.strReleaseType = 'album' ORDER BY RANDOM() DESC LIMIT 3 2019-02-26 11:15:28.004 T:5171 DEBUG: GetAlbumsByWhereJSON - query took 3 ms 2019-02-26 11:15:33.127 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:33.128 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:15:33.228 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:39.518 T:3822 DEBUG: Thread JobWorker 3822 terminating (autodelete) 2019-02-26 11:15:39.544 T:3574 DEBUG: Thread JobWorker 3574 terminating (autodelete) 2019-02-26 11:15:39.584 T:3575 DEBUG: Thread JobWorker 3575 terminating (autodelete) 2019-02-26 11:15:40.354 T:3283 DEBUG: Thread JobWorker 3283 terminating (autodelete) 2019-02-26 11:15:42.796 T:3131 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:42.797 T:3131 DEBUG: HandleKey: backspace (0xf008) pressed, action is Back 2019-02-26 11:15:42.849 T:3131 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 2019-02-26 11:15:43.123 T:3131 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------ 2019-02-26 11:15:43.124 T:3131 DEBUG: FreeVisualisation() done 2019-02-26 11:15:43.127 T:3131 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 2019-02-26 11:15:43.127 T:3131 DEBUG: ------ Window Init (Settings.xml) ------ 2019-02-26 11:15:43.141 T:3131 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:44.429 T:3131 DEBUG: Previous line repeats 2 times. 2019-02-26 11:15:44.429 T:3131 DEBUG: HandleKey: backspace (0xf008) pressed, action is Back 2019-02-26 11:15:44.430 T:3131 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 2019-02-26 11:15:44.748 T:3131 DEBUG: ------ Window Deinit (Settings.xml) ------ 2019-02-26 11:15:44.748 T:3131 DEBUG: FreeVisualisation() done 2019-02-26 11:15:44.751 T:3131 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 2019-02-26 11:15:44.756 T:3131 DEBUG: ------ Window Init (Home.xml) ------ 2019-02-26 11:15:45.670 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:45.671 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:15:45.788 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:45.971 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:15:45.972 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:15:46.088 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:46.711 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:15:46.712 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:15:46.836 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:47.867 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:15:47.868 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:15:48.009 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:48.081 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:15:48.082 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:15:48.246 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:48.295 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:15:48.296 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:15:48.459 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:48.549 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:15:48.549 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:15:48.686 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:49.708 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:15:49.709 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:15:49.831 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:49.905 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:15:49.906 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:15:50.022 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:50.102 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:15:50.103 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:15:50.221 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:50.747 T:3131 DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:50.892 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:15:50.894 T:3131 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2019-02-26 11:15:50.895 T:3131 DEBUG: Activating window ID: 10025 2019-02-26 11:15:51.216 T:3131 DEBUG: ------ Window Deinit (Home.xml) ------ 2019-02-26 11:15:51.217 T:3131 DEBUG: FreeVisualisation() done 2019-02-26 11:15:51.353 T:3131 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 2019-02-26 11:15:51.353 T:3131 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 2019-02-26 11:15:51.754 T:3131 DEBUG: CDirectoryProvider[]: refreshing.. 2019-02-26 11:15:51.755 T:5975 DEBUG: Thread JobWorker start, auto delete: true 2019-02-26 11:15:51.755 T:3131 DEBUG: CDirectoryProvider[]: refreshing.. 2019-02-26 11:15:51.757 T:5976 DEBUG: Previous line repeats 5 times. 2019-02-26 11:15:51.758 T:5976 DEBUG: Thread JobWorker start, auto delete: true 2019-02-26 11:15:51.761 T:3131 DEBUG: CGUIMediaWindow::GetDirectory () 2019-02-26 11:15:51.762 T:3131 DEBUG: ParentPath = [] 2019-02-26 11:15:51.811 T:5994 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-02-26 11:15:51.812 T:5976 ERROR: GetDirectory - Error getting 2019-02-26 11:15:51.864 T:5994 ERROR: Previous line repeats 6 times. 2019-02-26 11:15:51.865 T:5994 DEBUG: Thread BackgroundLoader 5994 terminating 2019-02-26 11:15:53.185 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:53.186 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:15:53.321 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:54.681 T:3131 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:54.682 T:3131 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2019-02-26 11:15:54.833 T:3131 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:55.109 T:3131 DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:55.255 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:15:55.255 T:3131 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2019-02-26 11:15:55.261 T:3131 DEBUG: CGUIMediaWindow::GetDirectory (library://video/files.xml/) 2019-02-26 11:15:55.262 T:3131 DEBUG: ParentPath = [] 2019-02-26 11:15:55.263 T:6077 DEBUG: Thread waiting start, auto delete: false 2019-02-26 11:15:55.279 T:6077 DEBUG: Thread waiting 6077 terminating 2019-02-26 11:15:55.342 T:6080 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-02-26 11:15:55.379 T:6080 DEBUG: Thread BackgroundLoader 6080 terminating 2019-02-26 11:15:56.139 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:56.140 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:15:56.269 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:56.520 T:3131 DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:56.684 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:15:56.704 T:3131 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2019-02-26 11:15:56.708 T:3131 DEBUG: CGUIMediaWindow::GetDirectory (smb://WORKGROUP/) 2019-02-26 11:15:56.708 T:3131 DEBUG: ParentPath = [sources://video/] 2019-02-26 11:15:56.710 T:6150 DEBUG: Thread waiting start, auto delete: false 2019-02-26 11:15:56.810 T:3131 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2019-02-26 11:15:57.180 T:6150 DEBUG: Thread waiting 6150 terminating 2019-02-26 11:15:57.180 T:3131 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2019-02-26 11:15:57.200 T:6157 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-02-26 11:15:57.274 T:6157 DEBUG: Thread BackgroundLoader 6157 terminating 2019-02-26 11:15:57.834 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:57.834 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:15:57.988 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:58.307 T:3131 DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0 2019-02-26 11:15:58.397 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:15:58.398 T:3131 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2019-02-26 11:15:58.404 T:3131 DEBUG: CGUIMediaWindow::GetDirectory (smb://FRITZ-NAS/) 2019-02-26 11:15:58.404 T:3131 DEBUG: ParentPath = [smb://WORKGROUP/] 2019-02-26 11:15:58.407 T:6191 DEBUG: Thread waiting start, auto delete: false 2019-02-26 11:15:58.507 T:3131 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2019-02-26 11:16:00.769 T:6191 DEBUG: Thread waiting 6191 terminating 2019-02-26 11:16:00.773 T:3131 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2019-02-26 11:16:00.774 T:3131 DEBUG: Saving fileitems [smb://FRITZ-NAS/] 2019-02-26 11:16:00.778 T:3131 DEBUG: -- items: 1, sort method: 0, ascending: true 2019-02-26 11:16:00.796 T:6214 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-02-26 11:16:00.908 T:6214 DEBUG: Thread BackgroundLoader 6214 terminating 2019-02-26 11:16:01.422 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:01.423 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:16:01.553 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:01.887 T:3131 DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:02.021 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:02.021 T:3131 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2019-02-26 11:16:02.027 T:3131 DEBUG: CGUIMediaWindow::GetDirectory (smb://FRITZ-NAS/FRITZ.NAS/) 2019-02-26 11:16:02.027 T:3131 DEBUG: ParentPath = [smb://FRITZ-NAS/] 2019-02-26 11:16:02.030 T:6225 DEBUG: Thread waiting start, auto delete: false 2019-02-26 11:16:02.130 T:3131 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2019-02-26 11:16:02.419 T:6225 DEBUG: CSMBFile::Open - opened smb://USERNAME:PASSWORD@FRITZ-NAS/FRITZ.NAS/repository.kodinerds-6.0.0(1).zip, fd=10000 2019-02-26 11:16:02.560 T:6225 DEBUG: CSMBFile::Close closing fd 10000 2019-02-26 11:16:02.573 T:6225 DEBUG: CSMBFile::Open - opened smb://USERNAME:PASSWORD@FRITZ-NAS/FRITZ.NAS/sky.zip, fd=10000 2019-02-26 11:16:02.601 T:6225 DEBUG: CSMBFile::Close closing fd 10000 2019-02-26 11:16:02.606 T:6225 DEBUG: Thread waiting 6225 terminating 2019-02-26 11:16:02.613 T:3131 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2019-02-26 11:16:02.636 T:6240 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-02-26 11:16:03.103 T:6240 DEBUG: Thread BackgroundLoader 6240 terminating 2019-02-26 11:16:03.143 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:03.144 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:16:03.283 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:03.342 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:03.342 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:16:03.491 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:03.541 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:03.541 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:16:03.667 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:03.742 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:03.742 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:16:03.854 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:03.912 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:03.913 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:16:04.084 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:04.130 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:04.130 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:16:04.229 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:04.290 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:04.291 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:16:04.437 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:04.823 T:3131 DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:04.974 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:04.974 T:3131 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2019-02-26 11:16:04.978 T:3131 DEBUG: CGUIMediaWindow::GetDirectory (smb://FRITZ-NAS/FRITZ.NAS/Videos/) 2019-02-26 11:16:04.978 T:3131 DEBUG: ParentPath = [smb://FRITZ-NAS/FRITZ.NAS/] 2019-02-26 11:16:04.980 T:6310 DEBUG: Thread waiting start, auto delete: false 2019-02-26 11:16:05.031 T:6310 DEBUG: CSMBFile::Open - opened smb://USERNAME:PASSWORD@FRITZ-NAS/FRITZ.NAS/Videos/ntv.strm, fd=10000 2019-02-26 11:16:05.055 T:6310 DEBUG: CSMBFile::Close closing fd 10000 2019-02-26 11:16:05.057 T:6310 DEBUG: Thread waiting 6310 terminating 2019-02-26 11:16:05.095 T:6313 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-02-26 11:16:05.198 T:6313 DEBUG: Thread BackgroundLoader 6313 terminating 2019-02-26 11:16:05.881 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:05.881 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:16:06.024 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:06.408 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:06.409 T:3131 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2019-02-26 11:16:06.494 T:5975 DEBUG: ffmpeg[BAC26F68]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-02-26 11:16:06.544 T:3131 DEBUG: Keyboard: scancode: 0x14, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:07.530 T:3131 DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:07.707 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:07.707 T:3131 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2019-02-26 11:16:07.760 T:3131 DEBUG: OnPlayMedia smb://FRITZ-NAS/FRITZ.NAS/Videos/Semino Rossi im Göttinger Kauf Park – Goettinger-Tageblatt.d.mp4 2019-02-26 11:16:07.822 T:3157 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 2019-02-26 11:16:07.822 T:3157 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 2019-02-26 11:16:07.840 T:3131 DEBUG: CPlayerCoreFactory::GetPlayers(smb://FRITZ-NAS/FRITZ.NAS/Videos/Semino Rossi im Göttinger Kauf Park – Goettinger-Tageblatt.d.mp4) 2019-02-26 11:16:07.841 T:3131 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 2019-02-26 11:16:07.841 T:3131 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 2019-02-26 11:16:07.842 T:3131 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 2019-02-26 11:16:07.842 T:3131 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 2019-02-26 11:16:07.843 T:3131 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 2019-02-26 11:16:07.844 T:3131 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 2019-02-26 11:16:07.844 T:3131 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 2019-02-26 11:16:07.845 T:3131 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 2019-02-26 11:16:07.846 T:3131 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 2019-02-26 11:16:07.846 T:3131 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 2019-02-26 11:16:07.846 T:3131 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 2019-02-26 11:16:07.846 T:3131 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 2019-02-26 11:16:07.847 T:3131 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 2019-02-26 11:16:07.847 T:3131 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 2019-02-26 11:16:07.847 T:3131 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 2019-02-26 11:16:07.847 T:3131 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 2019-02-26 11:16:07.848 T:3131 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 2019-02-26 11:16:07.857 T:3131 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 2019-02-26 11:16:07.858 T:3131 NOTICE: VideoPlayer::OpenFile: smb://FRITZ-NAS/FRITZ.NAS/Videos/Semino Rossi im Göttinger Kauf Park – Goettinger-Tageblatt.d.mp4 2019-02-26 11:16:07.858 T:3131 DEBUG: OnPlayBackStarted: CApplication::OnPlayBackStarted 2019-02-26 11:16:07.859 T:6393 DEBUG: Thread VideoPlayer start, auto delete: false 2019-02-26 11:16:07.861 T:6393 NOTICE: Creating InputStream 2019-02-26 11:16:07.864 T:6394 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-02-26 11:16:07.886 T:6393 DEBUG: CSMBFile::Open - opened smb://USERNAME:PASSWORD@FRITZ-NAS/FRITZ.NAS/Videos/Semino Rossi im Göttinger Kauf Park – Goettinger-Tageblatt.d.mp4, fd=10000 2019-02-26 11:16:07.890 T:6393 DEBUG: ScanForExternalSubtitles: Searching for subtitles... 2019-02-26 11:16:07.898 T:6393 DEBUG: ScanForExternalSubtitles: END (total time: 9 ms) 2019-02-26 11:16:07.898 T:6393 NOTICE: Creating Demuxer 2019-02-26 11:16:07.903 T:3131 DEBUG: CVideoGUIInfo::InitCurrentItem(smb://FRITZ-NAS/FRITZ.NAS/Videos/Semino Rossi im Göttinger Kauf Park – Goettinger-Tageblatt.d.mp4) 2019-02-26 11:16:07.903 T:3131 DEBUG: CPlayerGUIInfo::InitCurrentItem(smb://FRITZ-NAS/FRITZ.NAS/Videos/Semino Rossi im Göttinger Kauf Park – Goettinger-Tageblatt.d.mp4) 2019-02-26 11:16:07.904 T:3157 DEBUG: CAnnouncementManager - Announcement: OnChanged from xbmc 2019-02-26 11:16:07.906 T:5975 DEBUG: Loading settings for smb://FRITZ-NAS/FRITZ.NAS/Videos/Semino Rossi im Göttinger Kauf Park – Goettinger-Tageblatt.d.mp4 2019-02-26 11:16:07.931 T:3157 DEBUG: GOT ANNOUNCEMENT, type: 1024, from xbmc, message OnChanged 2019-02-26 11:16:07.954 T:6393 DEBUG: Open - probing detected format [mov,mp4,m4a,3gp,3g2,mj2] 2019-02-26 11:16:07.988 T:6394 DEBUG: Thread BackgroundLoader 6394 terminating 2019-02-26 11:16:07.995 T:3157 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 2019-02-26 11:16:07.996 T:3157 DEBUG: void CXBMCApp::OnPlayBackStarted() 2019-02-26 11:16:08.004 T:6393 INFO: ffmpeg[BAACFAF0]: [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 2019-02-26 11:16:08.005 T:3131 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2019-02-26 11:16:08.045 T:6393 DEBUG: Open - avformat_find_stream_info starting 2019-02-26 11:16:08.227 T:3157 DEBUG: Visible Behind request: true 2019-02-26 11:16:08.227 T:3157 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 2019-02-26 11:16:08.242 T:6393 DEBUG: Open - av_find_stream_info finished 2019-02-26 11:16:08.246 T:6393 INFO: ffmpeg[BAACFAF0]: Input #0, mov,mp4,m4a,3gp,3g2,mj2, from 'smb://FRITZ-NAS/FRITZ.NAS/Videos/Semino Rossi im Göttinger Kauf Park – Goettinger-Tageblatt.d.mp4': 2019-02-26 11:16:08.247 T:6393 INFO: ffmpeg[BAACFAF0]: Metadata: 2019-02-26 11:16:08.247 T:6393 INFO: ffmpeg[BAACFAF0]: major_brand : isom 2019-02-26 11:16:08.248 T:6393 INFO: ffmpeg[BAACFAF0]: minor_version : 1 2019-02-26 11:16:08.248 T:6393 INFO: ffmpeg[BAACFAF0]: compatible_brands: isomavc1mp42 2019-02-26 11:16:08.248 T:6393 INFO: ffmpeg[BAACFAF0]: creation_time : 2017-10-20T17:36:48.000000Z 2019-02-26 11:16:08.249 T:6393 INFO: ffmpeg[BAACFAF0]: Duration: 00:02:58.11, start: 0.000000, bitrate: 587 kb/s 2019-02-26 11:16:08.250 T:6393 INFO: ffmpeg[BAACFAF0]: Stream #0:0(und): Video: h264 (Constrained Baseline) (avc1 / 0x31637661), yuv420p(tv, bt709), 480x270 [SAR 1:1 DAR 16:9], 521 kb/s, 25 fps, 25 tbr, 25 tbn, 50 tbc (default) 2019-02-26 11:16:08.250 T:6393 INFO: ffmpeg[BAACFAF0]: Metadata: 2019-02-26 11:16:08.251 T:6393 INFO: ffmpeg[BAACFAF0]: creation_time : 2017-10-20T17:36:14.000000Z 2019-02-26 11:16:08.252 T:6393 INFO: ffmpeg[BAACFAF0]: Stream #0:1(und): Audio: aac (LC) (mp4a / 0x6134706D), 48000 Hz, stereo, fltp, 63 kb/s (default) 2019-02-26 11:16:08.252 T:6393 INFO: ffmpeg[BAACFAF0]: Metadata: 2019-02-26 11:16:08.253 T:6393 INFO: ffmpeg[BAACFAF0]: creation_time : 2017-10-20T17:35:35.000000Z 2019-02-26 11:16:08.254 T:6393 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0 2019-02-26 11:16:08.254 T:6393 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1 2019-02-26 11:16:08.256 T:6393 NOTICE: Opening stream: 0 source: 256 2019-02-26 11:16:08.260 T:6393 NOTICE: Whitelist search for: width: 480, height: 270, fps: 25.000, 3D: false 2019-02-26 11:16:08.263 T:6393 DEBUG: Whitelist is empty using default one 2019-02-26 11:16:08.265 T:6393 DEBUG: Trying to find exact refresh rate 2019-02-26 11:16:08.266 T:6393 DEBUG: No exact whitelisted resolution matched, trying double refresh rate 2019-02-26 11:16:08.266 T:6393 DEBUG: No double refresh rate whitelisted resolution matched, trying current resolution 2019-02-26 11:16:08.266 T:6393 DEBUG: Current resolution doesn't match, trying default resolution 2019-02-26 11:16:08.267 T:6393 DEBUG: Default resolution doesn't provide reqired refreshrate, trying default resolution with double refreshrate 2019-02-26 11:16:08.267 T:6393 DEBUG: Matched fuzzy whitelisted Resolution 1920x1080 @ 50.000000 - Full Screen (22) 2019-02-26 11:16:08.267 T:6393 NOTICE: Display resolution ADJUST : 1920x1080 @ 50.000000 - Full Screen (22) (weight: -0.000) 2019-02-26 11:16:08.315 T:3131 DEBUG: CAndroidUtils: SetNativeResolution: -1: 1920x1080 1920x1080@50.000000 2019-02-26 11:16:08.333 T:6408 DEBUG: Thread Timer start, auto delete: false 2019-02-26 11:16:08.409 T:3181 DEBUG: Draining Audio 2019-02-26 11:16:08.410 T:3181 DEBUG: CAESinkAUDIOTRACK::Deinitialize 2019-02-26 11:16:08.413 T:2905 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:08.414 T:2905 NOTICE: VideoPlayer: OnLostDisplay received 2019-02-26 11:16:08.421 T:2905 WARNING: CDVDMessageQueue(audio)::Put MSGQ_NOT_INITIALIZED 2019-02-26 11:16:08.422 T:2905 WARNING: CDVDMessageQueue(video)::Put MSGQ_NOT_INITIALIZED 2019-02-26 11:16:10.237 T:2905 ERROR: Flush - timed out waiting for renderer to flush 2019-02-26 11:16:10.238 T:6408 NOTICE: VideoPlayer: OnResetDisplay received 2019-02-26 11:16:10.239 T:6408 WARNING: CDVDMessageQueue(audio)::Put MSGQ_NOT_INITIALIZED 2019-02-26 11:16:10.239 T:6408 WARNING: CDVDMessageQueue(video)::Put MSGQ_NOT_INITIALIZED 2019-02-26 11:16:10.239 T:6408 DEBUG: Thread Timer 6408 terminating 2019-02-26 11:16:10.240 T:3180 DEBUG: CActiveAE - display reset event 2019-02-26 11:16:10.243 T:3181 INFO: CActiveAESink::OpenSink - initialize sink 2019-02-26 11:16:10.243 T:3181 DEBUG: CActiveAESink::OpenSink - trying to open device AUDIOTRACK:AudioTrack 2019-02-26 11:16:10.244 T:3181 DEBUG: CAESinkAUDIOTRACK::Initialize requested: sampleRate 44100; format: AE_FMT_FLOAT; channels: 2 2019-02-26 11:16:10.244 T:3181 DEBUG: Updated SampleRate: 32000 Distance: 108900 2019-02-26 11:16:10.244 T:3181 DEBUG: Updated SampleRate: 44100 Distance: 0 2019-02-26 11:16:10.245 T:3181 NOTICE: Trying to open: samplerate: 44100, channelMask: 12, encoding: 4 2019-02-26 11:16:10.254 T:3181 DEBUG: Minimum size we need for stream: 30104 2019-02-26 11:16:10.254 T:3181 DEBUG: Created Audiotrackbuffer with playing time of 170.657596 ms min buffer size: 60208 bytes 2019-02-26 11:16:10.333 T:3181 NOTICE: CAESinkAUDIOTRACK::Initializing with: m_sampleRate: 44100 format: AE_FMT_FLOAT (AE) method: PCM stream-type: PCM-STREAM min_buffer_size: 60208 m_frames: 3763 m_frameSize: 8 channels: 2 2019-02-26 11:16:10.333 T:3181 DEBUG: CActiveAESink::OpenSink - AUDIOTRACK Initialized: 2019-02-26 11:16:10.333 T:3181 DEBUG: Output Device : android 2019-02-26 11:16:10.334 T:3181 DEBUG: Sample Rate : 44100 2019-02-26 11:16:10.334 T:3181 DEBUG: Sample Format : AE_FMT_FLOAT 2019-02-26 11:16:10.334 T:3181 DEBUG: Channel Count : 2 2019-02-26 11:16:10.334 T:3181 DEBUG: Channel Layout: FL, FR 2019-02-26 11:16:10.334 T:3181 DEBUG: Frames : 3763 2019-02-26 11:16:10.334 T:3181 DEBUG: Frame Size : 8 2019-02-26 11:16:10.340 T:3180 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2019-02-26 11:16:11.105 T:3131 INFO: GLES: Maximum texture width: 4096 2019-02-26 11:16:11.111 T:3131 DEBUG: Flush - flushing renderer 2019-02-26 11:16:11.112 T:6393 NOTICE: Creating video codec with codec id: 27 2019-02-26 11:16:11.113 T:6393 INFO: CBitstreamConverter::Open bitstream to annexb init 2019-02-26 11:16:11.188 T:6393 NOTICE: CDVDVideoCodecAndroidMediaCodec::Open Testing codec:OMX.MTK.AUDIO.DECODER.MP3 2019-02-26 11:16:11.189 T:6393 NOTICE: CDVDVideoCodecAndroidMediaCodec::Open Testing codec:OMX.MTK.VIDEO.DECODER.MPEG4 2019-02-26 11:16:11.190 T:6393 NOTICE: CDVDVideoCodecAndroidMediaCodec::Open Testing codec:OMX.MTK.VIDEO.DECODER.H263 2019-02-26 11:16:11.191 T:6393 NOTICE: CDVDVideoCodecAndroidMediaCodec::Open Testing codec:OMX.MTK.VIDEO.DECODER.MPEG2 2019-02-26 11:16:11.192 T:6393 NOTICE: CDVDVideoCodecAndroidMediaCodec::Open Testing codec:OMX.MTK.VIDEO.DECODER.AVC 2019-02-26 11:16:11.312 T:6393 DEBUG: CDVDVideoCodecAndroidMediaCodec::Open m_codecname(OMX.MTK.VIDEO.DECODER.AVC), colorFormat(19) 2019-02-26 11:16:11.312 T:6393 DEBUG: CDVDVideoCodecAndroidMediaCodec::Open m_codecname(OMX.MTK.VIDEO.DECODER.AVC), colorFormat(2135033992) 2019-02-26 11:16:11.313 T:6393 DEBUG: CDVDVideoCodecAndroidMediaCodec::Open m_codecname(OMX.MTK.VIDEO.DECODER.AVC), colorFormat(2130706433) 2019-02-26 11:16:11.378 T:6393 DEBUG: CDVDVideoCodecAndroidMediaCodec:: width(480), height(270), stride(0), slice-height(0), color-format(0) 2019-02-26 11:16:11.379 T:6393 DEBUG: CDVDVideoCodecAndroidMediaCodec:: crop-left(0), crop-top(0), crop-right(479), crop-bottom(269) 2019-02-26 11:16:11.379 T:6393 DEBUG: CDVDVideoCodecAndroidMediaCodec:: Multi-Surface Rendering 2019-02-26 11:16:11.384 T:6393 INFO: CDVDVideoCodecAndroidMediaCodec:: Open Android MediaCodec OMX.MTK.VIDEO.DECODER.AVC 2019-02-26 11:16:11.384 T:6393 DEBUG: CDVDVideoCodecAndroidMediaCodec::UpdateFpsDuration fpsRate:25 fpsscale:1, fpsDur:40000 2019-02-26 11:16:11.384 T:6393 DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 27 2019-02-26 11:16:11.385 T:6393 NOTICE: Creating video thread 2019-02-26 11:16:11.385 T:6481 DEBUG: Thread VideoPlayerVideo start, auto delete: false 2019-02-26 11:16:11.385 T:6481 NOTICE: running thread: video_thread 2019-02-26 11:16:11.386 T:6481 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: 0 2019-02-26 11:16:11.391 T:6393 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: smb://FRITZ-NAS/FRITZ.NAS/Videos/Semino Rossi im Göttinger Kauf Park – Goettinger-Tageblatt.d.mp4 2019-02-26 11:16:11.392 T:6393 NOTICE: Opening stream: 1 source: 256 2019-02-26 11:16:11.395 T:6393 NOTICE: Finding audio codec for: 86018 2019-02-26 11:16:11.395 T:6393 DEBUG: CDVDAudioCodecAndroidMediaCodec::Open codec(86018), profile(1), tag(1630826605), extrasize(5) 2019-02-26 11:16:11.398 T:6393 INFO: CDVDAudioCodecAndroidMediaCodec::Open() Use default handling for non encrypted stream 2019-02-26 11:16:11.407 T:6393 NOTICE: CDVDAudioCodecFFmpeg::Open() Successful opened audio decoder aac 2019-02-26 11:16:11.407 T:6393 NOTICE: Creating audio thread 2019-02-26 11:16:11.413 T:6482 DEBUG: Thread VideoPlayerAudio start, auto delete: false 2019-02-26 11:16:11.413 T:6393 DEBUG: CVideoPlayer::SetCaching - caching state 2 2019-02-26 11:16:11.414 T:6393 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 2019-02-26 11:16:11.415 T:6393 DEBUG: CVideoPlayer::HandleMessages - player 2 reported state: 0 2019-02-26 11:16:11.416 T:6393 DEBUG: CVideoPlayer::SetCaching - caching state 1 2019-02-26 11:16:11.417 T:5976 DEBUG: OnAVChange: CApplication::OnAVChange 2019-02-26 11:16:11.417 T:6393 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 2019-02-26 11:16:11.418 T:6481 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 2019-02-26 11:16:11.419 T:6481 DEBUG: CDVDVideoCodecAndroidMediaCodec::AddData current state (2) 2019-02-26 11:16:11.432 T:6482 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:11.432 T:6482 NOTICE: running thread: CVideoPlayerAudio::Process() 2019-02-26 11:16:11.434 T:6481 DEBUG: CDVDVideoCodecAndroidMediaCodec::AddData current state (2) 2019-02-26 11:16:11.436 T:6482 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_PAUSE: 0 2019-02-26 11:16:11.436 T:6482 DEBUG: CDVDAudio::Pause - pausing audio stream 2019-02-26 11:16:11.442 T:6482 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:11.444 T:6482 NOTICE: Creating audio stream (codec id: 86018, channels: 2, sample rate: 48000, no pass-through) 2019-02-26 11:16:11.447 T:6482 DEBUG: CVideoPlayerAudio:: synctype set to 0: clock feedback 2019-02-26 11:16:11.474 T:6393 DEBUG: CVideoPlayer::HandleMessages - player 1 reported state: 0 2019-02-26 11:16:11.511 T:3157 DEBUG: CAnnouncementManager - Announcement: OnAVChange from xbmc 2019-02-26 11:16:11.512 T:3157 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVChange 2019-02-26 11:16:11.557 T:6481 DEBUG: CDVDVideoCodecAndroidMediaCodec:: width(480), height(270), stride(480), slice-height(288), color-format(2130706433) 2019-02-26 11:16:11.557 T:6481 DEBUG: CDVDVideoCodecAndroidMediaCodec:: crop-left(0), crop-top(0), crop-right(479), crop-bottom(269) 2019-02-26 11:16:11.557 T:6481 DEBUG: CDVDVideoCodecAndroidMediaCodec:: Multi-Surface Rendering 2019-02-26 11:16:11.559 T:6481 DEBUG: CRenderManager::Configure - change configuration. 480x270. display: 480x270. framerate: 25.00. 2019-02-26 11:16:11.563 T:3131 DEBUG: DeleteRenderer - deleting renderer 2019-02-26 11:16:11.563 T:3131 DEBUG: LinuxRendererGLES: Cleaning up GLES resources 2019-02-26 11:16:11.564 T:3131 NOTICE: Instancing CRendererMediaCodecSurface 2019-02-26 11:16:11.564 T:3131 NOTICE: CRendererMediaCodecSurface::Configure 2019-02-26 11:16:11.565 T:3131 DEBUG: CRenderManager::Configure - 4 2019-02-26 11:16:11.597 T:6393 DEBUG: CVideoPlayer::HandleMessages - player started 2 2019-02-26 11:16:11.598 T:5975 DEBUG: OnAVChange: CApplication::OnAVChange 2019-02-26 11:16:11.614 T:3181 INFO: CActiveAESink::OpenSink - initialize sink 2019-02-26 11:16:11.614 T:3181 DEBUG: Draining Audio 2019-02-26 11:16:11.615 T:3181 DEBUG: CAESinkAUDIOTRACK::Deinitialize 2019-02-26 11:16:11.618 T:3181 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:11.618 T:3181 DEBUG: CActiveAESink::OpenSink - trying to open device AUDIOTRACK:AudioTrack 2019-02-26 11:16:11.618 T:3181 DEBUG: CAESinkAUDIOTRACK::Initialize requested: sampleRate 48000; format: AE_FMT_FLOATP; channels: 2 2019-02-26 11:16:11.619 T:3181 DEBUG: Updated SampleRate: 32000 Distance: 144000 2019-02-26 11:16:11.619 T:3181 DEBUG: Updated SampleRate: 44100 Distance: 35100 2019-02-26 11:16:11.619 T:3181 DEBUG: Updated SampleRate: 48000 Distance: 0 2019-02-26 11:16:11.620 T:3181 NOTICE: Trying to open: samplerate: 48000, channelMask: 12, encoding: 4 2019-02-26 11:16:11.621 T:3181 DEBUG: Minimum size we need for stream: 32768 2019-02-26 11:16:11.622 T:3181 DEBUG: Created Audiotrackbuffer with playing time of 170.666667 ms min buffer size: 65536 bytes 2019-02-26 11:16:11.632 T:3131 DEBUG: Inhibiting OS screen saver 2019-02-26 11:16:11.636 T:3181 NOTICE: CAESinkAUDIOTRACK::Initializing with: m_sampleRate: 48000 format: AE_FMT_FLOAT (AE) method: PCM stream-type: PCM-STREAM min_buffer_size: 65536 m_frames: 4096 m_frameSize: 8 channels: 2 2019-02-26 11:16:11.636 T:3181 DEBUG: CActiveAESink::OpenSink - AUDIOTRACK Initialized: 2019-02-26 11:16:11.636 T:3181 DEBUG: Output Device : android 2019-02-26 11:16:11.637 T:3181 DEBUG: Sample Rate : 48000 2019-02-26 11:16:11.637 T:3181 DEBUG: Sample Format : AE_FMT_FLOAT 2019-02-26 11:16:11.637 T:3181 DEBUG: Channel Count : 2 2019-02-26 11:16:11.638 T:3181 DEBUG: Channel Layout: FL, FR 2019-02-26 11:16:11.638 T:3181 DEBUG: Frames : 4096 2019-02-26 11:16:11.638 T:3181 DEBUG: Frame Size : 8 2019-02-26 11:16:11.648 T:3180 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2019-02-26 11:16:11.677 T:6393 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:11.678 T:6393 DEBUG: CVideoPlayer::HandleMessages - player started 1 2019-02-26 11:16:11.678 T:5975 DEBUG: OnAVChange: CApplication::OnAVChange 2019-02-26 11:16:11.679 T:3157 DEBUG: CAnnouncementManager - Announcement: OnAVChange from xbmc 2019-02-26 11:16:11.679 T:3157 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVChange 2019-02-26 11:16:11.681 T:6393 DEBUG: VideoPlayer::Sync - Audio - pts: 298666.000000, cache: 320000.022650, totalcache: 770666.658878 2019-02-26 11:16:11.681 T:6393 DEBUG: VideoPlayer::Sync - Video - pts: 0.000000, cache: 50000.000000, totalcache: 100000.000000 2019-02-26 11:16:11.682 T:6393 DEBUG: CVideoPlayer::SetCaching - caching state 0 2019-02-26 11:16:11.683 T:6393 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 2019-02-26 11:16:11.687 T:6482 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(-100000.000000), level: 70, cache: 399012.740983 2019-02-26 11:16:11.687 T:6482 DEBUG: CDVDAudio::Resume - resume audio stream 2019-02-26 11:16:11.691 T:6481 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(-100000.000000) 2019-02-26 11:16:11.692 T:3180 DEBUG: ActiveAE - start sync of audio stream 2019-02-26 11:16:11.692 T:5976 DEBUG: OnAVStarted: CApplication::OnAVStarted 2019-02-26 11:16:11.721 T:3131 DEBUG: Activating window ID: 12005 2019-02-26 11:16:11.724 T:3131 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 2019-02-26 11:16:11.726 T:3131 DEBUG: FreeVisualisation() done 2019-02-26 11:16:11.731 T:3131 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 2019-02-26 11:16:11.732 T:3131 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY 2019-02-26 11:16:11.752 T:3131 NOTICE: Whitelist search for: width: 480, height: 270, fps: 25.000, 3D: false 2019-02-26 11:16:11.753 T:3131 DEBUG: Whitelist is empty using default one 2019-02-26 11:16:11.753 T:3131 DEBUG: Trying to find exact refresh rate 2019-02-26 11:16:11.754 T:3131 DEBUG: No exact whitelisted resolution matched, trying double refresh rate 2019-02-26 11:16:11.755 T:3131 DEBUG: No double refresh rate whitelisted resolution matched, trying current resolution 2019-02-26 11:16:11.755 T:3131 DEBUG: Matched current Resolution 1920x1080 @ 50.000000 - Full Screen (22) 2019-02-26 11:16:11.755 T:3131 NOTICE: Display resolution ADJUST : 1920x1080 @ 50.000000 - Full Screen (22) (weight: -0.000) 2019-02-26 11:16:11.756 T:5975 DEBUG: OnAVChange: CApplication::OnAVChange 2019-02-26 11:16:11.764 T:3131 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2019-02-26 11:16:11.787 T:3157 DEBUG: CAnnouncementManager - Announcement: OnAVChange from xbmc 2019-02-26 11:16:11.787 T:3157 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVChange 2019-02-26 11:16:11.837 T:3157 DEBUG: CAnnouncementManager - Announcement: OnAVStart from xbmc 2019-02-26 11:16:11.838 T:3157 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVStart 2019-02-26 11:16:11.870 T:3180 DEBUG: ActiveAE::SyncStream - average error of -6.090587, start adjusting 2019-02-26 11:16:11.871 T:3180 DEBUG: ActiveAE::SyncStream - average error -0.007254 below threshold of 30.000000 2019-02-26 11:16:11.878 T:3157 DEBUG: CAnnouncementManager - Announcement: OnAVChange from xbmc 2019-02-26 11:16:11.878 T:3157 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVChange 2019-02-26 11:16:13.921 T:6482 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-30058.066006, adjusted:-40000.000000 2019-02-26 11:16:16.489 T:6481 DEBUG: CPtsTracker: detected pattern of length 1: 40000.00, frameduration: 40000.000000 2019-02-26 11:16:22.338 T:3131 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 2019-02-26 11:16:22.366 T:3131 DEBUG: ------ Window Init (Custom_1109_TopBarOverlay.xml) ------ 2019-02-26 11:16:22.366 T:6482 DEBUG: CDVDAudio::Pause - pausing audio stream 2019-02-26 11:16:22.408 T:3157 DEBUG: CAnnouncementManager - Announcement: OnPause from xbmc 2019-02-26 11:16:22.409 T:3157 DEBUG: void CXBMCApp::OnPlayBackPaused() 2019-02-26 11:16:22.431 T:3157 DEBUG: Visible Behind request: false 2019-02-26 11:16:22.441 T:3157 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPause 2019-02-26 11:16:22.480 T:3131 DEBUG: Uninhibiting OS screen saver 2019-02-26 11:16:23.584 T:2905 DEBUG: CXBMCApp::onReceive - Got intent. Action: android.media.action.HDMI_AUDIO_PLUG 2019-02-26 11:16:23.585 T:2905 DEBUG: -- HDMI state: off 2019-02-26 11:16:29.893 T:2905 DEBUG: CXBMCApp::onReceive - Got intent. Action: android.media.action.HDMI_AUDIO_PLUG 2019-02-26 11:16:29.893 T:2905 DEBUG: -- HDMI state: on 2019-02-26 11:16:36.039 T:3131 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:36.120 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:36.121 T:3131 DEBUG: HandleKey: backspace (0xf008) pressed, action is Fullscreen 2019-02-26 11:16:36.121 T:3131 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 2019-02-26 11:16:36.121 T:3131 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 2019-02-26 11:16:36.176 T:3131 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 2019-02-26 11:16:36.196 T:3131 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 2019-02-26 11:16:36.233 T:3131 DEBUG: CGUIMediaWindow::GetDirectory (smb://FRITZ-NAS/FRITZ.NAS/Videos/) 2019-02-26 11:16:36.234 T:3131 DEBUG: ParentPath = [smb://FRITZ-NAS/FRITZ.NAS/Videos/] 2019-02-26 11:16:36.284 T:3131 DEBUG: CSMBFile::Open - opened smb://USERNAME:PASSWORD@FRITZ-NAS/FRITZ.NAS/Videos/ntv.strm, fd=10001 2019-02-26 11:16:36.303 T:3131 DEBUG: CSMBFile::Close closing fd 10001 2019-02-26 11:16:36.338 T:7012 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-02-26 11:16:36.429 T:7012 DEBUG: Thread BackgroundLoader 7012 terminating 2019-02-26 11:16:37.005 T:5976 DEBUG: ffmpeg[BAC26C38]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-02-26 11:16:37.104 T:3131 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 2019-02-26 11:16:37.105 T:3131 DEBUG: ------ Window Deinit (Custom_1109_TopBarOverlay.xml) ------ 2019-02-26 11:16:37.107 T:3131 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:37.319 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:37.319 T:3131 DEBUG: HandleKey: backspace (0xf008) pressed, action is Back 2019-02-26 11:16:37.320 T:3131 DEBUG: CGUIMediaWindow::GetDirectory (smb://FRITZ-NAS/FRITZ.NAS/) 2019-02-26 11:16:37.321 T:3131 DEBUG: ParentPath = [smb://FRITZ-NAS/] 2019-02-26 11:16:37.323 T:7030 DEBUG: Thread waiting start, auto delete: false 2019-02-26 11:16:37.385 T:7030 DEBUG: Thread waiting 7030 terminating 2019-02-26 11:16:37.408 T:7032 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-02-26 11:16:37.847 T:7032 DEBUG: Thread BackgroundLoader 7032 terminating 2019-02-26 11:16:38.286 T:3131 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:38.446 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:38.447 T:3131 DEBUG: HandleKey: backspace (0xf008) pressed, action is Back 2019-02-26 11:16:38.448 T:3131 DEBUG: CGUIMediaWindow::GetDirectory (smb://FRITZ-NAS/) 2019-02-26 11:16:38.449 T:3131 DEBUG: ParentPath = [smb://WORKGROUP/] 2019-02-26 11:16:38.454 T:3131 DEBUG: Loading items: 1, directory: smb://FRITZ-NAS/ sort method: 0, ascending: true 2019-02-26 11:16:38.473 T:7049 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-02-26 11:16:38.542 T:7049 DEBUG: Thread BackgroundLoader 7049 terminating 2019-02-26 11:16:39.113 T:3131 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:39.289 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:39.289 T:3131 DEBUG: HandleKey: backspace (0xf008) pressed, action is Back 2019-02-26 11:16:39.290 T:3131 DEBUG: CGUIMediaWindow::GetDirectory (smb://WORKGROUP/) 2019-02-26 11:16:39.291 T:3131 DEBUG: ParentPath = [sources://video/] 2019-02-26 11:16:39.294 T:7070 DEBUG: Thread waiting start, auto delete: false 2019-02-26 11:16:39.323 T:7070 DEBUG: Thread waiting 7070 terminating 2019-02-26 11:16:39.341 T:7071 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-02-26 11:16:39.419 T:7071 DEBUG: Thread BackgroundLoader 7071 terminating 2019-02-26 11:16:39.982 T:3131 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:40.106 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:40.107 T:3131 DEBUG: HandleKey: backspace (0xf008) pressed, action is Back 2019-02-26 11:16:40.109 T:3131 DEBUG: CGUIMediaWindow::GetDirectory (sources://video/) 2019-02-26 11:16:40.112 T:3131 DEBUG: ParentPath = [] 2019-02-26 11:16:40.116 T:7085 DEBUG: Thread waiting start, auto delete: false 2019-02-26 11:16:40.130 T:7085 DEBUG: Thread waiting 7085 terminating 2019-02-26 11:16:40.148 T:7086 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-02-26 11:16:40.223 T:7086 DEBUG: Thread BackgroundLoader 7086 terminating 2019-02-26 11:16:40.836 T:3131 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:41.042 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:41.047 T:3131 DEBUG: HandleKey: backspace (0xf008) pressed, action is Back 2019-02-26 11:16:41.052 T:3131 DEBUG: CGUIMediaWindow::GetDirectory () 2019-02-26 11:16:41.052 T:3131 DEBUG: ParentPath = [] 2019-02-26 11:16:41.089 T:7099 DEBUG: Thread waiting start, auto delete: false 2019-02-26 11:16:41.095 T:7099 DEBUG: Thread waiting 7099 terminating 2019-02-26 11:16:41.110 T:7101 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-02-26 11:16:41.143 T:7101 DEBUG: Thread BackgroundLoader 7101 terminating 2019-02-26 11:16:41.839 T:3131 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:42.021 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:42.022 T:3131 DEBUG: HandleKey: backspace (0xf008) pressed, action is Back 2019-02-26 11:16:42.022 T:3131 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 2019-02-26 11:16:42.340 T:3131 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 2019-02-26 11:16:42.341 T:3131 DEBUG: FreeVisualisation() done 2019-02-26 11:16:42.343 T:3131 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 2019-02-26 11:16:42.344 T:3131 DEBUG: ------ Window Init (Home.xml) ------ 2019-02-26 11:16:42.346 T:3131 DEBUG: CDirectoryProvider[addons://]: refreshing.. 2019-02-26 11:16:42.348 T:3131 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 2019-02-26 11:16:42.348 T:3131 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 2019-02-26 11:16:42.349 T:3131 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing.. 2019-02-26 11:16:42.350 T:3131 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 2019-02-26 11:16:42.350 T:3131 DEBUG: CDirectoryProvider[androidapp://sources/apps/]: refreshing.. 2019-02-26 11:16:42.351 T:7139 DEBUG: Thread JobWorker start, auto delete: true 2019-02-26 11:16:42.352 T:3131 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 2019-02-26 11:16:42.352 T:3131 DEBUG: CDirectoryProvider[library://video/]: refreshing.. 2019-02-26 11:16:42.353 T:3131 DEBUG: CDirectoryProvider[sources://video/]: refreshing.. 2019-02-26 11:16:42.353 T:3131 DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing.. 2019-02-26 11:16:42.356 T:3131 DEBUG: CDirectoryProvider[pvr://channels/tv/*?view=lastplayed]: refreshing.. 2019-02-26 11:16:42.356 T:3131 DEBUG: CDirectoryProvider[pvr://channels/radio/*?view=lastplayed]: refreshing.. 2019-02-26 11:16:42.357 T:3131 DEBUG: CDirectoryProvider[favourites://]: refreshing.. 2019-02-26 11:16:42.357 T:3131 DEBUG: CDirectoryProvider[sources://pictures/]: refreshing.. 2019-02-26 11:16:42.357 T:3131 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing.. 2019-02-26 11:16:42.661 T:5976 DEBUG: CAddonMgr::GetAvailableUpdates took 291 ms 2019-02-26 11:16:43.179 T:5976 DEBUG: CAndroidAppDirectory::GetDirectory: apps 2019-02-26 11:16:43.327 T:7139 DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3a%2f%2fprofile%2fplaylists%2fvideo/special%3a%2f%2fprofile%2fplaylists%2fmixed/) 2019-02-26 11:16:43.328 T:7139 DEBUG: Getting Directory (special://profile/playlists/video) 2019-02-26 11:16:43.332 T:7139 DEBUG: Getting Directory (special://profile/playlists/mixed) 2019-02-26 11:16:43.336 T:7139 DEBUG: CMultiPathDirectory::MergeItems, items = 0 2019-02-26 11:16:43.339 T:7139 DEBUG: CPVRDirectory::GetDirectory(pvr://channels/tv/*?view=lastplayed) 2019-02-26 11:16:43.379 T:7139 DEBUG: CPVRDirectory::GetDirectory(pvr://channels/radio/*?view=lastplayed) 2019-02-26 11:16:44.128 T:3131 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:44.128 T:3131 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2019-02-26 11:16:44.248 T:3131 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:44.311 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:44.312 T:3131 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2019-02-26 11:16:44.421 T:3131 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:44.473 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:44.473 T:3131 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2019-02-26 11:16:44.609 T:3131 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:44.663 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:44.663 T:3131 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2019-02-26 11:16:44.769 T:3131 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:44.812 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:44.812 T:3131 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2019-02-26 11:16:44.947 T:3131 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:44.995 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:44.996 T:3131 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2019-02-26 11:16:45.108 T:3131 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:45.820 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:45.820 T:3131 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2019-02-26 11:16:45.989 T:3131 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:46.413 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:46.414 T:3131 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2019-02-26 11:16:46.614 T:3131 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:47.010 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:47.011 T:3131 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2019-02-26 11:16:47.172 T:3131 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:47.572 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:47.573 T:3131 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2019-02-26 11:16:47.744 T:3131 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:48.381 T:3131 DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:48.539 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:48.540 T:3131 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2019-02-26 11:16:48.540 T:3131 DEBUG: Activating window ID: 10111 2019-02-26 11:16:48.541 T:3131 DEBUG: ------ Window Init (DialogButtonMenu.xml) ------ 2019-02-26 11:16:48.541 T:3131 INFO: Loading skin file: DialogButtonMenu.xml, load type: KEEP_IN_MEMORY 2019-02-26 11:16:50.114 T:3131 DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0 2019-02-26 11:16:50.331 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:50.331 T:3131 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2019-02-26 11:16:50.356 T:3131 NOTICE: stop player 2019-02-26 11:16:50.357 T:3131 NOTICE: CVideoPlayer::CloseFile() 2019-02-26 11:16:50.357 T:3131 DEBUG: DeleteRenderer - deleting renderer 2019-02-26 11:16:50.358 T:3131 NOTICE: VideoPlayer: waiting for threads to exit 2019-02-26 11:16:50.358 T:6393 NOTICE: CVideoPlayer::OnExit() 2019-02-26 11:16:50.360 T:6393 NOTICE: Closing stream player 1 2019-02-26 11:16:50.365 T:6393 NOTICE: Waiting for audio thread to exit 2019-02-26 11:16:50.366 T:6482 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true 2019-02-26 11:16:50.366 T:6482 NOTICE: thread end: CVideoPlayerAudio::OnExit() 2019-02-26 11:16:50.366 T:6482 DEBUG: Thread VideoPlayerAudio 6482 terminating 2019-02-26 11:16:50.367 T:6393 NOTICE: Closing audio device 2019-02-26 11:16:50.433 T:6393 DEBUG: CDVDAudio::Flush - flush audio stream 2019-02-26 11:16:50.434 T:3180 DEBUG: CActiveAE::DiscardStream - audio stream deleted 2019-02-26 11:16:50.434 T:3180 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2019-02-26 11:16:50.436 T:6393 DEBUG: Previous line repeats 2 times. 2019-02-26 11:16:50.436 T:6393 NOTICE: Deleting audio codec 2019-02-26 11:16:50.443 T:6393 NOTICE: Closing stream player 2 2019-02-26 11:16:50.443 T:6393 NOTICE: waiting for video thread to exit 2019-02-26 11:16:50.443 T:6481 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true 2019-02-26 11:16:50.443 T:6481 NOTICE: thread end: video_thread 2019-02-26 11:16:50.444 T:6481 DEBUG: Thread VideoPlayerVideo 6481 terminating 2019-02-26 11:16:50.445 T:6393 NOTICE: deleting video codec 2019-02-26 11:16:50.584 T:6393 DEBUG: CMediaCodecVideoBufferPool::~CMediaCodecVideoBufferPool Releasing 4 buffers 2019-02-26 11:16:50.601 T:6393 DEBUG: CSMBFile::Close closing fd 10000 2019-02-26 11:16:50.604 T:3181 INFO: CActiveAESink::OpenSink - initialize sink 2019-02-26 11:16:50.604 T:3181 DEBUG: Draining Audio 2019-02-26 11:16:50.605 T:6393 DEBUG: Thread VideoPlayer 6393 terminating 2019-02-26 11:16:50.606 T:3181 DEBUG: CAESinkAUDIOTRACK::Deinitialize 2019-02-26 11:16:50.606 T:3131 NOTICE: VideoPlayer: finished waiting 2019-02-26 11:16:50.606 T:3131 NOTICE: CVideoPlayer::CloseFile() 2019-02-26 11:16:50.607 T:3131 NOTICE: VideoPlayer: waiting for threads to exit 2019-02-26 11:16:50.607 T:3131 NOTICE: VideoPlayer: finished waiting 2019-02-26 11:16:50.608 T:3181 DEBUG: CAESinkAUDIOTRACK::Deinitialize 2019-02-26 11:16:50.609 T:3181 DEBUG: CActiveAESink::OpenSink - trying to open device AUDIOTRACK:AudioTrack 2019-02-26 11:16:50.609 T:3181 DEBUG: CAESinkAUDIOTRACK::Initialize requested: sampleRate 44100; format: AE_FMT_FLOAT; channels: 2 2019-02-26 11:16:50.611 T:3131 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 2019-02-26 11:16:50.612 T:3181 DEBUG: Updated SampleRate: 32000 Distance: 108900 2019-02-26 11:16:50.612 T:3181 DEBUG: Updated SampleRate: 44100 Distance: 0 2019-02-26 11:16:50.613 T:3181 NOTICE: Trying to open: samplerate: 44100, channelMask: 12, encoding: 4 2019-02-26 11:16:50.617 T:7139 INFO: Deleting settings information for files smb://FRITZ-NAS/FRITZ.NAS/Videos/Semino Rossi im Göttinger Kauf Park – Goettinger-Tageblatt.d.mp4 2019-02-26 11:16:50.629 T:3181 DEBUG: Minimum size we need for stream: 30104 2019-02-26 11:16:50.629 T:3181 DEBUG: Created Audiotrackbuffer with playing time of 170.657596 ms min buffer size: 60208 bytes 2019-02-26 11:16:50.633 T:5975 DEBUG: DoWork - Saving file state for video item smb://FRITZ-NAS/FRITZ.NAS/Videos/Semino Rossi im Göttinger Kauf Park – Goettinger-Tageblatt.d.mp4 2019-02-26 11:16:50.665 T:3181 NOTICE: CAESinkAUDIOTRACK::Initializing with: m_sampleRate: 44100 format: AE_FMT_FLOAT (AE) method: PCM stream-type: PCM-STREAM min_buffer_size: 60208 m_frames: 3763 m_frameSize: 8 channels: 2 2019-02-26 11:16:50.665 T:3181 DEBUG: CActiveAESink::OpenSink - AUDIOTRACK Initialized: 2019-02-26 11:16:50.666 T:3181 DEBUG: Output Device : android 2019-02-26 11:16:50.666 T:3181 DEBUG: Sample Rate : 44100 2019-02-26 11:16:50.666 T:3181 DEBUG: Sample Format : AE_FMT_FLOAT 2019-02-26 11:16:50.666 T:3181 DEBUG: Channel Count : 2 2019-02-26 11:16:50.667 T:3181 DEBUG: Channel Layout: FL, FR 2019-02-26 11:16:50.667 T:3181 DEBUG: Frames : 3763 2019-02-26 11:16:50.667 T:3181 DEBUG: Frame Size : 8 2019-02-26 11:16:50.672 T:3180 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2019-02-26 11:16:50.724 T:5976 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:50.724 T:5976 DEBUG: OnPlayBackStopped: CApplication::OnPlayBackStopped 2019-02-26 11:16:50.727 T:3131 NOTICE: Storing total System Uptime 2019-02-26 11:16:50.728 T:3131 NOTICE: Saving settings 2019-02-26 11:16:50.745 T:3131 NOTICE: Saving skin settings 2019-02-26 11:16:50.762 T:3131 NOTICE: stop all 2019-02-26 11:16:50.763 T:7139 DEBUG: Thread JobWorker 7139 terminating (autodelete) 2019-02-26 11:16:50.764 T:5976 DEBUG: Thread JobWorker 5976 terminating (autodelete) 2019-02-26 11:16:50.764 T:5975 DEBUG: Thread JobWorker 5975 terminating (autodelete) 2019-02-26 11:16:50.767 T:3131 DEBUG: NetworkMessage - Signaling network services to stop 2019-02-26 11:16:50.767 T:3131 NOTICE: ES: Stopping event server 2019-02-26 11:16:50.769 T:3131 DEBUG: NetworkMessage - Waiting for network services to stop 2019-02-26 11:16:50.769 T:3131 NOTICE: stopping zeroconf publishing 2019-02-26 11:16:50.770 T:3131 DEBUG: ZeroconfAndroid: Shutdown services 2019-02-26 11:16:50.773 T:3157 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 2019-02-26 11:16:50.774 T:3157 DEBUG: void CXBMCApp::OnPlayBackStopped() 2019-02-26 11:16:50.776 T:3131 DEBUG: CZeroconfAndroid: Removed service servers.eventserver 2019-02-26 11:16:50.777 T:3131 DEBUG: CZeroconfAndroid: Removed service servers.jsonrpc-tpc 2019-02-26 11:16:50.778 T:3157 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 2019-02-26 11:16:50.779 T:3157 DEBUG: CAnnouncementManager - Announcement: OnQuit from xbmc 2019-02-26 11:16:50.780 T:3157 DEBUG: GOT ANNOUNCEMENT, type: 8, from xbmc, message OnQuit 2019-02-26 11:16:50.802 T:3729 INFO: ZeroconfAndroid: Kodi (FireTVStick.fritz.box)._xbmc-events._udp registration removed 2019-02-26 11:16:50.804 T:3729 INFO: ZeroconfAndroid: Kodi (FireTVStick.fritz.box)._xbmc-jsonrpc._tcp registration removed 2019-02-26 11:16:50.857 T:3734 DEBUG: Thread TCPServer 3734 terminating 2019-02-26 11:16:50.867 T:3732 NOTICE: ES: UDP Event server stopped 2019-02-26 11:16:50.868 T:3732 DEBUG: Thread EventServer 3732 terminating 2019-02-26 11:16:50.879 T:3780 DEBUG: Thread PVRGUIInfo 3780 terminating 2019-02-26 11:16:50.884 T:3131 DEBUG: CServiceAddonManager: stopping script.common.plugin.cache. 2019-02-26 11:16:50.885 T:3131 DEBUG: CPythonInvoker(2, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.common.plugin.cache/default.py): trigger Monitor abort request 2019-02-26 11:16:51.214 T:3728 DEBUG: StorageServer-2.5.4 Closed down 2019-02-26 11:16:51.228 T:3728 INFO: CPythonInvoker(2, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.common.plugin.cache/default.py): script successfully run 2019-02-26 11:16:51.229 T:3728 DEBUG: onExecutionDone(2, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.common.plugin.cache/default.py) 2019-02-26 11:16:51.265 T:3728 INFO: Python interpreter interrupted by user 2019-02-26 11:16:51.266 T:3131 DEBUG: CPythonInvoker(2, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/script.common.plugin.cache/default.py): script termination took 378ms 2019-02-26 11:16:51.266 T:3131 DEBUG: CServiceAddonManager: stopping script.kodi.android.update. 2019-02-26 11:16:51.266 T:3728 DEBUG: Thread LanguageInvoker 3728 terminating 2019-02-26 11:16:51.267 T:3131 INFO: CServiceAddonManager: failed to stop script.kodi.android.update (may have ended) 2019-02-26 11:16:51.267 T:3131 DEBUG: CServiceAddonManager: stopping service.xbmc.versioncheck. 2019-02-26 11:16:51.267 T:3131 INFO: CServiceAddonManager: failed to stop service.xbmc.versioncheck (may have ended) 2019-02-26 11:16:51.268 T:3180 DEBUG: Thread ActiveAE 3180 terminating 2019-02-26 11:16:51.286 T:3181 DEBUG: Thread AESink 3181 terminating 2019-02-26 11:16:51.287 T:3131 DEBUG: Draining Audio 2019-02-26 11:16:51.288 T:3131 DEBUG: CAESinkAUDIOTRACK::Deinitialize 2019-02-26 11:16:51.291 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:51.291 T:3131 NOTICE: stopped 2019-02-26 11:16:51.493 T:3131 NOTICE: destroy 2019-02-26 11:16:51.496 T:3131 NOTICE: PVR Manager: Stopping 2019-02-26 11:16:51.500 T:3782 DEBUG: Thread EPGUpdater 3782 terminating 2019-02-26 11:16:51.605 T:3742 DEBUG: Thread PVRManager 3742 terminating 2019-02-26 11:16:51.614 T:3131 NOTICE: PVR Manager: Stopped 2019-02-26 11:16:51.618 T:3131 DEBUG: SECTION:UnloadDll(/data/data/org.xbmc.kodi/cache/lib/libpvr.iptvsimple.so) 2019-02-26 11:16:51.623 T:3131 INFO: ADDON: Dll Destroyed - PVR IPTV Simple Client 2019-02-26 11:16:51.628 T:3716 DEBUG: Thread PeripEventScanner 3716 terminating 2019-02-26 11:16:51.629 T:3581 DEBUG: Thread PeripBusAddon 3581 terminating 2019-02-26 11:16:51.711 T:3131 DEBUG: SECTION:UnloadDll(/data/app/org.xbmc.kodi-2/lib/arm/libperipheral.joystick.so) 2019-02-26 11:16:51.714 T:3131 INFO: ADDON: Dll Destroyed - Joystick Support 2019-02-26 11:16:51.715 T:3131 NOTICE: unload skin 2019-02-26 11:16:51.715 T:3131 INFO: Unloading old skin ... 2019-02-26 11:16:51.723 T:3131 DEBUG: ------ Window Deinit (Home.xml) ------ 2019-02-26 11:16:51.723 T:3131 DEBUG: FreeVisualisation() done 2019-02-26 11:16:51.749 T:3131 DEBUG: Previous line repeats 1 times. 2019-02-26 11:16:51.750 T:3131 DEBUG: ------ Window Deinit () ------ 2019-02-26 11:16:51.750 T:3131 DEBUG: FreeVisualisation() done 2019-02-26 11:16:51.770 T:3131 DEBUG: Previous line repeats 2 times. 2019-02-26 11:16:51.770 T:3131 DEBUG: ------ Window Deinit (DialogButtonMenu.xml) ------ 2019-02-26 11:16:51.775 T:3131 DEBUG: CloseBundle - Closed bundle 2019-02-26 11:16:51.865 T:3131 NOTICE: unload sections 2019-02-26 11:16:51.876 T:3157 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 2019-02-26 11:16:51.881 T:3723 DEBUG: Thread Timer 3723 terminating 2019-02-26 11:16:51.901 T:3131 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0xb9332600 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-02-26 11:16:51.902 T:3131 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0xb93e8f50 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-02-26 11:16:51.902 T:3131 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0xb9351ad0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-02-26 11:16:51.902 T:3131 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0xb9395b58 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-02-26 11:16:51.903 T:3131 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0xb936d858 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-02-26 11:16:51.903 T:3131 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0xb94178a0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-02-26 11:16:51.903 T:3131 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0xb93f1c28 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-02-26 11:16:51.904 T:3131 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0xb93e8930 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-02-26 11:16:51.904 T:3131 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0xb93f0af8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-02-26 11:16:51.906 T:3131 DEBUG: object 0 --> 0 instances 2019-02-26 11:16:51.906 T:3131 DEBUG: object 1 --> 0 instances 2019-02-26 11:16:51.906 T:3131 DEBUG: object 2 --> 0 instances 2019-02-26 11:16:51.907 T:3131 DEBUG: object 3 --> 0 instances 2019-02-26 11:16:51.907 T:3131 DEBUG: object 4 --> 0 instances 2019-02-26 11:16:51.907 T:3131 DEBUG: object 5 --> 0 instances 2019-02-26 11:16:51.907 T:3131 DEBUG: object 6 --> 0 instances 2019-02-26 11:16:51.907 T:3131 DEBUG: object 7 --> 0 instances 2019-02-26 11:16:51.908 T:3131 DEBUG: object 8 --> 0 instances 2019-02-26 11:16:51.908 T:3131 DEBUG: object 9 --> 0 instances 2019-02-26 11:16:51.940 T:3161 DEBUG: Thread CWinEventsAndroid 3161 terminating 2019-02-26 11:16:51.971 T:3157 DEBUG: Thread Announce 3157 terminating 2019-02-26 11:16:51.980 T:3131 NOTICE: application stopped...