search

OpenELEC / OpenELEC.tv

OpenELEC - The living room PC for everyone
http://openelec.tv
1.61k stars 881 forks source link

CEC broken after upgrade from 2.99.4 to 2.99.5, raspberry pi version #2071

Closed frayber closed 11 years ago

frayber commented 11 years ago

Message CEC connected appears but then it does not work.

klopsknoedel commented 11 years ago

Happens for me too. But, in my case it's TV-related (LG 42LV579S).

Try disconnecting the RPi from the TV while both are ON! Now turn off TV and plugin the HDMI - cable again. If the TV does not turn on automatically, reboot the RPi via SSH and wait for the TV turning on. Now CEC should work again.

frayber commented 11 years ago

Thanks, I tried but it didn't solve my problem. With older versions worked perfectly. I have a Samsung TV

frayber commented 11 years ago

I noticed stability problems too...system often hangs and I have to reboot.

TheBobotron commented 11 years ago

Had CEC-problems with my Samsung too. Its working for me to leave the Pi turned on 24/7...

frayber commented 11 years ago

Problem is present in 3.0.0 version too. I'll come back to 2.99.4...please check this issue...thanks

sraue commented 11 years ago

it would makes sense to provide logs like xbmc.log with enabled debugging, other then that it should be reported at https://github.com/Pulse-Eight/libcec/issues

frayber commented 11 years ago

here is the xbmc.log

01:00:23 T:3043147776 NOTICE: ----------------------------------------------------------------------- 01:00:23 T:3043147776 NOTICE: Starting XBMC (12.1 Git:0d373cc), Platform: Linux (OpenELEC - Version: 3.0.0, 3.6.11 armv6l). Built on Mar 24 2013 01:00:23 T:3043147776 NOTICE: special://xbmc/ is mapped to: /usr/share/xbmc 01:00:23 T:3043147776 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/xbmc 01:00:23 T:3043147776 NOTICE: special://masterprofile/ is mapped to: /storage/.xbmc/userdata 01:00:23 T:3043147776 NOTICE: special://home/ is mapped to: /storage/.xbmc 01:00:23 T:3043147776 NOTICE: special://temp/ is mapped to: /storage/.xbmc/temp 01:00:23 T:3043147776 NOTICE: The executable running is: /usr/lib/xbmc/xbmc.bin 01:00:23 T:3043147776 NOTICE: Local hostname: openelec 01:00:23 T:3043147776 NOTICE: Log File is located: /storage/.xbmc/temp/xbmc.log 01:00:23 T:3043147776 NOTICE: ----------------------------------------------------------------------- 01:00:23 T:3043147776 NOTICE: load settings... 01:00:24 T:3043147776 NOTICE: special://profile/ is mapped to: special://masterprofile/ 01:00:24 T:3043147776 NOTICE: loading special://masterprofile/guisettings.xml 01:00:24 T:3043147776 NOTICE: Getting hardware information now... 01:00:24 T:3043147776 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 01:00:24 T:3043147776 NOTICE: Loaded playercorefactory configuration 01:00:24 T:3043147776 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 01:00:24 T:3043147776 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 01:00:24 T:3043147776 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml 01:00:24 T:3043147776 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are... <?xml version="1.0" encoding="UTF-8" ?>

false false 540 256 2 false 2097152 30 30

