23:40:59 T:140685861042112 NOTICE: special://profile/ is mapped to: special://masterprofile/ 23:40:59 T:140685861042112 NOTICE: ----------------------------------------------------------------------- 23:40:59 T:140685861042112 NOTICE: Starting Kodi (14.0-RC3 Git:bdf56d0). Platform: Linux x86 64-bit 23:40:59 T:140685861042112 NOTICE: Using Release Kodi x64 build 23:40:59 T:140685861042112 NOTICE: Kodi compiled Dec 9 2014 by GCC 4.8.2 for Linux x86 64-bit version 3.13.11 (199947) 23:40:59 T:140685861042112 NOTICE: Running on Ubuntu 14.04.1 LTS, kernel: Linux x86 64-bit version 3.13.0-32-generic 23:40:59 T:140685861042112 NOTICE: FFmpeg statically linked, version: 2.4.4-xbmc-2.4.4-Helix 23:40:59 T:140685861042112 NOTICE: Host CPU: Intel(R) Pentium(R) CPU G3220 @ 3.00GHz, 2 cores available 23:40:59 T:140685861042112 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi 23:40:59 T:140685861042112 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi 23:40:59 T:140685861042112 NOTICE: special://masterprofile/ is mapped to: /home/knut/.kodi/userdata 23:40:59 T:140685861042112 NOTICE: special://home/ is mapped to: /home/knut/.kodi 23:40:59 T:140685861042112 NOTICE: special://temp/ is mapped to: /home/knut/.kodi/temp 23:40:59 T:140685861042112 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin 23:40:59 T:140685861042112 NOTICE: Local hostname: knut-tvkiste 23:40:59 T:140685861042112 NOTICE: Log File is located: /home/knut/.kodi/temp/kodi.log 23:40:59 T:140685861042112 NOTICE: ----------------------------------------------------------------------- 23:40:59 T:140685861042112 NOTICE: load settings... 23:40:59 T:140685861042112 NOTICE: Found 1 Lists of Devices 23:40:59 T:140685861042112 NOTICE: Enumerated PULSE devices: 23:40:59 T:140685861042112 NOTICE: Device 1 23:40:59 T:140685861042112 NOTICE: m_deviceName : Default 23:40:59 T:140685861042112 NOTICE: m_displayName : Default 23:40:59 T:140685861042112 NOTICE: m_displayNameExtra: Default Output Device (PULSEAUDIO) 23:40:59 T:140685861042112 NOTICE: m_deviceType : AE_DEVTYPE_PCM 23:40:59 T:140685861042112 NOTICE: m_channels : FL,FR 23:40:59 T:140685861042112 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000 23:40:59 T:140685861042112 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT 23:40:59 T:140685861042112 NOTICE: Device 2 23:40:59 T:140685861042112 NOTICE: m_deviceName : alsa_output.pci-0000_00_03.0.hdmi-stereo 23:40:59 T:140685861042112 NOTICE: m_displayName : Internes Audio Digital Stereo (HDMI) 23:40:59 T:140685861042112 NOTICE: m_displayNameExtra: HDMI / DisplayPort (PULSEAUDIO) 23:40:59 T:140685861042112 NOTICE: m_deviceType : AE_DEVTYPE_PCM 23:40:59 T:140685861042112 NOTICE: m_channels : FL,FR 23:40:59 T:140685861042112 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000 23:40:59 T:140685861042112 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT 23:40:59 T:140685861042112 NOTICE: Device 3 23:40:59 T:140685861042112 NOTICE: m_deviceName : alsa_output.pci-0000_00_1b.0.analog-stereo 23:40:59 T:140685861042112 NOTICE: m_displayName : Internes Audio Analog Stereo 23:40:59 T:140685861042112 NOTICE: m_displayNameExtra: Analoge Ausgabe (PULSEAUDIO) 23:40:59 T:140685861042112 NOTICE: m_deviceType : AE_DEVTYPE_PCM 23:40:59 T:140685861042112 NOTICE: m_channels : FL,FR 23:40:59 T:140685861042112 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000 23:40:59 T:140685861042112 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT 23:40:59 T:140685861042112 NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml) 23:40:59 T:140685861042112 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 23:40:59 T:140685861042112 NOTICE: Default DVD Player: dvdplayer 23:40:59 T:140685861042112 NOTICE: Default Video Player: dvdplayer 23:40:59 T:140685861042112 NOTICE: Default Audio Player: paplayer 23:40:59 T:140685861042112 NOTICE: Enabled debug logging due to GUI setting (2) 23:40:59 T:140685861042112 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 23:40:59 T:140685861042112 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 23:40:59 T:140685861042112 DEBUG: CPlayerCoreConfig::: created player DVDPlayer for core 1 23:40:59 T:140685861042112 DEBUG: CPlayerCoreConfig::: created player oldmplayercore for core 1 23:40:59 T:140685861042112 DEBUG: CPlayerCoreConfig::: created player PAPlayer for core 3 23:40:59 T:140685861042112 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules 23:40:59 T:140685861042112 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtv 23:40:59 T:140685861042112 DEBUG: CPlayerSelectionRule::Initialize: creating rule: hdhomerun/myth/mms/udp 23:40:59 T:140685861042112 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout 23:40:59 T:140685861042112 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp 23:40:59 T:140685861042112 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp 23:40:59 T:140685861042112 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams 23:40:59 T:140685861042112 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp 23:40:59 T:140685861042112 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2 23:40:59 T:140685861042112 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd 23:40:59 T:140685861042112 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage 23:40:59 T:140685861042112 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf 23:40:59 T:140685861042112 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv 23:40:59 T:140685861042112 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio 23:40:59 T:140685861042112 NOTICE: Loaded playercorefactory configuration 23:40:59 T:140685861042112 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 23:40:59 T:140685861042112 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 23:40:59 T:140685861042112 INFO: creating subdirectories 23:40:59 T:140685861042112 INFO: userdata folder: special://masterprofile/ 23:40:59 T:140685861042112 INFO: recording folder: 23:40:59 T:140685861042112 INFO: screenshots folder: 23:40:59 T:140685861042112 INFO: load language info file: special://xbmc/language/English/langinfo.xml 23:40:59 T:140685861042112 DEBUG: trying to set locale to en_US.UTF-8 23:40:59 T:140685861042112 INFO: global locale set to en_US.UTF-8 23:40:59 T:140685861042112 INFO: load English language file, from path: special://xbmc/language/ 23:41:00 T:140685861042112 DEBUG: POParser: loaded 3267 strings from file /usr/share/kodi/language/English/strings.po 23:41:00 T:140685395212032 NOTICE: Thread ActiveAE start, auto delete: false 23:41:00 T:140685454026496 NOTICE: Thread AESink start, auto delete: false 23:41:00 T:140685454026496 INFO: CActiveAESink::OpenSink - initialize sink 23:41:00 T:140685454026496 DEBUG: CActiveAESink::OpenSink - trying to open device PULSE:Default 23:41:00 T:140685454026496 DEBUG: PulseAudio: Context authorizing 23:41:00 T:140685454026496 DEBUG: PulseAudio: Context setting name 23:41:00 T:140685454026496 DEBUG: PulseAudio: Context ready 23:41:00 T:140685454026496 DEBUG: PulseAudio: Stream ready 23:41:00 T:140685454026496 NOTICE: PulseAudio: Opened device Default in pcm mode with Buffersize 150 ms 23:41:00 T:140685454026496 DEBUG: CActiveAESink::OpenSink - PULSE Initialized: 23:41:00 T:140685454026496 DEBUG: Output Device : Default 23:41:00 T:140685454026496 DEBUG: Sample Rate : 44100 23:41:00 T:140685454026496 DEBUG: Sample Format : AE_FMT_FLOAT 23:41:00 T:140685454026496 DEBUG: Channel Count : 2 23:41:00 T:140685454026496 DEBUG: Channel Layout: FL,FR 23:41:00 T:140685454026496 DEBUG: Frames : 2205 23:41:00 T:140685454026496 DEBUG: Frame Samples : 4410 23:41:00 T:140685454026496 DEBUG: Frame Size : 8 23:41:00 T:140685861042112 NOTICE: Running database version Addons16 23:41:00 T:140685861042112 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcpluff-x86_64-linux.so) 23:41:00 T:140685861042112 DEBUG: Loading: /usr/lib/kodi/system/libcpluff-x86_64-linux.so 23:41:00 T:140685861042112 INFO: ADDON: cpluff: 'Could not read plug-in directory /home/knut/.kodi/addons: No such file or directory' 23:41:00 T:140685861042112 INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/kodi/addons: No such file or directory' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in visualization.fishbmc has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.euphoria has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in visualization.vortex has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.wma has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in visualization.projectm has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in script.module.simplejson has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in service.xbmc.versioncheck has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in skin.confluence has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in visualization.glspectrum has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.amazon.de has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in metadata.musicvideos.theaudiodb.com has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.solarwinds has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in script.module.requests has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.aac has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in metadata.local has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.last.fm has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in visualization.waveform has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.plasma has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in xbmc.codec has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.hdtrailers.net has been installed.' 23:41:00 T:140685861042112 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.' 23:41:00 T:140685861042112 NOTICE: ADDONS: Using repository repository.xbmc.org 23:41:00 T:140685861042112 INFO: LIRC Initialize: using: /dev/lircd 23:41:00 T:140685861042112 INFO: LIRC Initialize: connect failed: No such file or directory 23:41:00 T:140685861042112 DEBUG: Failed to connect to LIRC. Retry in 10s. 23:41:00 T:140685861042112 DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid" 23:41:00 T:140685861042112 DEBUG: LoadMappings - loaded node "CEC Adapter" 23:41:00 T:140685861042112 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter" 23:41:00 T:140685861042112 DEBUG: LoadMappings - loaded node "iMON HID device" 23:41:00 T:140685861042112 DEBUG: CPeripheralBusUSB - initialised udev monitor 23:41:00 T:140685861042112 DEBUG: SECTION:LoadDLL(libcec.so.2) 23:41:00 T:140685861042112 DEBUG: Loading: libcec.so.2 23:41:00 T:140685428025088 NOTICE: Thread PeripBusCEC start, auto delete: false 23:41:00 T:140685419632384 NOTICE: Thread PeripBusUSBUdev start, auto delete: false 23:41:00 T:140685861042112 DEBUG: UDisks: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UDisks was not provided by any .service files 23:41:00 T:140685861042112 DEBUG: DeviceKit.Disks: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.DeviceKit.Disks was not provided by any .service files 23:41:00 T:140685861042112 DEBUG: Selected UDev as storage provider 23:41:00 T:140685861042112 NOTICE: Setup SDL 23:41:00 T:140685861042112 INFO: Available videomodes (xrandr): 23:41:00 T:140685861042112 INFO: Output 'HDMI2' has 25 modes 23:41:00 T:140685861042112 INFO: ID:0x48 Name:1920x1200 Refresh:59.950169 Width:1920 Height:1200 23:41:00 T:140685861042112 INFO: Pixel Ratio: 0.999228 23:41:00 T:140685861042112 INFO: ID:0xab Name:1920x1080 Refresh:60.000000 Width:1920 Height:1080 23:41:00 T:140685861042112 INFO: Pixel Ratio: 0.899306 23:41:00 T:140685861042112 INFO: ID:0xac Name:1920x1080 Refresh:50.000000 Width:1920 Height:1080 23:41:00 T:140685861042112 INFO: Pixel Ratio: 0.899306 23:41:00 T:140685861042112 INFO: ID:0xad Name:1920x1080 Refresh:59.940201 Width:1920 Height:1080 23:41:00 T:140685861042112 INFO: Pixel Ratio: 0.899306 23:41:00 T:140685861042112 INFO: ID:0xae Name:1920x1080 Refresh:59.987869 Width:1920 Height:1080 23:41:00 T:140685861042112 INFO: Pixel Ratio: 0.899306 23:41:00 T:140685861042112 INFO: ID:0xaf Name:1920x1080i Refresh:30.000000 Width:1920 Height:1080 23:41:00 T:140685861042112 INFO: Pixel Ratio: 0.899306 23:41:00 T:140685861042112 INFO: ID:0xb0 Name:1920x1080i Refresh:25.000000 Width:1920 Height:1080 23:41:00 T:140685861042112 INFO: Pixel Ratio: 0.899306 23:41:00 T:140685861042112 INFO: ID:0xb1 Name:1920x1080i Refresh:29.970100 Width:1920 Height:1080 23:41:00 T:140685861042112 INFO: Pixel Ratio: 0.899306 23:41:00 T:140685861042112 INFO: ID:0xb2 Name:1600x1200 Refresh:60.000000 Width:1600 Height:1200 23:41:00 T:140685861042112 INFO: Pixel Ratio: 1.199074 23:41:00 T:140685861042112 INFO: ID:0xb3 Name:1680x1050 Refresh:59.883251 Width:1680 Height:1050 23:41:00 T:140685861042112 INFO: Pixel Ratio: 0.999228 23:41:00 T:140685861042112 INFO: ID:0xb4 Name:1280x1024 Refresh:60.019741 Width:1280 Height:1024 23:41:00 T:140685861042112 INFO: Pixel Ratio: 1.279012 23:41:00 T:140685861042112 INFO: ID:0xb5 Name:1440x900 Refresh:59.901459 Width:1440 Height:900 23:41:00 T:140685861042112 INFO: Pixel Ratio: 0.999228 23:41:00 T:140685861042112 INFO: ID:0xb6 Name:1280x960 Refresh:60.000000 Width:1280 Height:960 23:41:00 T:140685861042112 INFO: Pixel Ratio: 1.199074 23:41:00 T:140685861042112 INFO: ID:0xb7 Name:1366x768 Refresh:59.789539 Width:1366 Height:768 23:41:00 T:140685861042112 INFO: Pixel Ratio: 0.898867 23:41:00 T:140685861042112 INFO: ID:0xb8 Name:1280x720 Refresh:60.000000 Width:1280 Height:720 23:41:00 T:140685861042112 INFO: Pixel Ratio: 0.899306 23:41:00 T:140685861042112 INFO: ID:0xb9 Name:1280x720 Refresh:50.000000 Width:1280 Height:720 23:41:00 T:140685861042112 INFO: Pixel Ratio: 0.899306 23:41:00 T:140685861042112 INFO: ID:0xba Name:1280x720 Refresh:59.940201 Width:1280 Height:720 23:41:00 T:140685861042112 INFO: Pixel Ratio: 0.899306 23:41:00 T:140685861042112 INFO: ID:0xbb Name:1024x768 Refresh:60.003841 Width:1024 Height:768 23:41:00 T:140685861042112 INFO: Pixel Ratio: 1.199074 23:41:00 T:140685861042112 INFO: ID:0xbc Name:800x600 Refresh:60.316540 Width:800 Height:600 23:41:00 T:140685861042112 INFO: Pixel Ratio: 1.199074 23:41:00 T:140685861042112 INFO: ID:0xbd Name:800x600 Refresh:56.250000 Width:800 Height:600 23:41:00 T:140685861042112 INFO: Pixel Ratio: 1.199074 23:41:00 T:140685861042112 INFO: ID:0xbe Name:720x576 Refresh:50.000000 Width:720 Height:576 23:41:00 T:140685861042112 INFO: Pixel Ratio: 1.279012 23:41:00 T:140685861042112 INFO: ID:0xbf Name:720x480 Refresh:60.000000 Width:720 Height:480 23:41:00 T:140685861042112 INFO: Pixel Ratio: 1.065844 23:41:00 T:140685861042112 INFO: ID:0xc0 Name:720x480 Refresh:59.940060 Width:720 Height:480 23:41:00 T:140685861042112 INFO: Pixel Ratio: 1.065844 23:41:00 T:140685861042112 INFO: ID:0xc1 Name:640x480 Refresh:60.000000 Width:640 Height:480 23:41:00 T:140685861042112 INFO: Pixel Ratio: 1.199074 23:41:00 T:140685861042112 INFO: ID:0xc2 Name:640x480 Refresh:59.940479 Width:640 Height:480 23:41:00 T:140685861042112 INFO: Pixel Ratio: 1.199074 23:41:00 T:140685861042112 NOTICE: Checking resolution 16 23:41:00 T:140685861042112 DEBUG: Window Manager Name: Openbox 23:41:00 T:140685861042112 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib-x86_64-linux.so) 23:41:00 T:140685861042112 DEBUG: Loading: /usr/lib/kodi/system/ImageLib-x86_64-linux.so 23:41:00 T:140685861042112 NOTICE: Using visual 0x20 23:41:00 T:140685861042112 INFO: GL: Maximum texture width: 8192 23:41:00 T:140685861042112 DEBUG: GLX_EXTENSIONS: GLX_ARB_create_context GLX_ARB_create_context_profile GLX_ARB_create_context_robustness GLX_ARB_fbconfig_float GLX_ARB_framebuffer_sRGB GLX_ARB_get_proc_address GLX_ARB_multisample GLX_EXT_import_context GLX_EXT_visual_info GLX_EXT_visual_rating GLX_EXT_framebuffer_sRGB GLX_EXT_create_context_es2_profile GLX_MESA_copy_sub_buffer GLX_MESA_multithread_makecurrent GLX_MESA_query_renderer GLX_MESA_swap_control GLX_OML_swap_method GLX_OML_sync_control GLX_SGI_make_current_read GLX_SGI_swap_control GLX_SGI_video_sync GLX_SGIS_multisample GLX_SGIX_fbconfig GLX_SGIX_pbuffer GLX_SGIX_visual_select_group GLX_EXT_texture_from_pixmap GLX_INTEL_swap_event 23:41:00 T:140685861042112 NOTICE: GL_VENDOR = Intel Open Source Technology Center 23:41:00 T:140685861042112 NOTICE: GL_RENDERER = Mesa DRI Intel(R) Haswell Desktop 23:41:00 T:140685861042112 NOTICE: GL_VERSION = 3.0 Mesa 10.1.3 23:41:00 T:140685861042112 NOTICE: GL_SHADING_LANGUAGE_VERSION = 1.30 23:41:00 T:140685861042112 NOTICE: GL_EXTENSIONS = GL_ARB_multisample GL_EXT_abgr GL_EXT_bgra GL_EXT_blend_color GL_EXT_blend_minmax GL_EXT_blend_subtract GL_EXT_copy_texture GL_EXT_polygon_offset GL_EXT_subtexture GL_EXT_texture_object GL_EXT_vertex_array GL_EXT_compiled_vertex_array GL_EXT_texture GL_EXT_texture3D GL_IBM_rasterpos_clip GL_ARB_point_parameters GL_EXT_draw_range_elements GL_EXT_packed_pixels GL_EXT_point_parameters GL_EXT_rescale_normal GL_EXT_separate_specular_color GL_EXT_texture_edge_clamp GL_SGIS_generate_mipmap GL_SGIS_texture_border_clamp GL_SGIS_texture_edge_clamp GL_SGIS_texture_lod GL_ARB_framebuffer_sRGB GL_ARB_multitexture GL_EXT_framebuffer_sRGB GL_IBM_multimode_draw_arrays GL_IBM_texture_mirrored_repeat GL_3DFX_texture_compression_FXT1 GL_ARB_texture_cube_map GL_ARB_texture_env_add GL_ARB_transpose_matrix GL_EXT_blend_func_separate GL_EXT_fog_coord GL_EXT_multi_draw_arrays GL_EXT_secondary_color GL_EXT_texture_env_add GL_EXT_texture_filter_anisotropic GL_EXT_texture_lod_bias GL_INGR_blend_func_separate GL_NV_blend_square GL_NV_light_max_exponent GL_NV_texgen_reflection GL_NV_texture_env_combine4 GL_S3_s3tc GL_SUN_multi_draw_arrays GL_ARB_texture_border_clamp GL_ARB_texture_compression GL_EXT_framebuffer_object GL_EXT_texture_env_combine GL_EXT_texture_env_dot3 GL_MESA_window_pos GL_NV_packed_depth_stencil GL_NV_texture_rectangle GL_ARB_depth_texture GL_ARB_occlusion_query GL_ARB_shadow GL_ARB_texture_env_combine GL_ARB_texture_env_crossbar GL_ARB_texture_env_dot3 GL_ARB_texture_mirrored_repeat GL_ARB_window_pos GL_ATI_envmap_bumpmap GL_EXT_stencil_two_side GL_EXT_texture_cube_map GL_NV_depth_clamp GL_APPLE_packed_pixels GL_APPLE_vertex_array_object GL_ARB_draw_buffers GL_ARB_fragment_program GL_ARB_fragment_shader GL_ARB_shader_objects GL_ARB_vertex_program GL_ARB_vertex_shader GL_ATI_draw_buffers GL_ATI_texture_env_combine3 GL_ATI_texture_float GL_EXT_shadow_funcs GL_EXT_stencil_wrap GL_MESA_pack_invert GL_NV_primitive_restart GL_ARB_depth_clamp GL_ARB_fragment_program_shadow GL_ARB_half_float_pixel GL_ARB_occlusion_query2 GL_ARB_point_sprite GL_ARB_shading_language_100 GL_ARB_sync GL_ARB_texture_non_power_of_two GL_ARB_vertex_buffer_object GL_ATI_blend_equation_separate GL_EXT_blend_equation_separate GL_OES_read_format GL_ARB_color_buffer_float GL_ARB_pixel_buffer_object GL_ARB_texture_compression_rgtc GL_ARB_texture_float GL_ARB_texture_rectangle GL_EXT_packed_float GL_EXT_pixel_buffer_object GL_EXT_texture_compression_dxt1 GL_EXT_texture_compression_rgtc GL_EXT_texture_rectangle GL_EXT_texture_sRGB GL_EXT_texture_shared_exponent GL_ARB_framebuffer_object GL_EXT_framebuffer_blit GL_EXT_framebuffer_multisample GL_EXT_packed_depth_stencil GL_APPLE_object_purgeable GL_ARB_vertex_array_object GL_ATI_separate_stencil GL_EXT_draw_buffers2 GL_EXT_draw_instanced GL_EXT_gpu_program_parameters GL_EXT_texture_array GL_EXT_texture_integer GL_EXT_texture_sRGB_decode GL_EXT_timer_query GL_OES_EGL_image GL_ARB_copy_buffer GL_ARB_depth_buffer_float GL_ARB_draw_instanced GL_ARB_half_float_vertex GL_ARB_instanced_arrays GL_ARB_map_buffer_range GL_ARB_texture_rg GL_ARB_texture_swizzle GL_ARB_vertex_array_bgra GL_EXT_separate_shader_objects GL_EXT_texture_swizzle GL_EXT_vertex_array_bgra GL_NV_conditional_render GL_AMD_conservative_depth GL_AMD_draw_buffers_blend GL_AMD_seamless_cubemap_per_texture GL_ARB_ES2_compatibility GL_ARB_blend_func_extended GL_ARB_debug_output GL_ARB_draw_buffers_blend GL_ARB_draw_elements_base_vertex GL_ARB_explicit_attrib_location GL_ARB_fragment_coord_conventions GL_ARB_provoking_vertex GL_ARB_sample_shading GL_ARB_sampler_objects GL_ARB_seamless_cube_map GL_ARB_shader_texture_lod GL_ARB_texture_cube_map_array GL_ARB_texture_gather GL_ARB_texture_multisample GL_ARB_texture_query_lod GL_ARB_texture_rgb10_a2ui GL_ARB_uniform_buffer_object GL_ARB_vertex_type_2_10_10_10_rev GL_EXT_provoking_vertex GL_EXT_texture_snorm GL_MESA_texture_signed_rgba GL_ARB_get_program_binary GL_ARB_robustness GL_ARB_shader_bit_encoding GL_ARB_timer_query GL_ANGLE_texture_compression_dxt3 GL_ANGLE_texture_compression_dxt5 GL_ARB_conservative_depth GL_ARB_internalformat_query GL_ARB_map_buffer_alignment GL_ARB_shader_atomic_counters GL_ARB_shading_language_420pack GL_ARB_shading_language_packing GL_ARB_texture_storage GL_EXT_framebuffer_multisample_blit_scaled GL_EXT_transform_feedback GL_AMD_shader_trinary_minmax GL_ARB_ES3_compatibility GL_ARB_clear_buffer_object GL_ARB_invalidate_subdata GL_ARB_texture_query_levels GL_ARB_texture_storage_multisample GL_ARB_vertex_attrib_binding GL_KHR_debug GL_ARB_texture_mirror_clamp_to_edge GL_ARB_vertex_type_10f_11f_11f_rev GL_EXT_shader_integer_mix 23:41:00 T:140685861042112 INFO: GL: Maximum texture width: 8192 23:41:00 T:140685861042112 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec 23:41:00 T:140685861042112 INFO: load default splash image: /usr/share/kodi/media/Splash.png 23:41:00 T:140685861042112 INFO: load keymapping 23:41:00 T:140685861042112 INFO: Loading special://xbmc/system/keymaps/appcommand.xml 23:41:00 T:140685861042112 INFO: Loading special://xbmc/system/keymaps/gamepad.xml 23:41:00 T:140685861042112 INFO: Loading special://xbmc/system/keymaps/joystick.Alienware.Dual.Compatible.Controller.xml 23:41:00 T:140685861042112 INFO: Loading special://xbmc/system/keymaps/joystick.AppleRemote.xml 23:41:00 T:140685861042112 INFO: Loading special://xbmc/system/keymaps/joystick.Harmony.xml 23:41:00 T:140685861042112 INFO: Loading special://xbmc/system/keymaps/joystick.Interact.AxisPad.xml 23:41:00 T:140685861042112 INFO: Loading special://xbmc/system/keymaps/joystick.Logitech.RumblePad.2.xml 23:41:00 T:140685861042112 INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.360.Controller.xml 23:41:00 T:140685861042112 INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.Controller.S.xml 23:41:00 T:140685861042112 INFO: Loading special://xbmc/system/keymaps/joystick.Nintendo.Wii.U.Pro.Controller.xml 23:41:00 T:140685861042112 INFO: Loading special://xbmc/system/keymaps/joystick.PS3.Remote.Keyboard.xml 23:41:00 T:140685861042112 INFO: Loading special://xbmc/system/keymaps/joystick.Sony.PLAYSTATION(R)3.Controller.xml 23:41:00 T:140685861042112 INFO: Loading special://xbmc/system/keymaps/joystick.WiiRemote.xml 23:41:00 T:140685861042112 INFO: Loading special://xbmc/system/keymaps/keyboard.xml 23:41:00 T:140685861042112 INFO: Loading special://xbmc/system/keymaps/mouse.xml 23:41:00 T:140685861042112 INFO: Loading special://xbmc/system/keymaps/remote.xml 23:41:00 T:140685861042112 INFO: Loading special://xbmc/system/keymaps/touchscreen.xml 23:41:00 T:140685861042112 INFO: Loading special://xbmc/system/Lircmap.xml 23:41:00 T:140685861042112 INFO: * Adding remote mapping for device 'mceusb' 23:41:00 T:140685861042112 INFO: * Adding remote mapping for device 'XboxDVDDongle' 23:41:00 T:140685861042112 INFO: * Adding remote mapping for device 'Microsoft_Xbox' 23:41:00 T:140685861042112 INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote' 23:41:00 T:140685861042112 INFO: * Adding remote mapping for device 'anysee' 23:41:00 T:140685861042112 INFO: * Adding remote mapping for device 'iMON-PAD' 23:41:00 T:140685861042112 INFO: * Adding remote mapping for device 'Antec_Veris_RM200' 23:41:00 T:140685861042112 INFO: * Adding remote mapping for device 'MCE_via_iMON' 23:41:00 T:140685861042112 INFO: * Adding remote mapping for device 'TwinHanRemote' 23:41:00 T:140685861042112 INFO: * Adding remote mapping for device 'linux-input-layer' 23:41:00 T:140685861042112 INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote' 23:41:00 T:140685861042112 INFO: * Adding remote mapping for device 'mediacenter' 23:41:00 T:140685861042112 INFO: * Adding remote mapping for device 'devinput' 23:41:00 T:140685861042112 DEBUG: CButtonTranslator::Load - no userdata Lircmap.xml found, skipping 23:41:00 T:140685861042112 INFO: GUI format 1920x1200, Display 1920x1200@ 59.95 - Full Screen 23:41:00 T:140685861042112 DEBUG: guilib: Fill viewport on change for solving rendering passes 23:41:00 T:140685861042112 DEBUG: SECTION:LoadDLL(libcurl.so.4) 23:41:00 T:140685861042112 DEBUG: Loading: libcurl.so.4 23:41:00 T:140685861042112 NOTICE: Running database version Addons16 23:41:00 T:140685861042112 DEBUG: Initialize, updating databases... 23:41:00 T:140685861042112 NOTICE: Running database version ViewModes6 23:41:00 T:140685861042112 NOTICE: Running database version Textures13 23:41:00 T:140685861042112 NOTICE: Running database version MyMusic48 23:41:00 T:140685861042112 NOTICE: Running database version MyVideos90 23:41:00 T:140685861042112 NOTICE: Running database version TV26 23:41:00 T:140685861042112 NOTICE: Running database version Epg8 23:41:00 T:140685861042112 DEBUG: Initialize, updating databases... DONE 23:41:00 T:140685861042112 NOTICE: start dvd mediatype detection 23:41:00 T:140685860509440 NOTICE: Thread DetectDVDMedia start, auto delete: false 23:41:00 T:140685860509440 DEBUG: Compiled with libcdio Version 0.83 23:41:00 T:140685861042112 DEBUG: DPMS: supported power-saving modes: SUSPEND OFF STANDBY 23:41:00 T:140685861042112 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 23:41:00 T:140685860509440 INFO: Detecting DVD-ROM media filesystem... 23:41:00 T:140685861042112 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 23:41:00 T:140685861042112 INFO: Unloading old skin ... 23:41:00 T:140685861042112 INFO: load skin from: /usr/share/kodi/addons/skin.confluence (version: 2.5.7) 23:41:00 T:140685861042112 INFO: load fonts for skin... 23:41:00 T:140685861042112 INFO: Loading fonts from /usr/share/kodi/addons/skin.confluence/720p/Font.xml 23:41:00 T:140685861042112 DEBUG: POParser: loaded 149 strings from file /usr/share/kodi/addons/skin.confluence/language/English/strings.po 23:41:00 T:140685861042112 INFO: Loading skin includes from /usr/share/kodi/addons/skin.confluence/720p/includes.xml 23:41:00 T:140685860509440 INFO: CD Analysis Report 23:41:00 T:140685860509440 INFO: __________________________________ 23:41:00 T:140685860509440 INFO: CD-ROM with ISO 9660 filesystem 23:41:00 T:140685860509440 INFO: ISO 9660: 1151849 blocks, label 23:41:00 T:140685860509440 INFO: Tracks overall:1; Audio tracks:0; Data tracks:1 23:41:00 T:140685860509440 INFO: Using protocol iso9660:// 23:41:00 T:140685860509440 INFO: Disc label: 23:41:00 T:140685861042112 INFO: load new skin... 23:41:00 T:140685861042112 INFO: Loading user windows, path /usr/share/kodi/addons/skin.confluence/720p 23:41:00 T:140685861042112 DEBUG: Load Skin XML: 1.00ms 23:41:00 T:140685861042112 INFO: initialize new skin... 23:41:00 T:140685861042112 DEBUG: guilib: Fill viewport on change for solving rendering passes 23:41:00 T:140685861042112 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT 23:41:00 T:140685861042112 DEBUG: OpenBundle - Opened bundle /usr/share/kodi/addons/skin.confluence/media/Textures.xbt 23:41:00 T:140685861042112 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT 23:41:00 T:140685861042112 INFO: Loading skin file: DialogKaiToast.xml, load type: LOAD_ON_GUI_INIT 23:41:00 T:140685861042112 INFO: Loading skin file: DialogMuteBug.xml, load type: LOAD_ON_GUI_INIT 23:41:00 T:140685861042112 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT 23:41:00 T:140685861042112 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT 23:41:00 T:140685861042112 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT 23:41:00 T:140685861042112 INFO: Loading /usr/share/kodi/addons/skin.confluence/sounds/sounds.xml 23:41:00 T:140685861042112 INFO: skin loaded... 23:41:00 T:140685861042112 DEBUG: JSONRPC: JSON schema type broadcastnext references an unknown type PVR.Details.Broadcast 23:41:00 T:140685861042112 WARNING: JSONRPC: Could not parse type "PVR.Details.Channel" 23:41:00 T:140685861042112 INFO: JSONRPC: Adding type "PVR.Details.Channel" to list of incomplete definitions (waiting for "PVR.Details.Broadcast") 23:41:00 T:140685861042112 DEBUG: JSONRPC: JSON schema type references an unknown type PVR.Details.Channel 23:41:00 T:140685861042112 DEBUG: Invalid item definition in "items" for type channels 23:41:00 T:140685861042112 WARNING: JSONRPC: Could not parse type "PVR.Details.ChannelGroup.Extended" 23:41:00 T:140685861042112 INFO: JSONRPC: Adding type "PVR.Details.ChannelGroup.Extended" to list of incomplete definitions (waiting for "PVR.Details.Channel") 23:41:00 T:140685861042112 INFO: JSONRPC: Resolving incomplete types/methods referencing PVR.Details.Broadcast 23:41:00 T:140685861042112 INFO: JSONRPC: Resolving incomplete types/methods referencing PVR.Details.Channel 23:41:00 T:140685861042112 DEBUG: JSONRPC: JSON schema type stereoscopicmode references an unknown type GUI.Stereoscopy.Mode 23:41:00 T:140685861042112 WARNING: JSONRPC: Could not parse type "GUI.Property.Value" 23:41:00 T:140685861042112 INFO: JSONRPC: Adding type "GUI.Property.Value" to list of incomplete definitions (waiting for "GUI.Stereoscopy.Mode") 23:41:00 T:140685861042112 INFO: JSONRPC: Resolving incomplete types/methods referencing GUI.Stereoscopy.Mode 23:41:00 T:140685861042112 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting 23:41:00 T:140685861042112 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 23:41:00 T:140685861042112 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting") 23:41:00 T:140685861042112 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting 23:41:00 T:140685861042112 INFO: JSONRPC v6.21.2: Successfully initialized 23:41:00 T:140685861042112 DEBUG: ADDON: Starting service addons. 23:41:00 T:140685861042112 DEBUG: Activating window ID: 12999 23:41:00 T:140685861042112 DEBUG: ------ Window Init (Startup.xml) ------ 23:41:00 T:140685861042112 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME 23:41:00 T:140685861042112 INFO: removing tempfiles 23:41:00 T:140685861042112 DEBUG: ADDON: Starting service addons. 23:41:00 T:140685861042112 NOTICE: initialize done 23:41:00 T:140685861042112 NOTICE: Running the application... 23:41:00 T:140685861042112 DEBUG: Activating window ID: 10000 23:41:00 T:140685064742656 NOTICE: Thread LanguageInvoker start, auto delete: false 23:41:00 T:140685064742656 INFO: initializing python engine. 23:41:00 T:140685861042112 DEBUG: ------ Window Init () ------ 23:41:00 T:140685064742656 DEBUG: CPythonInvoker(0, /home/knut/.kodi/addons/service.xbmc.versioncheck/service.py): start processing 23:41:00 T:140685064742656 NOTICE: -->Python Interpreter Initialized<-- 23:41:00 T:140685064742656 DEBUG: CPythonInvoker(0, /home/knut/.kodi/addons/service.xbmc.versioncheck/service.py): the source file to load is "/home/knut/.kodi/addons/service.xbmc.versioncheck/service.py" 23:41:00 T:140685064742656 DEBUG: CPythonInvoker(0, /home/knut/.kodi/addons/service.xbmc.versioncheck/service.py): setting the Python path to /home/knut/.kodi/addons/service.xbmc.versioncheck:/usr/lib/python2.7:/usr/lib/python2.7/plat-x86_64-linux-gnu:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat:/usr/lib/python2.7/dist-packages/gtk-2.0 23:41:00 T:140685064742656 DEBUG: CPythonInvoker(0, /home/knut/.kodi/addons/service.xbmc.versioncheck/service.py): entering source directory /home/knut/.kodi/addons/service.xbmc.versioncheck 23:41:00 T:140685064742656 DEBUG: CPythonInvoker(0, /home/knut/.kodi/addons/service.xbmc.versioncheck/service.py): instantiating addon using automatically obtained id of "service.xbmc.versioncheck" dependent on version 2.1.0 of the xbmc.python api 23:41:00 T:140685861042112 DEBUG: ------ Window Deinit (Startup.xml) ------ 23:41:00 T:140685861042112 DEBUG: ------ Window Init (Home.xml) ------ 23:41:00 T:140685861042112 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY 23:41:00 T:140685064742656 DEBUG: Version Check: Version 0.2.7 started 23:41:00 T:140685038614272 NOTICE: Thread JobWorker start, auto delete: true 23:41:00 T:140685038614272 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update 23:41:00 T:140685038614272 DEBUG: GetRecentlyAddedAlbumSongs() query: SELECT songview.* FROM (SELECT idAlbum FROM albumview ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN songview ON songview.idAlbum=recentalbums.idAlbum 23:41:00 T:140685038614272 DEBUG: GetRecentlyAddedAlbums query: select * from albumview where strAlbum != '' order by idAlbum desc limit 10 23:41:00 T:140685038614272 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update 23:41:00 T:140685861042112 DEBUG: no profile autoexec.py (/home/knut/.kodi/userdata/autoexec.py) found, skipping 23:41:00 T:140685861042112 DEBUG: NetworkMessage - Starting network services 23:41:00 T:140685038614272 DEBUG: RunQuery took 0 ms for 0 items query: select * from movieview ORDER BY dateAdded desc, idMovie desc LIMIT 10 23:41:00 T:140685038614272 DEBUG: RunQuery took 0 ms for 0 items query: select * from episodeview ORDER BY dateAdded desc, idEpisode desc LIMIT 10 23:41:00 T:140685038614272 DEBUG: RunQuery took 1 ms for 0 items query: select * from musicvideoview ORDER BY dateAdded desc, idMVideo desc LIMIT 10 23:41:00 T:140685038614272 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 23:41:00 T:140685861042112 INFO: CZeroconfAvahi::clientCallback: avahi server not available. But may become later... 23:41:00 T:140685861042112 NOTICE: starting zeroconf publishing 23:41:00 T:140685861042112 NOTICE: ES: Starting event server 23:41:00 T:140685021828864 NOTICE: Thread EventServer start, auto delete: false 23:41:00 T:140685861042112 INFO: JSONRPC Server: Successfully initialized 23:41:00 T:140685021828864 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777 23:41:00 T:140685021828864 NOTICE: UDP: Listening on port 9777 23:41:00 T:140685038614272 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:Kodi (knut-tvkiste) port:9777 23:41:00 T:140685038614272 DEBUG: CZeroconfAvahi::doPublishService: client not running, queued for publishing 23:41:00 T:140685038614272 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:Kodi (knut-tvkiste) port:9090 23:41:00 T:140685038614272 DEBUG: CZeroconfAvahi::doPublishService: client not running, queued for publishing 23:41:00 T:140684539459328 NOTICE: Thread TCPServer start, auto delete: false 23:41:00 T:140685056022272 NOTICE: Thread RSSReader start, auto delete: false 23:41:00 T:140685056022272 DEBUG: CurlFile::Open(0x7ff3caca0c60) http://feeds.xbmc.org/xbmc 23:41:00 T:140685056022272 INFO: easy_aquire - Created session to http://feeds.xbmc.org 23:41:00 T:140685056022272 DEBUG: Got rss feed: http://feeds.xbmc.org/xbmc 23:41:00 T:140685056022272 DEBUG: RSS feed encoding: UTF-8 23:41:00 T:140685056022272 DEBUG: Parsed rss feed: http://feeds.xbmc.org/xbmc 23:41:00 T:140685056022272 DEBUG: CurlFile::Open(0x7ff3caca0c60) http://feeds.xbmc.org/latest_xbmc_addons 23:41:00 T:140685861042112 DEBUG: UPower: Received an unknown signal NameAcquired 23:41:00 T:140685056022272 DEBUG: Got rss feed: http://feeds.xbmc.org/latest_xbmc_addons 23:41:00 T:140685056022272 DEBUG: RSS feed encoding: UTF-8 23:41:00 T:140685056022272 DEBUG: Parsed rss feed: http://feeds.xbmc.org/latest_xbmc_addons 23:41:00 T:140685056022272 DEBUG: CurlFile::Open(0x7ff3caca0c60) http://feeds.xbmc.org/updated_xbmc_addons 23:41:00 T:140685056022272 DEBUG: Got rss feed: http://feeds.xbmc.org/updated_xbmc_addons 23:41:00 T:140685056022272 DEBUG: RSS feed encoding: UTF-8 23:41:00 T:140685056022272 DEBUG: Parsed rss feed: http://feeds.xbmc.org/updated_xbmc_addons 23:41:00 T:140685056022272 DEBUG: Thread RSSReader 140685056022272 terminating 23:41:02 T:140685861042112 DEBUG: Keyboard: scancode: 0x71, sym: 0x0114, unicode: 0x0000, modifier: 0x0 23:41:02 T:140685861042112 DEBUG: OnKey: left (0xf082) pressed, action is Left 23:41:03 T:140685861042112 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 23:41:03 T:140685861042112 DEBUG: OnKey: return (0xf00d) pressed, action is Select 23:41:03 T:140685861042112 DEBUG: Activating window ID: 10025 23:41:03 T:140685861042112 DEBUG: ------ Window Deinit (Home.xml) ------ 23:41:03 T:140685861042112 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 23:41:03 T:140685861042112 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 23:41:03 T:140685861042112 DEBUG: CGUIMediaWindow::GetDirectory () 23:41:03 T:140685861042112 DEBUG: ParentPath = [] 23:41:03 T:140684531066624 NOTICE: Thread BackgroundLoader start, auto delete: false 23:41:03 T:140684531066624 DEBUG: Thread BackgroundLoader 140684531066624 terminating 23:41:04 T:140685861042112 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 23:41:04 T:140685861042112 DEBUG: OnKey: return (0xf00d) pressed, action is Select 23:41:04 T:140685861042112 DEBUG: CGUIMediaWindow::GetDirectory (library://video/files.xml/) 23:41:04 T:140685861042112 DEBUG: ParentPath = [] 23:41:04 T:140684531066624 NOTICE: Thread BackgroundLoader start, auto delete: false 23:41:04 T:140684531066624 DEBUG: Thread BackgroundLoader 140684531066624 terminating 23:41:04 T:140685861042112 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:41:04 T:140685861042112 DEBUG: OnKey: down (0xf081) pressed, action is Down 23:41:05 T:140685064742656 DEBUG: Version Check: Version installed {u'major': 14, u'tag': u'releasecandidate', u'tagversion': u'3', u'minor': 0, u'revision': u'bdf56d0'} 23:41:05 T:140685064742656 INFO: CPythonInvoker(0, /home/knut/.kodi/addons/service.xbmc.versioncheck/service.py): script successfully run 23:41:05 T:140685064742656 INFO: Python script stopped 23:41:05 T:140685064742656 DEBUG: Thread LanguageInvoker 140685064742656 terminating 23:41:05 T:140685861042112 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 23:41:05 T:140685861042112 DEBUG: OnKey: return (0xf00d) pressed, action is Select 23:41:05 T:140685861042112 DEBUG: CGUIMediaWindow::GetDirectory (/media/knut/Data1/) 23:41:05 T:140685861042112 DEBUG: ParentPath = [sources://video/] 23:41:05 T:140685064742656 NOTICE: Thread BackgroundLoader start, auto delete: false 23:41:05 T:140685064742656 DEBUG: Thread BackgroundLoader 140685064742656 terminating 23:41:06 T:140685861042112 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 23:41:06 T:140685861042112 DEBUG: OnKey: up (0xf080) pressed, action is Up 23:41:06 T:140685861042112 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 23:41:06 T:140685861042112 DEBUG: OnKey: return (0xf00d) pressed, action is Select 23:41:06 T:140685861042112 DEBUG: CGUIMediaWindow::GetDirectory (/media/knut/Data1/videos/) 23:41:06 T:140685861042112 DEBUG: ParentPath = [/media/knut/Data1/] 23:41:06 T:140685064742656 NOTICE: Thread BackgroundLoader start, auto delete: false 23:41:06 T:140685038614272 DEBUG: DoWork - trying to extract thumb from video file /media/knut/Data1/videos/EDEKA Supergeil (feat. Friedrich Liechtenstein)-[jxVcgDMBU94].mp4 23:41:06 T:140685038614272 DEBUG: Open - probing detected format [mov,mp4,m4a,3gp,3g2,mj2] 23:41:06 T:140685038614272 DEBUG: Open - avformat_find_stream_info starting 23:41:06 T:140685064742656 DEBUG: Thread BackgroundLoader 140685064742656 terminating 23:41:06 T:140685038614272 DEBUG: Open - av_find_stream_info finished 23:41:06 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Input #0, mov,mp4,m4a,3gp,3g2,mj2, from '/media/knut/Data1/videos/EDEKA Supergeil (feat. Friedrich Liechtenstein)-[jxVcgDMBU94].mp4': 23:41:06 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:06 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: major_brand : mp42 23:41:06 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: minor_version : 0 23:41:06 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: compatible_brands: isommp42 23:41:06 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: creation_time : 2014-03-07 17:20:08 23:41:06 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Duration: 00:03:16.86, start: 0.000000, bitrate: 2523 kb/s 23:41:06 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Stream #0:0(und): Video: h264 (High) (avc1 / 0x31637661), yuv420p, 1280x720 [SAR 1:1 DAR 16:9], 2329 kb/s, 25 fps, 25 tbr, 25 tbn, 50 tbc (default) 23:41:06 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:06 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: handler_name : VideoHandler 23:41:06 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Stream #0:1(und): Audio: aac (mp4a / 0x6134706D), 44100 Hz, stereo, fltp, 191 kb/s (default) 23:41:06 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:06 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: creation_time : 2014-03-07 17:20:09 23:41:06 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: handler_name : IsoMedia File Produced by Google, 5-11-2011 23:41:06 T:140685038614272 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 23:41:06 T:140685038614272 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 23:41:06 T:140685038614272 DEBUG: ScanForExternalSubtitles: Searching for subtitles... 23:41:06 T:140685038614272 DEBUG: ScanForExternalSubtitles: END (total time: 0 ms) 23:41:06 T:140685038614272 DEBUG: CDVDFactoryCodec: compiled in hardware support: AMCodec:no MediaCodec:no OpenMax:no libstagefright:no VDPAU:yes VAAPI:yes iMXVPU:no 23:41:06 T:140685038614272 DEBUG: FactoryCodec - Video: - Opening 23:41:06 T:140685038614272 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 23:41:06 T:140685038614272 DEBUG: FactoryCodec - Video: ff-h264 - Opened 23:41:06 T:140685038614272 DEBUG: ExtractThumb - seeking to pos 65619ms (total: 196858ms) in /media/knut/Data1/videos/EDEKA Supergeil (feat. Friedrich Liechtenstein)-[jxVcgDMBU94].mp4 23:41:06 T:140685038614272 DEBUG: SeekTime - unknown position after seek 23:41:07 T:140685038614272 DEBUG: ExtractThumb - decode failed in /media/knut/Data1/videos/EDEKA Supergeil (feat. Friedrich Liechtenstein)-[jxVcgDMBU94].mp4 after 161 packets. 23:41:07 T:140685038614272 DEBUG: ExtractThumb - measured 433 ms to extract thumb from file in 161 packets. 23:41:07 T:140685038614272 DEBUG: DoWork - trying to extract thumb from video file /media/knut/Data1/videos/1280x720-optimus-g-gartenregen.mp4 23:41:07 T:140685064742656 NOTICE: Thread JobWorker start, auto delete: true 23:41:07 T:140685038614272 DEBUG: Open - probing detected format [mov,mp4,m4a,3gp,3g2,mj2] 23:41:07 T:140685038614272 DEBUG: Open - avformat_find_stream_info starting 23:41:07 T:140685038614272 DEBUG: Open - av_find_stream_info finished 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Input #0, mov,mp4,m4a,3gp,3g2,mj2, from '/media/knut/Data1/videos/1280x720-optimus-g-gartenregen.mp4': 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: major_brand : isom 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: minor_version : 0 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: compatible_brands: isom3gp4 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: creation_time : 2014-08-16 13:42:00 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Duration: 00:00:13.40, start: 0.000000, bitrate: 8296 kb/s 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Stream #0:0(eng): Video: h264 (Constrained Baseline) (avc1 / 0x31637661), yuv420p, 1280x720, 8051 kb/s, SAR 65536:65536 DAR 16:9, 29.98 fps, 30 tbr, 90k tbn, 180k tbc (default) 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: creation_time : 2014-08-16 13:42:00 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: handler_name : VideoHandle 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Stream #0:1(eng): Audio: aac (mp4a / 0x6134706D), 48000 Hz, stereo, fltp, 96 kb/s (default) 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: creation_time : 2014-08-16 13:42:00 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: handler_name : SoundHandle 23:41:07 T:140685038614272 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 23:41:07 T:140685038614272 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 23:41:07 T:140685038614272 DEBUG: ScanForExternalSubtitles: Searching for subtitles... 23:41:07 T:140685038614272 DEBUG: ScanForExternalSubtitles: END (total time: 0 ms) 23:41:07 T:140685038614272 DEBUG: CDVDFactoryCodec: compiled in hardware support: AMCodec:no MediaCodec:no OpenMax:no libstagefright:no VDPAU:yes VAAPI:yes iMXVPU:no 23:41:07 T:140685038614272 DEBUG: FactoryCodec - Video: - Opening 23:41:07 T:140685038614272 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 23:41:07 T:140685038614272 DEBUG: FactoryCodec - Video: ff-h264 - Opened 23:41:07 T:140685038614272 DEBUG: ExtractThumb - seeking to pos 4465ms (total: 13397ms) in /media/knut/Data1/videos/1280x720-optimus-g-gartenregen.mp4 23:41:07 T:140685038614272 DEBUG: SeekTime - unknown position after seek 23:41:07 T:140685861042112 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:41:07 T:140685861042112 DEBUG: OnKey: down (0xf081) pressed, action is Down 23:41:07 T:140685038614272 DEBUG: ExtractThumb - decode failed in /media/knut/Data1/videos/1280x720-optimus-g-gartenregen.mp4 after 161 packets. 23:41:07 T:140685038614272 DEBUG: ExtractThumb - measured 317 ms to extract thumb from file in 161 packets. 23:41:07 T:140685038614272 DEBUG: DoWork - trying to extract thumb from video file /media/knut/Data1/videos/720x480-optimus-g-zimmer.mp4 23:41:07 T:140685038614272 DEBUG: Open - probing detected format [mov,mp4,m4a,3gp,3g2,mj2] 23:41:07 T:140685038614272 DEBUG: Open - avformat_find_stream_info starting 23:41:07 T:140685038614272 DEBUG: Open - av_find_stream_info finished 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Input #0, mov,mp4,m4a,3gp,3g2,mj2, from '/media/knut/Data1/videos/720x480-optimus-g-zimmer.mp4': 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: major_brand : isom 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: minor_version : 0 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: compatible_brands: isom3gp4 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: creation_time : 2014-08-16 13:38:12 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Duration: 00:00:11.26, start: 0.000000, bitrate: 4352 kb/s 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Stream #0:0(eng): Video: h264 (Constrained Baseline) (avc1 / 0x31637661), yuv420p, 720x480, 4015 kb/s, SAR 65536:65536 DAR 3:2, 30 fps, 29.92 tbr, 90k tbn, 180k tbc (default) 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: creation_time : 2014-08-16 13:38:12 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: handler_name : VideoHandle 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Stream #0:1(eng): Audio: aac (mp4a / 0x6134706D), 16000 Hz, mono, fltp, 95 kb/s (default) 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: creation_time : 2014-08-16 13:38:12 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: handler_name : SoundHandle 23:41:07 T:140685038614272 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 23:41:07 T:140685038614272 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 23:41:07 T:140685038614272 DEBUG: ScanForExternalSubtitles: Searching for subtitles... 23:41:07 T:140685038614272 DEBUG: ScanForExternalSubtitles: END (total time: 1 ms) 23:41:07 T:140685038614272 DEBUG: CDVDFactoryCodec: compiled in hardware support: AMCodec:no MediaCodec:no OpenMax:no libstagefright:no VDPAU:yes VAAPI:yes iMXVPU:no 23:41:07 T:140685038614272 DEBUG: FactoryCodec - Video: - Opening 23:41:07 T:140685038614272 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 23:41:07 T:140685038614272 DEBUG: FactoryCodec - Video: ff-h264 - Opened 23:41:07 T:140685038614272 DEBUG: ExtractThumb - seeking to pos 3754ms (total: 11264ms) in /media/knut/Data1/videos/720x480-optimus-g-zimmer.mp4 23:41:07 T:140685038614272 DEBUG: SeekTime - unknown position after seek 23:41:07 T:140685038614272 DEBUG: ExtractThumb - decode failed in /media/knut/Data1/videos/720x480-optimus-g-zimmer.mp4 after 161 packets. 23:41:07 T:140685038614272 DEBUG: ExtractThumb - measured 251 ms to extract thumb from file in 161 packets. 23:41:07 T:140685038614272 DEBUG: DoWork - trying to extract thumb from video file /media/knut/Data1/videos/1280x720-canon-powershotg12-gartenregen.MOV 23:41:07 T:140685038614272 DEBUG: Open - probing detected format [mov,mp4,m4a,3gp,3g2,mj2] 23:41:07 T:140685038614272 DEBUG: Open - avformat_find_stream_info starting 23:41:07 T:140685038614272 DEBUG: Open - av_find_stream_info finished 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Input #0, mov,mp4,m4a,3gp,3g2,mj2, from '/media/knut/Data1/videos/1280x720-canon-powershotg12-gartenregen.MOV': 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: major_brand : qt 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: minor_version : 537331968 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: compatible_brands: qt CAEP 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: creation_time : 2014-08-16 13:42:33 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Duration: 00:00:30.24, start: 0.000000, bitrate: 20867 kb/s 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Stream #0:0(eng): Video: h264 (Constrained Baseline) (avc1 / 0x31637661), yuvj420p(pc, smpte170m), 1280x720, 19305 kb/s, 23.98 fps, 23.98 tbr, 24k tbn, 48k tbc (default) 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: creation_time : 2014-08-16 13:42:33 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Stream #0:1(eng): Audio: pcm_s16le (sowt / 0x74776F73), 48000 Hz, stereo, s16, 1536 kb/s (default) 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:07 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: creation_time : 2014-08-16 13:42:33 23:41:07 T:140685038614272 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 23:41:07 T:140685038614272 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 23:41:07 T:140685038614272 DEBUG: ScanForExternalSubtitles: Searching for subtitles... 23:41:07 T:140685038614272 DEBUG: ScanForExternalSubtitles: END (total time: 1 ms) 23:41:07 T:140685038614272 DEBUG: CDVDFactoryCodec: compiled in hardware support: AMCodec:no MediaCodec:no OpenMax:no libstagefright:no VDPAU:yes VAAPI:yes iMXVPU:no 23:41:07 T:140685038614272 DEBUG: FactoryCodec - Video: - Opening 23:41:07 T:140685038614272 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 23:41:07 T:140685038614272 DEBUG: FactoryCodec - Video: ff-h264 - Opened 23:41:07 T:140685038614272 DEBUG: ExtractThumb - seeking to pos 10079ms (total: 30238ms) in /media/knut/Data1/videos/1280x720-canon-powershotg12-gartenregen.MOV 23:41:07 T:140685038614272 DEBUG: SeekTime - unknown position after seek 23:41:07 T:140685038614272 DEBUG: ExtractThumb - decode failed in /media/knut/Data1/videos/1280x720-canon-powershotg12-gartenregen.MOV after 161 packets. 23:41:07 T:140685038614272 DEBUG: ExtractThumb - measured 376 ms to extract thumb from file in 161 packets. 23:41:07 T:140685038614272 DEBUG: DoWork - trying to extract thumb from video file /media/knut/Data1/videos/1920x1088-optimus-g-gartenregen.mp4 23:41:07 T:140685038614272 DEBUG: Open - probing detected format [mov,mp4,m4a,3gp,3g2,mj2] 23:41:07 T:140685038614272 DEBUG: Open - avformat_find_stream_info starting 23:41:08 T:140685038614272 DEBUG: Open - av_find_stream_info finished 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Input #0, mov,mp4,m4a,3gp,3g2,mj2, from '/media/knut/Data1/videos/1920x1088-optimus-g-gartenregen.mp4': 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: major_brand : isom 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: minor_version : 0 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: compatible_brands: isom3gp4 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: creation_time : 2014-08-16 13:41:37 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Duration: 00:00:14.72, start: 0.000000, bitrate: 8271 kb/s 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Stream #0:0(eng): Video: h264 (Constrained Baseline) (avc1 / 0x31637661), yuv420p, 1920x1088, 8041 kb/s, SAR 65536:65536 DAR 30:17, 30.01 fps, 30 tbr, 90k tbn, 180k tbc (default) 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: creation_time : 2014-08-16 13:41:37 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: handler_name : VideoHandle 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Stream #0:1(eng): Audio: aac (mp4a / 0x6134706D), 16000 Hz, mono, fltp, 96 kb/s (default) 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: creation_time : 2014-08-16 13:41:37 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: handler_name : SoundHandle 23:41:08 T:140685038614272 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 23:41:08 T:140685038614272 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 23:41:08 T:140685038614272 DEBUG: ScanForExternalSubtitles: Searching for subtitles... 23:41:08 T:140685038614272 DEBUG: ScanForExternalSubtitles: END (total time: 0 ms) 23:41:08 T:140685038614272 DEBUG: CDVDFactoryCodec: compiled in hardware support: AMCodec:no MediaCodec:no OpenMax:no libstagefright:no VDPAU:yes VAAPI:yes iMXVPU:no 23:41:08 T:140685038614272 DEBUG: FactoryCodec - Video: - Opening 23:41:08 T:140685038614272 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 23:41:08 T:140685038614272 DEBUG: FactoryCodec - Video: ff-h264 - Opened 23:41:08 T:140685038614272 DEBUG: ExtractThumb - seeking to pos 4906ms (total: 14720ms) in /media/knut/Data1/videos/1920x1088-optimus-g-gartenregen.mp4 23:41:08 T:140685038614272 DEBUG: SeekTime - unknown position after seek 23:41:08 T:140685861042112 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:41:08 T:140685861042112 DEBUG: OnKey: down (0xf081) pressed, action is Down 23:41:08 T:140685038614272 DEBUG: ExtractThumb - decode failed in /media/knut/Data1/videos/1920x1088-optimus-g-gartenregen.mp4 after 161 packets. 23:41:08 T:140685038614272 DEBUG: ExtractThumb - measured 806 ms to extract thumb from file in 161 packets. 23:41:08 T:140685038614272 DEBUG: DoWork - trying to extract thumb from video file /media/knut/Data1/videos/Joe_sample.mkv 23:41:08 T:140685038614272 DEBUG: Open - probing detected format [matroska,webm] 23:41:08 T:140685038614272 DEBUG: Open - avformat_find_stream_info starting 23:41:08 T:140685038614272 DEBUG: Open - av_find_stream_info finished 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Input #0, matroska,webm, from '/media/knut/Data1/videos/Joe_sample.mkv': 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: encoder : libebml v1.3.0 + libmatroska v1.4.1 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: creation_time : 2014-07-08 22:15:43 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Duration: 00:00:29.75, start: 0.000000, bitrate: 27288 kb/s 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Stream #0:0: Video: h264 (High), yuv420p(tv, bt709), 1920x1080 [SAR 1:1 DAR 16:9], 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc (default) 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: BPS : 23874972 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: BPS-eng : 23874972 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: DURATION : 00:00:29.738000000 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: DURATION-eng : 00:00:29.738000000 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: NUMBER_OF_FRAMES: 713 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: NUMBER_OF_FRAMES-eng: 713 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: NUMBER_OF_BYTES : 88749243 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: NUMBER_OF_BYTES-eng: 88749243 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: _STATISTICS_WRITING_APP: mkvmerge v7.0.0 ('Where We Going') 64bit built on Jun 9 2014 15:16:27 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: _STATISTICS_WRITING_APP-eng: mkvmerge v7.0.0 ('Where We Going') 64bit built on Jun 9 2014 15:16:27 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: _STATISTICS_WRITING_DATE_UTC: 2014-07-08 22:15:43 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: _STATISTICS_WRITING_DATE_UTC-eng: 2014-07-08 22:15:43 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: _STATISTICS_TAGS-eng: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Stream #0:1(eng): Audio: dts (DTS-HD MA), 48000 Hz, 5.1(side), fltp, 1536 kb/s (default) 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: BPS : 3414756 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: BPS-eng : 3414756 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: DURATION : 00:00:29.740000000 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: DURATION-eng : 00:00:29.740000000 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: NUMBER_OF_FRAMES: 2787 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: NUMBER_OF_FRAMES-eng: 2787 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: NUMBER_OF_BYTES : 12694356 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: NUMBER_OF_BYTES-eng: 12694356 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: _STATISTICS_WRITING_APP: mkvmerge v7.0.0 ('Where We Going') 64bit built on Jun 9 2014 15:16:27 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: _STATISTICS_WRITING_APP-eng: mkvmerge v7.0.0 ('Where We Going') 64bit built on Jun 9 2014 15:16:27 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: _STATISTICS_WRITING_DATE_UTC: 2014-07-08 22:15:43 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: _STATISTICS_WRITING_DATE_UTC-eng: 2014-07-08 22:15:43 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES 23:41:08 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: _STATISTICS_TAGS-eng: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES 23:41:08 T:140685038614272 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 23:41:08 T:140685038614272 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 23:41:08 T:140685038614272 DEBUG: ScanForExternalSubtitles: Searching for subtitles... 23:41:08 T:140685038614272 DEBUG: ScanForExternalSubtitles: END (total time: 0 ms) 23:41:08 T:140685038614272 DEBUG: CDVDFactoryCodec: compiled in hardware support: AMCodec:no MediaCodec:no OpenMax:no libstagefright:no VDPAU:yes VAAPI:yes iMXVPU:no 23:41:08 T:140685038614272 DEBUG: FactoryCodec - Video: - Opening 23:41:08 T:140685038614272 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 23:41:08 T:140685038614272 DEBUG: FactoryCodec - Video: ff-h264 - Opened 23:41:08 T:140685038614272 DEBUG: ExtractThumb - seeking to pos 9915ms (total: 29745ms) in /media/knut/Data1/videos/Joe_sample.mkv 23:41:08 T:140685038614272 DEBUG: SeekTime - seek ended up on time 9009 23:41:09 T:140685861042112 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:41:09 T:140685861042112 DEBUG: OnKey: down (0xf081) pressed, action is Down 23:41:09 T:140685038614272 DEBUG: ExtractThumb - decode failed in /media/knut/Data1/videos/Joe_sample.mkv after 161 packets. 23:41:09 T:140685038614272 DEBUG: ExtractThumb - measured 684 ms to extract thumb from file in 161 packets. 23:41:09 T:140685038614272 DEBUG: DoWork - trying to extract thumb from video file /media/knut/Data1/videos/channelcheck-large.mp4 23:41:09 T:140685038614272 DEBUG: Open - probing detected format [mov,mp4,m4a,3gp,3g2,mj2] 23:41:09 T:140685038614272 DEBUG: Open - avformat_find_stream_info starting 23:41:09 T:140685038614272 DEBUG: Open - av_find_stream_info finished 23:41:09 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Input #0, mov,mp4,m4a,3gp,3g2,mj2, from '/media/knut/Data1/videos/channelcheck-large.mp4': 23:41:09 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:09 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: major_brand : dby1 23:41:09 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: minor_version : 0 23:41:09 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: compatible_brands: isommp42dby1 23:41:09 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: creation_time : 2011-09-22 00:28:51 23:41:09 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: encoder : Audio: Dolby Digital Plus Encoder 2.2.2 Video: Dolby Impact H.264 Encoder 2.4.7.26 (win64) 23:41:09 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Duration: 00:01:21.95, start: 0.000000, bitrate: 2753 kb/s 23:41:09 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Stream #0:0(und): Video: h264 (Constrained Baseline) (avc1 / 0x31637661), yuv420p(tv), 1280x720 [SAR 1:1 DAR 16:9], 2533 kb/s, 29.97 fps, 29.97 tbr, 29970 tbn, 59.94 tbc (default) 23:41:09 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:09 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: creation_time : 2011-09-22 00:28:51 23:41:09 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: handler_name : video handler 23:41:09 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Stream #0:1(und): Audio: eac3 (ec-3 / 0x332D6365), 48000 Hz, 5.1(side), fltp, 224 kb/s (default) 23:41:09 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: Metadata: 23:41:09 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: creation_time : 2011-09-22 00:28:51 23:41:09 T:140685038614272 INFO: ffmpeg[7FF3C9C07700]: handler_name : ilst handler 23:41:09 T:140685038614272 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 23:41:09 T:140685038614272 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 23:41:09 T:140685038614272 DEBUG: ScanForExternalSubtitles: Searching for subtitles... 23:41:09 T:140685038614272 DEBUG: ScanForExternalSubtitles: END (total time: 0 ms) 23:41:09 T:140685038614272 DEBUG: CDVDFactoryCodec: compiled in hardware support: AMCodec:no MediaCodec:no OpenMax:no libstagefright:no VDPAU:yes VAAPI:yes iMXVPU:no 23:41:09 T:140685038614272 DEBUG: FactoryCodec - Video: - Opening 23:41:09 T:140685038614272 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 23:41:09 T:140685038614272 DEBUG: FactoryCodec - Video: ff-h264 - Opened 23:41:09 T:140685038614272 DEBUG: ExtractThumb - seeking to pos 27317ms (total: 81951ms) in /media/knut/Data1/videos/channelcheck-large.mp4 23:41:09 T:140685038614272 DEBUG: SeekTime - unknown position after seek 23:41:09 T:140685038614272 DEBUG: ExtractThumb - decode failed in /media/knut/Data1/videos/channelcheck-large.mp4 after 161 packets. 23:41:09 T:140685038614272 DEBUG: ExtractThumb - measured 127 ms to extract thumb from file in 161 packets. 23:41:09 T:140685861042112 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:41:09 T:140685861042112 DEBUG: OnKey: down (0xf081) pressed, action is Down 23:41:10 T:140685861042112 INFO: LIRC Initialize: using: /dev/lircd 23:41:10 T:140685861042112 DEBUG: Failed to connect to LIRC. Retry in 20s. 23:41:13 T:140685861042112 DEBUG: UPower: Received an unknown signal DeviceChanged 23:41:13 T:140685861042112 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:41:13 T:140685861042112 DEBUG: OnKey: down (0xf081) pressed, action is Down 23:41:13 T:140685861042112 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:41:13 T:140685861042112 DEBUG: OnKey: down (0xf081) pressed, action is Down 23:41:13 T:140685861042112 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 23:41:13 T:140685861042112 DEBUG: OnKey: down (0xf081) pressed, action is Down 23:41:14 T:140685861042112 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 23:41:14 T:140685861042112 DEBUG: OnKey: return (0xf00d) pressed, action is Select 23:41:14 T:140685861042112 DEBUG: OnPlayMedia /media/knut/Data1/videos/Joe_sample.mkv 23:41:14 T:140685861042112 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 23:41:14 T:140685861042112 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 23:41:14 T:140685861042112 DEBUG: Loading settings for /media/knut/Data1/videos/Joe_sample.mkv 23:41:14 T:140685861042112 DEBUG: CPlayerCoreFactory::GetPlayers(/media/knut/Data1/videos/Joe_sample.mkv) 23:41:14 T:140685861042112 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 23:41:14 T:140685861042112 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 23:41:14 T:140685861042112 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv 23:41:14 T:140685861042112 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp 23:41:14 T:140685861042112 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 23:41:14 T:140685861042112 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 23:41:14 T:140685861042112 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 23:41:14 T:140685861042112 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 23:41:14 T:140685861042112 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 23:41:14 T:140685861042112 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 23:41:14 T:140685861042112 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 23:41:14 T:140685861042112 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 23:41:14 T:140685861042112 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 23:41:14 T:140685861042112 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 23:41:14 T:140685861042112 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1) 23:41:14 T:140685861042112 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 23:41:14 T:140685861042112 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 23:41:14 T:140685861042112 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1) 23:41:14 T:140685861042112 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 23:41:14 T:140685861042112 NOTICE: DVDPlayer: Opening: /media/knut/Data1/videos/Joe_sample.mkv 23:41:14 T:140685861042112 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 23:41:14 T:140685861042112 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec 23:41:14 T:140685861042112 DEBUG: LinuxRendererGL: Cleaning up GL resources 23:41:14 T:140685861042112 DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16 23:41:14 T:140684531066624 NOTICE: Thread DVDPlayer start, auto delete: false 23:41:14 T:140684531066624 NOTICE: Creating InputStream 23:41:14 T:140684531066624 DEBUG: ScanForExternalSubtitles: Searching for subtitles... 23:41:14 T:140684531066624 DEBUG: ScanForExternalSubtitles: END (total time: 0 ms) 23:41:14 T:140684531066624 NOTICE: Creating Demuxer 23:41:14 T:140684531066624 DEBUG: Open - probing detected format [matroska,webm] 23:41:14 T:140684531066624 DEBUG: Open - avformat_find_stream_info starting 23:41:14 T:140684531066624 DEBUG: Open - av_find_stream_info finished 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: Input #0, matroska,webm, from '/media/knut/Data1/videos/Joe_sample.mkv': 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: Metadata: 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: encoder : libebml v1.3.0 + libmatroska v1.4.1 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: creation_time : 2014-07-08 22:15:43 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: Duration: 00:00:29.75, start: 0.000000, bitrate: 27288 kb/s 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: Stream #0:0: Video: h264 (High), yuv420p(tv, bt709), 1920x1080 [SAR 1:1 DAR 16:9], 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc (default) 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: Metadata: 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: BPS : 23874972 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: BPS-eng : 23874972 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: DURATION : 00:00:29.738000000 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: DURATION-eng : 00:00:29.738000000 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: NUMBER_OF_FRAMES: 713 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: NUMBER_OF_FRAMES-eng: 713 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: NUMBER_OF_BYTES : 88749243 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: NUMBER_OF_BYTES-eng: 88749243 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: _STATISTICS_WRITING_APP: mkvmerge v7.0.0 ('Where We Going') 64bit built on Jun 9 2014 15:16:27 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: _STATISTICS_WRITING_APP-eng: mkvmerge v7.0.0 ('Where We Going') 64bit built on Jun 9 2014 15:16:27 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: _STATISTICS_WRITING_DATE_UTC: 2014-07-08 22:15:43 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: _STATISTICS_WRITING_DATE_UTC-eng: 2014-07-08 22:15:43 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: _STATISTICS_TAGS-eng: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: Stream #0:1(eng): Audio: dts (DTS-HD MA), 48000 Hz, 5.1(side), fltp, 1536 kb/s (default) 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: Metadata: 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: BPS : 3414756 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: BPS-eng : 3414756 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: DURATION : 00:00:29.740000000 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: DURATION-eng : 00:00:29.740000000 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: NUMBER_OF_FRAMES: 2787 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: NUMBER_OF_FRAMES-eng: 2787 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: NUMBER_OF_BYTES : 12694356 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: NUMBER_OF_BYTES-eng: 12694356 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: _STATISTICS_WRITING_APP: mkvmerge v7.0.0 ('Where We Going') 64bit built on Jun 9 2014 15:16:27 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: _STATISTICS_WRITING_APP-eng: mkvmerge v7.0.0 ('Where We Going') 64bit built on Jun 9 2014 15:16:27 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: _STATISTICS_WRITING_DATE_UTC: 2014-07-08 22:15:43 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: _STATISTICS_WRITING_DATE_UTC-eng: 2014-07-08 22:15:43 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES 23:41:14 T:140684531066624 INFO: ffmpeg[7FF3AB7FE700]: _STATISTICS_TAGS-eng: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES 23:41:14 T:140684531066624 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 23:41:14 T:140684531066624 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 23:41:14 T:140684531066624 NOTICE: Opening stream: 0 source: 256 23:41:14 T:140684531066624 NOTICE: Creating video codec with codec id: 28 23:41:14 T:140684531066624 DEBUG: CDVDFactoryCodec: compiled in hardware support: AMCodec:no MediaCodec:no OpenMax:no libstagefright:no VDPAU:yes VAAPI:yes iMXVPU:no 23:41:14 T:140684531066624 DEBUG: FactoryCodec - Video: - Opening 23:41:14 T:140684531066624 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 23:41:14 T:140684531066624 DEBUG: FactoryCodec - Video: ff-h264 - Opened 23:41:14 T:140684531066624 NOTICE: Creating video thread 23:41:14 T:140684531066624 NOTICE: Opening stream: 1 source: 256 23:41:14 T:140684531066624 NOTICE: Finding audio codec for: 86020 23:41:14 T:140684503738112 NOTICE: Thread DVDPlayerVideo start, auto delete: false 23:41:14 T:140684503738112 NOTICE: running thread: video_thread 23:41:14 T:140684531066624 DEBUG: FactoryCodec - Audio: passthrough - Opening 23:41:14 T:140684531066624 DEBUG: FactoryCodec - Audio: passthrough - Failed 23:41:14 T:140684531066624 DEBUG: FactoryCodec - Audio: FFmpeg - Opening 23:41:14 T:140684531066624 DEBUG: FactoryCodec - Audio: FFmpeg - Opened 23:41:14 T:140684531066624 NOTICE: Creating audio thread 23:41:14 T:140684503738112 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 23:41:14 T:140684531066624 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: /media/knut/Data1/videos/Joe_sample.mkv 23:41:14 T:140684495345408 NOTICE: Thread DVDPlayerAudio start, auto delete: false 23:41:14 T:140684495345408 NOTICE: running thread: CDVDPlayerAudio::Process() 23:41:14 T:140684495345408 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 23:41:14 T:140684531066624 DEBUG: OnPlayBackStarted: play state was 1, starting 1 23:41:14 T:140684531066624 DEBUG: CDVDPlayer::SetCaching - caching state 3 23:41:14 T:140685861042112 DEBUG: PlayFile: OpenFile succeed, play state 2 23:41:14 T:140685861042112 DEBUG: OnPlayBackStarted: play state was 2, starting 0 23:41:14 T:140684503738112 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 23:41:14 T:140684495345408 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(5000.000000, 1) 23:41:14 T:140684495345408 NOTICE: Creating audio stream (codec id: 86020, channels: 6, sample rate: 48000, no pass-through) 23:41:14 T:140684495345408 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback 23:41:14 T:140685861042112 DEBUG: CGUIInfoManager::SetCurrentMovie(/media/knut/Data1/videos/Joe_sample.mkv) 23:41:14 T:140685861042112 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 23:41:14 T:140685861042112 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 23:41:14 T:140685454026496 INFO: CActiveAESink::OpenSink - initialize sink 23:41:14 T:140685454026496 DEBUG: CActiveAESink::OpenSink - trying to open device PULSE:Default 23:41:14 T:140685454026496 DEBUG: PulseAudio: Context authorizing 23:41:14 T:140685454026496 DEBUG: PulseAudio: Context setting name 23:41:14 T:140685454026496 DEBUG: PulseAudio: Context ready 23:41:14 T:140685454026496 DEBUG: PULSE does not support format: AE_FMT_FLOATP - will fallback to AE_FMT_FLOAT 23:41:14 T:140685454026496 DEBUG: PulseAudio: Stream ready 23:41:14 T:140685454026496 NOTICE: PulseAudio: Opened device Default in pcm mode with Buffersize 150 ms 23:41:14 T:140685454026496 DEBUG: CActiveAESink::OpenSink - PULSE Initialized: 23:41:14 T:140685454026496 DEBUG: Output Device : Default 23:41:14 T:140685454026496 DEBUG: Sample Rate : 48000 23:41:14 T:140685454026496 DEBUG: Sample Format : AE_FMT_FLOAT 23:41:14 T:140685454026496 DEBUG: Channel Count : 2 23:41:14 T:140685454026496 DEBUG: Channel Layout: FL,FR 23:41:14 T:140685454026496 DEBUG: Frames : 2400 23:41:14 T:140685454026496 DEBUG: Frame Samples : 4800 23:41:14 T:140685454026496 DEBUG: Frame Size : 8 23:41:14 T:140685395212032 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 23:41:14 T:140684531066624 DEBUG: Previous line repeats 1 times. 23:41:14 T:140684531066624 DEBUG: CDVDPlayer::HandleMessages - player started 1 23:41:14 T:140684271023872 NOTICE: Thread Vaapi-Output start, auto delete: false 23:41:14 T:140684271023872 NOTICE: COutput::OnStartup: Output Thread created 23:41:14 T:140684271023872 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libsse4-x86_64-linux.so) 23:41:14 T:140684271023872 DEBUG: Loading: /usr/lib/kodi/system/libsse4-x86_64-linux.so 23:41:14 T:140684246882048 NOTICE: Thread Vaapi-Output start, auto delete: false 23:41:14 T:140684246882048 NOTICE: COutput::OnStartup: Output Thread created 23:41:14 T:140684503738112 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(125000.000000, 0) 23:41:14 T:140684503738112 INFO: ffmpeg[7FF3A9DEE700]: [h264] Cannot parallelize slice decoding with deblocking filter type 1, decoding such frames in sequential order 23:41:14 T:140684503738112 INFO: ffmpeg[7FF3A9DEE700]: [h264] To parallelize slice decoding you need video encoded with disable_deblocking_filter_idc set to 2 (deblock only edges that do not cross slices). 23:41:14 T:140684503738112 INFO: ffmpeg[7FF3A9DEE700]: [h264] Setting the flags2 libavcodec option to +fast (-flags2 +fast) will disable deblocking across slices and enable parallel slice decoding but will generate non-standard-compliant output. 23:41:14 T:140684503738112 NOTICE: VAAPI::Close 23:41:14 T:140684271023872 NOTICE: COutput::OnExit: Output Thread terminated 23:41:14 T:140684271023872 DEBUG: Thread Vaapi-Output 140684271023872 terminating 23:41:14 T:140684503738112 NOTICE: fps: 23.976024, pwidth: 1920, pheight: 1080, dwidth: 1920, dheight: 1080 23:41:14 T:140684503738112 DEBUG: OutputPicture - change configuration. 1920x1080. framerate: 23.98. format: VAAPI 23:41:14 T:140684503738112 NOTICE: Display resolution DESKTOP : 1920x1200@ 59.95 - Full Screen (16) 23:41:14 T:140684503738112 DEBUG: CXBMCRenderManager::Configure - 4 23:41:14 T:140685861042112 NOTICE: Using GL_TEXTURE_2D 23:41:14 T:140685861042112 NOTICE: GL: Using VAAPI render method 23:41:14 T:140685861042112 NOTICE: GL: NPOT texture support detected 23:41:14 T:140685861042112 NOTICE: GL: Using GL_ARB_pixel_buffer_object 23:41:14 T:140685861042112 DEBUG: Activating window ID: 12005 23:41:14 T:140685861042112 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 23:41:14 T:140685861042112 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 23:41:14 T:140685861042112 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY 23:41:14 T:140684531066624 DEBUG: CDVDPlayer::HandleMessages - player started 2 23:41:14 T:140684531066624 DEBUG: CDVDPlayer::SetCaching - caching state 0 23:41:14 T:140685861042112 DEBUG: GL: Vertex Shader compilation log: 23:41:14 T:140685861042112 DEBUG: GL: Vertex Shader compiled successfully 23:41:14 T:140685861042112 DEBUG: GL: Pixel Shader compilation log: 23:41:14 T:140685861042112 DEBUG: GL: Fragment Shader compiled successfully 23:41:14 T:140684495345408 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError1 - was:12401.973000, should be:15666.666667, error:3264.693667 23:41:15 T:140684495345408 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError1 - was:141633.137667, should be:15666.666667, error:-125966.471000 23:41:15 T:140685861042112 INFO: Python, unloading python shared library because no scripts are running anymore 23:41:15 T:140685861042112 DEBUG: UnloadExtensionLibs, clearing python extension libraries 23:41:16 T:140685861042112 DEBUG: Keyboard: scancode: 0x09, sym: 0x001b, unicode: 0x001b, modifier: 0x0 23:41:16 T:140685861042112 DEBUG: OnKey: escape (0xf01b) pressed, action is Fullscreen 23:41:16 T:140685861042112 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 23:41:16 T:140685861042112 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 23:41:16 T:140685861042112 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 23:41:16 T:140685861042112 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 23:41:16 T:140685861042112 DEBUG: CGUIMediaWindow::GetDirectory (/media/knut/Data1/videos/) 23:41:16 T:140685861042112 DEBUG: ParentPath = [/media/knut/Data1/videos/] 23:41:16 T:140684271023872 NOTICE: Thread BackgroundLoader start, auto delete: false 23:41:16 T:140685861042112 DEBUG: GL: Vertex Shader compilation log: 23:41:16 T:140685861042112 DEBUG: GL: Vertex Shader compiled successfully 23:41:16 T:140685861042112 DEBUG: GL: Pixel Shader compilation log: 23:41:16 T:140685861042112 DEBUG: GL: Fragment Shader compiled successfully 23:41:16 T:140684271023872 DEBUG: Thread BackgroundLoader 140684271023872 terminating 23:41:17 T:140684495345408 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:2016265.599667, should be:1973236.153158, error:-43029.446509 23:41:17 T:140685861042112 DEBUG: Keyboard: scancode: 0x71, sym: 0x0114, unicode: 0x0000, modifier: 0x0 23:41:17 T:140685861042112 DEBUG: OnKey: left (0xf082) pressed, action is Left 23:41:18 T:140685861042112 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 23:41:18 T:140685861042112 DEBUG: OnKey: up (0xf080) pressed, action is Up 23:41:19 T:140684503738112 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer 23:41:20 T:140684503738112 WARNING: Previous line repeats 22 times. 23:41:20 T:140684503738112 DEBUG: CPullupCorrection: detected pattern of length 1: 41708.33, frameduration: 41708.333333 23:41:20 T:140684503738112 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer 23:41:44 T:140684495345408 WARNING: Previous line repeats 562 times. 23:41:44 T:140684495345408 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_EOF 23:41:44 T:140684495345408 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available 23:41:44 T:140684503738112 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer 23:41:45 T:140684503738112 WARNING: Previous line repeats 23 times. 23:41:45 T:140684503738112 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available 23:41:45 T:140684531066624 NOTICE: CDVDPlayer::OnExit() 23:41:45 T:140684531066624 NOTICE: DVDPlayer: eof, waiting for queues to empty 23:41:45 T:140684531066624 NOTICE: Closing stream player 1 23:41:45 T:140684531066624 NOTICE: CDVDMessageQueue(audio)::WaitUntilEmpty 23:41:45 T:140684495345408 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 23:41:45 T:140684531066624 NOTICE: Waiting for audio thread to exit 23:41:45 T:140684495345408 DEBUG: CDVDPlayerAudio::Process - Abort received, exiting thread 23:41:45 T:140684495345408 NOTICE: thread end: CDVDPlayerAudio::OnExit() 23:41:45 T:140684531066624 NOTICE: Closing audio device 23:41:45 T:140684495345408 DEBUG: Thread DVDPlayerAudio 140684495345408 terminating 23:41:45 T:140684531066624 NOTICE: Deleting audio codec 23:41:45 T:140685395212032 DEBUG: CActiveAE::DiscardStream - audio stream deleted 23:41:45 T:140684531066624 NOTICE: Closing stream player 2 23:41:45 T:140684531066624 NOTICE: CDVDMessageQueue(video)::WaitUntilEmpty 23:41:45 T:140685395212032 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 23:41:45 T:140684503738112 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 23:41:45 T:140684503738112 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true 23:41:45 T:140684503738112 NOTICE: thread end: video_thread 23:41:45 T:140684531066624 NOTICE: waiting for video thread to exit 23:41:45 T:140684531066624 NOTICE: deleting video codec 23:41:45 T:140684503738112 DEBUG: Thread DVDPlayerVideo 140684503738112 terminating 23:41:45 T:140685395212032 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 23:41:45 T:140685454026496 INFO: CActiveAESink::OpenSink - initialize sink 23:41:45 T:140685454026496 DEBUG: CActiveAESink::OpenSink - trying to open device PULSE:Default 23:41:46 T:140685064742656 DEBUG: Thread JobWorker 140685064742656 terminating (autodelete) 23:41:46 T:140685038614272 DEBUG: Thread JobWorker 140685038614272 terminating (autodelete) 23:41:47 T:140684531066624 ERROR: VAAPI::Release - pre-cleanup timed out 23:41:47 T:140684531066624 DEBUG: OnPlayBackEnded: play state was 2, starting 0 23:41:47 T:140684531066624 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 23:41:47 T:140684531066624 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 23:41:47 T:140684531066624 DEBUG: Thread DVDPlayer 140684531066624 terminating 23:41:50 T:140685395212032 ERROR: ActiveAE::InitSink - failed to init 23:41:50 T:140685454026496 DEBUG: PulseAudio: Context authorizing 23:41:50 T:140685454026496 DEBUG: PulseAudio: Context setting name 23:41:50 T:140685454026496 DEBUG: PulseAudio: Context ready 23:41:50 T:140685454026496 DEBUG: PulseAudio: Stream ready 23:41:50 T:140685454026496 NOTICE: PulseAudio: Opened device Default in pcm mode with Buffersize 150 ms 23:41:50 T:140685454026496 DEBUG: CActiveAESink::OpenSink - PULSE Initialized: 23:41:50 T:140685454026496 DEBUG: Output Device : Default 23:41:50 T:140685454026496 DEBUG: Sample Rate : 44100 23:41:50 T:140685454026496 DEBUG: Sample Format : AE_FMT_FLOAT 23:41:50 T:140685454026496 DEBUG: Channel Count : 2 23:41:50 T:140685454026496 DEBUG: Channel Layout: FL,FR 23:41:50 T:140685454026496 DEBUG: Frames : 2205 23:41:50 T:140685454026496 DEBUG: Frame Samples : 4410 23:41:50 T:140685454026496 DEBUG: Frame Size : 8