2019-12-06 20:48:30.202 [INFO ] [el.core.internal.ModelRepositoryImpl] - Refreshing model 'roomba.things'
2019-12-06 20:48:30.216 [TRACE] [.transport.mqtt.MqttBrokerConnection] - Closing the MQTT broker connection '192.168.178.44'
2019-12-06 20:48:30.230 [INFO ] [.transport.mqtt.MqttBrokerConnection] - Starting MQTT broker connection to '192.168.178.44' with clientid 3162831022440790
2019-12-06 20:48:30.258 [DEBUG] [.MqttChannelStateDescriptionProvider] - Adding state description for channel mqtt:topic:roomba:state:wifistat
2019-12-06 20:48:30.259 [DEBUG] [.MqttChannelStateDescriptionProvider] - Adding state description for channel mqtt:topic:roomba:state:shadow
2019-12-06 20:48:31.684 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic 'wifistat' : {"state":{"reported":{"netinfo":{"dhcp":true,"addr":3232281132,"mask":4294967040,"gw":3232281089,"dns1":3232281090,"dns2":3232281089,"bssid":"b0:b2:dc:5c:59:c0","sec":4}}}}
2019-12-06 20:48:31.685 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for 'wifistat' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:48:31.685 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for 'wifistat' using regex wifistat
2019-12-06 20:48:31.697 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic 'wifistat' : {"state":{"reported":{"wifistat":{"wifi":1,"uap":false,"cloud":1}}}}
2019-12-06 20:48:31.698 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for 'wifistat' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:48:31.698 [DEBUG] [ab.binding.mqtt.generic.ChannelState] - Subscribed channel mqtt:topic:roomba:state:shadow to topic: $aws/things/3162831022440790/shadow/#
2019-12-06 20:48:31.698 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for 'wifistat' using regex wifistat
2019-12-06 20:48:31.700 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic 'wifistat' : {"state":{"reported":{"netinfo":{"dhcp":true,"addr":3232281132,"mask":4294967040,"gw":3232281089,"dns1":3232281090,"dns2":3232281089,"bssid":"b0:b2:dc:5c:59:c0","sec":4}}}}
2019-12-06 20:48:31.699 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic '$aws/things/3162831022440790/shadow/update' : {"state":{"reported":{"country": "DE"}}}
2019-12-06 20:48:31.700 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for 'wifistat' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:48:31.701 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for 'wifistat' using regex wifistat
2019-12-06 20:48:31.702 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic 'wifistat' : {"state":{"reported":{"wlcfg":{"sec":7,"ssid":"4963682062696E2065696E20576C616E"}}}}
2019-12-06 20:48:31.702 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for '$aws/things/3162831022440790/shadow/update' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:48:31.702 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for '$aws/things/3162831022440790/shadow/update' using regex wifistat
2019-12-06 20:48:31.703 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for 'wifistat' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:48:31.704 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for 'wifistat' using regex wifistat
2019-12-06 20:48:31.704 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic 'wifistat' : {"state":{"reported":{"mac":"40:9f:38:a8:26:7f"}}}
2019-12-06 20:48:31.705 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for 'wifistat' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:48:31.706 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for 'wifistat' using regex wifistat
2019-12-06 20:48:31.751 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic '$aws/things/3162831022440790/shadow/update' : {"state":{"reported":{"cloudEnv": "prod"}}}
2019-12-06 20:48:31.751 [DEBUG] [ab.binding.mqtt.generic.ChannelState] - Subscribed channel mqtt:topic:roomba:state:wifistat to topic: wifistat
2019-12-06 20:48:31.752 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for '$aws/things/3162831022440790/shadow/update' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:48:31.752 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for '$aws/things/3162831022440790/shadow/update' using regex wifistat
2019-12-06 20:48:31.753 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic '$aws/things/3162831022440790/shadow/update' : {"state":{"reported":{"svcEndpoints":{"svcDeplId": "v011"}}}}
2019-12-06 20:48:31.753 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for '$aws/things/3162831022440790/shadow/update' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:48:31.754 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for '$aws/things/3162831022440790/shadow/update' using regex wifistat
2019-12-06 20:48:31.755 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic '$aws/things/3162831022440790/shadow/update' : {"state":{"reported":{"name": "Roomba"}}}
2019-12-06 20:48:31.756 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for '$aws/things/3162831022440790/shadow/update' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:48:31.756 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for '$aws/things/3162831022440790/shadow/update' using regex wifistat
2019-12-06 20:48:32.137 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic '$aws/things/3162831022440790/shadow/update' : {"state":{"reported":{"lastDisconnect":0,"cap":{"ota":1,"eco":1,"svcConf":1},"bbrun":{"nCliffsF":9443,"nPanics":3419,"hr":210,"min":29,"nScrubs":2748,"sqft":0,"nStuck":0,"nPicks":0,"nCliffsR":0,"nMBStll":0,"nWStll":0,"nCBump":0},"bbmssn":{"nMssn":370,"nMssnOk":215,"nMssnF":155,"aMssnM":25,"nMssnC":0,"aCycleM":0},"bbpause":{"pauses":[13,14,13,13,0,6,0,6,6,14]},"bbrstinfo":{"nNavRst":0,"nMobRst":0,"causes":"0000"},"bbpanic":{"panics":[17,12,17,12,17]}}}}
2019-12-06 20:48:32.138 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for '$aws/things/3162831022440790/shadow/update' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:48:32.139 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for '$aws/things/3162831022440790/shadow/update' using regex wifistat
2019-12-06 20:48:32.139 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic '$aws/things/3162831022440790/shadow/update' : {"state":{"reported":{"cleanSchedule":{"cycle":["none","none","none","none","none","none","none"],"h":[0,0,0,0,0,0,0],"m":[0,0,0,0,0,0,0]},"language":2,"cleanMissionStatus":{"cycle":"none","phase":"charge","expireM":0,"rechrgM":0,"error":0,"notReady":0,"mssnM":96,"sqft":0,"initiator":"","nMssn":370},"dock":{"known":true},"bin":{"present":true,"full":false},"batteryType":"lith","batPct":100,"mobilityVer":"7375","bootloaderVer":"36","soundVer":"11"}}}
2019-12-06 20:48:32.140 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for '$aws/things/3162831022440790/shadow/update' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:48:32.140 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for '$aws/things/3162831022440790/shadow/update' using regex wifistat
2019-12-06 20:48:32.193 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic '$aws/things/3162831022440790/shadow/update' : {"state":{"reported":{"langs":[{"en-US":0},{"fr-FR":1},{"de-DE":2},{"es-ES":3},{"es-XL":11},{"pt-PT":12},{"it-IT":4},{"nl-NL":5},{"da-DK":6},{"sv-SE":7},{"nb-NO":8},{"pl-PL":10},{"ja-JP":13},{"zh-CN":14},{"zh-TW":9}],"audio":{"active":false},"binPause":false,"carpetBoost":false,"noAutoPasses":false,"noPP":false,"openOnly":false,"twoPass":false,"vacHigh":false,"sku":"R895040","timezone":"Europe/Berlin"}}}
2019-12-06 20:48:32.194 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for '$aws/things/3162831022440790/shadow/update' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:48:32.195 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for '$aws/things/3162831022440790/shadow/update' using regex wifistat
2019-12-06 20:48:32.246 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic '$aws/things/3162831022440790/shadow/update' : {"state":{"reported":{"tz":{"ver":7,"events":[{"dt":1564675200,"off":120},{"dt":1572138001,"off":60},{"dt":1585443601,"off":120}]},"ecoCharge":false,"wifiSwVer":"3.2.47+77","softwareVer":"3.2.47+77","lastCommand":{"command":"clean","time":1575588789,"initiator":"manual"},"hardwareRev":1,"wifiAnt":1,"schedHold":false}}}
2019-12-06 20:48:32.247 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for '$aws/things/3162831022440790/shadow/update' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:48:32.247 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for '$aws/things/3162831022440790/shadow/update' using regex wifistat
2019-12-06 20:48:32.291 [INFO ] [rthome.model.script.RoombaShadowJSON] - JSON: {"state":{"reported":{"tz":{"ver":7,"events":[{"dt":1564675200,"off":120},{"dt":1572138001,"off":60},{"dt":1585443601,"off":120}]},"ecoCharge":false,"wifiSwVer":"3.2.47+77","softwareVer":"3.2.47+77","lastCommand":{"command":"clean","time":1575588789,"initiator":"manual"},"hardwareRev":1,"wifiAnt":1,"schedHold":false}}} Key: wifiAnt
2019-12-06 20:48:32.448 [INFO ] [rthome.model.script.RoombaShadowJSON] - JSON: {"state":{"reported":{"cleanSchedule":{"cycle":["none","none","none","none","none","none","none"],"h":[0,0,0,0,0,0,0],"m":[0,0,0,0,0,0,0]},"language":2,"cleanMissionStatus":{"cycle":"none","phase":"charge","expireM":0,"rechrgM":0,"error":0,"notReady":0,"mssnM":96,"sqft":0,"initiator":"","nMssn":370},"dock":{"known":true},"bin":{"present":true,"full":false},"batteryType":"lith","batPct":100,"mobilityVer":"7375","bootloaderVer":"36","soundVer":"11"}}} Key: batPct
2019-12-06 20:48:32.448 [INFO ] [rthome.model.script.RoombaShadowJSON] - JSON: {"state":{"reported":{"cleanSchedule":{"cycle":["none","none","none","none","none","none","none"],"h":[0,0,0,0,0,0,0],"m":[0,0,0,0,0,0,0]},"language":2,"cleanMissionStatus":{"cycle":"none","phase":"charge","expireM":0,"rechrgM":0,"error":0,"notReady":0,"mssnM":96,"sqft":0,"initiator":"","nMssn":370},"dock":{"known":true},"bin":{"present":true,"full":false},"batteryType":"lith","batPct":100,"mobilityVer":"7375","bootloaderVer":"36","soundVer":"11"}}} Key: batPct
2019-12-06 20:48:32.451 [INFO ] [rthome.model.script.RoombaShadowJSON] - JSON: {"state":{"reported":{"cleanSchedule":{"cycle":["none","none","none","none","none","none","none"],"h":[0,0,0,0,0,0,0],"m":[0,0,0,0,0,0,0]},"language":2,"cleanMissionStatus":{"cycle":"none","phase":"charge","expireM":0,"rechrgM":0,"error":0,"notReady":0,"mssnM":96,"sqft":0,"initiator":"","nMssn":370},"dock":{"known":true},"bin":{"present":true,"full":false},"batteryType":"lith","batPct":100,"mobilityVer":"7375","bootloaderVer":"36","soundVer":"11"}}} Val: 100
2019-12-06 20:48:32.451 [INFO ] [rthome.model.script.RoombaShadowJSON] - JSON: {"state":{"reported":{"cleanSchedule":{"cycle":["none","none","none","none","none","none","none"],"h":[0,0,0,0,0,0,0],"m":[0,0,0,0,0,0,0]},"language":2,"cleanMissionStatus":{"cycle":"none","phase":"charge","expireM":0,"rechrgM":0,"error":0,"notReady":0,"mssnM":96,"sqft":0,"initiator":"","nMssn":370},"dock":{"known":true},"bin":{"present":true,"full":false},"batteryType":"lith","batPct":100,"mobilityVer":"7375","bootloaderVer":"36","soundVer":"11"}}} Val: 100
2019-12-06 20:48:35.766 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic 'wifistat' : {"state":{"reported":{"signal":{"rssi":-46,"snr":43}}}}
2019-12-06 20:48:35.767 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for 'wifistat' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:48:35.767 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for 'wifistat' using regex wifistat
2019-12-06 20:48:38.898 [INFO ] [pse.smarthome.model.script.AstroRule] - Calculated projected angle: 85.59351705430068
2019-12-06 20:48:38.900 [INFO ] [pse.smarthome.model.script.AstroRule] - Calculated projected angle for facade 1: 85.59351705430068
2019-12-06 20:48:38.907 [INFO ] [pse.smarthome.model.script.AstroRule] - Calculated projected angle: 41.94824766755031
2019-12-06 20:48:38.909 [INFO ] [pse.smarthome.model.script.AstroRule] - Calculated projected angle for facade 2: 41.94824766755031
2019-12-06 20:48:38.912 [INFO ] [pse.smarthome.model.script.AstroRule] - Calculated projected angle: -85.59351705430066
2019-12-06 20:48:38.913 [INFO ] [pse.smarthome.model.script.AstroRule] - Calculated projected angle: Less than 0
2019-12-06 20:48:38.915 [INFO ] [pse.smarthome.model.script.AstroRule] - Calculated projected angle for facade 3: -1.0E-4
2019-12-06 20:48:38.919 [INFO ] [pse.smarthome.model.script.AstroRule] - Calculated projected angle: -41.94824766755031
2019-12-06 20:48:38.920 [INFO ] [pse.smarthome.model.script.AstroRule] - Calculated projected angle: Less than 0
2019-12-06 20:48:38.921 [INFO ] [pse.smarthome.model.script.AstroRule] - Calculated projected angle for facade 4: -1.0E-4
2019-12-06 20:48:38.924 [INFO ] [e.smarthome.model.script.PowerInput4] - PowerInput4 set to 0
2019-12-06 20:48:38.927 [INFO ] [e.smarthome.model.script.PowerInput1] - PowerInput1 set to 0
2019-12-06 20:48:38.936 [INFO ] [e.smarthome.model.script.PowerInput2] - PowerInput2 set to 0
2019-12-06 20:48:38.941 [INFO ] [e.smarthome.model.script.PowerInput3] - PowerInput3 set to 0
2019-12-06 20:48:41.758 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic 'wifistat' : {"state":{"reported":{"signal":{"rssi":-47,"snr":43}}}}
2019-12-06 20:48:41.758 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for 'wifistat' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:48:41.759 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for 'wifistat' using regex wifistat
2019-12-06 20:48:47.750 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic 'wifistat' : {"state":{"reported":{"signal":{"rssi":-50,"snr":39}}}}
2019-12-06 20:48:47.751 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for 'wifistat' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:48:47.751 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for 'wifistat' using regex wifistat
2019-12-06 20:48:53.748 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic 'wifistat' : {"state":{"reported":{"signal":{"rssi":-46,"snr":43}}}}
2019-12-06 20:48:53.748 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for 'wifistat' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:48:53.749 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for 'wifistat' using regex wifistat
2019-12-06 20:48:59.739 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic 'wifistat' : {"state":{"reported":{"signal":{"rssi":-46,"snr":43}}}}
2019-12-06 20:48:59.740 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for 'wifistat' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:48:59.740 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for 'wifistat' using regex wifistat
2019-12-06 20:49:05.730 [TRACE] [ansport.mqtt.internal.ClientCallback] - Received message on topic 'wifistat' : {"state":{"reported":{"signal":{"rssi":-48,"snr":41}}}}
2019-12-06 20:49:05.730 [TRACE] [ansport.mqtt.internal.ClientCallback] - No topic match for 'wifistat' using regex \$aws/things/3162831022440790/shadow/.*
2019-12-06 20:49:05.731 [TRACE] [ansport.mqtt.internal.ClientCallback] - Topic match for 'wifistat' using regex wifistat
2019-12-06 20:49:09.154 [WARN ] [nhab.binding.mqtt.action.MQTTActions] - MQTT publish to cmd failed!
2019-12-06 20:49:19.915 [INFO ] [el.script.Temp_Outside_MinMaxAverage] - I_Geb_OutsideTemp24HMin set to -3.8000000000000003
2019-12-06 20:49:19.944 [INFO ] [el.script.Temp_Outside_MinMaxAverage] - I_Geb_OutsideTemp24HMax set to 4.2
2019-12-06 20:49:19.966 [INFO ] [el.script.Temp_Outside_MinMaxAverage] - I_Geb_OutsideTemp24HAvg set to -0.7035762231367975
2019-12-06 20:50:19.608 [INFO ] [el.script.Temp_Outside_MinMaxAverage] - I_Geb_OutsideTemp24HMin set to -3.8000000000000003
2019-12-06 20:50:19.634 [INFO ] [el.script.Temp_Outside_MinMaxAverage] - I_Geb_OutsideTemp24HMax set to 4.2
2019-12-06 20:50:19.649 [INFO ] [el.script.Temp_Outside_MinMaxAverage] - I_Geb_OutsideTemp24HAvg set to -0.6999813119320193