Kodi Community Forum

Kodi Community Forum > Support > General Support > Linux > Blu-Ray playback from *.iso files does not work
Full Version: Blu-Ray playback from *.iso files does not work
You're currently viewing a stripped down version of our content. View the full version with proper formatting.

coper2

2015-01-30, 01:34
Hi all,

I'm running the latest Kodi version (built a few hours ago) on my debian system and cannot start blu-ray discs saved as iso image files.

I have already tried the following steps :

- manually mounting the *.iso file to a local folder --> playback is running quite fine.
- upgrading the linux distribution to get the current libbluray1 version 0.6.2
- checking log files : it seems the internal DVDPlayer only tries to play the file as DVD, not as Blu-Ray

This is the corresponding part of the log file :

Quote:00:27:27 T:139960720004864 NOTICE: Creating InputStream
00:27:27 T:139960720004864 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/libdvdnav-x86_64-linux.so)
00:27:27 T:139960720004864 DEBUG: Loading: /media/320aa26a-bffc-48ea-b295-0b235d42d98f/kodi/xbmc/system/players/dvdplayer/libdvdnav-x86_64-linux.so
00:27:27 T:139960720004864 INFO: msg: libdvdnav: Using dvdnav version 4.2.1
00:27:27 T:139960720004864 INFO: msg: libdvdnavBig GrinVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.IFO failed
00:27:27 T:139960720004864 INFO: msg: libdvdnavBig GrinVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.BUP failed
00:27:27 T:139960720004864 DEBUG: libdvdread: Can't open file VIDEO_TS.IFO.
00:27:27 T:139960720004864 DEBUG: libdvdnav: vm: failed to read VIDEO_TS.IFO
00:27:27 T:139960720004864 ERROR: Error on dvdnav_open
00:27:27 T:139960720004864 ERROR: CDVDPlayer::OpenInputStream - error opening [/mnt/Media/Video/Dokumentationen/Natur + Landschaften/ifpd-insiderschottland-bluray.iso]
00:27:27 T:139960720004864 NOTICE: CDVDPlayer::OnExit()
00:27:27 T:139960720004864 DEBUG: OnPlayBackStopped: play state was 1, starting 1


Does anybody know what's wrong? Is a library missing or do I need to enable a specific feature during build configuration?

Many thanks!
Stefan

nickr

2015-01-30, 07:32
My understanding is that blurays DO need to be mounted, so "manually mounting the *.iso file to a local folder --> playback is running quite fine." seems correct.

fritsch

2015-01-30, 09:39
Remove the "+" just for fun from the path and post a complete Debug Log, please.

coper2

2015-01-30, 21:37
I moved the iso file to "/mnt/Media/Video/test.iso", but I still have the same issue.

After enabling the debug logging, I got the following messages :

Code:
20:33:10 T:140164925695936   DEBUG: OnPlayMedia /mnt/Media/Video/test.iso
20:33:10 T:140164925695936   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
20:33:10 T:140164925695936   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
20:33:10 T:140164925695936   DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc
20:33:10 T:140164925695936   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd
20:33:10 T:140164925695936   DEBUG: Loading settings for /mnt/Media/Video/test.iso
20:33:10 T:140164925695936   DEBUG: CPlayerCoreFactory::GetPlayers(/mnt/Media/Video/test.iso)
20:33:10 T:140164925695936   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
20:33:10 T:140164925695936   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
20:33:10 T:140164925695936   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
20:33:10 T:140164925695936   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
20:33:10 T:140164925695936   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
20:33:10 T:140164925695936   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
20:33:10 T:140164925695936   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
20:33:10 T:140164925695936   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
20:33:10 T:140164925695936   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
20:33:10 T:140164925695936   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
20:33:10 T:140164925695936   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: dvdimage
20:33:10 T:140164925695936   DEBUG: CPlayerSelectionRule::GetPlayers: adding player: DVDPlayer (1) for rule: dvdimage
20:33:10 T:140164925695936   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
20:33:10 T:140164925695936   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
20:33:10 T:140164925695936   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
20:33:10 T:140164925695936   DEBUG: CPlayerCoreFactory::GetPlayers: matched 1 rules with players
20:33:10 T:140164925695936   DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
20:33:10 T:140164925695936   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
20:33:10 T:140164925695936   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
20:33:10 T:140164925695936   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
20:33:10 T:140164925695936   DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
20:33:10 T:140164925695936  NOTICE: DVDPlayer: Opening: /mnt/Media/Video/test.iso
20:33:10 T:140164925695936 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
20:33:10 T:140164925695936   DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
20:33:10 T:140164925695936   DEBUG: LinuxRendererGL: Cleaning up GL resources
20:33:10 T:140164925695936   DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16
20:33:10 T:140163630024448  NOTICE: Thread DVDPlayer start, auto delete: false
20:33:10 T:140163630024448  NOTICE: Creating InputStream
20:33:10 T:140163630024448   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/libdvdnav-x86_64-linux.so)
20:33:10 T:140163630024448   DEBUG: Loading: /usr/local/lib/kodi/system/players/dvdplayer/libdvdnav-x86_64-linux.so
20:33:10 T:140163630024448    INFO:   msg: libdvdnav: Using dvdnav version 4.2.1
20:33:10 T:140163630024448    INFO:   msg: libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.IFO failed
20:33:10 T:140163630024448    INFO:   msg: libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.BUP failed
20:33:10 T:140163630024448   DEBUG: libdvdread: Can't open file VIDEO_TS.IFO.
20:33:10 T:140163630024448   DEBUG: libdvdnav: vm: failed to read VIDEO_TS.IFO
20:33:10 T:140163630024448   ERROR: Error on dvdnav_open
20:33:10 T:140163630024448   ERROR: CDVDPlayer::OpenInputStream - error opening [/mnt/Media/Video/test.iso]
20:33:10 T:140163630024448  NOTICE: CDVDPlayer::OnExit()
20:33:10 T:140163630024448   DEBUG: OnPlayBackStopped: play state was 1, starting 1
20:33:10 T:140163630024448   DEBUG: Thread DVDPlayer 140163630024448 terminating
20:33:10 T:140164925695936   DEBUG: OnPlayBackStopped: play state was 3, starting 0
20:33:10 T:140164925695936   DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
20:33:10 T:140164925695936   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
20:33:10 T:140164925695936   ERROR: Playlist Player: skipping unplayable item: 0, path [/mnt/Media/Video/test.iso]
20:33:10 T:140164925695936   DEBUG: Playlist Player: one or more items failed to play... aborting playback

fritsch

2015-01-30, 22:04
Don't cut logfiles, please.

coper2

2015-02-01, 12:34
I'm sorry. I thought this is the interesing part for my issue.

Here is the complete debug logfile from starting kodi, selecting *.iso file and shutting down the media center.

