So I have a new Raspberry B+ that I've just installed latest Raspbmc Helix build on SD Card.
Very snappy gui.
So, I thought I'd try and get this Pi to turn off the TV using same scripts as last time. All seems well, except XBMC wakes itself up
Running the following in Putty (testing purposes I set 60 seconds to switch off TV)
Code:
2015-01-09 12:04:38.760194:MainThread: Command line args: ['./texturecache.py', '@logfile=/home/pi/t1.txt', '@debug=yes', '@bin.tvservice=/opt/vc/bin/tvservice', '@bin.vcgencmd=/opt/vc/bin/vcgencmd', '@xbmc.host=localhost', '@bin.ceccontrol=/home/pi/mytv.sh', 'rbphdmi', '60']
2015-01-09 12:04:38.761422:MainThread: Current version #: v1.8.7
2015-01-09 12:04:38.762176:MainThread: Current platform : linux2
2015-01-09 12:04:38.762937:MainThread: Python version #: v2.7.3.0 (final)
2015-01-09 12:04:38.778563:MainThread: RPC connection established with IPv6
2015-01-09 12:04:38.779814:MainThread: libVersion.JSON SOCKET REQUEST: [{"jsonrpc": "2.0", "method": "JSONRPC.Version", "id": "libVersion"}]
2015-01-09 12:04:38.786470:MainThread: libVersion.BUFFER RECEIVED (len 89)
2015-01-09 12:04:38.788057:MainThread: libVersion.PARSING JSON DATA: {"id":"libVersion","jsonrpc":"2.0","result":{"version":{"major":6,"minor":21,"patch":2}}}
2015-01-09 12:04:38.789076:MainThread: libVersion.PARSING COMPLETE, elapsed time: 0.001500 seconds
2015-01-09 12:04:38.789907:MainThread: libVersion.FINISHED, elapsed time: 0.005901 seconds
2015-01-09 12:04:38.791820:MainThread: JSON CAPABILITIES: {'dpmsnotify': True, 'isodates': True, 'debugextralog': True, 'profilesupport': True, 'setseason': True, 'setresume': True, 'filternullval': True, 'openplayercoredef': True, 'libshowdialogs': True, 'removeart': True, 'profiledirectory': False, 'setsettings': True, 'texturedb': True, 'setmovieset': True, 'exitcode': True}
2015-01-09 12:04:38.793229:MainThread: libProfile.JSON SOCKET REQUEST: [{"jsonrpc": "2.0", "params": {"properties": ["thumbnail", "lockmode"]}, "method": "Profiles.GetCurrentProfile", "id": "libProfile"}]
2015-01-09 12:04:38.796710:MainThread: libProfile.BUFFER RECEIVED (len 96)
2015-01-09 12:04:38.797988:MainThread: libProfile.PARSING JSON DATA: {"id":"libProfile","jsonrpc":"2.0","result":{"label":"Master user","lockmode":0,"thumbnail":""}}
2015-01-09 12:04:38.798944:MainThread: libProfile.PARSING COMPLETE, elapsed time: 0.001168 seconds
2015-01-09 12:04:38.799765:MainThread: libProfile.FINISHED, elapsed time: 0.005759 seconds
2015-01-09 12:04:38.800756:MainThread: CURRENT PROFILE: {'lockmode': 0, 'directory': '', 'name': u'Master user', 'thumbnail': u''}
2015-01-09 12:04:38.801887:MainThread: libPVR.JSON SOCKET REQUEST: [{"jsonrpc": "2.0", "params": {"booleans": ["System.GetBool(pvrmanager.enabled)"]}, "method": "XBMC.GetInfoBooleans", "id": "libPVR"}]
2015-01-09 12:04:38.824079:MainThread: libPVR.BUFFER RECEIVED (len 85)
2015-01-09 12:04:38.825221:MainThread: libPVR.PARSING JSON DATA: {"id":"libPVR","jsonrpc":"2.0","result":{"System.GetBool(pvrmanager.enabled)":false}}
2015-01-09 12:04:38.828187:MainThread: libPVR.PARSING COMPLETE, elapsed time: 0.003080 seconds
2015-01-09 12:04:38.829092:MainThread: libPVR.FINISHED, elapsed time: 0.026180 seconds
2015-01-09 12:04:38.853978:MainThread: CONFIG VALUES:
{
"ADD_SET_MEMBERS": true,
"ADD_SONG_MEMBERS": false,
"ANALYTICS_GOOD": "http://goo.gl/BjH6Lj",
"AUDIO_FILETYPES_EX": [],
"AUTOUPDATE": true,
"BIN_CECCONTROL": "/home/pi/mytv.sh",
"BIN_TVSERVICE": "/opt/vc/bin/tvservice",
"BIN_VCGENCMD": "/opt/vc/bin/vcgencmd",
"CACHE_ARTWORK": [],
"CACHE_CAST_THUMB": false,
"CACHE_EXTRA": false,
"CACHE_EXTRA_FANART": false,
"CACHE_EXTRA_THUMBS": false,
"CACHE_HIDEALLITEMS": false,
"CACHE_IGNORE_TYPES": [
"^video",
"^music"
],
"CACHE_REFRESH": "",
"CACHE_VIDEO_EXTRAS": false,
"CHECKUPDATE": true,
"CHUNKED": true,
"CLEAN_SHOW_DIALOGS": false,
"CONFIG_NAME": "texturecache.cfg",
"CURRENT_PROFILE": {
"directory": "",
"lockmode": 0,
"name": "Master user",
"thumbnail": ""
},
"DBJSON": "auto",
"DCACHE_AGELIMIT": 180,
"DCACHE_SIZE": 512,
"DEBUG": true,
"DOWNLOAD_PAYLOAD": true,
"DOWNLOAD_PREDELETE": false,
"DOWNLOAD_RETRY": 3,
"DOWNLOAD_THREADS": {
"download.threads.addons": 2,
"download.threads.albums": 2,
"download.threads.artists": 2,
"download.threads.movies": 2,
"download.threads.pvr.radio": 2,
"download.threads.pvr.tv": 2,
"download.threads.sets": 2,
"download.threads.songs": 2,
"download.threads.tags": 2,
"download.threads.tvshows": 2
},
"DOWNLOAD_THREADS_DEFAULT": 2,
"FILENAME": "/home/pi/.config/texturecache.cfg",
"FILTER_FIELD": "",
"FILTER_OPERATOR": "contains",
"FSEP": "|",
"GITHUB": "https://raw.github.com/MilhouseVH/texturecache.py/master",
"GLOBAL_SECTION": "global",
"HAS_PVR": false,
"HAS_THUMBNAILS_FS": true,
"HDMI_FORCE_HOTPLUG": false,
"HDMI_IGNORE_DISABLE": false,
"HDMI_IGNORE_LIBRARY": false,
"HDMI_IGNORE_PLAYER": false,
"HDMI_IGNORE_SUSPEND": false,
"IDFORMAT": "%06d",
"IGNORE_PLAYLISTS": true,
"IMDB_FIELDS": [
"rating",
"votes",
"top250"
],
"IMDB_TIMEOUT": 15.0,
"JSON_HAS_DEBUG_EXTRA_LOG": true,
"JSON_HAS_DPMS_NOTIFY": true,
"JSON_HAS_EXIT_CODE": true,
"JSON_HAS_FILTERNULLVALUE": true,
"JSON_HAS_ISO_DATES": true,
"JSON_HAS_LIB_SHOWDIALOGS_PARAM": true,
"JSON_HAS_OPEN_PLAYERCORE_DEFAULT": true,
"JSON_HAS_PROFILE_DIRECTORY": false,
"JSON_HAS_PROFILE_SUPPORT": true,
"JSON_HAS_SETMOVIESET": true,
"JSON_HAS_SETNULL": true,
"JSON_HAS_SETRESUME": true,
"JSON_HAS_SETSEASON": true,
"JSON_HAS_TEXTUREDB": true,
"JSON_VER": [
6,
21,
2
],
"JSON_VER_CAPABILITIES": {
"debugextralog": [
6,
15,
3
],
"dpmsnotify": [
6,
16,
0
],
"exitcode": [
6,
21,
0
],
"filternullval": [
6,
13,
1
],
"isodates": [
6,
13,
2
],
"libshowdialogs": [
6,
19,
0
],
"openplayercoredef": [
6,
18,
3
],
"profiledirectory": [
999,
99,
9
],
"profilesupport": [
6,
6,
0
],
"removeart": [
6,
9,
1
],
"setmovieset": [
6,
12,
0
],
"setresume": [
6,
2,
0
],
"setseason": [
6,
10,
0
],
"setsettings": [
6,
13,
0
],
"texturedb": [
6,
9,
0
]
},
"JSON_VER_STR": "v6.21.2",
"LASTRUNFILE": "",
"LASTRUNFILE_DATETIME": null,
"LOGDCACHE": false,
"LOGFILE": "/home/pi/t1.txt",
"LOGUNIQUE": false,
"LOGVERBOSE": true,
"MAC_ADDRESS": "",
"MDATE_MDY": false,
"ORPHAN_LIMIT_CHECK": true,
"PICTURE_FILETYPES_EX": [],
"POSTER_WIDTH": 5,
"PROFILE_AUTOLOAD": true,
"PROFILE_DIRECTORY": "",
"PROFILE_ENABLED": true,
"PROFILE_ENCRYPTED": false,
"PROFILE_MASTER": "Master user",
"PROFILE_NAME": "Master user",
"PROFILE_PASSWORD": "",
"PROFILE_RETRY": 60,
"PROFILE_WAIT": 0,
"PRUNE_RETAIN_PICTURES": false,
"PRUNE_RETAIN_PREVIEWS": true,
"PRUNE_RETAIN_TYPES": [],
"PURGE_MIN_LEN": 5,
"QADATE": "2014-12-10",
"QAPERIOD": 30,
"QA_FAIL_CHECKEXISTS": true,
"QA_FAIL_TYPES": [
"^video",
"^music"
],
"QA_FIELDS": {
"qa.art.addons": "thumbnail",
"qa.art.agenres": "thumbnail",
"qa.art.albums": "fanart, thumbnail",
"qa.art.artists": "fanart, thumbnail",
"qa.art.movies": "fanart, poster",
"qa.art.pvr.radio": null,
"qa.art.pvr.radio.channel": "thumbnail",
"qa.art.pvr.tv": null,
"qa.art.pvr.tv.channel": "thumbnail",
"qa.art.sets": "fanart, poster",
"qa.art.songs": "fanart, thumbnail",
"qa.art.tvshows.episode": "thumb",
"qa.art.tvshows.season": "poster",
"qa.art.tvshows.tvshow": "fanart, banner, poster",
"qa.art.vgenres": "thumbnail",
"qa.blank.addons": null,
"qa.blank.agenres": null,
"qa.blank.albums": null,
"qa.blank.artists": null,
"qa.blank.movies": "plot, mpaa",
"qa.blank.pvr.radio": null,
"qa.blank.pvr.radio.channel": null,
"qa.blank.pvr.tv": null,
"qa.blank.pvr.tv.channel": null,
"qa.blank.sets": null,
"qa.blank.songs": null,
"qa.blank.tvshows.episode": "plot",
"qa.blank.tvshows.season": null,
"qa.blank.tvshows.tvshow": "plot",
"qa.blank.vgenres": null,
"qa.zero.addons": null,
"qa.zero.agenres": null,
"qa.zero.albums": null,
"qa.zero.artists": null,
"qa.zero.movies": null,
"qa.zero.pvr.radio": null,
"qa.zero.pvr.radio.channel": null,
"qa.zero.pvr.tv": null,
"qa.zero.pvr.tv.channel": null,
"qa.zero.sets": null,
"qa.zero.songs": null,
"qa.zero.tvshows.episode": null,
"qa.zero.tvshows.season": null,
"qa.zero.tvshows.tvshow": null,
"qa.zero.vgenres": null
},
"QA_FILE": false,
"QA_NFO_REFRESH": "",
"QA_WARN_TYPES": [],
"QUERY_EPISODES": true,
"QUERY_SEASONS": true,
"RECACHEALL": false,
"RPC_CONNECTTIMEOUT": 0.5,
"RPC_IPVERSION": "",
"RPC_PORT": "9090",
"RPC_RETRY": 12,
"SCAN_SHOW_DIALOGS": false,
"SEARCH_ENCODE": true,
"SINGLETHREAD_URLS": [
"assets\\.fanart\\.tv"
],
"SUBTITLE_FILETYPES_EX": [],
"TEXTUREDB": "Database/Textures13.db",
"THIS_SECTION": "global",
"THUMBNAILS": "Thumbnails/",
"USEJSONDB": true,
"VERSION": "1.8.7",
"VIDEO_FILETYPES_EX": [],
"WATCHEDOVERWRITE": false,
"WEB_AUTH_TOKEN": null,
"WEB_CONNECTTIMEOUT": 0.5,
"WEB_PORT": "8080",
"WEB_SINGLESHOT": true,
"XBMC_BASE": "/home/pi/.kodi/userdata/",
"XBMC_HOST": "localhost",
"XTRAJSON": {
"extrajson.addons": null,
"extrajson.agenres": null,
"extrajson.albums": null,
"extrajson.artists": null,
"extrajson.movies": null,
"extrajson.pvr.radio": null,
"extrajson.pvr.radio.channel": null,
"extrajson.pvr.tv": null,
"extrajson.pvr.tv.channel": null,
"extrajson.sets": null,
"extrajson.songs": null,
"extrajson.tvshows.episode": null,
"extrajson.tvshows.season": null,
"extrajson.tvshows.tvshow": null,
"extrajson.vgenres": null
}
}
2015-01-09 12:04:40.509261:MainThread: [DEBUG] HDMI Power off delay: 60 seconds (ignored when CanSuspend is yes)
2015-01-09 12:04:40.511772:MainThread: [DEBUG] Player OnStop delay : 5 seconds (ignored when CanSuspend is yes)
2015-01-09 12:04:40.513764:MainThread: [DEBUG] Path to tvservice : /opt/vc/bin/tvservice
2015-01-09 12:04:40.515843:MainThread: [DEBUG] Path to vcgencmd : /opt/vc/bin/vcgencmd
2015-01-09 12:04:40.517731:MainThread: [DEBUG] Path to ceccontrol : /home/pi/mytv.sh
2015-01-09 12:04:40.519573:MainThread: [DEBUG] Ignore Active Player: No
2015-01-09 12:04:40.521537:MainThread: [DEBUG] Ignore Library Scan : No
2015-01-09 12:04:40.525179:MainThread: [DEBUG] Connecting to XBMC on localhost...
2015-01-09 12:04:40.529065:MainThread: RPC connection established with IPv6
2015-01-09 12:04:40.530161:MainThread: libListen.JSON SOCKET REQUEST: [{"jsonrpc": "2.0", "method": "JSONRPC.Ping", "id": "libListen"}]
2015-01-09 12:04:40.536369:MainThread: libListen.BUFFER RECEIVED (len 50)
2015-01-09 12:04:40.537746:MainThread: libListen.PARSING JSON DATA: {"id":"libListen","jsonrpc":"2.0","result":"pong"}
2015-01-09 12:04:40.538690:MainThread: libListen.PARSING COMPLETE, elapsed time: 0.001139 seconds
2015-01-09 12:04:40.539555:MainThread: libListen.PERFORMING CALLBACK: Name [rbphdmi_listen], with Id [libListen], Method [pong], Params [None]
2015-01-09 12:04:40.542333:Thread-1 : [DEBUG] Connected to XBMC
2015-01-09 12:04:40.544199:Thread-1 : [DEBUG] HDMI power management thread - initialising XBMC and HDMI state
2015-01-09 12:04:40.547473:MainThread: libListen.CALLBACK RESULT: [False] Name [rbphdmi_listen], Id [libListen], Method [pong], Params [None]
2015-01-09 12:04:40.548326:MainThread: libListen.READING SOCKET UNTIL CALLBACK SUCCEEDS...
2015-01-09 12:04:40.549211:Thread-1 : RPC connection established with IPv6
2015-01-09 12:04:40.550263:Thread-1 : libBooleans.JSON SOCKET REQUEST: [{"jsonrpc": "2.0", "params": {"booleans": ["System.ScreenSaverActive", "Library.IsScanningMusic", "Library.IsScanningVideo"]}, "method": "XBMC.GetInfoBooleans", "id": "libBooleans"}]
2015-01-09 12:04:40.576032:Thread-1 : libBooleans.BUFFER RECEIVED (len 143)
2015-01-09 12:04:40.577400:Thread-1 : libBooleans.PARSING JSON DATA: {"id":"libBooleans","jsonrpc":"2.0","result":{"Library.IsScanningMusic":false,"Library.IsScanningVideo":false,"System.ScreenSaverActive":true}}
2015-01-09 12:04:40.578526:Thread-1 : libBooleans.PARSING COMPLETE, elapsed time: 0.001456 seconds
2015-01-09 12:04:40.579407:Thread-1 : libBooleans.FINISHED, elapsed time: 0.028322 seconds
2015-01-09 12:04:40.580500:Thread-1 : libPlayers.JSON SOCKET REQUEST: [{"jsonrpc": "2.0", "method": "Player.GetActivePlayers", "id": "libPlayers"}]
2015-01-09 12:04:40.583422:Thread-1 : libPlayers.BUFFER RECEIVED (len 47)
2015-01-09 12:04:40.584525:Thread-1 : libPlayers.PARSING JSON DATA: {"id":"libPlayers","jsonrpc":"2.0","result":[]}
2015-01-09 12:04:40.585517:Thread-1 : libPlayers.PARSING COMPLETE, elapsed time: 0.001098 seconds
2015-01-09 12:04:40.586375:Thread-1 : libPlayers.FINISHED, elapsed time: 0.005071 seconds
2015-01-09 12:04:40.587648:Thread-1 : libProperties.JSON SOCKET REQUEST: [{"jsonrpc": "2.0", "params": {"properties": ["canshutdown", "cansuspend", "canreboot", "canhibernate"]}, "method": "System.GetProperties", "id": "libProperties"}]
2015-01-09 12:04:40.591011:Thread-1 : libProperties.BUFFER RECEIVED (len 125)
2015-01-09 12:04:40.592330:Thread-1 : libProperties.PARSING JSON DATA: {"id":"libProperties","jsonrpc":"2.0","result":{"canhibernate":false,"canreboot":true,"canshutdown":true,"cansuspend":false}}
2015-01-09 12:04:40.593320:Thread-1 : libProperties.PARSING COMPLETE, elapsed time: 0.001301 seconds
2015-01-09 12:04:40.594109:Thread-1 : libProperties.FINISHED, elapsed time: 0.005725 seconds
2015-01-09 12:04:40.640001:Thread-1 : bin.tvservice (checking HDMI status) calling subprocess [/opt/vc/bin/tvservice --status]
2015-01-09 12:04:40.677803:Thread-1 : bin.tvservice response: [state 0x12001a [HDMI CEA (4) RGB lim 16:9], 1280x720 @ 60.00Hz, progressive]
2015-01-09 12:04:40.678847:Thread-1 : bin.vcgencmd (checking HDMI power status) calling subprocess [/opt/vc/bin/vcgencmd display_power]
2015-01-09 12:04:40.709008:Thread-1 : bin.vcgencmd response: [display_power=0]
2015-01-09 12:04:40.711516:Thread-1 : [DEBUG] HDMI is [disabled], Screensaver is [active], Player is [inactive], Library scan [inactive], CanSuspend [no], CanDisable [yes]
2015-01-09 12:05:11.780799:MainThread: libListen.BUFFER RECEIVED (len 114)
2015-01-09 12:05:11.782344:MainThread: libListen.PARSING JSON DATA: {"jsonrpc":"2.0","method":"GUI.OnScreensaverDeactivated","params":{"data":{"shuttingdown":false},"sender":"xbmc"}}
2015-01-09 12:05:11.783435:MainThread: libListen.PARSING COMPLETE, elapsed time: 0.001588 seconds
2015-01-09 12:05:11.784422:MainThread: libListen.PERFORMING CALLBACK: Name [rbphdmi_listen], with Id [None], Method [GUI.OnScreensaverDeactivated], Params [{u'data': {u'shuttingdown': False}, u'sender': u'xbmc'}]
2015-01-09 12:05:11.792391:Thread-1 : [DEBUG] Screensaver has deactivated
2015-01-09 12:05:11.793220:Thread-1 : bin.vcgencmd (enabling/disabling HDMI power) calling subprocess [/opt/vc/bin/vcgencmd display_power 1]
2015-01-09 12:05:11.810201:MainThread: libListen.CALLBACK RESULT: [False] Name [rbphdmi_listen], Id [None], Method [GUI.OnScreensaverDeactivated], Params [{u'data': {u'shuttingdown': False}, u'sender': u'xbmc'}]
2015-01-09 12:05:11.813453:MainThread: libListen.READING SOCKET UNTIL CALLBACK SUCCEEDS...
2015-01-09 12:05:11.864147:Thread-1 : bin.vcgencmd response: [display_power=1]
2015-01-09 12:05:11.871975:Thread-1 : [DEBUG] HDMI is now on
2015-01-09 12:05:11.874214:Thread-1 : [DEBUG] Executing CEC Control script [on]
2015-01-09 12:05:11.876046:Thread-1 : bin.ceccontrol calling subprocess [/home/pi/mytv.sh on]
2015-01-09 12:05:14.335063:Thread-1 : bin.ceccontrol response: []
2015-01-09 12:08:11.877967:MainThread: libListen.BUFFER RECEIVED (len 94)
2015-01-09 12:08:11.879277:MainThread: libListen.PARSING JSON DATA: {"jsonrpc":"2.0","method":"GUI.OnScreensaverActivated","params":{"data":null,"sender":"xbmc"}}
2015-01-09 12:08:11.880387:MainThread: libListen.PARSING COMPLETE, elapsed time: 0.001293 seconds
2015-01-09 12:08:11.881437:MainThread: libListen.PERFORMING CALLBACK: Name [rbphdmi_listen], with Id [None], Method [GUI.OnScreensaverActivated], Params [{u'data': None, u'sender': u'xbmc'}]
2015-01-09 12:08:11.888962:Thread-1 : [DEBUG] Screensaver has activated
2015-01-09 12:08:11.893927:Thread-1 : [DEBUG] HDMI power off in 60 seconds unless cancelled
2015-01-09 12:08:11.894793:MainThread: libListen.CALLBACK RESULT: [False] Name [rbphdmi_listen], Id [None], Method [GUI.OnScreensaverActivated], Params [{u'data': None, u'sender': u'xbmc'}]
2015-01-09 12:08:11.899921:MainThread: libListen.READING SOCKET UNTIL CALLBACK SUCCEEDS...
2015-01-09 12:09:11.904092:Thread-1 : bin.tvservice (checking if TV is powered on) calling subprocess [/opt/vc/bin/tvservice --status]
2015-01-09 12:09:11.932503:Thread-1 : bin.tvservice response: [state 0x12001a [HDMI CEA (4) RGB lim 16:9], 1280x720 @ 60.00Hz, progressive]
2015-01-09 12:09:11.942172:Thread-1 : bin.vcgencmd (enabling/disabling HDMI power) calling subprocess [/opt/vc/bin/vcgencmd display_power 0]
2015-01-09 12:09:11.969229:Thread-1 : bin.vcgencmd response: [display_power=0]
2015-01-09 12:09:11.971706:Thread-1 : [DEBUG] HDMI is now off
2015-01-09 12:09:11.973821:Thread-1 : [DEBUG] Executing CEC Control script [off]
2015-01-09 12:09:11.974649:Thread-1 : bin.ceccontrol calling subprocess [/home/pi/mytv.sh off]
2015-01-09 12:09:15.152933:Thread-1 : bin.ceccontrol response: []
2015-01-09 12:10:42.299672:MainThread: libListen.BUFFER RECEIVED (len 114)
2015-01-09 12:10:42.301256:MainThread: libListen.PARSING JSON DATA: {"jsonrpc":"2.0","method":"GUI.OnScreensaverDeactivated","params":{"data":{"shuttingdown":false},"sender":"xbmc"}}
2015-01-09 12:10:42.302480:MainThread: libListen.PARSING COMPLETE, elapsed time: 0.001733 seconds
2015-01-09 12:10:42.305602:MainThread: libListen.PERFORMING CALLBACK: Name [rbphdmi_listen], with Id [None], Method [GUI.OnScreensaverDeactivated], Params [{u'data': {u'shuttingdown': False}, u'sender': u'xbmc'}]
2015-01-09 12:10:42.312037:Thread-1 : [DEBUG] Screensaver has deactivated
2015-01-09 12:10:42.312881:Thread-1 : bin.vcgencmd (enabling/disabling HDMI power) calling subprocess [/opt/vc/bin/vcgencmd display_power 1]
2015-01-09 12:10:42.317798:MainThread: libListen.CALLBACK RESULT: [False] Name [rbphdmi_listen], Id [None], Method [GUI.OnScreensaverDeactivated], Params [{u'data': {u'shuttingdown': False}, u'sender': u'xbmc'}]
2015-01-09 12:10:42.318774:MainThread: libListen.READING SOCKET UNTIL CALLBACK SUCCEEDS...
2015-01-09 12:10:42.379430:Thread-1 : bin.vcgencmd response: [display_power=1]
2015-01-09 12:10:42.385577:Thread-1 : [DEBUG] HDMI is now on
2015-01-09 12:10:42.392832:Thread-1 : [DEBUG] Executing CEC Control script [on]
2015-01-09 12:10:42.393962:Thread-1 : bin.ceccontrol calling subprocess [/home/pi/mytv.sh on]
2015-01-09 12:10:44.731916:Thread-1 : bin.ceccontrol response: []
2015-01-09 12:13:42.769655:MainThread: libListen.BUFFER RECEIVED (len 94)
2015-01-09 12:13:42.771015:MainThread: libListen.PARSING JSON DATA: {"jsonrpc":"2.0","method":"GUI.OnScreensaverActivated","params":{"data":null,"sender":"xbmc"}}
2015-01-09 12:13:42.772075:MainThread: libListen.PARSING COMPLETE, elapsed time: 0.001356 seconds
2015-01-09 12:13:42.773053:MainThread: libListen.PERFORMING CALLBACK: Name [rbphdmi_listen], with Id [None], Method [GUI.OnScreensaverActivated], Params [{u'data': None, u'sender': u'xbmc'}]
2015-01-09 12:13:42.781685:Thread-1 : [DEBUG] Screensaver has activated
2015-01-09 12:13:42.785867:Thread-1 : [DEBUG] HDMI power off in 60 seconds unless cancelled
2015-01-09 12:13:42.787090:MainThread: libListen.CALLBACK RESULT: [False] Name [rbphdmi_listen], Id [None], Method [GUI.OnScreensaverActivated], Params [{u'data': None, u'sender': u'xbmc'}]
2015-01-09 12:13:42.787972:MainThread: libListen.READING SOCKET UNTIL CALLBACK SUCCEEDS...
2015-01-09 12:14:42.787765:Thread-1 : bin.tvservice (checking if TV is powered on) calling subprocess [/opt/vc/bin/tvservice --status]
2015-01-09 12:14:42.819548:Thread-1 : bin.tvservice response: [state 0x12001a [HDMI CEA (4) RGB lim 16:9], 1280x720 @ 60.00Hz, progressive]
2015-01-09 12:14:42.820876:Thread-1 : bin.vcgencmd (enabling/disabling HDMI power) calling subprocess [/opt/vc/bin/vcgencmd display_power 0]
2015-01-09 12:14:42.847639:Thread-1 : bin.vcgencmd response: [display_power=0]
2015-01-09 12:14:42.850196:Thread-1 : [DEBUG] HDMI is now off
2015-01-09 12:14:42.855611:Thread-1 : [DEBUG] Executing CEC Control script [off]
2015-01-09 12:14:42.856462:Thread-1 : bin.ceccontrol calling subprocess [/home/pi/mytv.sh off]
2015-01-09 12:14:45.031638:Thread-1 : bin.ceccontrol response: []
2015-01-09 12:15:19.880885:MainThread: libListen.BUFFER RECEIVED (len 114)
2015-01-09 12:15:19.882458:MainThread: libListen.PARSING JSON DATA: {"jsonrpc":"2.0","method":"GUI.OnScreensaverDeactivated","params":{"data":{"shuttingdown":false},"sender":"xbmc"}}
2015-01-09 12:15:19.883474:MainThread: libListen.PARSING COMPLETE, elapsed time: 0.001307 seconds
2015-01-09 12:15:19.884529:MainThread: libListen.PERFORMING CALLBACK: Name [rbphdmi_listen], with Id [None], Method [GUI.OnScreensaverDeactivated], Params [{u'data': {u'shuttingdown': False}, u'sender': u'xbmc'}]
2015-01-09 12:15:19.892853:Thread-1 : [DEBUG] Screensaver has deactivated
2015-01-09 12:15:19.893685:Thread-1 : bin.vcgencmd (enabling/disabling HDMI power) calling subprocess [/opt/vc/bin/vcgencmd display_power 1]
2015-01-09 12:15:19.922839:MainThread: libListen.CALLBACK RESULT: [False] Name [rbphdmi_listen], Id [None], Method [GUI.OnScreensaverDeactivated], Params [{u'data': {u'shuttingdown': False}, u'sender': u'xbmc'}]
2015-01-09 12:15:19.929789:MainThread: libListen.READING SOCKET UNTIL CALLBACK SUCCEEDS...
2015-01-09 12:15:19.969293:Thread-1 : bin.vcgencmd response: [display_power=1]
2015-01-09 12:15:19.973788:Thread-1 : [DEBUG] HDMI is now on
2015-01-09 12:15:19.978565:Thread-1 : [DEBUG] Executing CEC Control script [on]
2015-01-09 12:15:19.979419:Thread-1 : bin.ceccontrol calling subprocess [/home/pi/mytv.sh on]
2015-01-09 12:15:22.324110:Thread-1 : bin.ceccontrol response: []
2015-01-09 12:18:20.056617:MainThread: libListen.BUFFER RECEIVED (len 94)
2015-01-09 12:18:20.061038:MainThread: libListen.PARSING JSON DATA: {"jsonrpc":"2.0","method":"GUI.OnScreensaverActivated","params":{"data":null,"sender":"xbmc"}}
2015-01-09 12:18:20.062084:MainThread: libListen.PARSING COMPLETE, elapsed time: 0.001377 seconds
2015-01-09 12:18:20.063111:MainThread: libListen.PERFORMING CALLBACK: Name [rbphdmi_listen], with Id [None], Method [GUI.OnScreensaverActivated], Params [{u'data': None, u'sender': u'xbmc'}]
2015-01-09 12:18:20.067824:Thread-1 : [DEBUG] Screensaver has activated
2015-01-09 12:18:20.070167:Thread-1 : [DEBUG] HDMI power off in 60 seconds unless cancelled
2015-01-09 12:18:20.071631:MainThread: libListen.CALLBACK RESULT: [False] Name [rbphdmi_listen], Id [None], Method [GUI.OnScreensaverActivated], Params [{u'data': None, u'sender': u'xbmc'}]
2015-01-09 12:18:20.072465:MainThread: libListen.READING SOCKET UNTIL CALLBACK SUCCEEDS...
2015-01-09 12:19:20.072040:Thread-1 : bin.tvservice (checking if TV is powered on) calling subprocess [/opt/vc/bin/tvservice --status]
2015-01-09 12:19:20.127511:Thread-1 : bin.tvservice response: [state 0x12001a [HDMI CEA (4) RGB lim 16:9], 1280x720 @ 60.00Hz, progressive]
2015-01-09 12:19:20.128672:Thread-1 : bin.vcgencmd (enabling/disabling HDMI power) calling subprocess [/opt/vc/bin/vcgencmd display_power 0]
2015-01-09 12:19:20.160832:Thread-1 : bin.vcgencmd response: [display_power=0]
2015-01-09 12:19:20.163368:Thread-1 : [DEBUG] HDMI is now off
2015-01-09 12:19:20.165587:Thread-1 : [DEBUG] Executing CEC Control script [off]
2015-01-09 12:19:20.166470:Thread-1 : bin.ceccontrol calling subprocess [/home/pi/mytv.sh off]
2015-01-09 12:19:23.369156:Thread-1 : bin.ceccontrol response: []
2015-01-09 12:22:57.421317:MainThread: libListen.BUFFER RECEIVED (len 114)
2015-01-09 12:22:57.422700:MainThread: libListen.PARSING JSON DATA: {"jsonrpc":"2.0","method":"GUI.OnScreensaverDeactivated","params":{"data":{"shuttingdown":false},"sender":"xbmc"}}
2015-01-09 12:22:57.423842:MainThread: libListen.PARSING COMPLETE, elapsed time: 0.001336 seconds
2015-01-09 12:22:57.424885:MainThread: libListen.PERFORMING CALLBACK: Name [rbphdmi_listen], with Id [None], Method [GUI.OnScreensaverDeactivated], Params [{u'data': {u'shuttingdown': False}, u'sender': u'xbmc'}]
2015-01-09 12:22:57.435480:Thread-1 : [DEBUG] Screensaver has deactivated
2015-01-09 12:22:57.436407:Thread-1 : bin.vcgencmd (enabling/disabling HDMI power) calling subprocess [/opt/vc/bin/vcgencmd display_power 1]
2015-01-09 12:22:57.449807:MainThread: libListen.CALLBACK RESULT: [False] Name [rbphdmi_listen], Id [None], Method [GUI.OnScreensaverDeactivated], Params [{u'data': {u'shuttingdown': False}, u'sender': u'xbmc'}]
2015-01-09 12:22:57.454903:MainThread: libListen.READING SOCKET UNTIL CALLBACK SUCCEEDS...
2015-01-09 12:22:57.501056:Thread-1 : bin.vcgencmd response: [display_power=1]
2015-01-09 12:22:57.506589:Thread-1 : [DEBUG] HDMI is now on
2015-01-09 12:22:57.514232:Thread-1 : [DEBUG] Executing CEC Control script [on]
2015-01-09 12:22:57.515053:Thread-1 : bin.ceccontrol calling subprocess [/home/pi/mytv.sh on]
2015-01-09 12:22:59.846838:Thread-1 : bin.ceccontrol response: []
2015-01-09 12:25:57.598100:MainThread: libListen.BUFFER RECEIVED (len 94)
2015-01-09 12:25:57.599558:MainThread: libListen.PARSING JSON DATA: {"jsonrpc":"2.0","method":"GUI.OnScreensaverActivated","params":{"data":null,"sender":"xbmc"}}
2015-01-09 12:25:57.600580:MainThread: libListen.PARSING COMPLETE, elapsed time: 0.001383 seconds
2015-01-09 12:25:57.601527:MainThread: libListen.PERFORMING CALLBACK: Name [rbphdmi_listen], with Id [None], Method [GUI.OnScreensaverActivated], Params [{u'data': None, u'sender': u'xbmc'}]
2015-01-09 12:25:57.612182:Thread-1 : [DEBUG] Screensaver has activated
2015-01-09 12:25:57.614267:MainThread: libListen.CALLBACK RESULT: [False] Name [rbphdmi_listen], Id [None], Method [GUI.OnScreensaverActivated], Params [{u'data': None, u'sender': u'xbmc'}]
2015-01-09 12:25:57.615194:MainThread: libListen.READING SOCKET UNTIL CALLBACK SUCCEEDS...
2015-01-09 12:25:57.616314:Thread-1 : [DEBUG] HDMI power off in 60 seconds unless cancelled
2015-01-09 12:26:57.618075:Thread-1 : bin.tvservice (checking if TV is powered on) calling subprocess [/opt/vc/bin/tvservice --status]
2015-01-09 12:26:57.649901:Thread-1 : bin.tvservice response: [state 0x12001a [HDMI CEA (4) RGB lim 16:9], 1280x720 @ 60.00Hz, progressive]
2015-01-09 12:26:57.651066:Thread-1 : bin.vcgencmd (enabling/disabling HDMI power) calling subprocess [/opt/vc/bin/vcgencmd display_power 0]
2015-01-09 12:26:57.677849:Thread-1 : bin.vcgencmd response: [display_power=0]
2015-01-09 12:26:57.680425:Thread-1 : [DEBUG] HDMI is now off
2015-01-09 12:26:57.682452:Thread-1 : [DEBUG] Executing CEC Control script [off]
2015-01-09 12:26:57.683290:Thread-1 : bin.ceccontrol calling subprocess [/home/pi/mytv.sh off]
2015-01-09 12:27:00.860779:Thread-1 : bin.ceccontrol response: []
2015-01-09 12:31:19.110825:MainThread: libListen.BUFFER RECEIVED (len 114)
2015-01-09 12:31:19.121801:MainThread: libListen.PARSING JSON DATA: {"jsonrpc":"2.0","method":"GUI.OnScreensaverDeactivated","params":{"data":{"shuttingdown":false},"sender":"xbmc"}}
2015-01-09 12:31:19.122852:MainThread: libListen.PARSING COMPLETE, elapsed time: 0.001428 seconds
2015-01-09 12:31:19.123856:MainThread: libListen.PERFORMING CALLBACK: Name [rbphdmi_listen], with Id [None], Method [GUI.OnScreensaverDeactivated], Params [{u'data': {u'shuttingdown': False}, u'sender': u'xbmc'}]
2015-01-09 12:31:19.129599:Thread-1 : [DEBUG] Screensaver has deactivated
2015-01-09 12:31:19.130662:Thread-1 : bin.vcgencmd (enabling/disabling HDMI power) calling subprocess [/opt/vc/bin/vcgencmd display_power 1]
2015-01-09 12:31:19.143950:MainThread: libListen.CALLBACK RESULT: [False] Name [rbphdmi_listen], Id [None], Method [GUI.OnScreensaverDeactivated], Params [{u'data': {u'shuttingdown': False}, u'sender': u'xbmc'}]
2015-01-09 12:31:19.148660:MainThread: libListen.READING SOCKET UNTIL CALLBACK SUCCEEDS...
2015-01-09 12:31:19.298442:Thread-1 : bin.vcgencmd response: [display_power=1]
2015-01-09 12:31:19.302998:Thread-1 : [DEBUG] HDMI is now on
2015-01-09 12:31:19.310446:Thread-1 : [DEBUG] Executing CEC Control script [on]
2015-01-09 12:31:19.311654:Thread-1 : bin.ceccontrol calling subprocess [/home/pi/mytv.sh on]
2015-01-09 12:31:21.811646:Thread-1 : bin.ceccontrol response: []
2015-01-09 12:34:19.401206:MainThread: libListen.BUFFER RECEIVED (len 94)
2015-01-09 12:34:19.402528:MainThread: libListen.PARSING JSON DATA: {"jsonrpc":"2.0","method":"GUI.OnScreensaverActivated","params":{"data":null,"sender":"xbmc"}}
2015-01-09 12:34:19.403583:MainThread: libListen.PARSING COMPLETE, elapsed time: 0.001297 seconds
2015-01-09 12:34:19.404541:MainThread: libListen.PERFORMING CALLBACK: Name [rbphdmi_listen], with Id [None], Method [GUI.OnScreensaverActivated], Params [{u'data': None, u'sender': u'xbmc'}]
2015-01-09 12:34:19.412247:Thread-1 : [DEBUG] Screensaver has activated
2015-01-09 12:34:19.416467:MainThread: libListen.CALLBACK RESULT: [False] Name [rbphdmi_listen], Id [None], Method [GUI.OnScreensaverActivated], Params [{u'data': None, u'sender': u'xbmc'}]
2015-01-09 12:34:19.419240:MainThread: libListen.READING SOCKET UNTIL CALLBACK SUCCEEDS...
2015-01-09 12:34:19.422585:Thread-1 : [DEBUG] HDMI power off in 60 seconds unless cancelled
2015-01-09 12:35:19.429965:Thread-1 : bin.tvservice (checking if TV is powered on) calling subprocess [/opt/vc/bin/tvservice --status]
2015-01-09 12:35:19.468176:Thread-1 : bin.tvservice response: [state 0x12001a [HDMI CEA (4) RGB lim 16:9], 1280x720 @ 60.00Hz, progressive]
2015-01-09 12:35:19.472830:Thread-1 : bin.vcgencmd (enabling/disabling HDMI power) calling subprocess [/opt/vc/bin/vcgencmd display_power 0]
2015-01-09 12:35:19.499490:Thread-1 : bin.vcgencmd response: [display_power=0]
2015-01-09 12:35:19.501981:Thread-1 : [DEBUG] HDMI is now off
2015-01-09 12:35:19.504009:Thread-1 : [DEBUG] Executing CEC Control script [off]
2015-01-09 12:35:19.504853:Thread-1 : bin.ceccontrol calling subprocess [/home/pi/mytv.sh off]
2015-01-09 12:35:22.682313:Thread-1 : bin.ceccontrol response: []
2015-01-09 12:39:41.058942:MainThread: libListen.BUFFER RECEIVED (len 114)
2015-01-09 12:39:41.060344:MainThread: libListen.PARSING JSON DATA: {"jsonrpc":"2.0","method":"GUI.OnScreensaverDeactivated","params":{"data":{"shuttingdown":false},"sender":"xbmc"}}
2015-01-09 12:39:41.061353:MainThread: libListen.PARSING COMPLETE, elapsed time: 0.001338 seconds
2015-01-09 12:39:41.062385:MainThread: libListen.PERFORMING CALLBACK: Name [rbphdmi_listen], with Id [None], Method [GUI.OnScreensaverDeactivated], Params [{u'data': {u'shuttingdown': False}, u'sender': u'xbmc'}]
2015-01-09 12:39:41.069974:Thread-1 : [DEBUG] Screensaver has deactivated
2015-01-09 12:39:41.070830:Thread-1 : bin.vcgencmd (enabling/disabling HDMI power) calling subprocess [/opt/vc/bin/vcgencmd display_power 1]
2015-01-09 12:39:41.083939:MainThread: libListen.CALLBACK RESULT: [False] Name [rbphdmi_listen], Id [None], Method [GUI.OnScreensaverDeactivated], Params [{u'data': {u'shuttingdown': False}, u'sender': u'xbmc'}]
2015-01-09 12:39:41.089094:MainThread: libListen.READING SOCKET UNTIL CALLBACK SUCCEEDS...
2015-01-09 12:39:41.139516:Thread-1 : bin.vcgencmd response: [display_power=1]
2015-01-09 12:39:41.143376:Thread-1 : [DEBUG] HDMI is now on
2015-01-09 12:39:41.147392:Thread-1 : [DEBUG] Executing CEC Control script [on]
2015-01-09 12:39:41.148273:Thread-1 : bin.ceccontrol calling subprocess [/home/pi/mytv.sh on]
2015-01-09 12:39:43.487699:Thread-1 : bin.ceccontrol response: []
2015-01-09 12:42:41.361434:MainThread: libListen.BUFFER RECEIVED (len 94)
2015-01-09 12:42:41.362732:MainThread: libListen.PARSING JSON DATA: {"jsonrpc":"2.0","method":"GUI.OnScreensaverActivated","params":{"data":null,"sender":"xbmc"}}
2015-01-09 12:42:41.363728:MainThread: libListen.PARSING COMPLETE, elapsed time: 0.001262 seconds
2015-01-09 12:42:41.364769:MainThread: libListen.PERFORMING CALLBACK: Name [rbphdmi_listen], with Id [None], Method [GUI.OnScreensaverActivated], Params [{u'data': None, u'sender': u'xbmc'}]
2015-01-09 12:42:41.373585:Thread-1 : [DEBUG] Screensaver has activated
2015-01-09 12:42:41.377640:Thread-1 : [DEBUG] HDMI power off in 60 seconds unless cancelled
2015-01-09 12:42:41.378879:MainThread: libListen.CALLBACK RESULT: [False] Name [rbphdmi_listen], Id [None], Method [GUI.OnScreensaverActivated], Params [{u'data': None, u'sender': u'xbmc'}]
2015-01-09 12:42:41.379704:MainThread: libListen.READING SOCKET UNTIL CALLBACK SUCCEEDS...
Darn it, so close. From what I can see Kodi is sending
, waking TV up.
I don't have any add-on's installed. Just stock Raspbmc Kodi
No Cron jobs listed (I wanted to add this to CronJobs as you suggested, instead of in rc.local)