01:00:24 T:3043147776 NOTICE: Getting hardware information now... 01:00:24 T:3043147776 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 01:00:24 T:3043147776 NOTICE: Default DVD Player: omxplayer 01:00:24 T:3043147776 NOTICE: Default Video Player: omxplayer 01:00:24 T:3043147776 NOTICE: Default Audio Player: omxplayer 01:00:24 T:3043147776 NOTICE: Enabled debug logging due to GUI setting (2) 01:00:24 T:3043147776 NOTICE: Log level changed to 2 01:00:24 T:3043147776 NOTICE: Loading media sources from special://masterprofile/sources.xml 01:00:24 T:3043147776 DEBUG: tag is missing or sources.xml is malformed 01:00:24 T:3043147776 DEBUG: tag is missing or sources.xml is malformed 01:00:25 T:3043147776 INFO: creating subdirectories 01:00:25 T:3043147776 INFO: userdata folder: special://masterprofile/ 01:00:25 T:3043147776 INFO: recording folder: 01:00:25 T:3043147776 INFO: screenshots folder: /storage/screenshots/ 01:00:25 T:3043147776 INFO: thumbnails folder: special://masterprofile/Thumbnails 01:00:25 T:3043147776 INFO: load language info file: special://xbmc/language/Italian/langinfo.xml 01:00:25 T:3043147776 DEBUG: trying to set locale to it_IT.UTF-8 01:00:25 T:3043147776 INFO: global locale set to C 01:00:25 T:3043147776 INFO: load Italian language file, from path: special://xbmc/language/ 01:00:25 T:3043147776 DEBUG: POParser: loaded 2686 strings from file /usr/share/xbmc/language/Italian/strings.po 01:00:26 T:3043147776 DEBUG: POParser: id:16325 was recently re-used in the English string file, which is not yet changed in the translated file. Using the English string instead 22:19:10 T:3043147776 DEBUG: POParser: loaded 6 strings from file /usr/share/xbmc/language/English/strings.po 22:19:10 T:3043147776 ERROR: Error: Requested setting (audiooutput.guisoundmode) was not found. It must be case-sensitive 22:19:11 T:3043147776 NOTICE: Running database version Addons15 22:19:11 T:3043147776 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcpluff-arm.so) 22:19:11 T:3043147776 DEBUG: Loading: /usr/lib/xbmc/system/libcpluff-arm.so 22:19:14 T:3043147776 INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/lib/xbmc/addons: No such file or directory' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.hwclips has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in script.module.pyamf has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in script.module.xbmcswift has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in script.module.t0mm0.common has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in script.facebook.media has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in network.backup.rsync has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in plugin.image.flickr has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in pvr.vdr.vnsi has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in pvr.argustv has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.disclose_tv has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-osx32.xbmc.org has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in pvr.mediaportal.tvserver has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in weather.wunderground has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in script.gmail.checker has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in script.module.simplejson has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in service.libraryautoupdate has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-ios.xbmc.org has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in skin.confluence has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.documentary.net has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.fox.news has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in script.globalsearch has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in visualization.glspectrum has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in script.module.beautifulsoup has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.amazon.de has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.redbull_tv has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in script.common.plugin.cache has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in repository.openelec.tv has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in os.openelec.tv has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in metadata.albums.metal-archives.com has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in pvr.vuplus has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in metadata.musicvideos.theaudiodb.com has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.vimeo has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in script.module.simple.downloader has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.hdtrailers_net has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in os.openelec.settings has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.youtube has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.espn.video has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in pvr.demo has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in script.module.requests has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in pvr.vdr.xvdr has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in pvr.njoy has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in pvr.nextpvr has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.khanacademy has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-android.xbmc.org has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in plugin.image.google has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in plugin.image.picasa has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-win32.xbmc.org has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in pvr.dvbviewer has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-osx64.xbmc.org has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in pvr.mythtv.cmyth has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in script.module.buggalo has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.pinkbike has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.last.fm has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in script.module.parsedom has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.metal-archives.com has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.classiccinema has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in script.module.xbmcswift2 has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in script.module.elementtree has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in script.web.viewer has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in visualization.waveform has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in pvr.hts has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.filmon has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.hdtrailers.net has been installed.' 22:19:14 T:3043147776 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.' 22:19:14 T:3043147776 DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid" 22:19:14 T:3043147776 DEBUG: LoadMappings - loaded node "CEC Adapter" 22:19:14 T:3043147776 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter" 22:19:14 T:3043147776 DEBUG: LoadMappings - loaded node "iMON HID device" 22:19:14 T:3043147776 DEBUG: CPeripheralBusUSB - initialised udev monitor 22:19:14 T:3043147776 DEBUG: SECTION:LoadDLL(libcec.so.2) 22:19:14 T:3043147776 DEBUG: Loading: libcec.so.2 22:19:14 T:3043147776 DEBUG: GetMappingForDevice - device (2708:1001) mapped to CEC Adapter (type = cec) 22:19:15 T:3043147776 DEBUG: InitialiseFeature - using libCEC v2.1.1 22:19:15 T:3043147776 DEBUG: Initialise - initialised peripheral on 'RPI' with 2 features and 0 sub devices 22:19:15 T:3043147776 NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001) 22:19:15 T:3032478816 NOTICE: Thread CEC Adapter start, auto delete: false 22:19:15 T:3032478816 DEBUG: OpenConnection - opening a connection to the CEC adapter: RPI 22:19:15 T:3032478816 DEBUG: CecLogMessage - unregistering all CEC clients 22:19:15 T:3032478816 DEBUG: CecLogMessage - Broadcast (F): osd name set to 'Broadcast' 22:19:15 T:3032478816 DEBUG: CecLogMessage - InitHostCEC - vchiq_initialise succeeded 22:19:15 T:3032478816 DEBUG: CecLogMessage - InitHostCEC - vchi_initialise succeeded 22:19:15 T:3032478816 DEBUG: CecLogMessage - InitHostCEC - vchi_connect succeeded 22:19:15 T:3021993056 NOTICE: Thread XBMC Peripherals start, auto delete: false 22:19:15 T:3043147776 NOTICE: Previous line repeats 1 times. 22:19:15 T:3043147776 INFO: LIRC Initialize: using: /var/run/lirc/lircd 22:19:15 T:3043147776 INFO: LIRC Initialize: sucessfully started 22:19:15 T:3043147776 DEBUG: Selected UDisks as storage provider 22:19:15 T:3043147776 DEBUG: UDisks: DaemonVersion 1 22:19:15 T:3043147776 DEBUG: UDisks: Querying available devices 22:19:15 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd11: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:15 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd12: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:16 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd13: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:16 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd0: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:16 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd1: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:16 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd15: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:16 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd14: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:16 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd3: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:16 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd2: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:16 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd5: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:16 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd4: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:17 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd7: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:17 T:3043147776 DEBUG: UDisks: Mounting /org/freedesktop/UDisks/devices/sda1 22:19:18 T:3032478816 ERROR: CecLogMessage - failed to release the previous LA 22:19:18 T:3032478816 ERROR: CecLogMessage - could not open a connection (try 1) 22:19:19 T:3032478816 DEBUG: CecLogMessage - InitHostCEC - vchiq_initialise succeeded 22:19:19 T:3032478816 DEBUG: CecLogMessage - InitHostCEC - vchi_initialise succeeded 22:19:19 T:3032478816 DEBUG: CecLogMessage - InitHostCEC - vchi_connect succeeded 22:19:21 T:3032478816 ERROR: CecLogMessage - failed to release the previous LA 22:19:21 T:3032478816 ERROR: CecLogMessage - could not open a connection (try 2) 22:19:22 T:3032478816 DEBUG: CecLogMessage - InitHostCEC - vchiq_initialise succeeded 22:19:22 T:3032478816 DEBUG: CecLogMessage - InitHostCEC - vchi_initialise succeeded 22:19:22 T:3032478816 DEBUG: CecLogMessage - InitHostCEC - vchi_connect succeeded 22:19:23 T:3032478816 ERROR: CecLogMessage - failed to release the previous LA 22:19:23 T:3032478816 ERROR: CecLogMessage - could not open a connection (try 3) 22:19:24 T:3032478816 DEBUG: CecLogMessage - InitHostCEC - vchiq_initialise succeeded 22:19:24 T:3032478816 DEBUG: CecLogMessage - InitHostCEC - vchi_initialise succeeded 22:19:24 T:3032478816 DEBUG: CecLogMessage - InitHostCEC - vchi_connect succeeded 22:19:24 T:3032478816 ERROR: CecLogMessage - failed to release the previous LA 22:19:24 T:3032478816 ERROR: CecLogMessage - could not open a connection (try 4) 22:19:25 T:3032478816 DEBUG: CecLogMessage - connection opened 22:19:25 T:3032478816 ERROR: CecLogMessage - could not start CEC communications 22:19:25 T:3032478816 ERROR: OpenConnection - could not opening a connection to the CEC adapter 22:19:25 T:3043147776 DEBUG: UDisks: Sucessfully mounted /org/freedesktop/UDisks/devices/sda1 on /media/My Book 22:19:25 T:3043147776 INFO: UDisks: Added /media/My Book 22:19:25 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/mmcblk0: IsFileSystem false HasFileSystem IsSystemInternal false IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:25 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd8: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:25 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd6: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:26 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd9: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:26 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/mmcblk0p1: IsFileSystem true HasFileSystem vfat IsSystemInternal false IsMounted true IsRemovable false IsPartition true IsOptical false 22:19:26 T:3043147776 INFO: UDisks: Added /flash 22:19:26 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/mmcblk0p2: IsFileSystem true HasFileSystem ext4 IsSystemInternal false IsMounted true IsRemovable false IsPartition true IsOptical false 22:19:26 T:3043147776 INFO: UDisks: Added /storage 22:19:26 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/sda: IsFileSystem false HasFileSystem IsSystemInternal false IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:26 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/loop0: IsFileSystem true HasFileSystem squashfs IsSystemInternal true IsMounted true IsRemovable false IsPartition false IsOptical false 22:19:26 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/zram0: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:26 T:3043147776 DEBUG: UDisks: Is not able to mount DeviceUDI /org/freedesktop/UDisks/devices/nbd10: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false 22:19:26 T:3043147776 DEBUG: DllBcm: Using omx system library 22:19:26 T:3043147776 DEBUG: SECTION:LoadDLL(libopenmaxil.so) 22:19:26 T:3043147776 DEBUG: Loading: libopenmaxil.so 22:19:26 T:3043147776 NOTICE: Raspberry PI firmware version: Mar 19 2013 00:02:38 Copyright (c) 2012 Broadcom version 377915 (release) 22:19:26 T:3043147776 DEBUG: DllBcm: Using omx system library 22:19:26 T:3043147776 NOTICE: InitWindowSystem: Using EGL Implementation: raspberrypi 22:19:26 T:3043147776 DEBUG: EGL initial desktop resolution 1920x1080 @ 60.00 - Full Screen (1.00) 22:19:26 T:3043147776 DEBUG: EGL get supported modes (1) = 14, prefer_group=1, prefer_mode=10 22:19:26 T:3043147776 DEBUG: EGL mode 0: 640x480 @ 60.00 - Full Screen (1.00) :1 22:19:26 T:3043147776 DEBUG: EGL mode 1: 720x480 @ 60.00 - Full Screen (0.89) :2 22:19:26 T:3043147776 DEBUG: EGL mode 2: 720x480 @ 60.00 - Full Screen (1.19) :3 22:19:26 T:3043147776 DEBUG: EGL mode 3: 1280x720 @ 60.00 - Full Screen (1.00) :4 22:19:26 T:3043147776 DEBUG: EGL mode 4: 1920x1080 @ 60.00i - Full Screen (1.00) I:5 22:19:26 T:3043147776 DEBUG: EGL mode 5: 1920x1080 @ 60.00 - Full Screen (1.00) N:10 22:19:26 T:3043147776 DEBUG: EGL mode 6: 720x576 @ 50.00 - Full Screen (1.07) :11 22:19:26 T:3043147776 DEBUG: EGL mode 7: 720x576 @ 50.00 - Full Screen (1.42) :12 22:19:26 T:3043147776 DEBUG: EGL mode 8: 1280x720 @ 50.00 - Full Screen (1.00) :13 22:19:26 T:3043147776 DEBUG: EGL mode 9: 1920x1080 @ 50.00i - Full Screen (1.00) I:14 22:19:26 T:3043147776 DEBUG: EGL mode 10: 1920x1080 @ 50.00 - Full Screen (1.00) :1f 22:19:26 T:3043147776 DEBUG: EGL mode 11: 1920x1080 @ 24.00 - Full Screen (1.00) :20 22:19:26 T:3043147776 DEBUG: EGL mode 12: 1920x1080 @ 25.00 - Full Screen (1.00) :21 22:19:26 T:3043147776 DEBUG: EGL mode 13: 1920x1080 @ 30.00 - Full Screen (1.00) :22 22:19:26 T:3043147776 DEBUG: EGL get supported modes (2) = 1, prefer_group=1, prefer_mode=10 22:19:26 T:3043147776 DEBUG: EGL mode 0: 640x480 @ 60.00 - Full Screen (1.00) :4 22:19:26 T:3043147776 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 60.000000 Hz 22:19:26 T:3043147776 NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 60.000000 Hz 22:19:26 T:3043147776 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 60.000000 Hz 22:19:26 T:3043147776 NOTICE: Found resolution 1280 x 720 for display 0 with 1920 x 1080 @ 60.000000 Hz 22:19:26 T:3043147776 NOTICE: Found resolution 720 x 576 for display 0 with 720 x 576 @ 50.000000 Hz 22:19:26 T:3043147776 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 50.000000 Hz 22:19:26 T:3043147776 NOTICE: Found resolution 1280 x 720 for display 0 with 1920 x 1080 @ 50.000000 Hz 22:19:26 T:3043147776 NOTICE: Found resolution 1280 x 720 for display 0 with 1920 x 1080 @ 24.000000 Hz 22:19:26 T:3043147776 NOTICE: Found resolution 1280 x 720 for display 0 with 1920 x 1080 @ 25.000000 Hz 22:19:26 T:3043147776 NOTICE: Found resolution 1280 x 720 for display 0 with 1920 x 1080 @ 30.000000 Hz 22:19:26 T:3043147776 NOTICE: Found (1280x720@60.000000) at 19, setting to RES_DESKTOP at 16 22:19:26 T:3043147776 NOTICE: Checking resolution 16 22:19:26 T:2996827232 DEBUG: EGL tv_service_callback (8,1,16) 22:19:26 T:3043147776 DEBUG: EGL set HDMI mode (1,16)=0 22:19:26 T:3043147776 DEBUG: EGL set resolution 1280x720 -> 1920x1080 @ 60.00 fps (1,16) flags:10010004 aspect:1.00 22:19:26 T:3043147776 DEBUG: CreateWindow: Created surface of size 1280x720 22:19:26 T:3043147776 NOTICE: GL_VENDOR = Broadcom 22:19:26 T:3043147776 NOTICE: GL_RENDERER = VideoCore IV HW 22:19:26 T:3043147776 NOTICE: GL_VERSION = OpenGL ES 2.0 22:19:26 T:3043147776 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 22:19:26 T:3043147776 DEBUG: GLES: Extension Support Test - GL_NVX_gpu_memory_info NO 22:19:26 T:3043147776 NOTICE: GL_EXTENSIONS = GL_OES_compressed_ETC1_RGB8_texture GL_OES_compressed_paletted_texture GL_OES_texture_npot GL_OES_depth24 GL_OES_vertex_half_float GL_OES_EGL_image GL_OES_EGL_image_external GL_EXT_discard_framebuffer GL_OES_rgb8_rgba8 GL_OES_depth32 GL_OES_mapbuffer GL_EXT_texture_format_BGRA8888 GL_APPLE_rgb_422 GL_EXT_debug_marker 22:19:26 T:3043147776 DEBUG: GLES: Extension Support Test - GL_EXT_texture_format_BGRA8888 YES 22:19:26 T:3043147776 DEBUG: GLES: Extension Support Test - GL_IMG_texture_format_BGRA8888 NO 22:19:26 T:3043147776 DEBUG: GLES: Extension Support Test - GL_APPLE_texture_format_BGRA8888 NO 22:19:26 T:3043147776 DEBUG: GL: Vertex Shader compilation log: 22:19:26 T:3043147776 DEBUG: Compiled 22:19:26 T:3043147776 DEBUG: GL: Vertex Shader compiled successfully 22:19:26 T:3043147776 DEBUG: GL: Pixel Shader compilation log: 22:19:26 T:3043147776 DEBUG: Compiled 22:19:26 T:3043147776 DEBUG: GL: Fragment Shader compiled successfully 22:19:26 T:3043147776 DEBUG: GUI Shader [guishader_frag_default.glsl]- Initialise successful : 0x268ae48 22:19:26 T:3043147776 DEBUG: GL: Vertex Shader compilation log: 22:19:26 T:3043147776 DEBUG: Compiled 22:19:26 T:3043147776 DEBUG: GL: Vertex Shader compiled successfully 22:19:26 T:3043147776 DEBUG: GL: Pixel Shader compilation log: 22:19:26 T:3043147776 DEBUG: Compiled 22:19:26 T:3043147776 DEBUG: GL: Fragment Shader compiled successfully 22:19:26 T:3043147776 DEBUG: GUI Shader [guishader_frag_texture.glsl]- Initialise successful : 0x25b65c8 22:19:26 T:3043147776 DEBUG: GL: Vertex Shader compilation log: 22:19:26 T:3043147776 DEBUG: Compiled 22:19:26 T:3043147776 DEBUG: GL: Vertex Shader compiled successfully 22:19:26 T:3043147776 DEBUG: GL: Pixel Shader compilation log: 22:19:26 T:3043147776 DEBUG: Compiled 22:19:26 T:3043147776 DEBUG: GL: Fragment Shader compiled successfully 22:19:26 T:3043147776 DEBUG: GUI Shader [guishader_frag_multi.glsl]- Initialise successful : 0x25536c0 22:19:26 T:3043147776 DEBUG: GL: Vertex Shader compilation log: 22:19:26 T:3043147776 DEBUG: Compiled 22:19:26 T:3043147776 DEBUG: GL: Vertex Shader compiled successfully 22:19:26 T:3043147776 DEBUG: GL: Pixel Shader compilation log: 22:19:26 T:3043147776 DEBUG: Compiled 22:19:26 T:3043147776 DEBUG: GL: Fragment Shader compiled successfully 22:19:26 T:3043147776 DEBUG: GUI Shader [guishader_frag_fonts.glsl]- Initialise successful : 0x268f7b0 22:19:26 T:3043147776 DEBUG: GL: Vertex Shader compilation log: 22:19:26 T:3043147776 DEBUG: Compiled 22:19:26 T:3043147776 DEBUG: GL: Vertex Shader compiled successfully 22:19:26 T:3043147776 DEBUG: GL: Pixel Shader compilation log: 22:19:26 T:3043147776 DEBUG: Compiled 22:19:26 T:3043147776 DEBUG: GL: Fragment Shader compiled successfully 22:19:26 T:3043147776 DEBUG: GUI Shader [guishader_frag_texture_noblend.glsl]- Initialise successful : 0x2692b70 22:19:26 T:3043147776 DEBUG: GL: Vertex Shader compilation log: 22:19:26 T:3043147776 DEBUG: Compiled 22:19:26 T:3043147776 DEBUG: GL: Vertex Shader compiled successfully 22:19:26 T:3043147776 DEBUG: GL: Pixel Shader compilation log: 22:19:26 T:3043147776 DEBUG: Compiled 22:19:26 T:3043147776 DEBUG: GL: Fragment Shader compiled successfully 22:19:26 T:3043147776 DEBUG: GUI Shader [guishader_frag_multi_blendcolor.glsl]- Initialise successful : 0x2553128 22:19:26 T:3043147776 DEBUG: GL: Vertex Shader compilation log: 22:19:26 T:3043147776 DEBUG: Compiled 22:19:26 T:3043147776 DEBUG: GL: Vertex Shader compiled successfully 22:19:26 T:3043147776 DEBUG: GL: Pixel Shader compilation log: 22:19:27 T:3043147776 DEBUG: Compiled 22:19:27 T:3043147776 DEBUG: GL: Fragment Shader compiled successfully 22:19:27 T:3043147776 DEBUG: GUI Shader [guishader_frag_rgba.glsl]- Initialise successful : 0x25535f8 22:19:27 T:3043147776 DEBUG: GL: Vertex Shader compilation log: 22:19:27 T:3043147776 DEBUG: Compiled 22:19:27 T:3043147776 DEBUG: GL: Vertex Shader compiled successfully 22:19:27 T:3043147776 DEBUG: GL: Pixel Shader compilation log: 22:19:27 T:3043147776 DEBUG: Compiled 22:19:27 T:3043147776 DEBUG: GL: Fragment Shader compiled successfully 22:19:27 T:3043147776 DEBUG: GUI Shader [guishader_frag_rgba_blendcolor.glsl]- Initialise successful : 0x26908d8 22:19:27 T:3043147776 DEBUG: CWinSystemEGL::CreateNewWindow: No need to create a new window 22:19:27 T:3043147776 INFO: GLES: Maximum texture width: 2048 22:19:27 T:3043147776 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec 22:19:27 T:3043147776 INFO: load default splash image: /usr/share/xbmc/media/Splash.png 22:19:27 T:3043147776 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib-arm.so) 22:19:27 T:3043147776 DEBUG: Loading: /usr/lib/xbmc/system/ImageLib-arm.so 22:19:27 T:3043147776 INFO: load keymapping 22:19:27 T:3043147776 INFO: Loading special://xbmc/system/keymaps/appcommand.xml 22:19:27 T:3043147776 INFO: Loading special://xbmc/system/keymaps/gamepad.xml 22:19:28 T:3043147776 INFO: Loading special://xbmc/system/keymaps/joystick.Alienware.Dual.Compatible.Controller.xml 22:19:28 T:3043147776 INFO: Loading special://xbmc/system/keymaps/joystick.AppleRemote.xml 22:19:28 T:3043147776 INFO: Loading special://xbmc/system/keymaps/joystick.Harmony.xml 22:19:28 T:3043147776 INFO: Loading special://xbmc/system/keymaps/joystick.Interact.AxisPad.xml 22:19:28 T:3043147776 INFO: Loading special://xbmc/system/keymaps/joystick.Logitech.RumblePad.2.xml 22:19:28 T:3043147776 INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.360.Controller.xml 22:19:28 T:3043147776 INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.Controller.S.xml 22:19:29 T:3043147776 INFO: Loading special://xbmc/system/keymaps/joystick.PS3.Remote.Keyboard.xml 22:19:29 T:3043147776 INFO: Loading special://xbmc/system/keymaps/joystick.Sony.PLAYSTATION(R)3.Controller.xml 22:19:29 T:3043147776 INFO: Loading special://xbmc/system/keymaps/joystick.WiiRemote.xml 22:19:29 T:3043147776 INFO: Loading special://xbmc/system/keymaps/keyboard.xml 22:19:29 T:3043147776 INFO: Loading special://xbmc/system/keymaps/mouse.xml 22:19:29 T:3043147776 INFO: Loading special://xbmc/system/keymaps/remote.xml 22:19:30 T:3043147776 INFO: Loading special://xbmc/system/Lircmap.xml 22:19:30 T:3043147776 INFO: * Adding remote mapping for device 'mceusb' 22:19:30 T:3043147776 INFO: * Adding remote mapping for device 'XboxDVDDongle' 22:19:30 T:3043147776 INFO: * Adding remote mapping for device 'Microsoft_Xbox' 22:19:30 T:3043147776 INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote' 22:19:30 T:3043147776 INFO: * Adding remote mapping for device 'anysee' 22:19:30 T:3043147776 INFO: * Adding remote mapping for device 'iMON-PAD' 22:19:30 T:3043147776 INFO: * Adding remote mapping for device 'Antec_Veris_RM200' 22:19:30 T:3043147776 INFO: * Adding remote mapping for device 'MCE_via_iMON' 22:19:30 T:3043147776 INFO: * Adding remote mapping for device 'TwinHanRemote' 22:19:30 T:3043147776 INFO: * Adding remote mapping for device 'linux-input-layer' 22:19:30 T:3043147776 INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote' 22:19:30 T:3043147776 INFO: * Adding remote mapping for device 'mediacenter' 22:19:30 T:3043147776 INFO: * Adding remote mapping for device 'devinput' 22:19:30 T:3043147776 DEBUG: CButtonTranslator::Load - no userdata Lircmap.xml found, skipping 22:19:30 T:3043147776 INFO: GUI format 1280x720, Display 1920x1080 @ 60.00 - Full Screen 22:19:30 T:3043147776 DEBUG: guilib: Fill viewport on change for solving rendering passes 22:19:30 T:3043147776 DEBUG: SECTION:LoadDLL(libcurl.so.4) 22:19:30 T:3043147776 DEBUG: Loading: libcurl.so.4 22:19:31 T:3043147776 NOTICE: Running database version Addons15 22:19:31 T:3043147776 DEBUG: Initialize, updating databases... 22:19:31 T:3043147776 NOTICE: Running database version ViewModes4 22:19:31 T:3043147776 NOTICE: Running database version Textures13 22:19:31 T:3043147776 NOTICE: Running database version MyMusic32 22:19:31 T:3043147776 NOTICE: Running database version MyVideos75 22:19:31 T:3043147776 NOTICE: Running database version TV22 22:19:31 T:3043147776 NOTICE: Running database version Epg7 22:19:31 T:3043147776 DEBUG: Initialize, updating databases... DONE 22:19:31 T:3043147776 NOTICE: start dvd mediatype detection 22:19:31 T:3043147776 NOTICE: initializing playlistplayer 22:19:31 T:3043147776 NOTICE: DONE initializing playlistplayer 22:19:31 T:3043147776 INFO: DPMS: not supported on this platform 22:19:31 T:2961036384 NOTICE: Thread CDetectDVDMedia start, auto delete: false 22:19:31 T:2961036384 DEBUG: Compiled with libcdio Version 0.90 22:19:31 T:2961036384 DEBUG: Thread CDetectDVDMedia 2961036384 terminating 22:19:32 T:3043147776 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 22:19:32 T:3043147776 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 22:19:32 T:3043147776 INFO: Unloading old skin ... 22:19:32 T:3043147776 INFO: load skin from: /usr/share/xbmc/addons/skin.confluence (version: 2.1.4) 22:19:32 T:3043147776 INFO: load fonts for skin... 22:19:32 T:3043147776 INFO: Loading fonts from /usr/share/xbmc/addons/skin.confluence/720p/Font.xml 22:19:32 T:3043147776 DEBUG: POParser: loaded 131 strings from file /usr/share/xbmc/addons/skin.confluence/language/Italian/strings.po 22:19:32 T:3043147776 DEBUG: POParser: loaded 0 strings from file /usr/share/xbmc/addons/skin.confluence/language/English/strings.po 22:19:32 T:3043147776 INFO: Loading skin includes from /usr/share/xbmc/addons/skin.confluence/720p/includes.xml 22:19:35 T:3032478816 DEBUG: CecLogMessage - unregistering all CEC clients 22:19:35 T:3032478816 DEBUG: CecLogMessage - InitHostCEC - vchiq_initialise succeeded 22:19:35 T:3032478816 DEBUG: CecLogMessage - InitHostCEC - vchi_initialise succeeded 22:19:35 T:3032478816 DEBUG: CecLogMessage - InitHostCEC - vchi_connect succeeded 22:19:35 T:2988438624 DEBUG: CecLogMessage - logical address changed to Broadcast (f) 22:19:35 T:3032478816 DEBUG: CecLogMessage - RegisterLogicalAddress - registering address e 22:19:35 T:2988438624 DEBUG: CecLogMessage - logical address changed to Playback 1 (4) 22:19:35 T:2988438624 DEBUG: CecLogMessage - logical address changed to Free use (e) 22:19:35 T:3032478816 DEBUG: CecLogMessage - Open - vc_cec initialised 22:19:35 T:3032478816 DEBUG: CecLogMessage - connection opened 22:19:35 T:3032478816 DEBUG: CecLogMessage - << Broadcast (F) -> TV (0): POLL 22:19:35 T:3032478816 DEBUG: CecLogMessage - initiator 'Broadcast' is not supported by the CEC adapter. using 'Free use' instead 22:19:35 T:3032478816 DEBUG: CecLogMessage - << e0 22:19:35 T:2960634976 DEBUG: CecLogMessage - processor thread started 22:19:35 T:3032478816 DEBUG: CecLogMessage - >> POLL sent 22:19:35 T:3032478816 DEBUG: CecLogMessage - TV (0): device status changed into 'present' 22:19:35 T:3032478816 DEBUG: CecLogMessage - << requesting vendor ID of 'TV' (0) 22:19:35 T:3032478816 DEBUG: CecLogMessage - << e0:8c 22:19:36 T:3043147776 INFO: load new skin... 22:19:36 T:3043147776 INFO: Loading user windows, path /usr/share/xbmc/addons/skin.confluence/720p 22:19:36 T:3043147776 DEBUG: Load Skin XML: 54.85ms 22:19:36 T:3043147776 INFO: initialize new skin... 22:19:36 T:3043147776 DEBUG: guilib: Fill viewport on change for solving rendering passes 22:19:36 T:3043147776 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT 22:19:36 T:3043147776 DEBUG: OpenBundle - Opened bundle /usr/share/xbmc/addons/skin.confluence/media/Textures.xbt 22:19:36 T:3043147776 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT 22:19:36 T:3043147776 INFO: Loading skin file: DialogKaiToast.xml, load type: LOAD_ON_GUI_INIT 22:19:36 T:3043147776 INFO: Loading skin file: DialogMuteBug.xml, load type: LOAD_ON_GUI_INIT 22:19:36 T:3043147776 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT 22:19:36 T:3043147776 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT 22:19:36 T:3043147776 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT 22:19:36 T:3043147776 INFO: Loading /usr/share/xbmc/addons/skin.confluence/sounds/sounds.xml 22:19:36 T:3043147776 INFO: skin loaded... 22:19:36 T:3032478816 DEBUG: CecLogMessage - expected response not received (87: device vendor id) 22:19:36 T:3032478816 DEBUG: CecLogMessage - << e0:8c 22:19:37 T:3043147776 INFO: JSONRPC v6.0.3: Successfully initialized 22:19:37 T:3043147776 DEBUG: ADDON: Starting service addons. 22:19:37 T:3043147776 INFO: initializing python engine. 22:19:37 T:3043147776 DEBUG: new python thread created. id=1 22:19:37 T:3043147776 INFO: initializing python engine. 22:19:37 T:3043147776 DEBUG: new python thread created. id=2 22:19:37 T:3043147776 DEBUG: Activating window ID: 12999 22:19:37 T:3043147776 DEBUG: ------ Window Init (Startup.xml) ------ 22:19:37 T:3043147776 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME 22:19:37 T:2951435360 NOTICE: Thread XBPyThread start, auto delete: false 22:19:37 T:2951435360 DEBUG: Python thread: start processing 22:19:37 T:2943046752 NOTICE: Thread XBPyThread start, auto delete: false 22:19:37 T:2943046752 DEBUG: Python thread: start processing 22:19:37 T:3043147776 INFO: removing tempfiles 22:19:37 T:3043147776 DEBUG: ADDON: Starting service addons. 22:19:37 T:3043147776 INFO: initializing python engine. 22:19:37 T:3043147776 DEBUG: new python thread created. id=3 22:19:37 T:3043147776 NOTICE: initialize done 22:19:37 T:3043147776 NOTICE: Running the application... 22:19:37 T:3043147776 DEBUG: ExecuteXBMCAction : Translating ReplaceWindow(Home) 22:19:37 T:3043147776 DEBUG: ExecuteXBMCAction : To ReplaceWindow(Home) 22:19:37 T:3043147776 DEBUG: Activating window ID: 10000 22:19:37 T:2934391904 NOTICE: Thread XBPyThread start, auto delete: false 22:19:37 T:2934391904 DEBUG: Python thread: start processing 22:19:37 T:3032478816 DEBUG: CecLogMessage - expected response not received (87: device vendor id) 22:19:37 T:3032478816 DEBUG: CecLogMessage - registering new CEC client - v2.1.1 22:19:37 T:3032478816 DEBUG: CecLogMessage - detecting logical address for type 'recording device' 22:19:37 T:3032478816 DEBUG: CecLogMessage - trying logical address 'Recorder 1' 22:19:37 T:3032478816 DEBUG: CecLogMessage - << Recorder 1 (1) -> Recorder 1 (1): POLL 22:19:37 T:3032478816 DEBUG: CecLogMessage - << 11 22:19:37 T:3032478816 DEBUG: CecLogMessage - UnregisterLogicalAddress - releasing previous logical address 22:19:37 T:2988438624 DEBUG: CecLogMessage - logical address changed to Broadcast (f) 22:19:37 T:3032478816 DEBUG: CecLogMessage - RegisterLogicalAddress - registering address 1 22:19:37 T:3043147776 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.image_decode handle 0x02e49318 dllopen : 1 22:19:37 T:3043147776 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 22:19:37 T:3043147776 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.resize handle 0x02e28fe0 dllopen : 1 22:19:37 T:3043147776 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 22:19:37 T:3043147776 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(3), nBufferSize(81920), nBufferAlignmen(16) 22:19:37 T:3043147776 DEBUG: COMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.resize) - port(61), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(3686400) nBufferAlignmen(16) 22:19:38 T:2988438624 DEBUG: CecLogMessage - logical address changed to Free use (e) 22:19:38 T:3032478816 DEBUG: CecLogMessage - << 11 22:19:38 T:3032478816 DEBUG: CecLogMessage - UnregisterLogicalAddress - releasing previous logical address 22:19:38 T:2988438624 DEBUG: CecLogMessage - logical address changed to Recorder 1 (1) 22:19:38 T:3032478816 DEBUG: CecLogMessage - RegisterLogicalAddress - registering address 1 22:19:38 T:3043147776 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x02e28fe0 dllopen : 1 22:19:38 T:3043147776 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x02e49318 dllopen : 1 22:19:38 T:3043147776 DEBUG: ------ Window Init () ------ 22:19:38 T:2988438624 DEBUG: CecLogMessage - logical address changed to Broadcast (f) 22:19:38 T:2988438624 DEBUG: CecLogMessage - logical address changed to Recorder 1 (1) 22:19:38 T:3032478816 DEBUG: Previous line repeats 1 times. 22:19:38 T:3032478816 DEBUG: CecLogMessage - >> POLL not sent 22:19:38 T:3032478816 DEBUG: CecLogMessage - using logical address 'Recorder 1' 22:19:38 T:3032478816 DEBUG: CecLogMessage - Recorder 1 (1): device status changed into 'handled by libCEC' 22:19:38 T:3032478816 DEBUG: CecLogMessage - Recorder 1 (1): power status changed from 'unknown' to 'on' 22:19:38 T:3032478816 DEBUG: CecLogMessage - Recorder 1 (1): CEC version 1.4 22:19:38 T:3032478816 DEBUG: CecLogMessage - AllocateLogicalAddresses - device '0', type 'recording device', LA '1' 22:19:38 T:3032478816 DEBUG: CecLogMessage - Recorder 1 (1): osd name set to 'XBMC' 22:19:38 T:3032478816 DEBUG: CecLogMessage - Recorder 1 (1): menu language set to 'eng' 22:19:38 T:3032478816 DEBUG: CecLogMessage - GetPhysicalAddress - physical address = 2000 22:19:38 T:3032478816 DEBUG: CecLogMessage - AutodetectPhysicalAddress - autodetected physical address '2000' 22:19:38 T:3032478816 DEBUG: CecLogMessage - Recorder 1 (1): physical address changed from ffff to 2000 22:19:38 T:3032478816 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): physical adddress 2000 22:19:38 T:3032478816 DEBUG: CecLogMessage - << 1f:84:20:00:01 22:19:38 T:3043147776 DEBUG: ------ Window Init (Pointer.xml) ------ 22:19:38 T:3032478816 DEBUG: CecLogMessage - making Recorder 1 (1) the active source 22:19:38 T:3032478816 DEBUG: CecLogMessage - TV (0): power status changed from 'unknown' to 'in transition from standby to on' 22:19:38 T:3032478816 DEBUG: CecLogMessage - >> source activated: Recorder 1 (1) 22:19:38 T:3032478816 DEBUG: CecLogMessage - scheduling active source message for 'Recorder 1' 22:19:38 T:3032478816 DEBUG: CecLogMessage - CEC client registered: libCEC version = 2.1.1, client version = 2.1.1, firmware version = 1, logical address(es) = Recorder 1 (1) , physical address: 2.0.0.0, host: armv6zk-openelec-linux-gnueabi, features: 'P8 USB' 'P8 USB detect' 'RPi', git revision: 5c23e3f, compiled on: Sat Mar 23 18:47:46 UTC 2013 by openelec@buildsystem.lhhi.local on Linux 2.6.32-5-amd64 (x86_64) 22:19:38 T:3032478816 DEBUG: CecLogMessage - << Recorder 1 (1) -> TV (0): OSD name 'XBMC' 22:19:38 T:3032478816 DEBUG: CecLogMessage - << 10:47:58:42:4d:43 22:19:38 T:3043147776 DEBUG: ------ Window Deinit (Startup.xml) ------ 22:19:38 T:3043147776 DEBUG: ------ Window Init (Home.xml) ------ 22:19:38 T:3043147776 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY 22:19:38 T:3032478816 DEBUG: CecLogMessage - << requesting power status of 'TV' (0) 22:19:38 T:3032478816 DEBUG: CecLogMessage - << 10:8f 22:19:39 T:3032478816 DEBUG: CecLogMessage - expected response not received (90: report power status) 22:19:39 T:3032478816 DEBUG: CecLogMessage - << 10:8f 22:19:39 T:2960634976 DEBUG: CecLogMessage - << 10:04 22:19:39 T:2960634976 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (2000) 22:19:39 T:2960634976 DEBUG: CecLogMessage - << 1f:82:20:00 22:19:39 T:2960634976 DEBUG: CecLogMessage - << Recorder 1 (1) -> TV (0): menu state 'activated' 22:19:39 T:2960634976 DEBUG: CecLogMessage - << 10:8e:00 22:19:40 T:2951435360 NOTICE: -->Python Interpreter Initialized<-- 22:19:40 T:2951435360 DEBUG: Process - The source file to load is /storage/.xbmc/addons/service.libraryautoupdate/default.py 22:19:40 T:2943046752 NOTICE: -->Python Interpreter Initialized<-- 22:19:40 T:2943046752 DEBUG: Process - The source file to load is /storage/.xbmc/addons/script.module.simple.downloader/default.py 22:19:40 T:2951435360 DEBUG: Process - Setting the Python path to /storage/.xbmc/addons/service.libraryautoupdate:/storage/.xbmc/addons/script.module.pyamf/lib:/storage/.xbmc/addons/script.module.xbmcswift/lib:/storage/.xbmc/addons/script.module.t0mm0.common/lib:/usr/share/xbmc/addons/weather.wunderground/resources/lib/wunderground:/storage/.xbmc/addons/script.module.simplejson/lib:/storage/.xbmc/addons/script.module.beautifulsoup/lib:/usr/share/xbmc/addons/script.module.pil/lib:/storage/.xbmc/addons/script.common.plugin.cache/lib:/storage/.xbmc/addons/script.module.simple.downloader/lib:/storage/.xbmc/addons/script.module.requests/lib:/storage/.xbmc/addons/script.module.buggalo/lib:/storage/.xbmc/addons/script.module.parsedom/lib:/storage/.xbmc/addons/script.module.xbmcswift2/lib:/storage/.xbmc/addons/script.module.elementtree/lib:/storage/.xbmc/addons/script.web.viewer/lib:/usr/lib/python27.zip:/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/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/PIL:/usr/lib/python2.7/site-packages/gtk-2.0: 22:19:40 T:2951435360 DEBUG: Process - Entering source directory /storage/.xbmc/addons/service.libraryautoupdate 22:19:40 T:2951435360 DEBUG: Instantiating addon using automatically obtained id of "service.libraryautoupdate" dependent on version 2.1.0 of the xbmc.python api 22:19:40 T:2943046752 DEBUG: Process - Setting the Python path to /storage/.xbmc/addons/script.module.simple.downloader:/storage/.xbmc/addons/script.module.pyamf/lib:/storage/.xbmc/addons/script.module.xbmcswift/lib:/storage/.xbmc/addons/script.module.t0mm0.common/lib:/usr/share/xbmc/addons/weather.wunderground/resources/lib/wunderground:/storage/.xbmc/addons/script.module.simplejson/lib:/storage/.xbmc/addons/script.module.beautifulsoup/lib:/usr/share/xbmc/addons/script.module.pil/lib:/storage/.xbmc/addons/script.common.plugin.cache/lib:/storage/.xbmc/addons/script.module.simple.downloader/lib:/storage/.xbmc/addons/script.module.requests/lib:/storage/.xbmc/addons/script.module.buggalo/lib:/storage/.xbmc/addons/script.module.parsedom/lib:/storage/.xbmc/addons/script.module.xbmcswift2/lib:/storage/.xbmc/addons/script.module.elementtree/lib:/storage/.xbmc/addons/script.web.viewer/lib:/usr/lib/python27.zip:/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/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/PIL:/usr/lib/python2.7/site-packages/gtk-2.0: 22:19:40 T:2943046752 DEBUG: Process - Entering source directory /storage/.xbmc/addons/script.module.simple.downloader 22:19:40 T:2943046752 DEBUG: Instantiating addon using automatically obtained id of "script.module.simple.downloader" dependent on version 2.1.0 of the xbmc.python api 22:19:40 T:2934391904 NOTICE: -->Python Interpreter Initialized<-- 22:19:40 T:2934391904 DEBUG: Process - The source file to load is /storage/.xbmc/addons/script.common.plugin.cache/default.py 22:19:40 T:2925896800 NOTICE: Thread Jobworker start, auto delete: true 22:19:40 T:3032478816 DEBUG: CecLogMessage - expected response not received (90: report power status) 22:19:40 T:3032478816 DEBUG: CecLogMessage - TV (0): power status changed from 'in transition from standby to on' to 'unknown' 22:19:40 T:3032478816 DEBUG: OpenConnection - connection to the CEC adapter opened 22:19:40 T:2925896800 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update 22:19:41 T:2917401696 NOTICE: Thread CEC Adapter Update Thread start, auto delete: false 22:19:41 T:2917401696 DEBUG: CecLogMessage - Recorder 1 (1) was already marked as active source 22:19:41 T:2917401696 DEBUG: CecLogMessage - TV (0): power status changed from 'unknown' to 'in transition from standby to on' 22:19:41 T:2917401696 DEBUG: CecLogMessage - sending active source message for 'Recorder 1' 22:19:41 T:2917401696 DEBUG: CecLogMessage - << 10:04 22:19:41 T:3043147776 DEBUG: Process - no profile autoexec.py (/storage/.xbmc/userdata/autoexec.py) found, skipping 22:19:41 T:3043147776 DEBUG: NetworkMessage - Starting network services 22:19:41 T:3043147776 NOTICE: Webserver: Starting... 22:19:41 T:3043147776 NOTICE: WebServer: Started the webserver 22:19:41 T:2917401696 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (2000) 22:19:41 T:2917401696 DEBUG: CecLogMessage - << 1f:82:20:00 22:19:41 T:3043147776 DEBUG: CZeroconfAvahi::clientCallback: client is up and running 22:19:41 T:3043147776 NOTICE: ES: Starting event server 22:19:41 T:2864706656 NOTICE: Thread CEventServer start, auto delete: false 22:19:41 T:2864706656 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777 22:19:41 T:2864706656 NOTICE: UDP: Listening on port 9777 22:19:42 T:2925896800 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 22:19:42 T:2917401696 DEBUG: CecLogMessage - << Recorder 1 (1) -> TV (0): menu state 'activated' 22:19:42 T:2917401696 DEBUG: CecLogMessage - << 10:8e:00 22:19:42 T:2925896800 DEBUG: GetRecentlyAddedAlbums query: select * from albumview where strAlbum != '' order by idAlbum desc limit 10 22:19:42 T:2925896800 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update 22:19:42 T:2917401696 DEBUG: CecLogMessage - << requesting vendor ID of 'TV' (0) 22:19:42 T:2917401696 DEBUG: CecLogMessage - << 10:8c 22:19:42 T:3043147776 ERROR: JSONRPC Server: Failed to connect to sdpd 22:19:42 T:3043147776 INFO: JSONRPC Server: Successfully initialized 22:19:42 T:3043147776 NOTICE: starting zeroconf publishing 22:19:42 T:3043147776 INFO: AIRPLAY Server: Successfully initialized 22:19:42 T:3043147776 DEBUG: SECTION:LoadDLL(libshairport.so.0) 22:19:42 T:2845832288 NOTICE: Thread Jobworker start, auto delete: true 22:19:42 T:2854220896 NOTICE: Thread CTCPServer start, auto delete: false 22:19:42 T:2845832288 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:XBMC (openelec) port:9777 22:19:42 T:2845832288 DEBUG: CZeroconfAvahi::addService() named: XBMC (openelec) type: _xbmc-events._udp port:9777 22:19:42 T:2837443680 NOTICE: Thread AirPlayServer start, auto delete: false 22:19:42 T:3043147776 DEBUG: Loading: libshairport.so.0 22:19:42 T:2845832288 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:XBMC (openelec) port:8282 22:19:42 T:2845832288 DEBUG: CZeroconfAvahi::addService() named: XBMC (openelec) type: _xbmc-jsonrpc-h._tcp port:8282 22:19:42 T:2845832288 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:XBMC (openelec) port:9090 22:19:42 T:2845832288 DEBUG: CZeroconfAvahi::addService() named: XBMC (openelec) type: _xbmc-jsonrpc._tcp port:9090 22:19:42 T:3043147776 DEBUG: CLastfmScrobbler: Clearing session. 22:19:42 T:3043147776 DEBUG: CLibrefmScrobbler: Clearing session. 22:19:42 T:2829055072 NOTICE: Thread AirTunesServer start, auto delete: false 22:19:42 T:2820666464 NOTICE: Thread Jobworker start, auto delete: true 22:19:42 T:2820666464 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airplay type: _airplay._tcp name:XBMC (openelec) port:36667 22:19:42 T:2820666464 DEBUG: CZeroconfAvahi::addService() named: XBMC (openelec) type: _airplay._tcp port:36667 22:19:42 T:2845832288 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.webserver type: _http._tcp name:XBMC (openelec) port:8282 22:19:42 T:2845832288 DEBUG: CZeroconfAvahi::addService() named: XBMC (openelec) type: _http._tcp port:8282 22:19:42 T:2820666464 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.airtunes type: _raop._tcp name:B827EB2EAA35@XBMC (openelec) port:36666 22:19:42 T:2820666464 DEBUG: CZeroconfAvahi::addService() named: B827EB2EAA35@XBMC (openelec) type: _raop._tcp port:36666 22:19:42 T:3043147776 DEBUG: ------ Window Init (DialogKaiToast.xml) ------ 22:19:42 T:3043147776 DEBUG: Checking device: /dev/input/event0 22:19:42 T:3043147776 DEBUG: Checking device: /dev/input/event1 22:19:42 T:3043147776 DEBUG: Checking device: /dev/input/event2 22:19:42 T:3043147776 DEBUG: Checking device: /dev/input/event3 22:19:42 T:3043147776 DEBUG: Checking device: /dev/input/event4 22:19:42 T:3043147776 DEBUG: Checking device: /dev/input/event5 22:19:42 T:3043147776 DEBUG: Checking device: /dev/input/event6 22:19:42 T:3043147776 DEBUG: Checking device: /dev/input/event7 22:19:42 T:3043147776 DEBUG: Checking device: /dev/input/event8 22:19:42 T:3043147776 DEBUG: Checking device: /dev/input/event9 22:19:42 T:3043147776 DEBUG: Checking device: /dev/input/event10 22:19:42 T:3043147776 DEBUG: Checking device: /dev/input/event11 22:19:42 T:3043147776 DEBUG: Checking device: /dev/input/event12 22:19:42 T:3043147776 DEBUG: Checking device: /dev/input/event13 22:19:42 T:3043147776 DEBUG: Checking device: /dev/input/event14 22:19:42 T:3043147776 DEBUG: Checking device: /dev/input/event15 22:19:42 T:3043147776 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.image_decode handle 0x02fe4770 dllopen : 1 22:19:42 T:3043147776 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 22:19:42 T:3043147776 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.resize handle 0x02f614f8 dllopen : 1 22:19:42 T:3043147776 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 22:19:42 T:3043147776 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(3), nBufferSize(81920), nBufferAlignmen(16) 22:19:42 T:3043147776 DEBUG: COMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.resize) - port(61), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(3686400) nBufferAlignmen(16) 22:19:42 T:2934391904 DEBUG: Process - Setting the Python path to /storage/.xbmc/addons/script.common.plugin.cache:/storage/.xbmc/addons/script.module.pyamf/lib:/storage/.xbmc/addons/script.module.xbmcswift/lib:/storage/.xbmc/addons/script.module.t0mm0.common/lib:/usr/share/xbmc/addons/weather.wunderground/resources/lib/wunderground:/storage/.xbmc/addons/script.module.simplejson/lib:/storage/.xbmc/addons/script.module.beautifulsoup/lib:/usr/share/xbmc/addons/script.module.pil/lib:/storage/.xbmc/addons/script.common.plugin.cache/lib:/storage/.xbmc/addons/script.module.simple.downloader/lib:/storage/.xbmc/addons/script.module.requests/lib:/storage/.xbmc/addons/script.module.buggalo/lib:/storage/.xbmc/addons/script.module.parsedom/lib:/storage/.xbmc/addons/script.module.xbmcswift2/lib:/storage/.xbmc/addons/script.module.elementtree/lib:/storage/.xbmc/addons/script.web.viewer/lib:/usr/lib/python27.zip:/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/lib/python2.7/site-packages:/usr/lib/python2.7/site-packages/PIL:/usr/lib/python2.7/site-packages/gtk-2.0: 22:19:42 T:2934391904 DEBUG: Process - Entering source directory /storage/.xbmc/addons/script.common.plugin.cache 22:19:42 T:2934391904 DEBUG: Instantiating addon using automatically obtained id of "script.common.plugin.cache" dependent on version 2.1.0 of the xbmc.python api 22:19:42 T:2951435360 NOTICE: service.libraryautoupdate: Update Library Service starting... 22:19:42 T:2925896800 DEBUG: RunQuery took 30 ms for 0 items query: select * from movieview ORDER BY dateAdded desc, idMovie desc LIMIT 10 22:19:42 T:2925896800 DEBUG: RunQuery took 28 ms for 0 items query: select * from episodeview ORDER BY dateAdded desc, idEpisode desc LIMIT 10 22:19:42 T:2925896800 DEBUG: RunQuery took 36 ms for 0 items query: select * from musicvideoview ORDER BY dateAdded desc, idMVideo desc LIMIT 10 22:19:43 T:2951435360 NOTICE: service.libraryautoupdate: update timers 22:19:43 T:2951435360 DEBUG: LocalizeStrings: no strings.po file exist at /storage/.xbmc/addons/service.libraryautoupdate/resources/language/Italian, fallback to strings.xml 22:19:43 T:3043147776 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x02f614f8 dllopen : 1 22:19:43 T:3043147776 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x02fe4770 dllopen : 1 22:19:43 T:2951435360 DEBUG: LocalizeStrings: no strings.po file exist at /storage/.xbmc/addons/service.libraryautoupdate/resources/language/English, fallback to strings.xml 22:19:43 T:2873095264 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 22:19:43 T:2917401696 DEBUG: CecLogMessage - expected response not received (87: device vendor id) 22:19:43 T:2917401696 DEBUG: CecLogMessage - << 10:8c 22:19:43 T:2873095264 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 22:19:43 T:3043147776 DEBUG: ------ Window Deinit (Pointer.xml) ------ 22:19:43 T:2873095264 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 22:19:43 T:2925896800 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 22:19:43 T:2873095264 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established 22:19:44 T:2917401696 DEBUG: Previous line repeats 2 times. 22:19:44 T:2917401696 DEBUG: CecLogMessage - expected response not received (87: device vendor id) 22:19:44 T:2917401696 DEBUG: CecLogMessage - << requesting power status of 'TV' (0) 22:19:44 T:2917401696 DEBUG: CecLogMessage - << 10:8f 22:19:45 T:2943046752 INFO: Scriptresult: Success 22:19:45 T:2917401696 DEBUG: CecLogMessage - expected response not received (90: report power status) 22:19:45 T:2917401696 DEBUG: CecLogMessage - << 10:8f 22:19:46 T:2917401696 DEBUG: CecLogMessage - expected response not received (90: report power status) 22:19:46 T:2917401696 DEBUG: CecLogMessage - TV (0): power status changed from 'in transition from standby to on' to 'unknown' 22:19:46 T:2943046752 INFO: Python script stopped 22:19:46 T:2943046752 DEBUG: Thread XBPyThread 2943046752 terminating 22:19:46 T:3043147776 DEBUG: waiting for python thread 2 (/storage/.xbmc/addons/script.module.simple.downloader/default.py) to stop 22:19:46 T:3043147776 DEBUG: python thread 2 (/storage/.xbmc/addons/script.module.simple.downloader/default.py) destructed 22:19:46 T:2934391904 NOTICE: StorageServer Module loaded RUN 22:19:46 T:2934391904 NOTICE: StorageClient-2.5.0 Starting server 22:19:46 T:2934391904 NOTICE: StorageServer-2.5.0 Storage Server starting /storage/.xbmc/userdata/addon_data/script.common.plugin.cache/commoncache.db 22:19:49 T:2917401696 DEBUG: CecLogMessage - << requesting power status of 'TV' (0) 22:19:49 T:2917401696 DEBUG: CecLogMessage - << 10:8f 22:19:50 T:2917401696 DEBUG: CecLogMessage - expected response not received (90: report power status) 22:19:50 T:2917401696 DEBUG: CecLogMessage - << 10:8f 22:19:51 T:3043147776 DEBUG: ------ Window Deinit (DialogKaiToast.xml) ------ 22:19:51 T:2917401696 DEBUG: CecLogMessage - expected response not received (90: report power status) 22:19:54 T:2917401696 DEBUG: CecLogMessage - << requesting power status of 'TV' (0) 22:19:54 T:2917401696 DEBUG: CecLogMessage - << 10:8f 22:19:55 T:2917401696 DEBUG: CecLogMessage - expected response not received (90: report power status) 22:19:55 T:2917401696 DEBUG: CecLogMessage - << 10:8f 22:19:56 T:2917401696 DEBUG: CecLogMessage - expected response not received (90: report power status) 22:19:59 T:2917401696 DEBUG: CecLogMessage - << requesting power status of 'TV' (0) 22:19:59 T:2917401696 DEBUG: CecLogMessage - << 10:8f 22:20:00 T:2917401696 DEBUG: CecLogMessage - expected response not received (90: report power status) 22:20:00 T:2917401696 DEBUG: CecLogMessage - << 10:8f 22:20:01 T:2917401696 DEBUG: CecLogMessage - expected response not received (90: report power status) 22:20:04 T:2917401696 DEBUG: CecLogMessage - << requesting power status of 'TV' (0) 22:20:04 T:2917401696 DEBUG: CecLogMessage - << 10:8f 22:20:05 T:2917401696 DEBUG: CecLogMessage - expected response not received (90: report power status) 22:20:05 T:2917401696 DEBUG: CecLogMessage - << 10:8f 22:20:06 T:2917401696 DEBUG: CecLogMessage - expect

klopsknoedel commented 11 years ago

Would be great if you could use pastebin or gist too keep these reports clean.

May you post this issue over at the libCEC-Repository Stephan mentioned as these guys are responsible for this.

frayber commented 11 years ago

sorry but I don't know how to pastebin or gist. I'll post again there. Thank you very much

frayber commented 11 years ago

https://github.com/Pulse-Eight/libcec/issues/152