Code:
11:16:44 T:139978535622592  NOTICE: special://profile/ is mapped to: special://masterprofile/
11:16:44 T:139978535622592  NOTICE: -----------------------------------------------------------------------
11:16:44 T:139978535622592  NOTICE: Starting Kodi (15.0-ALPHA1 Git:2015-01-29-2938b5a-dirty). Platform: Linux x86 64-bit
11:16:44 T:139978535622592  NOTICE: Using Debug Kodi x64 build
11:16:44 T:139978535622592  NOTICE: Kodi compiled Jan 29 2015 by GCC 4.7.2 for Linux x86 64-bit version 3.16.7 (200711)
11:16:44 T:139978535622592  NOTICE: Running on Debian GNU/Linux 8 (jessie), kernel: Linux x86 64-bit version 3.2.0-4-amd64
11:16:44 T:139978535622592  NOTICE: FFmpeg statically linked, version: 14.0rc3-Helix-810-g2938b5a-xbmc-2.5.2-Isengard-alpha
11:16:44 T:139978535622592  NOTICE: Host CPU: Intel(R) Atom(TM) CPU D510 @ 1.66GHz, 4 cores available
11:16:44 T:139978535622592  NOTICE: special://xbmc/ is mapped to: /usr/local/share/kodi
11:16:44 T:139978535622592  NOTICE: special://xbmcbin/ is mapped to: /usr/local/lib/kodi
11:16:44 T:139978535622592  NOTICE: special://masterprofile/ is mapped to: /home/xbmc/.kodi/userdata
11:16:44 T:139978535622592  NOTICE: special://home/ is mapped to: /home/xbmc/.kodi
11:16:44 T:139978535622592  NOTICE: special://temp/ is mapped to: /home/xbmc/.kodi/temp
11:16:44 T:139978535622592  NOTICE: The executable running is: /usr/local/lib/kodi/kodi.bin
11:16:44 T:139978535622592  NOTICE: Local hostname: Media-NAS
11:16:44 T:139978535622592  NOTICE: Log File is located: /home/xbmc/.kodi/temp/kodi.log
11:16:44 T:139978535622592  NOTICE: -----------------------------------------------------------------------
11:16:44 T:139978535622592    INFO: Selected UPower as PowerSyscall
11:16:44 T:139978535622592  NOTICE: load settings...
11:16:44 T:139978535622592   DEBUG: CSettings: loaded settings definition from special://xbmc/system/settings/settings.xml
11:16:44 T:139978535622592   DEBUG: CSettings: loaded settings definition from special://xbmc/system/settings/linux.xml
11:16:44 T:139978535622592   ERROR: PulseAudio: Failed to connect context
11:16:44 T:139978535622592  NOTICE: PulseAudio might not be running. Context was not created.
11:16:44 T:139978535622592   DEBUG: CAESinkALSA - HDMI device "hdmi:CARD=NVidia,DEV=0" may be unconnected (no ELD data)
11:16:44 T:139978535622592   DEBUG: CAESinkALSA - HDMI device "hdmi:CARD=NVidia,DEV=2" may be unconnected (no ELD data)
11:16:44 T:139978535622592   DEBUG: CAESinkALSA - HDMI device "hdmi:CARD=NVidia,DEV=3" may be unconnected (no ELD data)
11:16:44 T:139978535622592  NOTICE: Found 1 Lists of Devices
11:16:44 T:139978535622592  NOTICE: Enumerated ALSA devices:
11:16:44 T:139978535622592  NOTICE:     Device 1
11:16:44 T:139978535622592  NOTICE:         m_deviceName      : @
11:16:44 T:139978535622592  NOTICE:         m_displayName     : Default (HDA Intel ALC662 rev1 Analog)
11:16:44 T:139978535622592  NOTICE:         m_displayNameExtra:
11:16:44 T:139978535622592  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM
11:16:44 T:139978535622592  NOTICE:         m_channels        : FL,FR
11:16:44 T:139978535622592  NOTICE:         m_sampleRates     : 48000
11:16:44 T:139978535622592  NOTICE:         m_dataFormats     : AE_FMT_S32NE
11:16:44 T:139978535622592  NOTICE:     Device 2
11:16:44 T:139978535622592  NOTICE:         m_deviceName      : @:CARD=Intel,DEV=0
11:16:44 T:139978535622592  NOTICE:         m_displayName     : HDA Intel
11:16:44 T:139978535622592  NOTICE:         m_displayNameExtra: ALC662 rev1 Analog
11:16:44 T:139978535622592  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM
11:16:44 T:139978535622592  NOTICE:         m_channels        : FL,FR
11:16:44 T:139978535622592  NOTICE:         m_sampleRates     : 48000
11:16:44 T:139978535622592  NOTICE:         m_dataFormats     : AE_FMT_S32NE
11:16:44 T:139978535622592  NOTICE:     Device 3
11:16:44 T:139978535622592  NOTICE:         m_deviceName      : iec958:CARD=Intel,DEV=0
11:16:44 T:139978535622592  NOTICE:         m_displayName     : HDA Intel
11:16:44 T:139978535622592  NOTICE:         m_displayNameExtra: ALC662 rev1 Digital S/PDIF
11:16:44 T:139978535622592  NOTICE:         m_deviceType      : AE_DEVTYPE_IEC958
11:16:44 T:139978535622592  NOTICE:         m_channels        : FL,FR
11:16:44 T:139978535622592  NOTICE:         m_sampleRates     : 44100,48000,96000
11:16:44 T:139978535622592  NOTICE:         m_dataFormats     : AE_FMT_AC3,AE_FMT_DTS,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE
11:16:44 T:139978535622592  NOTICE:     Device 4
11:16:44 T:139978535622592  NOTICE:         m_deviceName      : hdmi:CARD=NVidia,DEV=0
11:16:44 T:139978535622592  NOTICE:         m_displayName     : HDA NVidia
11:16:44 T:139978535622592  NOTICE:         m_displayNameExtra: HDMI #0
11:16:44 T:139978535622592  NOTICE:         m_deviceType      : AE_DEVTYPE_HDMI
11:16:44 T:139978535622592  NOTICE:         m_channels        : FL,FR,BL,BR,FC,LFE,SL,SR
11:16:44 T:139978535622592  NOTICE:         m_sampleRates     : 32000,44100,48000,88200,96000,176400,192000
11:16:44 T:139978535622592  NOTICE:         m_dataFormats     : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_LPCM,AE_FMT_DTSHD,AE_FMT_TRUEHD,AE_FMT_EAC3,AE_FMT_DTS,AE_FMT_AC3,AE_FMT_AAC
11:16:44 T:139978535622592  NOTICE:     Device 5
11:16:44 T:139978535622592  NOTICE:         m_deviceName      : hdmi:CARD=NVidia,DEV=1
11:16:44 T:139978535622592  NOTICE:         m_displayName     : HDA NVidia
11:16:44 T:139978535622592  NOTICE:         m_displayNameExtra: MEI Panasonic-TV on HDMI #1
11:16:44 T:139978535622592  NOTICE:         m_deviceType      : AE_DEVTYPE_HDMI
11:16:44 T:139978535622592  NOTICE:         m_channels        : FL,FR
11:16:44 T:139978535622592  NOTICE:         m_sampleRates     : 32000,44100,48000
11:16:44 T:139978535622592  NOTICE:         m_dataFormats     : AE_FMT_LPCM,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_DTSHD,AE_FMT_TRUEHD,AE_FMT_EAC3,AE_FMT_DTS,AE_FMT_AC3,AE_FMT_AAC
11:16:44 T:139978535622592  NOTICE:     Device 6
11:16:44 T:139978535622592  NOTICE:         m_deviceName      : hdmi:CARD=NVidia,DEV=2
11:16:44 T:139978535622592  NOTICE:         m_displayName     : HDA NVidia
11:16:44 T:139978535622592  NOTICE:         m_displayNameExtra: HDMI #2
11:16:44 T:139978535622592  NOTICE:         m_deviceType      : AE_DEVTYPE_HDMI
11:16:44 T:139978535622592  NOTICE:         m_channels        : FL,FR,BL,BR,FC,LFE,SL,SR
11:16:44 T:139978535622592  NOTICE:         m_sampleRates     : 32000,44100,48000,88200,96000,176400,192000
11:16:44 T:139978535622592  NOTICE:         m_dataFormats     : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_LPCM,AE_FMT_DTSHD,AE_FMT_TRUEHD,AE_FMT_EAC3,AE_FMT_DTS,AE_FMT_AC3,AE_FMT_AAC
11:16:44 T:139978535622592  NOTICE:     Device 7
11:16:44 T:139978535622592  NOTICE:         m_deviceName      : hdmi:CARD=NVidia,DEV=3
11:16:44 T:139978535622592  NOTICE:         m_displayName     : HDA NVidia
11:16:44 T:139978535622592  NOTICE:         m_displayNameExtra: HDMI #3
11:16:44 T:139978535622592  NOTICE:         m_deviceType      : AE_DEVTYPE_HDMI
11:16:44 T:139978535622592  NOTICE:         m_channels        : FL,FR,BL,BR,FC,LFE,SL,SR
11:16:44 T:139978535622592  NOTICE:         m_sampleRates     : 32000,44100,48000,88200,96000,176400,192000
11:16:44 T:139978535622592  NOTICE:         m_dataFormats     : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_LPCM,AE_FMT_DTSHD,AE_FMT_TRUEHD,AE_FMT_EAC3,AE_FMT_DTS,AE_FMT_AC3,AE_FMT_AAC
11:16:44 T:139978535622592  NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml)
11:16:44 T:139978535622592  NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml)
11:16:44 T:139978535622592  NOTICE: Default DVD Player: dvdplayer
11:16:44 T:139978535622592  NOTICE: Default Video Player: dvdplayer
11:16:44 T:139978535622592  NOTICE: Default Audio Player: paplayer
11:16:44 T:139978535622592  NOTICE: Enabled debug logging due to GUI setting (2)
11:16:44 T:139978535622592  NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM"
11:16:44 T:139978535622592  NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml
11:16:44 T:139978535622592  NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
11:16:44 T:139978535622592   DEBUG: CPlayerCoreConfig::<ctor>: created player DVDPlayer for core 1
11:16:44 T:139978535622592   DEBUG: CPlayerCoreConfig::<ctor>: created player oldmplayercore for core 1
11:16:44 T:139978535622592   DEBUG: CPlayerCoreConfig::<ctor>: created player PAPlayer for core 3
11:16:44 T:139978535622592   DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules
11:16:44 T:139978535622592   DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtv
11:16:44 T:139978535622592   DEBUG: CPlayerSelectionRule::Initialize: creating rule: hdhomerun/myth/mms/udp
11:16:44 T:139978535622592   DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout
11:16:44 T:139978535622592   DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp
11:16:44 T:139978535622592   DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp
11:16:44 T:139978535622592   DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams
11:16:44 T:139978535622592   DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp
11:16:44 T:139978535622592   DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2
11:16:44 T:139978535622592   DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd
11:16:44 T:139978535622592   DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage
11:16:44 T:139978535622592   DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf
11:16:44 T:139978535622592   DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv
11:16:44 T:139978535622592   DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio
11:16:44 T:139978535622592  NOTICE: Loaded playercorefactory configuration
11:16:44 T:139978535622592  NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
11:16:44 T:139978535622592  NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
11:16:44 T:139978535622592    INFO: creating subdirectories
11:16:44 T:139978535622592    INFO: userdata folder: special://masterprofile/
11:16:44 T:139978535622592    INFO: recording folder:
11:16:44 T:139978535622592    INFO: screenshots folder:
11:16:44 T:139978535622592    INFO: load language info file: special://xbmc/language/German/langinfo.xml
11:16:44 T:139978535622592   DEBUG: trying to set locale to de_DE.UTF-8
11:16:44 T:139978535622592    INFO: global locale set to de_DE.UTF-8
11:16:44 T:139978535622592    INFO: load German language file, from path: special://xbmc/language/
11:16:44 T:139978535622592   DEBUG: POParser: loaded 3267 strings from file /usr/local/share/kodi/language/German/strings.po
11:16:44 T:139978535622592   DEBUG: POParser: id:19048 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead
11:16:44 T:139978535622592   DEBUG: POParser: loaded 21 strings from file /usr/local/share/kodi/language/English/strings.po
11:16:44 T:139978167334656  NOTICE: Thread ActiveAE start, auto delete: false
11:16:44 T:139978084448000  NOTICE: Thread AESink start, auto delete: false
11:16:44 T:139978084448000    INFO: CActiveAESink::OpenSink - initialize sink
11:16:44 T:139978084448000   DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:iec958:CARD=Intel,DEV=0
11:16:44 T:139978084448000    INFO: CAESinkALSA::Initialize - Attempting to open device "iec958:CARD=Intel,DEV=0"
11:16:44 T:139978084448000    INFO: CAESinkALSA::Initialize - Opened device "iec958:CARD=Intel,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00"
11:16:44 T:139978084448000    INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
11:16:44 T:139978084448000    INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
11:16:44 T:139978084448000   DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2048, bufferSize 8192
11:16:44 T:139978084448000   DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2048, bufferSize 8192
11:16:44 T:139978084448000   DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 186 ms
11:16:44 T:139978084448000   DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
11:16:44 T:139978084448000   DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
11:16:44 T:139978084448000   DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: none)
11:16:44 T:139978084448000   DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
11:16:44 T:139978084448000   DEBUG:   Output Device : HDA Intel
11:16:44 T:139978084448000   DEBUG:   Sample Rate   : 44100
11:16:44 T:139978084448000   DEBUG:   Sample Format : AE_FMT_S32NE
11:16:44 T:139978084448000   DEBUG:   Channel Count : 2
11:16:44 T:139978084448000   DEBUG:   Channel Layout: FL,FR
11:16:44 T:139978084448000   DEBUG:   Frames        : 2048
11:16:44 T:139978084448000   DEBUG:   Frame Samples : 4096
11:16:44 T:139978084448000   DEBUG:   Frame Size    : 8
11:16:44 T:139978535622592  NOTICE: Running database version Addons16
11:16:44 T:139978535622592   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcpluff-x86_64-linux.so)
11:16:44 T:139978535622592   DEBUG: Loading: /usr/local/lib/kodi/system/libcpluff-x86_64-linux.so
11:16:44 T:139978535622592    INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/local/lib/kodi/addons: No such file or directory'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in script.module.pyamf has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.dokumonster has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.albums.allmusic.com has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.itunes_trailers has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in visualization.fishbmc has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.euphoria has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in visualization.vortex has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.wma has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in visualization.projectm has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in weather.wunderground has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in script.module.simplejson has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.allmusic.com has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in service.xbmc.versioncheck has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in skin.confluence has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in visualization.glspectrum has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in script.module.beautifulsoup has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.amazon.de has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in script.common.plugin.cache has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.musicvideos.theaudiodb.com has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in script.module.simple.downloader has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.hdtrailers_net has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.youtube has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.solarwinds has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in script.module.requests has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.trailerseite_de has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.aac has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.zdf_de_lite has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.local has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.last.fm has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in script.module.parsedom has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in script.module.xbmcswift2 has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in visualization.waveform has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.plasma has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.enigmatv has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in xbmc.codec has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.hdtrailers.net has been installed.'
11:16:44 T:139978535622592   DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.'
11:16:44 T:139978535622592  NOTICE: ADDONS: Using repository repository.xbmc.org
11:16:44 T:139978535622592    INFO: LIRC Initialize: using: /dev/lircd
11:16:44 T:139978535622592    INFO: LIRC Initialize: connect failed: No such file or directory
11:16:44 T:139978535622592   DEBUG: Failed to connect to LIRC. Retry in 10s.
11:16:44 T:139978535622592   DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid"
11:16:44 T:139978535622592   DEBUG: LoadMappings - loaded node "CEC Adapter"
11:16:44 T:139978535622592   DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter"
11:16:44 T:139978535622592   DEBUG: LoadMappings - loaded node "iMON HID device"
11:16:44 T:139978535622592   DEBUG: CPeripheralBusUSB - initialised udev monitor
11:16:44 T:139978535622592   DEBUG: SECTION:LoadDLL(libcec.so.2)
11:16:44 T:139978535622592   DEBUG: Loading: libcec.so.2
11:16:45 T:139978535622592   DEBUG: GetMappingForDevice - device (2548:1002) mapped to CEC Adapter (type = cec)
11:16:45 T:139978535622592   DEBUG: InitialiseFeature - using libCEC v2.2.0
11:16:45 T:139978535622592   DEBUG: Initialise - initialised peripheral on '/dev/ttyACM0' with 2 features and 0 sub devices
11:16:45 T:139978535622592  NOTICE: Register - new cec device registered on cec->/dev/ttyACM0: CEC Adapter (2548:1002)
11:16:45 T:139978076055296  NOTICE: Thread CECAdapter start, auto delete: false
11:16:45 T:139978076055296   DEBUG: OpenConnection - opening a connection to the CEC adapter: /dev/ttyACM0
11:16:45 T:139978067662592  NOTICE: Thread PeripBusCEC start, auto delete: false
11:16:45 T:139978535622592   DEBUG: GetMappingForDevice - device (2548:1002) mapped to Pulse-Eight CEC Adapter (type = cec)
11:16:45 T:139977799227136  NOTICE: Thread PeripBusUSBUdev start, auto delete: false
11:16:45 T:139978535622592   DEBUG: Selected UDisks as storage provider
11:16:45 T:139978535622592   DEBUG: UDisks: DaemonVersion 1
11:16:45 T:139978535622592   DEBUG: UDisks: Querying available devices
11:16:45 T:139978535622592   DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sdc2: IsFileSystem true HasFileSystem ext4 IsSystemInternal false IsMounted true IsRemovable false IsPartition true IsOptical false
11:16:45 T:139978535622592    INFO: UDisks: Added /media/8011a3fc-48e7-474c-bb66-716aa9b59367
11:16:45 T:139978535622592   DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sdc3: IsFileSystem true HasFileSystem ext4 IsSystemInternal false IsMounted true IsRemovable false IsPartition true IsOptical false
11:16:45 T:139978535622592    INFO: UDisks: Added /media/320aa26a-bffc-48ea-b295-0b235d42d98f
11:16:45 T:139978535622592   DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sdb1: IsFileSystem false HasFileSystem  IsSystemInternal true IsMounted false IsRemovable false IsPartition true IsOptical false
11:16:45 T:139978535622592   DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sda: IsFileSystem false HasFileSystem  IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false
11:16:45 T:139978535622592   DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sda1: IsFileSystem false HasFileSystem  IsSystemInternal true IsMounted false IsRemovable false IsPartition true IsOptical false
11:16:45 T:139978535622592   DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/md0: IsFileSystem false HasFileSystem  IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false
11:16:45 T:139978535622592   DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sde1: IsFileSystem false HasFileSystem  IsSystemInternal true IsMounted false IsRemovable false IsPartition true IsOptical false
11:16:45 T:139978535622592   DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sdd: IsFileSystem false HasFileSystem  IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false
11:16:45 T:139978535622592   DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/dm_2d0: IsFileSystem false HasFileSystem  IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false
11:16:45 T:139977799227136   DEBUG: GetMappingForDevice - device (2548:1002) mapped to Pulse-Eight CEC Adapter (type = cec)
11:16:45 T:139978535622592   DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/dm_2d1: IsFileSystem true HasFileSystem ext4 IsSystemInternal true IsMounted true IsRemovable false IsPartition false IsOptical false
11:16:45 T:139978535622592    INFO: UDisks: Added /mnt/Media
11:16:45 T:139978535622592   DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sdc: IsFileSystem false HasFileSystem  IsSystemInternal false IsMounted false IsRemovable false IsPartition false IsOptical false
11:16:45 T:139978535622592   DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sde: IsFileSystem false HasFileSystem  IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false
11:16:45 T:139978535622592   DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sdb: IsFileSystem false HasFileSystem  IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false
11:16:45 T:139978535622592   DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sdf1: IsFileSystem false HasFileSystem  IsSystemInternal true IsMounted false IsRemovable false IsPartition true IsOptical false
11:16:45 T:139978535622592   DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sdf: IsFileSystem false HasFileSystem  IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false
11:16:45 T:139978535622592   DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sdd1: IsFileSystem false HasFileSystem  IsSystemInternal true IsMounted false IsRemovable false IsPartition true IsOptical false
11:16:45 T:139978535622592   DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sdc1: IsFileSystem true HasFileSystem ext4 IsSystemInternal false IsMounted true IsRemovable false IsPartition true IsOptical false
11:16:45 T:139978535622592  NOTICE: Setup SDL
11:16:45 T:139978535622592    INFO: Available videomodes (xrandr):
11:16:45 T:139978535622592    INFO: Output 'HDMI-0' has 15 modes
11:16:45 T:139978535622592    INFO: ID:0x1c7 Name:1920x1080 Refresh:50.000000 Width:1920 Height:1080
11:16:45 T:139978535622592    INFO: Pixel Ratio: 1.001594
11:16:45 T:139978535622592    INFO: ID:0x1c8 Name:1920x1080 Refresh:60.000000 Width:1920 Height:1080
11:16:45 T:139978535622592    INFO: Pixel Ratio: 1.001594
11:16:45 T:139978535622592    INFO: ID:0x1c9 Name:1920x1080 Refresh:59.939388 Width:1920 Height:1080
11:16:45 T:139978535622592    INFO: Pixel Ratio: 1.001594
11:16:45 T:139978535622592    INFO: ID:0x1ca Name:1920x1080 Refresh:23.970909 Width:1920 Height:1080
11:16:45 T:139978535622592    INFO: Pixel Ratio: 1.001594
11:16:45 T:139978535622592    INFO: ID:0x1cb Name:1920x1080 Refresh:30.026690 Width:1920 Height:1080
11:16:45 T:139978535622592    INFO: Pixel Ratio: 1.001594
11:16:45 T:139978535622592    INFO: ID:0x1cc Name:1920x1080 Refresh:29.998381 Width:1920 Height:1080
11:16:45 T:139978535622592    INFO: Pixel Ratio: 1.001594
11:16:45 T:139978535622592    INFO: ID:0x1cd Name:1920x1080 Refresh:25.022240 Width:1920 Height:1080
11:16:45 T:139978535622592    INFO: Pixel Ratio: 1.001594
11:16:45 T:139978535622592    INFO: ID:0x1ce Name:1280x720 Refresh:60.000000 Width:1280 Height:720
11:16:45 T:139978535622592    INFO: Pixel Ratio: 1.001594
11:16:45 T:139978535622592    INFO: ID:0x1cf Name:1280x720 Refresh:59.943432 Width:1280 Height:720
11:16:45 T:139978535622592    INFO: Pixel Ratio: 1.001594
11:16:45 T:139978535622592    INFO: ID:0x1d0 Name:1280x720 Refresh:50.000000 Width:1280 Height:720
11:16:45 T:139978535622592    INFO: Pixel Ratio: 1.001594
11:16:45 T:139978535622592    INFO: ID:0x1d1 Name:720x576 Refresh:50.000000 Width:720 Height:576
11:16:45 T:139978535622592    INFO: Pixel Ratio: 1.424490
11:16:45 T:139978535622592    INFO: ID:0x1d2 Name:720x576 Refresh:25.040060 Width:720 Height:576
11:16:45 T:139978535622592    INFO: Pixel Ratio: 1.424490
11:16:45 T:139978535622592    INFO: ID:0x1d3 Name:720x480 Refresh:59.940060 Width:720 Height:480
11:16:45 T:139978535622592    INFO: Pixel Ratio: 1.187075
11:16:45 T:139978535622592    INFO: ID:0x1d4 Name:720x480 Refresh:30.027220 Width:720 Height:480
11:16:45 T:139978535622592    INFO: Pixel Ratio: 1.187075
11:16:45 T:139978535622592    INFO: ID:0x1d5 Name:640x480 Refresh:59.928570 Width:640 Height:480
11:16:45 T:139978535622592    INFO: Pixel Ratio: 1.335459
11:16:45 T:139978535622592  NOTICE: Checking resolution 16
11:16:45 T:139978535622592   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib-x86_64-linux.so)
11:16:45 T:139978535622592   DEBUG: Loading: /usr/local/lib/kodi/system/ImageLib-x86_64-linux.so
11:16:45 T:139978535622592  NOTICE: Using visual 0x27
11:16:45 T:139978535622592    INFO: GL: Maximum texture width: 8192
11:16:45 T:139978535622592   DEBUG: GLX_EXTENSIONS: GLX_EXT_visual_info GLX_EXT_visual_rating GLX_SGIX_fbconfig GLX_SGIX_pbuffer GLX_SGI_video_sync GLX_SGI_swap_control GLX_EXT_swap_control GLX_EXT_swap_control_tear GLX_EXT_texture_from_pixmap GLX_ARB_create_context GLX_ARB_create_context_profile GLX_EXT_create_context_es2_profile GLX_ARB_create_context_robustness GLX_ARB_multisample GLX_NV_float_buffer GLX_ARB_fbconfig_float GLX_EXT_framebuffer_sRGB GLX_NV_multisample_coverage GLX_ARB_get_proc_address
11:16:45 T:139978535622592  NOTICE: GL_VENDOR = NVIDIA Corporation
11:16:45 T:139978535622592  NOTICE: GL_RENDERER = ION/PCIe/SSE2
11:16:45 T:139978535622592  NOTICE: GL_VERSION = 3.3.0 NVIDIA 304.125
11:16:45 T:139978535622592  NOTICE: GL_SHADING_LANGUAGE_VERSION = 3.30 NVIDIA via Cg compiler
11:16:45 T:139978535622592  NOTICE: GL_GPU_MEMORY_INFO_TOTAL_AVAILABLE_MEMORY_NVX = 524288
11:16:45 T:139978535622592  NOTICE: GL_GPU_MEMORY_INFO_DEDICATED_VIDMEM_NVX = 524288
11:16:45 T:139978535622592  NOTICE: GL_EXTENSIONS = GL_ARB_base_instance GL_ARB_blend_func_extended GL_ARB_color_buffer_float GL_ARB_compatibility GL_ARB_compressed_texture_pixel_storage GL_ARB_conservative_depth GL_ARB_copy_buffer GL_ARB_depth_buffer_float GL_ARB_depth_clamp GL_ARB_depth_texture GL_ARB_draw_buffers GL_ARB_draw_buffers_blend GL_ARB_draw_elements_base_vertex GL_ARB_draw_instanced GL_ARB_ES2_compatibility GL_ARB_explicit_attrib_location GL_ARB_fragment_coord_conventions GL_ARB_fragment_program GL_ARB_fragment_program_shadow GL_ARB_fragment_shader GL_ARB_framebuffer_object GL_ARB_framebuffer_sRGB GL_ARB_geometry_shader4 GL_ARB_get_program_binary GL_ARB_half_float_pixel GL_ARB_half_float_vertex GL_ARB_imaging GL_ARB_instanced_arrays GL_ARB_internalformat_query GL_ARB_map_buffer_alignment GL_ARB_map_buffer_range GL_ARB_multisample GL_ARB_multitexture GL_ARB_occlusion_query GL_ARB_occlusion_query2 GL_ARB_pixel_buffer_object GL_ARB_point_parameters GL_ARB_point_sprite GL_ARB_provoking_vertex GL_ARB_robustness GL_ARB_sample_shading GL_ARB_sampler_objects GL_ARB_seamless_cube_map GL_ARB_separate_shader_objects GL_ARB_shader_bit_encoding GL_ARB_shader_objects GL_ARB_shader_texture_lod GL_ARB_shading_language_100 GL_ARB_shading_language_420pack GL_ARB_shading_language_include GL_ARB_shading_language_packing GL_ARB_shadow GL_ARB_sync GL_ARB_texture_border_clamp GL_ARB_texture_buffer_object GL_ARB_texture_compression GL_ARB_texture_compression_rgtc GL_ARB_texture_cube_map GL_ARB_texture_cube_map_array GL_ARB_texture_env_add GL_ARB_texture_env_combine GL_ARB_texture_env_crossbar GL_ARB_texture_env_dot3 GL_ARB_texture_float GL_ARB_texture_gather GL_ARB_texture_mirrored_repeat GL_ARB_texture_multisample GL_ARB_texture_non_power_of_two GL_ARB_texture_query_lod GL_ARB_texture_rectangle GL_ARB_texture_rg GL_ARB_texture_rgb10_a2ui GL_ARB_texture_storage GL_ARB_texture_swizzle GL_ARB_timer_query GL_ARB_transform_feedback2 GL_ARB_transform_feedback_instanced GL_ARB_transpose_matrix GL_ARB_uniform_buffer_object GL_ARB_vertex_array_bgra GL_ARB_vertex_array_object GL_ARB_vertex_buffer_object GL_ARB_vertex_program GL_ARB_vertex_shader GL_ARB_vertex_type_2_10_10_10_rev GL_ARB_viewport_array GL_ARB_window_pos GL_ATI_draw_buffers GL_ATI_texture_float GL_ATI_texture_mirror_once GL_S3_s3tc GL_EXT_texture_env_add GL_EXT_abgr GL_EXT_bgra GL_EXT_bindable_uniform GL_EXT_blend_color GL_EXT_blend_equation_separate GL_EXT_blend_func_separate GL_EXT_blend_minmax GL_EXT_blend_subtract GL_EXT_compiled_vertex_array GL_EXT_Cg_shader GL_EXT_depth_bounds_test GL_EXT_direct_state_access GL_EXT_draw_buffers2 GL_EXT_draw_instanced GL_EXT_draw_range_elements GL_EXT_fog_coord GL_EXT_framebuffer_blit GL_EXT_framebuffer_multisample GL_EXTX_framebuffer_mixed_formats GL_EXT_framebuffer_object GL_EXT_framebuffer_sRGB GL_EXT_geometry_shader4 GL_EXT_gpu_program_parameters GL_EXT_gpu_shader4 GL_EXT_multi_draw_arrays GL_EXT_packed_depth_stencil GL_EXT_packed_float GL_EXT_packed_pixels GL_EXT_pixel_buffer_object GL_EXT_point_parameters GL_EXT_provoking_vertex GL_EXT_rescale_normal GL_EXT_secondary_color GL_EXT_separate_shader_objects GL_EXT_separate_specular_color GL_EXT_shadow_funcs GL_EXT_stencil_two_side GL_EXT_stencil_wrap GL_EXT_texture3D GL_EXT_texture_array GL_EXT_texture_buffer_object GL_EXT_texture_compression_dxt1 GL_EXT_texture_compression_latc GL_EXT_texture_compression_rgtc GL_EXT_texture_compression_s3tc GL_EXT_texture_cube_map GL_EXT_texture_edge_clamp GL_EXT_texture_env_combine GL_EXT_texture_env_dot3 GL_EXT_texture_filter_anisotropic GL_EXT_texture_format_BGRA8888 GL_EXT_texture_integer GL_EXT_texture_lod GL_EXT_texture_lod_bias GL_EXT_texture_mirror_clamp GL_EXT_texture_object GL_EXT_texture_shared_exponent GL_EXT_texture_sRGB GL_EXT_texture_sRGB_decode GL_EXT_texture_storage GL_EXT_texture_swizzle GL_EXT_texture_type_2_10_10_10_REV GL_EXT_timer_query GL_EXT_transform_feedback2 GL_EXT_vertex_array GL_EXT_vertex_array_bgra GL_EXT_x11_sync_object GL_EXT_import_sync_object GL_IBM_rasterpos_clip GL_IBM_texture_mirrored_repeat GL_KTX_buffer_region GL_NV_alpha_test GL_NV_blend_minmax GL_NV_blend_square GL_NV_complex_primitives GL_NV_conditional_render GL_NV_copy_depth_to_color GL_NV_copy_image GL_NV_depth_buffer_float GL_NV_depth_clamp GL_NV_ES1_1_compatibility GL_NV_explicit_multisample GL_NV_fbo_color_attachments GL_NV_fence GL_NV_float_buffer GL_NV_fog_distance GL_NV_fragdepth GL_NV_fragment_program GL_NV_fragment_program_option GL_NV_fragment_program2 GL_NV_framebuffer_multisample_coverage GL_NV_geometry_shader4 GL_NV_gpu_program4 GL_NV_gpu_program4_1 GL_NV_half_float GL_NV_light_max_exponent GL_NV_multisample_coverage GL_NV_multisample_filter_hint GL_NV_occlusion_query GL_NV_packed_depth_stencil GL_NV_parameter_buffer_object GL_NV_parameter_buffer_object2 GL_NV_path_rendering GL_NV_pixel_data_range GL_NV_point_sprite GL_NV_primitive_restart GL_NV_register_combiners GL_NV_register_combiners2 GL_NV_shader_buffer_load GL_NV_texgen_reflection GL_NV_texture_barrier GL_NV_texture_compression_vtc GL_NV_texture_env_combine4 GL_NV_texture_expand_normal GL_NV_texture_lod_clamp GL_NV_texture_multisample GL_NV_texture_rectangle GL_NV_texture_shader GL_NV_texture_shader2 GL_NV_texture_shader3 GL_NV_transform_feedback GL_NV_transform_feedback2 GL_NV_vdpau_interop GL_NV_vertex_array_range GL_NV_vertex_array_range2 GL_NV_vertex_buffer_unified_memory GL_NV_vertex_program GL_NV_vertex_program1_1 GL_NV_vertex_program2 GL_NV_vertex_program2_option GL_NV_vertex_program3 GL_NVX_conditional_render GL_NVX_gpu_memory_info GL_OES_compressed_paletted_texture GL_OES_depth24 GL_OES_depth32 GL_OES_depth_texture GL_OES_element_index_uint GL_OES_fbo_render_mipmap GL_OES_get_program_binary GL_OES_mapbuffer GL_OES_packed_depth_stencil GL_OES_point_size_array GL_OES_point_sprite GL_OES_rgb8_rgba8 GL_OES_read_format GL_OES_standard_derivatives GL_OES_texture_3D GL_OES_texture_float GL_OES_texture_float_linear GL_OES_texture_half_float GL_OES_texture_half_float_linear GL_OES_texture_npot GL_OES_vertex_array_object GL_OES_vertex_half_float GL_SGIS_generate_mipmap GL_SGIS_texture_lod GL_SGIX_depth_texture GL_SGIX_shadow GL_SUN_slice_accum
11:16:45 T:139978535622592    INFO: GL: Maximum texture width: 8192
11:16:45 T:139978535622592   DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
11:16:45 T:139978535622592    INFO: load default splash image: /usr/local/share/kodi/media/Splash.png
11:16:45 T:139978535622592    INFO: load keymapping
11:16:45 T:139978535622592    INFO: Loading special://xbmc/system/keymaps/appcommand.xml
11:16:45 T:139978535622592    INFO: Loading special://xbmc/system/keymaps/gamepad.xml
11:16:45 T:139978535622592    INFO: Loading special://xbmc/system/keymaps/joystick.Alienware.Dual.Compatible.Controller.xml
11:16:45 T:139978535622592    INFO: Loading special://xbmc/system/keymaps/joystick.AppleRemote.xml
11:16:45 T:139978535622592    INFO: Loading special://xbmc/system/keymaps/joystick.Harmony.xml
11:16:45 T:139978535622592    INFO: Loading special://xbmc/system/keymaps/joystick.Interact.AxisPad.xml
11:16:45 T:139978535622592    INFO: Loading special://xbmc/system/keymaps/joystick.Logitech.RumblePad.2.xml
11:16:45 T:139978535622592    INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.360.Controller.xml
11:16:45 T:139978535622592    INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.Controller.S.xml
11:16:45 T:139978535622592    INFO: Loading special://xbmc/system/keymaps/joystick.Nintendo.Wii.U.Pro.Controller.xml
11:16:45 T:139978535622592    INFO: Loading special://xbmc/system/keymaps/joystick.PS3.Remote.Keyboard.xml
11:16:45 T:139978535622592    INFO: Loading special://xbmc/system/keymaps/joystick.Sony.PLAYSTATION(R)3.Controller.xml
11:16:45 T:139978535622592    INFO: Loading special://xbmc/system/keymaps/joystick.WiiRemote.xml
11:16:45 T:139978535622592    INFO: Loading special://xbmc/system/keymaps/keyboard.xml
11:16:45 T:139978535622592    INFO: Loading special://xbmc/system/keymaps/mouse.xml
11:16:45 T:139978535622592    INFO: Loading special://xbmc/system/keymaps/remote.xml
11:16:45 T:139978535622592    INFO: Loading special://xbmc/system/keymaps/touchscreen.xml
11:16:45 T:139978535622592    INFO: Loading special://masterprofile/keymaps/remote.xml
11:16:45 T:139978535622592   ERROR: Window Translator: Can't find window tv
11:16:45 T:139978535622592   ERROR: Previous line repeats 1 times.
11:16:45 T:139978535622592   ERROR: Window Translator: Can't find window pvrosddirector
11:16:45 T:139978535622592   ERROR: Window Translator: Can't find window pvrosdcutter
11:16:45 T:139978535622592    INFO: Loading special://profile/keymaps/remote.xml
11:16:45 T:139978535622592   ERROR: Window Translator: Can't find window tv
11:16:45 T:139978535622592   ERROR: Previous line repeats 1 times.
11:16:45 T:139978535622592   ERROR: Window Translator: Can't find window pvrosddirector
11:16:45 T:139978535622592   ERROR: Window Translator: Can't find window pvrosdcutter
11:16:45 T:139978535622592    INFO: Loading special://xbmc/system/Lircmap.xml
11:16:45 T:139978535622592    INFO: * Adding remote mapping for device 'mceusb'
11:16:45 T:139978535622592    INFO: * Adding remote mapping for device 'XboxDVDDongle'
11:16:45 T:139978535622592    INFO: * Adding remote mapping for device 'Microsoft_Xbox'
11:16:45 T:139978535622592    INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote'
11:16:45 T:139978535622592    INFO: * Adding remote mapping for device 'anysee'
11:16:45 T:139978535622592    INFO: * Adding remote mapping for device 'iMON-PAD'
11:16:45 T:139978535622592    INFO: * Adding remote mapping for device 'Antec_Veris_RM200'
11:16:45 T:139978535622592    INFO: * Adding remote mapping for device 'MCE_via_iMON'
11:16:45 T:139978535622592    INFO: * Adding remote mapping for device 'TwinHanRemote'
11:16:45 T:139978535622592    INFO: * Adding remote mapping for device 'linux-input-layer'
11:16:45 T:139978535622592    INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote'
11:16:45 T:139978535622592    INFO: * Adding remote mapping for device 'mediacenter'
11:16:45 T:139978535622592    INFO: * Adding remote mapping for device 'devinput'
11:16:45 T:139978535622592   DEBUG: CButtonTranslator::Load - no userdata Lircmap.xml found, skipping
11:16:45 T:139978535622592    INFO: GUI format 1920x1080, Display 1920x1080@ 50.00 - Full Screen
11:16:45 T:139978535622592   DEBUG: guilib: Fill viewport on change for solving rendering passes
11:16:45 T:139978535622592   DEBUG: SECTION:LoadDLL(libcurl-gnutls.so.4)
11:16:45 T:139978535622592   DEBUG: Loading: libcurl-gnutls.so.4
11:16:45 T:139978535622592  NOTICE: Running database version Addons16
11:16:45 T:139978535622592   DEBUG: Initialize, updating databases...
11:16:45 T:139978535622592  NOTICE: Running database version ViewModes6
11:16:45 T:139978535622592  NOTICE: Running database version Textures13
11:16:45 T:139978535622592  NOTICE: Running database version MyMusic48
11:16:45 T:139978535622592  NOTICE: Running database version MyVideos91
11:16:45 T:139978535622592  NOTICE: Running database version TV27
11:16:45 T:139978535622592  NOTICE: Running database version Epg9
11:16:45 T:139978535622592   DEBUG: Initialize, updating databases... DONE
11:16:45 T:139978535622592  NOTICE: start dvd mediatype detection
11:16:45 T:139978534065920  NOTICE: Thread DetectDVDMedia start, auto delete: false
11:16:45 T:139978534065920   DEBUG: Compiled with libcdio Version 0.83
11:16:45 T:139978535622592   DEBUG: DPMS: supported power-saving modes: SUSPEND OFF STANDBY
11:16:45 T:139978534065920   DEBUG: Thread DetectDVDMedia 139978534065920 terminating
11:16:45 T:139978535622592   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
11:16:45 T:139978535622592   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
11:16:45 T:139978535622592    INFO: Unloading old skin ...
11:16:45 T:139978535622592    INFO:   load skin from: /usr/local/share/kodi/addons/skin.confluence (version: 2.7.0)
11:16:45 T:139978535622592    INFO:   load fonts for skin...
11:16:45 T:139978535622592    INFO: Loading fonts from /usr/local/share/kodi/addons/skin.confluence/720p/Font.xml
11:16:45 T:139978535622592   DEBUG: POParser: loaded 149 strings from file /usr/local/share/kodi/addons/skin.confluence/language/German/strings.po
11:16:45 T:139978535622592   DEBUG: POParser: loaded 0 strings from file /usr/local/share/kodi/addons/skin.confluence/language/English/strings.po
11:16:45 T:139978535622592    INFO: Loading skin includes from /usr/local/share/kodi/addons/skin.confluence/720p/includes.xml
11:16:45 T:139978076055296   DEBUG: OpenConnection - connection to the CEC adapter opened
11:16:45 T:139977779595008  NOTICE: Thread CECAdapterUpdate start, auto delete: false
11:16:45 T:139977779595008   DEBUG: UpdateMenuLanguage - requesting the menu language of the TV
11:16:46 T:139978535622592    INFO:   load new skin...
11:16:46 T:139978535622592    INFO: Loading user windows, path /usr/local/share/kodi/addons/skin.confluence/720p
11:16:46 T:139978535622592   DEBUG: Load Skin XML: 7.68ms
11:16:46 T:139978535622592    INFO:   initialize new skin...
11:16:46 T:139978535622592   DEBUG: guilib: Fill viewport on change for solving rendering passes
11:16:46 T:139978535622592    INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT
11:16:46 T:139978535622592   DEBUG: Load Pointer.xml: 2.01ms
11:16:46 T:139978535622592   DEBUG: OpenBundle - Opened bundle /usr/local/share/kodi/addons/skin.confluence/media/Textures.xbt
11:16:46 T:139978535622592   DEBUG: Alloc resources: 6.39ms  (2.11 ms skin load)
11:16:46 T:139978535622592    INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT
11:16:46 T:139978535622592   DEBUG: Load DialogVolumeBar.xml: 4.43ms
11:16:46 T:139978535622592   DEBUG: Alloc resources: 4.75ms  (4.54 ms skin load)
11:16:46 T:139978535622592    INFO: Loading skin file: DialogKaiToast.xml, load type: LOAD_ON_GUI_INIT
11:16:46 T:139978535622592   DEBUG: Load DialogKaiToast.xml: 4.03ms
11:16:46 T:139978535622592   DEBUG: Alloc resources: 4.15ms  (4.15 ms skin load)
11:16:46 T:139978535622592    INFO: Loading skin file: DialogMuteBug.xml, load type: LOAD_ON_GUI_INIT
11:16:46 T:139978535622592   DEBUG: Load DialogMuteBug.xml: 0.95ms
11:16:46 T:139978535622592   DEBUG: Alloc resources: 1.05ms  (1.05 ms skin load)
11:16:46 T:139978535622592    INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT
11:16:46 T:139978535622592   DEBUG: Load DialogSeekBar.xml: 15.54ms
11:16:46 T:139978535622592   DEBUG: Alloc resources: 16.05ms  (15.77 ms skin load)
11:16:46 T:139978535622592    INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
11:16:46 T:139978535622592   DEBUG: Load DialogBusy.xml: 2.49ms
11:16:46 T:139978535622592   DEBUG: Alloc resources: 2.62ms  (2.59 ms skin load)
11:16:46 T:139978535622592    INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT
11:16:46 T:139978535622592   DEBUG: Load DialogExtendedProgressBar.xml: 2.82ms
11:16:46 T:139978535622592   DEBUG: Alloc resources: 2.95ms  (2.93 ms skin load)
11:16:46 T:139978535622592    INFO: Loading /usr/local/share/kodi/addons/skin.confluence/sounds/sounds.xml
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: Format wav probed with size=2048 and score=99
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] Format wav probed with size=2048 and score=99
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] Before avformat_find_stream_info() pos: 44 bytes read:1402 seeks:0
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] After avformat_find_stream_info() pos: 1402 bytes read:1402 seeks:0 frames:1
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: Format wav probed with size=2048 and score=99
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] Format wav probed with size=2048 and score=99
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] Before avformat_find_stream_info() pos: 44 bytes read:9842 seeks:0
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] After avformat_find_stream_info() pos: 9842 bytes read:9842 seeks:0 frames:3
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: Format wav probed with size=2048 and score=99
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] Format wav probed with size=2048 and score=99
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] Before avformat_find_stream_info() pos: 44 bytes read:4572 seeks:0
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] After avformat_find_stream_info() pos: 4572 bytes read:4572 seeks:0 frames:2
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: Format wav probed with size=2048 and score=99
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] Format wav probed with size=2048 and score=99
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] Before avformat_find_stream_info() pos: 44 bytes read:20480 seeks:0
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:14
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:13
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:12
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:11
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:10
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:9
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:8
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probed stream 0
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] After avformat_find_stream_info() pos: 20780 bytes read:20780 seeks:0 frames:6
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: Format wav probed with size=2048 and score=99
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] Format wav probed with size=2048 and score=99
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] Before avformat_find_stream_info() pos: 46 bytes read:20480 seeks:0
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:14
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:13
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:12
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:11
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:10
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:9
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:8
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:7
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:6
11:16:46 T:139977779595008   DEBUG: SetMenuLanguage - language set to 'German'
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:5
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:4
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:3
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probed stream 0
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] After avformat_find_stream_info() pos: 43822 bytes read:43822 seeks:0 frames:11
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: Format wav probed with size=2048 and score=99
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] Format wav probed with size=2048 and score=99
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] Before avformat_find_stream_info() pos: 46 bytes read:18478 seeks:0
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:14
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:13
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:12
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:11
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:10
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probing stream 0 pp:9
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] probed stream 0
11:16:46 T:139978535622592   DEBUG: ffmpeg[7F4F4AE457C0]: [wav] After avformat_find_stream_info() pos: 18478 bytes read:18478 seeks:0 frames:5

