################################################################################ # ... output of cat /storage/.kodi/temp/kodi.log # LibreELEC release: RPi2.arm-8.0.2 # ################################################################################ 16:01:32.479 T:1962259568 NOTICE: special://profile/ is mapped to: special://masterprofile/ 16:01:32.479 T:1962259568 NOTICE: ----------------------------------------------------------------------- 16:01:32.479 T:1962259568 NOTICE: Starting Kodi (17.3 Git:147cec4). Platform: Linux ARM 32-bit 16:01:32.479 T:1962259568 NOTICE: Using Release Kodi x32 build (version for Raspberry Pi) 16:01:32.480 T:1962259568 NOTICE: Kodi compiled May 25 2017 by GCC 6.2.0 for Linux ARM 32-bit version 4.9.29 (264477) 16:01:32.480 T:1962259568 NOTICE: Running on LibreELEC (official) - Version: 8.0.2, kernel: Linux ARM 32-bit version 4.9.29 16:01:32.480 T:1962259568 NOTICE: FFmpeg version/source: ffmpeg-3.1-kodi 16:01:32.480 T:1962259568 NOTICE: Host CPU: ARMv7 Processor rev 5 (v7l), 4 cores available 16:01:32.480 T:1962259568 NOTICE: ARM Features: Neon enabled 16:01:32.480 T:1962259568 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi/ 16:01:32.480 T:1962259568 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi 16:01:32.480 T:1962259568 NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons 16:01:32.480 T:1962259568 NOTICE: special://masterprofile/ is mapped to: /storage/.kodi/userdata 16:01:32.481 T:1962259568 NOTICE: special://envhome/ is mapped to: /storage 16:01:32.481 T:1962259568 NOTICE: special://home/ is mapped to: /storage/.kodi 16:01:32.481 T:1962259568 NOTICE: special://temp/ is mapped to: /storage/.kodi/temp 16:01:32.481 T:1962259568 NOTICE: special://logpath/ is mapped to: /storage/.kodi/temp 16:01:32.481 T:1962259568 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin 16:01:32.481 T:1962259568 NOTICE: Local hostname: Kodi-SebSonic 16:01:32.481 T:1962259568 NOTICE: Log File is located: /storage/.kodi/temp//kodi.log 16:01:32.481 T:1962259568 NOTICE: ----------------------------------------------------------------------- 16:01:32.652 T:1962259568 ERROR: DBus: Error org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files 16:01:32.670 T:1962259568 NOTICE: load settings... 16:01:32.879 T:1962259568 NOTICE: Found 2 Lists of Devices 16:01:32.879 T:1962259568 NOTICE: Enumerated PI devices: 16:01:32.879 T:1962259568 NOTICE: Device 1 16:01:32.880 T:1962259568 NOTICE: m_deviceName : HDMI 16:01:32.880 T:1962259568 NOTICE: m_displayName : HDMI 16:01:32.880 T:1962259568 NOTICE: m_displayNameExtra: 16:01:32.880 T:1962259568 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 16:01:32.880 T:1962259568 NOTICE: m_channels : FL,FR 16:01:32.880 T:1962259568 NOTICE: m_sampleRates : 8000,11025,16000,22050,24000,32000,44100,48000,88200,96000,176400,192000 16:01:32.880 T:1962259568 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP,AE_FMT_RAW 16:01:32.880 T:1962259568 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_EAC3,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_512 16:01:32.881 T:1962259568 NOTICE: Device 2 16:01:32.881 T:1962259568 NOTICE: m_deviceName : Analogue 16:01:32.881 T:1962259568 NOTICE: m_displayName : Analogue 16:01:32.881 T:1962259568 NOTICE: m_displayNameExtra: 16:01:32.881 T:1962259568 NOTICE: m_deviceType : AE_DEVTYPE_PCM 16:01:32.881 T:1962259568 NOTICE: m_channels : FL,FR 16:01:32.881 T:1962259568 NOTICE: m_sampleRates : 48000 16:01:32.881 T:1962259568 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 16:01:32.881 T:1962259568 NOTICE: m_streamTypes : No passthrough capabilities 16:01:32.881 T:1962259568 NOTICE: Device 3 16:01:32.881 T:1962259568 NOTICE: m_deviceName : Both 16:01:32.881 T:1962259568 NOTICE: m_displayName : HDMI and Analogue 16:01:32.881 T:1962259568 NOTICE: m_displayNameExtra: 16:01:32.881 T:1962259568 NOTICE: m_deviceType : AE_DEVTYPE_PCM 16:01:32.881 T:1962259568 NOTICE: m_channels : FL,FR 16:01:32.882 T:1962259568 NOTICE: m_sampleRates : 48000 16:01:32.882 T:1962259568 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 16:01:32.882 T:1962259568 NOTICE: m_streamTypes : No passthrough capabilities 16:01:32.882 T:1962259568 NOTICE: Enumerated PULSE devices: 16:01:32.882 T:1962259568 NOTICE: Device 1 16:01:32.882 T:1962259568 NOTICE: m_deviceName : Default 16:01:32.882 T:1962259568 NOTICE: m_displayName : Default 16:01:32.882 T:1962259568 NOTICE: m_displayNameExtra: Bluetooth Audio (PULSEAUDIO) 16:01:32.882 T:1962259568 NOTICE: m_deviceType : AE_DEVTYPE_PCM 16:01:32.882 T:1962259568 NOTICE: m_channels : FL,FR 16:01:32.882 T:1962259568 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000 16:01:32.882 T:1962259568 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT 16:01:32.882 T:1962259568 NOTICE: m_streamTypes : No passthrough capabilities 16:01:32.917 T:1962259568 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml 16:01:32.918 T:1962259568 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are... false 1 720 540 30 16:01:32.923 T:1962259568 NOTICE: Loaded settings file from special://profile/advancedsettings.xml 16:01:32.923 T:1962259568 NOTICE: Contents of special://profile/advancedsettings.xml are... 1 157286400 5 30 30 mysql 192.168.0.102 3306 kodi ***** mysql 192.168.0.102 3306 kodi ***** true true 16:01:32.923 T:1962259568 WARNING: VIDEO database configuration is experimental. 16:01:32.926 T:1962259568 NOTICE: Default Video Player: VideoPlayer 16:01:32.926 T:1962259568 NOTICE: Default Audio Player: paplayer 16:01:32.926 T:1962259568 NOTICE: Disabled debug logging due to GUI setting. Level 0. 16:01:32.926 T:1962259568 NOTICE: Log level changed to "LOG_LEVEL_NORMAL" 16:01:32.926 T:1962259568 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml 16:01:32.931 T:1962259568 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 16:01:32.932 T:1962259568 NOTICE: Loaded playercorefactory configuration 16:01:32.933 T:1962259568 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 16:01:32.933 T:1962259568 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 16:01:32.942 T:1962259568 NOTICE: WakeOnAccess - Load settings : 16:01:32.942 T:1962259568 NOTICE: WakeOnAccess - Enabled:TRUE 16:01:32.942 T:1962259568 NOTICE: -Network init timeout : [20] sec 16:01:32.942 T:1962259568 NOTICE: -Network settle time : [500] ms 16:01:32.942 T:1962259568 NOTICE: Registering wakeup entry: 16:01:32.942 T:1962259568 NOTICE: HostName : 192.168.0.102 16:01:32.943 T:1962259568 NOTICE: MacAddress : F8:D1:11:02:D7:29 16:01:32.943 T:1962259568 NOTICE: PingPort : 0 16:01:32.943 T:1962259568 NOTICE: PingMode : 0 16:01:32.943 T:1962259568 NOTICE: Timeout : 300 (sec) 16:01:32.943 T:1962259568 NOTICE: WaitForOnline : 40 (sec) 16:01:32.943 T:1962259568 NOTICE: WaitForOnlineEx : 40 (sec) 16:01:32.943 T:1962259568 NOTICE: WaitForServices : 5 (sec) 16:01:32.943 T:1962259568 NOTICE: Registering wakeup entry: 16:01:32.943 T:1962259568 NOTICE: HostName : HTPC-SERVER 16:01:32.943 T:1962259568 NOTICE: MacAddress : F8:D1:11:02:D7:29 16:01:32.943 T:1962259568 NOTICE: PingPort : 0 16:01:32.943 T:1962259568 NOTICE: PingMode : 0 16:01:32.943 T:1962259568 NOTICE: Timeout : 300 (sec) 16:01:32.943 T:1962259568 NOTICE: WaitForOnline : 40 (sec) 16:01:32.943 T:1962259568 NOTICE: WaitForOnlineEx : 40 (sec) 16:01:32.943 T:1962259568 NOTICE: WaitForServices : 5 (sec) 15:16:13.600 T:1962259568 NOTICE: Running database version Addons27 15:16:14.534 T:1962259568 NOTICE: ADDONS: Using repository repository.xbmc.org 15:16:14.535 T:1962259568 NOTICE: ADDONS: Using repository repository.kodi.game 15:16:14.535 T:1962259568 NOTICE: ADDONS: Using repository repository.libreelec.tv 15:16:14.535 T:1962259568 NOTICE: ADDONS: Using repository repository.kodinerds 15:16:14.535 T:1962259568 NOTICE: ADDONS: Using repository repository.kodinerds_RPi2 15:16:14.750 T:1962259568 NOTICE: Raspberry PI firmware version: May 15 2017 17:01:07 Copyright (c) 2012 Broadcom version 9469ea3706e34c4de62f38a5008f69a429b4b43e (clean) (release) 15:16:14.751 T:1962259568 NOTICE: ARM mem: 752MB GPU mem: 256MB MPG2:0 WVC1:0 15:16:14.751 T:1962259568 NOTICE: cache.memorysize: 20MB libass.cache: 0MB 15:16:14.751 T:1962259568 NOTICE: Config: arm_freq=900 audio_pwm_mode=1 config_hdmi_boost=5 disable_commandline_tags=2 disable_l2cache=1 enable_uart=1 force_eeprom_read=1 force_pwm_open=1 framebuffer_ignore_alpha=1 framebuffer_swap=1 hdmi_channel_map=8 hdmi_force_cec_address=65535 hdmi_ignore_cec_init=1 init_uart_clock=0x2dc6c00 lcd_framerate=60 over_voltage_avs=0x1b774 over_voltage_avs_boost=0x13d62 overscan_bottom=48 overscan_left=48 overscan_right=48 overscan_top=48 pause_burst_frames=1 program_serial_random=1 sdram_freq=450 temp_limit=85 15:16:14.752 T:1962259568 NOTICE: Config: device_tree=- 15:16:14.753 T:1962259568 NOTICE: InitWindowSystem: Using EGL Implementation: raspberrypi 15:16:14.756 T:1962259568 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 60.000000 Hz 15:16:14.756 T:1962259568 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 59.940063 Hz 15:16:14.756 T:1962259568 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 60.000000 Hz 15:16:14.756 T:1962259568 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 59.940063 Hz 15:16:14.756 T:1962259568 NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 60.000000 Hz 15:16:14.756 T:1962259568 NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 59.940063 Hz 15:16:14.756 T:1962259568 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 60.000000 Hz 15:16:14.756 T:1962259568 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 59.940063 Hz 15:16:14.756 T:1962259568 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 60.000000 Hz 15:16:14.757 T:1962259568 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 59.940063 Hz 15:16:14.757 T:1962259568 NOTICE: Found resolution 720 x 576 for display 0 with 720 x 576 @ 50.000000 Hz 15:16:14.757 T:1962259568 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 50.000000 Hz 15:16:14.757 T:1962259568 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 50.000000 Hz 15:16:14.757 T:1962259568 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 24.000000 Hz 15:16:14.757 T:1962259568 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 23.976025 Hz 15:16:14.757 T:1962259568 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 25.000000 Hz 15:16:14.757 T:1962259568 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 30.000000 Hz 15:16:14.757 T:1962259568 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 29.970032 Hz 15:16:14.757 T:1962259568 NOTICE: Found (1920x1080@60.000000) at 24, setting to RES_DESKTOP at 16 15:16:14.757 T:1962259568 NOTICE: Checking resolution 16 15:16:15.080 T:1962259568 NOTICE: GL_VENDOR = Broadcom 15:16:15.080 T:1962259568 NOTICE: GL_RENDERER = VideoCore IV HW 15:16:15.081 T:1962259568 NOTICE: GL_VERSION = OpenGL ES 2.0 15:16:15.081 T:1962259568 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 15:16:15.081 T:1962259568 NOTICE: GL_EXTENSIONS = GL_OES_compressed_ETC1_RGB8_texture GL_OES_compressed_paletted_texture GL_OES_texture_npot GL_OES_depth24 GL_OES_vertex_half_float GL_OES_EGL_image GL_OES_EGL_image_external GL_EXT_discard_framebuffer GL_OES_rgb8_rgba8 GL_OES_depth32 GL_OES_mapbuffer GL_EXT_texture_format_BGRA8888 GL_APPLE_rgb_422 GL_EXT_debug_marker 15:16:16.852 T:1874850720 NOTICE: Running database version Addons27 15:16:16.860 T:1874850720 NOTICE: Running database version ViewModes6 15:16:17.105 T:1832907680 NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001) 15:16:17.166 T:1874850720 NOTICE: Running database version Textures13 15:16:17.194 T:1874850720 NOTICE: WakeOnAccess [192.168.0.102] trigged by accessing : MySQL : MyMusic60 15:16:17.213 T:1874850720 NOTICE: WakeOnAccess success exit, server already running 15:16:17.709 T:1874850720 NOTICE: Running database version MyMusic60 15:16:17.788 T:1874850720 NOTICE: Running database version MyVideos107 15:16:17.799 T:1874850720 NOTICE: Running database version TV29 15:16:17.808 T:1874850720 NOTICE: Running database version Epg11 15:16:17.817 T:1962259568 NOTICE: start dvd mediatype detection 15:16:19.235 T:1962259568 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 15:16:20.245 T:1962259568 NOTICE: initialize done 15:16:20.245 T:1962259568 NOTICE: Running the application... 15:16:20.299 T:1962259568 NOTICE: starting zeroconf publishing 15:16:20.300 T:1962259568 NOTICE: CWebServer[8080]: Started 15:16:20.300 T:1962259568 NOTICE: starting upnp client 15:16:20.316 T:1635136416 NOTICE: ES: Starting UDP Event server on port 9777 15:16:20.316 T:1635136416 NOTICE: UDP: Listening on port 9777 (ipv6 : false) 15:16:21.045 T:1792013216 NOTICE: script.tv.show.next.aired: ### TV Show - Next Aired starting background proc (6.0.15) 15:16:24.258 T:1792013216 NOTICE: script.tv.show.next.aired: ### starting data update 15:16:27.724 T:1750070176 NOTICE: Skin Helper Backgrounds --> BackgroundsUpdater - started 15:16:28.172 T:1758458784 NOTICE: Skin Helper Widgets --> Backgroundservice started 15:16:28.643 T:1719022496 WARNING: CSkinInfo: failed to load skin settings 15:16:28.916 T:1507849120 NOTICE: Skin Helper Service --> WebService - start helper webservice on port 52307 15:16:28.924 T:1800401824 NOTICE: Skin Helper Service --> Skin Helper Service version 1.1.3 started 15:16:32.207 T:1792013216 NOTICE: script.tv.show.next.aired: ### getting series & episode info for #257655 - Arrow 15:16:33.541 T:1792013216 NOTICE: script.tv.show.next.aired: ### getting series info for #121361 - Game of Thrones 15:16:33.721 T:1792013216 NOTICE: script.tv.show.next.aired: ### getting series info for #274431 - Gotham 15:16:34.213 T:1792013216 NOTICE: script.tv.show.next.aired: ### getting series info for #264586 - Orange Is the New Black 15:16:35.759 T:1792013216 NOTICE: script.tv.show.next.aired: ### data update finished 15:17:10.004 T:1962259568 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 15:17:10.005 T:1962259568 NOTICE: Enabled debug logging due to GUI setting. Level 2. 15:17:10.005 T:1962259568 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 15:17:10.007 T:1962259568 DEBUG: ------ Window Init () ------ 15:17:29.392 T:1440740256 DEBUG: Thread JobWorker 1440740256 terminating (autodelete) 15:17:29.393 T:1733292960 DEBUG: Thread JobWorker 1733292960 terminating (autodelete) 15:17:29.393 T:1874850720 DEBUG: Thread JobWorker 1874850720 terminating (autodelete) 15:17:29.490 T:1741681568 DEBUG: Thread JobWorker 1741681568 terminating (autodelete) 15:17:31.304 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:17:31.305 T:1962259568 DEBUG: OnKey: down (0xf081) pressed, action is Down 15:17:31.421 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:17:31.622 T:1962259568 DEBUG: Previous line repeats 1 times. 15:17:31.622 T:1962259568 DEBUG: OnKey: down (0xf081) pressed, action is Down 15:17:31.721 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:17:31.838 T:1962259568 DEBUG: Previous line repeats 1 times. 15:17:31.838 T:1962259568 DEBUG: OnKey: down (0xf081) pressed, action is Down 15:17:31.938 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:17:32.104 T:1962259568 DEBUG: Previous line repeats 1 times. 15:17:32.105 T:1962259568 DEBUG: OnKey: down (0xf081) pressed, action is Down 15:17:32.121 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:17:32.271 T:1962259568 DEBUG: Previous line repeats 1 times. 15:17:32.271 T:1962259568 DEBUG: OnKey: down (0xf081) pressed, action is Down 15:17:32.321 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:17:32.821 T:1962259568 DEBUG: Previous line repeats 1 times. 15:17:32.821 T:1962259568 DEBUG: OnKey: down (0xf081) pressed, action is Down 15:17:32.871 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:17:33.104 T:1962259568 DEBUG: Previous line repeats 1 times. 15:17:33.105 T:1962259568 DEBUG: OnKey: down (0xf081) pressed, action is Down 15:17:33.105 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:17:33.271 T:1962259568 DEBUG: Previous line repeats 1 times. 15:17:33.271 T:1962259568 DEBUG: OnKey: down (0xf081) pressed, action is Down 15:17:33.338 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:17:34.338 T:1962259568 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 15:17:34.338 T:1962259568 DEBUG: OnKey: up (0xf080) pressed, action is Up 15:17:34.404 T:1962259568 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 15:17:34.604 T:1962259568 DEBUG: Previous line repeats 1 times. 15:17:34.605 T:1962259568 DEBUG: OnKey: up (0xf080) pressed, action is Up 15:17:34.638 T:1962259568 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 15:17:40.504 T:1962259568 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 15:17:40.654 T:1962259568 DEBUG: OnKey: escape (0xf01b) pressed, action is PreviousMenu 15:17:40.687 T:1962259568 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 15:17:40.898 T:1962259568 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------ 15:17:40.904 T:1962259568 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 15:17:40.904 T:1962259568 DEBUG: ------ Window Init (Settings.xml) ------ 15:17:40.905 T:1962259568 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 15:17:40.909 T:1741681568 DEBUG: Thread JobWorker start, auto delete: true 15:17:40.926 T:1741681568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x5ef558b8 15:17:40.927 T:1741681568 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(402672), nBufferAlignmen(16) 15:17:40.935 T:1741681568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x5ef8b220 15:17:40.936 T:1741681568 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:17:40.974 T:1741681568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x5ef558b8 15:17:40.976 T:1741681568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x5ef8b220 15:17:40.976 T:1741681568 DEBUG: DecodeJpegToTexture: decoded special://skin/backgrounds/settings.jpg 1024x576 15:17:48.825 T:1962259568 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 15:17:48.910 T:1962259568 DEBUG: OnKey: escape (0xf01b) pressed, action is PreviousMenu 15:17:48.910 T:1962259568 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 15:17:49.180 T:1962259568 DEBUG: ------ Window Deinit (Settings.xml) ------ 15:17:49.187 T:1962259568 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 15:17:49.188 T:1962259568 DEBUG: ------ Window Init (Home.xml) ------ 15:17:49.201 T:1962259568 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 15:17:49.202 T:1741681568 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update 15:17:49.226 T:1741681568 DEBUG: GetRecentlyAddedAlbumSongs() query: SELECT songview.*, songartistview.* FROM (SELECT idAlbum FROM album ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN songview ON songview.idAlbum = recentalbums.idAlbum JOIN songartistview ON songview.idSong = songartistview.idSong ORDER BY songview.idAlbum DESC, songview.idSong, songartistview.idRole, songartistview.iOrder 15:17:49.230 T:1741681568 DEBUG: GetRecentlyAddedAlbums query: SELECT albumview.*, albumartistview.* FROM (SELECT idAlbum FROM album WHERE strAlbum != '' ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN albumview ON albumview.idAlbum = recentalbums.idAlbum JOIN albumartistview ON albumview.idAlbum = albumartistview.idAlbum ORDER BY albumview.idAlbum desc, albumartistview.iOrder 15:17:49.246 T:1741681568 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update 15:17:49.347 T:1741681568 DEBUG: RunQuery took 76 ms for 10 items query: select * from movie_view ORDER BY dateAdded desc, idMovie desc LIMIT 10 15:17:49.456 T:1741681568 DEBUG: RunQuery took 61 ms for 10 items query: select * from episode_view ORDER BY dateAdded desc, idEpisode desc LIMIT 10 15:17:49.527 T:1741681568 DEBUG: RunQuery took 9 ms for 0 items query: select * from musicvideo_view ORDER BY dateAdded desc, idMVideo desc LIMIT 10 15:17:49.530 T:1741681568 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 15:17:49.539 T:1741681568 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') 15:17:50.099 T:1962259568 DEBUG: Keyboard: scancode: 0x69, sym: 0x0114, unicode: 0x0000, modifier: 0x0 15:17:50.099 T:1962259568 DEBUG: OnKey: left (0xf082) pressed, action is Left 15:17:50.121 T:1962259568 DEBUG: Keyboard: scancode: 0x69, sym: 0x0114, unicode: 0x0000, modifier: 0x0 15:17:50.271 T:1962259568 DEBUG: Previous line repeats 1 times. 15:17:50.271 T:1962259568 DEBUG: OnKey: left (0xf082) pressed, action is Left 15:17:50.337 T:1962259568 DEBUG: Keyboard: scancode: 0x69, sym: 0x0114, unicode: 0x0000, modifier: 0x0 15:17:50.471 T:1962259568 DEBUG: Previous line repeats 1 times. 15:17:50.471 T:1962259568 DEBUG: OnKey: left (0xf082) pressed, action is Left 15:17:50.475 T:1874850720 DEBUG: Thread JobWorker start, auto delete: true 15:17:50.507 T:1741681568 DEBUG: Previous line repeats 2 times. 15:17:50.507 T:1741681568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x5efa62b8 15:17:50.509 T:1741681568 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(112432), nBufferAlignmen(16) 15:17:50.516 T:1440740256 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x7275b730 15:17:50.517 T:1741681568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x5ef7d1d8 15:17:50.518 T:1440740256 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 15:17:50.519 T:1741681568 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:17:50.541 T:1440740256 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x727261d8 15:17:50.542 T:1741681568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x5efa62b8 15:17:50.544 T:1440740256 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:17:50.544 T:1741681568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x5ef7d1d8 15:17:50.545 T:1741681568 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/c/cdb3cbce.jpg 960x540 15:17:50.580 T:1741681568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x5ef83200 15:17:50.580 T:1874850720 DEBUG: ffmpeg[6FBFF3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 15:17:50.580 T:1440740256 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x7275b730 15:17:50.582 T:1733292960 DEBUG: ffmpeg[674FF3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 15:17:50.584 T:1741681568 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(141888), nBufferAlignmen(16) 15:17:50.584 T:1440740256 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x727261d8 15:17:50.585 T:1440740256 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/7/78915a9a.jpg 960x540 15:17:50.585 T:1440740256 DEBUG: DoWork - took 106 ms to load special://masterprofile/Thumbnails/7/78915a9a.jpg 15:17:50.601 T:1741681568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x5efb3610 15:17:50.603 T:1733292960 DEBUG: DoWork - took 123 ms to load special://masterprofile/Thumbnails/1/14aaf49d.jpg 15:17:50.604 T:1874850720 DEBUG: DoWork - took 127 ms to load special://masterprofile/Thumbnails/f/ff090537.jpg 15:17:50.604 T:1741681568 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:17:50.617 T:1962259568 DEBUG: Keyboard: scancode: 0x69, sym: 0x0114, unicode: 0x0000, modifier: 0x0 15:17:50.626 T:1741681568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x5ef83200 15:17:50.628 T:1741681568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x5efb3610 15:17:50.629 T:1741681568 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/1/1ccbf1eb.jpg 960x540 15:17:52.276 T:1962259568 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 15:17:52.393 T:1962259568 DEBUG: OnKey: return (0xf00d) pressed, action is Select 15:17:52.393 T:1962259568 DEBUG: Activating window ID: 10025 15:17:52.648 T:1962259568 DEBUG: ------ Window Deinit (Home.xml) ------ 15:17:52.702 T:1962259568 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 15:17:52.702 T:1962259568 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 15:17:53.076 T:1962259568 DEBUG: CGUIMediaWindow::GetDirectory (videodb://movies/titles/) 15:17:53.076 T:1962259568 DEBUG: ParentPath = [videodb://movies/titles/] 15:17:53.584 T:1962259568 DEBUG: RunQuery took 498 ms for 1263 items query: select * from movie_view 15:17:54.373 T:1962259568 DEBUG: Saving fileitems [videodb://movies/titles/] 15:17:54.501 T:1962259568 DEBUG: -- items: 1263, sort method: 0, ascending: true 15:17:54.677 T:1499460512 DEBUG: Thread BackgroundLoader start, auto delete: false 15:17:54.888 T:1962259568 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 15:17:54.915 T:1962259568 DEBUG: [Warning] CGUITextureManager::GetTexturePath: could not find texture 'OverlayUnwatched.png' 15:17:54.939 T:1440740256 DEBUG: Previous line repeats 10 times. 15:17:54.939 T:1440740256 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x7275b730 15:17:54.940 T:1440740256 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 15:17:54.947 T:1741681568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x5ef558b8 15:17:54.948 T:1440740256 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x7271f768 15:17:54.949 T:1741681568 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 15:17:54.950 T:1440740256 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:17:54.960 T:1741681568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x5efb8f30 15:17:54.961 T:1440740256 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x7275b730 15:17:54.961 T:1741681568 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:17:54.963 T:1440740256 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x7271f768 15:17:54.964 T:1440740256 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/e/e36f19d0.jpg 360x540 15:17:54.967 T:1874850720 DEBUG: ffmpeg[6FBFF3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 15:17:54.972 T:1741681568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x5ef558b8 15:17:54.974 T:1741681568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x5efb8f30 15:17:54.975 T:1741681568 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/d/dc90101b.jpg 360x540 15:17:55.922 T:1962259568 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 15:17:55.922 T:1962259568 DEBUG: OnKey: right (0xf083) pressed, action is Right 15:17:55.925 T:1962259568 DEBUG: [Warning] CGUITextureManager::GetTexturePath: could not find texture 'OverlayUnwatched.png' 15:17:56.043 T:1962259568 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 15:17:56.402 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x5ea29340 15:17:56.403 T:1733292960 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x6ba64730 15:17:56.403 T:1874850720 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 15:17:56.411 T:1874850720 DEBUG: Previous line repeats 1 times. 15:17:56.412 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x5e064910 15:17:56.413 T:1874850720 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:17:56.427 T:1733292960 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x73179160 15:17:56.427 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x5ea29340 15:17:56.429 T:1733292960 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:17:56.429 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x5e064910 15:17:56.430 T:1874850720 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/6/68d62945.jpg 360x540 15:17:56.446 T:1440740256 DEBUG: ffmpeg[55DFF3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 15:17:56.450 T:1741681568 DEBUG: ffmpeg[67CFF3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 15:17:56.452 T:1733292960 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x6ba64730 15:17:56.453 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x5ed237f8 15:17:56.454 T:1733292960 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x73179160 15:17:56.455 T:1874850720 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 15:17:56.455 T:1733292960 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/e/ed4e1d28.jpg 360x540 15:17:56.461 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x5ea07cb8 15:17:56.463 T:1874850720 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:17:56.477 T:1733292960 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x731ce8d0 15:17:56.478 T:1733292960 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 15:17:56.478 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x5ed237f8 15:17:56.481 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x5ea07cb8 15:17:56.482 T:1874850720 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/3/303278f7.jpg 360x540 15:17:56.487 T:1733292960 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x73159658 15:17:56.489 T:1733292960 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:17:56.501 T:1440740256 DEBUG: ffmpeg[55DFF3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 15:17:56.513 T:1741681568 DEBUG: ffmpeg[67CFF3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 15:17:56.525 T:1733292960 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x731ce8d0 15:17:56.526 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x5ed238c8 15:17:56.534 T:1733292960 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x73159658 15:17:56.535 T:1733292960 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/7/7ec149bb.jpg 360x540 15:17:56.535 T:1874850720 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(275088), nBufferAlignmen(16) 15:17:56.543 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x5ed2b910 15:17:56.545 T:1874850720 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:17:56.560 T:1440740256 DEBUG: ffmpeg[55DFF3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 15:17:56.593 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x5ed238c8 15:17:56.596 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x5ed2b910 15:17:56.596 T:1874850720 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/9/9ef14b82.jpg 1280x720 15:17:56.596 T:1874850720 DEBUG: DoWork - took 112 ms to load special://masterprofile/Thumbnails/9/9ef14b82.jpg 15:17:56.691 T:1741681568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x5efba0d8 15:17:56.693 T:1741681568 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 15:17:56.699 T:1440740256 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x7275b730 15:17:56.700 T:1440740256 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 15:17:56.700 T:1741681568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x5ef990a0 15:17:56.702 T:1741681568 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:17:56.713 T:1440740256 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x7271f768 15:17:56.714 T:1741681568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x5efba0d8 15:17:56.715 T:1440740256 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:17:56.716 T:1741681568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x5ef990a0 15:17:56.716 T:1741681568 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/e/e40dbfd8.jpg 360x540 15:17:56.727 T:1440740256 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x7275b730 15:17:56.729 T:1440740256 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x7271f768 15:17:56.729 T:1440740256 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/a/a0c025c5.jpg 360x540 15:17:57.754 T:1962259568 DEBUG: Keyboard: scancode: 0x69, sym: 0x0114, unicode: 0x0000, modifier: 0x0 15:17:57.754 T:1962259568 DEBUG: OnKey: left (0xf082) pressed, action is Left 15:17:57.787 T:1962259568 DEBUG: Keyboard: scancode: 0x69, sym: 0x0114, unicode: 0x0000, modifier: 0x0 15:17:57.921 T:1962259568 DEBUG: Previous line repeats 1 times. 15:17:57.921 T:1962259568 DEBUG: OnKey: left (0xf082) pressed, action is Left 15:17:58.054 T:1962259568 DEBUG: Keyboard: scancode: 0x69, sym: 0x0114, unicode: 0x0000, modifier: 0x0 15:17:58.241 T:1499460512 DEBUG: Thread BackgroundLoader 1499460512 terminating 15:17:59.429 T:1962259568 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 15:17:59.518 T:1962259568 DEBUG: OnKey: return (0xf00d) pressed, action is Select 15:17:59.601 T:1962259568 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 15:18:00.690 T:1962259568 DEBUG: Previous line repeats 1 times. 15:18:00.691 T:1962259568 DEBUG: OnKey: return (0xf00d) pressed, action is Select 15:18:00.808 T:1962259568 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 15:18:02.145 T:1962259568 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 15:18:02.145 T:1962259568 DEBUG: OnKey: right (0xf083) pressed, action is Right 15:18:02.204 T:1962259568 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 15:18:02.702 T:1962259568 DEBUG: Previous line repeats 1 times. 15:18:02.702 T:1962259568 DEBUG: OnKey: right (0xf083) pressed, action is Right 15:18:02.705 T:1962259568 DEBUG: [Warning] CGUITextureManager::GetTexturePath: could not find texture 'OverlayUnwatched.png' 15:18:02.788 T:1962259568 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 15:18:03.482 T:1962259568 DEBUG: Previous line repeats 1 times. 15:18:03.482 T:1962259568 DEBUG: OnKey: right (0xf083) pressed, action is Right 15:18:03.484 T:1962259568 DEBUG: [Warning] CGUITextureManager::GetTexturePath: could not find texture 'OverlayUnwatched.png' 15:18:03.515 T:1733292960 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x731c8df8 15:18:03.517 T:1733292960 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(275088), nBufferAlignmen(16) 15:18:03.522 T:1733292960 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x73159658 15:18:03.523 T:1733292960 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:18:03.538 T:1962259568 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 15:18:03.559 T:1733292960 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x731c8df8 15:18:03.561 T:1733292960 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x73159658 15:18:03.562 T:1733292960 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/f/f98fe47c.jpg 1280x720 15:18:04.286 T:1962259568 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 15:18:04.286 T:1962259568 DEBUG: OnKey: return (0xf00d) pressed, action is Select 15:18:04.287 T:1962259568 INFO: Loading skin file: DialogContextMenu.xml, load type: KEEP_IN_MEMORY 15:18:04.294 T:1962259568 DEBUG: ------ Window Init (DialogContextMenu.xml) ------ 15:18:11.654 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:18:11.655 T:1962259568 DEBUG: OnKey: down (0xf081) pressed, action is Down 15:18:11.788 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:18:12.254 T:1962259568 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 15:18:12.354 T:1962259568 DEBUG: OnKey: return (0xf00d) pressed, action is Select 15:18:12.355 T:1962259568 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 15:18:12.606 T:1962259568 DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------ 15:18:12.621 T:1962259568 NOTICE: WakeOnAccess [HTPC-SERVER] trigged by accessing : smb://HTPC-SERVER/3D MKV/Assassin's Creed (2016)/Assassin's Creed.mk3d 15:18:12.746 T:1962259568 NOTICE: WakeOnAccess success exit, server already running 15:18:12.884 T:1962259568 DEBUG: OnPlayMedia smb://HTPC-SERVER/3D MKV/Assassin's Creed (2016)/Assassin's Creed.mk3d 15:18:12.886 T:1962255264 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 15:18:12.886 T:1962255264 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 15:18:12.901 T:1962259568 DEBUG: Loading settings for smb://HTPC-SERVER/3D MKV/Assassin's Creed (2016)/Assassin's Creed.mk3d 15:18:12.913 T:1962259568 DEBUG: CPlayerCoreFactory::GetPlayers(smb://HTPC-SERVER/3D MKV/Assassin's Creed (2016)/Assassin's Creed.mk3d) 15:18:12.913 T:1962259568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 15:18:12.913 T:1962259568 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 15:18:12.913 T:1962259568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 15:18:12.913 T:1962259568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 15:18:12.913 T:1962259568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 15:18:12.914 T:1962259568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 15:18:12.914 T:1962259568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 15:18:12.914 T:1962259568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 15:18:12.914 T:1962259568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 15:18:12.914 T:1962259568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 15:18:12.914 T:1962259568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 15:18:12.914 T:1962259568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 15:18:12.915 T:1962259568 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 15:18:12.915 T:1962259568 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 15:18:12.915 T:1962259568 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 15:18:12.915 T:1962259568 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 15:18:12.915 T:1962259568 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 15:18:12.924 T:1962259568 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 15:18:12.925 T:1962259568 NOTICE: VideoPlayer: Opening: smb://HTPC-SERVER/3D MKV/Assassin's Creed (2016)/Assassin's Creed.mk3d 15:18:12.925 T:1962259568 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 15:18:12.926 T:1962259568 DEBUG: CMMALRenderer::CMMALRenderer 15:18:12.926 T:1962259568 DEBUG: CMMALRenderer::UnInitMMAL 15:18:12.926 T:1962259568 DEBUG: CMMALRenderer::PreInit 15:18:12.926 T:1499460512 DEBUG: Thread MMALProcess start, auto delete: false 15:18:12.927 T:1499460512 DEBUG: CMMALRenderer::Run - starting 15:18:12.927 T:1423963040 DEBUG: Thread VideoPlayer start, auto delete: false 15:18:12.929 T:1423963040 NOTICE: Creating InputStream 15:18:12.941 T:1930425248 INFO: CActiveAESink::OpenSink - initialize sink 15:18:12.958 T:1423963040 DEBUG: CSMBFile::Open - opened smb://HTPC-SERVER/3D MKV/Assassin's Creed (2016)/Assassin's Creed.mk3d, fd=10000 15:18:12.960 T:1423963040 DEBUG: ScanForExternalSubtitles: Searching for subtitles... 15:18:12.964 T:1423963040 DEBUG: ScanForExternalSubtitles: END (total time: 5 ms) 15:18:12.964 T:1423963040 NOTICE: Creating Demuxer 15:18:12.969 T:1800401824 DEBUG: Skin Helper Service --> Kodi_Monitor: sender xbmc - method: Playlist.OnAdd - data: {"item":{"id":2755,"type":"movie"},"playlistid":1,"position":0} 15:18:12.970 T:1423963040 DEBUG: Open - probing detected format [matroska,webm] 15:18:12.982 T:1758458784 DEBUG: Skin Helper Widgets --> Kodi_Monitor: sender xbmc - method: Playlist.OnAdd - data: {"item":{"id":2755,"type":"movie"},"playlistid":1,"position":0} 15:18:13.041 T:1930425248 DEBUG: CAESinkPi:Drain delay:99ms now:0ms 15:18:13.041 T:1930425248 DEBUG: CAESinkPi:Deinitialize 15:18:13.042 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 15:18:13.050 T:1930425248 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x72701a48 15:18:13.051 T:1930425248 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 15:18:13.051 T:1930425248 DEBUG: CAESinkPi:Initialize Format:2 Channels:2 Samplerate:16000 framesize:4 bufsize:3200 bytes/s=64000.00 dest=PI:HDMI 15:18:13.051 T:1930425248 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 15:18:13.051 T:1930425248 DEBUG: Output Device : HDMI 15:18:13.051 T:1930425248 DEBUG: Sample Rate : 16000 15:18:13.052 T:1930425248 DEBUG: Sample Format : AE_FMT_S16NE 15:18:13.052 T:1930425248 DEBUG: Channel Count : 2 15:18:13.052 T:1930425248 DEBUG: Channel Layout: RAW,RAW 15:18:13.052 T:1930425248 DEBUG: Frames : 800 15:18:13.053 T:1930425248 DEBUG: Frame Size : 4 15:18:13.072 T:1940439968 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 15:18:13.293 T:1423963040 DEBUG: Previous line repeats 1 times. 15:18:13.293 T:1423963040 DEBUG: Open - avformat_find_stream_info starting 15:18:13.427 T:1962259568 DEBUG: ------ Window Init (DialogBusy.xml) ------ 15:18:14.006 T:1423963040 DEBUG: ffmpeg[54DFF3A0]: [matroska,webm] Could not find codec parameters for stream 3 (Subtitle: hdmv_pgs_subtitle): unspecified size 15:18:14.007 T:1423963040 DEBUG: ffmpeg[54DFF3A0]: [matroska,webm] Consider increasing the value for the 'analyzeduration' and 'probesize' options 15:18:14.007 T:1423963040 DEBUG: ffmpeg[54DFF3A0]: [matroska,webm] Could not find codec parameters for stream 4 (Subtitle: hdmv_pgs_subtitle): unspecified size 15:18:14.007 T:1423963040 DEBUG: ffmpeg[54DFF3A0]: [matroska,webm] Consider increasing the value for the 'analyzeduration' and 'probesize' options 15:18:14.007 T:1423963040 DEBUG: ffmpeg[54DFF3A0]: [matroska,webm] Could not find codec parameters for stream 5 (Subtitle: hdmv_pgs_subtitle): unspecified size 15:18:14.007 T:1423963040 DEBUG: ffmpeg[54DFF3A0]: [matroska,webm] Consider increasing the value for the 'analyzeduration' and 'probesize' options 15:18:14.007 T:1423963040 DEBUG: ffmpeg[54DFF3A0]: [matroska,webm] Could not find codec parameters for stream 6 (Subtitle: hdmv_pgs_subtitle): unspecified size 15:18:14.007 T:1423963040 DEBUG: ffmpeg[54DFF3A0]: [matroska,webm] Consider increasing the value for the 'analyzeduration' and 'probesize' options 15:18:14.007 T:1423963040 DEBUG: ffmpeg[54DFF3A0]: [matroska,webm] Could not find codec parameters for stream 16 (Attachment: none): unknown codec 15:18:14.007 T:1423963040 DEBUG: ffmpeg[54DFF3A0]: [matroska,webm] Consider increasing the value for the 'analyzeduration' and 'probesize' options 15:18:14.008 T:1423963040 DEBUG: Open - av_find_stream_info finished 15:18:14.008 T:1423963040 INFO: ffmpeg[54DFF3A0]: Input #0, matroska,webm, smb://HTPC-SERVER/3D MKV/Assassi's Creed (2016)/Assassin's Creed.mk3d': 15:18:14.008 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.009 T:1423963040 INFO: ffmpeg[54DFF3A0]: DATE_RELEASED : 2016-12-21 15:18:14.009 T:1423963040 INFO: ffmpeg[54DFF3A0]: encoder : libebml v1.3.4 + libmatroska v1.4.5 15:18:14.009 T:1423963040 INFO: ffmpeg[54DFF3A0]: creation_time : 2017-07-12 17:17:34 15:18:14.009 T:1423963040 INFO: ffmpeg[54DFF3A0]: SUMMARY : Callum Lynch soll wegen Mordes hingerichtet werden, doch kurz bevor das Urteil vollstreckt wird, kommt er im Auftrag der Firma Abstergo Industries in die Einrichtung der Wissenschaftlerin Sophia Rikkin nach Madrid, wo Menschen mit hohem Gewaltpotenzial ge 15:18:14.009 T:1423963040 INFO: ffmpeg[54DFF3A0]: TITLE : Assassin's Creed 15:18:14.009 T:1423963040 INFO: ffmpeg[54DFF3A0]: IMDB : tt2094766 15:18:14.009 T:1423963040 INFO: ffmpeg[54DFF3A0]: TMDB : 121856 15:18:14.009 T:1423963040 INFO: ffmpeg[54DFF3A0]: LAW_RATING : 16 15:18:14.009 T:1423963040 INFO: ffmpeg[54DFF3A0]: Duration: 01:55:31.01, start: 0.000000, bitrate: 6120 kb/s 15:18:14.010 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:0: start 0.000000, end 364.155000 15:18:14.010 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.010 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 1 - 0:00:00 15:18:14.010 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:1: start 364.155000, end 572.697000 15:18:14.010 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.010 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 2 - 0:06:04 15:18:14.010 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:2: start 572.697000, end 767.516000 15:18:14.010 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.010 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 3 - 0:09:33 15:18:14.010 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:3: start 767.516000, end 1007.715000 15:18:14.011 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.011 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 4 - 0:12:48 15:18:14.011 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:4: start 1007.715000, end 1267.432000 15:18:14.011 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.011 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 5 - 0:16:48 15:18:14.011 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:5: start 1267.432000, end 1616.448000 15:18:14.011 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.011 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 6 - 0:21:07 15:18:14.011 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:6: start 1616.448000, end 1915.079000 15:18:14.011 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.012 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 7 - 0:26:56 15:18:14.012 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:7: start 1915.079000, end 2286.284000 15:18:14.012 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.012 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 8 - 0:31:55 15:18:14.012 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:8: start 2286.284000, end 2503.167000 15:18:14.012 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.012 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 9 - 0:38:06 15:18:14.012 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:9: start 2503.167000, end 2793.040000 15:18:14.012 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.012 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 10 - 0:41:43 15:18:14.012 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:10: start 2793.040000, end 3010.257000 15:18:14.013 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.013 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 11 - 0:46:33 15:18:14.013 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:11: start 3010.257000, end 3184.389000 15:18:14.013 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.013 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 12 - 0:50:10 15:18:14.013 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:12: start 3184.389000, end 3377.624000 15:18:14.013 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.013 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 13 - 0:53:04 15:18:14.013 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:13: start 3377.624000, end 3566.479000 15:18:14.013 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.013 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 14 - 0:56:18 15:18:14.014 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:14: start 3566.479000, end 3752.582000 15:18:14.014 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.014 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 15 - 0:59:26 15:18:14.014 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:15: start 3752.582000, end 3997.034000 15:18:14.014 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.014 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 16 - 1:02:33 15:18:14.014 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:16: start 3997.034000, end 4388.759000 15:18:14.014 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.014 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 17 - 1:06:37 15:18:14.014 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:17: start 4388.759000, end 4725.887000 15:18:14.014 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.015 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 18 - 1:13:09 15:18:14.015 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:18: start 4725.887000, end 4981.101000 15:18:14.015 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.015 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 19 - 1:18:46 15:18:14.015 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:19: start 4981.101000, end 5417.995000 15:18:14.015 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.015 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 20 - 1:23:01 15:18:14.015 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:20: start 5417.995000, end 5658.194000 15:18:14.015 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.015 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 21 - 1:30:18 15:18:14.016 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:21: start 5658.194000, end 5865.192000 15:18:14.016 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.016 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 22 - 1:34:18 15:18:14.016 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:22: start 5865.192000, end 6051.003000 15:18:14.016 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.016 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 23 - 1:37:45 15:18:14.016 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:23: start 6051.003000, end 6930.715000 15:18:14.016 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.016 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 24 - 1:40:51 15:18:14.016 T:1423963040 INFO: ffmpeg[54DFF3A0]: Chapter #0:24: start 6930.715000, end 6931.008000 15:18:14.016 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.017 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 25 - 1:55:31 15:18:14.017 T:1423963040 INFO: ffmpeg[54DFF3A0]: Stream #0:0: Video: h264 (High), yuv420p(tv, bt709), 1920x1080 [SAR 1:1 DAR 16:9], SAR 1:2 DAR 8:9, 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc (default) 15:18:14.017 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.017 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : 3D Half-T&B (x264 BD compatible CRF 18 preset veryslow, tune film) 15:18:14.018 T:1423963040 INFO: ffmpeg[54DFF3A0]: stereo_mode : top_bottom 15:18:14.018 T:1423963040 INFO: ffmpeg[54DFF3A0]: Side data: 15:18:14.018 T:1423963040 INFO: ffmpeg[54DFF3A0]: stereo3d: top and bottom 15:18:14.018 T:1423963040 INFO: ffmpeg[54DFF3A0]: Stream #0:1(ger): Audio: dts (DTS), 48000 Hz, 5.1(side), fltp, 768 kb/s (default) 15:18:14.018 T:1423963040 INFO: ffmpeg[54DFF3A0]: Stream #0:2(eng): Audio: ac3, 48000 Hz, 5.1(side), fltp, 640 kb/s 15:18:14.019 T:1423963040 INFO: ffmpeg[54DFF3A0]: Stream #0:3(ger): Subtitle: hdmv_pgs_subtitle (default) (forced) 15:18:14.019 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.019 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : forced 15:18:14.019 T:1423963040 INFO: ffmpeg[54DFF3A0]: Stream #0:4(ger): Subtitle: hdmv_pgs_subtitle 15:18:14.019 T:1423963040 INFO: ffmpeg[54DFF3A0]: Stream #0:5(eng): Subtitle: hdmv_pgs_subtitle (forced) 15:18:14.019 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.019 T:1423963040 INFO: ffmpeg[54DFF3A0]: title : forced 15:18:14.020 T:1423963040 INFO: ffmpeg[54DFF3A0]: Stream #0:6(eng): Subtitle: hdmv_pgs_subtitle 15:18:14.020 T:1423963040 INFO: ffmpeg[54DFF3A0]: Stream #0:7: Video: mjpeg, yuvj420p(pc, bt470bg/unknown/unknown), 600x900 [SAR 300:300 DAR 2:3], 90k tbr, 90k tbn, 90k tbc 15:18:14.020 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.020 T:1423963040 INFO: ffmpeg[54DFF3A0]: filename : cover.jpg 15:18:14.020 T:1423963040 INFO: ffmpeg[54DFF3A0]: mimetype : image/jpeg 15:18:14.021 T:1423963040 INFO: ffmpeg[54DFF3A0]: Stream #0:8: Video: mjpeg, yuvj420p(pc, bt470bg/unknown/unknown), 120x180 [SAR 300:300 DAR 2:3], 90k tbr, 90k tbn, 90k tbc 15:18:14.021 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.021 T:1423963040 INFO: ffmpeg[54DFF3A0]: filename : small_cover.jpg 15:18:14.021 T:1423963040 INFO: ffmpeg[54DFF3A0]: mimetype : image/jpeg 15:18:14.021 T:1423963040 INFO: ffmpeg[54DFF3A0]: Stream #0:9: Video: mjpeg, yuvj420p(pc, bt470bg/unknown/unknown), 2000x3000 [SAR 300:300 DAR 2:3], 90k tbr, 90k tbn, 90k tbc 15:18:14.021 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.021 T:1423963040 INFO: ffmpeg[54DFF3A0]: filename : cover_org.jpg 15:18:14.021 T:1423963040 INFO: ffmpeg[54DFF3A0]: mimetype : image/jpeg 15:18:14.022 T:1423963040 INFO: ffmpeg[54DFF3A0]: Stream #0:10: Video: mjpeg, yuvj444p(pc, bt470bg/unknown/unknown), 1000x185, 90k tbr, 90k tbn, 90k tbc 15:18:14.022 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.022 T:1423963040 INFO: ffmpeg[54DFF3A0]: filename : banner.jpg 15:18:14.022 T:1423963040 INFO: ffmpeg[54DFF3A0]: mimetype : image/jpeg 15:18:14.022 T:1423963040 INFO: ffmpeg[54DFF3A0]: Stream #0:11: Video: mjpeg, yuvj420p(pc, bt470bg/unknown/unknown), 1920x1080 [SAR 72:72 DAR 16:9], 90k tbr, 90k tbn, 90k tbc 15:18:14.022 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.023 T:1423963040 INFO: ffmpeg[54DFF3A0]: filename : fanart.jpg 15:18:14.023 T:1423963040 INFO: ffmpeg[54DFF3A0]: mimetype : image/jpeg 15:18:14.023 T:1423963040 INFO: ffmpeg[54DFF3A0]: Stream #0:12: Video: png, rgba(pc), 1000x562 [SAR 3780:3780 DAR 500:281], 90k tbr, 90k tbn, 90k tbc 15:18:14.023 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.023 T:1423963040 INFO: ffmpeg[54DFF3A0]: filename : clearart.png 15:18:14.023 T:1423963040 INFO: ffmpeg[54DFF3A0]: mimetype : image/png 15:18:14.023 T:1423963040 INFO: ffmpeg[54DFF3A0]: Stream #0:13: Video: png, rgba(pc), 800x310 [SAR 2835:2835 DAR 80:31], 90k tbr, 90k tbn, 90k tbc 15:18:14.024 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.024 T:1423963040 INFO: ffmpeg[54DFF3A0]: filename : clearlogo.png 15:18:14.024 T:1423963040 INFO: ffmpeg[54DFF3A0]: mimetype : image/png 15:18:14.024 T:1423963040 INFO: ffmpeg[54DFF3A0]: Stream #0:14: Video: png, pal8(pc), 1000x1000, 90k tbr, 90k tbn, 90k tbc 15:18:14.024 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.024 T:1423963040 INFO: ffmpeg[54DFF3A0]: filename : disc.png 15:18:14.024 T:1423963040 INFO: ffmpeg[54DFF3A0]: mimetype : image/png 15:18:14.025 T:1423963040 INFO: ffmpeg[54DFF3A0]: Stream #0:15: Video: mjpeg, yuvj444p(pc, bt470bg/unknown/unknown), 1000x562, 90k tbr, 90k tbn, 90k tbc 15:18:14.025 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.025 T:1423963040 INFO: ffmpeg[54DFF3A0]: filename : thumb.jpg 15:18:14.025 T:1423963040 INFO: ffmpeg[54DFF3A0]: mimetype : image/jpeg 15:18:14.025 T:1423963040 INFO: ffmpeg[54DFF3A0]: Stream #0:16: Attachment: none 15:18:14.025 T:1423963040 INFO: ffmpeg[54DFF3A0]: Metadata: 15:18:14.025 T:1423963040 INFO: ffmpeg[54DFF3A0]: filename : Assassin's Creed.nfo 15:18:14.025 T:1423963040 INFO: ffmpeg[54DFF3A0]: mimetype : application/xml 15:18:14.026 T:1423963040 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0 15:18:14.026 T:1423963040 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1 15:18:14.026 T:1423963040 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 2 15:18:14.026 T:1423963040 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 3 15:18:14.026 T:1423963040 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 4 15:18:14.026 T:1423963040 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 5 15:18:14.026 T:1423963040 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 6 15:18:14.026 T:1423963040 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 7 15:18:14.026 T:1423963040 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 8 15:18:14.026 T:1423963040 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 9 15:18:14.026 T:1423963040 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 10 15:18:14.026 T:1423963040 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 11 15:18:14.026 T:1423963040 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 12 15:18:14.026 T:1423963040 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 13 15:18:14.026 T:1423963040 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 14 15:18:14.027 T:1423963040 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 15 15:18:14.027 T:1423963040 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 16 15:18:14.031 T:1423963040 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.clock input port 80 output port 81 m_handle 0x5f6581a0 15:18:14.032 T:1423963040 DEBUG: OMXClock::OMXStop 15:18:14.032 T:1423963040 DEBUG: OMXClock::OMXSetSpeed(0.000) pause_resume:1 15:18:14.032 T:1423963040 NOTICE: Opening stream: 0 source: 256 15:18:14.032 T:1423963040 DEBUG: DllBcm: Using omx system library 15:18:14.034 T:1423963040 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.video_decode input port 130 output port 131 m_handle 0x5f663e20 15:18:14.036 T:1423963040 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.video_decode) - port(130), nBufferCountMin(1), nBufferCountActual(120), nBufferSize(81920), nBufferAlignmen(16) 15:18:14.056 T:1423963040 DEBUG: COMXVideo::Open - decoder_component(0x0x5f663e20), input_port(0x82), output_port(0x83) hdmiclocksync 0 15:18:14.056 T:1423963040 INFO: OMXPlayerVideo::OpenDecoder : Video codec omx-h264 width 1920 height 1080 profile 100 fps 23.976025 15:18:14.056 T:1423963040 NOTICE: Creating video thread 15:18:14.056 T:1457517472 DEBUG: Thread OMXPlayerVideo start, auto delete: false 15:18:14.057 T:1423963040 NOTICE: Opening stream: 1 source: 256 15:18:14.058 T:1423963040 NOTICE: Creating audio thread 15:18:14.058 T:1407185824 DEBUG: Thread OMXPlayerAudio start, auto delete: false 15:18:14.058 T:1423963040 NOTICE: Opening stream: 4 source: 256 15:18:14.058 T:1423963040 DEBUG: FactoryCodec - Overlay: FFmpeg Subtitle Decoder - Opening 15:18:14.059 T:1423963040 DEBUG: FactoryCodec - Overlay: FFmpeg Subtitle Decoder - Opened 15:18:14.059 T:1423963040 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: smb://HTPC-SERVER/3D MKV/Assassin's Creed (2016)/Assassin's Creed.mk3d 15:18:14.061 T:1423963040 DEBUG: OnPlayBackStarted: play state was 1, starting 1 15:18:14.061 T:1423963040 DEBUG: CVideoPlayer::SetCaching - caching state 2 15:18:14.062 T:1457517472 DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_SETSPEED 0 15:18:14.062 T:1423963040 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 15:18:14.063 T:1457517472 DEBUG: OMXVideo::Decode VDec : setStartTime 0.000000 15:18:14.068 T:1407185824 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_SETSPEED 0 15:18:14.069 T:1407185824 DEBUG: COMXAudioCodecOMX::Decode(0x5f646d98,1024) format=8(8) chan=6 samples=512 size=2048 data=0x5efb2910,0x5efbbc70,0x5ef9b6c0,0x5e60c100,0x5e60c930,0x5effab50,(nil),(nil) 15:18:14.070 T:1407185824 DEBUG: COMXAudioCodecOMX::GetData size=12288/12288 line=2048/2048 buf=0x5efa6b28, desired=49152 15:18:14.072 T:1407185824 DEBUG: COMXAudio::SetCodingType OMX_AUDIO_CodingPCM 15:18:14.073 T:1457517472 INFO: Output - renderer not configured 15:18:14.073 T:1407185824 DEBUG: COMXAudio:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 0b02c4c8 15:18:14.073 T:1407185824 INFO: COMXAudio::Initialize remap:(nil) chan:6->6 norm:0 upmix:0 60f:3f 15:18:14.074 T:1407185824 INFO: COMXAudio::Initialize 1.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 15:18:14.075 T:1457517472 INFO: Output - renderer not configured 15:18:14.075 T:1407185824 INFO: COMXAudio::Initialize 0.00 1.00 0.00 0.00 0.00 0.00 0.00 0.00 15:18:14.075 T:1407185824 INFO: COMXAudio::Initialize 0.00 0.00 1.00 0.00 0.00 0.00 0.00 0.00 15:18:14.075 T:1407185824 INFO: COMXAudio::Initialize 0.00 0.00 0.00 1.00 0.00 0.00 0.00 0.00 15:18:14.075 T:1407185824 INFO: COMXAudio::Initialize 0.00 0.00 0.00 0.00 1.00 0.00 0.00 0.00 15:18:14.075 T:1457517472 INFO: Output - renderer not configured 15:18:14.075 T:1407185824 INFO: COMXAudio::Initialize 0.00 0.00 0.00 0.00 0.00 1.00 0.00 0.00 15:18:14.076 T:1407185824 INFO: COMXAudio::Initialize 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 15:18:14.076 T:1962259568 INFO: Previous line repeats 1 times. 15:18:14.076 T:1962259568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x3a72648 15:18:14.076 T:1457517472 INFO: Output - renderer not configured 15:18:14.078 T:1962259568 INFO: Previous line repeats 3 times. 15:18:14.078 T:1962259568 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 15:18:14.078 T:1457517472 INFO: Output - renderer not configured 15:18:14.079 T:1407185824 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_decode input port 120 output port 121 m_handle 0x5ef990a0 15:18:14.079 T:1457517472 INFO: Output - renderer not configured 15:18:14.099 T:1457517472 INFO: Previous line repeats 43 times. 15:18:14.100 T:1457517472 DEBUG: COMXVideo::PortSettingsChanged - 1920x1080@23.98 interlace:0 deinterlace:0 15:18:14.107 T:1407185824 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_decode) - port(120), nBufferCountMin(4), nBufferCountActual(16), nBufferSize(49152), nBufferAlignmen(16) 15:18:14.111 T:1457517472 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.video_render input port 90 output port 90 m_handle 0x4225728 15:18:14.113 T:1962259568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x4211bd0 15:18:14.116 T:1962259568 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:18:14.117 T:1457517472 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.video_scheduler input port 10 output port 11 m_handle 0x4987538 15:18:14.126 T:1407185824 DEBUG: COMXAudio::Initialize Input bps 32 samplerate 48000 channels 6 buffer size 2304000 bytes per second 1152000 15:18:14.126 T:1407185824 DEBUG: pcm->direction : input 15:18:14.127 T:1407185824 DEBUG: pcm->nPortIndex : 0 15:18:14.127 T:1407185824 DEBUG: pcm->eNumData : 0 15:18:14.127 T:1407185824 DEBUG: pcm->eEndian : 1 15:18:14.127 T:1407185824 DEBUG: pcm->bInterleaved : 1 15:18:14.127 T:1407185824 DEBUG: pcm->nBitPerSample : 32 15:18:14.127 T:1407185824 DEBUG: pcm->ePCMMode : 0 15:18:14.127 T:1407185824 DEBUG: pcm->nChannels : 6 15:18:14.127 T:1407185824 DEBUG: pcm->nSamplingRate : 48000 15:18:14.127 T:1407185824 DEBUG: COMXAudio::Initialize device passthrough 0 15:18:14.127 T:1457517472 DEBUG: ResolutionUpdateCallBack - change configuration. video:1920x1080. framerate: 23.98. 1920x1080 format: BYPASS 15:18:14.128 T:1407185824 INFO: Audio codec channels 6 samplerate 48000 bitspersample 32 15:18:14.128 T:1457517472 DEBUG: CRenderManager::Configure - change configuration. 1920x1080. display: 1920x1080. framerate: 23.98. format: BYPASS 15:18:14.128 T:1407185824 DEBUG: COMXAudio::Decode ADec : setStartTime 0.000000 15:18:14.132 T:1407185824 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_mixer input port 232 output port 231 m_handle 0x5efa62b8 15:18:14.144 T:1407185824 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x5ef7d1d8 15:18:14.145 T:1407185824 INFO: COMXAudio::ApplyVolume - Volume=0.00 (* 1.00 * 1.00) 15:18:14.145 T:1962259568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x3a72648 15:18:14.146 T:1407185824 DEBUG: COMXAudio::PortSettingsChanged - Output bps 16 samplerate 48000 channels 8 buffer size 2304000 bytes per second 768000 15:18:14.146 T:1407185824 DEBUG: pcm->direction : output 15:18:14.146 T:1407185824 DEBUG: pcm->nPortIndex : 231 15:18:14.146 T:1407185824 DEBUG: pcm->eNumData : 0 15:18:14.146 T:1407185824 DEBUG: pcm->eEndian : 1 15:18:14.146 T:1407185824 DEBUG: pcm->bInterleaved : 1 15:18:14.146 T:1407185824 DEBUG: pcm->nBitPerSample : 16 15:18:14.146 T:1407185824 DEBUG: pcm->ePCMMode : 0 15:18:14.146 T:1407185824 DEBUG: pcm->nChannels : 8 15:18:14.146 T:1407185824 DEBUG: pcm->nSamplingRate : 48000 15:18:14.147 T:1962259568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x4211bd0 15:18:14.147 T:1962259568 DEBUG: DecodeJpegToTexture: decoded special://skin/backgrounds/media-overlay.jpg 1280x720 15:18:14.155 T:1407185824 DEBUG: COMXAudio::PortSettingsChanged - bits:32 mode:0 channels:6 srate:48000 nopassthrough 15:18:14.156 T:1962259568 DEBUG: DeleteRenderer - deleting renderer 15:18:14.156 T:1962259568 DEBUG: CMMALRenderer::~CMMALRenderer 15:18:14.156 T:1962259568 DEBUG: CMMALRenderer::UnInitMMAL 15:18:14.157 T:1499460512 DEBUG: CMMALRenderer::Run - stopping 15:18:14.157 T:1499460512 DEBUG: Thread MMALProcess 1499460512 terminating 15:18:14.157 T:1962259568 DEBUG: CMMALRenderer::CMMALRenderer 15:18:14.157 T:1962259568 DEBUG: CMMALRenderer::UnInitMMAL 15:18:14.157 T:1962259568 DEBUG: CMMALRenderer::PreInit 15:18:14.157 T:1499460512 DEBUG: Thread MMALProcess start, auto delete: false 15:18:14.158 T:1962259568 DEBUG: CMMALRenderer::Configure - 1920x1080->1920x1080@23.98 flags:2010 format:14 ext:0 orient:0 15:18:14.158 T:1499460512 DEBUG: CMMALRenderer::Run - starting 15:18:14.158 T:1962259568 DEBUG: CRenderManager::Configure - 3 15:18:14.158 T:1457517472 DEBUG: OMXPlayerVideo::SetVideoRect 0,0,1920,1080 -> 0,0,0,0 (0,0,0,0,top_bottom) 15:18:14.158 T:1457517472 DEBUG: COMXVideo::SetVideoRect 0,0,1920,1080 -> 0,0,0,0 t:100000 15:18:14.163 T:1423963040 DEBUG: CVideoPlayer::HandleMessages - player started 2 15:18:14.187 T:1962259568 DEBUG: CMMALRenderer::RenderUpdate - vsync -1 (+7149) 15:18:14.202 T:1962259568 INFO: COMXAudio::ApplyVolume - Volume=1.00 (* 1.00 * 1.00) 15:18:14.203 T:1962259568 INFO: Previous line repeats 1 times. 15:18:14.203 T:1962259568 DEBUG: Activating window ID: 12005 15:18:14.204 T:1962259568 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 15:18:14.205 T:1423963040 DEBUG: CVideoPlayer::HandleMessages - player started 1 15:18:14.205 T:1423963040 DEBUG: CVideoPlayer::SetCaching - caching state 3 15:18:14.205 T:1423963040 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 15:18:14.205 T:1407185824 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_SETSPEED 1000 15:18:14.205 T:1457517472 DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_SETSPEED 1000 15:18:14.205 T:1423963040 DEBUG: VideoPlayer::Sync - Audio - pts: 42000.000000, cache: 0.000000, totalcache: 4024000.167847 15:18:14.205 T:1423963040 DEBUG: VideoPlayer::Sync - Video - pts: 2252000.000000, cache: 50000.000000, totalcache: 100000.000000 15:18:14.206 T:1423963040 DEBUG: CVideoPlayer::HandlePlaySpeed player started RESET 15:18:14.206 T:1423963040 NOTICE: OMXClock using audio as reference 15:18:14.206 T:1423963040 DEBUG: OMXClock::OMXReset audio / video : 1 / 1 wait mask 0->3 state : 2->1 15:18:14.207 T:1423963040 DEBUG: CVideoPlayer::SetCaching - caching state 0 15:18:14.207 T:1423963040 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 15:18:14.207 T:1457517472 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(42000.000000) 15:18:14.208 T:1457517472 DEBUG: OMXPlayerVideo::SetVideoRect 0,0,1920,1080 -> 0,0,1920,1080 (0,0,0,0,top_bottom) 15:18:14.209 T:1457517472 DEBUG: COMXVideo::SetVideoRect 0,0,1920,1080 -> 0,0,1920,1080 t:100000 15:18:14.215 T:1407185824 DEBUG: COMXPlayerAudio - CDVDMsg::GENERAL_RESYNC(42000.000000) 15:18:14.218 T:1407185824 INFO: COMXPlayerAudio - Switching to normal playback 15:18:14.228 T:1423963040 DEBUG: CVideoPlayer::OMXDoProcessing Resume 0.35,2.41 (A:01 V:01) EOF:0 FULL:0 T:0.20 15:18:14.229 T:1423963040 DEBUG: OMXClock::OMXSetSpeed(1.000) pause_resume:1 15:18:14.232 T:1962259568 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 15:18:14.232 T:1962259568 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY 15:18:14.307 T:1962259568 DEBUG: PlayFile: OpenFile succeed, play state 2 15:18:14.307 T:1962259568 DEBUG: OnPlayBackStarted: play state was 2, starting 0 15:18:14.308 T:1962259568 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 15:18:14.311 T:1457517472 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer 15:18:14.313 T:1962259568 DEBUG: CMMALRenderer::RenderUpdate - vsync 7149 (+6) 15:18:14.315 T:1440740256 DEBUG: CGUIInfoManager::SetCurrentMovie(smb://HTPC-SERVER/3D MKV/Assassin's Creed (2016)/Assassin's Creed.mk3d) 15:18:14.315 T:1962255264 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 15:18:14.316 T:1962255264 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 15:18:14.316 T:1962259568 DEBUG: StereoscopicsManager: autodetected stereo mode for movie mode top_bottom is: split_horizontal 15:18:14.316 T:1962259568 DEBUG: Previous line repeats 1 times. 15:18:14.317 T:1962259568 DEBUG: StereoscopicsManager: stereo mode setting changed to split_horizontal 15:18:14.317 T:1962259568 DEBUG: StereoscopicsManager::ApplyStereoMode: trying to apply stereo mode. Current: off | Target: split_horizontal 15:18:14.317 T:1962259568 DEBUG: StereoscopicsManager: stereo mode changed to split_horizontal 15:18:14.318 T:1962259568 DEBUG: ------ Window Init (DialogNotification.xml) ------ 15:18:14.319 T:1758458784 DEBUG: Skin Helper Widgets --> Kodi_Monitor: sender xbmc - method: Player.OnPlay - data: {"item":{"id":2755,"type":"movie"},"player":{"playerid":1,"speed":1}} 15:18:14.322 T:1457517472 DEBUG: OMXPlayerVideo::SetVideoRect 0,0,1920,1080 -> 0,0,1920,1080 (1,1,0,0,top_bottom) 15:18:14.323 T:1457517472 DEBUG: COMXVideo::SetVideoRect 0,0,1920,1080 -> 0,0,1920,2160 t:300000 15:18:14.331 T:1930425248 DEBUG: CAESinkPi:Drain delay:0ms now:0ms 15:18:14.331 T:1930425248 DEBUG: CAESinkPi:Deinitialize 15:18:14.332 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 15:18:14.332 T:1962259568 NOTICE: VideoPlayer: OnLostDisplay received 15:18:14.338 T:1440740256 DEBUG: GetMovieId (smb://HTPC-SERVER/3D MKV/Assassin's Creed (2016)/Assassin's Creed.mk3d), query = select idMovie from movie where idFile=2478 15:18:14.372 T:1962259568 DEBUG: EGL set HDMI mode (1,16)=0 split_horizontal TB 15:18:14.374 T:1800401824 DEBUG: Skin Helper Service --> Kodi_Monitor: sender xbmc - method: Player.OnPlay - data: {"item":{"id":2755,"type":"movie"},"player":{"playerid":1,"speed":1}} 15:18:14.522 T:1903162272 DEBUG: EGL tv_service_callback (8,1,16) 15:18:14.522 T:1962259568 DEBUG: EGL set resolution 1920x1080 -> 1920x1080 @ 60.00 fps (1,16) flags:10010004 aspect:1.00 15:18:14.550 T:1962259568 DEBUG: CreateWindow: Created surface of size 1920x1080 15:18:14.550 T:1962259568 NOTICE: VideoPlayer: OnResetDisplay received 15:18:14.550 T:1962259568 INFO: GLES: Maximum texture width: 2048 15:18:14.552 T:1940439968 DEBUG: CActiveAE - display reset event 15:18:14.554 T:1930425248 INFO: CActiveAESink::OpenSink - initialize sink 15:18:14.554 T:1930425248 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 15:18:14.554 T:1930425248 DEBUG: CAESinkPi:Initialize Format:2 Channels:2 Samplerate:16000 framesize:4 bufsize:3200 bytes/s=64000.00 dest=PI:HDMI 15:18:14.554 T:1930425248 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 15:18:14.554 T:1930425248 DEBUG: Output Device : HDMI 15:18:14.555 T:1930425248 DEBUG: Sample Rate : 16000 15:18:14.555 T:1930425248 DEBUG: Sample Format : AE_FMT_S16NE 15:18:14.555 T:1930425248 DEBUG: Channel Count : 2 15:18:14.555 T:1930425248 DEBUG: Channel Layout: RAW,RAW 15:18:14.555 T:1930425248 DEBUG: Frames : 800 15:18:14.555 T:1930425248 DEBUG: Frame Size : 4 15:18:14.566 T:1940439968 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 15:18:14.678 T:1457517472 DEBUG: Previous line repeats 2 times. 15:18:14.678 T:1457517472 DEBUG: OMXPlayerVideo::SetVideoRect 0,0,1920,1080 -> 0,0,1920,540 (1,1,0,1,top_bottom) 15:18:14.678 T:1457517472 DEBUG: COMXVideo::SetVideoRect 0,0,1920,1080 -> 0,0,1920,1080 t:300000 15:18:14.761 T:1962259568 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 15:18:14.761 T:1962259568 DEBUG: CMMALRenderer::RenderUpdate - vsync 7157 (+16) 15:18:20.089 T:1962259568 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 15:18:20.222 T:1962259568 DEBUG: OnKey: return (0xf00d) pressed, action is OSD 15:18:20.223 T:1962259568 DEBUG: ------ Window Init (VideoOSD.xml) ------ 15:18:20.316 T:1962259568 DEBUG: CMMALRenderer::RenderUpdate - vsync 7504 (+2) 15:18:20.439 T:1962259568 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 15:18:25.172 T:1962259568 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 15:18:25.173 T:1962259568 DEBUG: OnKey: right (0xf083) pressed, action is Right 15:18:25.306 T:1962259568 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 15:18:25.489 T:1962259568 DEBUG: Previous line repeats 1 times. 15:18:25.489 T:1962259568 DEBUG: OnKey: right (0xf083) pressed, action is Right 15:18:25.639 T:1962259568 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 15:18:25.673 T:1962259568 DEBUG: Previous line repeats 1 times. 15:18:25.673 T:1962259568 DEBUG: OnKey: right (0xf083) pressed, action is Right 15:18:25.756 T:1962259568 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 15:18:25.889 T:1962259568 DEBUG: Previous line repeats 1 times. 15:18:25.889 T:1962259568 DEBUG: OnKey: right (0xf083) pressed, action is Right 15:18:25.957 T:1962259568 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 15:18:26.057 T:1962259568 DEBUG: Previous line repeats 1 times. 15:18:26.057 T:1962259568 DEBUG: OnKey: right (0xf083) pressed, action is Right 15:18:26.139 T:1962259568 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 15:18:26.339 T:1962259568 DEBUG: Previous line repeats 1 times. 15:18:27.103 T:1962259568 DEBUG: OnKey: right (0xf083) pressed, action is Right 15:18:27.103 T:1962259568 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 15:18:27.104 T:1962259568 DEBUG: Previous line repeats 1 times. 15:18:27.104 T:1962259568 DEBUG: OnKey: right (0xf083) pressed, action is Right 15:18:27.104 T:1962259568 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 15:18:27.124 T:1962259568 DEBUG: CMMALRenderer::RenderUpdate - vsync 7869 (+46) 15:18:27.189 T:1962259568 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 15:18:27.189 T:1962259568 DEBUG: OnKey: right (0xf083) pressed, action is Right 15:18:27.305 T:1962259568 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 15:18:27.960 T:1962259568 DEBUG: Keyboard: scancode: 0x69, sym: 0x0114, unicode: 0x0000, modifier: 0x0 15:18:27.960 T:1962259568 DEBUG: OnKey: left (0xf082) pressed, action is Left 15:18:28.056 T:1962259568 DEBUG: Keyboard: scancode: 0x69, sym: 0x0114, unicode: 0x0000, modifier: 0x0 15:18:28.289 T:1962259568 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 15:18:28.406 T:1962259568 DEBUG: OnKey: return (0xf00d) pressed, action is Select 15:18:28.406 T:1962259568 DEBUG: Activating window ID: 10124 15:18:28.406 T:1962259568 DEBUG: ------ Window Init (DialogSettings.xml) ------ 15:18:28.407 T:1962259568 DEBUG: CSettingsManager: requested setting (audio.volume) was not found. 15:18:28.407 T:1962259568 DEBUG: CSettingsManager: requested setting (audio.volumeamplification) was not found. 15:18:28.407 T:1962259568 DEBUG: CSettingsManager: requested setting (audio.delay) was not found. 15:18:28.408 T:1962259568 DEBUG: CSettingsManager: requested setting (audio.stream) was not found. 15:18:28.408 T:1962259568 DEBUG: CSettingsManager: requested setting (audio.outputtoallspeakers) was not found. 15:18:28.408 T:1962259568 DEBUG: CSettingsManager: requested setting (audio.digitalanalog) was not found. 15:18:28.408 T:1962259568 DEBUG: CSettingsManager: requested setting (subtitles.enable) was not found. 15:18:28.408 T:1962259568 DEBUG: CSettingsManager: requested setting (subtitles.delay) was not found. 15:18:28.408 T:1962259568 DEBUG: CSettingsManager: requested setting (subtitles.stream) was not found. 15:18:28.408 T:1962259568 DEBUG: CSettingsManager: requested setting (subtitles.browser) was not found. 15:18:28.408 T:1962259568 DEBUG: CSettingsManager: requested setting (audio.makedefault) was not found. 15:18:28.472 T:1962259568 DEBUG: CMMALRenderer::RenderUpdate - vsync 7993 (+3) 15:18:29.539 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:18:29.540 T:1962259568 DEBUG: OnKey: down (0xf081) pressed, action is Down 15:18:29.622 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:18:29.757 T:1962259568 DEBUG: Previous line repeats 1 times. 15:18:29.757 T:1962259568 DEBUG: OnKey: down (0xf081) pressed, action is Down 15:18:29.806 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:18:29.906 T:1962259568 DEBUG: Previous line repeats 1 times. 15:18:29.906 T:1962259568 DEBUG: OnKey: down (0xf081) pressed, action is Down 15:18:29.989 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:18:30.089 T:1962259568 DEBUG: Previous line repeats 1 times. 15:18:30.089 T:1962259568 DEBUG: OnKey: down (0xf081) pressed, action is Down 15:18:30.173 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:18:30.323 T:1962259568 DEBUG: Previous line repeats 1 times. 15:18:30.323 T:1962259568 DEBUG: OnKey: down (0xf081) pressed, action is Down 15:18:30.358 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:18:30.489 T:1962259568 DEBUG: Previous line repeats 1 times. 15:18:30.489 T:1962259568 DEBUG: OnKey: down (0xf081) pressed, action is Down 15:18:30.556 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:18:31.407 T:1962259568 DEBUG: Previous line repeats 1 times. 15:18:31.407 T:1962259568 DEBUG: OnKey: down (0xf081) pressed, action is Down 15:18:31.459 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:18:32.122 T:1962259568 DEBUG: Previous line repeats 1 times. 15:18:32.123 T:1962259568 DEBUG: OnKey: down (0xf081) pressed, action is Down 15:18:32.223 T:1962259568 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 15:18:34.323 T:1962259568 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 15:18:34.439 T:1962259568 DEBUG: OnKey: escape (0xf01b) pressed, action is PreviousMenu 15:18:34.439 T:1962259568 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 15:18:34.690 T:1962259568 DEBUG: ------ Window Deinit (DialogSettings.xml) ------ 15:18:34.693 T:1962259568 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 15:18:35.789 T:1962259568 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 15:18:35.858 T:1962259568 DEBUG: OnKey: escape (0xf01b) pressed, action is PreviousMenu 15:18:35.858 T:1962259568 DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0 15:18:36.114 T:1962259568 DEBUG: ------ Window Deinit (VideoOSD.xml) ------ 15:18:36.122 T:1962259568 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 15:18:39.389 T:1962259568 DEBUG: Keyboard: scancode: 0x68, sym: 0x0118, unicode: 0x0000, modifier: 0x0 15:18:39.389 T:1962259568 DEBUG: OnKey: pageup (0xf084) pressed, action is SkipNext 15:18:39.393 T:1423963040 DEBUG: CVideoPlayer::SetCaching - caching state 2 15:18:39.393 T:1423963040 DEBUG: OMXClock::OMXSetSpeed(0.000) pause_resume:1 15:18:39.394 T:1423963040 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 15:18:39.396 T:1407185824 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_SETSPEED 0 15:18:39.406 T:1962259568 DEBUG: Keyboard: scancode: 0x68, sym: 0x0118, unicode: 0x0000, modifier: 0x0 15:18:39.475 T:1962259568 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 15:18:39.581 T:1423963040 DEBUG: SeekTime - seek ended up on time 364155 15:18:39.581 T:1423963040 DEBUG: CVideoPlayer::FlushBuffers - flushing buffers 15:18:39.585 T:1407185824 DEBUG: COMXPlayerAudio - CDVDMsg::GENERAL_FLUSH(1) 15:18:39.596 T:1457517472 DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_SETSPEED 0 15:18:39.596 T:1457517472 DEBUG: COMXPlayerVideo - CDVDMsg::GENERAL_FLUSH(1) 15:18:39.602 T:1457517472 DEBUG: COMXPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 15:18:39.602 T:1407185824 DEBUG: COMXPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 15:18:39.603 T:1423963040 DEBUG: OMXClock::OMXFlush 15:18:39.603 T:1423963040 DEBUG: OMXClock::OMXStop 15:18:39.604 T:1423963040 DEBUG: OMXClock::OMXMediaTime set config OMX_IndexConfigTimeCurrentAudioReference = 0.00 15:18:39.668 T:1457517472 DEBUG: OMXVideo::Decode VDec : setStartTime 364.155000 15:18:39.674 T:1423963040 DEBUG: CVideoPlayer::HandleMessages - player started 2 15:18:39.677 T:1407185824 DEBUG: COMXAudio::Decode ADec : setStartTime 364.160004 15:18:39.680 T:1423963040 DEBUG: CVideoPlayer::HandleMessages - player started 1 15:18:39.680 T:1423963040 DEBUG: CVideoPlayer::SetCaching - caching state 3 15:18:39.680 T:1407185824 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_SETSPEED 1000 15:18:39.681 T:1423963040 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 15:18:39.681 T:1457517472 DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_SETSPEED 1000 15:18:39.681 T:1423963040 DEBUG: VideoPlayer::Sync - Audio - pts: 364202000.000000, cache: 0.000000, totalcache: 4024000.167847 15:18:39.681 T:1423963040 DEBUG: VideoPlayer::Sync - Video - pts: 364155000.000000, cache: 50000.000000, totalcache: 100000.000000 15:18:39.681 T:1423963040 DEBUG: CVideoPlayer::HandlePlaySpeed player started RESET 15:18:39.681 T:1423963040 DEBUG: OMXClock::OMXReset audio / video : 1 / 1 wait mask 0->3 state : 2->1 15:18:39.682 T:1457517472 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(364055000.000000) 15:18:39.682 T:1423963040 DEBUG: CVideoPlayer::SetCaching - caching state 0 15:18:39.682 T:1423963040 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 15:18:39.690 T:1423963040 DEBUG: CVideoPlayer::OMXDoProcessing Resume 364.20,364.24 (A:01 V:01) EOF:0 FULL:0 T:0.20 15:18:39.690 T:1423963040 DEBUG: OMXClock::OMXSetSpeed(1.000) pause_resume:1 15:18:39.691 T:1407185824 DEBUG: COMXPlayerAudio - CDVDMsg::GENERAL_RESYNC(364055000.000000) 15:18:39.747 T:1407185824 INFO: COMXPlayerAudio - Switching to normal playback 15:18:42.431 T:1962259568 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 15:18:44.315 T:1733292960 DEBUG: Thread JobWorker 1733292960 terminating (autodelete) 15:18:44.316 T:1874850720 DEBUG: Thread JobWorker 1874850720 terminating (autodelete) 15:18:44.319 T:1741681568 DEBUG: Thread JobWorker 1741681568 terminating (autodelete) 15:18:44.641 T:1440740256 DEBUG: Thread JobWorker 1440740256 terminating (autodelete) 15:19:36.272 T:1423963040 DEBUG: Overlay: x:492 y:433 w:938 h:571 15:19:41.258 T:1423963040 DEBUG: Overlay: x:635 y:433 w:650 h:571 15:19:48.210 T:1962259568 DEBUG: CMMALRenderer::RenderUpdate - vsync 12776 (+4) 15:19:53.285 T:1962259568 DEBUG: CMMALRenderer::RenderUpdate - vsync 13082 (+2) 15:20:00.324 T:1423963040 DEBUG: Overlay: x:723 y:433 w:475 h:565 15:20:01.489 T:1962259568 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 15:20:01.540 T:1962259568 DEBUG: OnKey: return (0xf00d) pressed, action is OSD 15:20:01.541 T:1962259568 DEBUG: ------ Window Init (VideoOSD.xml) ------ 15:20:01.588 T:1962259568 DEBUG: CMMALRenderer::RenderUpdate - vsync 13581 (+1) 15:20:02.439 T:1962259568 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 15:20:02.439 T:1962259568 DEBUG: OnKey: right (0xf083) pressed, action is Right 15:20:02.489 T:1962259568 DEBUG: Keyboard: scancode: 0x6a, sym: 0x0113, unicode: 0x0000, modifier: 0x0 15:20:03.756 T:1962259568 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 15:20:03.839 T:1962259568 DEBUG: OnKey: return (0xf00d) pressed, action is Select 15:20:03.840 T:1962259568 NOTICE: CVideoPlayer::CloseFile() 15:20:03.840 T:1962259568 NOTICE: VideoPlayer: waiting for threads to exit 15:20:03.850 T:1423963040 NOTICE: CVideoPlayer::OnExit() 15:20:03.850 T:1423963040 NOTICE: Closing stream player 1 15:20:03.853 T:1407185824 NOTICE: thread end: OMXPlayerAudio::OnExit() 15:20:03.853 T:1407185824 DEBUG: Thread OMXPlayerAudio 1407185824 terminating 15:20:03.917 T:1423963040 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_decode handle 0x5ef990a0 15:20:03.935 T:1423963040 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_mixer handle 0x5efa62b8 15:20:03.937 T:1423963040 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x5ef7d1d8 15:20:03.938 T:1423963040 NOTICE: Closing stream player 2 15:20:03.938 T:1457517472 NOTICE: thread end: video_thread 15:20:03.939 T:1457517472 DEBUG: Thread OMXPlayerVideo 1457517472 terminating 15:20:03.962 T:1423963040 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.video_scheduler handle 0x4987538 15:20:03.981 T:1423963040 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.video_decode handle 0x5f663e20 15:20:03.983 T:1423963040 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.video_render handle 0x4225728 15:20:03.983 T:1423963040 NOTICE: Closing stream player 3 15:20:04.000 T:1423963040 DEBUG: CSMBFile::Close closing fd 10000 15:20:04.002 T:1423963040 DEBUG: OMXClock::OMXStop 15:20:04.003 T:1423963040 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.clock handle 0x5f6581a0 15:20:04.004 T:1423963040 DEBUG: OnPlayBackStopped: play state was 2, starting 0 15:20:04.004 T:1423963040 DEBUG: Thread VideoPlayer 1423963040 terminating 15:20:04.005 T:1962259568 NOTICE: VideoPlayer: finished waiting 15:20:04.005 T:1962255264 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 15:20:04.005 T:1962259568 DEBUG: DeleteRenderer - deleting renderer 15:20:04.005 T:1962259568 DEBUG: CMMALRenderer::~CMMALRenderer 15:20:04.005 T:1962255264 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 15:20:04.005 T:1962259568 DEBUG: CMMALRenderer::UnInitMMAL 15:20:04.005 T:1499460512 DEBUG: CMMALRenderer::Run - stopping 15:20:04.006 T:1499460512 DEBUG: Thread MMALProcess 1499460512 terminating 15:20:04.006 T:1962259568 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 15:20:04.006 T:1962259568 DEBUG: ------ Window Deinit (VideoOSD.xml) ------ 15:20:04.007 T:1962259568 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 15:20:04.013 T:1800401824 DEBUG: Skin Helper Service --> Kodi_Monitor: sender xbmc - method: Player.OnStop - data: {"end":false,"item":{"id":2755,"type":"movie"}} 15:20:04.043 T:1962259568 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 15:20:04.052 T:1962259568 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 15:20:04.060 T:1962259568 DEBUG: CGUIMediaWindow::GetDirectory (videodb://movies/titles/) 15:20:04.060 T:1962259568 DEBUG: ParentPath = [videodb://movies/titles/] 15:20:04.090 T:1758458784 DEBUG: Skin Helper Widgets --> Kodi_Monitor: sender xbmc - method: Player.OnStop - data: {"end":false,"item":{"id":2755,"type":"movie"}} 15:20:04.091 T:1758458784 DEBUG: Skin Helper Widgets --> Video database changed - type: movie - refreshing widgets.... 15:20:04.311 T:1962259568 DEBUG: Loading items: 1263, directory: videodb://movies/titles/ sort method: 0, ascending: true 15:20:04.525 T:1499460512 DEBUG: Thread BackgroundLoader start, auto delete: false 15:20:04.812 T:1962259568 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 15:20:04.832 T:1962259568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x4b09e08 15:20:04.865 T:1962259568 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(125120), nBufferAlignmen(16) 15:20:04.869 T:1962259568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x30c50c8 15:20:04.871 T:1962259568 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x42e41a8 15:20:04.872 T:1962259568 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:20:05.054 T:1962259568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x4b09e08 15:20:05.055 T:1962259568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x30c50c8 15:20:05.057 T:1962259568 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x42e41a8 15:20:05.057 T:1962259568 DEBUG: DecodeJpegToTexture: decoded special://skin/backgrounds/SKINDEFAULT.jpg 1280x720 15:20:05.069 T:1962259568 DEBUG: [Warning] CGUITextureManager::GetTexturePath: could not find texture 'OverlayUnwatched.png' 15:20:05.070 T:1874850720 DEBUG: Thread JobWorker start, auto delete: true 15:20:05.077 T:1783624608 DEBUG: Previous line repeats 1 times. 15:20:05.077 T:1783624608 DEBUG: RunQuery took 22 ms for 44 items query: select * from movie_view WHERE (movie_view.idFile IN (SELECT DISTINCT idFile FROM bookmark WHERE type = 1)) 15:20:05.085 T:1415574432 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x727bc640 15:20:05.088 T:1415574432 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 15:20:05.094 T:1415574432 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x727bc7d8 15:20:05.097 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x5e0af098 15:20:05.097 T:1415574432 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:20:05.101 T:1874850720 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 15:20:05.112 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x5e0af8e0 15:20:05.113 T:1415574432 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x727bc640 15:20:05.114 T:1874850720 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:20:05.115 T:1415574432 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x727bc7d8 15:20:05.115 T:1415574432 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/d/dc90101b.jpg 360x540 15:20:05.126 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x5e0af098 15:20:05.128 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x5e0af8e0 15:20:05.129 T:1874850720 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/e/e36f19d0.jpg 360x540 15:20:05.177 T:1775236000 DEBUG: RunQuery took 24 ms for 44 items query: select * from movie_view WHERE (movie_view.idFile IN (SELECT DISTINCT idFile FROM bookmark WHERE type = 1)) 15:20:05.332 T:1962259568 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 15:20:05.373 T:1962259568 NOTICE: CVideoPlayer::CloseFile() 15:20:05.373 T:1962259568 NOTICE: VideoPlayer: waiting for threads to exit 15:20:05.373 T:1962259568 NOTICE: VideoPlayer: finished waiting 15:20:05.373 T:1962259568 NOTICE: CVideoPlayer::CloseFile() 15:20:05.374 T:1962259568 NOTICE: VideoPlayer: waiting for threads to exit 15:20:05.374 T:1962259568 NOTICE: VideoPlayer: finished waiting 15:20:05.374 T:1940439968 DEBUG: CActiveAE::DiscardStream - audio stream deleted 15:20:05.374 T:1940439968 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 15:20:05.380 T:1962259568 DEBUG: Previous line repeats 2 times. 15:20:05.381 T:1962259568 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 15:20:05.381 T:1930425248 INFO: CActiveAESink::OpenSink - initialize sink 15:20:05.381 T:1930425248 DEBUG: CAESinkPi:Drain delay:0ms now:0ms 15:20:05.381 T:1930425248 DEBUG: CAESinkPi:Deinitialize 15:20:05.382 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 15:20:05.382 T:1930425248 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 15:20:05.383 T:1930425248 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI 15:20:05.384 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 15:20:05.388 T:1930425248 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x727d2c48 15:20:05.391 T:1930425248 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignmen(16) 15:20:05.392 T:1962259568 DEBUG: StereoscopicsManager: stereo mode setting changed to off 15:20:05.392 T:1930425248 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 15:20:05.392 T:1930425248 DEBUG: Output Device : HDMI 15:20:05.392 T:1930425248 DEBUG: Sample Rate : 44100 15:20:05.392 T:1930425248 DEBUG: Sample Format : AE_FMT_FLOAT 15:20:05.392 T:1930425248 DEBUG: Channel Count : 2 15:20:05.393 T:1930425248 DEBUG: Channel Layout: FL,FR 15:20:05.393 T:1930425248 DEBUG: Frames : 2205 15:20:05.393 T:1930425248 DEBUG: Frame Size : 8 15:20:05.396 T:1962259568 DEBUG: StereoscopicsManager::ApplyStereoMode: trying to apply stereo mode. Current: split_horizontal | Target: off 15:20:05.397 T:1962259568 DEBUG: StereoscopicsManager: stereo mode changed to off 15:20:05.398 T:1940439968 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 15:20:05.402 T:1415574432 DEBUG: Previous line repeats 1 times. 15:20:05.402 T:1415574432 DEBUG: DoWork - Saving file state for video item smb://HTPC-SERVER/3D MKV/Assassin's Creed (2016)/Assassin's Creed.mk3d 15:20:05.408 T:1962259568 DEBUG: ------ Window Init (DialogNotification.xml) ------ 15:20:05.422 T:1415574432 DEBUG: Mysql execute: update files set playCount=NULL,lastPlayed='2017-07-18 15:20:05' where idFile=2478 15:20:05.599 T:1930425248 DEBUG: CAESinkPi:Drain delay:99ms now:0ms 15:20:05.599 T:1930425248 DEBUG: CAESinkPi:Deinitialize 15:20:05.600 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 15:20:05.609 T:1930425248 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x727d2c48 15:20:05.639 T:1962259568 DEBUG: EGL set HDMI mode (1,16)=0 off 15:20:05.664 T:1962255264 DEBUG: CAnnouncementManager - Announcement: OnUpdate from xbmc 15:20:05.665 T:1962255264 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnUpdate 15:20:05.665 T:1800401824 DEBUG: Skin Helper Service --> Kodi_Monitor: sender xbmc - method: VideoLibrary.OnUpdate - data: {"item":{"id":2755,"type":"movie"}} 15:20:05.667 T:1415574432 DEBUG: Mysql execute: update bookmark set timeInSeconds = 447.979034, totalTimeInSeconds = 6931.008301, thumbNailImage = '', player = 'VideoPlayer', playerState = '' where idBookmark = 154 15:20:05.732 T:1758458784 DEBUG: Skin Helper Widgets --> Kodi_Monitor: sender xbmc - method: VideoLibrary.OnUpdate - data: {"item":{"id":2755,"type":"movie"}} 15:20:05.734 T:1962255264 DEBUG: CAnnouncementManager - Announcement: OnUpdate from xbmc 15:20:05.734 T:1962255264 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnUpdate 15:20:05.735 T:1758458784 DEBUG: Skin Helper Widgets --> Video database changed - type: movie - refreshing widgets.... 15:20:05.737 T:1415574432 DEBUG: Mysql execute: update settings set Deinterlace=1,ViewMode=0,ZoomAmount=1.000000,PixelRatio=1.000000,VerticalShift=0.000000,AudioStream=-1,SubtitleStream=1,SubtitleDelay=0.000000,SubtitlesOn=1,Brightness=50.000000,Contrast=50.000000,Gamma=20.000000,VolumeAmplification=0.000000,AudioDelay=0.000000,OutputToAllSpeakers=0,Sharpness=0.000000,NoiseReduction=0.000000,NonLinStretch=0,PostProcess=0,ScalingMethod=1,ResumeTime=0,StereoMode=1,StereoInvert=0, VideoStream=-1 where idFile=2478 15:20:05.790 T:1903162272 DEBUG: EGL tv_service_callback (8,1,16) 15:20:05.790 T:1962259568 DEBUG: EGL set resolution 1920x1080 -> 1920x1080 @ 60.00 fps (1,16) flags:10010004 aspect:1.00 15:20:05.815 T:1962259568 DEBUG: CreateWindow: Created surface of size 1920x1080 15:20:05.815 T:1962259568 INFO: GLES: Maximum texture width: 2048 15:20:05.815 T:1940439968 DEBUG: CActiveAE - display reset event 15:20:05.816 T:1930425248 INFO: CActiveAESink::OpenSink - initialize sink 15:20:05.816 T:1930425248 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 15:20:05.816 T:1930425248 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI 15:20:05.817 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 15:20:05.818 T:1930425248 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x5eb20bb8 15:20:05.820 T:1930425248 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignmen(16) 15:20:05.821 T:1930425248 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 15:20:05.821 T:1930425248 DEBUG: Output Device : HDMI 15:20:05.821 T:1930425248 DEBUG: Sample Rate : 44100 15:20:05.821 T:1930425248 DEBUG: Sample Format : AE_FMT_FLOAT 15:20:05.821 T:1930425248 DEBUG: Channel Count : 2 15:20:05.821 T:1930425248 DEBUG: Channel Layout: FL,FR 15:20:05.821 T:1930425248 DEBUG: Frames : 2205 15:20:05.821 T:1930425248 DEBUG: Frame Size : 8 15:20:05.827 T:1940439968 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 15:20:05.888 T:1962259568 DEBUG: Clearing cached fileitems [videodb://movies/titles/] 15:20:06.004 T:1962259568 DEBUG: [Warning] CGUITextureManager::GetTexturePath: could not find texture 'OverlayUnwatched.png' 15:20:06.071 T:1758458784 DEBUG: Skin Helper Widgets --> Kodi_Monitor: sender xbmc - method: VideoLibrary.OnUpdate - data: {"id":2755,"type":"movie"} 15:20:06.072 T:1758458784 DEBUG: Skin Helper Widgets --> Video database changed - type: movie - refreshing widgets.... 15:20:06.168 T:1800401824 DEBUG: Skin Helper Service --> Kodi_Monitor: sender xbmc - method: VideoLibrary.OnUpdate - data: {"id":2755,"type":"movie"} 15:20:06.328 T:1423963040 DEBUG: Thread JobWorker start, auto delete: true 15:20:06.334 T:1874850720 DEBUG: Previous line repeats 1 times. 15:20:06.334 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x5e0ca070 15:20:06.335 T:1874850720 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 15:20:06.338 T:1415574432 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x72721950 15:20:06.340 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x5e0cb9a8 15:20:06.340 T:1415574432 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 15:20:06.341 T:1874850720 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:20:06.352 T:1415574432 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x7276ac90 15:20:06.353 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x5e0ca070 15:20:06.354 T:1415574432 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:20:06.354 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x5e0cb9a8 15:20:06.355 T:1874850720 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/8/896dcc86.jpg 360x540 15:20:06.364 T:1491071904 DEBUG: ffmpeg[58DFF3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 15:20:06.366 T:1415574432 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x72721950 15:20:06.368 T:1415574432 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x7276ac90 15:20:06.369 T:1415574432 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/0/01077e93.jpg 360x540 15:20:06.369 T:1423963040 DEBUG: ffmpeg[54DFF3A0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 15:20:07.043 T:1775236000 DEBUG: RunQuery took 914 ms for 1156 items query: select * from movie_view WHERE ((movie_view.playCount IS NULL OR movie_view.playCount < 1)) 15:20:07.255 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x5dbb5d60 15:20:07.259 T:1874850720 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 15:20:07.262 T:1491071904 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x73dcd630 15:20:07.264 T:1491071904 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 15:20:07.267 T:1874850720 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x5d93d200 15:20:07.269 T:1874850720 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:20:07.285 T:1491071904 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x668e5da8 15:20:07.286 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x5dbb5d60 15:20:07.287 T:1491071904 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 15:20:07.288 T:1874850720 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x5d93d200 15:20:07.289 T:1874850720 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/e/e40dbfd8.jpg 360x540 15:20:07.300 T:1491071904 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x73dcd630 15:20:07.302 T:1491071904 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x668e5da8 15:20:07.302 T:1491071904 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/a/a0c025c5.jpg 360x540 15:20:07.394 T:1783624608 DEBUG: RunQuery took 1197 ms for 1156 items query: select * from movie_view WHERE ((movie_view.playCount IS NULL OR movie_view.playCount = 0)) 15:20:09.229 T:1499460512 DEBUG: Thread BackgroundLoader 1499460512 terminating 15:20:11.107 T:1962259568 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 15:20:37.252 T:1415574432 DEBUG: Thread JobWorker 1415574432 terminating (autodelete) 15:20:37.253 T:1423963040 DEBUG: Thread JobWorker 1423963040 terminating (autodelete) 15:20:37.289 T:1874850720 DEBUG: Thread JobWorker 1874850720 terminating (autodelete) 15:20:37.303 T:1491071904 DEBUG: Thread JobWorker 1491071904 terminating (autodelete) ################################################################################ # ... output of cat /storage/.kodi/temp/kodi.old.log # LibreELEC release: RPi2.arm-8.0.2 # ################################################################################ 16:01:32.125 T:1962157168 NOTICE: special://profile/ is mapped to: special://masterprofile/ 16:01:32.126 T:1962157168 NOTICE: ----------------------------------------------------------------------- 16:01:32.126 T:1962157168 NOTICE: Starting Kodi (17.3 Git:147cec4). Platform: Linux ARM 32-bit 16:01:32.126 T:1962157168 NOTICE: Using Release Kodi x32 build (version for Raspberry Pi) 16:01:32.126 T:1962157168 NOTICE: Kodi compiled May 25 2017 by GCC 6.2.0 for Linux ARM 32-bit version 4.9.29 (264477) 16:01:32.126 T:1962157168 NOTICE: Running on LibreELEC (official) - Version: 8.0.2, kernel: Linux ARM 32-bit version 4.9.29 16:01:32.126 T:1962157168 NOTICE: FFmpeg version/source: ffmpeg-3.1-kodi 16:01:32.126 T:1962157168 NOTICE: Host CPU: ARMv7 Processor rev 5 (v7l), 4 cores available 16:01:32.127 T:1962157168 NOTICE: ARM Features: Neon enabled 16:01:32.127 T:1962157168 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi/ 16:01:32.127 T:1962157168 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi 16:01:32.127 T:1962157168 NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons 16:01:32.127 T:1962157168 NOTICE: special://masterprofile/ is mapped to: /storage/.kodi/userdata 16:01:32.127 T:1962157168 NOTICE: special://envhome/ is mapped to: /storage 16:01:32.127 T:1962157168 NOTICE: special://home/ is mapped to: /storage/.kodi 16:01:32.127 T:1962157168 NOTICE: special://temp/ is mapped to: /storage/.kodi/temp 16:01:32.127 T:1962157168 NOTICE: special://logpath/ is mapped to: /storage/.kodi/temp 16:01:32.127 T:1962157168 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin 16:01:32.127 T:1962157168 NOTICE: Local hostname: Kodi-SebSonic 16:01:32.128 T:1962157168 NOTICE: Log File is located: /storage/.kodi/temp//kodi.log 16:01:32.128 T:1962157168 NOTICE: ----------------------------------------------------------------------- 16:01:32.298 T:1962157168 ERROR: DBus: Error org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files 16:01:32.313 T:1962157168 NOTICE: load settings... 16:01:32.521 T:1962157168 NOTICE: Found 2 Lists of Devices 16:01:32.521 T:1962157168 NOTICE: Enumerated PI devices: 16:01:32.521 T:1962157168 NOTICE: Device 1 16:01:32.522 T:1962157168 NOTICE: m_deviceName : HDMI 16:01:32.522 T:1962157168 NOTICE: m_displayName : HDMI 16:01:32.522 T:1962157168 NOTICE: m_displayNameExtra: 16:01:32.522 T:1962157168 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 16:01:32.522 T:1962157168 NOTICE: m_channels : FL,FR 16:01:32.522 T:1962157168 NOTICE: m_sampleRates : 8000,11025,16000,22050,24000,32000,44100,48000,88200,96000,176400,192000 16:01:32.522 T:1962157168 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP,AE_FMT_RAW 16:01:32.522 T:1962157168 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_EAC3,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_512 16:01:32.522 T:1962157168 NOTICE: Device 2 16:01:32.522 T:1962157168 NOTICE: m_deviceName : Analogue 16:01:32.522 T:1962157168 NOTICE: m_displayName : Analogue 16:01:32.523 T:1962157168 NOTICE: m_displayNameExtra: 16:01:32.523 T:1962157168 NOTICE: m_deviceType : AE_DEVTYPE_PCM 16:01:32.523 T:1962157168 NOTICE: m_channels : FL,FR 16:01:32.523 T:1962157168 NOTICE: m_sampleRates : 48000 16:01:32.523 T:1962157168 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 16:01:32.523 T:1962157168 NOTICE: m_streamTypes : No passthrough capabilities 16:01:32.523 T:1962157168 NOTICE: Device 3 16:01:32.523 T:1962157168 NOTICE: m_deviceName : Both 16:01:32.523 T:1962157168 NOTICE: m_displayName : HDMI and Analogue 16:01:32.523 T:1962157168 NOTICE: m_displayNameExtra: 16:01:32.523 T:1962157168 NOTICE: m_deviceType : AE_DEVTYPE_PCM 16:01:32.523 T:1962157168 NOTICE: m_channels : FL,FR 16:01:32.523 T:1962157168 NOTICE: m_sampleRates : 48000 16:01:32.523 T:1962157168 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 16:01:32.523 T:1962157168 NOTICE: m_streamTypes : No passthrough capabilities 16:01:32.523 T:1962157168 NOTICE: Enumerated PULSE devices: 16:01:32.523 T:1962157168 NOTICE: Device 1 16:01:32.524 T:1962157168 NOTICE: m_deviceName : Default 16:01:32.524 T:1962157168 NOTICE: m_displayName : Default 16:01:32.524 T:1962157168 NOTICE: m_displayNameExtra: Bluetooth Audio (PULSEAUDIO) 16:01:32.524 T:1962157168 NOTICE: m_deviceType : AE_DEVTYPE_PCM 16:01:32.524 T:1962157168 NOTICE: m_channels : FL,FR 16:01:32.524 T:1962157168 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000 16:01:32.524 T:1962157168 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT 16:01:32.524 T:1962157168 NOTICE: m_streamTypes : No passthrough capabilities 16:01:32.560 T:1962157168 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml 16:01:32.560 T:1962157168 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are... false 1 720 540 30 16:01:32.565 T:1962157168 NOTICE: Loaded settings file from special://profile/advancedsettings.xml 16:01:32.566 T:1962157168 NOTICE: Contents of special://profile/advancedsettings.xml are... 1 157286400 5 30 30 mysql 192.168.0.102 3306 kodi ***** mysql 192.168.0.102 3306 kodi ***** true true 16:01:32.566 T:1962157168 WARNING: VIDEO database configuration is experimental. 16:01:32.568 T:1962157168 NOTICE: Default Video Player: VideoPlayer 16:01:32.568 T:1962157168 NOTICE: Default Audio Player: paplayer 16:01:32.568 T:1962157168 NOTICE: Disabled debug logging due to GUI setting. Level 0. 16:01:32.568 T:1962157168 NOTICE: Log level changed to "LOG_LEVEL_NORMAL" 16:01:32.569 T:1962157168 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml 16:01:32.573 T:1962157168 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 16:01:32.575 T:1962157168 NOTICE: Loaded playercorefactory configuration 16:01:32.575 T:1962157168 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 16:01:32.576 T:1962157168 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 16:01:32.584 T:1962157168 NOTICE: WakeOnAccess - Load settings : 16:01:32.584 T:1962157168 NOTICE: WakeOnAccess - Enabled:TRUE 16:01:32.584 T:1962157168 NOTICE: -Network init timeout : [20] sec 16:01:32.584 T:1962157168 NOTICE: -Network settle time : [500] ms 16:01:32.584 T:1962157168 NOTICE: Registering wakeup entry: 16:01:32.584 T:1962157168 NOTICE: HostName : 192.168.0.102 16:01:32.584 T:1962157168 NOTICE: MacAddress : F8:D1:11:02:D7:29 16:01:32.584 T:1962157168 NOTICE: PingPort : 0 16:01:32.584 T:1962157168 NOTICE: PingMode : 0 16:01:32.585 T:1962157168 NOTICE: Timeout : 300 (sec) 16:01:32.585 T:1962157168 NOTICE: WaitForOnline : 40 (sec) 16:01:32.585 T:1962157168 NOTICE: WaitForOnlineEx : 40 (sec) 16:01:32.585 T:1962157168 NOTICE: WaitForServices : 5 (sec) 16:01:32.585 T:1962157168 NOTICE: Registering wakeup entry: 16:01:32.585 T:1962157168 NOTICE: HostName : HTPC-SERVER 16:01:32.585 T:1962157168 NOTICE: MacAddress : F8:D1:11:02:D7:29 16:01:32.585 T:1962157168 NOTICE: PingPort : 0 16:01:32.585 T:1962157168 NOTICE: PingMode : 0 16:01:32.585 T:1962157168 NOTICE: Timeout : 300 (sec) 16:01:32.585 T:1962157168 NOTICE: WaitForOnline : 40 (sec) 16:01:32.585 T:1962157168 NOTICE: WaitForOnlineEx : 40 (sec) 16:01:32.585 T:1962157168 NOTICE: WaitForServices : 5 (sec) 16:01:32.754 T:1962157168 NOTICE: Running database version Addons27 19:24:25.726 T:1962157168 NOTICE: ADDONS: Using repository repository.xbmc.org 19:24:25.726 T:1962157168 NOTICE: ADDONS: Using repository repository.kodi.game 19:24:25.726 T:1962157168 NOTICE: ADDONS: Using repository repository.libreelec.tv 19:24:25.726 T:1962157168 NOTICE: ADDONS: Using repository repository.kodinerds 19:24:25.726 T:1962157168 NOTICE: ADDONS: Using repository repository.kodinerds_RPi2 19:24:25.945 T:1962157168 NOTICE: Raspberry PI firmware version: May 15 2017 17:01:07 Copyright (c) 2012 Broadcom version 9469ea3706e34c4de62f38a5008f69a429b4b43e (clean) (release) 19:24:25.945 T:1962157168 NOTICE: ARM mem: 752MB GPU mem: 256MB MPG2:0 WVC1:0 19:24:25.945 T:1962157168 NOTICE: cache.memorysize: 20MB libass.cache: 0MB 19:24:25.946 T:1962157168 NOTICE: Config: arm_freq=900 audio_pwm_mode=1 config_hdmi_boost=5 disable_commandline_tags=2 disable_l2cache=1 enable_uart=1 force_eeprom_read=1 force_pwm_open=1 framebuffer_ignore_alpha=1 framebuffer_swap=1 hdmi_channel_map=8 hdmi_force_cec_address=65535 hdmi_ignore_cec_init=1 init_uart_clock=0x2dc6c00 lcd_framerate=60 over_voltage_avs=0x1b774 over_voltage_avs_boost=0x155cc overscan_bottom=48 overscan_left=48 overscan_right=48 overscan_top=48 pause_burst_frames=1 program_serial_random=1 sdram_freq=450 temp_limit=85 19:24:25.946 T:1962157168 NOTICE: Config: device_tree=- 19:24:25.946 T:1962157168 NOTICE: InitWindowSystem: Using EGL Implementation: raspberrypi 19:24:25.949 T:1962157168 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 60.000000 Hz 19:24:25.949 T:1962157168 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 59.940063 Hz 19:24:25.949 T:1962157168 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 60.000000 Hz 19:24:25.950 T:1962157168 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 59.940063 Hz 19:24:25.950 T:1962157168 NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 60.000000 Hz 19:24:25.950 T:1962157168 NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 59.940063 Hz 19:24:25.950 T:1962157168 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 60.000000 Hz 19:24:25.950 T:1962157168 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 59.940063 Hz 19:24:25.950 T:1962157168 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 60.000000 Hz 19:24:25.950 T:1962157168 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 59.940063 Hz 19:24:25.950 T:1962157168 NOTICE: Found resolution 720 x 576 for display 0 with 720 x 576 @ 50.000000 Hz 19:24:25.950 T:1962157168 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 50.000000 Hz 19:24:25.950 T:1962157168 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 50.000000 Hz 19:24:25.950 T:1962157168 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 24.000000 Hz 19:24:25.950 T:1962157168 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 23.976025 Hz 19:24:25.950 T:1962157168 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 25.000000 Hz 19:24:25.950 T:1962157168 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 30.000000 Hz 19:24:25.950 T:1962157168 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 29.970032 Hz 19:24:25.951 T:1962157168 NOTICE: Found (1920x1080@60.000000) at 24, setting to RES_DESKTOP at 16 19:24:25.951 T:1962157168 NOTICE: Checking resolution 16 19:24:26.276 T:1962157168 NOTICE: GL_VENDOR = Broadcom 19:24:26.276 T:1962157168 NOTICE: GL_RENDERER = VideoCore IV HW 19:24:26.276 T:1962157168 NOTICE: GL_VERSION = OpenGL ES 2.0 19:24:26.276 T:1962157168 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 19:24:26.276 T:1962157168 NOTICE: GL_EXTENSIONS = GL_OES_compressed_ETC1_RGB8_texture GL_OES_compressed_paletted_texture GL_OES_texture_npot GL_OES_depth24 GL_OES_vertex_half_float GL_OES_EGL_image GL_OES_EGL_image_external GL_EXT_discard_framebuffer GL_OES_rgb8_rgba8 GL_OES_depth32 GL_OES_mapbuffer GL_EXT_texture_format_BGRA8888 GL_APPLE_rgb_422 GL_EXT_debug_marker 19:24:28.030 T:1874850720 NOTICE: Running database version Addons27 19:24:28.038 T:1874850720 NOTICE: Running database version ViewModes6 19:24:28.269 T:1832907680 NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001) 19:24:28.344 T:1874850720 NOTICE: Running database version Textures13 19:24:28.373 T:1874850720 NOTICE: WakeOnAccess [192.168.0.102] trigged by accessing : MySQL : MyMusic60 19:24:28.392 T:1874850720 NOTICE: WakeOnAccess success exit, server already running 19:24:28.401 T:1874850720 NOTICE: Running database version MyMusic60 19:24:28.409 T:1874850720 NOTICE: Running database version MyVideos107 19:24:28.418 T:1874850720 NOTICE: Running database version TV29 19:24:28.426 T:1874850720 NOTICE: Running database version Epg11 19:24:28.433 T:1962157168 NOTICE: start dvd mediatype detection 19:24:29.843 T:1962157168 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 19:24:30.504 T:1962157168 NOTICE: initialize done 19:24:30.504 T:1962157168 NOTICE: Running the application... 19:24:30.546 T:1962157168 NOTICE: starting zeroconf publishing 19:24:30.547 T:1962157168 NOTICE: CWebServer[8080]: Started 19:24:30.547 T:1962157168 NOTICE: starting upnp client 19:24:30.555 T:1641018272 NOTICE: ES: Starting UDP Event server on port 9777 19:24:30.556 T:1641018272 NOTICE: UDP: Listening on port 9777 (ipv6 : false) 19:24:31.750 T:1792013216 NOTICE: script.tv.show.next.aired: ### TV Show - Next Aired starting background proc (6.0.15) 19:24:34.239 T:1758458784 NOTICE: Skin Helper Widgets --> Backgroundservice started 19:24:34.718 T:1724904352 WARNING: CSkinInfo: failed to load skin settings 19:24:35.007 T:1454371744 NOTICE: Skin Helper Service --> WebService - start helper webservice on port 52307 19:24:36.304 T:1750070176 NOTICE: Skin Helper Backgrounds --> BackgroundsUpdater - started 19:24:36.307 T:1800401824 NOTICE: Skin Helper Service --> Skin Helper Service version 1.1.3 started 19:24:40.198 T:1741681568 NOTICE: WakeOnAccess [HTPC-SERVER] trigged by accessing : smb://HTPC-SERVER/3D MKV/Findet Nemo (2003)/folder.jpg 19:24:40.318 T:1741681568 NOTICE: WakeOnAccess success exit, server already running 19:24:48.493 T:1962157168 NOTICE: VideoPlayer: Opening: smb://HTPC-SERVER/3D MKV/Assassin's Creed (2016)/Assassin's Creed.mk3d 19:24:48.493 T:1962157168 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 19:24:49.304 T:1412428704 NOTICE: Creating InputStream 19:24:49.325 T:1412428704 NOTICE: Creating Demuxer 19:24:51.528 T:1412428704 NOTICE: Opening stream: 0 source: 256 19:24:51.554 T:1412428704 NOTICE: Creating video thread 19:24:51.555 T:1412428704 NOTICE: Opening stream: 1 source: 256 19:24:51.556 T:1412428704 NOTICE: Creating audio thread 19:24:51.556 T:1412428704 NOTICE: Opening stream: 4 source: 256 19:24:51.572 T:1962157168 NOTICE: VideoPlayer: OnLostDisplay received 19:24:51.793 T:1962157168 NOTICE: VideoPlayer: OnResetDisplay received 19:24:51.965 T:1412428704 NOTICE: OMXClock using audio as reference 19:26:18.618 T:1962157168 NOTICE: CVideoPlayer::CloseFile() 19:26:18.618 T:1962157168 NOTICE: VideoPlayer: waiting for threads to exit 19:26:18.626 T:1412428704 NOTICE: CVideoPlayer::OnExit() 19:26:18.626 T:1412428704 NOTICE: Closing stream player 1 19:26:18.653 T:1462760352 NOTICE: thread end: OMXPlayerAudio::OnExit() 19:26:18.732 T:1412428704 NOTICE: Closing stream player 2 19:26:18.732 T:1504703392 ERROR: OMXPlayerVideo: Got MSGQ_IS_ERROR(-1) Aborting 19:26:18.732 T:1504703392 NOTICE: thread end: video_thread 19:26:18.796 T:1412428704 NOTICE: Closing stream player 3 19:26:18.813 T:1962157168 NOTICE: VideoPlayer: finished waiting 19:26:19.989 T:1962157168 NOTICE: CVideoPlayer::CloseFile() 19:26:19.990 T:1962157168 NOTICE: VideoPlayer: waiting for threads to exit 19:26:19.990 T:1962157168 NOTICE: VideoPlayer: finished waiting 19:26:19.990 T:1962157168 NOTICE: CVideoPlayer::CloseFile() 19:26:19.990 T:1962157168 NOTICE: VideoPlayer: waiting for threads to exit 19:26:19.990 T:1962157168 NOTICE: VideoPlayer: finished waiting 19:27:38.635 T:1930425248 NOTICE: CAESinkPi:AddPackets Underrun (delay:0.00 frames:2205) 19:27:53.740 T:1481634720 WARNING: CSkinInfo: failed to load skin settings 19:27:53.798 T:1962157168 WARNING: Skin has invalid include: DefaultBackground 19:27:53.799 T:1962157168 WARNING: Skin has invalid include: TopBar 19:27:53.799 T:1962157168 WARNING: Skin has invalid include: BottomBar 19:27:53.814 T:1962157168 ERROR: Window Translator: Can't find window videolibrary 19:27:53.815 T:1962157168 WARNING: Label Formating: $VAR[GlobalFanartVar] is not defined 19:27:54.128 T:1962157168 ERROR: Control 1000 in window 13001 has been asked to focus, but it can't 19:27:54.161 T:1962157168 WARNING: COMXImageFile::GetCodingType progressive images not supported by decoder 19:27:54.161 T:1962157168 NOTICE: LoadJpeg: unable to load /usr/share/kodi/addons/service.libreelec.settings/resources/skins/Default/media/default/bg.jpg 19:27:58.956 T:1962157168 NOTICE: Samba is idle. Closing the remaining connections 19:28:00.422 T:1481634720 WARNING: CSkinInfo: failed to load skin settings 19:28:00.497 T:1962157168 WARNING: Skin has invalid include: DefaultBackground 19:28:00.497 T:1962157168 WARNING: Skin has invalid include: TopBar 19:28:00.497 T:1962157168 WARNING: Skin has invalid include: BottomBar 19:28:00.521 T:1962157168 ERROR: Window Translator: Can't find window videolibrary 19:28:00.522 T:1962157168 WARNING: Label Formating: $VAR[GlobalFanartVar] is not defined 19:28:00.635 T:1962157168 ERROR: Control 1000 in window 13000 has been asked to focus, but it can't 19:28:30.622 T:1481634720 WARNING: CSkinInfo: failed to load skin settings 19:28:30.713 T:1962157168 WARNING: Skin has invalid include: DefaultBackground 19:28:30.713 T:1962157168 WARNING: Skin has invalid include: TopBar 19:28:30.713 T:1962157168 WARNING: Skin has invalid include: BottomBar 19:28:30.736 T:1962157168 WARNING: Label Formating: $VAR[GlobalFanartVar] is not defined 19:28:30.832 T:1962157168 ERROR: Control 1000 in window 13000 has been asked to focus, but it can't 19:29:07.154 T:1962157168 ERROR: GetDirectory - Error getting addons://search/ 19:29:07.155 T:1962157168 ERROR: CGUIMediaWindow::GetDirectory(addons://search/) failed 19:29:14.442 T:1962157168 ERROR: GetDirectory - Error getting addons://sources/ 19:29:14.443 T:1962157168 ERROR: CGUIMediaWindow::GetDirectory(addons://sources/) failed 19:30:38.823 T:1962157168 ERROR: GetDirectory - Error getting plugin://plugin.video.skyticket.de/?action=listPage&path=%2fst%2fmultiplatform%2fweb%2fjson%2feditorial_special%2f51.json 19:30:38.827 T:1962157168 ERROR: CGUIMediaWindow::GetDirectory(plugin://plugin.video.skyticket.de/?action=listPage&path=%2fst%2fmultiplatform%2fweb%2fjson%2feditorial_special%2f51.json) failed 19:30:54.010 T:1464857504 WARNING: Attempt to use invalid handle 6 19:31:34.638 T:1962157168 WARNING: Previous line repeats 5 times. 19:31:34.638 T:1962157168 NOTICE: VideoPlayer: Opening: http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F305100070060100332001/F305100070060100332001.ism/Manifest 19:31:34.638 T:1962157168 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 19:31:34.707 T:1464857504 NOTICE: Creating InputStream 19:31:38.325 T:1464857504 NOTICE: Creating Demuxer 19:31:38.329 T:1464857504 NOTICE: Opening stream: 1 source: 256 19:31:38.358 T:1464857504 NOTICE: Creating video thread 19:31:38.358 T:1464857504 NOTICE: Opening stream: 3 source: 256 19:31:38.368 T:1464857504 NOTICE: Creating audio thread 19:31:39.669 T:1464857504 NOTICE: Opening stream: 1 source: 256 19:31:39.669 T:1464857504 NOTICE: Opening stream: 3 source: 256 19:31:39.811 T:1464857504 NOTICE: OMXClock using audio as reference 19:32:05.821 T:1962157168 NOTICE: CVideoPlayer::CloseFile() 19:32:05.822 T:1962157168 NOTICE: VideoPlayer: waiting for threads to exit 19:32:05.822 T:1464857504 NOTICE: CVideoPlayer::OnExit() 19:32:05.822 T:1464857504 NOTICE: Closing stream player 1 19:32:05.834 T:1412428704 NOTICE: thread end: OMXPlayerAudio::OnExit() 19:32:05.906 T:1464857504 NOTICE: Closing stream player 2 19:32:05.909 T:1420817312 NOTICE: thread end: video_thread 19:32:05.954 T:1962157168 NOTICE: VideoPlayer: finished waiting 19:32:06.013 T:1962157168 ERROR: Control 50 in window 10025 has been asked to focus, but it can't 19:32:06.313 T:1962157168 NOTICE: CVideoPlayer::CloseFile() 19:32:06.313 T:1962157168 NOTICE: VideoPlayer: waiting for threads to exit 19:32:06.313 T:1962157168 NOTICE: VideoPlayer: finished waiting 19:32:06.314 T:1962157168 NOTICE: CVideoPlayer::CloseFile() 19:32:06.314 T:1962157168 NOTICE: VideoPlayer: waiting for threads to exit 19:32:06.314 T:1962157168 NOTICE: VideoPlayer: finished waiting 19:38:06.890 T:1962157168 NOTICE: VideoPlayer: Opening: http://skywebvod-s.akamaihd.net/ondemand/Production/de_at/movies/F305100070061100332001/F305100070061100332001.ism/Manifest 19:38:06.890 T:1962157168 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 19:38:06.957 T:1481634720 NOTICE: Creating InputStream 19:38:10.298 T:1481634720 NOTICE: Creating Demuxer 19:38:10.302 T:1481634720 NOTICE: Opening stream: 1 source: 256 19:38:10.331 T:1481634720 NOTICE: Creating video thread 19:38:10.331 T:1481634720 NOTICE: Opening stream: 3 source: 256 19:38:10.336 T:1481634720 NOTICE: Creating audio thread 19:38:11.320 T:1481634720 NOTICE: Opening stream: 1 source: 256 19:38:11.321 T:1481634720 NOTICE: Opening stream: 3 source: 256 19:38:11.421 T:1481634720 NOTICE: OMXClock using audio as reference 19:57:04.095 T:1464857504 NOTICE: WakeOnAccess [192.168.0.102] trigged by accessing : MySQL : MyVideos107 19:57:04.194 T:1464857504 NOTICE: WakeOnAccess success exit, server already running 20:16:59.069 T:1792013216 NOTICE: script.tv.show.next.aired: ### starting data update 20:17:01.028 T:1792013216 NOTICE: WakeOnAccess [192.168.0.102] trigged by accessing : MySQL : MyVideos107 20:17:01.125 T:1792013216 NOTICE: WakeOnAccess success exit, server already running 20:17:01.454 T:1792013216 NOTICE: script.tv.show.next.aired: ### getting series & episode info for #121361 - Game of Thrones 20:17:02.066 T:1792013216 NOTICE: script.tv.show.next.aired: ### getting series info for #264586 - Orange Is the New Black 20:17:02.534 T:1792013216 NOTICE: script.tv.show.next.aired: ### getting series & episode info for #299139 - The Magicians 20:17:02.897 T:1792013216 NOTICE: script.tv.show.next.aired: ### data update finished 20:27:33.484 T:1378874272 NOTICE: WakeOnAccess [192.168.0.102] trigged by accessing : MySQL : MyVideos107 20:27:33.587 T:1378874272 NOTICE: WakeOnAccess success exit, server already running 20:36:09.600 T:1962157168 NOTICE: CVideoPlayer::CloseFile() 20:36:09.600 T:1962157168 NOTICE: VideoPlayer: waiting for threads to exit 20:36:09.601 T:1481634720 NOTICE: CVideoPlayer::OnExit() 20:36:09.601 T:1481634720 NOTICE: Closing stream player 1 20:36:09.608 T:1473246112 NOTICE: thread end: OMXPlayerAudio::OnExit() 20:36:09.688 T:1481634720 NOTICE: Closing stream player 2 20:36:09.691 T:1420817312 NOTICE: thread end: video_thread 20:36:09.731 T:1962152864 NOTICE: WakeOnAccess [192.168.0.102] trigged by accessing : MySQL : MyVideos107 20:36:09.785 T:1962157168 NOTICE: VideoPlayer: finished waiting 20:36:09.819 T:1962152864 NOTICE: WakeOnAccess success exit, server already running 20:36:09.844 T:1962157168 ERROR: Control 50 in window 10025 has been asked to focus, but it can't 20:36:10.132 T:1962157168 NOTICE: CVideoPlayer::CloseFile() 20:36:10.133 T:1962157168 NOTICE: VideoPlayer: waiting for threads to exit 20:36:10.133 T:1962157168 NOTICE: VideoPlayer: finished waiting 20:36:10.133 T:1962157168 NOTICE: CVideoPlayer::CloseFile() 20:36:10.133 T:1962157168 NOTICE: VideoPlayer: waiting for threads to exit 20:36:10.133 T:1962157168 NOTICE: VideoPlayer: finished waiting 20:36:22.673 T:1962157168 ERROR: Control 50 in window 10025 has been asked to focus, but it can't 20:36:28.985 T:1962157168 ERROR: GetDirectory - Error getting plugin://plugin.video.skyticket.de/?action=listSeries&id=62871&infolabels=%7b%27plot%27%3a%20%27%27%2c%20%27title%27%3a%20u%27Game%20of%20Thrones%20-%20Das%20Lied%20von%20Eis%20und%20Feuer%27%2c%20%27originaltitle%27%3a%20u%27Game%20of%20Thrones%27%2c%20%27cast%27%3a%20%5b%5d%2c%20%27year%27%3a%202011%2c%20%27duration%27%3a%200%2c%20%27genre%27%3a%20%27%27%7d 20:36:28.990 T:1962157168 ERROR: CGUIMediaWindow::GetDirectory(plugin://plugin.video.skyticket.de/?action=listSeries&id=62871&infolabels=%7b%27plot%27%3a%20%27%27%2c%20%27title%27%3a%20u%27Game%20of%20Thrones%20-%20Das%20Lied%20von%20Eis%20und%20Feuer%27%2c%20%27originaltitle%27%3a%20u%27Game%20of%20Thrones%27%2c%20%27cast%27%3a%20%5b%5d%2c%20%27year%27%3a%202011%2c%20%27duration%27%3a%200%2c%20%27genre%27%3a%20%27%27%7d) failed 20:38:22.605 T:1481634720 NOTICE: WakeOnAccess [HTPC-SERVER] trigged by accessing : smb://HTPC-SERVER/MKV/Mein Nachbar Totoro (1988)/thumb.jpg 20:38:22.657 T:1930425248 NOTICE: CAESinkPi:AddPackets Underrun (delay:0.00 frames:2205) 20:38:22.694 T:1481634720 NOTICE: WakeOnAccess success exit, server already running 20:44:51.951 T:1962157168 NOTICE: VideoPlayer: Opening: smb://HTPC-SERVER/MKV/Zombieland (2009)/Zombieland.mkv 20:44:51.952 T:1962157168 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 20:44:51.953 T:1378886560 NOTICE: Creating InputStream 20:44:52.049 T:1378886560 NOTICE: Creating Demuxer 20:44:53.559 T:1378886560 NOTICE: Opening stream: 0 source: 256 20:44:53.597 T:1378886560 NOTICE: Creating video thread 20:44:53.597 T:1378886560 NOTICE: Opening stream: 1 source: 256 20:44:53.598 T:1378886560 NOTICE: Creating audio thread 20:44:53.598 T:1378886560 NOTICE: Opening stream: 3 source: 256 20:44:53.725 T:1378886560 NOTICE: OMXClock using audio as reference 21:01:57.216 T:1464857504 NOTICE: WakeOnAccess [192.168.0.102] trigged by accessing : MySQL : MyVideos107 21:01:57.397 T:1464857504 NOTICE: WakeOnAccess success exit, server already running 21:32:26.028 T:1464857504 NOTICE: WakeOnAccess [192.168.0.102] trigged by accessing : MySQL : MyVideos107 21:32:26.208 T:1464857504 NOTICE: WakeOnAccess success exit, server already running 21:38:20.961 T:1464857504 NOTICE: WakeOnAccess [192.168.0.102] trigged by accessing : MySQL : MyVideos107 21:38:21.164 T:1464857504 NOTICE: WakeOnAccess success exit, server already running 21:38:31.796 T:1962157168 NOTICE: Storing total System Uptime 21:38:31.797 T:1962157168 NOTICE: Saving settings 21:38:31.842 T:1962157168 NOTICE: Saving skin settings 21:38:31.857 T:1962157168 NOTICE: stop all 21:38:31.857 T:1962157168 NOTICE: stop player 21:38:31.857 T:1962157168 NOTICE: CVideoPlayer::CloseFile() 21:38:31.857 T:1962157168 NOTICE: VideoPlayer: waiting for threads to exit 21:38:31.866 T:1378886560 NOTICE: CVideoPlayer::OnExit() 21:38:31.866 T:1378886560 NOTICE: Closing stream player 1 21:38:31.868 T:1362297760 NOTICE: thread end: OMXPlayerAudio::OnExit() 21:38:31.950 T:1378886560 NOTICE: Closing stream player 2 21:38:31.955 T:1404040096 NOTICE: thread end: video_thread 21:38:32.008 T:1378886560 NOTICE: Closing stream player 3 21:38:32.016 T:1962157168 NOTICE: VideoPlayer: finished waiting 21:38:32.018 T:1962157168 NOTICE: ES: Stopping event server 21:38:32.380 T:1962157168 NOTICE: stopping upnp 21:38:32.466 T:1641018272 NOTICE: ES: UDP Event server stopped 21:38:32.535 T:1962157168 NOTICE: stopping zeroconf publishing 21:38:32.543 T:1962157168 NOTICE: CWebServer[8080]: Stopped 21:38:32.543 T:1962157168 NOTICE: stop dvd detect media 21:38:32.731 T:1962157168 NOTICE: clean cached files! 21:38:33.150 T:1800401824 NOTICE: Skin Helper Service --> Shutdown requested ! 21:38:33.187 T:1800401824 NOTICE: Skin Helper Service --> Skin Helper Service version 1.1.3 stopped 21:38:33.977 T:1792013216 NOTICE: script.tv.show.next.aired: ### abort requested -- stopping background processing 21:38:35.107 T:1775236000 WARNING: CPythonInvoker(4, /storage/.kodi/addons/service.library.data.provider/service.py): the python script "/storage/.kodi/addons/service.library.data.provider/service.py" has left several classes in memory that we couldn't clean up. The classes include: N14PythonBindings30XBMCAddon_xbmc_Player_DirectorE,N9XBMCAddon7xbmcgui6WindowE,N14PythonBindings31XBMCAddon_xbmc_Monitor_DirectorE 21:38:35.108 T:1758458784 NOTICE: Skin Helper Widgets --> Backgroundservice stopped 21:38:35.118 T:1750070176 NOTICE: Skin Helper Backgrounds --> BackgroundsUpdater - stop called 21:38:35.228 T:1962157168 NOTICE: closing down remote control service 21:38:35.228 T:1962157168 NOTICE: stopped 21:38:35.429 T:1962157168 NOTICE: CVideoPlayer::CloseFile() 21:38:35.429 T:1962157168 NOTICE: VideoPlayer: waiting for threads to exit 21:38:35.429 T:1962157168 NOTICE: VideoPlayer: finished waiting 21:38:35.476 T:1962157168 NOTICE: destroy 21:38:35.476 T:1962157168 NOTICE: unload skin 21:38:35.569 T:1962157168 WARNING: Cleanup: Having to cleanup texture button-nofocus.png 21:38:35.571 T:1962157168 WARNING: Cleanup: Having to cleanup texture button-focus.png 21:38:35.764 T:1962157168 NOTICE: unload sections 21:38:35.857 T:1962157168 NOTICE: special://profile/ is mapped to: special://masterprofile/ 21:38:35.869 T:1962157168 NOTICE: application stopped...