hass-circadian_lighting Multiple errors if enabling circadian lights

Multiple errors if enabling circadian lights

Open mrDFX opened this issue 3 years ago • 5 comments

Circadian Lighting from HACS, version: 2.0.4 Home Assistant version: 2021.5.3 i'm see next after upgrade Circadian Lighting plugin to 1.0.11

for example:

2021-06-07 21:05:14 ERROR (SyncWorker_28) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f6843622c10>: {'code': -5006, 'message': 'illegal request'} 2021-06-07 21:05:16 ERROR (SyncWorker_29) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f6843622c10>: {'code': -5006, 'message': 'illegal request'} 2021-06-07 21:05:17 ERROR (SyncWorker_6) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f6843622c10>: {'code': -5006, 'message': 'illegal request'} 2021-06-07 21:05:18 ERROR (SyncWorker_4) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f6843622c10>: {'code': -5006, 'message': 'illegal request'} 2021-06-07 21:05:19 ERROR (SyncWorker_0) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f6843622c10>: {'code': -5006, 'message': 'illegal request'} 2021-06-07 21:05:21 ERROR (SyncWorker_32) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f6843622c10>: {'code': -5006, 'message': 'illegal request'} 2021-06-07 21:05:22 ERROR (SyncWorker_22) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f6843622c10>: {'code': -5006, 'message': 'illegal request'} 2021-06-07 21:05:23 ERROR (SyncWorker_23) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f6843622c10>: {'code': -5006, 'message': 'illegal request'} 2021-06-07 21:05:25 ERROR (SyncWorker_13) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f6843622c10>: {'code': -5006, 'message': 'illegal request'} 2021-06-07 21:05:26 ERROR (SyncWorker_3) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f6843622c10>: {'code': -5006, 'message': 'illegal request'} 2021-06-07 21:05:27 ERROR (SyncWorker_17) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f6843622c10>: {'code': -5006, 'message': 'illegal request'} 2021-06-07 21:05:28 ERROR (SyncWorker_12) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_brightness at 0x7f68436228b0>: {'code': -1, 'message': 'client quota exceeded'} 2021-06-07 21:05:29 ERROR (SyncWorker_12) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f6843622c10>: {'code': -1, 'message': 'client quota exceeded'}

Jun 07 '21 18:06 mrDFX

Why are you using such an old version of Circadian Lighting? v1 does not work with Home Assistant 2021.5.x+, so it's almost definitely not caused by CL as v1 of the component doesn't even load on that version of Home Assistant.

EDIT: Sorry, are you saying you updated Circadian Lighting from 1.0.11 to 2.0.4 and that's when the issue started?

Jun 08 '21 12:06 claytonjn