coper2

2015-02-01, 12:36
Sorry, I had to split the log file. Uploading the file to pastebin failed Sad

Code:
11:16:46 T:139978535622592    INFO:   skin loaded...
11:16:46 T:139978535622592   DEBUG: JSONRPC: JSON schema type broadcastnext references an unknown type PVR.Details.Broadcast
11:16:46 T:139978535622592 WARNING: JSONRPC: Could not parse type "PVR.Details.Channel"
11:16:46 T:139978535622592    INFO: JSONRPC: Adding type "PVR.Details.Channel" to list of incomplete definitions (waiting for "PVR.Details.Broadcast")
11:16:46 T:139978535622592   DEBUG: JSONRPC: JSON schema type  references an unknown type PVR.Details.Channel
11:16:46 T:139978535622592   DEBUG: Invalid item definition in "items" for type channels
11:16:46 T:139978535622592 WARNING: JSONRPC: Could not parse type "PVR.Details.ChannelGroup.Extended"
11:16:46 T:139978535622592    INFO: JSONRPC: Adding type "PVR.Details.ChannelGroup.Extended" to list of incomplete definitions (waiting for "PVR.Details.Channel")
11:16:46 T:139978535622592    INFO: JSONRPC: Resolving incomplete types/methods referencing PVR.Details.Broadcast
11:16:46 T:139978535622592    INFO: JSONRPC: Resolving incomplete types/methods referencing PVR.Details.Channel
11:16:46 T:139978535622592   DEBUG: JSONRPC: JSON schema type stereoscopicmode references an unknown type GUI.Stereoscopy.Mode
11:16:46 T:139978535622592 WARNING: JSONRPC: Could not parse type "GUI.Property.Value"
11:16:46 T:139978535622592    INFO: JSONRPC: Adding type "GUI.Property.Value" to list of incomplete definitions (waiting for "GUI.Stereoscopy.Mode")
11:16:46 T:139978535622592    INFO: JSONRPC: Resolving incomplete types/methods referencing GUI.Stereoscopy.Mode
11:16:46 T:139978535622592   DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting
11:16:46 T:139978535622592 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList"
11:16:46 T:139978535622592    INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting")
11:16:46 T:139978535622592    INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting
11:16:46 T:139978535622592    INFO: JSONRPC v6.21.2: Successfully initialized
11:16:46 T:139978535622592   DEBUG: ADDON: Starting service addons.
11:16:46 T:139977769092864  NOTICE: Thread LanguageInvoker start, auto delete: false
11:16:46 T:139977769092864  NOTICE: Previous line repeats 1 times.
11:16:46 T:139977769092864    INFO: initializing python engine.
11:16:46 T:139978535622592   DEBUG: Activating window ID: 12999
11:16:46 T:139977760700160    INFO: initializing python engine.
11:16:46 T:139978535622592   DEBUG: ------ Window Init (Startup.xml) ------
11:16:46 T:139978535622592    INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME
11:16:46 T:139978535622592   DEBUG: Load Startup.xml: 8.95ms
11:16:46 T:139978535622592   DEBUG: Alloc resources: 9.11ms  (9.10 ms skin load)
11:16:46 T:139978535622592    INFO: removing tempfiles
11:16:46 T:139978535622592   DEBUG: ADDON: Starting service addons.
11:16:46 T:139978535622592  NOTICE: initialize done
11:16:46 T:139978535622592  NOTICE: Running the application...
11:16:46 T:139978535622592   DEBUG: Activating window ID: 10000
11:16:46 T:139977346250496  NOTICE: Thread LanguageInvoker start, auto delete: false
11:16:46 T:139977346250496    INFO: initializing python engine.
11:16:46 T:139977769092864   DEBUG: CPythonInvoker(0, /home/xbmc/.kodi/addons/service.xbmc.versioncheck/service.py): start processing
11:16:46 T:139977760700160   DEBUG: CPythonInvoker(1, /home/xbmc/.kodi/addons/script.module.simple.downloader/default.py): start processing
11:16:46 T:139977346250496   DEBUG: CPythonInvoker(2, /home/xbmc/.kodi/addons/script.common.plugin.cache/default.py): start processing
11:16:46 T:139977769092864  NOTICE: -->Python Interpreter Initialized<--
11:16:46 T:139977769092864   DEBUG: CPythonInvoker(0, /home/xbmc/.kodi/addons/service.xbmc.versioncheck/service.py): the source file to load is "/home/xbmc/.kodi/addons/service.xbmc.versioncheck/service.py"
11:16:46 T:139977769092864   DEBUG: CPythonInvoker(0, /home/xbmc/.kodi/addons/service.xbmc.versioncheck/service.py): setting the Python path to /home/xbmc/.kodi/addons/service.xbmc.versioncheck:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PIL:/usr/lib/pymodules/python2.7
11:16:46 T:139977769092864   DEBUG: CPythonInvoker(0, /home/xbmc/.kodi/addons/service.xbmc.versioncheck/service.py): entering source directory /home/xbmc/.kodi/addons/service.xbmc.versioncheck
11:16:46 T:139977769092864   DEBUG: CPythonInvoker(0, /home/xbmc/.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
11:16:46 T:139977769092864   DEBUG: Version Check: Version 0.3.2 started
11:16:46 T:139977346250496  NOTICE: -->Python Interpreter Initialized<--
11:16:46 T:139977346250496   DEBUG: CPythonInvoker(2, /home/xbmc/.kodi/addons/script.common.plugin.cache/default.py): the source file to load is "/home/xbmc/.kodi/addons/script.common.plugin.cache/default.py"
11:16:46 T:139977346250496   DEBUG: CPythonInvoker(2, /home/xbmc/.kodi/addons/script.common.plugin.cache/default.py): setting the Python path to /home/xbmc/.kodi/addons/script.common.plugin.cache:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PIL:/usr/lib/pymodules/python2.7
11:16:46 T:139977346250496   DEBUG: CPythonInvoker(2, /home/xbmc/.kodi/addons/script.common.plugin.cache/default.py): entering source directory /home/xbmc/.kodi/addons/script.common.plugin.cache
11:16:46 T:139977346250496   DEBUG: CPythonInvoker(2, /home/xbmc/.kodi/addons/script.common.plugin.cache/default.py): instantiating addon using automatically obtained id of "script.common.plugin.cache" dependent on version 2.1.0 of the xbmc.python api
11:16:46 T:139978535622592   DEBUG: ------ Window Init () ------
11:16:46 T:139978535622592   DEBUG: Alloc resources: 0.01ms  (0.01 ms skin load)
11:16:46 T:139978535622592    INFO: GL: Enabling VSYNC
11:16:46 T:139978535622592    INFO: GL: Selected vsync mode 6
11:16:46 T:139978535622592   DEBUG: ------ Window Deinit (Startup.xml) ------
11:16:46 T:139978535622592   DEBUG: ------ Window Init (Home.xml) ------
11:16:46 T:139978535622592    INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY
11:16:46 T:139977760700160  NOTICE: -->Python Interpreter Initialized<--
11:16:46 T:139977760700160   DEBUG: CPythonInvoker(1, /home/xbmc/.kodi/addons/script.module.simple.downloader/default.py): the source file to load is "/home/xbmc/.kodi/addons/script.module.simple.downloader/default.py"
11:16:46 T:139977760700160   DEBUG: CPythonInvoker(1, /home/xbmc/.kodi/addons/script.module.simple.downloader/default.py): setting the Python path to /home/xbmc/.kodi/addons/script.module.simple.downloader:/home/xbmc/.kodi/addons/script.common.plugin.cache/lib:/home/xbmc/.kodi/addons/script.module.parsedom/lib:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PIL:/usr/lib/pymodules/python2.7
11:16:46 T:139977760700160   DEBUG: CPythonInvoker(1, /home/xbmc/.kodi/addons/script.module.simple.downloader/default.py): entering source directory /home/xbmc/.kodi/addons/script.module.simple.downloader
11:16:46 T:139977760700160   DEBUG: CPythonInvoker(1, /home/xbmc/.kodi/addons/script.module.simple.downloader/default.py): instantiating addon using automatically obtained id of "script.module.simple.downloader" dependent on version 2.1.0 of the xbmc.python api
11:16:46 T:139977346250496  NOTICE:  StorageServer Module loaded RUN
11:16:46 T:139977346250496  NOTICE: StorageClient-2.5.4 Starting server
11:16:46 T:139978167334656   DEBUG: ffmpeg[7F4F34F0B700]: 0.707107
11:16:46 T:139978535622592   DEBUG: Previous line repeats 1 times.
11:16:46 T:139978535622592   DEBUG: Load Home.xml: 176.52ms
11:16:46 T:139978535622592   DEBUG: Alloc resources: 205.15ms  (182.22 ms skin load)
11:16:46 T:139977308436224  NOTICE: Thread JobWorker start, auto delete: true
11:16:46 T:139977308436224   DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update
11:16:46 T:139977308436224   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
11:16:46 T:139977308436224   DEBUG: GetRecentlyAddedAlbums query: select * from albumview where strAlbum != '' order by idAlbum desc limit 10
11:16:47 T:139977308436224   DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
11:16:47 T:139978535622592   DEBUG: no profile autoexec.py (/home/xbmc/.kodi/userdata/autoexec.py) found, skipping
11:16:47 T:139978535622592   DEBUG: NetworkMessage - Starting network services
11:16:47 T:139978535622592   DEBUG: CZeroconfAvahi::clientCallback: client is up and running
11:16:47 T:139978535622592  NOTICE: starting zeroconf publishing
11:16:47 T:139978535622592  NOTICE: Webserver: Starting...
11:16:47 T:139978535622592  NOTICE: WebServer: Started the webserver
11:16:47 T:139977291650816  NOTICE: Thread JobWorker start, auto delete: true
11:16:47 T:139977291650816   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:XBMC port:8080
11:16:47 T:139977291650816   DEBUG: CZeroconfAvahi::addService() named: XBMC type: _http._tcp port:8080
11:16:47 T:139978535622592  NOTICE: starting upnp server
11:16:47 T:139977061029632  NOTICE: Thread JobWorker start, auto delete: true
11:16:47 T:139977061029632   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:XBMC port:8080
11:16:47 T:139977061029632   DEBUG: CZeroconfAvahi::addService() named: XBMC type: _xbmc-jsonrpc-h._tcp port:8080
11:16:47 T:139978535622592  NOTICE: starting upnp renderer
11:16:47 T:139977308436224   DEBUG: RunQuery took 2 ms for 0 items query: select * from movie_view  ORDER BY dateAdded desc, idMovie desc LIMIT 10
11:16:47 T:139977308436224   DEBUG: RunQuery took 3 ms for 0 items query: select * from episode_view  ORDER BY dateAdded desc, idEpisode desc LIMIT 10
11:16:47 T:139977308436224   DEBUG: RunQuery took 3 ms for 0 items query: select * from musicvideo_view  ORDER BY dateAdded desc, idMVideo desc LIMIT 10
11:16:47 T:139978535622592  NOTICE: ES: Starting event server
11:16:47 T:139978535622592   ERROR: JSONRPC Server: Failed to connect to sdpd
11:16:47 T:139978535622592    INFO: JSONRPC Server: Successfully initialized
11:16:47 T:139977291650816   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:XBMC port:9090
11:16:47 T:139977291650816   DEBUG: CZeroconfAvahi::addService() named: XBMC type: _xbmc-jsonrpc._tcp port:9090
11:16:47 T:139978535622592   DEBUG: UPower: Received an unknown signal NameAcquired
11:16:47 T:139977308436224   DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
11:16:47 T:139977779595008   DEBUG: UpdateAudioSystemStatus - no CEC capable amplifier found
11:16:47 T:139976792594176  NOTICE: Thread TCPServer start, auto delete: false
11:16:47 T:139976800986880  NOTICE: Thread EventServer start, auto delete: false
11:16:47 T:139976800986880  NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777
11:16:47 T:139976800986880  NOTICE: UDP: Listening on port 9777
11:16:47 T:139977061029632   DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:XBMC port:9777
11:16:47 T:139977061029632   DEBUG: CZeroconfAvahi::addService() named: XBMC type: _xbmc-events._udp port:9777
11:16:47 T:139978535622592   DEBUG: ------ Window Init (DialogKaiToast.xml) ------
11:16:47 T:139978535622592   DEBUG: Window DialogKaiToast.xml was already loaded
11:16:47 T:139978535622592   DEBUG: Alloc resources: 0.00m
11:16:47 T:139977291650816    INFO: WEATHER: Downloading weather
11:16:47 T:139976784201472  NOTICE: Thread LanguageInvoker start, auto delete: false
11:16:47 T:139976784201472    INFO: initializing python engine.
11:16:47 T:139976784201472   DEBUG: CPythonInvoker(3, /home/xbmc/.kodi/addons/weather.wunderground/default.py): start processing
11:16:47 T:139978534065920  NOTICE: Thread RSSReader start, auto delete: false
11:16:47 T:139978534065920   DEBUG: CurlFile::Open(0x7f4f4acc8ba0) http://feeds.xbmc.org/xbmc
11:16:47 T:139978534065920    INFO: easy_aquire - Created session to http://feeds.xbmc.org
11:16:47 T:139977760700160    INFO: CPythonInvoker(1, /home/xbmc/.kodi/addons/script.module.simple.downloader/default.py): script successfully run
11:16:47 T:139977760700160    INFO: Python script stopped
11:16:47 T:139977760700160   DEBUG: Thread LanguageInvoker 139977760700160 terminating
11:16:47 T:139976784201472  NOTICE: -->Python Interpreter Initialized<--
11:16:47 T:139976784201472   DEBUG: CPythonInvoker(3, /home/xbmc/.kodi/addons/weather.wunderground/default.py): the source file to load is "/home/xbmc/.kodi/addons/weather.wunderground/default.py"
11:16:47 T:139976784201472   DEBUG: CPythonInvoker(3, /home/xbmc/.kodi/addons/weather.wunderground/default.py): setting the Python path to /home/xbmc/.kodi/addons/weather.wunderground:/home/xbmc/.kodi/addons/script.module.simplejson/lib:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PIL:/usr/lib/pymodules/python2.7
11:16:47 T:139976784201472   DEBUG: CPythonInvoker(3, /home/xbmc/.kodi/addons/weather.wunderground/default.py): entering source directory /home/xbmc/.kodi/addons/weather.wunderground
11:16:47 T:139976784201472   DEBUG: CPythonInvoker(3, /home/xbmc/.kodi/addons/weather.wunderground/default.py): instantiating addon using automatically obtained id of "weather.wunderground" dependent on version 2.12.0 of the xbmc.python api
11:16:47 T:139978167334656   DEBUG: ffmpeg[7F4F34F0B700]: 0.707107
11:16:47 T:139976784201472   DEBUG: Previous line repeats 3 times.
11:16:47 T:139976784201472   DEBUG: POParser: loaded 40 strings from file /home/xbmc/.kodi/addons/weather.wunderground/resources/language/German/strings.po
11:16:47 T:139976784201472   DEBUG: POParser: loaded 0 strings from file /home/xbmc/.kodi/addons/weather.wunderground/resources/language/English/strings.po
11:16:47 T:139978534065920   DEBUG: Got rss feed: http://feeds.xbmc.org/xbmc
11:16:47 T:139978534065920   DEBUG: RSS feed encoding: UTF-8
11:16:47 T:139978534065920   DEBUG: Parsed rss feed: http://feeds.xbmc.org/xbmc
11:16:47 T:139978534065920   DEBUG: Thread RSSReader 139978534065920 terminating
11:16:48 T:139977300043520   DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
11:16:48 T:139976784201472   DEBUG: Previous line repeats 3 times.
11:16:48 T:139976784201472    INFO: CPythonInvoker(3, /home/xbmc/.kodi/addons/weather.wunderground/default.py): script successfully run
11:16:48 T:139976784201472    INFO: Python script stopped
11:16:48 T:139976784201472   DEBUG: Thread LanguageInvoker 139976784201472 terminating
11:16:48 T:139977291650816   DEBUG: GetZipList - Processing zip://special%3a%2f%2fxbmc%2fmedia%2fweather.zip/
11:16:48 T:139977291650816   DEBUG: POParser: loaded 130 weather tokens
11:16:51 T:139977816012544   DEBUG: PushCecKeypress - received key a7 duration 0
11:16:51 T:139978535622592   DEBUG: OnKey: 167 (0xa7) pressed, action is Down
11:16:51 T:139977816012544   DEBUG: PushCecKeypress - received key a7 duration 334
11:16:51 T:139977769092864   DEBUG: Version Check: Version installed {u'major': 15, u'tag': u'alpha', u'tagversion': u'1', u'minor': 0, u'revision': u'2015-01-29-2938b5a-dirty'}
11:16:51 T:139977769092864    INFO: CPythonInvoker(0, /home/xbmc/.kodi/addons/service.xbmc.versioncheck/service.py): script successfully run
11:16:51 T:139977769092864    INFO: Python script stopped
11:16:51 T:139977769092864   DEBUG: Thread LanguageInvoker 139977769092864 terminating
11:16:52 T:139977816012544   DEBUG: PushCecKeypress - received key  b duration 0
11:16:52 T:139978535622592   DEBUG: OnKey: 11 (0x0b) pressed, action is Select
11:16:52 T:139978535622592   DEBUG: Activating window ID: 10025
11:16:52 T:139977816012544   DEBUG: PushCecKeypress - received key  b duration 204
11:16:52 T:139978535622592   DEBUG: ------ Window Deinit (Home.xml) ------
11:16:52 T:139978535622592   DEBUG: ------ Window Init (MyVideoNav.xml) ------
11:16:52 T:139978535622592    INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY
11:16:52 T:139978535622592   DEBUG: Load MyVideoNav.xml: 215.85ms
11:16:52 T:139978535622592   DEBUG: Alloc resources: 389.89ms  (216.84 ms skin load)
11:16:52 T:139978535622592   DEBUG: CGUIMediaWindow::GetDirectory (sources://video/)
11:16:52 T:139978535622592   DEBUG:   ParentPath = [sources://video/]
11:16:52 T:139977769092864  NOTICE: Thread BackgroundLoader start, auto delete: false
11:16:52 T:139977769092864   DEBUG: Thread BackgroundLoader 139977769092864 terminating
11:16:53 T:139977816012544   DEBUG: PushCecKeypress - received key a7 duration 0
11:16:53 T:139978535622592   DEBUG: OnKey: 167 (0xa7) pressed, action is Down
11:16:53 T:139977816012544   DEBUG: PushCecKeypress - received key a7 duration 208
11:16:54 T:139977816012544   DEBUG: PushCecKeypress - received key a7 duration 0
11:16:54 T:139978535622592   DEBUG: OnKey: 167 (0xa7) pressed, action is Down
11:16:54 T:139977816012544   DEBUG: PushCecKeypress - received key a7 duration 204
11:16:54 T:139977816012544   DEBUG: PushCecKeypress - received key a7 duration 0
11:16:54 T:139978535622592   DEBUG: OnKey: 167 (0xa7) pressed, action is Down
11:16:54 T:139978535622592   DEBUG: ------ Window Deinit (DialogKaiToast.xml) ------
11:16:54 T:139977816012544   DEBUG: PushCecKeypress - received key a7 duration 203
11:16:54 T:139977816012544   DEBUG: PushCecKeypress - received key a7 duration 0
11:16:54 T:139978535622592   DEBUG: OnKey: 167 (0xa7) pressed, action is Down
11:16:54 T:139977816012544   DEBUG: PushCecKeypress - received key a7 duration 203
11:16:55 T:139978535622592    INFO: LIRC Initialize: using: /dev/lircd
11:16:55 T:139978535622592   DEBUG: Failed to connect to LIRC. Retry in 20s.
11:16:55 T:139977816012544   DEBUG: PushCecKeypress - received key  b duration 0
11:16:55 T:139978535622592   DEBUG: OnKey: 11 (0x0b) pressed, action is Select
11:16:55 T:139978535622592   DEBUG: CGUIMediaWindow::GetDirectory (/mnt/Media/Video/)
11:16:55 T:139978535622592   DEBUG:   ParentPath = [sources://video/]
11:16:55 T:139977816012544   DEBUG: PushCecKeypress - received key  b duration 203
11:16:55 T:139978535622592   DEBUG: ------ Window Init (DialogBusy.xml) ------
11:16:55 T:139978535622592   DEBUG: Window DialogBusy.xml was already loaded
11:16:55 T:139978535622592   DEBUG: Alloc resources: 0.01m
11:16:55 T:139978535622592   ERROR: Control 50 in window 10025 has been asked to focus, but it can't
11:16:57 T:139978535622592   DEBUG: Saving fileitems [/mnt/Media/Video/]
11:16:57 T:139978535622592   DEBUG:   -- items: 7, sort method: 0, ascending: true
11:16:57 T:139978535622592   DEBUG: RunQuery took 51 ms for 29 items query: SELECT  files.strFilename, files.playCount,  bookmark.timeInSeconds, bookmark.totalTimeInSeconds FROM files  LEFT JOIN bookmark ON    files.idFile = bookmark.idFile AND bookmark.type = 1  WHERE files.idPath=1
11:16:57 T:139977769092864  NOTICE: Thread BackgroundLoader start, auto delete: false
11:16:57 T:139978535622592   DEBUG: ------ Window Deinit (DialogBusy.xml) ------
11:16:57 T:139977769092864   DEBUG: Thread BackgroundLoader 139977769092864 terminating
11:16:58 T:139977816012544   DEBUG: PushCecKeypress - received key a6 duration 0
11:16:58 T:139978535622592   DEBUG: OnKey: 166 (0xa6) pressed, action is Up
11:16:58 T:139977816012544   DEBUG: PushCecKeypress - received key a6 duration 203
11:16:59 T:139977816012544   DEBUG: PushCecKeypress - received key a6 duration 0
11:16:59 T:139978535622592   DEBUG: OnKey: 166 (0xa6) pressed, action is Up
11:16:59 T:139977816012544   DEBUG: PushCecKeypress - received key a6 duration 204
11:17:00 T:139977816012544   DEBUG: PushCecKeypress - received key  b duration 0
11:17:00 T:139978535622592   DEBUG: OnKey: 11 (0x0b) pressed, action is Select
11:17:00 T:139978535622592    INFO: Loading skin file: DialogContextMenu.xml, load type: KEEP_IN_MEMORY
11:17:00 T:139978535622592   DEBUG: Load DialogContextMenu.xml: 3.92ms
11:17:00 T:139978535622592   DEBUG: Alloc resources: 4.57ms  (4.03 ms skin load)
11:17:00 T:139978535622592   DEBUG: ------ Window Init (DialogContextMenu.xml) ------
11:17:00 T:139978535622592   DEBUG: Window DialogContextMenu.xml was already loaded
11:17:00 T:139978535622592   DEBUG: Alloc resources: 0.07m
11:17:00 T:139977816012544   DEBUG: PushCecKeypress - received key  b duration 199
11:17:01 T:139977816012544   DEBUG: PushCecKeypress - received key  b duration 0
11:17:01 T:139978535622592   DEBUG: OnKey: 11 (0x0b) pressed, action is Select
11:17:01 T:139978535622592   DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------
11:17:01 T:139977816012544   DEBUG: PushCecKeypress - received key  b duration 209
11:17:01 T:139978535622592   DEBUG: OnPlayMedia /mnt/Media/Video/test.iso
11:17:01 T:139978535622592   DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc
11:17:01 T:139978535622592   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd
11:17:01 T:139978535622592   DEBUG: Loading settings for /mnt/Media/Video/test.iso
11:17:01 T:139978535622592   DEBUG: CPlayerCoreFactory::GetPlayers(/mnt/Media/Video/test.iso)
11:17:01 T:139978535622592   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
11:17:01 T:139978535622592   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
11:17:01 T:139978535622592   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
11:17:01 T:139978535622592   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
11:17:01 T:139978535622592   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
11:17:01 T:139978535622592   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
11:17:01 T:139978535622592   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
11:17:01 T:139978535622592   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
11:17:01 T:139978535622592   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
11:17:01 T:139978535622592   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
11:17:01 T:139978535622592   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: dvdimage
11:17:01 T:139978535622592   DEBUG: CPlayerSelectionRule::GetPlayers: adding player: DVDPlayer (1) for rule: dvdimage
11:17:01 T:139978535622592   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
11:17:01 T:139978535622592   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
11:17:01 T:139978535622592   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
11:17:01 T:139978535622592   DEBUG: CPlayerCoreFactory::GetPlayers: matched 1 rules with players
11:17:01 T:139978535622592   DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
11:17:01 T:139978535622592   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
11:17:01 T:139978535622592   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
11:17:01 T:139978535622592   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
11:17:01 T:139978535622592   DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
11:17:01 T:139978535622592  NOTICE: DVDPlayer: Opening: /mnt/Media/Video/test.iso
11:17:01 T:139978535622592 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
11:17:01 T:139978535622592   DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
11:17:01 T:139978535622592   DEBUG: LinuxRendererGL: Cleaning up GL resources
11:17:01 T:139978535622592   DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16
11:17:01 T:139977769092864  NOTICE: Thread DVDPlayer start, auto delete: false
11:17:01 T:139977769092864  NOTICE: Creating InputStream
11:17:01 T:139977769092864   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/libdvdnav-x86_64-linux.so)
11:17:01 T:139977769092864   DEBUG: Loading: /usr/local/lib/kodi/system/players/dvdplayer/libdvdnav-x86_64-linux.so
11:17:01 T:139977769092864    INFO:   msg: libdvdnav: Using dvdnav version 4.2.1
11:17:01 T:139977769092864    INFO:   msg: libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.IFO failed
11:17:01 T:139977769092864    INFO:   msg: libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.BUP failed
11:17:01 T:139977769092864   DEBUG: libdvdread: Can't open file VIDEO_TS.IFO.
11:17:01 T:139977769092864   DEBUG: libdvdnav: vm: failed to read VIDEO_TS.IFO
11:17:01 T:139977769092864   ERROR: Error on dvdnav_open
11:17:01 T:139977769092864   ERROR: CDVDPlayer::OpenInputStream - error opening [/mnt/Media/Video/test.iso]
11:17:01 T:139977769092864  NOTICE: CDVDPlayer::OnExit()
11:17:01 T:139977769092864   DEBUG: OnPlayBackStopped: play state was 1, starting 1
11:17:01 T:139977769092864   DEBUG: Thread DVDPlayer 139977769092864 terminating
11:17:01 T:139978535622592   DEBUG: OnPlayBackStopped: play state was 3, starting 0
11:17:01 T:139978535622592   DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
11:17:01 T:139978535622592   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
11:17:01 T:139978535622592   ERROR: Playlist Player: skipping unplayable item: 0, path [/mnt/Media/Video/test.iso]
11:17:01 T:139978535622592   DEBUG: Playlist Player: no more playable items... aborting playback
11:17:01 T:139977769092864  NOTICE: Thread BackgroundLoader start, auto delete: false
11:17:01 T:139978535622592  NOTICE: CDVDPlayer::CloseFile()
11:17:01 T:139978535622592  NOTICE: DVDPlayer: waiting for threads to exit
11:17:01 T:139978535622592  NOTICE: DVDPlayer: finished waiting
11:17:01 T:139978535622592   DEBUG: LinuxRendererGL: Cleaning up GL resources
11:17:01 T:139978535622592  NOTICE: CDVDPlayer::CloseFile()
11:17:01 T:139978535622592  NOTICE: DVDPlayer: waiting for threads to exit
11:17:01 T:139978535622592  NOTICE: DVDPlayer: finished waiting
11:17:01 T:139978535622592   DEBUG: LinuxRendererGL: Cleaning up GL resources
11:17:01 T:139977769092864   DEBUG: Thread BackgroundLoader 139977769092864 terminating
11:17:08 T:139977816012544   DEBUG: PushCecKeypress - received key d8 duration 0
11:17:08 T:139978535622592   DEBUG: OnKey: menu (0xd8) pressed, action is Back
11:17:08 T:139978535622592   DEBUG: CGUIMediaWindow::GetDirectory (sources://video/)
11:17:08 T:139978535622592   DEBUG:   ParentPath = []
11:17:08 T:139977769092864  NOTICE: Thread BackgroundLoader start, auto delete: false
11:17:08 T:139977769092864   DEBUG: Thread BackgroundLoader 139977769092864 terminating
11:17:09 T:139977816012544   DEBUG: PushCecKeypress - received key d8 duration 203
11:17:09 T:139977816012544   DEBUG: PushCecKeypress - received key d8 duration 0
11:17:09 T:139978535622592   DEBUG: OnKey: menu (0xd8) pressed, action is Back
11:17:09 T:139978535622592   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
11:17:09 T:139977816012544   DEBUG: PushCecKeypress - received key d8 duration 198
11:17:09 T:139978535622592   DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
11:17:09 T:139978535622592   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
11:17:09 T:139978535622592   DEBUG: ------ Window Init (Home.xml) ------
11:17:09 T:139978535622592   DEBUG: Window Home.xml was already loaded
11:17:09 T:139978535622592   DEBUG: Alloc resources: 3.76m
11:17:10 T:139977816012544   DEBUG: PushCecKeypress - received key a7 duration 0
11:17:10 T:139978535622592   DEBUG: OnKey: 167 (0xa7) pressed, action is Down
11:17:10 T:139977816012544   DEBUG: PushCecKeypress - received key a7 duration 73
11:17:11 T:139977816012544   DEBUG: PushCecKeypress - received key a7 duration 0
11:17:11 T:139978535622592   DEBUG: OnKey: 167 (0xa7) pressed, action is Down
11:17:11 T:139977816012544   DEBUG: PushCecKeypress - received key a7 duration 204
11:17:11 T:139977816012544   DEBUG: PushCecKeypress - received key  b duration 0
11:17:11 T:139978535622592   DEBUG: OnKey: 11 (0x0b) pressed, action is Select
11:17:11 T:139978535622592   DEBUG: Activating window ID: 10111
11:17:11 T:139978535622592   DEBUG: ------ Window Init (DialogButtonMenu.xml) ------
11:17:11 T:139978535622592    INFO: Loading skin file: DialogButtonMenu.xml, load type: KEEP_IN_MEMORY
11:17:11 T:139978535622592   DEBUG: Load DialogButtonMenu.xml: 16.28ms
11:17:11 T:139978535622592   DEBUG: Alloc resources: 93.72ms  (16.41 ms skin load)
11:17:11 T:139977816012544   DEBUG: PushCecKeypress - received key  b duration 204
11:17:14 T:139977816012544   DEBUG: PushCecKeypress - received key  b duration 0
11:17:14 T:139978535622592   DEBUG: OnKey: 11 (0x0b) pressed, action is Select
11:17:14 T:139978535622592   DEBUG: CAnnouncementManager - Announcement: OnQuit from xbmc
11:17:14 T:139978535622592   DEBUG: GOT ANNOUNCEMENT, type: 8, from xbmc, message OnQuit
11:17:14 T:139978535622592  NOTICE: Storing total System Uptime
11:17:14 T:139978535622592  NOTICE: Saving settings
11:17:14 T:139977779595008   DEBUG: Thread CECAdapterUpdate 139977779595008 terminating
11:17:14 T:139978076055296   DEBUG: Process - sending standby commands
11:17:14 T:139978535622592  NOTICE: stop all
11:17:14 T:139977061029632   DEBUG: Thread JobWorker 139977061029632 terminating (autodelete)
11:17:14 T:139978535622592  NOTICE: stop player
11:17:14 T:139978535622592    INFO: stopping PVRManager
11:17:14 T:139977308436224   DEBUG: Thread JobWorker 139977308436224 terminating (autodelete)
11:17:14 T:139977291650816   DEBUG: Thread JobWorker 139977291650816 terminating (autodelete)
11:17:14 T:139978535622592   DEBUG: NetworkMessage - Signaling network services to stop
11:17:14 T:139978535622592  NOTICE: ES: Stopping event server
11:17:14 T:139978535622592   DEBUG: NetworkMessage - Waiting for network services to stop
11:17:14 T:139978535622592  NOTICE: stopping upnp
11:17:14 T:139978535622592  NOTICE: stopping zeroconf publishing
11:17:14 T:139978535622592  NOTICE: Webserver: Stopping...
11:17:14 T:139978535622592  NOTICE: WebServer: Stopped the webserver
11:17:14 T:139978535622592  NOTICE: Webserver: Stopped...
11:17:15 T:139976800986880  NOTICE: ES: UDP Event server stopped
11:17:15 T:139976800986880   DEBUG: Thread EventServer 139976800986880 terminating
11:17:15 T:139976792594176   DEBUG: Thread TCPServer 139976792594176 terminating
11:17:15 T:139978535622592  NOTICE: stop dvd detect media
11:17:15 T:139977799227136   DEBUG: Thread PeripBusUSBUdev 139977799227136 terminating
11:17:15 T:139978067662592   DEBUG: Thread PeripBusCEC 139978067662592 terminating
11:17:16 T:139978076055296   DEBUG: Process - CEC adapter processor thread ended
11:17:16 T:139978076055296   DEBUG: Thread CECAdapter 139978076055296 terminating
11:17:16 T:139978535622592  NOTICE: stop sap announcement listener
11:17:16 T:139978535622592  NOTICE: clean cached files!
11:17:16 T:139978535622592  NOTICE: unload skin
11:17:16 T:139978535622592    INFO: Unloading old skin ...
11:17:16 T:139978535622592   DEBUG: ------ Window Deinit () ------
11:17:16 T:139978535622592   DEBUG: ------ Window Deinit (Home.xml) ------
11:17:16 T:139978535622592 WARNING: Cleanup: Having to cleanup texture button-focus.png
11:17:16 T:139978535622592 WARNING: Cleanup: Having to cleanup texture button-nofocus.png
11:17:16 T:139978535622592   DEBUG: Cleanup - Closed bundle
11:17:16 T:139978535622592   DEBUG: ADDON: Stopping service addons.
11:17:16 T:139977346250496  NOTICE: StorageServer-2.5.4 Closed down
11:17:16 T:139977346250496    INFO: CPythonInvoker(2, /home/xbmc/.kodi/addons/script.common.plugin.cache/default.py): script successfully run
11:17:16 T:139978535622592   DEBUG: CPythonInvoker(2, /home/xbmc/.kodi/addons/script.common.plugin.cache/default.py): script termination took 101ms
11:17:16 T:139977346250496    INFO: Python script interrupted by user
11:17:16 T:139977346250496   DEBUG: Thread LanguageInvoker 139977346250496 terminating
11:17:16 T:139978535622592    INFO: XRANDR: /usr/local/lib/kodi/kodi-xrandr --screen 0 --output HDMI-0 --mode 0x1c7
11:17:16 T:139978167334656   DEBUG: Thread ActiveAE 139978167334656 terminating
11:17:16 T:139978084448000   DEBUG: Thread AESink 139978084448000 terminating
11:17:16 T:139978535622592  NOTICE: stopped
11:17:16 T:139978535622592  NOTICE: destroy
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.dokumonster has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in script.module.pyamf has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.itunes_trailers has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.albums.allmusic.com has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in visualization.fishbmc has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in visualization.vortex has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.euphoria has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.wma has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in visualization.projectm has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in script.module.simplejson has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in weather.wunderground has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.allmusic.com has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in service.xbmc.versioncheck has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in skin.confluence has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in script.module.beautifulsoup has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in visualization.glspectrum has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in script.common.plugin.cache has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.amazon.de has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in script.module.simple.downloader has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.musicvideos.theaudiodb.com has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.hdtrailers_net has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.youtube has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in script.module.requests has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.solarwinds has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.trailerseite_de has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.zdf_de_lite has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in audioencoder.xbmc.builtin.aac has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.local has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.last.fm has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in script.module.parsedom has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in script.module.xbmcswift2 has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in plugin.video.enigmatv has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.plasma has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in visualization.waveform has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in xbmc.codec has been uninstalled.'
11:17:16 T:139978535622592   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.hdtrailers.net has been uninstalled.'
11:17:16 T:139978535622592    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x3d6c340 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
11:17:16 T:139978535622592    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x3d88a80 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
11:17:16 T:139978535622592    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x3d6ac40 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
11:17:16 T:139978535622592    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x3da9290 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
11:17:16 T:139978535622592    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x3d78810 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
11:17:16 T:139978535622592    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x3d67190 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
11:17:16 T:139978535622592    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x3dd4060 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
11:17:16 T:139978535622592    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x3d9c860 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
11:17:16 T:139978535622592    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x3d9a3e0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
11:17:16 T:139978535622592    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x3d6c9a0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
11:17:16 T:139978535622592    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x3d11760 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
11:17:16 T:139978535622592    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x3d29620 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
11:17:16 T:139978535622592    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x3dc0530 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
11:17:16 T:139978535622592    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x3cfd7f0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
11:17:16 T:139978535622592    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x3d43170 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
11:17:16 T:139978535622592    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x3d3c330 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
11:17:16 T:139978535622592  NOTICE: closing down remote control service
11:17:16 T:139978535622592  NOTICE: unload sections
11:17:16 T:139978535622592   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
11:17:16 T:139978535622592  NOTICE: special://profile/ is mapped to: special://masterprofile/
11:17:16 T:139978535622592   DEBUG: object 0 --> 0 instances
11:17:16 T:139978535622592   DEBUG: object 1 --> 0 instances
11:17:16 T:139978535622592   DEBUG: object 2 --> 0 instances
11:17:16 T:139978535622592   DEBUG: object 3 --> 0 instances
11:17:16 T:139978535622592   DEBUG: object 4 --> 0 instances
11:17:16 T:139978535622592   DEBUG: object 5 --> 0 instances
11:17:16 T:139978535622592   DEBUG: object 6 --> 0 instances
11:17:16 T:139978535622592   DEBUG: object 7 --> 0 instances
11:17:16 T:139978535622592   DEBUG: object 8 --> 0 instances
11:17:16 T:139978535622592   DEBUG: object 9 --> 0 instances
11:17:16 T:139978535622592   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
11:17:16 T:139978535622592  NOTICE: destroy
11:17:16 T:139978535622592 WARNING: Attempted to remove window 10013 from the window manager when it didn't exist
11:17:16 T:139978535622592 WARNING: Attempted to remove window 10014 from the window manager when it didn't exist
11:17:16 T:139978535622592 WARNING: Attempted to remove window 10015 from the window manager when it didn't exist
11:17:16 T:139978535622592 WARNING: Attempted to remove window 10016 from the window manager when it didn't exist
11:17:16 T:139978535622592 WARNING: Attempted to remove window 10017 from the window manager when it didn't exist
11:17:16 T:139978535622592 WARNING: Attempted to remove window 10018 from the window manager when it didn't exist
11:17:16 T:139978535622592 WARNING: Attempted to remove window 10019 from the window manager when it didn't exist
11:17:16 T:139978535622592 WARNING: Attempted to remove window 10021 from the window manager when it didn't exist
11:17:16 T:139978535622592 WARNING: Attempted to remove window 10107 from the window manager when it didn't exist
11:17:16 T:139978535622592 WARNING: Attempted to remove window 10115 from the window manager when it didn't exist
11:17:16 T:139978535622592 WARNING: Attempted to remove window 10104 from the window manager when it didn't exist
11:17:16 T:139978535622592  NOTICE: closing down remote control service
11:17:16 T:139978535622592  NOTICE: unload sections
11:17:16 T:139978535622592   DEBUG: object 0 --> 0 instances
11:17:16 T:139978535622592   DEBUG: object 1 --> 0 instances
11:17:16 T:139978535622592   DEBUG: object 2 --> 0 instances
11:17:16 T:139978535622592   DEBUG: object 3 --> 0 instances
11:17:16 T:139978535622592   DEBUG: object 4 --> 0 instances
11:17:16 T:139978535622592   DEBUG: object 5 --> 0 instances
11:17:16 T:139978535622592   DEBUG: object 6 --> 0 instances
11:17:16 T:139978535622592   DEBUG: object 7 --> 0 instances
11:17:16 T:139978535622592   DEBUG: object 8 --> 0 instances
11:17:16 T:139978535622592   DEBUG: object 9 --> 0 instances
11:17:16 T:139978535622592  NOTICE: application stopped...
11:17:16 T:139978535622592   DEBUG: PVRManager - destroyed
11:17:16 T:139978535622592   DEBUG: SECTION:UnloadDll(libcurl-gnutls.so.4)
11:17:16 T:139978535622592   DEBUG: Unloading:
11:17:16 T:139978535622592   DEBUG: LinuxRendererGL: Cleaning up GL resources
11:17:16 T:139978535622592   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/libcpluff-x86_64-linux.so)
11:17:16 T:139978535622592   DEBUG: Unloading: /libcpluff-x86_64-linux.so
11:17:16 T:139978535622592   DEBUG: SECTION:UnloadAll(DLL: libcec.so.2)
11:17:16 T:139978535622592   DEBUG: Unloading:
11:17:16 T:139978535622592   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/ImageLib-x86_64-linux.so)
11:17:16 T:139978535622592   DEBUG: Unloading: /ImageLib-x86_64-linux.so
11:17:16 T:139978535622592   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/players/dvdplayer/libdvdnav-x86_64-linux.so)
11:17:16 T:139978535622592   DEBUG: Unloading: /libdvdnav-x86_64-linux.so

nickr

2015-02-01, 20:45
Please no logs in the forum. If pastebin doesn't work, try xbmclogs.

coper2

2015-02-02, 20:47
@ nickr : Okay, next time I will use xbmclogs to post the complete kodi log. I didn't know this site.

I did some futher investigations and found the following code lines in DVDFactoryInputStream.cpp

Code:
if(item.IsDiscImage())
  {
#ifdef HAVE_LIBBLURAY
    CURL url("udf://");
    url.SetHostName(file);
    url.SetFileName("BDMV/index.bdmv");
    if(XFILE::CFile::Exists(url.Get()))
          return new CDVDInputStreamBluray(pPlayer);
#endif

    return new CDVDInputStreamNavigator(pPlayer);
  }

I guess this is the part where kodi detect if the *.iso file should be played with the DVD-Player or the BD-Player. After that I double checked the disc image to verify that it's correct and doesn't cause my problem. Then I swapped both return commands, recompiled kodi and started the image file again, but the playback still doesn't start. Confused

But now I can see in the log file that kodi really starts the internal Bluray player and output the following log messages! Smile
Code:
19:22:54 T:140311503951616   DEBUG: CDVDInputStreamBluray::Open - opening udf://%2fmnt%2fMedia%2fVideo%2ftest.iso
19:22:54 T:140311503951616   DEBUG: CDVDInputStreamBluray::Logger - bluray.c:1357: libbluray version 0.6.2
19:22:54 T:140311503951616   DEBUG: CDVDInputStreamBluray - Error opening file! (0x7f9c64000990)
19:22:54 T:140311503951616   DEBUG: CDVDInputStreamBluray::Logger - libaacs.c:86: AACS/Unit_Key_RO.inf not found. No AACS protection.
19:22:54 T:140311503951616   DEBUG: CDVDInputStreamBluray - Error opening file! (0x7f9c64000990)
19:22:54 T:140311503951616   DEBUG: CDVDInputStreamBluray::Logger - libbdplus.c:85: BDSVM/00000.svm not found. No BD+ protection.
19:22:54 T:140311503951616   DEBUG: CDVDInputStreamBluray - Error opening file! (0x7f9c64000990)
19:22:54 T:140311503951616   DEBUG: CDVDInputStreamBluray::Logger - index_parse.c:191: indx_parse(): error opening udf://%2fmnt%2fMedia%2fVideo%2ftest.iso/BDMV/index.bdmv
19:22:54 T:140311503951616   DEBUG: CDVDInputStreamBluray - Error opening file! (0x7f9c64000990)
19:22:54 T:140311503951616   DEBUG: CDVDInputStreamBluray::Logger - index_parse.c:191: indx_parse(): error opening udf://%2fmnt%2fMedia%2fVideo%2ftest.iso/BDMV/BACKUP/index.bdmv

Please take a look at the "udf://" path name. I guess there is something wrong with the character coding, but I really don't know where to start searching the error. Does anybody have an idea?
Kodi Community Forum > Support > General Support > Linux > Blu-Ray playback from *.iso files does not work