17:00:16.720 T:3022080240 NOTICE: special://profile/ is mapped to: special://masterprofile/ 17:00:16.721 T:3022080240 NOTICE: ----------------------------------------------------------------------- 17:00:16.721 T:3022080240 NOTICE: Starting Kodi (17.6 Git:2018-11-27-7e52c-stb). Platform: Linux ARM 32-bit 17:00:16.721 T:3022080240 NOTICE: Using Release Kodi x32 build 17:00:16.721 T:3022080240 NOTICE: Kodi compiled Nov 27 2018 by GCC 6.3.0 for Linux ARM 32-bit version 4.10.0 (264704) 17:00:16.721 T:3022080240 NOTICE: Running on openhdf 6.3, kernel: Linux ARM 32-bit version 4.10.12 17:00:16.721 T:3022080240 NOTICE: FFmpeg version/source: ffmpeg-3.1-kodi 17:00:16.721 T:3022080240 NOTICE: Host CPU: ARMv7 Processor rev 3 (v7l), 2 cores available 17:00:16.721 T:3022080240 NOTICE: ARM Features: Neon enabled 17:00:16.721 T:3022080240 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi 17:00:16.721 T:3022080240 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi 17:00:16.721 T:3022080240 NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons 17:00:16.721 T:3022080240 NOTICE: special://masterprofile/ is mapped to: /media/hdd/.kodi/userdata 17:00:16.721 T:3022080240 NOTICE: special://envhome/ is mapped to: /media/hdd 17:00:16.721 T:3022080240 NOTICE: special://home/ is mapped to: /media/hdd/.kodi 17:00:16.721 T:3022080240 NOTICE: special://temp/ is mapped to: /tmp/kodi 17:00:16.721 T:3022080240 NOTICE: special://logpath/ is mapped to: /tmp/kodi 17:00:16.721 T:3022080240 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin 17:00:16.721 T:3022080240 NOTICE: Local hostname: ax51 17:00:16.721 T:3022080240 NOTICE: Log File is located: /tmp/kodi//kodi.log 17:00:16.721 T:3022080240 NOTICE: ----------------------------------------------------------------------- 17:00:16.723 T:3022080240 NOTICE: load settings... 17:00:16.743 T:3022080240 WARNING: CSettingInt: unknown options filler "audiocdactions" of "audiocds.autoaction" 17:00:16.783 T:3022080240 NOTICE: Found 1 Lists of Devices 17:00:16.783 T:3022080240 NOTICE: Enumerated ALSA devices: 17:00:16.783 T:3022080240 NOTICE: Device 1 17:00:16.783 T:3022080240 NOTICE: m_deviceName : @ 17:00:16.783 T:3022080240 NOTICE: m_displayName : Default (bcm Analog) 17:00:16.783 T:3022080240 NOTICE: m_displayNameExtra: 17:00:16.783 T:3022080240 NOTICE: m_deviceType : AE_DEVTYPE_PCM 17:00:16.783 T:3022080240 NOTICE: m_channels : FL,FR 17:00:16.783 T:3022080240 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000 17:00:16.783 T:3022080240 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE 17:00:16.783 T:3022080240 NOTICE: m_streamTypes : No passthrough capabilities 17:00:16.791 T:3022080240 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml 17:00:16.791 T:3022080240 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are... 17:00:16.792 T:3022080240 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 17:00:16.792 T:3022080240 NOTICE: Default Video Player: E2Player 17:00:16.792 T:3022080240 NOTICE: Default Audio Player: paplayer 17:00:16.792 T:3022080240 NOTICE: Disabled debug logging due to GUI setting. Level 0. 17:00:16.792 T:3022080240 NOTICE: Log level changed to "LOG_LEVEL_NORMAL" 17:00:16.792 T:3022080240 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml 17:00:16.792 T:3022080240 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 17:00:16.793 T:3022080240 WARNING: CPlayerCoreFactory::GetPlayer(E2Player): no such player: E2Player 17:00:16.793 T:3022080240 NOTICE: Loaded playercorefactory configuration 17:00:16.793 T:3022080240 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 17:00:16.793 T:3022080240 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 17:00:16.805 T:3022080240 NOTICE: Running database version Addons27 17:00:19.607 T:3022080240 NOTICE: ADDONS: Using repository repository.xbmc.org 17:00:19.652 T:3022080240 NOTICE: InitWindowSystem: Using EGL Implementation: V3D 17:00:19.659 T:3022080240 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 50.000000 Hz 17:00:19.659 T:3022080240 NOTICE: Previous line repeats 2 times. 17:00:19.659 T:3022080240 NOTICE: Found resolution 1280 x 720 for display 0 with 1920 x 1080 @ 50.000000 Hz 17:00:19.659 T:3022080240 NOTICE: Found (1280x720@50.000000) at 16, setting to RES_DESKTOP at 16 17:00:19.659 T:3022080240 NOTICE: Checking resolution 16 17:00:19.660 T:3022080240 NOTICE: GL_VENDOR = Broadcom 17:00:19.660 T:3022080240 NOTICE: GL_RENDERER = VideoCore V HW (V3D-530) 17:00:19.660 T:3022080240 NOTICE: GL_VERSION = OpenGL ES 3.1 17:00:19.661 T:3022080240 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 3.10 17:00:19.661 T:3022080240 NOTICE: GL_EXTENSIONS = GL_OES_compressed_ETC1_RGB8_texture GL_OES_compressed_paletted_texture GL_OES_texture_npot GL_OES_vertex_half_float GL_OES_EGL_image GL_OES_EGL_image_external GL_EXT_discard_framebuffer GL_OES_rgb8_rgba8 GL_OES_depth24 GL_OES_mapbuffer GL_OES_vertex_array_object GL_OES_packed_depth_stencil GL_OES_EGL_sync GL_OES_standard_derivatives GL_OES_surfaceless_context GL_EXT_shader_texture_lod GL_EXT_draw_elements_base_vertex GL_EXT_multisampled_render_to_texture GL_KHR_debug GL_OES_texture_stencil8 GL_EXT_shader_integer_mix GL_OES_texture_storage_multisample_2d_array GL_EXT_texture_format_BGRA8888 GL_EXT_debug_marker GL_KHR_texture_compression_astc_ldr GL_BRCM_multi_draw_indirect GL_BRCM_base_instance GL_EXT_robustness 17:00:20.041 T:3002069952 NOTICE: Running database version Addons27 17:00:20.043 T:3002069952 NOTICE: Running database version ViewModes6 17:00:20.044 T:3002069952 NOTICE: Running database version Textures13 17:00:20.055 T:3002069952 NOTICE: Running database version MyMusic60 17:00:20.072 T:3002069952 NOTICE: Running database version MyVideos107 17:00:20.076 T:3002069952 NOTICE: Running database version TV29 17:00:20.079 T:3002069952 NOTICE: Running database version Epg11 17:00:20.361 T:3022080240 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 17:00:20.696 T:3022080240 NOTICE: initialize done 17:00:20.696 T:3022080240 NOTICE: Running the application... 17:00:20.716 T:3022080240 NOTICE: starting zeroconf publishing 17:00:20.716 T:3022080240 NOTICE: starting upnp client 17:00:20.733 T:2516997056 NOTICE: ES: Starting UDP Event server on port 9777 17:00:20.734 T:2516997056 NOTICE: UDP: Listening on port 9777 (ipv6 : false) 17:00:41.217 T:3022080240 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 17:00:41.217 T:3022080240 NOTICE: Enabled debug logging due to GUI setting. Level 2. 17:00:41.217 T:3022080240 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 17:00:41.218 T:3022080240 DEBUG: ------ Window Init () ------ 17:00:51.274 T:2575717312 DEBUG: Thread JobWorker 2575717312 terminating (autodelete) 17:00:51.274 T:2409710528 DEBUG: Thread JobWorker 2409710528 terminating (autodelete) 17:00:51.289 T:2584105920 DEBUG: Thread JobWorker 2584105920 terminating (autodelete) 17:00:51.323 T:3002069952 DEBUG: Thread JobWorker 3002069952 terminating (autodelete) 17:00:57.007 T:3022080240 DEBUG: Keyboard: scancode: 0xae, sym: 0x001b, unicode: 0x001b, modifier: 0x0 17:00:57.207 T:3022080240 DEBUG: OnKey: escape (0xf01b) pressed, action is PreviousMenu 17:00:57.215 T:3022080240 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 17:00:57.535 T:3022080240 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------ 17:00:57.566 T:3022080240 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 17:00:57.566 T:3022080240 DEBUG: ------ Window Init (Settings.xml) ------ 17:00:57.570 T:3022080240 DEBUG: Keyboard: scancode: 0xae, sym: 0x001b, unicode: 0x001b, modifier: 0x0 17:00:59.094 T:3022080240 DEBUG: Previous line repeats 1 times. 17:00:59.094 T:3022080240 DEBUG: OnKey: escape (0xf01b) pressed, action is PreviousMenu 17:00:59.094 T:3022080240 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 17:00:59.421 T:3022080240 DEBUG: ------ Window Deinit (Settings.xml) ------ 17:00:59.450 T:3022080240 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 17:00:59.450 T:3022080240 DEBUG: ------ Window Init (Home.xml) ------ 17:00:59.465 T:3022080240 DEBUG: Keyboard: scancode: 0xae, sym: 0x001b, unicode: 0x001b, modifier: 0x0 17:01:05.428 T:3022080240 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 17:01:05.591 T:3022080240 DEBUG: OnKey: return (0xf00d) pressed, action is Select 17:01:05.591 T:3022080240 DEBUG: Activating window ID: 10004 17:01:05.899 T:3022080240 DEBUG: ------ Window Deinit (Home.xml) ------ 17:01:05.923 T:3022080240 DEBUG: ------ Window Init (Settings.xml) ------ 17:01:05.926 T:3022080240 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 17:01:08.201 T:3022080240 DEBUG: Keyboard: scancode: 0xae, sym: 0x001b, unicode: 0x001b, modifier: 0x0 17:01:08.407 T:3022080240 DEBUG: OnKey: escape (0xf01b) pressed, action is PreviousMenu 17:01:08.407 T:3022080240 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 17:01:08.736 T:3022080240 DEBUG: ------ Window Deinit (Settings.xml) ------ 17:01:08.767 T:3022080240 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 17:01:08.767 T:3022080240 DEBUG: ------ Window Init (Home.xml) ------ 17:01:08.774 T:3022080240 DEBUG: Keyboard: scancode: 0xae, sym: 0x001b, unicode: 0x001b, modifier: 0x0 17:01:10.052 T:3022080240 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 17:01:10.053 T:3022080240 DEBUG: OnKey: down (0xf081) pressed, action is Down 17:01:10.242 T:3022080240 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 17:01:10.819 T:3022080240 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 17:01:11.009 T:3022080240 DEBUG: OnKey: return (0xf00d) pressed, action is Select 17:01:11.009 T:3022080240 DEBUG: Activating window ID: 10025 17:01:11.335 T:3022080240 DEBUG: ------ Window Deinit (Home.xml) ------ 17:01:11.378 T:3022080240 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 17:01:11.378 T:3022080240 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 17:01:11.508 T:3022080240 DEBUG: CDirectoryProvider[]: refreshing.. 17:01:11.509 T:3002069952 DEBUG: Previous line repeats 1 times. 17:01:11.509 T:3002069952 DEBUG: Thread JobWorker start, auto delete: true 17:01:11.509 T:3022080240 DEBUG: CDirectoryProvider[]: refreshing.. 17:01:11.509 T:3002069952 ERROR: GetDirectory - Error getting 17:01:11.509 T:3022080240 DEBUG: CDirectoryProvider[]: refreshing.. 17:01:11.509 T:3002069952 ERROR: GetDirectory - Error getting 17:01:11.509 T:3022080240 DEBUG: CDirectoryProvider[]: refreshing.. 17:01:11.509 T:3002069952 ERROR: GetDirectory - Error getting 17:01:11.509 T:3022080240 DEBUG: CDirectoryProvider[]: refreshing.. 17:01:11.509 T:3002069952 ERROR: GetDirectory - Error getting 17:01:11.509 T:3022080240 DEBUG: CDirectoryProvider[]: refreshing.. 17:01:11.509 T:3002069952 ERROR: GetDirectory - Error getting 17:01:11.511 T:2584105920 ERROR: Previous line repeats 2 times. 17:01:11.511 T:2584105920 DEBUG: Thread JobWorker start, auto delete: true 17:01:11.520 T:3022080240 DEBUG: CGUIMediaWindow::GetDirectory (videodb://movies/titles/) 17:01:11.520 T:3022080240 DEBUG: ParentPath = [videodb://movies/titles/] 17:01:11.527 T:3022080240 DEBUG: RunQuery took 2 ms for 3 items query: select * from movie_view 17:01:11.532 T:2575717312 DEBUG: Thread BackgroundLoader start, auto delete: false 17:01:11.552 T:2575717312 DEBUG: Thread BackgroundLoader 2575717312 terminating 17:01:11.557 T:3022080240 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 17:01:12.883 T:3022080240 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 17:01:12.883 T:3022080240 DEBUG: OnKey: down (0xf081) pressed, action is down 17:01:12.982 T:3002069952 DEBUG: ffmpeg[B2EFF3C0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 17:01:13.022 T:3002069952 DEBUG: DoWork - took 137 ms to load special://masterprofile/Thumbnails/9/9d7f0bb9.jpg 17:01:13.072 T:3022080240 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0112, modifier: 0x0 17:01:19.806 T:3022080240 DEBUG: Keyboard: scancode: 0x66, sym: 0x0069, unicode: 0x0069, modifier: 0x0 17:01:19.806 T:3022080240 DEBUG: OnKey: i (0xf049) pressed, action is Info 17:01:20.294 T:3022080240 DEBUG: ------ Window Init (DialogVideoInfo.xml) ------ 17:01:20.294 T:3022080240 INFO: Loading skin file: DialogVideoInfo.xml, load type: KEEP_IN_MEMORY 17:01:20.368 T:3022080240 DEBUG: Keyboard: scancode: 0x66, sym: 0x0069, unicode: 0x0069, modifier: 0x0 17:01:20.379 T:2575717312 DEBUG: Thread JobWorker start, auto delete: true 17:01:20.421 T:2584105920 DEBUG: Previous line repeats 1 times. 17:01:20.421 T:2584105920 DEBUG: ffmpeg[9A0653C0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 17:01:20.426 T:2409710528 DEBUG: ffmpeg[8FA143C0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 17:01:20.480 T:2575717312 DEBUG: ffmpeg[998653C0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 17:01:20.495 T:2575717312 DEBUG: DoWork - took 115 ms to load special://masterprofile/Thumbnails/0/04954ef6.jpg 17:01:20.509 T:3002069952 DEBUG: ffmpeg[B2EFF3C0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 17:01:20.525 T:2584105920 DEBUG: ffmpeg[9A0653C0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 17:01:20.530 T:2409710528 DEBUG: ffmpeg[8FA143C0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 17:01:20.536 T:3002069952 DEBUG: DoWork - took 158 ms to load special://masterprofile/Thumbnails/f/f2888aa7.jpg 17:01:22.935 T:3022080240 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 17:01:23.147 T:3022080240 DEBUG: OnKey: return (0xf00d) pressed, action is Select 17:01:23.149 T:3022080240 DEBUG: ------ Window Deinit (DialogVideoInfo.xml) ------ 17:01:23.159 T:3022066624 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 17:01:23.159 T:3022066624 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 17:01:23.161 T:3022080240 NOTICE: CApplication::PlayFile: no bRestart 17:01:23.167 T:3022080240 DEBUG: Loading settings for smb://FRITZ-NAS/FRITZ.NAS/Fritz_Filme/Cargo.2017.German.AC3D.DL.1080p.WEB-DL.x265-FuN/Cargo.x265.mkv 17:01:23.168 T:3022080240 NOTICE: CApplication::PlayFile: item.IsVideo() 17:01:23.174 T:3022080240 NOTICE: CApplication::PlayFile: else m_itemCurrentFile->IsStack() && m_currentStack->Size() > 0 17:01:23.174 T:3022080240 DEBUG: CPlayerCoreFactory::GetPlayers(smb://FRITZ-NAS/FRITZ.NAS/Fritz_Filme/Cargo.2017.German.AC3D.DL.1080p.WEB-DL.x265-FuN/Cargo.x265.mkv) 17:01:23.175 T:3022080240 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 17:01:23.175 T:3022080240 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 17:01:23.175 T:3022080240 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 17:01:23.175 T:3022080240 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 17:01:23.175 T:3022080240 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 17:01:23.175 T:3022080240 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 17:01:23.175 T:3022080240 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 17:01:23.175 T:3022080240 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 17:01:23.175 T:3022080240 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 17:01:23.175 T:3022080240 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 17:01:23.175 T:3022080240 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 17:01:23.175 T:3022080240 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 17:01:23.175 T:3022080240 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 17:01:23.175 T:3022080240 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (E2Player) 17:01:23.175 T:3022080240 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 17:01:23.175 T:3022080240 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 17:01:23.175 T:3022080240 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: GstPlayer 17:01:23.175 T:3022080240 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: VideoPlayer 17:01:23.175 T:3022080240 DEBUG: CPlayerCoreFactory::GetPlayers: added 3 players 17:01:23.175 T:3022080240 NOTICE: ExternalPlayer Filename: kodiext 17:01:23.175 T:3022080240 WARNING: ExternalPlayer: invalid value for warpcursor: none 17:01:23.175 T:3022080240 NOTICE: ExternalPlayer Tweaks: hideconsole (true), hidexbmc (true), islauncher (false), warpcursor (none) 17:01:23.175 T:3022080240 NOTICE: OpenFile: smb://FRITZ-NAS/FRITZ.NAS/Fritz_Filme/Cargo.2017.German.AC3D.DL.1080p.WEB-DL.x265-FuN/Cargo.x265.mkv 17:01:23.175 T:3022080240 NOTICE: CApplicationPlayer::OpenFile: iResult=1 PLAYBACK_OK? 17:01:23.175 T:3022080240 NOTICE: CApplication::PlayFile: m_pPlayer->IsPlayingVideo() 17:01:23.175 T:3022080240 NOTICE: CApplication::PlayFile: options.fullscreen=true 17:01:23.175 T:2594161600 DEBUG: Thread ExternalPlayer start, auto delete: false 17:01:23.176 T:3022080240 NOTICE: CApplication::PlayFile: m_pPlayer->IsRenderingVideo()=false 17:01:23.176 T:2594161600 NOTICE: Process: Player : kodiext 17:01:23.176 T:2594161600 NOTICE: Process: File : smb://FRITZ-NAS/FRITZ.NAS/Fritz_Filme/Cargo.2017.German.AC3D.DL.1080p.WEB-DL.x265-FuN/Cargo.x265.mkv 17:01:23.176 T:2594161600 NOTICE: Process: Content: 17:01:23.176 T:2594161600 NOTICE: Process: Args : -U "{1}" -S "{3}" -P "$PPID" 17:01:23.176 T:2594161600 NOTICE: Process: Start 17:01:23.176 T:3022080240 NOTICE: CApplication::PlayFile: g_windowManager.GetActiveWindow() != WINDOW_FULLSCREEN_VIDEO=true 17:01:23.176 T:3022080240 DEBUG: PlayFile: OpenFile succeed, play state 1 17:01:23.176 T:3022080240 NOTICE: CApplication::PlayFile: PLAY_STATE_STARTING 17:01:23.176 T:2594161600 NOTICE: Process: Hiding Kodi window 17:01:23.176 T:3022080240 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 17:01:23.426 T:2594161600 DEBUG: OnPlayBackStarted: play state was 1, starting 0 17:01:23.426 T:2594161600 NOTICE: ExecuteAppLinux: "kodiext" -U "smb://FRITZ-NAS/FRITZ.NAS/Fritz_Filme/Cargo.2017.German.AC3D.DL.1080p.WEB-DL.x265-FuN/Cargo.x265.mkv" -S "{3}" -P "$PPID" 17:01:23.452 T:2575717312 DEBUG: CGUIInfoManager::SetCurrentMovie(smb://FRITZ-NAS/FRITZ.NAS/Fritz_Filme/Cargo.2017.German.AC3D.DL.1080p.WEB-DL.x265-FuN/Cargo.x265.mkv) 17:01:23.453 T:3022066624 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 17:01:23.453 T:3022066624 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 17:01:23.453 T:3022080240 DEBUG: Percentage is 0.000000 17:01:23.471 T:2575717312 DEBUG: GetMovieId (smb://FRITZ-NAS/FRITZ.NAS/Fritz_Filme/Cargo.2017.German.AC3D.DL.1080p.WEB-DL.x265-FuN/Cargo.x265.mkv), query = select idMovie from movie where idFile=13 17:01:23.967 T:3022080240 DEBUG: Percentage is 0.000000 17:01:34.229 T:3022080240 DEBUG: Previous line repeats 19 times. 17:01:34.229 T:3022080240 DEBUG: Percentage is 100.000000 17:01:51.852 T:2594161600 DEBUG: Previous line repeats 34 times. 17:01:51.852 T:2594161600 NOTICE: Process: Stop 17:01:51.852 T:2594161600 NOTICE: Process: Showing Kodi window 17:01:51.863 T:2992632768 INFO: CAESinkALSA - Unable to open device "surround71" for playback 17:01:51.864 T:2992632768 INFO: CAESinkALSA - Unable to open device "surround51" for playback 17:01:51.864 T:2992632768 INFO: CAESinkALSA - Unable to open device "surround71" for playback 17:01:51.866 T:2992632768 INFO: CAESinkALSA - Unable to open device "surround40" for playback 17:01:51.866 T:2992632768 INFO: CAESinkALSA - Unable to open device "surround51" for playback 17:01:51.866 T:2992632768 INFO: CAESinkALSA - Unable to open device "surround71" for playback 17:01:51.892 T:2992632768 NOTICE: Found 1 Lists of Devices 17:01:51.892 T:2992632768 NOTICE: Enumerated ALSA devices: 17:01:51.892 T:2992632768 NOTICE: Device 1 17:01:51.892 T:2992632768 NOTICE: m_deviceName : @ 17:01:51.892 T:2992632768 NOTICE: m_displayName : Default (bcm Analog) 17:01:51.892 T:2992632768 NOTICE: m_displayNameExtra: 17:01:51.892 T:2992632768 NOTICE: m_deviceType : AE_DEVTYPE_PCM 17:01:51.892 T:2992632768 NOTICE: m_channels : FL,FR 17:01:51.892 T:2992632768 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000 17:01:51.892 T:2992632768 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE 17:01:51.892 T:2992632768 NOTICE: m_streamTypes : No passthrough capabilities 17:01:51.893 T:2984244160 INFO: CActiveAESink::OpenSink - initialize sink 17:01:51.893 T:2984244160 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:@ 17:01:51.894 T:2984244160 INFO: CAESinkALSA::Initialize - Attempting to open device "@" 17:01:51.898 T:2984244160 INFO: CAESinkALSA::Initialize - Opened device "sysdefault" 17:01:51.899 T:2984244160 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 17:01:51.899 T:2984244160 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 17:01:51.899 T:2984244160 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 512, bufferSize 8820 17:01:51.899 T:2984244160 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 275, bufferSize 8820 17:01:51.899 T:2984244160 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 200 ms 17:01:51.899 T:2984244160 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 17:01:51.899 T:2984244160 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR 17:01:51.899 T:2984244160 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: none) 17:01:51.899 T:2984244160 DEBUG: CActiveAESink::OpenSink - ALSA Initialized: 17:01:51.899 T:2984244160 DEBUG: Output Device : Default (bcm Analog) 17:01:51.899 T:2984244160 DEBUG: Sample Rate : 44100 17:01:51.899 T:2984244160 DEBUG: Sample Format : AE_FMT_S32NE 17:01:51.899 T:2984244160 DEBUG: Channel Count : 2 17:01:51.899 T:2984244160 DEBUG: Channel Layout: FL,FR 17:01:51.900 T:2984244160 DEBUG: Frames : 275 17:01:51.900 T:2984244160 DEBUG: Frame Size : 8 17:01:51.901 T:2992632768 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 17:01:51.901 T:2594161600 DEBUG: OnPlayBackEnded: play state was 2, starting 0 17:01:51.902 T:2594161600 DEBUG: Thread ExternalPlayer 2594161600 terminating 17:01:51.902 T:3022066624 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 17:01:51.902 T:3022066624 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 17:01:51.905 T:2984244160 ERROR: CAESinkALSA - snd_pcm_writei(-32) Broken pipe - trying to recover 17:01:52.343 T:3002069952 ERROR: Previous line repeats 2 times. 17:01:52.344 T:3002069952 DEBUG: DoWork - Saving file state for video item smb://FRITZ-NAS/FRITZ.NAS/Fritz_Filme/Cargo.2017.German.AC3D.DL.1080p.WEB-DL.x265-FuN/Cargo.x265.mkv 17:01:52.352 T:3002069952 DEBUG: DoWork - Marking video item smb://FRITZ-NAS/FRITZ.NAS/Fritz_Filme/Cargo.2017.German.AC3D.DL.1080p.WEB-DL.x265-FuN/Cargo.x265.mkv as watched 17:01:52.923 T:3022066624 DEBUG: CAnnouncementManager - Announcement: OnUpdate from xbmc 17:01:52.923 T:3022066624 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnUpdate 17:01:52.923 T:3022066624 DEBUG: CAnnouncementManager - Announcement: OnUpdate from xbmc 17:01:52.923 T:3022066624 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnUpdate 17:01:56.957 T:3022080240 DEBUG: Keyboard: scancode: 0xae, sym: 0x001b, unicode: 0x001b, modifier: 0x0 17:01:57.000 T:3022080240 NOTICE: Samba is idle. Closing the remaining connections 17:01:57.262 T:3022080240 DEBUG: OnKey: escape (0xf01b) pressed, action is PreviousMenu 17:01:57.262 T:3022080240 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 17:01:57.595 T:3022080240 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 17:01:57.622 T:3022080240 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 17:01:57.623 T:3022080240 DEBUG: ------ Window Init (Home.xml) ------ 17:01:57.623 T:3022080240 DEBUG: CDirectoryProvider[special://skin/playlists/recent_unwatched_movies.xsp]: refreshing.. 17:01:57.626 T:3022080240 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_movies.xsp]: refreshing.. 17:01:57.630 T:3022080240 DEBUG: CDirectoryProvider[special://skin/playlists/random_movies.xsp]: refreshing.. 17:01:57.630 T:3022080240 DEBUG: CDirectoryProvider[videodb://movies/genres/]: refreshing.. 17:01:57.639 T:3022080240 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 17:01:57.640 T:3022080240 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 17:01:57.640 T:3022080240 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 17:01:57.640 T:3022080240 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 17:01:57.654 T:2409710528 DEBUG: RunQuery took 9 ms for 1 items query: select * from movie_view WHERE ((movie_view.dateAdded > '1900-01-01')) AND ((movie_view.playCount IS NULL OR movie_view.playCount < 1)) 17:01:57.656 T:3002069952 DEBUG: RunQuery took 7 ms for 3 items query: select * from movie_view 17:01:57.669 T:3022080240 DEBUG: Keyboard: scancode: 0xae, sym: 0x001b, unicode: 0x001b, modifier: 0x0 17:01:57.673 T:2584105920 DEBUG: RunQuery took 16 ms for 1 items query: select * from movie_view WHERE ((movie_view.playCount IS NULL OR movie_view.playCount = 0)) 17:01:57.715 T:2409710528 DEBUG: RunQuery took 10 ms for 9 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 17:01:57.737 T:2584105920 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 17:01:57.747 T:2584105920 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 <> 'Verschiedene Interpreten') 17:02:00.083 T:3022080240 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0111, modifier: 0x0 17:02:00.083 T:3022080240 DEBUG: OnKey: up (0xf080) pressed, action is Up 17:02:00.310 T:3022080240 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0111, modifier: 0x0 17:02:00.994 T:3022080240 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 17:02:01.132 T:3022080240 DEBUG: OnKey: return (0xf00d) pressed, action is Select 17:02:01.133 T:3022080240 DEBUG: Keyboard: scancode: 0x60, sym: 0x000d, unicode: 0x000d, modifier: 0x0 17:02:01.150 T:3022066624 DEBUG: CAnnouncementManager - Announcement: OnQuit from xbmc 17:02:01.150 T:3022066624 DEBUG: GOT ANNOUNCEMENT, type: 8, from xbmc, message OnQuit 17:02:01.151 T:3022080240 NOTICE: Storing total System Uptime 17:02:01.151 T:3022080240 NOTICE: Saving settings 17:02:01.158 T:3022080240 NOTICE: Saving skin settings 17:02:01.159 T:3022080240 NOTICE: stop all 17:02:01.160 T:2575717312 DEBUG: Thread JobWorker 2575717312 terminating (autodelete) 17:02:01.160 T:2584105920 DEBUG: Thread JobWorker 2584105920 terminating (autodelete) 17:02:01.161 T:2409710528 DEBUG: Thread JobWorker 2409710528 terminating (autodelete) 17:02:01.161 T:3022080240 NOTICE: stop player 17:02:01.161 T:3022080240 DEBUG: NetworkMessage - Signaling network services to stop 17:02:01.161 T:3022080240 NOTICE: ES: Stopping event server 17:02:01.161 T:3022080240 DEBUG: NetworkMessage - Waiting for network services to stop 17:02:01.161 T:3022080240 NOTICE: stopping upnp 17:02:01.161 T:3002069952 DEBUG: Thread JobWorker 3002069952 terminating (autodelete) 17:02:01.315 T:3022080240 NOTICE: stopping zeroconf publishing 17:02:01.831 T:2508608448 DEBUG: Thread TCPServer 2508608448 terminating 17:02:01.836 T:2516997056 NOTICE: ES: UDP Event server stopped 17:02:01.837 T:2516997056 DEBUG: Thread EventServer 2516997056 terminating 17:02:01.837 T:2609902528 DEBUG: Thread PeripEventScanner 2609902528 terminating 17:02:01.899 T:2635068352 DEBUG: Thread PeripBusUSBUdev 2635068352 terminating 17:02:02.040 T:2618291136 DEBUG: Thread PeripBusAddon 2618291136 terminating 17:02:02.041 T:3022080240 NOTICE: clean cached files! 17:02:02.041 T:3022080240 DEBUG: ADDON: Stopping service addons. 17:02:02.041 T:2626679744 DEBUG: Thread PeripBusCEC 2626679744 terminating 17:02:02.044 T:2992632768 DEBUG: Thread ActiveAE 2992632768 terminating 17:02:02.048 T:2984244160 DEBUG: Thread AESink 2984244160 terminating 17:02:02.271 T:3022080240 NOTICE: closing down remote control service 17:02:02.271 T:3022080240 NOTICE: stopped 17:02:02.471 T:3022080240 NOTICE: destroy 17:02:02.472 T:3022080240 NOTICE: unload skin 17:02:02.472 T:3022080240 INFO: Unloading old skin ... 17:02:02.473 T:3022080240 DEBUG: ------ Window Deinit () ------ 17:02:02.473 T:3022080240 DEBUG: ------ Window Deinit (Home.xml) ------ 17:02:02.525 T:3022080240 DEBUG: GUI Shader - Destroying Shader : 0x2848740 17:02:02.533 T:3022080240 NOTICE: unload sections 17:02:02.542 T:3022066624 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 17:02:02.542 T:3022066624 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 17:02:02.546 T:3022080240 NOTICE: special://profile/ is mapped to: special://masterprofile/ 17:02:02.546 T:3022080240 DEBUG: object 0 --> 0 instances 17:02:02.546 T:3022080240 DEBUG: object 1 --> 0 instances 17:02:02.546 T:3022080240 DEBUG: object 2 --> 0 instances 17:02:02.546 T:3022080240 DEBUG: object 3 --> 0 instances 17:02:02.546 T:3022080240 DEBUG: object 4 --> 0 instances 17:02:02.546 T:3022080240 DEBUG: object 5 --> 0 instances 17:02:02.546 T:3022080240 DEBUG: object 6 --> 0 instances 17:02:02.546 T:3022080240 DEBUG: object 7 --> 0 instances 17:02:02.546 T:3022080240 DEBUG: object 8 --> 0 instances 17:02:02.546 T:3022080240 DEBUG: object 9 --> 0 instances 17:02:02.547 T:3022080240 DEBUG: PVRManager - destroyed 17:02:02.547 T:3022080240 DEBUG: ActiveAE DSP - destroyed 17:02:02.549 T:3022080240 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x27720c0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 17:02:02.550 T:3022080240 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x2757ec0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 17:02:02.550 T:3022080240 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x27a4088 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 17:02:02.550 T:3022080240 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x268ce88 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 17:02:02.550 T:3022080240 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x2792690 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 17:02:02.550 T:3022080240 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x26ce6d0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 17:02:02.550 T:3022080240 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x27ab818 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 17:02:02.550 T:3022080240 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x27648d8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 17:02:02.550 T:3022080240 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x277aff8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 17:02:02.550 T:3022080240 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x2757df8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 17:02:02.551 T:3022066624 DEBUG: Thread Announce 3022066624 terminating 17:02:02.551 T:3022080240 NOTICE: application stopped... 17:02:02.567 T:3022080240 DEBUG: SECTION:UnloadDll(libcurl.so.4)