Troubles started after i'm upgrade HA, and plugin Circadian Lighting(then still on version 1.0.11) cant use my yeelight lamps - lamps go to unavailable state after this upgrade HA - next i'm try upgrade Circadian Lighting to 1.0.13b - and Circadian Lighting plugin return same effects.. After released 2.0.4 i'm upgrade Circadian Lighting - but this not solve my troubles.. now i'm cant use Circadian Lighting plugin :(

Jun 08 '21 18:06 mrDFX

@claytonjn, Maybe i'm can provide more logs or other details for resolve this issue?

Jun 08 '21 18:06 mrDFX

Yes, it would be helpful if you turned on debug logging for Circadian Lighting and could post a log that includes both the CL debug log entries and the errors you're seeing from your lights.

Jun 09 '21 12:06 claytonjn

Ok, tnx, f.e.:

2021-06-10 15:32:35 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=light.bathroom_main_light, old_state=<state light.bathroom_main_light=unavailable; min_mireds=153, max_mireds=370, effect_list=['Slow Temp', 'Stop'], supported_color_modes=['color_temp'], friendly_name=Mini Lustre, supported_features=47 @ 2021-06-10T15:31:57.180971+03:00>, new_state=<state light.bathroom_main_light=on; min_mireds=153, max_mireds=370, effect_list=['Slow Temp', 'Stop'], supported_color_modes=['color_temp'], color_mode=color_temp, brightness=252, color_temp=192, flowing=False, music_mode=False, night_light=False, friendly_name=Mini Lustre, supported_features=47 @ 2021-06-10T15:32:35.715147+03:00>> 2021-06-10 15:32:35 DEBUG (MainThread) [homeassistant.components.homekit.accessories] New_state: <state light.bathroom_main_light=on; min_mireds=153, max_mireds=370, effect_list=['Slow Temp', 'Stop'], supported_color_modes=['color_temp'], color_mode=color_temp, brightness=252, color_temp=192, flowing=False, music_mode=False, night_light=False, friendly_name=Mini Lustre, supported_features=47 @ 2021-06-10T15:32:35.715147+03:00> 2021-06-10 15:32:35 DEBUG (MainThread) [custom_components.circadian_lighting.switch] Lights adjusting because light.bathroom_main_light changed from unavailable to on and these attributes changes: color_mode: color_temp, brightness: 252, color_temp: 192, flowing: False, music_mode: False, night_light: False. 2021-06-10 15:32:35 DEBUG (MainThread) [custom_components.circadian_lighting.switch] Lights adjusting because light.bathroom_main_light changed from unavailable to on and these attributes changes: color_mode: color_temp, brightness: 252, color_temp: 192, flowing: False, music_mode: False, night_light: False. 2021-06-10 15:32:35 DEBUG (MainThread) [custom_components.circadian_lighting.switch] Scheduling 'light.turn_on' with the following 'service_data': {'entity_id': 'light.bathroom_main_light', 'transition': 1.0, 'brightness': 254, 'color_temp': 192} 2021-06-10 15:32:35 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=light.liustry_zala, old_state=<state light.liustry_zala=off; min_mireds=153, max_mireds=370, effect_list=['Slow Temp', 'Stop'], supported_color_modes=['color_temp'], entity_id=['light.bathroom_main_light', 'light.guest_room_main_light'], friendly_name=GuestRoom Lustres, icon=mdi:lightbulb-group, supported_features=44 @ 2021-06-10T15:31:57.183507+03:00>, new_state=<state light.liustry_zala=on; min_mireds=153, max_mireds=370, effect_list=['Slow Temp', 'Stop'], supported_color_modes=['color_temp'], color_mode=color_temp, brightness=252, color_temp=192, entity_id=['light.bathroom_main_light', 'light.guest_room_main_light'], friendly_name=GuestRoom Lustres, icon=mdi:lightbulb-group, supported_features=44 @ 2021-06-10T15:32:35.717617+03:00>> 2021-06-10 15:32:35 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection] [139921451340368] Sending {"id": 2, "type": "event", "event": {"event_type": "state_changed", "data": {"entity_id": "light.bathroom_main_light", "old_state": {"entity_id": "light.bathroom_main_light", "state": "unavailable", "attributes": {"min_mireds": 153, "max_mireds": 370, "effect_list": ["Slow Temp", "Stop"], "supported_color_modes": ["color_temp"], "friendly_name": "\u041c\u0430\u043b\u0430\u044f \u043b\u044e\u0441\u0442\u0440\u0430", "supported_features": 47}, "last_changed": "2021-06-10T12:31:57.180971+00:00", "last_updated": "2021-06-10T12:31:57.180971+00:00", "context": {"id": "9d7fb01016e42f36124d8969c0572b56", "parent_id": null, "user_id": null}}, "new_state": {"entity_id": "light.bathroom_main_light", "state": "on", "attributes": {"min_mireds": 153, "max_mireds": 370, "effect_list": ["Slow Temp", "Stop"], "supported_color_modes": ["color_temp"], "color_mode": "color_temp", "brightness": 252, "color_temp": 192, "flowing": false, "music_mode": false, "night_light": false, "friendly_name": "\u041c\u0430\u043b\u0430\u044f \u043b\u044e\u0441\u0442\u0440\u0430", "supported_features": 47}, "last_changed": "2021-06-10T12:32:35.715147+00:00", "last_updated": "2021-06-10T12:32:35.715147+00:00", "context": {"id": "4ea1a4a458ed4227ee9c9364bd37e6d6", "parent_id": null, "user_id": null}}}, "origin": "LOCAL", "time_fired": "2021-06-10T12:32:35.715147+00:00", "context": {"id": "4ea1a4a458ed4227ee9c9364bd37e6d6", "parent_id": null, "user_id": null}}} 2021-06-10 15:32:35 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=light, service=turn_on, service_data=entity_id=light.bathroom_main_light, transition=1.0, brightness=254, color_temp=192> 2021-06-10 15:32:35 DEBUG (MainThread) [homeassistant.components.homekit.accessories] New_state: <state light.liustry_zala=on; min_mireds=153, max_mireds=370, effect_list=['Slow Temp', 'Stop'], supported_color_modes=['color_temp'], color_mode=color_temp, brightness=252, color_temp=192, entity_id=['light.bathroom_main_light', 'light.guest_room_main_light'], friendly_name=GuestRoom Lustres, icon=mdi:lightbulb-group, supported_features=44 @ 2021-06-10T15:32:35.717617+03:00> 2021-06-10 15:32:35 DEBUG (MainThread) [pyhap.characteristic] set_value: On to 1 2021-06-10 15:32:35 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection] [139921451340368] Sending {"id": 2, "type": "event", "event": {"event_type": "state_changed", "data": {"entity_id": "light.liustry_zala", "old_state": {"entity_id": "light.liustry_zala", "state": "off", "attributes": {"min_mireds": 153, "max_mireds": 370, "effect_list": ["Slow Temp", "Stop"], "supported_color_modes": ["color_temp"], "entity_id": ["light.bathroom_main_light", "light.guest_room_main_light"], "friendly_name": "\u041b\u044e\u0441\u0442\u0440\u044b \u0437\u0430\u043b\u0430", "icon": "mdi:lightbulb-group", "supported_features": 44}, "last_changed": "2021-06-10T12:31:57.183507+00:00", "last_updated": "2021-06-10T12:31:57.183507+00:00", "context": {"id": "9d7fb01016e42f36124d8969c0572b56", "parent_id": null, "user_id": null}}, "new_state": {"entity_id": "light.liustry_zala", "state": "on", "attributes": {"min_mireds": 153, "max_mireds": 370, "effect_list": ["Slow Temp", "Stop"], "supported_color_modes": ["color_temp"], "color_mode": "color_temp", "brightness": 252, "color_temp": 192, "entity_id": ["light.bathroom_main_light", "light.guest_room_main_light"], "friendly_name": "\u041b\u044e\u0441\u0442\u0440\u044b \u0437\u0430\u043b\u0430", "icon": "mdi:lightbulb-group", "supported_features": 44}, "last_changed": "2021-06-10T12:32:35.717617+00:00", "last_updated": "2021-06-10T12:32:35.717617+00:00", "context": {"id": "4ea1a4a458ed4227ee9c9364bd37e6d6", "parent_id": null, "user_id": null}}}, "origin": "LOCAL", "time_fired": "2021-06-10T12:32:35.717617+00:00", "context": {"id": "4ea1a4a458ed4227ee9c9364bd37e6d6", "parent_id": null, "user_id": null}}} 2021-06-10 15:32:35 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=light.bathroom_main_light_nightlight, old_state=<state light.bathroom_main_light_nightlight=unavailable; effect_list=['Slow Temp', 'Stop'], supported_color_modes=['brightness'], friendly_name= , icon=mdi:weather-night, supported_features=45 @ 2021-06-10T15:31:57.181282+03:00>, new_state=<state light.bathroom_main_light_nightlight=off; effect_list=['Slow Temp', 'Stop'], supported_color_modes=['brightness'], flowing=False, music_mode=False, night_light=False, friendly_name=Mini Lustre Nigght Mode, icon=mdi:weather-night, supported_features=45 @ 2021-06-10T15:32:35.724010+03:00>> 2021-06-10 15:32:35 DEBUG (MainThread) [homeassistant.components.homekit.accessories] New_state: <state light.bathroom_main_light_nightlight=off; effect_list=['Slow Temp', 'Stop'], supported_color_modes=['brightness'], flowing=False, music_mode=False, night_light=False, friendly_name=Mini Lustre Nigght Mode, icon=mdi:weather-night, supported_features=45 @ 2021-06-10T15:32:35.724010+03:00> 2021-06-10 15:32:35 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection] [139921451340368] Sending {"id": 2, "type": "event", "event": {"event_type": "state_changed", "data": {"entity_id": "light.bathroom_main_light_nightlight", "old_state": {"entity_id": "light.bathroom_main_light_nightlight", "state": "unavailable", "attributes": {"effect_list": ["Slow Temp", "Stop"], "supported_color_modes": ["brightness"], "friendly_name": "\u041d\u043e\u0447\u043d\u043e\u0439 \u0440\u0435\u0436\u0438\u043c \u043c\u0430\u043b\u043e\u0439 \u043b\u044e\u0441\u0442\u0440\u044b", "icon": "mdi:weather-night", "supported_features": 45}, "last_changed": "2021-06-10T12:31:57.181282+00:00", "last_updated": "2021-06-10T12:31:57.181282+00:00", "context": {"id": "d90c14444dd258459f7051a03c6f335f", "parent_id": null, "user_id": null}}, "new_state": {"entity_id": "light.bathroom_main_light_nightlight", "state": "off", "attributes": {"effect_list": ["Slow Temp", "Stop"], "supported_color_modes": ["brightness"], "flowing": false, "music_mode": false, "night_light": false, "friendly_name": "\u041d\u043e\u0447\u043d\u043e\u0439 \u0440\u0435\u0436\u0438\u043c \u043c\u0430\u043b\u043e\u0439 \u043b\u044e\u0441\u0442\u0440\u044b", "icon": "mdi:weather-night", "supported_features": 45}, "last_changed": "2021-06-10T12:32:35.724010+00:00", "last_updated": "2021-06-10T12:32:35.724010+00:00", "context": {"id": "12eb444d1762e2808f0f692d0558a4ed", "parent_id": null, "user_id": null}}}, "origin": "LOCAL", "time_fired": "2021-06-10T12:32:35.724010+00:00", "context": {"id": "12eb444d1762e2808f0f692d0558a4ed", "parent_id": null, "user_id": null}}} 2021-06-10 15:32:35 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 87, 'method': 'set_power', 'params': ['on', 'smooth', 1000, 1]} 2021-06-10 15:32:35 DEBUG (SyncWorker_25) [yeelight.main] Bulb<192.168.1.242:55443, type=BulbType.WhiteTempMood> > {'id': 4, 'method': 'get_prop', 'params': ['power', 'main_power', 'bright', 'ct', 'rgb', 'hue', 'sat', 'color_mode', 'flowing', 'bg_power', 'bg_lmode', 'bg_flowing', 'bg_ct', 'bg_bright', 'bg_hue', 'bg_sat', 'bg_rgb', 'nl_br', 'active_mode']} 2021-06-10 15:32:36 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> checked out from pool 2021-06-10 15:32:36 DEBUG (SyncWorker_25) [yeelight.main] Bulb<192.168.1.242:55443, type=BulbType.WhiteTempMood> < {'id': 4, 'result': ['off', 'off', '100', '3802', '', '', '', '2', '0', 'off', '2', '0', '2700', '100', '0', '0', '16777215', '0', '0']} 2021-06-10 15:32:36 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> being returned to pool 2021-06-10 15:32:36 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> rollback-on-return 2021-06-10 15:32:36 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 87, 'result': ['ok']} 2021-06-10 15:32:36 DEBUG (SyncWorker_3) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_rgb at 0x7f41f87bd160> with (None, 1000) {} 2021-06-10 15:32:36 DEBUG (SyncWorker_3) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_colortemp at 0x7f41f87bd280> with (192, 1000) {} 2021-06-10 15:32:36 DEBUG (SyncWorker_3) [homeassistant.components.yeelight.light] Setting color temp: 5208 K 2021-06-10 15:32:36 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 88, 'method': 'set_ct_abx', 'params': [5208, 'smooth', 1000]} 2021-06-10 15:32:36 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 88, 'result': ['ok']} 2021-06-10 15:32:36 DEBUG (SyncWorker_3) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_brightness at 0x7f41f87bd040> with (254, 1000) {} 2021-06-10 15:32:36 DEBUG (SyncWorker_3) [homeassistant.components.yeelight.light] Setting brightness: 254 2021-06-10 15:32:36 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 89, 'method': 'set_bright', 'params': [99.6078431372549, 'smooth', 1000]} 2021-06-10 15:32:36 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.circadian_values, old_state=<state sensor.circadian_values=89.9866604151581; colortemp=5199.599812454742, rgb_color=(255, 231.90616025214513, 212.6755238763966), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:35.293722+03:00>, new_state=<state sensor.circadian_values=89.9845092161199; colortemp=5199.535276483597, rgb_color=(255, 231.90492564084514, 212.67339523428973), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:36.294279+03:00>> 2021-06-10 15:32:36 DEBUG (MainThread) [custom_components.circadian_lighting.switch] Scheduling 'light.turn_on' with the following 'service_data': {'entity_id': 'light.bathroom_main_light', 'transition': 200.0, 'brightness': 254, 'color_temp': 192} 2021-06-10 15:32:36 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=light, service=turn_on, service_data=entity_id=light.bathroom_main_light, transition=200.0, brightness=254, color_temp=192> 2021-06-10 15:32:36 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection] [139921451340368] Sending {"id": 2, "type": "event", "event": {"event_type": "state_changed", "data": {"entity_id": "sensor.circadian_values", "old_state": {"entity_id": "sensor.circadian_values", "state": "89.9866604151581", "attributes": {"colortemp": 5199.599812454742, "rgb_color": [255, 231.90616025214513, 212.6755238763966], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:35.293722+00:00", "last_updated": "2021-06-10T12:32:35.293722+00:00", "context": {"id": "49cbf74d3b1decd45bb03eb2bb0a7229", "parent_id": null, "user_id": null}}, "new_state": {"entity_id": "sensor.circadian_values", "state": "89.9845092161199", "attributes": {"colortemp": 5199.535276483597, "rgb_color": [255, 231.90492564084514, 212.67339523428973], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:36.294279+00:00", "last_updated": "2021-06-10T12:32:36.294279+00:00", "context": {"id": "000544519752a3dbce7b4f166d402182", "parent_id": null, "user_id": null}}}, "origin": "LOCAL", "time_fired": "2021-06-10T12:32:36.294279+00:00", "context": {"id": "000544519752a3dbce7b4f166d402182", "parent_id": null, "user_id": null}}} 2021-06-10 15:32:36 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 89, 'result': ['ok']} 2021-06-10 15:32:36 DEBUG (SyncWorker_3) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_flash at 0x7f41f87bd4c0> with (None,) {} 2021-06-10 15:32:36 DEBUG (SyncWorker_3) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_effect at 0x7f41f87bd5e0> with (None,) {} 2021-06-10 15:32:36 DEBUG (SyncWorker_3) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_default at 0x7f41f87bd3a0> with () {} 2021-06-10 15:32:36 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 90, 'method': 'set_default', 'params': []} 2021-06-10 15:32:36 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 90, 'error': {'code': -5006, 'message': 'illegal request'}} 2021-06-10 15:32:36 ERROR (SyncWorker_3) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f41f87bd3a0>: {'code': -5006, 'message': 'illegal request'} 2021-06-10 15:32:36 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 91, 'method': 'get_prop', 'params': ['power', 'main_power', 'bright', 'ct', 'rgb', 'hue', 'sat', 'color_mode', 'flowing', 'bg_power', 'bg_lmode', 'bg_flowing', 'bg_ct', 'bg_bright', 'bg_hue', 'bg_sat', 'bg_rgb', 'nl_br', 'active_mode']} 2021-06-10 15:32:37 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> checked out from pool 2021-06-10 15:32:37 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> being returned to pool 2021-06-10 15:32:37 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> rollback-on-return 2021-06-10 15:32:37 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 91, 'result': ['on', '', '99', '5208', '', '', '', '2', '0', '', '', '', '', '', '', '', '', '0', '0']} 2021-06-10 15:32:37 DEBUG (SyncWorker_20) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 92, 'method': 'set_power', 'params': ['on', 'smooth', 200000, 1]} 2021-06-10 15:32:37 DEBUG (SyncWorker_20) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 92, 'result': ['ok']} 2021-06-10 15:32:37 DEBUG (SyncWorker_20) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_rgb at 0x7f41f87bd160> with (None, 200000) {} 2021-06-10 15:32:37 DEBUG (SyncWorker_20) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_colortemp at 0x7f41f87bd280> with (192, 200000) {} 2021-06-10 15:32:37 DEBUG (SyncWorker_20) [homeassistant.components.yeelight.light] Setting color temp: 5208 K 2021-06-10 15:32:37 DEBUG (SyncWorker_20) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 93, 'method': 'set_ct_abx', 'params': [5208, 'smooth', 200000]} 2021-06-10 15:32:37 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.circadian_values, old_state=<state sensor.circadian_values=89.9845092161199; colortemp=5199.535276483597, rgb_color=(255, 231.90492564084514, 212.67339523428973), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:36.294279+03:00>, new_state=<state sensor.circadian_values=89.9823569089315; colortemp=5199.470707267947, rgb_color=(255, 231.90369037822228, 212.67126546291536), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:37.295521+03:00>> 2021-06-10 15:32:37 DEBUG (MainThread) [custom_components.circadian_lighting.switch] Scheduling 'light.turn_on' with the following 'service_data': {'entity_id': 'light.bathroom_main_light', 'transition': 200.0, 'brightness': 254, 'color_temp': 192} 2021-06-10 15:32:37 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=light, service=turn_on, service_data=entity_id=light.bathroom_main_light, transition=200.0, brightness=254, color_temp=192> 2021-06-10 15:32:37 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection] [139921451340368] Sending {"id": 2, "type": "event", "event": {"event_type": "state_changed", "data": {"entity_id": "sensor.circadian_values", "old_state": {"entity_id": "sensor.circadian_values", "state": "89.9845092161199", "attributes": {"colortemp": 5199.535276483597, "rgb_color": [255, 231.90492564084514, 212.67339523428973], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:36.294279+00:00", "last_updated": "2021-06-10T12:32:36.294279+00:00", "context": {"id": "000544519752a3dbce7b4f166d402182", "parent_id": null, "user_id": null}}, "new_state": {"entity_id": "sensor.circadian_values", "state": "89.9823569089315", "attributes": {"colortemp": 5199.470707267947, "rgb_color": [255, 231.90369037822228, 212.67126546291536], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:37.295521+00:00", "last_updated": "2021-06-10T12:32:37.295521+00:00", "context": {"id": "9e5af4aee1b4f74b765bba6e188d288d", "parent_id": null, "user_id": null}}}, "origin": "LOCAL", "time_fired": "2021-06-10T12:32:37.295521+00:00", "context": {"id": "9e5af4aee1b4f74b765bba6e188d288d", "parent_id": null, "user_id": null}}} 2021-06-10 15:32:37 DEBUG (SyncWorker_20) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 93, 'result': ['ok']} 2021-06-10 15:32:37 DEBUG (SyncWorker_20) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_brightness at 0x7f41f87bd040> with (254, 200000) {} 2021-06-10 15:32:37 DEBUG (SyncWorker_20) [homeassistant.components.yeelight.light] Setting brightness: 254 2021-06-10 15:32:37 DEBUG (SyncWorker_20) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 94, 'method': 'set_bright', 'params': [99.6078431372549, 'smooth', 200000]} 2021-06-10 15:32:37 DEBUG (SyncWorker_20) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 94, 'result': ['ok']} 2021-06-10 15:32:37 DEBUG (SyncWorker_20) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_flash at 0x7f41f87bd4c0> with (None,) {} 2021-06-10 15:32:37 DEBUG (SyncWorker_20) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_effect at 0x7f41f87bd5e0> with (None,) {} 2021-06-10 15:32:37 DEBUG (SyncWorker_20) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_default at 0x7f41f87bd3a0> with () {} 2021-06-10 15:32:37 DEBUG (SyncWorker_20) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 95, 'method': 'set_default', 'params': []} 2021-06-10 15:32:38 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> checked out from pool 2021-06-10 15:32:38 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> being returned to pool 2021-06-10 15:32:38 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> rollback-on-return 2021-06-10 15:32:38 DEBUG (SyncWorker_20) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 95, 'error': {'code': -5006, 'message': 'illegal request'}} 2021-06-10 15:32:38 ERROR (SyncWorker_20) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f41f87bd3a0>: {'code': -5006, 'message': 'illegal request'} 2021-06-10 15:32:38 DEBUG (SyncWorker_20) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 96, 'method': 'get_prop', 'params': ['power', 'main_power', 'bright', 'ct', 'rgb', 'hue', 'sat', 'color_mode', 'flowing', 'bg_power', 'bg_lmode', 'bg_flowing', 'bg_ct', 'bg_bright', 'bg_hue', 'bg_sat', 'bg_rgb', 'nl_br', 'active_mode']} 2021-06-10 15:32:38 DEBUG (SyncWorker_20) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 96, 'result': ['on', '', '99', '5208', '', '', '', '2', '0', '', '', '', '', '', '', '', '', '0', '0']} 2021-06-10 15:32:38 DEBUG (SyncWorker_16) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 97, 'method': 'set_power', 'params': ['on', 'smooth', 200000, 1]} 2021-06-10 15:32:38 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.circadian_values, old_state=<state sensor.circadian_values=89.9823569089315; colortemp=5199.470707267947, rgb_color=(255, 231.90369037822228, 212.67126546291536), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:37.295521+03:00>, new_state=<state sensor.circadian_values=89.9802046934931; colortemp=5199.406140804792, rgb_color=(255, 231.9024551529178, 212.6691357495855), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:38.296472+03:00>> 2021-06-10 15:32:38 DEBUG (MainThread) [custom_components.circadian_lighting.switch] Scheduling 'light.turn_on' with the following 'service_data': {'entity_id': 'light.bathroom_main_light', 'transition': 200.0, 'brightness': 254, 'color_temp': 192} 2021-06-10 15:32:38 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=light, service=turn_on, service_data=entity_id=light.bathroom_main_light, transition=200.0, brightness=254, color_temp=192> 2021-06-10 15:32:38 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection] [139921451340368] Sending {"id": 2, "type": "event", "event": {"event_type": "state_changed", "data": {"entity_id": "sensor.circadian_values", "old_state": {"entity_id": "sensor.circadian_values", "state": "89.9823569089315", "attributes": {"colortemp": 5199.470707267947, "rgb_color": [255, 231.90369037822228, 212.67126546291536], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:37.295521+00:00", "last_updated": "2021-06-10T12:32:37.295521+00:00", "context": {"id": "9e5af4aee1b4f74b765bba6e188d288d", "parent_id": null, "user_id": null}}, "new_state": {"entity_id": "sensor.circadian_values", "state": "89.9802046934931", "attributes": {"colortemp": 5199.406140804792, "rgb_color": [255, 231.9024551529178, 212.6691357495855], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:38.296472+00:00", "last_updated": "2021-06-10T12:32:38.296472+00:00", "context": {"id": "9c664966ab6a85974f139dc7c6bb2cdc", "parent_id": null, "user_id": null}}}, "origin": "LOCAL", "time_fired": "2021-06-10T12:32:38.296472+00:00", "context": {"id": "9c664966ab6a85974f139dc7c6bb2cdc", "parent_id": null, "user_id": null}}} 2021-06-10 15:32:39 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> checked out from pool 2021-06-10 15:32:39 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> being returned to pool 2021-06-10 15:32:39 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> rollback-on-return 2021-06-10 15:32:39 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.circadian_values, old_state=<state sensor.circadian_values=89.9802046934931; colortemp=5199.406140804792, rgb_color=(255, 231.9024551529178, 212.6691357495855), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:38.296472+03:00>, new_state=<state sensor.circadian_values=89.978050001621; colortemp=5199.34150004863, rgb_color=(255, 231.90121849094328, 212.66700355291255), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:39.298229+03:00>> 2021-06-10 15:32:39 DEBUG (MainThread) [custom_components.circadian_lighting.switch] Scheduling 'light.turn_on' with the following 'service_data': {'entity_id': 'light.bathroom_main_light', 'transition': 200.0, 'brightness': 254, 'color_temp': 192} 2021-06-10 15:32:39 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=light, service=turn_on, service_data=entity_id=light.bathroom_main_light, transition=200.0, brightness=254, color_temp=192> 2021-06-10 15:32:39 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection] [139921451340368] Sending {"id": 2, "type": "event", "event": {"event_type": "state_changed", "data": {"entity_id": "sensor.circadian_values", "old_state": {"entity_id": "sensor.circadian_values", "state": "89.9802046934931", "attributes": {"colortemp": 5199.406140804792, "rgb_color": [255, 231.9024551529178, 212.6691357495855], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:38.296472+00:00", "last_updated": "2021-06-10T12:32:38.296472+00:00", "context": {"id": "9c664966ab6a85974f139dc7c6bb2cdc", "parent_id": null, "user_id": null}}, "new_state": {"entity_id": "sensor.circadian_values", "state": "89.978050001621", "attributes": {"colortemp": 5199.34150004863, "rgb_color": [255, 231.90121849094328, 212.66700355291255], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:39.298229+00:00", "last_updated": "2021-06-10T12:32:39.298229+00:00", "context": {"id": "341573e25f365e39eb06ec3495bb51f4", "parent_id": null, "user_id": null}}}, "origin": "LOCAL", "time_fired": "2021-06-10T12:32:39.298229+00:00", "context": {"id": "341573e25f365e39eb06ec3495bb51f4", "parent_id": null, "user_id": null}}} 2021-06-10 15:32:40 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> checked out from pool 2021-06-10 15:32:40 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> being returned to pool 2021-06-10 15:32:40 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> rollback-on-return 2021-06-10 15:32:40 DEBUG (SyncWorker_16) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 97, 'result': ['ok']} 2021-06-10 15:32:40 DEBUG (SyncWorker_16) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_rgb at 0x7f41f87bd160> with (None, 200000) {} 2021-06-10 15:32:40 DEBUG (SyncWorker_16) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_colortemp at 0x7f41f87bd280> with (192, 200000) {} 2021-06-10 15:32:40 DEBUG (SyncWorker_16) [homeassistant.components.yeelight.light] Setting color temp: 5208 K 2021-06-10 15:32:40 DEBUG (SyncWorker_16) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 98, 'method': 'set_ct_abx', 'params': [5208, 'smooth', 200000]} 2021-06-10 15:32:40 DEBUG (SyncWorker_16) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 98, 'result': ['ok']} 2021-06-10 15:32:40 DEBUG (SyncWorker_16) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_brightness at 0x7f41f87bd040> with (254, 200000) {} 2021-06-10 15:32:40 DEBUG (SyncWorker_16) [homeassistant.components.yeelight.light] Setting brightness: 254 2021-06-10 15:32:40 DEBUG (SyncWorker_16) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 99, 'method': 'set_bright', 'params': [99.6078431372549, 'smooth', 200000]} 2021-06-10 15:32:40 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.circadian_values, old_state=<state sensor.circadian_values=89.978050001621; colortemp=5199.34150004863, rgb_color=(255, 231.90121849094328, 212.66700355291255), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:39.298229+03:00>, new_state=<state sensor.circadian_values=89.9758968154292; colortemp=5199.276904462875, rgb_color=(255, 231.89998267777872, 212.66487281341358), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:40.298996+03:00>> 2021-06-10 15:32:40 DEBUG (MainThread) [custom_components.circadian_lighting.switch] Scheduling 'light.turn_on' with the following 'service_data': {'entity_id': 'light.bathroom_main_light', 'transition': 200.0, 'brightness': 254, 'color_temp': 192} 2021-06-10 15:32:40 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=light, service=turn_on, service_data=entity_id=light.bathroom_main_light, transition=200.0, brightness=254, color_temp=192> 2021-06-10 15:32:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection] [139921451340368] Sending {"id": 2, "type": "event", "event": {"event_type": "state_changed", "data": {"entity_id": "sensor.circadian_values", "old_state": {"entity_id": "sensor.circadian_values", "state": "89.978050001621", "attributes": {"colortemp": 5199.34150004863, "rgb_color": [255, 231.90121849094328, 212.66700355291255], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:39.298229+00:00", "last_updated": "2021-06-10T12:32:39.298229+00:00", "context": {"id": "341573e25f365e39eb06ec3495bb51f4", "parent_id": null, "user_id": null}}, "new_state": {"entity_id": "sensor.circadian_values", "state": "89.9758968154292", "attributes": {"colortemp": 5199.276904462875, "rgb_color": [255, 231.89998267777872, 212.66487281341358], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:40.298996+00:00", "last_updated": "2021-06-10T12:32:40.298996+00:00", "context": {"id": "0627d3aa1daa4ebb9704cf8413ac9f55", "parent_id": null, "user_id": null}}}, "origin": "LOCAL", "time_fired": "2021-06-10T12:32:40.298996+00:00", "context": {"id": "0627d3aa1daa4ebb9704cf8413ac9f55", "parent_id": null, "user_id": null}}} 2021-06-10 15:32:40 DEBUG (SyncWorker_16) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 99, 'result': ['ok']} 2021-06-10 15:32:40 DEBUG (SyncWorker_16) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_flash at 0x7f41f87bd4c0> with (None,) {} 2021-06-10 15:32:40 DEBUG (SyncWorker_16) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_effect at 0x7f41f87bd5e0> with (None,) {} 2021-06-10 15:32:40 DEBUG (SyncWorker_16) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_default at 0x7f41f87bd3a0> with () {} 2021-06-10 15:32:40 DEBUG (SyncWorker_16) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 100, 'method': 'set_default', 'params': []} 2021-06-10 15:32:40 DEBUG (SyncWorker_16) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 100, 'error': {'code': -5006, 'message': 'illegal request'}} 2021-06-10 15:32:40 ERROR (SyncWorker_16) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f41f87bd3a0>: {'code': -5006, 'message': 'illegal request'} 2021-06-10 15:32:40 DEBUG (SyncWorker_16) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 101, 'method': 'get_prop', 'params': ['power', 'main_power', 'bright', 'ct', 'rgb', 'hue', 'sat', 'color_mode', 'flowing', 'bg_power', 'bg_lmode', 'bg_flowing', 'bg_ct', 'bg_bright', 'bg_hue', 'bg_sat', 'bg_rgb', 'nl_br', 'active_mode']} 2021-06-10 15:32:40 DEBUG (SyncWorker_10) [miio.miioprotocol] 192.168.1.245:54321 >>: {'id': 106, 'method': 'get_prop', 'params': ['power', 'dv', 'bright', 'cct', 'snm']} 2021-06-10 15:32:40 DEBUG (SyncWorker_14) [miio.miioprotocol] 192.168.1.29:54321 >>: {'id': 106, 'method': 'get_prop', 'params': ['power', 'dv', 'bright', 'cct', 'snm']} 2021-06-10 15:32:40 DEBUG (SyncWorker_10) [miio.miioprotocol] 192.168.1.245:54321 (ts: 1970-01-06 14:30:22, id: 106) << {'result': ['off', 0, 100, 52, 0], 'id': 106} 2021-06-10 15:32:40 DEBUG (SyncWorker_8) [miio.miioprotocol] 192.168.1.244:54321 >>: {'id': 106, 'method': 'get_prop', 'params': ['power', 'dv', 'bright', 'cct', 'snm']} 2021-06-10 15:32:40 DEBUG (MainThread) [homeassistant.components.xiaomi_miio.light] Got new state: <PhilipsBulbStatus brightness=100 color_temperature=52 delay_off_countdown=0 is_on=False power=off scene=0> 2021-06-10 15:32:40 DEBUG (SyncWorker_6) [miio.miioprotocol] 192.168.1.231:54321 >>: {'id': 106, 'method': 'get_prop', 'params': ['power', 'dv', 'bright', 'cct', 'snm']} 2021-06-10 15:32:40 DEBUG (SyncWorker_8) [miio.miioprotocol] 192.168.1.244:54321 (ts: 1970-01-06 14:30:22, id: 106) << {'result': ['off', 0, 100, 52, 0], 'id': 106} 2021-06-10 15:32:40 DEBUG (MainThread) [homeassistant.components.xiaomi_miio.light] Got new state: <PhilipsBulbStatus brightness=100 color_temperature=52 delay_off_countdown=0 is_on=False power=off scene=0> 2021-06-10 15:32:40 DEBUG (MainThread) [homeassistant.components.xiaomi_miio.light] Got new state: <PhilipsBulbStatus brightness=100 color_temperature=52 delay_off_countdown=0 is_on=False power=off scene=0> 2021-06-10 15:32:40 DEBUG (MainThread) [homeassistant.components.xiaomi_miio.light] Got new state: <PhilipsBulbStatus brightness=100 color_temperature=52 delay_off_countdown=0 is_on=False power=off scene=0> 2021-06-10 15:32:40 DEBUG (SyncWorker_14) [miio.miioprotocol] 192.168.1.29:54321 (ts: 1970-01-06 14:30:23, id: 106) << {'result': ['off', 0, 100, 52, 0], 'id': 106} 2021-06-10 15:32:40 DEBUG (MainThread) [homeassistant.components.xiaomi_miio.light] Got new state: <PhilipsBulbStatus brightness=100 color_temperature=52 delay_off_countdown=0 is_on=False power=off scene=0> 2021-06-10 15:32:40 DEBUG (MainThread) [homeassistant.components.xiaomi_miio.light] Got new state: <PhilipsBulbStatus brightness=100 color_temperature=52 delay_off_countdown=0 is_on=False power=off scene=0> 2021-06-10 15:32:40 DEBUG (SyncWorker_6) [miio.miioprotocol] 192.168.1.231:54321 (ts: 1970-01-06 16:08:03, id: 106) << {'result': ['off', 0, 100, 51, 0], 'id': 106} 2021-06-10 15:32:40 DEBUG (MainThread) [homeassistant.components.xiaomi_miio.light] Got new state: <PhilipsBulbStatus brightness=100 color_temperature=52 delay_off_countdown=0 is_on=False power=off scene=0> 2021-06-10 15:32:40 DEBUG (MainThread) [homeassistant.components.xiaomi_miio.light] Got new state: <PhilipsBulbStatus brightness=100 color_temperature=51 delay_off_countdown=0 is_on=False power=off scene=0> 2021-06-10 15:32:41 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> checked out from pool 2021-06-10 15:32:41 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> being returned to pool 2021-06-10 15:32:41 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> rollback-on-return 2021-06-10 15:32:41 DEBUG (SyncWorker_16) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 101, 'result': ['on', '', '99', '5208', '', '', '', '2', '0', '', '', '', '', '', '', '', '', '0', '0']} 2021-06-10 15:32:41 DEBUG (SyncWorker_1) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 102, 'method': 'set_power', 'params': ['on', 'smooth', 200000, 1]} 2021-06-10 15:32:41 DEBUG (SyncWorker_1) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 102, 'result': ['ok']} 2021-06-10 15:32:41 DEBUG (SyncWorker_1) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_rgb at 0x7f41f87bd160> with (None, 200000) {} 2021-06-10 15:32:41 DEBUG (SyncWorker_1) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_colortemp at 0x7f41f87bd280> with (192, 200000) {} 2021-06-10 15:32:41 DEBUG (SyncWorker_1) [homeassistant.components.yeelight.light] Setting color temp: 5208 K 2021-06-10 15:32:41 DEBUG (SyncWorker_1) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 103, 'method': 'set_ct_abx', 'params': [5208, 'smooth', 200000]} 2021-06-10 15:32:41 DEBUG (MainThread) [homeassistant.components.xiaomi_miio.light] Got new state: <PhilipsBulbStatus brightness=100 color_temperature=51 delay_off_countdown=0 is_on=False power=off scene=0> 2021-06-10 15:32:41 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.circadian_values, old_state=<state sensor.circadian_values=89.9758968154292; colortemp=5199.276904462875, rgb_color=(255, 231.89998267777872, 212.66487281341358), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:40.298996+03:00>, new_state=<state sensor.circadian_values=89.9737454524153; colortemp=5199.21236357246, rgb_color=(255, 231.89874789568609, 212.6627438453512), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:41.299240+03:00>> 2021-06-10 15:32:41 DEBUG (MainThread) [custom_components.circadian_lighting.switch] Scheduling 'light.turn_on' with the following 'service_data': {'entity_id': 'light.bathroom_main_light', 'transition': 200.0, 'brightness': 254, 'color_temp': 192} 2021-06-10 15:32:41 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=light, service=turn_on, service_data=entity_id=light.bathroom_main_light, transition=200.0, brightness=254, color_temp=192> 2021-06-10 15:32:41 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection] [139921451340368] Sending {"id": 2, "type": "event", "event": {"event_type": "state_changed", "data": {"entity_id": "sensor.circadian_values", "old_state": {"entity_id": "sensor.circadian_values", "state": "89.9758968154292", "attributes": {"colortemp": 5199.276904462875, "rgb_color": [255, 231.89998267777872, 212.66487281341358], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:40.298996+00:00", "last_updated": "2021-06-10T12:32:40.298996+00:00", "context": {"id": "0627d3aa1daa4ebb9704cf8413ac9f55", "parent_id": null, "user_id": null}}, "new_state": {"entity_id": "sensor.circadian_values", "state": "89.9737454524153", "attributes": {"colortemp": 5199.21236357246, "rgb_color": [255, 231.89874789568609, 212.6627438453512], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:41.299240+00:00", "last_updated": "2021-06-10T12:32:41.299240+00:00", "context": {"id": "69cc3bb5b784ff3127e1743fb4a7b12a", "parent_id": null, "user_id": null}}}, "origin": "LOCAL", "time_fired": "2021-06-10T12:32:41.299240+00:00", "context": {"id": "69cc3bb5b784ff3127e1743fb4a7b12a", "parent_id": null, "user_id": null}}} 2021-06-10 15:32:41 DEBUG (SyncWorker_1) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 103, 'result': ['ok']} 2021-06-10 15:32:41 DEBUG (SyncWorker_1) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_brightness at 0x7f41f87bd040> with (254, 200000) {} 2021-06-10 15:32:41 DEBUG (SyncWorker_1) [homeassistant.components.yeelight.light] Setting brightness: 254 2021-06-10 15:32:41 DEBUG (SyncWorker_1) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 104, 'method': 'set_bright', 'params': [99.6078431372549, 'smooth', 200000]} 2021-06-10 15:32:41 DEBUG (SyncWorker_1) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 104, 'result': ['ok']} 2021-06-10 15:32:41 DEBUG (SyncWorker_1) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_flash at 0x7f41f87bd4c0> with (None,) {} 2021-06-10 15:32:41 DEBUG (SyncWorker_1) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_effect at 0x7f41f87bd5e0> with (None,) {} 2021-06-10 15:32:41 DEBUG (SyncWorker_1) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_default at 0x7f41f87bd3a0> with () {} 2021-06-10 15:32:41 DEBUG (SyncWorker_1) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 105, 'method': 'set_default', 'params': []} 2021-06-10 15:32:42 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> checked out from pool 2021-06-10 15:32:42 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> being returned to pool 2021-06-10 15:32:42 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> rollback-on-return 2021-06-10 15:32:42 DEBUG (SyncWorker_1) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 105, 'error': {'code': -5006, 'message': 'illegal request'}} 2021-06-10 15:32:42 ERROR (SyncWorker_1) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f41f87bd3a0>: {'code': -5006, 'message': 'illegal request'} 2021-06-10 15:32:42 DEBUG (SyncWorker_1) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 106, 'method': 'get_prop', 'params': ['power', 'main_power', 'bright', 'ct', 'rgb', 'hue', 'sat', 'color_mode', 'flowing', 'bg_power', 'bg_lmode', 'bg_flowing', 'bg_ct', 'bg_bright', 'bg_hue', 'bg_sat', 'bg_rgb', 'nl_br', 'active_mode']} 2021-06-10 15:32:42 DEBUG (SyncWorker_1) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 106, 'result': ['on', '', '99', '5208', '', '', '', '2', '0', '', '', '', '', '', '', '', '', '0', '0']} 2021-06-10 15:32:42 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 107, 'method': 'set_power', 'params': ['on', 'smooth', 200000, 1]} 2021-06-10 15:32:42 DEBUG (MainThread) [homeassistant.components.wled] Finished fetching wled data in 9.019 seconds 2021-06-10 15:32:42 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.circadian_values, old_state=<state sensor.circadian_values=89.9737454524153; colortemp=5199.21236357246, rgb_color=(255, 231.89874789568609, 212.6627438453512), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:41.299240+03:00>, new_state=<state sensor.circadian_values=89.9715885777482; colortemp=5199.147657332447, rgb_color=(255, 231.89750993477423, 212.66060939016222), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:42.302203+03:00>> 2021-06-10 15:32:42 DEBUG (MainThread) [custom_components.circadian_lighting.switch] Scheduling 'light.turn_on' with the following 'service_data': {'entity_id': 'light.bathroom_main_light', 'transition': 200.0, 'brightness': 254, 'color_temp': 192} 2021-06-10 15:32:42 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=light, service=turn_on, service_data=entity_id=light.bathroom_main_light, transition=200.0, brightness=254, color_temp=192> 2021-06-10 15:32:42 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection] [139921451340368] Sending {"id": 2, "type": "event", "event": {"event_type": "state_changed", "data": {"entity_id": "sensor.circadian_values", "old_state": {"entity_id": "sensor.circadian_values", "state": "89.9737454524153", "attributes": {"colortemp": 5199.21236357246, "rgb_color": [255, 231.89874789568609, 212.6627438453512], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:41.299240+00:00", "last_updated": "2021-06-10T12:32:41.299240+00:00", "context": {"id": "69cc3bb5b784ff3127e1743fb4a7b12a", "parent_id": null, "user_id": null}}, "new_state": {"entity_id": "sensor.circadian_values", "state": "89.9715885777482", "attributes": {"colortemp": 5199.147657332447, "rgb_color": [255, 231.89750993477423, 212.66060939016222], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:42.302203+00:00", "last_updated": "2021-06-10T12:32:42.302203+00:00", "context": {"id": "25f4ec40a31da677ea9b8ca9e7588ed8", "parent_id": null, "user_id": null}}}, "origin": "LOCAL", "time_fired": "2021-06-10T12:32:42.302203+00:00", "context": {"id": "25f4ec40a31da677ea9b8ca9e7588ed8", "parent_id": null, "user_id": null}}} 2021-06-10 15:32:42 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 107, 'result': ['ok']} 2021-06-10 15:32:42 DEBUG (SyncWorker_3) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_rgb at 0x7f41f87bd160> with (None, 200000) {} 2021-06-10 15:32:42 DEBUG (SyncWorker_3) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_colortemp at 0x7f41f87bd280> with (192, 200000) {} 2021-06-10 15:32:42 DEBUG (SyncWorker_3) [homeassistant.components.yeelight.light] Setting color temp: 5208 K 2021-06-10 15:32:42 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 108, 'method': 'set_ct_abx', 'params': [5208, 'smooth', 200000]} 2021-06-10 15:32:42 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 108, 'result': ['ok']} 2021-06-10 15:32:42 DEBUG (SyncWorker_3) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_brightness at 0x7f41f87bd040> with (254, 200000) {} 2021-06-10 15:32:42 DEBUG (SyncWorker_3) [homeassistant.components.yeelight.light] Setting brightness: 254 2021-06-10 15:32:42 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 109, 'method': 'set_bright', 'params': [99.6078431372549, 'smooth', 200000]} 2021-06-10 15:32:43 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> checked out from pool 2021-06-10 15:32:43 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> being returned to pool 2021-06-10 15:32:43 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> rollback-on-return 2021-06-10 15:32:43 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 109, 'result': ['ok']} 2021-06-10 15:32:43 DEBUG (SyncWorker_3) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_flash at 0x7f41f87bd4c0> with (None,) {} 2021-06-10 15:32:43 DEBUG (SyncWorker_3) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_effect at 0x7f41f87bd5e0> with (None,) {} 2021-06-10 15:32:43 DEBUG (SyncWorker_3) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_default at 0x7f41f87bd3a0> with () {} 2021-06-10 15:32:43 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 110, 'method': 'set_default', 'params': []} 2021-06-10 15:32:43 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 110, 'error': {'code': -5006, 'message': 'illegal request'}} 2021-06-10 15:32:43 ERROR (SyncWorker_3) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f41f87bd3a0>: {'code': -5006, 'message': 'illegal request'} 2021-06-10 15:32:43 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 111, 'method': 'get_prop', 'params': ['power', 'main_power', 'bright', 'ct', 'rgb', 'hue', 'sat', 'color_mode', 'flowing', 'bg_power', 'bg_lmode', 'bg_flowing', 'bg_ct', 'bg_bright', 'bg_hue', 'bg_sat', 'bg_rgb', 'nl_br', 'active_mode']} 2021-06-10 15:32:43 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.circadian_values, old_state=<state sensor.circadian_values=89.9715885777482; colortemp=5199.147657332447, rgb_color=(255, 231.89750993477423, 212.66060939016222), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:42.302203+03:00>, new_state=<state sensor.circadian_values=89.9694364965295; colortemp=5199.0830948958865, rgb_color=(255, 231.89627470975677, 212.6584796458152), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:43.301793+03:00>> 2021-06-10 15:32:43 DEBUG (MainThread) [custom_components.circadian_lighting.switch] Scheduling 'light.turn_on' with the following 'service_data': {'entity_id': 'light.bathroom_main_light', 'transition': 200.0, 'brightness': 254, 'color_temp': 192} 2021-06-10 15:32:43 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=light, service=turn_on, service_data=entity_id=light.bathroom_main_light, transition=200.0, brightness=254, color_temp=192> 2021-06-10 15:32:43 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection] [139921451340368] Sending {"id": 2, "type": "event", "event": {"event_type": "state_changed", "data": {"entity_id": "sensor.circadian_values", "old_state": {"entity_id": "sensor.circadian_values", "state": "89.9715885777482", "attributes": {"colortemp": 5199.147657332447, "rgb_color": [255, 231.89750993477423, 212.66060939016222], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:42.302203+00:00", "last_updated": "2021-06-10T12:32:42.302203+00:00", "context": {"id": "25f4ec40a31da677ea9b8ca9e7588ed8", "parent_id": null, "user_id": null}}, "new_state": {"entity_id": "sensor.circadian_values", "state": "89.9694364965295", "attributes": {"colortemp": 5199.0830948958865, "rgb_color": [255, 231.89627470975677, 212.6584796458152], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:43.301793+00:00", "last_updated": "2021-06-10T12:32:43.301793+00:00", "context": {"id": "a15bbe89151af7b492a977af22879115", "parent_id": null, "user_id": null}}}, "origin": "LOCAL", "time_fired": "2021-06-10T12:32:43.301793+00:00", "context": {"id": "a15bbe89151af7b492a977af22879115", "parent_id": null, "user_id": null}}} 2021-06-10 15:32:43 DEBUG (SyncWorker_3) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 111, 'result': ['on', '', '99', '5208', '', '', '', '2', '0', '', '', '', '', '', '', '', '', '0', '0']} 2021-06-10 15:32:43 DEBUG (SyncWorker_2) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 112, 'method': 'set_power', 'params': ['on', 'smooth', 200000, 1]} 2021-06-10 15:32:43 DEBUG (SyncWorker_2) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 112, 'result': ['ok']} 2021-06-10 15:32:43 DEBUG (SyncWorker_2) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_rgb at 0x7f41f87bd160> with (None, 200000) {} 2021-06-10 15:32:43 DEBUG (SyncWorker_2) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_colortemp at 0x7f41f87bd280> with (192, 200000) {} 2021-06-10 15:32:43 DEBUG (SyncWorker_2) [homeassistant.components.yeelight.light] Setting color temp: 5208 K 2021-06-10 15:32:43 DEBUG (SyncWorker_2) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 113, 'method': 'set_ct_abx', 'params': [5208, 'smooth', 200000]} 2021-06-10 15:32:44 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> checked out from pool 2021-06-10 15:32:44 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> being returned to pool 2021-06-10 15:32:44 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> rollback-on-return 2021-06-10 15:32:44 DEBUG (SyncWorker_2) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 113, 'result': ['ok']} 2021-06-10 15:32:44 DEBUG (SyncWorker_2) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_brightness at 0x7f41f87bd040> with (254, 200000) {} 2021-06-10 15:32:44 DEBUG (SyncWorker_2) [homeassistant.components.yeelight.light] Setting brightness: 254 2021-06-10 15:32:44 DEBUG (SyncWorker_2) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 114, 'method': 'set_bright', 'params': [99.6078431372549, 'smooth', 200000]} 2021-06-10 15:32:44 DEBUG (SyncWorker_2) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 114, 'result': ['ok']} 2021-06-10 15:32:44 DEBUG (SyncWorker_2) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_flash at 0x7f41f87bd4c0> with (None,) {} 2021-06-10 15:32:44 DEBUG (SyncWorker_2) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_effect at 0x7f41f87bd5e0> with (None,) {} 2021-06-10 15:32:44 DEBUG (SyncWorker_2) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_default at 0x7f41f87bd3a0> with () {} 2021-06-10 15:32:44 DEBUG (SyncWorker_2) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 115, 'method': 'set_default', 'params': []} 2021-06-10 15:32:44 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.circadian_values, old_state=<state sensor.circadian_values=89.9694364965295; colortemp=5199.0830948958865, rgb_color=(255, 231.89627470975677, 212.6584796458152), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:43.301793+03:00>, new_state=<state sensor.circadian_values=89.9672830952989; colortemp=5199.018492858968, rgb_color=(255, 231.89503871174173, 212.6563485623809), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:44.303525+03:00>> 2021-06-10 15:32:44 DEBUG (MainThread) [custom_components.circadian_lighting.switch] Scheduling 'light.turn_on' with the following 'service_data': {'entity_id': 'light.bathroom_main_light', 'transition': 200.0, 'brightness': 254, 'color_temp': 192} 2021-06-10 15:32:44 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=light, service=turn_on, service_data=entity_id=light.bathroom_main_light, transition=200.0, brightness=254, color_temp=192> 2021-06-10 15:32:44 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection] [139921451340368] Sending {"id": 2, "type": "event", "event": {"event_type": "state_changed", "data": {"entity_id": "sensor.circadian_values", "old_state": {"entity_id": "sensor.circadian_values", "state": "89.9694364965295", "attributes": {"colortemp": 5199.0830948958865, "rgb_color": [255, 231.89627470975677, 212.6584796458152], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:43.301793+00:00", "last_updated": "2021-06-10T12:32:43.301793+00:00", "context": {"id": "a15bbe89151af7b492a977af22879115", "parent_id": null, "user_id": null}}, "new_state": {"entity_id": "sensor.circadian_values", "state": "89.9672830952989", "attributes": {"colortemp": 5199.018492858968, "rgb_color": [255, 231.89503871174173, 212.6563485623809], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:44.303525+00:00", "last_updated": "2021-06-10T12:32:44.303525+00:00", "context": {"id": "1c876b41ecf24f485ed357f8c4567744", "parent_id": null, "user_id": null}}}, "origin": "LOCAL", "time_fired": "2021-06-10T12:32:44.303525+00:00", "context": {"id": "1c876b41ecf24f485ed357f8c4567744", "parent_id": null, "user_id": null}}} 2021-06-10 15:32:44 DEBUG (SyncWorker_2) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 115, 'error': {'code': -5006, 'message': 'illegal request'}} 2021-06-10 15:32:44 ERROR (SyncWorker_2) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f41f87bd3a0>: {'code': -5006, 'message': 'illegal request'} 2021-06-10 15:32:44 DEBUG (SyncWorker_2) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 116, 'method': 'get_prop', 'params': ['power', 'main_power', 'bright', 'ct', 'rgb', 'hue', 'sat', 'color_mode', 'flowing', 'bg_power', 'bg_lmode', 'bg_flowing', 'bg_ct', 'bg_bright', 'bg_hue', 'bg_sat', 'bg_rgb', 'nl_br', 'active_mode']} 2021-06-10 15:32:44 DEBUG (SyncWorker_2) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 116, 'result': ['on', '', '99', '5208', '', '', '', '2', '0', '', '', '', '', '', '', '', '', '0', '0']} 2021-06-10 15:32:44 DEBUG (SyncWorker_9) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 117, 'method': 'set_power', 'params': ['on', 'smooth', 200000, 1]} 2021-06-10 15:32:45 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> checked out from pool 2021-06-10 15:32:45 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> being returned to pool 2021-06-10 15:32:45 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> rollback-on-return 2021-06-10 15:32:45 DEBUG (SyncWorker_9) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 117, 'result': ['ok']} 2021-06-10 15:32:45 DEBUG (SyncWorker_9) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_rgb at 0x7f41f87bd160> with (None, 200000) {} 2021-06-10 15:32:45 DEBUG (SyncWorker_9) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_colortemp at 0x7f41f87bd280> with (192, 200000) {} 2021-06-10 15:32:45 DEBUG (SyncWorker_9) [homeassistant.components.yeelight.light] Setting color temp: 5208 K 2021-06-10 15:32:45 DEBUG (SyncWorker_9) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 118, 'method': 'set_ct_abx', 'params': [5208, 'smooth', 200000]} 2021-06-10 15:32:45 DEBUG (SyncWorker_9) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 118, 'result': ['ok']} 2021-06-10 15:32:45 DEBUG (SyncWorker_9) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_brightness at 0x7f41f87bd040> with (254, 200000) {} 2021-06-10 15:32:45 DEBUG (SyncWorker_9) [homeassistant.components.yeelight.light] Setting brightness: 254 2021-06-10 15:32:45 DEBUG (SyncWorker_9) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 119, 'method': 'set_bright', 'params': [99.6078431372549, 'smooth', 200000]} 2021-06-10 15:32:45 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.circadian_values, old_state=<state sensor.circadian_values=89.9672830952989; colortemp=5199.018492858968, rgb_color=(255, 231.89503871174173, 212.6563485623809), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:44.303525+03:00>, new_state=<state sensor.circadian_values=89.9651302186875; colortemp=5198.953906560624, rgb_color=(255, 231.89380299949215, 212.6542179653536), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:45.303772+03:00>> 2021-06-10 15:32:45 DEBUG (MainThread) [custom_components.circadian_lighting.switch] Scheduling 'light.turn_on' with the following 'service_data': {'entity_id': 'light.bathroom_main_light', 'transition': 200.0, 'brightness': 254, 'color_temp': 192} 2021-06-10 15:32:45 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=light, service=turn_on, service_data=entity_id=light.bathroom_main_light, transition=200.0, brightness=254, color_temp=192> 2021-06-10 15:32:45 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection] [139921451340368] Sending {"id": 2, "type": "event", "event": {"event_type": "state_changed", "data": {"entity_id": "sensor.circadian_values", "old_state": {"entity_id": "sensor.circadian_values", "state": "89.9672830952989", "attributes": {"colortemp": 5199.018492858968, "rgb_color": [255, 231.89503871174173, 212.6563485623809], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:44.303525+00:00", "last_updated": "2021-06-10T12:32:44.303525+00:00", "context": {"id": "1c876b41ecf24f485ed357f8c4567744", "parent_id": null, "user_id": null}}, "new_state": {"entity_id": "sensor.circadian_values", "state": "89.9651302186875", "attributes": {"colortemp": 5198.953906560624, "rgb_color": [255, 231.89380299949215, 212.6542179653536], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:45.303772+00:00", "last_updated": "2021-06-10T12:32:45.303772+00:00", "context": {"id": "6fc942235c71a792f40339ce705638b3", "parent_id": null, "user_id": null}}}, "origin": "LOCAL", "time_fired": "2021-06-10T12:32:45.303772+00:00", "context": {"id": "6fc942235c71a792f40339ce705638b3", "parent_id": null, "user_id": null}}} 2021-06-10 15:32:45 DEBUG (SyncWorker_9) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 119, 'result': ['ok']} 2021-06-10 15:32:45 DEBUG (SyncWorker_9) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_flash at 0x7f41f87bd4c0> with (None,) {} 2021-06-10 15:32:45 DEBUG (SyncWorker_9) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_effect at 0x7f41f87bd5e0> with (None,) {} 2021-06-10 15:32:45 DEBUG (SyncWorker_9) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_default at 0x7f41f87bd3a0> with () {} 2021-06-10 15:32:45 DEBUG (SyncWorker_9) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 120, 'method': 'set_default', 'params': []} 2021-06-10 15:32:45 DEBUG (SyncWorker_9) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 120, 'error': {'code': -5006, 'message': 'illegal request'}} 2021-06-10 15:32:45 ERROR (SyncWorker_9) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f41f87bd3a0>: {'code': -5006, 'message': 'illegal request'} 2021-06-10 15:32:45 DEBUG (SyncWorker_9) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 121, 'method': 'get_prop', 'params': ['power', 'main_power', 'bright', 'ct', 'rgb', 'hue', 'sat', 'color_mode', 'flowing', 'bg_power', 'bg_lmode', 'bg_flowing', 'bg_ct', 'bg_bright', 'bg_hue', 'bg_sat', 'bg_rgb', 'nl_br', 'active_mode']} 2021-06-10 15:32:46 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> checked out from pool 2021-06-10 15:32:46 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> being returned to pool 2021-06-10 15:32:46 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> rollback-on-return 2021-06-10 15:32:46 DEBUG (SyncWorker_9) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 121, 'result': ['on', '', '99', '5208', '', '', '', '2', '0', '', '', '', '', '', '', '', '', '0', '0']} 2021-06-10 15:32:46 DEBUG (SyncWorker_4) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 122, 'method': 'set_power', 'params': ['on', 'smooth', 200000, 1]} 2021-06-10 15:32:46 DEBUG (SyncWorker_4) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 122, 'result': ['ok']} 2021-06-10 15:32:46 DEBUG (SyncWorker_4) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_rgb at 0x7f41f87bd160> with (None, 200000) {} 2021-06-10 15:32:46 DEBUG (SyncWorker_4) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_colortemp at 0x7f41f87bd280> with (192, 200000) {} 2021-06-10 15:32:46 DEBUG (SyncWorker_4) [homeassistant.components.yeelight.light] Setting color temp: 5208 K 2021-06-10 15:32:46 DEBUG (SyncWorker_4) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 123, 'method': 'set_ct_abx', 'params': [5208, 'smooth', 200000]} 2021-06-10 15:32:46 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.circadian_values, old_state=<state sensor.circadian_values=89.9651302186875; colortemp=5198.953906560624, rgb_color=(255, 231.89380299949215, 212.6542179653536), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:45.303772+03:00>, new_state=<state sensor.circadian_values=89.9629741540016; colortemp=5198.889224620049, rgb_color=(255, 231.89256544196013, 212.65208418039958), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:46.305771+03:00>> 2021-06-10 15:32:46 DEBUG (MainThread) [custom_components.circadian_lighting.switch] Scheduling 'light.turn_on' with the following 'service_data': {'entity_id': 'light.bathroom_main_light', 'transition': 200.0, 'brightness': 254, 'color_temp': 192} 2021-06-10 15:32:46 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=light, service=turn_on, service_data=entity_id=light.bathroom_main_light, transition=200.0, brightness=254, color_temp=192> 2021-06-10 15:32:46 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection] [139921451340368] Sending {"id": 2, "type": "event", "event": {"event_type": "state_changed", "data": {"entity_id": "sensor.circadian_values", "old_state": {"entity_id": "sensor.circadian_values", "state": "89.9651302186875", "attributes": {"colortemp": 5198.953906560624, "rgb_color": [255, 231.89380299949215, 212.6542179653536], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:45.303772+00:00", "last_updated": "2021-06-10T12:32:45.303772+00:00", "context": {"id": "6fc942235c71a792f40339ce705638b3", "parent_id": null, "user_id": null}}, "new_state": {"entity_id": "sensor.circadian_values", "state": "89.9629741540016", "attributes": {"colortemp": 5198.889224620049, "rgb_color": [255, 231.89256544196013, 212.65208418039958], "xy_color": [0.364, 0.347], "unit_of_measurement": "%", "friendly_name": "Circadian Values", "icon": "mdi:theme-light-dark"}, "last_changed": "2021-06-10T12:32:46.305771+00:00", "last_updated": "2021-06-10T12:32:46.305771+00:00", "context": {"id": "cfb903ad3be08250d4b8f27ebfccd9fa", "parent_id": null, "user_id": null}}}, "origin": "LOCAL", "time_fired": "2021-06-10T12:32:46.305771+00:00", "context": {"id": "cfb903ad3be08250d4b8f27ebfccd9fa", "parent_id": null, "user_id": null}}} 2021-06-10 15:32:46 DEBUG (SyncWorker_4) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 123, 'result': ['ok']} 2021-06-10 15:32:46 DEBUG (SyncWorker_4) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_brightness at 0x7f41f87bd040> with (254, 200000) {} 2021-06-10 15:32:46 DEBUG (SyncWorker_4) [homeassistant.components.yeelight.light] Setting brightness: 254 2021-06-10 15:32:46 DEBUG (SyncWorker_4) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 124, 'method': 'set_bright', 'params': [99.6078431372549, 'smooth', 200000]} 2021-06-10 15:32:46 DEBUG (SyncWorker_4) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 124, 'result': ['ok']} 2021-06-10 15:32:46 DEBUG (SyncWorker_4) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_flash at 0x7f41f87bd4c0> with (None,) {} 2021-06-10 15:32:46 DEBUG (SyncWorker_4) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_effect at 0x7f41f87bd5e0> with (None,) {} 2021-06-10 15:32:46 DEBUG (SyncWorker_4) [homeassistant.components.yeelight.light] Calling <function YeelightGenericLight.set_default at 0x7f41f87bd3a0> with () {} 2021-06-10 15:32:46 DEBUG (SyncWorker_4) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 125, 'method': 'set_default', 'params': []} 2021-06-10 15:32:47 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> checked out from pool 2021-06-10 15:32:47 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> being returned to pool 2021-06-10 15:32:47 DEBUG (Recorder) [homeassistant.components.recorder.pool.RecorderPool] Connection <sqlite3.Connection object at 0x7f42042eb210> rollback-on-return 2021-06-10 15:32:47 DEBUG (SyncWorker_4) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 125, 'error': {'code': -5006, 'message': 'illegal request'}} 2021-06-10 15:32:47 ERROR (SyncWorker_4) [homeassistant.components.yeelight.light] Error when calling <function YeelightGenericLight.set_default at 0x7f41f87bd3a0>: {'code': -5006, 'message': 'illegal request'} 2021-06-10 15:32:47 DEBUG (SyncWorker_4) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 126, 'method': 'get_prop', 'params': ['power', 'main_power', 'bright', 'ct', 'rgb', 'hue', 'sat', 'color_mode', 'flowing', 'bg_power', 'bg_lmode', 'bg_flowing', 'bg_ct', 'bg_bright', 'bg_hue', 'bg_sat', 'bg_rgb', 'nl_br', 'active_mode']} 2021-06-10 15:32:47 DEBUG (SyncWorker_4) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> < {'id': 126, 'result': ['on', '', '99', '5208', '', '', '', '2', '0', '', '', '', '', '', '', '', '', '0', '0']} 2021-06-10 15:32:47 DEBUG (SyncWorker_15) [yeelight.main] Bulb<192.168.1.52:55443, type=BulbType.WhiteTemp> > {'id': 127, 'method': 'set_power', 'params': ['on', 'smooth', 200000, 1]} 2021-06-10 15:32:47 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.circadian_values, old_state=<state sensor.circadian_values=89.9629741540016; colortemp=5198.889224620049, rgb_color=(255, 231.89256544196013, 212.65208418039958), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:46.305771+03:00>, new_state=<state sensor.circadian_values=89.9608197241358; colortemp=5198.824591724075, rgb_color=(255, 231.89132880741727, 212.6499519805393), xy_color=(0.364, 0.347), unit_of_measurement=%, friendly_name=Circadian Values, icon=mdi:theme-light-dark @ 2021-06-10T15:32:47.307243+03:00>> 2021-06-10 15:32:47 DEBUG (MainThread) [custom_components.circadian_lighting.switch] Scheduling 'light.turn_on' with the following 'service_data': {'entity_id': 'light.bathroom_main_light', 'transition': 200.0, 'brightness': 254, 'color_temp': 192}

Jun 10 '21 13:06 mrDFX

hass-circadian_lighting hass-circadian_lighting copied to clipboard

Multiple errors if enabling circadian lights

hass-circadian_lighting
hass-circadian_lighting copied to clipboard