search

IndigoDomotics / indigo-ecobee-plugin

Plugin for Indigo home automation software to support Ecobee thermostats and remote sensors
1 stars 1 forks source link

Lost connection last night #10

Closed rapamatic closed 6 years ago

rapamatic commented 6 years ago

Not a lot of details in the log, but here's what I had. Note also that it did not trigger a connection failure alert.

Aug 15, 2018, 9:09:04 PM
   Ecobee                          Error connecting to Ecobee.  Possible connectivity outage. Could not get thermostats.
   Ecobee                          no thermostats found; authenticated?

From what I can tell it didn't try to reconnect again (no error messages, Indigo devices not updated.) Here's what happened when I restarted the plugin:

Aug 16, 2018, 12:40:20 PM
   Reloading plugin "Ecobee 1.2.8"
   Stopping plugin "Ecobee 1.2.8" (pid 24182)

Aug 16, 2018, 12:40:35 PM
   Error                           process (pid 24182) failed to quit after polite request -- forcing it to quit now
   Stopped plugin "Ecobee 1.2.8"
   Starting plugin "Ecobee 1.2.8" (pid 48351)
   Ecobee                          Update failed, Ecobee servers returned error code 500
   Started plugin "Ecobee 1.2.8"
   Ecobee                          Starting Ecobee
   Ecobee                          not authenticated to pyecobee yet; not initializing state of device G5PH
   Ecobee                          added remote sensor G5PH
   Ecobee                          not authenticated to pyecobee yet; not initializing state of device 173448830954
   Ecobee                          added smart thermostat 173448830954
   Ecobee                          not authenticated to pyecobee yet; not initializing state of device 150992022817
   Ecobee                          added smart thermostat 150992022817
   Ecobee                          not authenticated to pyecobee yet; not initializing state of device 314784831377
   Ecobee                          added thermostat 314784831377
   Ecobee                          not authenticated to pyecobee yet; not initializing state of device G5PH
   Ecobee                          not authenticated to pyecobee yet; not initializing state of device 314784831377
   Ecobee                          not authenticated to pyecobee yet; not initializing state of device 173448830954
   Ecobee                          not authenticated to pyecobee yet; not initializing state of device 150992022817
   Ecobee                          Token refresh failed, Ecobee servers returned error code 400
   Trigger                         Ecobee Auth Event
   Pushover Debug                  Auth Failure Event
   Pushover Debug                  Ecobee Sync
   Pushover Debug                  Result: {"status":1,"request":"8d9aa2e3-084b-4960-b07c-0cb69cdb7845"}
rapamatic commented 6 years ago

So it looks like whatever the error is, it is causing the plugin to lock up and not try to reconnect...

FlyingDiver commented 6 years ago

Grrr. OK, I'll look at it again.

rapamatic commented 6 years ago

I have debugging level set to "detailed debugging messages" but I'm not getting a lot in my logs - is there a better setting for that? I'm surprised its not making more noise when it locks up like above...

FlyingDiver commented 6 years ago

The logging in this plugin is all messed up. Most of it does not get into the main Indigo log. Zip up the plugin-specific log and attach it, please.

rapamatic commented 6 years ago

Nothing crazy in the log - here are the last lines (I've attached the complete log)

2018-08-15 21:20:11.852 DEBUG   Plugin.debugLog:    updateServer: thermostat 314784831377 -
{u'program': {u'currentClimateRef': u'home', u'climates': [{u'vent': u'off', u'name': u'Away', u'coolTemp': 820, u'isOptimized': True, u'colour': 9021815, u'ventilatorMinOnTime': 20, u'heatFan': u'auto', u'heatTemp': 640, u'isOccupied': False, u'owner': u'system', u'climateRef': u'away', u'type': u'program', u'sensors': [{u'id': u'ei:0:1', u'name': u'Office'}, {u'id': u'rs:100:1', u'name': u'Desk'}], u'coolFan': u'auto'}, {u'vent': u'off', u'name': u'Home', u'coolTemp': 750, u'isOptimized': False, u'colour': 13560055, u'ventilatorMinOnTime': 20, u'heatFan': u'auto', u'heatTemp': 690, u'isOccupied': True, u'owner': u'system', u'climateRef': u'home', u'type': u'program', u'sensors': [{u'id': u'ei:0:1', u'name': u'Office'}, {u'id': u'rs:100:1', u'name': u'Desk'}], u'coolFan': u'auto'}, {u'vent': u'off', u'name': u'Sleep', u'coolTemp': 750, u'isOptimized': False, u'colour': 2179683, u'ventilatorMinOnTime': 20, u'heatFan': u'auto', u'heatTemp': 670, u'isOccupied': True, u'owner': u'system', u'climateRef': u'sleep', u'type': u'program', u'sensors': [{u'id': u'ei:0:1', u'name': u'Office'}, {u'id': u'rs:100:1', u'name': u'Desk'}], u'coolFan': u'auto'}], u'schedule': [[u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep']]}, u'runtime': {u'firstConnected': u'2015-10-20 14:44:37', u'desiredFanMode': u'auto', u'desiredHeatRange': [450, 790], u'desiredCoolRange': [650, 920], u'actualHumidity': 61, u'desiredCool': 750, u'desiredDehumidity': 50, u'lastModified': u'2018-08-16 02:18:54', u'desiredHumidity': 36, u'connectDateTime': u'2018-08-15 08:20:05', u'desiredHeat': 690, u'lastStatusModified': u'2018-08-16 02:18:54', u'connected': True, u'actualTemperature': 724, u'runtimeInterval': 26, u'runtimeRev': u'180816021854', u'runtimeDate': u'2018-08-16', u'disconnectDateTime': u'2018-08-14 16:27:15'}, u'name': u'Office', u'settings': {u'electricityBillCycleMonths': 1, u'condensationAvoid': False, u'hasUVFilter': True, u'disablePreHeating': False, u'coolRangeHigh': 920, u'tempAlertNotifyTechnician': False, u'enableElectricityBillAlert': False, u'humidityHighAlert': 80, u'ventilatorMinOnTimeAway': 0, u'serviceRemindTechnician': False, u'ventilatorType': u'none', u'groupName': u'Glencoe', u'maxSetForward': 80, u'heatPumpReversalOnCool': True, u'heatRangeLow': 450, u'ventilatorFreeCooling': True, u'hasHumidifier': False, u'hvacMode': u'cool', u'heatRangeHigh': 790, u'dehumidifyWhenHeating': False, u'stage1HeatingDifferentialTemp': 5, u'installerCodeRequired': False, u'wifiOfflineAlert': False, u'remindMeDate': u'2014-12-21', u'auxMaxOutdoorTemp': 700, u'hotTempAlertEnabled': True, u'tempCorrection': 0, u'auxOutdoorTempAlert': 800, u'humidity': u'36', u'ventilatorMinOnTimeHome': 20, u'smartCirculation': False, u'heatMaxTemp': 1200, u'ventilatorDehumidify': True, u'hasHrv': False, u'eiLocation': u'', u'locale': u'en', u'dehumidifyOvercoolOffset': 20, u'soundAlertVolume': 0, u'coolStages': 1, u'maxSetBack': 100, u'hasDehumidifier': False, u'disableHeatPumpAlerts': False, u'randomStartDelayCool': 0, u'hasHeatPump': False, u'drAccept': u'always', u'auxRuntimeAlertNotifyTechnician': False, u'electricityBillStartMonth': 1, u'coolRangeLow': 650, u'lastServiceDate': u'2014-06-21', u'userAccessSetting': 0, u'disablePreCooling': False, u'coolMaxTemp': 1200, u'humidityAlertNotify': True, u'compressorProtectionMinTime': 300, u'hotTempAlert': 920, u'heatPumpGroundWater': False, u'enableProjectedElectricityBillAlert': False, u'auxOutdoorTempAlertNotify': False, u'hasElectric': False, u'hasErv': False, u'soundTickVolume': 0, u'vent': u'off', u'backlightOffDuringSleep': False, u'serviceRemindMe': False, u'groupSetting': 1880, u'quickSaveSetBack': 40, u'auxRuntimeAlert': 0, u'ventilatorMinOnTime': 20, u'heatMinTemp': 450, u'dehumidifierLevel': 50, u'dehumidifierMode': u'on', u'auxOutdoorTempAlertNotifyTechnician': False, u'autoAway': False, u'fanMinOnTime': 10, u'compressorProtectionMinTemp': 450, u'heatStages': 1, u'groupRef': u'4897d4ae78000670', u'monthsBetweenService': 6, u'coldTempAlertEnabled': True, u'fanControlRequired': True, u'followMeComfort': False, u'backlightSleepIntensity': 4, u'useCelsius': False, u'dehumidifyWithAC': True, u'quickSaveSetForward': 40, u'coldTempAlert': 500, u'userAccessCode': u'', u'backlightOffTime': 60, u'stage1CoolingDifferentialTemp': 5, u'useTimeFormat12': True, u'tempAlertNotify': True, u'heatCoolMinDelta': 30, u'backlightOnIntensity': 10, u'hasForcedAir': True, u'auxRuntimeAlertNotify': False, u'autoHeatCoolFeatureEnabled': True, u'humidifierMode': u'off', u'stage1HeatingDissipationTime': 31, u'holdAction': u'askMe', u'coolingLockout': False, u'useZoneController': False, u'monthlyElectricityBillLimit': 0, u'ventilatorOffDateTime': u'', u'isVentilatorTimerOn': False, u'humidityAlertNotifyTechnician': False, u'electricityBillingDayOfMonth': 1, u'randomStartDelayHeat': 0, u'humidityLowAlert': 5, u'disableAlertsOnIdt': False, u'stage1CoolingDissipationTime': 31, u'isRentalProperty': False, u'hasBoiler': False, u'coolMinTemp': -100}, u'lastModified': u'2018-08-14 13:42:41', u'brand': u'ecobee', u'remoteSensors': [{u'code': u'G5PH', u'name': u'Desk', u'inUse': True, u'capability': [{u'type': u'temperature', u'id': u'1', u'value': u'758'}, {u'type': u'occupancy', u'id': u'2', u'value': u'false'}], u'type': u'ecobee3_remote_sensor', u'id': u'rs:100'}, {u'capability': [{u'type': u'temperature', u'id': u'1', u'value': u'691'}, {u'type': u'humidity', u'id': u'2', u'value': u'61'}, {u'type': u'occupancy', u'id': u'3', u'value': u'false'}], u'inUse': True, u'type': u'thermostat', u'id': u'ei:0', u'name': u'Office'}], u'events': [{u'startDate': u'2035-01-01', u'drRampUpTemp': 0, u'endDate': u'2035-01-01', u'vent': u'off', u'isHeatOff': False, u'coolHoldTemp': 800, u'ventilatorMinOnTime': 5, u'linkRef': u'', u'drRampUpTime': 3600, u'isTemperatureAbsolute': False, u'isTemperatureRelative': False, u'dutyCyclePercentage': 255, u'isOccupied': False, u'heatRelativeTemp': 40, u'coolRelativeTemp': 40, u'unoccupiedSensorActive': False, u'type': u'template', u'fanMinOnTime': 5, u'isOptional': True, u'running': False, u'fan': u'auto', u'startTime': u'00:00:00', u'occupiedSensorActive': False, u'holdClimateRef': u'', u'isCoolOff': False, u'name': u'_Default_', u'heatHoldTemp': 550, u'endTime': u'23:59:59'}], u'equipmentStatus': u'', u'utcTime': u'2018-08-16 02:20:11', u'modelNumber': u'athenaSmart', u'isRegistered': True, u'thermostatRev': u'180814134241', u'weather': {u'timestamp': u'2018-08-16 02:03:20', u'weatherStation': u'FI:KNBU', u'forecasts': [{u'tempLow': 719, u'temperature': 739, u'dewpoint': 703, u'tempHigh': 829, u'sky': 5, u'visibility': 15000, u'dateTime': u'2018-08-15 21:03:20', u'pressure': 1012, u'windSpeed': 4, u'weatherSymbol': 6, u'pop': 99, u'windGust': -5002, u'windBearing': 184, u'windDirection': u'S', u'condition': u'Drizzle', u'relativeHumidity': 89}, {u'tempLow': 709, u'temperature': 766, u'dewpoint': 696, u'tempHigh': 823, u'sky': 4, u'visibility': 16000, u'dateTime': u'2018-08-16 00:00:00', u'pressure': 1012, u'windSpeed': 2, u'weatherSymbol': 2, u'pop': 63, u'windGust': -5002, u'windBearing': 25, u'windDirection': u'NNE', u'condition': u'Mostly cloudy throughout the day.', u'relativeHumidity': 83}, {u'tempLow': 689, u'temperature': 754, u'dewpoint': 669, u'tempHigh': 820, u'sky': 3, u'visibility': 16000, u'dateTime': u'2018-08-17 00:00:00', u'pressure': 1015, u'windSpeed': 6, u'weatherSymbol': 2, u'pop': 57, u'windGust': -5002, u'windBearing': 353, u'windDirection': u'N', u'condition': u'Partly cloudy throughout the day.', u'relativeHumidity': 77}, {u'tempLow': 685, u'temperature': 750, u'dewpoint': 645, u'tempHigh': 815, u'sky': 2, u'visibility': 16000, u'dateTime': u'2018-08-18 00:00:00', u'pressure': 1016, u'windSpeed': 7, u'weatherSymbol': 2, u'pop': 4, u'windGust': -5002, u'windBearing': 27, u'windDirection': u'NNE', u'condition': u'Partly cloudy throughout the day.', u'relativeHumidity': 72}, {u'tempLow': 687, u'temperature': 766, u'dewpoint': 626, u'tempHigh': 845, u'sky': 2, u'visibility': 16000, u'dateTime': u'2018-08-19 00:00:00', u'pressure': 1015, u'windSpeed': 3, u'weatherSymbol': 1, u'pop': 2, u'windGust': -5002, u'windBearing': 91, u'windDirection': u'E', u'condition': u'Mostly cloudy starting in the evening.', u'relativeHumidity': 65}, {u'tempLow': -5002, u'temperature': 724, u'dewpoint': 698, u'tempHigh': -5002, u'sky': 4, u'visibility': 14000, u'dateTime': u'2018-08-16 00:00:00', u'pressure': 1012, u'windSpeed': 5, u'weatherSymbol': 1, u'pop': 20, u'windGust': -5002, u'windBearing': 165, u'windDirection': u'SSE', u'condition': u'Mostly Cloudy', u'relativeHumidity': 92}, {u'tempLow': -5002, u'temperature': 709, u'dewpoint': 698, u'tempHigh': -5002, u'sky': 3, u'visibility': 16000, u'dateTime': u'2018-08-16 06:00:00', u'pressure': 1012, u'windSpeed': 3, u'weatherSymbol': 1, u'pop': 8, u'windGust': -5002, u'windBearing': 14, u'windDirection': u'NNE', u'condition': u'Partly Cloudy', u'relativeHumidity': 97}, {u'tempLow': -5002, u'temperature': 793, u'dewpoint': 699, u'tempHigh': -5002, u'sky': 4, u'visibility': 16000, u'dateTime': u'2018-08-16 12:00:00', u'pressure': 1012, u'windSpeed': 4, u'weatherSymbol': 2, u'pop': 7, u'windGust': -5002, u'windBearing': 33, u'windDirection': u'NNE', u'condition': u'Mostly Cloudy', u'relativeHumidity': 73}, {u'tempLow': -5002, u'temperature': 791, u'dewpoint': 691, u'tempHigh': -5002, u'sky': 4, u'visibility': 16000, u'dateTime': u'2018-08-16 18:00:00', u'pressure': 1012, u'windSpeed': 5, u'weatherSymbol': 2, u'pop': 7, u'windGust': -5002, u'windBearing': 8, u'windDirection': u'N', u'condition': u'Mostly Cloudy', u'relativeHumidity': 72}]}, u'identifier': u'314784831377', u'thermostatTime': u'2018-08-15 21:20:11', u'features': u'HomeKit'}
2018-08-15 21:20:11.853 DEBUG   Plugin.debugLog:    heat setpoint: 690, cool setpoint: 750, hvac mode: cool, fan mode: auto, climate: home, status 
2018-08-15 21:20:11.853 DEBUG   Plugin.debugLog:    Sensor Temp: 691
2018-08-15 21:20:11.854 DEBUG   Plugin.debugLog:    updating Smart thermostat from server
2018-08-15 21:20:12.444 DEBUG   Plugin.debugLog:    heat setpoint: 720, cool setpoint: 750, hvac mode: cool, fan mode: auto, climate: home, status compCool1,fan
2018-08-15 21:20:12.445 DEBUG   Plugin.debugLog:    updating Smart thermostat from server
2018-08-15 21:20:13.036 DEBUG   Plugin.debugLog:    heat setpoint: 680, cool setpoint: 730, hvac mode: cool, fan mode: on, climate: sleep, status fan
2018-08-15 21:21:15.849 DEBUG   Plugin.debugLog:    looking for remote sensor G5PH in [{u'code': u'G5PH', u'name': u'Desk', u'inUse': True, u'capability': [{u'type': u'temperature', u'id': u'1', u'value': u'758'}, {u'type': u'occupancy', u'id': u'2', u'value': u'false'}], u'type': u'ecobee3_remote_sensor', u'id': u'rs:100'}]
2018-08-15 21:21:15.849 DEBUG   Plugin.debugLog:    Sensor Temp: 758
2018-08-15 21:21:15.850 DEBUG   Plugin.debugLog:    updating ecobee3 thermostat from server
2018-08-15 21:21:16.466 DEBUG   Plugin.debugLog:    updateServer: thermostat 314784831377 -
{u'program': {u'currentClimateRef': u'home', u'climates': [{u'vent': u'off', u'name': u'Away', u'coolTemp': 820, u'isOptimized': True, u'colour': 9021815, u'ventilatorMinOnTime': 20, u'heatFan': u'auto', u'heatTemp': 640, u'isOccupied': False, u'owner': u'system', u'climateRef': u'away', u'type': u'program', u'sensors': [{u'id': u'ei:0:1', u'name': u'Office'}, {u'id': u'rs:100:1', u'name': u'Desk'}], u'coolFan': u'auto'}, {u'vent': u'off', u'name': u'Home', u'coolTemp': 750, u'isOptimized': False, u'colour': 13560055, u'ventilatorMinOnTime': 20, u'heatFan': u'auto', u'heatTemp': 690, u'isOccupied': True, u'owner': u'system', u'climateRef': u'home', u'type': u'program', u'sensors': [{u'id': u'ei:0:1', u'name': u'Office'}, {u'id': u'rs:100:1', u'name': u'Desk'}], u'coolFan': u'auto'}, {u'vent': u'off', u'name': u'Sleep', u'coolTemp': 750, u'isOptimized': False, u'colour': 2179683, u'ventilatorMinOnTime': 20, u'heatFan': u'auto', u'heatTemp': 670, u'isOccupied': True, u'owner': u'system', u'climateRef': u'sleep', u'type': u'program', u'sensors': [{u'id': u'ei:0:1', u'name': u'Office'}, {u'id': u'rs:100:1', u'name': u'Desk'}], u'coolFan': u'auto'}], u'schedule': [[u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep']]}, u'runtime': {u'firstConnected': u'2015-10-20 14:44:37', u'desiredFanMode': u'auto', u'desiredHeatRange': [450, 790], u'desiredCoolRange': [650, 920], u'actualHumidity': 61, u'desiredCool': 750, u'desiredDehumidity': 50, u'lastModified': u'2018-08-16 02:18:54', u'desiredHumidity': 36, u'connectDateTime': u'2018-08-15 08:20:05', u'desiredHeat': 690, u'lastStatusModified': u'2018-08-16 02:18:54', u'connected': True, u'actualTemperature': 724, u'runtimeInterval': 26, u'runtimeRev': u'180816021854', u'runtimeDate': u'2018-08-16', u'disconnectDateTime': u'2018-08-14 16:27:15'}, u'name': u'Office', u'settings': {u'electricityBillCycleMonths': 1, u'condensationAvoid': False, u'hasUVFilter': True, u'disablePreHeating': False, u'coolRangeHigh': 920, u'tempAlertNotifyTechnician': False, u'enableElectricityBillAlert': False, u'humidityHighAlert': 80, u'ventilatorMinOnTimeAway': 0, u'serviceRemindTechnician': False, u'ventilatorType': u'none', u'groupName': u'Glencoe', u'maxSetForward': 80, u'heatPumpReversalOnCool': True, u'heatRangeLow': 450, u'ventilatorFreeCooling': True, u'hasHumidifier': False, u'hvacMode': u'cool', u'heatRangeHigh': 790, u'dehumidifyWhenHeating': False, u'stage1HeatingDifferentialTemp': 5, u'installerCodeRequired': False, u'wifiOfflineAlert': False, u'remindMeDate': u'2014-12-21', u'auxMaxOutdoorTemp': 700, u'hotTempAlertEnabled': True, u'tempCorrection': 0, u'auxOutdoorTempAlert': 800, u'humidity': u'36', u'ventilatorMinOnTimeHome': 20, u'smartCirculation': False, u'heatMaxTemp': 1200, u'ventilatorDehumidify': True, u'hasHrv': False, u'eiLocation': u'', u'locale': u'en', u'dehumidifyOvercoolOffset': 20, u'soundAlertVolume': 0, u'coolStages': 1, u'maxSetBack': 100, u'hasDehumidifier': False, u'disableHeatPumpAlerts': False, u'randomStartDelayCool': 0, u'hasHeatPump': False, u'drAccept': u'always', u'auxRuntimeAlertNotifyTechnician': False, u'electricityBillStartMonth': 1, u'coolRangeLow': 650, u'lastServiceDate': u'2014-06-21', u'userAccessSetting': 0, u'disablePreCooling': False, u'coolMaxTemp': 1200, u'humidityAlertNotify': True, u'compressorProtectionMinTime': 300, u'hotTempAlert': 920, u'heatPumpGroundWater': False, u'enableProjectedElectricityBillAlert': False, u'auxOutdoorTempAlertNotify': False, u'hasElectric': False, u'hasErv': False, u'soundTickVolume': 0, u'vent': u'off', u'backlightOffDuringSleep': False, u'serviceRemindMe': False, u'groupSetting': 1880, u'quickSaveSetBack': 40, u'auxRuntimeAlert': 0, u'ventilatorMinOnTime': 20, u'heatMinTemp': 450, u'dehumidifierLevel': 50, u'dehumidifierMode': u'on', u'auxOutdoorTempAlertNotifyTechnician': False, u'autoAway': False, u'fanMinOnTime': 10, u'compressorProtectionMinTemp': 450, u'heatStages': 1, u'groupRef': u'4897d4ae78000670', u'monthsBetweenService': 6, u'coldTempAlertEnabled': True, u'fanControlRequired': True, u'followMeComfort': False, u'backlightSleepIntensity': 4, u'useCelsius': False, u'dehumidifyWithAC': True, u'quickSaveSetForward': 40, u'coldTempAlert': 500, u'userAccessCode': u'', u'backlightOffTime': 60, u'stage1CoolingDifferentialTemp': 5, u'useTimeFormat12': True, u'tempAlertNotify': True, u'heatCoolMinDelta': 30, u'backlightOnIntensity': 10, u'hasForcedAir': True, u'auxRuntimeAlertNotify': False, u'autoHeatCoolFeatureEnabled': True, u'humidifierMode': u'off', u'stage1HeatingDissipationTime': 31, u'holdAction': u'askMe', u'coolingLockout': False, u'useZoneController': False, u'monthlyElectricityBillLimit': 0, u'ventilatorOffDateTime': u'', u'isVentilatorTimerOn': False, u'humidityAlertNotifyTechnician': False, u'electricityBillingDayOfMonth': 1, u'randomStartDelayHeat': 0, u'humidityLowAlert': 5, u'disableAlertsOnIdt': False, u'stage1CoolingDissipationTime': 31, u'isRentalProperty': False, u'hasBoiler': False, u'coolMinTemp': -100}, u'lastModified': u'2018-08-14 13:42:41', u'brand': u'ecobee', u'remoteSensors': [{u'code': u'G5PH', u'name': u'Desk', u'inUse': True, u'capability': [{u'type': u'temperature', u'id': u'1', u'value': u'758'}, {u'type': u'occupancy', u'id': u'2', u'value': u'false'}], u'type': u'ecobee3_remote_sensor', u'id': u'rs:100'}, {u'capability': [{u'type': u'temperature', u'id': u'1', u'value': u'691'}, {u'type': u'humidity', u'id': u'2', u'value': u'61'}, {u'type': u'occupancy', u'id': u'3', u'value': u'false'}], u'inUse': True, u'type': u'thermostat', u'id': u'ei:0', u'name': u'Office'}], u'events': [{u'startDate': u'2035-01-01', u'drRampUpTemp': 0, u'endDate': u'2035-01-01', u'vent': u'off', u'isHeatOff': False, u'coolHoldTemp': 800, u'ventilatorMinOnTime': 5, u'linkRef': u'', u'drRampUpTime': 3600, u'isTemperatureAbsolute': False, u'isTemperatureRelative': False, u'dutyCyclePercentage': 255, u'isOccupied': False, u'heatRelativeTemp': 40, u'coolRelativeTemp': 40, u'unoccupiedSensorActive': False, u'type': u'template', u'fanMinOnTime': 5, u'isOptional': True, u'running': False, u'fan': u'auto', u'startTime': u'00:00:00', u'occupiedSensorActive': False, u'holdClimateRef': u'', u'isCoolOff': False, u'name': u'_Default_', u'heatHoldTemp': 550, u'endTime': u'23:59:59'}], u'equipmentStatus': u'', u'utcTime': u'2018-08-16 02:21:16', u'modelNumber': u'athenaSmart', u'isRegistered': True, u'thermostatRev': u'180814134241', u'weather': {u'timestamp': u'2018-08-16 02:03:20', u'weatherStation': u'FI:KNBU', u'forecasts': [{u'tempLow': 719, u'temperature': 739, u'dewpoint': 703, u'tempHigh': 829, u'sky': 5, u'visibility': 15000, u'dateTime': u'2018-08-15 21:03:20', u'pressure': 1012, u'windSpeed': 4, u'weatherSymbol': 6, u'pop': 99, u'windGust': -5002, u'windBearing': 184, u'windDirection': u'S', u'condition': u'Drizzle', u'relativeHumidity': 89}, {u'tempLow': 709, u'temperature': 766, u'dewpoint': 696, u'tempHigh': 823, u'sky': 4, u'visibility': 16000, u'dateTime': u'2018-08-16 00:00:00', u'pressure': 1012, u'windSpeed': 2, u'weatherSymbol': 2, u'pop': 63, u'windGust': -5002, u'windBearing': 25, u'windDirection': u'NNE', u'condition': u'Mostly cloudy throughout the day.', u'relativeHumidity': 83}, {u'tempLow': 689, u'temperature': 754, u'dewpoint': 669, u'tempHigh': 820, u'sky': 3, u'visibility': 16000, u'dateTime': u'2018-08-17 00:00:00', u'pressure': 1015, u'windSpeed': 6, u'weatherSymbol': 2, u'pop': 57, u'windGust': -5002, u'windBearing': 353, u'windDirection': u'N', u'condition': u'Partly cloudy throughout the day.', u'relativeHumidity': 77}, {u'tempLow': 685, u'temperature': 750, u'dewpoint': 645, u'tempHigh': 815, u'sky': 2, u'visibility': 16000, u'dateTime': u'2018-08-18 00:00:00', u'pressure': 1016, u'windSpeed': 7, u'weatherSymbol': 2, u'pop': 4, u'windGust': -5002, u'windBearing': 27, u'windDirection': u'NNE', u'condition': u'Partly cloudy throughout the day.', u'relativeHumidity': 72}, {u'tempLow': 687, u'temperature': 766, u'dewpoint': 626, u'tempHigh': 845, u'sky': 2, u'visibility': 16000, u'dateTime': u'2018-08-19 00:00:00', u'pressure': 1015, u'windSpeed': 3, u'weatherSymbol': 1, u'pop': 2, u'windGust': -5002, u'windBearing': 91, u'windDirection': u'E', u'condition': u'Mostly cloudy starting in the evening.', u'relativeHumidity': 65}, {u'tempLow': -5002, u'temperature': 724, u'dewpoint': 698, u'tempHigh': -5002, u'sky': 4, u'visibility': 14000, u'dateTime': u'2018-08-16 00:00:00', u'pressure': 1012, u'windSpeed': 5, u'weatherSymbol': 1, u'pop': 20, u'windGust': -5002, u'windBearing': 165, u'windDirection': u'SSE', u'condition': u'Mostly Cloudy', u'relativeHumidity': 92}, {u'tempLow': -5002, u'temperature': 709, u'dewpoint': 698, u'tempHigh': -5002, u'sky': 3, u'visibility': 16000, u'dateTime': u'2018-08-16 06:00:00', u'pressure': 1012, u'windSpeed': 3, u'weatherSymbol': 1, u'pop': 8, u'windGust': -5002, u'windBearing': 14, u'windDirection': u'NNE', u'condition': u'Partly Cloudy', u'relativeHumidity': 97}, {u'tempLow': -5002, u'temperature': 793, u'dewpoint': 699, u'tempHigh': -5002, u'sky': 4, u'visibility': 16000, u'dateTime': u'2018-08-16 12:00:00', u'pressure': 1012, u'windSpeed': 4, u'weatherSymbol': 2, u'pop': 7, u'windGust': -5002, u'windBearing': 33, u'windDirection': u'NNE', u'condition': u'Mostly Cloudy', u'relativeHumidity': 73}, {u'tempLow': -5002, u'temperature': 791, u'dewpoint': 691, u'tempHigh': -5002, u'sky': 4, u'visibility': 16000, u'dateTime': u'2018-08-16 18:00:00', u'pressure': 1012, u'windSpeed': 5, u'weatherSymbol': 2, u'pop': 7, u'windGust': -5002, u'windBearing': 8, u'windDirection': u'N', u'condition': u'Mostly Cloudy', u'relativeHumidity': 72}]}, u'identifier': u'314784831377', u'thermostatTime': u'2018-08-15 21:21:16', u'features': u'HomeKit'}
2018-08-15 21:21:16.467 DEBUG   Plugin.debugLog:    heat setpoint: 690, cool setpoint: 750, hvac mode: cool, fan mode: auto, climate: home, status 
2018-08-15 21:21:16.467 DEBUG   Plugin.debugLog:    Sensor Temp: 691
2018-08-15 21:21:16.468 DEBUG   Plugin.debugLog:    updating Smart thermostat from server
2018-08-15 21:21:17.408 DEBUG   Plugin.debugLog:    heat setpoint: 720, cool setpoint: 750, hvac mode: cool, fan mode: auto, climate: home, status compCool1,fan
2018-08-15 21:21:17.409 DEBUG   Plugin.debugLog:    updating Smart thermostat from server

plugin.log.2018-08-15.zip

rapamatic commented 6 years ago

This is happening around once a day now... the plugin silently fails, it doesn't throw an authentication error and stops putting anything in the log... I checked the log file again, looked basically the same as the above log, with no obvious errors... Looks like everything is going along and then it crashes hard... Fun stuff! Let me know if anything else I can do to help - I know the code for this is incredibly convoluted and hard to meaningfully debug...

FlyingDiver commented 6 years ago

Check the Ecobee devices for the last updated time. Is there anything in the logs about that time?

rapamatic commented 6 years ago

Last update was 2018-08-20 15:42:37. Here's the ecobee log file from around then, everything looks normal:

2018-08-20 15:41:31.057 DEBUG   Plugin.debugLog:    looking for remote sensor G5PH in [{u'code': u'G5PH', u'name': u'Desk', u'inUse': True, u'capability': [{u'type': u'temperature', u'id': u'1', u'value': u'749'}, {u'type': u'occupancy', u'id': u'2', u'value': u'false'}], u'type': u'ecobee3_remote_sensor', u'id': u'rs:100'}]
2018-08-20 15:41:31.057 DEBUG   Plugin.debugLog:    Sensor Temp: 749
2018-08-20 15:41:31.058 DEBUG   Plugin.debugLog:    updating ecobee3 thermostat from server
2018-08-20 15:41:31.777 DEBUG   Plugin.debugLog:    updateServer: thermostat 314784831377 -
{u'program': {u'currentClimateRef': u'home', u'climates': [{u'vent': u'off', u'name': u'Away', u'coolTemp': 820, u'isOptimized': True, u'colour': 9021815, u'ventilatorMinOnTime': 20, u'heatFan': u'auto', u'heatTemp': 640, u'isOccupied': False, u'owner': u'system', u'climateRef': u'away', u'type': u'program', u'sensors': [{u'id': u'ei:0:1', u'name': u'Office'}, {u'id': u'rs:100:1', u'name': u'Desk'}], u'coolFan': u'auto'}, {u'vent': u'off', u'name': u'Home', u'coolTemp': 750, u'isOptimized': False, u'colour': 13560055, u'ventilatorMinOnTime': 20, u'heatFan': u'auto', u'heatTemp': 690, u'isOccupied': True, u'owner': u'system', u'climateRef': u'home', u'type': u'program', u'sensors': [{u'id': u'ei:0:1', u'name': u'Office'}, {u'id': u'rs:100:1', u'name': u'Desk'}], u'coolFan': u'auto'}, {u'vent': u'off', u'name': u'Sleep', u'coolTemp': 750, u'isOptimized': False, u'colour': 2179683, u'ventilatorMinOnTime': 20, u'heatFan': u'auto', u'heatTemp': 670, u'isOccupied': True, u'owner': u'system', u'climateRef': u'sleep', u'type': u'program', u'sensors': [{u'id': u'ei:0:1', u'name': u'Office'}, {u'id': u'rs:100:1', u'name': u'Desk'}], u'coolFan': u'auto'}], u'schedule': [[u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep']]}, u'runtime': {u'firstConnected': u'2015-10-20 14:44:37', u'desiredFanMode': u'auto', u'desiredHeatRange': [450, 790], u'desiredCoolRange': [650, 920], u'actualHumidity': 56, u'desiredCool': 750, u'desiredDehumidity': 50, u'lastModified': u'2018-08-20 20:39:50', u'desiredHumidity': 36, u'connectDateTime': u'2018-08-19 07:00:22', u'desiredHeat': 690, u'lastStatusModified': u'2018-08-20 20:39:50', u'connected': True, u'actualTemperature': 715, u'runtimeInterval': 245, u'runtimeRev': u'180820203950', u'runtimeDate': u'2018-08-20', u'disconnectDateTime': u'2018-08-19 06:56:20'}, u'name': u'Office', u'settings': {u'electricityBillCycleMonths': 1, u'condensationAvoid': False, u'hasUVFilter': True, u'disablePreHeating': False, u'coolRangeHigh': 920, u'tempAlertNotifyTechnician': False, u'enableElectricityBillAlert': False, u'humidityHighAlert': 80, u'ventilatorMinOnTimeAway': 0, u'serviceRemindTechnician': False, u'ventilatorType': u'none', u'groupName': u'Glencoe', u'maxSetForward': 80, u'heatPumpReversalOnCool': True, u'heatRangeLow': 450, u'ventilatorFreeCooling': True, u'hasHumidifier': False, u'hvacMode': u'cool', u'heatRangeHigh': 790, u'dehumidifyWhenHeating': False, u'stage1HeatingDifferentialTemp': 5, u'installerCodeRequired': False, u'wifiOfflineAlert': False, u'remindMeDate': u'2014-12-21', u'auxMaxOutdoorTemp': 700, u'hotTempAlertEnabled': True, u'tempCorrection': 0, u'auxOutdoorTempAlert': 800, u'humidity': u'36', u'ventilatorMinOnTimeHome': 20, u'smartCirculation': False, u'heatMaxTemp': 1200, u'ventilatorDehumidify': True, u'hasHrv': False, u'eiLocation': u'', u'locale': u'en', u'dehumidifyOvercoolOffset': 20, u'soundAlertVolume': 0, u'coolStages': 1, u'maxSetBack': 100, u'hasDehumidifier': False, u'disableHeatPumpAlerts': False, u'randomStartDelayCool': 0, u'hasHeatPump': False, u'drAccept': u'always', u'auxRuntimeAlertNotifyTechnician': False, u'electricityBillStartMonth': 1, u'coolRangeLow': 650, u'lastServiceDate': u'2014-06-21', u'userAccessSetting': 0, u'disablePreCooling': False, u'coolMaxTemp': 1200, u'humidityAlertNotify': True, u'compressorProtectionMinTime': 300, u'hotTempAlert': 920, u'heatPumpGroundWater': False, u'enableProjectedElectricityBillAlert': False, u'auxOutdoorTempAlertNotify': False, u'hasElectric': False, u'hasErv': False, u'soundTickVolume': 0, u'vent': u'off', u'backlightOffDuringSleep': False, u'serviceRemindMe': False, u'groupSetting': 1880, u'quickSaveSetBack': 40, u'auxRuntimeAlert': 0, u'ventilatorMinOnTime': 20, u'heatMinTemp': 450, u'dehumidifierLevel': 50, u'dehumidifierMode': u'on', u'auxOutdoorTempAlertNotifyTechnician': False, u'autoAway': False, u'fanMinOnTime': 10, u'compressorProtectionMinTemp': 450, u'heatStages': 1, u'groupRef': u'4897d4ae78000670', u'monthsBetweenService': 6, u'coldTempAlertEnabled': True, u'fanControlRequired': True, u'followMeComfort': False, u'backlightSleepIntensity': 4, u'useCelsius': False, u'dehumidifyWithAC': True, u'quickSaveSetForward': 40, u'coldTempAlert': 500, u'userAccessCode': u'', u'backlightOffTime': 60, u'stage1CoolingDifferentialTemp': 5, u'useTimeFormat12': True, u'tempAlertNotify': True, u'heatCoolMinDelta': 30, u'backlightOnIntensity': 10, u'hasForcedAir': True, u'auxRuntimeAlertNotify': False, u'autoHeatCoolFeatureEnabled': True, u'humidifierMode': u'off', u'stage1HeatingDissipationTime': 31, u'holdAction': u'askMe', u'coolingLockout': False, u'useZoneController': False, u'monthlyElectricityBillLimit': 0, u'ventilatorOffDateTime': u'', u'isVentilatorTimerOn': False, u'humidityAlertNotifyTechnician': False, u'electricityBillingDayOfMonth': 1, u'randomStartDelayHeat': 0, u'humidityLowAlert': 5, u'disableAlertsOnIdt': False, u'stage1CoolingDissipationTime': 31, u'isRentalProperty': False, u'hasBoiler': False, u'coolMinTemp': -100}, u'lastModified': u'2018-08-18 20:38:30', u'brand': u'ecobee', u'remoteSensors': [{u'code': u'G5PH', u'name': u'Desk', u'inUse': True, u'capability': [{u'type': u'temperature', u'id': u'1', u'value': u'749'}, {u'type': u'occupancy', u'id': u'2', u'value': u'false'}], u'type': u'ecobee3_remote_sensor', u'id': u'rs:100'}, {u'capability': [{u'type': u'temperature', u'id': u'1', u'value': u'682'}, {u'type': u'humidity', u'id': u'2', u'value': u'56'}, {u'type': u'occupancy', u'id': u'3', u'value': u'false'}], u'inUse': True, u'type': u'thermostat', u'id': u'ei:0', u'name': u'Office'}], u'events': [{u'startDate': u'2035-01-01', u'drRampUpTemp': 0, u'endDate': u'2035-01-01', u'vent': u'off', u'isHeatOff': False, u'coolHoldTemp': 800, u'ventilatorMinOnTime': 5, u'linkRef': u'', u'drRampUpTime': 3600, u'isTemperatureAbsolute': False, u'isTemperatureRelative': False, u'dutyCyclePercentage': 255, u'isOccupied': False, u'heatRelativeTemp': 40, u'coolRelativeTemp': 40, u'unoccupiedSensorActive': False, u'type': u'template', u'fanMinOnTime': 5, u'isOptional': True, u'running': False, u'fan': u'auto', u'startTime': u'00:00:00', u'occupiedSensorActive': False, u'holdClimateRef': u'', u'isCoolOff': False, u'name': u'_Default_', u'heatHoldTemp': 550, u'endTime': u'23:59:59'}], u'equipmentStatus': u'', u'utcTime': u'2018-08-20 20:41:31', u'modelNumber': u'athenaSmart', u'isRegistered': True, u'thermostatRev': u'180818203830', u'weather': {u'timestamp': u'2018-08-20 20:33:24', u'weatherStation': u'FI:KNBU', u'forecasts': [{u'tempLow': 704, u'temperature': 739, u'dewpoint': 702, u'tempHigh': 755, u'sky': 4, u'visibility': 14000, u'dateTime': u'2018-08-20 15:33:24', u'pressure': 1008, u'windSpeed': 10, u'weatherSymbol': 2, u'pop': 0, u'windGust': -5002, u'windBearing': 109, u'windDirection': u'ESE', u'condition': u'Mostly Cloudy', u'relativeHumidity': 88}, {u'tempLow': 689, u'temperature': 744, u'dewpoint': 663, u'tempHigh': 800, u'sky': 4, u'visibility': 16000, u'dateTime': u'2018-08-21 00:00:00', u'pressure': 1010, u'windSpeed': 7, u'weatherSymbol': 16, u'pop': 74, u'windGust': -5002, u'windBearing': 354, u'windDirection': u'N', u'condition': u'Partly cloudy throughout the day and breezy in the afternoon.', u'relativeHumidity': 79}, {u'tempLow': 611, u'temperature': 691, u'dewpoint': 535, u'tempHigh': 772, u'sky': 2, u'visibility': 16000, u'dateTime': u'2018-08-22 00:00:00', u'pressure': 1019, u'windSpeed': 9, u'weatherSymbol': 0, u'pop': 11, u'windGust': -5002, u'windBearing': 341, u'windDirection': u'NNW', u'condition': u'Clear throughout the day.', u'relativeHumidity': 57}, {u'tempLow': 605, u'temperature': 707, u'dewpoint': 537, u'tempHigh': 810, u'sky': 1, u'visibility': 16000, u'dateTime': u'2018-08-23 00:00:00', u'pressure': 1019, u'windSpeed': 5, u'weatherSymbol': 1, u'pop': 0, u'windGust': -5002, u'windBearing': 240, u'windDirection': u'WSW', u'condition': u'Partly cloudy overnight.', u'relativeHumidity': 55}, {u'tempLow': 648, u'temperature': 693, u'dewpoint': 569, u'tempHigh': 739, u'sky': 4, u'visibility': 16000, u'dateTime': u'2018-08-24 00:00:00', u'pressure': 1016, u'windSpeed': 10, u'weatherSymbol': 2, u'pop': 59, u'windGust': -5002, u'windBearing': 180, u'windDirection': u'S', u'condition': u'Mostly cloudy throughout the day.', u'relativeHumidity': 65}, {u'tempLow': -5002, u'temperature': 755, u'dewpoint': 694, u'tempHigh': -5002, u'sky': 4, u'visibility': 16000, u'dateTime': u'2018-08-20 18:00:00', u'pressure': 1007, u'windSpeed': 11, u'weatherSymbol': 6, u'pop': 42, u'windGust': -5002, u'windBearing': 112, u'windDirection': u'ESE', u'condition': u'Rain', u'relativeHumidity': 82}, {u'tempLow': -5002, u'temperature': 720, u'dewpoint': 701, u'tempHigh': -5002, u'sky': 5, u'visibility': 11000, u'dateTime': u'2018-08-21 00:00:00', u'pressure': 1007, u'windSpeed': 5, u'weatherSymbol': 6, u'pop': 37, u'windGust': -5002, u'windBearing': 166, u'windDirection': u'SSE', u'condition': u'Light Rain', u'relativeHumidity': 94}, {u'tempLow': -5002, u'temperature': 689, u'dewpoint': 683, u'tempHigh': -5002, u'sky': 4, u'visibility': 16000, u'dateTime': u'2018-08-21 06:00:00', u'pressure': 1007, u'windSpeed': 3, u'weatherSymbol': 1, u'pop': 18, u'windGust': -5002, u'windBearing': 300, u'windDirection': u'WNW', u'condition': u'Mostly Cloudy', u'relativeHumidity': 98}, {u'tempLow': -5002, u'temperature': 764, u'dewpoint': 643, u'tempHigh': -5002, u'sky': 4, u'visibility': 16000, u'dateTime': u'2018-08-21 12:00:00', u'pressure': 1010, u'windSpeed': 16, u'weatherSymbol': 16, u'pop': 19, u'windGust': -5002, u'windBearing': 1, u'windDirection': u'N', u'condition': u'Breezy and Mostly Cloudy', u'relativeHumidity': 66}]}, u'identifier': u'314784831377', u'thermostatTime': u'2018-08-20 15:41:31', u'features': u'HomeKit'}
2018-08-20 15:41:31.778 DEBUG   Plugin.debugLog:    heat setpoint: 690, cool setpoint: 750, hvac mode: cool, fan mode: auto, climate: home, status 
2018-08-20 15:41:31.778 DEBUG   Plugin.debugLog:    Sensor Temp: 682
2018-08-20 15:41:31.779 DEBUG   Plugin.debugLog:    updating Smart thermostat from server
2018-08-20 15:41:32.397 DEBUG   Plugin.debugLog:    heat setpoint: 720, cool setpoint: 750, hvac mode: cool, fan mode: auto, climate: home, status 
2018-08-20 15:41:32.398 DEBUG   Plugin.debugLog:    updating Smart thermostat from server
2018-08-20 15:41:33.030 DEBUG   Plugin.debugLog:    heat setpoint: 680, cool setpoint: 740, hvac mode: cool, fan mode: auto, climate: home, status 
2018-08-20 15:42:35.288 DEBUG   Plugin.debugLog:    looking for remote sensor G5PH in [{u'code': u'G5PH', u'name': u'Desk', u'inUse': True, u'capability': [{u'type': u'temperature', u'id': u'1', u'value': u'749'}, {u'type': u'occupancy', u'id': u'2', u'value': u'false'}], u'type': u'ecobee3_remote_sensor', u'id': u'rs:100'}]
2018-08-20 15:42:35.289 DEBUG   Plugin.debugLog:    Sensor Temp: 749
2018-08-20 15:42:35.289 DEBUG   Plugin.debugLog:    updating ecobee3 thermostat from server
2018-08-20 15:42:36.007 DEBUG   Plugin.debugLog:    updateServer: thermostat 314784831377 -
{u'program': {u'currentClimateRef': u'home', u'climates': [{u'vent': u'off', u'name': u'Away', u'coolTemp': 820, u'isOptimized': True, u'colour': 9021815, u'ventilatorMinOnTime': 20, u'heatFan': u'auto', u'heatTemp': 640, u'isOccupied': False, u'owner': u'system', u'climateRef': u'away', u'type': u'program', u'sensors': [{u'id': u'ei:0:1', u'name': u'Office'}, {u'id': u'rs:100:1', u'name': u'Desk'}], u'coolFan': u'auto'}, {u'vent': u'off', u'name': u'Home', u'coolTemp': 750, u'isOptimized': False, u'colour': 13560055, u'ventilatorMinOnTime': 20, u'heatFan': u'auto', u'heatTemp': 690, u'isOccupied': True, u'owner': u'system', u'climateRef': u'home', u'type': u'program', u'sensors': [{u'id': u'ei:0:1', u'name': u'Office'}, {u'id': u'rs:100:1', u'name': u'Desk'}], u'coolFan': u'auto'}, {u'vent': u'off', u'name': u'Sleep', u'coolTemp': 750, u'isOptimized': False, u'colour': 2179683, u'ventilatorMinOnTime': 20, u'heatFan': u'auto', u'heatTemp': 670, u'isOccupied': True, u'owner': u'system', u'climateRef': u'sleep', u'type': u'program', u'sensors': [{u'id': u'ei:0:1', u'name': u'Office'}, {u'id': u'rs:100:1', u'name': u'Desk'}], u'coolFan': u'auto'}], u'schedule': [[u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep'], [u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'sleep', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'home', u'sleep']]}, u'runtime': {u'firstConnected': u'2015-10-20 14:44:37', u'desiredFanMode': u'auto', u'desiredHeatRange': [450, 790], u'desiredCoolRange': [650, 920], u'actualHumidity': 56, u'desiredCool': 750, u'desiredDehumidity': 50, u'lastModified': u'2018-08-20 20:39:50', u'desiredHumidity': 36, u'connectDateTime': u'2018-08-19 07:00:22', u'desiredHeat': 690, u'lastStatusModified': u'2018-08-20 20:39:50', u'connected': True, u'actualTemperature': 715, u'runtimeInterval': 245, u'runtimeRev': u'180820203950', u'runtimeDate': u'2018-08-20', u'disconnectDateTime': u'2018-08-19 06:56:20'}, u'name': u'Office', u'settings': {u'electricityBillCycleMonths': 1, u'condensationAvoid': False, u'hasUVFilter': True, u'disablePreHeating': False, u'coolRangeHigh': 920, u'tempAlertNotifyTechnician': False, u'enableElectricityBillAlert': False, u'humidityHighAlert': 80, u'ventilatorMinOnTimeAway': 0, u'serviceRemindTechnician': False, u'ventilatorType': u'none', u'groupName': u'Glencoe', u'maxSetForward': 80, u'heatPumpReversalOnCool': True, u'heatRangeLow': 450, u'ventilatorFreeCooling': True, u'hasHumidifier': False, u'hvacMode': u'cool', u'heatRangeHigh': 790, u'dehumidifyWhenHeating': False, u'stage1HeatingDifferentialTemp': 5, u'installerCodeRequired': False, u'wifiOfflineAlert': False, u'remindMeDate': u'2014-12-21', u'auxMaxOutdoorTemp': 700, u'hotTempAlertEnabled': True, u'tempCorrection': 0, u'auxOutdoorTempAlert': 800, u'humidity': u'36', u'ventilatorMinOnTimeHome': 20, u'smartCirculation': False, u'heatMaxTemp': 1200, u'ventilatorDehumidify': True, u'hasHrv': False, u'eiLocation': u'', u'locale': u'en', u'dehumidifyOvercoolOffset': 20, u'soundAlertVolume': 0, u'coolStages': 1, u'maxSetBack': 100, u'hasDehumidifier': False, u'disableHeatPumpAlerts': False, u'randomStartDelayCool': 0, u'hasHeatPump': False, u'drAccept': u'always', u'auxRuntimeAlertNotifyTechnician': False, u'electricityBillStartMonth': 1, u'coolRangeLow': 650, u'lastServiceDate': u'2014-06-21', u'userAccessSetting': 0, u'disablePreCooling': False, u'coolMaxTemp': 1200, u'humidityAlertNotify': True, u'compressorProtectionMinTime': 300, u'hotTempAlert': 920, u'heatPumpGroundWater': False, u'enableProjectedElectricityBillAlert': False, u'auxOutdoorTempAlertNotify': False, u'hasElectric': False, u'hasErv': False, u'soundTickVolume': 0, u'vent': u'off', u'backlightOffDuringSleep': False, u'serviceRemindMe': False, u'groupSetting': 1880, u'quickSaveSetBack': 40, u'auxRuntimeAlert': 0, u'ventilatorMinOnTime': 20, u'heatMinTemp': 450, u'dehumidifierLevel': 50, u'dehumidifierMode': u'on', u'auxOutdoorTempAlertNotifyTechnician': False, u'autoAway': False, u'fanMinOnTime': 10, u'compressorProtectionMinTemp': 450, u'heatStages': 1, u'groupRef': u'4897d4ae78000670', u'monthsBetweenService': 6, u'coldTempAlertEnabled': True, u'fanControlRequired': True, u'followMeComfort': False, u'backlightSleepIntensity': 4, u'useCelsius': False, u'dehumidifyWithAC': True, u'quickSaveSetForward': 40, u'coldTempAlert': 500, u'userAccessCode': u'', u'backlightOffTime': 60, u'stage1CoolingDifferentialTemp': 5, u'useTimeFormat12': True, u'tempAlertNotify': True, u'heatCoolMinDelta': 30, u'backlightOnIntensity': 10, u'hasForcedAir': True, u'auxRuntimeAlertNotify': False, u'autoHeatCoolFeatureEnabled': True, u'humidifierMode': u'off', u'stage1HeatingDissipationTime': 31, u'holdAction': u'askMe', u'coolingLockout': False, u'useZoneController': False, u'monthlyElectricityBillLimit': 0, u'ventilatorOffDateTime': u'', u'isVentilatorTimerOn': False, u'humidityAlertNotifyTechnician': False, u'electricityBillingDayOfMonth': 1, u'randomStartDelayHeat': 0, u'humidityLowAlert': 5, u'disableAlertsOnIdt': False, u'stage1CoolingDissipationTime': 31, u'isRentalProperty': False, u'hasBoiler': False, u'coolMinTemp': -100}, u'lastModified': u'2018-08-18 20:38:30', u'brand': u'ecobee', u'remoteSensors': [{u'code': u'G5PH', u'name': u'Desk', u'inUse': True, u'capability': [{u'type': u'temperature', u'id': u'1', u'value': u'749'}, {u'type': u'occupancy', u'id': u'2', u'value': u'false'}], u'type': u'ecobee3_remote_sensor', u'id': u'rs:100'}, {u'capability': [{u'type': u'temperature', u'id': u'1', u'value': u'682'}, {u'type': u'humidity', u'id': u'2', u'value': u'56'}, {u'type': u'occupancy', u'id': u'3', u'value': u'false'}], u'inUse': True, u'type': u'thermostat', u'id': u'ei:0', u'name': u'Office'}], u'events': [{u'startDate': u'2035-01-01', u'drRampUpTemp': 0, u'endDate': u'2035-01-01', u'vent': u'off', u'isHeatOff': False, u'coolHoldTemp': 800, u'ventilatorMinOnTime': 5, u'linkRef': u'', u'drRampUpTime': 3600, u'isTemperatureAbsolute': False, u'isTemperatureRelative': False, u'dutyCyclePercentage': 255, u'isOccupied': False, u'heatRelativeTemp': 40, u'coolRelativeTemp': 40, u'unoccupiedSensorActive': False, u'type': u'template', u'fanMinOnTime': 5, u'isOptional': True, u'running': False, u'fan': u'auto', u'startTime': u'00:00:00', u'occupiedSensorActive': False, u'holdClimateRef': u'', u'isCoolOff': False, u'name': u'_Default_', u'heatHoldTemp': 550, u'endTime': u'23:59:59'}], u'equipmentStatus': u'', u'utcTime': u'2018-08-20 20:42:35', u'modelNumber': u'athenaSmart', u'isRegistered': True, u'thermostatRev': u'180818203830', u'weather': {u'timestamp': u'2018-08-20 20:33:24', u'weatherStation': u'FI:KNBU', u'forecasts': [{u'tempLow': 704, u'temperature': 739, u'dewpoint': 702, u'tempHigh': 755, u'sky': 4, u'visibility': 14000, u'dateTime': u'2018-08-20 15:33:24', u'pressure': 1008, u'windSpeed': 10, u'weatherSymbol': 2, u'pop': 0, u'windGust': -5002, u'windBearing': 109, u'windDirection': u'ESE', u'condition': u'Mostly Cloudy', u'relativeHumidity': 88}, {u'tempLow': 689, u'temperature': 744, u'dewpoint': 663, u'tempHigh': 800, u'sky': 4, u'visibility': 16000, u'dateTime': u'2018-08-21 00:00:00', u'pressure': 1010, u'windSpeed': 7, u'weatherSymbol': 16, u'pop': 74, u'windGust': -5002, u'windBearing': 354, u'windDirection': u'N', u'condition': u'Partly cloudy throughout the day and breezy in the afternoon.', u'relativeHumidity': 79}, {u'tempLow': 611, u'temperature': 691, u'dewpoint': 535, u'tempHigh': 772, u'sky': 2, u'visibility': 16000, u'dateTime': u'2018-08-22 00:00:00', u'pressure': 1019, u'windSpeed': 9, u'weatherSymbol': 0, u'pop': 11, u'windGust': -5002, u'windBearing': 341, u'windDirection': u'NNW', u'condition': u'Clear throughout the day.', u'relativeHumidity': 57}, {u'tempLow': 605, u'temperature': 707, u'dewpoint': 537, u'tempHigh': 810, u'sky': 1, u'visibility': 16000, u'dateTime': u'2018-08-23 00:00:00', u'pressure': 1019, u'windSpeed': 5, u'weatherSymbol': 1, u'pop': 0, u'windGust': -5002, u'windBearing': 240, u'windDirection': u'WSW', u'condition': u'Partly cloudy overnight.', u'relativeHumidity': 55}, {u'tempLow': 648, u'temperature': 693, u'dewpoint': 569, u'tempHigh': 739, u'sky': 4, u'visibility': 16000, u'dateTime': u'2018-08-24 00:00:00', u'pressure': 1016, u'windSpeed': 10, u'weatherSymbol': 2, u'pop': 59, u'windGust': -5002, u'windBearing': 180, u'windDirection': u'S', u'condition': u'Mostly cloudy throughout the day.', u'relativeHumidity': 65}, {u'tempLow': -5002, u'temperature': 755, u'dewpoint': 694, u'tempHigh': -5002, u'sky': 4, u'visibility': 16000, u'dateTime': u'2018-08-20 18:00:00', u'pressure': 1007, u'windSpeed': 11, u'weatherSymbol': 6, u'pop': 42, u'windGust': -5002, u'windBearing': 112, u'windDirection': u'ESE', u'condition': u'Rain', u'relativeHumidity': 82}, {u'tempLow': -5002, u'temperature': 720, u'dewpoint': 701, u'tempHigh': -5002, u'sky': 5, u'visibility': 11000, u'dateTime': u'2018-08-21 00:00:00', u'pressure': 1007, u'windSpeed': 5, u'weatherSymbol': 6, u'pop': 37, u'windGust': -5002, u'windBearing': 166, u'windDirection': u'SSE', u'condition': u'Light Rain', u'relativeHumidity': 94}, {u'tempLow': -5002, u'temperature': 689, u'dewpoint': 683, u'tempHigh': -5002, u'sky': 4, u'visibility': 16000, u'dateTime': u'2018-08-21 06:00:00', u'pressure': 1007, u'windSpeed': 3, u'weatherSymbol': 1, u'pop': 18, u'windGust': -5002, u'windBearing': 300, u'windDirection': u'WNW', u'condition': u'Mostly Cloudy', u'relativeHumidity': 98}, {u'tempLow': -5002, u'temperature': 764, u'dewpoint': 643, u'tempHigh': -5002, u'sky': 4, u'visibility': 16000, u'dateTime': u'2018-08-21 12:00:00', u'pressure': 1010, u'windSpeed': 16, u'weatherSymbol': 16, u'pop': 19, u'windGust': -5002, u'windBearing': 1, u'windDirection': u'N', u'condition': u'Breezy and Mostly Cloudy', u'relativeHumidity': 66}]}, u'identifier': u'314784831377', u'thermostatTime': u'2018-08-20 15:42:35', u'features': u'HomeKit'}
2018-08-20 15:42:36.007 DEBUG   Plugin.debugLog:    heat setpoint: 690, cool setpoint: 750, hvac mode: cool, fan mode: auto, climate: home, status 
2018-08-20 15:42:36.008 DEBUG   Plugin.debugLog:    Sensor Temp: 682
2018-08-20 15:42:36.009 DEBUG   Plugin.debugLog:    updating Smart thermostat from server
2018-08-20 15:42:36.757 DEBUG   Plugin.debugLog:    heat setpoint: 720, cool setpoint: 750, hvac mode: cool, fan mode: auto, climate: home, status 
2018-08-20 15:42:36.758 DEBUG   Plugin.debugLog:    updating Smart thermostat from server
2018-08-20 15:42:37.640 DEBUG   Plugin.debugLog:    heat setpoint: 680, cool setpoint: 740, hvac mode: cool, fan mode: auto, climate: home, status

There's nothing in the indigo log around the same time...

FlyingDiver commented 6 years ago

So the plugin just stops logging anything after that?

rapamatic commented 6 years ago

Yeah, that’s the end of the ecobee log file. In fact, since I haven’t restarted the plugin, it hasn’t even renamed the log file with yesterday’s date. It’s still just plugin.log instead of plugin.log.2018-08-20. Seems like it’s crashing on a pretty fundamental level.

FlyingDiver commented 6 years ago

Except I think that if the plugin actually crashed, Indigo would catch that.

So I'm thinking it's in some sort of loop that not doing anything.

Can you try to use Activity Monitor to see if that process is actually running?

rapamatic commented 6 years ago

looks like its still running heres what i can see using the utilities plugin:

utilities                       starting print plugin names, id, mem cpu  daughter processes . . . takes a little time,  using lsof, ps -ef, ps aux
   utilities                       
    PID    CPU-total  Mem-% -Virt -Real  version       pluginName ------------------------  .. + sub processes and non std open files 
    631      3:10.33    0.1  2626    36  1.4.0        Pushover
  53702      8:48.96    0.1  2630    48  1.2.8        Ecobee
                                                       openFile:   192.168.2.58:49969->api.ecobee.com:https (ESTABLISHED)

It is still running in activity monitor too, any way to troubleshoot from activity monitor?

FlyingDiver commented 6 years ago

It's worth a try. Open Activity Monitor, then find that PID (53702). Double click the line in the AM window, then click the sample button. Save the file and post it.

rapamatic commented 6 years ago

Sample of IndigoPluginHost.txt

Here's the sample file

FlyingDiver commented 6 years ago

Hmmm. Actually can tell a few things comparing it to a sample from my server.

What macOS version are you on?

It appears to be locking up on a socket read deep down in the code that does the https request to the Ecobee API.

rapamatic commented 6 years ago

I'm still on the latest El Cap (10.11.6) as I'm running Indigo on an old (2009) Mac Pro... I've been meaning to transfer Indigo over to a a newer mac mini, maybe this will be what pushes me over the edge...

FlyingDiver commented 6 years ago

What model is that Mac Pro? I have a 2010 MacPro5,1 that runs Sierra. And I think you can flash the BIOS on the 4,1 to make it a 5,1.

https://www.imore.com/how-upgrade-your-older-mac-pro-firmware

rapamatic commented 6 years ago

I will have to check that out - I've got a 4,1 now, but with 64 GB RAM and 2 4 core xeons I think it should be able to handle Sierra...

FlyingDiver commented 6 years ago

Also, I recently upgraded that Pro from an 8 core 2.4Ghz to a 12 core 2.93GHz for a net cost of $400.

I needed the extra cores because SecuritySpy really likes more cores. I haven't actually moved Indigo to that machine yet but I will as soon as I need the Mini for something else.

rapamatic commented 6 years ago

I don't use SecuritySpy - I'm running Surveillance Station on my Synology, so hopefully my 2x quad core 2.26 GHz should be enough to handle Indigo and a few background processes... But, nice to now that its not that $$ to upgrade... although I'm keeping my fingers crossed that we finally see a nice mac mini update...

FlyingDiver commented 6 years ago

My old DS411 couldn't handle many cameras. My new DS418play probably could, but I've already got the 8 camera license for SS.

FlyingDiver commented 6 years ago

My 2014 iMac is giving me all sorts of grief, but I've been holding out replacing it because the newer ones really aren't that much better. I could go for the iMac Pro, but that seems a little silly for mostly playing World of Warcraft. ;) I tried a Hackintosh, but keeping it stable was more trouble than it was worth. I'll look at the new "mini Pro", or might hold out for the modular Mac Pro. We'll see this fall.

rapamatic commented 6 years ago

I've got a DS1515+, which seems to handle 6 cameras ok (the recent update for the DS Cam app on iOS made things dramatically faster), my bigger issue is I also run Plex on the synology and that seems to get bogged down doing live transcoding... I'm keeping my fingers crossed for a nice mini pro in a few weeks :)

rapamatic commented 6 years ago

Thinking about this some more, I bet restarting the plugin periodically will fix this until I can update the Mac Pro, and this is probably not a bug in the plugin, but rather something deep in the bowels of my aged OS?

FlyingDiver commented 6 years ago

That's my guess. All of the calls to the Ecobee API are done using the Python requests library, which is very stable. And looking at that stack trace, the hang was deep in the OS socket code. So it's probably an OS problem.

Now, could I somehow figure out that the request never returns? Maybe, but that would require spinning it off into another thread. Since you're the only one who's reported this problem, I'm not quite willing to go there. If it was happening to multiple users on Sierra or High Sierra, I'd be more inclined to try it.

rapamatic commented 6 years ago

I agree 100%. I'm definitely an edge case, and as long as I restart the plugin frequently enough (I think 2 hours should work), the credentials shouldn't time out, right?

FlyingDiver commented 6 years ago

Correct. The refresh credentials are good for a long time, so there should be no issues there.

joe

On Aug 21, 2018, at 3:19 PM, Ray Kramer notifications@github.com wrote:

I agree 100%. I'm definitely an edge case, and as long as I restart the plugin frequently enough (I think 2 hours should work), the credentials shouldn't time out, right?

— You are receiving this because you commented. Reply to this email directly, view it on GitHub https://github.com/IndigoDomotics/indigo-ecobee-plugin/issues/10#issuecomment-414791134, or mute the thread https://github.com/notifications/unsubscribe-auth/AAEdEPvr3f72VaBWfcN0O4AJ8dksXZLsks5uTF0xgaJpZM4WASwz.

rapamatic commented 6 years ago

Alright, might as well close this issue then. Thanks!