Build 21228 has been released. Docker images available from DockerHub as usual, and bare-metal packages here.
Home Assistant up to version 2021.8.6 supported; the online version of the manual will now state the current supported versions;
Fix an error in OWMWeatherController that could cause it to stop updating;
Unify the approach to entity filtering on all hub interface classes (controllers); this works for device entities only; it may be extended to other entities later;
Improve error detail in messages for EzloController during auth phase;
Add isRuleSet() and isRuleEnabled() functions to expressions extensions;
Implement set action for lock and passage capabilities (makes them more easily scriptable in some cases);
Fix a place in the UI where 24-hour time was not being displayed.
Thanks again for the recent release. One thing I wanted to ask about integrations and their 'loaded' condition:
Is there something similar that applies to the entire controller? So if I have (for example) a helper in HA that is used to trigger an automation in MSR, is it possible to effectively exclude it until MSR is 'happy' that HA is stable and its values can be trusted?
This, actually goes back to the issue I had. I've got a use case where a 30 second delay from triggering is a bit of a PITA (sustained for...) and was just wondering if there's a way of knowing that 'native' HA functions are working correctly.
Probably asking wrong, or it's hideously obvious, but...
TIA
C
Hi. First off this is an unsupported version of HS 2026.5.2 so happy to be told it's that.
Currently running latest-26130-3d2a489a on a Debian Buster bare metal VM.
I've been working on moving away from OpenLuup completely and up until now have been using some virtual switches t manage things like 'Is there anyone home'
I have a binary sensor in HA that provides the same thing
binary_sensor.someone_home which appears in MSR as
hass>binary_sensor_someone_home
HA shows on or off. MSR shows true or false
All fine. The odd thing happened after an update of HA and a restart.
From HA
13:07:04 it turned off
13:07:11 it turned on
However that does not appear to have been reflected in MSR which turned all the heating and so on off as it is supposed to do, and I got all my notifications as I should.
Here's a huge log section (sorry) as I wanted to show how MSR identifies that HA is up and running at 12:07:08 (Zulu) but triggers the 'There's no one here' at 12:07:17 some 6 seconds after HA updated to on.
Checking in the interface MSR said the status was 'False' while HA stated 'On'
rule-mkwk2fwa.dval:[{"id":1,"container":2,"value":3,"serial":92,"tss":93,"tsc":93},"rule-mkwk2fwa","rules",{"id":1,"serial":4,"triggers":5,"constraints":21,"expressions":24,"name":25,"react_set":26,"react_reset":88,"ruleset":91},16,{"type":6,"id":7,"op":8,"conditions":9,"editor_version":20},"group","trig","and",[10],{"id":11,"type":12,"data":13},"condmkwk2fwa","entity",{"entity":14,"attribute":15,"op":16,"value":17},"hass>person_rachel_matthews","x_hass.state","change",[18,19],null,"not_home",25351,{"type":6,"id":22,"op":8,"conditions":23},"cons",[],{},"Rachel is on the move",{"id":27,"actions":28,"rule":1,"editor_version":87,"set":61},"rule-mkwk2fwa:S",[29,35,62,83],{"id":30,"type":31,"data":32},"24kv27go","setvar",{"var":33,"value":34},"g_CurrentHour","${{int(strftime(\"%H\", time()))}}",{"id":36,"type":6,"actions":37,"constraints":46},"rule-mkwk2fwa:S-24kv7qgg",[38],{"id":39,"type":12,"data":40},"24kv4y1v",{"entity":41,"action":42,"args":43},"hass>system","x_hass_system.call_service",{"service":44,"data":45},"notify.alexa_media","{\n\"message\":\"Good ${{g_Greeting}} Chris. , Rachel has left the ${{g_rachel_last_area}} zone and is in transit \",\n\"data\":{\"type\":\"announce\", \"method\":\"speak\"},\n\"target\":[\"media_player.everywhere\"]\n}",{"id":47,"name":48,"type":6,"op":8,"conditions":49,"editor_version":20},"rule-mkwk2fwa:S-24kv7qgg-cons","Group Constraints Copy",[50,55],{"id":51,"type":52,"data":53},"cond24kv89zv","comment",{"comment":54},"Should speak only when I'm home",{"id":56,"type":12,"data":57},"cond24kv7qgh",{"entity":58,"attribute":59,"op":60,"value":61},"mqqt>catman_iphone","binary_sensor.state","=",true,{"id":63,"type":6,"actions":64,"constraints":72},"rule-mkwk2fwa:S-24kv2lon",[65],{"id":66,"type":67,"data":68},"28xz6paf","notify",{"method":69,"message":70,"profile":71},"Telegram","Rachel has left the ${{g_rachel_last_area}} zone and is in transit","default",{"id":73,"name":48,"type":6,"op":8,"conditions":74,"editor_version":20},"rule-mkwk2fwa:S-24kv2lon-cons",[75,79],{"id":76,"type":52,"data":77},"cond24kvlpae",{"comment":78},"Should telegram while I am away",{"id":80,"type":12,"data":81},"cond24kvkyz7",{"entity":58,"attribute":59,"op":60,"value":82},false,{"id":84,"type":52,"data":85},"24kv7hvk",{"comment":86},"Enter comment text",25314,{"id":89,"actions":90,"rule":1,"set":82},"rule-mkwk2fwa:R",[],"rs-l5sdq41x",2,1779017869959]
rule-mkwk2fwa.json:{"id":"rule-mkwk2fwa","container":"rules","value":{"id":"rule-mkwk2fwa","serial":16,"triggers":{"type":"group","id":"trig","op":"and","conditions":[{"id":"condmkwk2fwa","type":"entity","data":{"entity":"hass>person_rachel_matthews","attribute":"x_hass.state","op":"change","value":[null,"not_home"]}}],"editor_version":25351},"constraints":{"type":"group","id":"cons","op":"and","conditions":[]},"expressions":{},"name":"Rachel is on the move","react_set":{"id":"rule-mkwk2fwa:S","actions":[{"id":"24kv27go","type":"setvar","data":{"var":"g_CurrentHour","value":"${{int(strftime(\"%H\", time()))}}"}},{"id":"rule-mkwk2fwa:S-24kv7qgg","type":"group","actions":[{"id":"24kv4y1v","type":"entity","data":{"entity":"hass>system","action":"x_hass_system.call_service","args":{"service":"notify.alexa_media","data":"{\n\"message\":\"Good ${{g_Greeting}} Chris. , Rachel has left the ${{g_rachel_last_area}} zone and is in transit \",\n\"data\":{\"type\":\"announce\", \"method\":\"speak\"},\n\"target\":[\"media_player.everywhere\"]\n}"}}}],"constraints":{"id":"rule-mkwk2fwa:S-24kv7qgg-cons","name":"Group Constraints Copy","type":"group","op":"and","conditions":[{"id":"cond24kv89zv","type":"comment","data":{"comment":"Should speak only when I'm home"}},{"id":"cond24kv7qgh","type":"entity","data":{"entity":"mqqt>catman_iphone","attribute":"binary_sensor.state","op":"=","value":true}}],"editor_version":25351}},{"id":"rule-mkwk2fwa:S-24kv2lon","type":"group","actions":[{"id":"28xz6paf","type":"notify","data":{"method":"Telegram","message":"Rachel has left the ${{g_rachel_last_area}} zone and is in transit","profile":"default"}}],"constraints":{"id":"rule-mkwk2fwa:S-24kv2lon-cons","name":"Group Constraints Copy","type":"group","op":"and","conditions":[{"id":"cond24kvlpae","type":"comment","data":{"comment":"Should telegram while I am away"}},{"id":"cond24kvkyz7","type":"entity","data":{"entity":"mqqt>catman_iphone","attribute":"binary_sensor.state","op":"=","value":false}}],"editor_version":25351}},{"id":"24kv7hvk","type":"comment","data":{"comment":"Enter comment text"}}],"rule":"rule-mkwk2fwa","editor_version":25314,"set":true},"react_reset":{"id":"rule-mkwk2fwa:R","actions":[],"rule":"rule-mkwk2fwa","set":false},"ruleset":"rs-l5sdq41x"},"serial":2,"tss":1779017869959,"tsc":1779017869959}
rule-mkwlg11o.dval:[{"id":1,"container":2,"value":3,"serial":92,"tss":93,"tsc":93},"rule-mkwlg11o","rules",{"id":1,"serial":4,"triggers":5,"constraints":20,"expressions":23,"name":24,"react_set":25,"react_reset":88,"ruleset":91},5,{"type":6,"id":7,"op":8,"conditions":9,"editor_version":19},"group","trig","and",[10],{"id":11,"type":12,"data":13},"condmkwk2fwa","entity",{"entity":14,"attribute":15,"op":16,"value":17},"hass>person_rachel_matthews","x_hass.state","change",[18],"not_home",25351,{"type":6,"id":21,"op":8,"conditions":22},"cons",[],{},"Rachel has arrived",{"id":26,"actions":27,"rule":1,"editor_version":87,"set":65},"rule-mkwlg11o:S",[28,33,39,66,83],{"id":29,"type":30,"data":31},"24kvboht","script",{"expr":32},"g_rachel_last_area = getEntity(\"hass>person_rachel_matthews\").attributes['x_hass'].state",{"id":34,"type":35,"data":36},"24kvbohu","setvar",{"var":37,"value":38},"g_CurrentHour","${{int(strftime(\"%H\", time()))}}",{"id":40,"type":6,"actions":41,"constraints":50},"rule-mkwlg11o:S-rule-mkwlg11o-24kvbohv",[42],{"id":43,"type":12,"data":44},"24kvbohw",{"entity":45,"action":46,"args":47},"hass>system","x_hass_system.call_service",{"service":48,"data":49},"notify.alexa_media","{\n\"message\":\"Good ${{g_Greeting}} Chris. , Rachel has arrived in the ${{g_rachel_last_area}} zone.\",\n\"data\":{\"type\":\"announce\", \"method\":\"speak\"},\n\"target\":[\"media_player.everywhere\"]\n}",{"id":51,"name":52,"type":6,"op":8,"conditions":53,"editor_version":19},"24kvbohv-cons","Group Constraints Copy",[54,59],{"id":55,"type":56,"data":57},"cond24kv89zv","comment",{"comment":58},"Should speak only when I'm home",{"id":60,"type":12,"data":61},"cond24kv7qgh",{"entity":62,"attribute":63,"op":64,"value":65},"mqqt>catman_iphone","binary_sensor.state","=",true,{"id":67,"type":6,"actions":68,"constraints":76},"rule-mkwlg11o:S-rule-mkwlg11o-24kvbohx",[69],{"id":70,"type":71,"data":72},"24kvbohy","notify",{"method":73,"message":74,"profile":75},"Telegram","Rachel has arrived in the ${{g_rachel_last_area}} zone.","default",{"id":77,"name":52,"type":6,"op":8,"conditions":78,"editor_version":19},"24kvbohx-cons",[79],{"id":80,"type":12,"data":81},"cond24kvmzfp",{"entity":62,"attribute":63,"op":64,"value":82},false,{"id":84,"type":56,"data":85},"24kvbohz",{"comment":86},"Enter comment text",25314,{"id":89,"actions":90,"rule":1,"set":82},"rule-mkwlg11o:R",[],"rs-l5sdq41x",1,1770023368433]
rule-mkwlg11o.json:{"id":"rule-mkwlg11o","container":"rules","value":{"id":"rule-mkwlg11o","serial":5,"triggers":{"type":"group","id":"trig","op":"and","conditions":[{"id":"condmkwk2fwa","type":"entity","data":{"entity":"hass>person_rachel_matthews","attribute":"x_hass.state","op":"change","value":["not_home"]}}],"editor_version":25351},"constraints":{"type":"group","id":"cons","op":"and","conditions":[]},"expressions":{},"name":"Rachel has arrived","react_set":{"id":"rule-mkwlg11o:S","actions":[{"id":"24kvboht","type":"script","data":{"expr":"g_rachel_last_area = getEntity(\"hass>person_rachel_matthews\").attributes['x_hass'].state"}},{"id":"24kvbohu","type":"setvar","data":{"var":"g_CurrentHour","value":"${{int(strftime(\"%H\", time()))}}"}},{"id":"rule-mkwlg11o:S-rule-mkwlg11o-24kvbohv","type":"group","actions":[{"id":"24kvbohw","type":"entity","data":{"entity":"hass>system","action":"x_hass_system.call_service","args":{"service":"notify.alexa_media","data":"{\n\"message\":\"Good ${{g_Greeting}} Chris. , Rachel has arrived in the ${{g_rachel_last_area}} zone.\",\n\"data\":{\"type\":\"announce\", \"method\":\"speak\"},\n\"target\":[\"media_player.everywhere\"]\n}"}}}],"constraints":{"id":"24kvbohv-cons","name":"Group Constraints Copy","type":"group","op":"and","conditions":[{"id":"cond24kv89zv","type":"comment","data":{"comment":"Should speak only when I'm home"}},{"id":"cond24kv7qgh","type":"entity","data":{"entity":"mqqt>catman_iphone","attribute":"binary_sensor.state","op":"=","value":true}}],"editor_version":25351}},{"id":"rule-mkwlg11o:S-rule-mkwlg11o-24kvbohx","type":"group","actions":[{"id":"24kvbohy","type":"notify","data":{"method":"Telegram","message":"Rachel has arrived in the ${{g_rachel_last_area}} zone.","profile":"default"}}],"constraints":{"id":"24kvbohx-cons","name":"Group Constraints Copy","type":"group","op":"and","conditions":[{"id":"cond24kvmzfp","type":"entity","data":{"entity":"mqqt>catman_iphone","attribute":"binary_sensor.state","op":"=","value":false}}],"editor_version":25351}},{"id":"24kvbohz","type":"comment","data":{"comment":"Enter comment text"}}],"rule":"rule-mkwlg11o","editor_version":25314,"set":true},"react_reset":{"id":"rule-mkwlg11o:R","actions":[],"rule":"rule-mkwlg11o","set":false},"ruleset":"rs-l5sdq41x"},"serial":1,"tss":1770023368433,"tsc":1770023368433}
catman@openluup:~/reactor/storage/rules$ exit
logout
Connection to 192.168.70.249 closed.
catman@ChrisMBP2021 ~ % ./NotVera
** WARNING: connection is not using a post-quantum key exchange algorithm.
** This session may be vulnerable to "store now, decrypt later" attacks.
** The server may need to be upgraded. See https://openssh.com/pq.html
Linux openluup 4.19.0-20-amd64 #1 SMP Debian 4.19.235-1 (2022-03-17) x86_64
The programs included with the Debian GNU/Linux system are free software;
the exact distribution terms for each program are described in the
individual files in /usr/share/doc/*/copyright.
Debian GNU/Linux comes with ABSOLUTELY NO WARRANTY, to the extent
permitted by applicable law.
Last login: Mon May 18 12:13:38 2026 from 192.168.70.69
cdcatman@openluup:~$ cd reactor/lo
locales/ logs/
catman@openluup:~$ cd reactor/logs/
catman@openluup:~/reactor/logs$ ls
console.log hass_config.json hass_services-2025-11-1.json hass_services-2026-1-0.json hass_services-2026-5-2.json reactor.log reactor.log.4 vera-user_data-initial.json
device_32 hass_device_registry.json hass_services-2025-11-2.json hass_services-2026-1-1.json hass_services.json reactor.log.1 reactor.log.5
e hass_entity_registry.json hass_services-2025-11-3.json hass_services-2026-4-2.json hass_sources.json reactor.log.2 unhandled.json
hass_area_registry.json hass_integrations.json hass_services-2025-7-2.json hass_services-2026-4-4.json hass_states.json reactor.log.3 vera-status-initial.json
catman@openluup:~/reactor/logs$ less reactor.log
catman@openluup:~/reactor/logs$ tail reactor.log
[latest-26130]2026-05-19T12:20:08.296Z <httpapi:INFO> httpapi#1 API request from ::ffff:192.168.70.249: GET /api/v1/netstatus
[latest-26130]2026-05-19T12:21:03.391Z <httpapi:INFO> httpapi#1 API request from ::ffff:192.168.70.249: GET /api/v1/netstatus
[latest-26130]2026-05-19T12:21:08.729Z <Rule:INFO> Rule#rule-mova0cpn re-evaluating local variable L_Cinema_Light_Level for dependency notification from ValueSensor#hass>sensor_cinema_multi_sensor_illuminance
[latest-26130]2026-05-19T12:21:08.734Z <Rule:INFO> Rule#rule-mova0cpn requesting eval for changed dependent locals Array(1) ["L_Cinema_Light_Level"]
[latest-26130]2026-05-19T12:22:03.501Z <httpapi:INFO> httpapi#1 API request from ::ffff:192.168.70.249: GET /api/v1/netstatus
[latest-26130]2026-05-19T12:22:08.614Z <Rule:INFO> Rule#rule-mova0cpn re-evaluating local variable L_Cinema_Light_Level for dependency notification from ValueSensor#hass>sensor_cinema_multi_sensor_illuminance
[latest-26130]2026-05-19T12:22:08.624Z <Rule:INFO> Rule#rule-mova0cpn requesting eval for changed dependent locals Array(1) ["L_Cinema_Light_Level"]
[latest-26130]2026-05-19T12:23:03.590Z <httpapi:INFO> httpapi#1 API request from ::ffff:192.168.70.249: GET /api/v1/netstatus
[latest-26130]2026-05-19T12:23:08.503Z <Rule:INFO> Rule#rule-mova0cpn re-evaluating local variable L_Cinema_Light_Level for dependency notification from ValueSensor#hass>sensor_cinema_multi_sensor_illuminance
[latest-26130]2026-05-19T12:23:08.506Z <Rule:INFO> Rule#rule-mova0cpn requesting eval for changed dependent locals Array(1) ["L_Cinema_Light_Level"]
catman@openluup:~/reactor/logs$ less reactor.log
[latest-26130]2026-05-19T12:07:17.946Z <Rule:INFO> Cyrus Stream Vol+ (rule-ml9yjy9z in Living Room) starting rule state evaluation; because predicate-state-changed Predicate#rule-ml9yjy9z/trig
[latest-26130]2026-05-19T12:07:17.947Z <Rule:INFO> Cyrus Stream Vol+ (rule-ml9yjy9z in Living Room) evaluated; rule state transition from RESET to 'SET'
[latest-26130]2026-05-19T12:07:17.961Z <Rule:INFO> Cyrus Stream Vol- (rule-ml9ylxw3 in Living Room) starting rule state evaluation; because predicate-state-changed Predicate#rule-ml9ylxw3/trig
[latest-26130]2026-05-19T12:07:17.962Z <Rule:INFO> Cyrus Stream Vol- (rule-ml9ylxw3 in Living Room) evaluated; rule state transition from RESET to 'SET'
[latest-26130]2026-05-19T12:07:17.995Z <Engine:INFO> Enqueueing "Heating Control Mode is Home<RESET>" (rule-l680lif2:R)
[latest-26130]2026-05-19T12:07:17.996Z <Engine:INFO> Enqueueing "House Mode is Home<RESET>" (rule-l5sdqazh:R)
[latest-26130]2026-05-19T12:07:17.997Z <Engine:INFO> Enqueueing "Cyrus Stream Play / Pause<SET>" (rule-ml9y0xqo:S)
[latest-26130]2026-05-19T12:07:17.997Z <Engine:INFO> Enqueueing "Cyrus Stream Vol+<SET>" (rule-ml9yjy9z:S)
[latest-26130]2026-05-19T12:07:17.998Z <Engine:INFO> Enqueueing "Cyrus Stream Vol-<SET>" (rule-ml9ylxw3:S)
[latest-26130]2026-05-19T12:07:18.000Z <Engine:NOTICE> Starting reaction Heating Control Mode is Home<RESET> (rule-l680lif2:R)
[latest-26130]2026-05-19T12:07:18.000Z <Engine:INFO> Engine#1 perform power_switch.off on Entity#hass>input_boolean_heating_mode with { } by reaction Heating Control Mode is Home<RESET> (rule-l680lif2:R) step 1
[latest-26130]2026-05-19T12:07:18.000Z <HassController:INFO> HassController#hass perform power_switch.off on Entity#hass>input_boolean_heating_mode with { }
[latest-26130]2026-05-19T12:07:18.001Z <HassController:INFO> HassController#hass service homeassistant.turn_off target data is { } (empty), assuming default entity target
[latest-26130]2026-05-19T12:07:18.001Z <HassController:INFO> HassController#hass: sending payload for power_switch.off on Entity#hass>input_boolean_heating_mode action: { "type": "call_service", "service_data": { }, "domain": "homeassistant", "service": "turn_off", "target": { "entity_id": "input_boolean.heating_mode" } }
[latest-26130]2026-05-19T12:07:18.017Z <Engine:NOTICE> Starting reaction House Mode is Home<RESET> (rule-l5sdqazh:R)
[latest-26130]2026-05-19T12:07:18.018Z <Engine:INFO> House Mode is Home<RESET> all actions completed.
[latest-26130]2026-05-19T12:07:18.074Z <Engine:NOTICE> Starting reaction Cyrus Stream Play / Pause<SET> (rule-ml9y0xqo:S)
[latest-26130]2026-05-19T12:07:18.076Z <Engine:INFO> Engine#1 perform x_hass.call_service on Entity#hass>text_living_room_remote_ir_code_to_send with { "service": "text.set_value", "data": "{ \"value\": \"BfcG9wZ8A+ABAeABDRP3BvcGfAN8A/cG9wb///cG9wZ8A+ABAeABDRP3BvcGfAN8A/cG9wb///cG9wZ8A+ABAeABDQv3BvcGfAN8A/cG9wY=\" }" } by reaction Cyrus Stream Play / Pause<SET> (rule-ml9y0xqo:S) step 1
[latest-26130]2026-05-19T12:07:18.076Z <HassController:INFO> HassController#hass perform x_hass.call_service on Entity#hass>text_living_room_remote_ir_code_to_send with { "service": "text.set_value", "data": "{ \"value\": \"BfcG9wZ8A+ABAeABDRP3BvcGfAN8A/cG9wb///cG9wZ8A+ABAeABDRP3BvcGfAN8A/cG9wb///cG9wZ8A+ABAeABDQv3BvcGfAN8A/cG9wY=\" }" }
[latest-26130]2026-05-19T12:07:18.077Z <HassController:INFO> HassController#hass: sending payload for x_hass.call_service on Entity#hass>text_living_room_remote_ir_code_to_send action: { "type": "call_service", "service_data": { "value": "BfcG9wZ8A+ABAeABDRP3BvcGfAN8A/cG9wb///cG9wZ8A+ABAeABDRP3BvcGfAN8A/cG9wb///cG9wZ8A+ABAeABDQv3BvcGfAN8A/cG9wY=" }, "domain": "text", "service": "set_value", "target": { "entity_id": "text.living_room_remote_ir_code_to_send" } }
[latest-26130]2026-05-19T12:07:18.090Z <Engine:NOTICE> Starting reaction Cyrus Stream Vol+<SET> (rule-ml9yjy9z:S)
[latest-26130]2026-05-19T12:07:18.091Z <Engine:INFO> Engine#1 perform x_hass.call_service on Entity#hass>text_living_room_remote_ir_code_to_send with { "service": "text.set_value", "data": "{ \"value\": \"BXsDewP3BkABAXsD4AUBBfcG9wZ7A+ABAQf//3sDewP3BkABAXsD4AUBBfcG9wZ7A+ABAQf//3sDewP3BkABAXsD4AUBD/cG9wZ7A3sDewN7A3sDewM=\" }" } by reaction Cyrus Stream Vol+<SET> (rule-ml9yjy9z:S) step 1
[latest-26130]2026-05-19T12:07:18.092Z <HassController:INFO> HassController#hass perform x_hass.call_service on Entity#hass>text_living_room_remote_ir_code_to_send with { "service": "text.set_value", "data": "{ \"value\": \"BXsDewP3BkABAXsD4AUBBfcG9wZ7A+ABAQf//3sDewP3BkABAXsD4AUBBfcG9wZ7A+ABAQf//3sDewP3BkABAXsD4AUBD/cG9wZ7A3sDewN7A3sDewM=\" }" }
[latest-26130]2026-05-19T12:07:18.092Z <HassController:INFO> HassController#hass: sending payload for x_hass.call_service on Entity#hass>text_living_room_remote_ir_code_to_send action: { "type": "call_service", "service_data": { "value": "BXsDewP3BkABAXsD4AUBBfcG9wZ7A+ABAQf//3sDewP3BkABAXsD4AUBBfcG9wZ7A+ABAQf//3sDewP3BkABAXsD4AUBD/cG9wZ7A3sDewN7A3sDewM=" }, "domain": "text", "service": "set_value", "target": { "entity_id": "text.living_room_remote_ir_code_to_send" } }
[latest-26130]2026-05-19T12:07:18.093Z <Engine:NOTICE> Starting reaction Cyrus Stream Vol-<SET> (rule-ml9ylxw3:S)
[latest-26130]2026-05-19T12:07:18.093Z <Engine:INFO> Engine#1 perform x_hass.call_service on Entity#hass>text_living_room_remote_ir_code_to_send with { "service": "text.set_value", "data": "{ \"value\": \"AXoD4AEBA/EGegPgBQEF8QbxBnoDgAFACQP//3oD4AEBQBHgBQEP8QbxBnoDegN6A3oD8QZ6Aw==\" }" } by reaction Cyrus Stream Vol-<SET> (rule-ml9ylxw3:S) step 1
[latest-26130]2026-05-19T12:07:18.094Z <HassController:INFO> HassController#hass perform x_hass.call_service on Entity#hass>text_living_room_remote_ir_code_to_send with { "service": "text.set_value", "data": "{ \"value\": \"AXoD4AEBA/EGegPgBQEF8QbxBnoDgAFACQP//3oD4AEBQBHgBQEP8QbxBnoDegN6A3oD8QZ6Aw==\" }" }
[latest-26130]2026-05-19T12:07:18.111Z <HassController:INFO> HassController#hass: sending payload for x_hass.call_service on Entity#hass>text_living_room_remote_ir_code_to_send action: { "type": "call_service", "service_data": { "value": "AXoD4AEBA/EGegPgBQEF8QbxBnoDgAFACQP//3oD4AEBQBHgBQEP8QbxBnoDegN6A3oD8QZ6Aw==" }, "domain": "text", "service": "set_value", "target": { "entity_id": "text.living_room_remote_ir_code_to_send" } }
[latest-26130]2026-05-19T12:07:18.113Z <Rule:INFO> Rule#rule-l5sdqazh reaction rule-l5sdqazh:R completed
This is hardly the end of the world as HA restarting is rare and I simply hit refresh on the entity in MSR but is this some kind of race condition or something that needs addressing?
Hoping I've given enough data to make it sensible
C
I have a couple of rules that has group reactions with empty conditions. I notice, in particular on one that's called every 5 secs, that it was not working. I added an empty comment as condition and it started working again.
I don't know if saving was enough to "reset" it, but I'm reporting anyway. No errors in the logs, but the MQTT message was not published, so I had an easy path to check the rule.
I have others like these, but not easy to test. @toggledbits maybe some stuck status data? (I restarted a couple of times after the last update). Thanks.
TL;DR: Format of data in storage directory will soon change. Make sure you are backing up the contents of that directory in its entirety, and you preserve your backups for an extended period, particularly the backup you take right before upgrading to the build containing this change (date of that is still to be determined, but soon). The old data format will remain readable (so you'll be able to read your pre-change backups) for the foreseeable future.
In support of a number of other changes in the works, I have found it necessary to change the storage format for Reactor objects in storage at the physical level.
Until now, plain, standard JSON has been used to store the data (everything under the storage directory). This has served well, but has a few limitations, including no real support for native JavaScript objects like Date, Map, Set, and others. It also is unable to store data that contains "loops" — objects that reference themselves in some way.
I'm not sure exactly when, but in the not-too-distant future I will publish a build using the new data format. It will automatically convert existing JSON data to the new format. For the moment, it will save data in both the new format and the old JSON format, preferring the former when loading data from storage. I have been running my own home with this new format for several months, and have no issues with data loss or corruption.
A few other things to know:
If you are not already backing up your storage directory, you should be. At a minimum, back this directory up every time you make big changes to your Rules, Reactions, etc.
Your existing JSON-format backups will continue to be readable for the long-term (years). The code that loads data from these files looks for the new file format first (which will have a .dval suffix), and if not found, will happily read (and convert) a same-basenamed .json file (i.e. it looks for ruleid.dval first, and if it doesn't find it, it tries to load ruleid.json). I'll publish detailed instructions for restoring from old backups when the build is posted (it's easy).
The new .dval files are not directly human-readable or editable as easily as the old .json files. A new utility will be provided in the tools directory to convert .dval data to .json format, which you can then read or edit if you find that necessary. However, that may not work for all future data, as my intent is to make more native JavaScript objects directly storable, and many of those objects cannot be stored in JSON.
You may need to modify your backup tools/scripts to pick up the new files: if you explicitly name .json files (rather than just specifying the entire storage directory) in your backup configuration, you will need to add .dval files to get a complete, accurate backup. I don't think this will be an issue for any of you; I imagine that you're all just backing up the entire contents of storage regardless of format/name, that is the safest (and IMO most correct) way to go (if that's not what you're doing, consider changing your approach).
The current code stores the data in both the .dval form and the .json form to hedge against any real-world problems I don't encounter in my own use. Some future build will drop this redundancy (i.e. save only to .dval form). However, the read code for the .json form will remain in any case.
This applies only to persistent storage that Reactor creates and controls under the storage tree. All other JSON data files (e.g. device data for Controllers) are unaffected by this change and will remain in that form. YAML files are also unaffected by this change.
This thread is open for any questions or concerns.
Hi,
I'm on Docker/NAs (latest-26011-c621bbc7) with Zwave js ui (last version).
I have set the 'Location' for each device in the Z-Wave JS UI dashboard, I cannot find this information among the Entity Attributes in the Reactor. I tried and the result is an empty array []. It seems the 'Location' metadata from Z-Wave JS is not being mapped to a standard attribute in Reactor. Location is equale to Rooms for me. When comparing this to the Vera or Ezlo Controller, Reactor automatically creates Room Icons also in the Reactor Dashboard and places the various devices under those room categories.
This is a very convenient way to keep the dashboard organized and quickly find lights to turn off with a click (especially when something isn't switched off as expected for me:) ).
Is there a way to map the Z-Wave JS UI 'Location' attribute and a dashboard organization, just like it does with Vera/Ezlo?
Thanks in advance for all the great tips you've shared
I use Virtual Entity Controller virtual switches which I turn on via webhooks from other applications. Once a switch triggers and turns on, I can then activate associated rules.
I would like each virtual switch to automatically turn off after a configurable time (e.g., 5 seconds, 10 seconds).
Is there a better way to achieve this auto-off behavior instead of creating a separate rule for each switch that uses the 'Condition must be sustained for' option to turn it off?
With a large number of these switches (and the associated turn-off rules), I'm checking to see if there is a simpler approach.If not, could this be a feature request to add an auto-off timer directly to the virtual switches.
Thanks
Reactor (Multi-hub) latest-26011-c621bbc7
VirtualEntityController v25356
Synology Docker
I've had similar problems before, but now this issue has resurfaced. Using build 26011 on Docker.
As I copied one old rule as a "template" for a similar new rule, where I have multiple conditions using changes operator (from any to any, and with delay reset of 900), these conditions do not detect change in attributes. Even if I manually reset the rule, reset delay timers do not restart.
If I do a new rule from scratch, and do not copy/import anything old, the same conditions work properly. Also, if I modify copied rule's conditions (put a random number to "from" & "to" fields), then save, and after that remove those modifications, rule begins to function normally. Just editing e.g. delay reset value does not do any good in this context.
@toggledbits, I can DM logs & related rule files to you, if you just send me instructions.
Constraints (no data) rule actions have never run
-
Hi
I have a problem rule it seems. Its set to turn off my Festoon lights at 23:55pm and in the constraints checks if those lights are already turned on ?
And the reaction is to turn them off.
Since I setup the rule my lights have never turned off.
In the summary card I can see (no data)
On this screen shot it says the power switch state is TRUE.
The switch is actually OFF at the moment, I have hard refreshed the browser but it still says True.
I can go to Scope and add a trace on this device and it does track if its turned on or off OK.
The device is one side of a Fibaro Dual Relay module.
Any clues?
Thanks
-
Changes to devices or other dependencies in the Constraints do not cause evaluation of the rule's conditions (triggers or constraints). Only Triggers do that. You would have to wait until after 23:55, which is the only trigger, for the Constraints to be evaluated.
Author of Multi-system Reactor and Reactor, DelayLight, Switchboard, and about a dozen other plugins that run on Vera and openLuup.
-
Changes to devices or other dependencies in the Constraints do not cause evaluation of the rule's conditions (triggers or constraints). Only Triggers do that. You would have to wait until after 23:55, which is the only trigger, for the Constraints to be evaluated.
@toggledbits OK think that makes sense.
Not sure why my rules action is not running then.
This is the trigger
I have pressed the Play button in the Set Reaction area and it does actually turn off the light OK.
I've had this rule setup for maybe 3 days and my Festoon lights have never turned off and have been left on all night.
-
Have you looked in the log at around the time the rule would be expected to trigger? There may be something logged. Remember to adjust for time zone if your host's configured time zone is different from your browser/desktop (i.e. it's not unusual to have a Pi, for example, default to UTC, so all times logged will be UTC and thus maybe different from your local time).
-
I have other Schedules in MSR for certain times in the morning to open window coverings they are now all working fine and open on the time I set in their triggers.
If I use the command "date" on the Pi in putty it does say the correct time as of now:
Fri 26 Feb 13:15:22 GMT 2021
I'll have a look in the Reactor logs
Thanks
-
Looking in reactor.log I searched this rules ID code kljc5802:
2021-02-25T19:00:05.003Z <Engine:INFO> Engine#1 master timer tick, local time "2/25/2021, 19:00:05" (TZ offset 0 mins from UTC) false false2021-02-25T19:34:00.006Z <Rule:5:Rule.js:635> Rule#rule-kljc5802 launching eval from timer-trigger notification by Timer#cond57lqecd false false2021-02-25T19:34:00.009Z <Rule:5:Rule.js:697> Rule#rule-kljc5802 (Schedule - Festoon Lights OFF) evaluate() acquiring mutex false false2021-02-25T19:34:00.012Z <Rule:5:Rule.js:635> Rule#rule-kljbrk9g launching eval from timer-trigger notification by Timer#cond57lqecd false false2021-02-25T19:34:00.014Z <Rule:5:Rule.js:697> Rule#rule-kljbrk9g (Schedule - Lawn Lights OFF) evaluate() acquiring mutex false false2021-02-25T19:34:00.017Z <Rule:5:Rule.js:700> Rule#rule-kljc5802.evaluate() mutex acquired, evaluating false false2021-02-25T19:34:00.021Z <Rule:5:Rule.js:704> Rule#rule-kljc5802 update rate is 0/min limit 60/min false false2021-02-25T19:34:00.023Z <Rule:5:Rule.js:654> Rule#rule-kljc5802 evaluateExpressions() with 0 expressions false false2021-02-25T19:34:00.025Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd trange after sdt=2/25/2021, 23:55:00 edt=2/25/2021, 19:34:00 now=2/25/2021, 19:34:00 false false2021-02-25T19:34:00.028Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd timer now scheduled for 2/25/2021, 23:55:00, 15659 secs from now false false2021-02-25T19:34:00.030Z <Rule:5:Rule.js:714> Rule#rule-kljc5802.evaluate() trigger state false (was false) false false2021-02-25T20:13:27.338Z <Engine:5:Engine.js:550> Engine#1 (re-)starting rule Rule#rule-kljc5802 (Schedule - Festoon Lights OFF) 2021-02-25T20:13:27.340Z <Rule:5:Rule.js:555> Rule#rule-kljc5802 start(), awaiting mutex2021-02-25T20:13:27.513Z <Rule:5:Rule.js:563> Rule#rule-kljc5802 restored states: trig=false, rule=false 2021-02-25T20:13:27.515Z <Rule:5:Rule.js:563> Rule#rule-kljc5802 subscribing to dependencies 2021-02-25T20:13:27.517Z <Rule:INFO> Rule#rule-kljc5802 (Schedule - Festoon Lights OFF) started2021-02-25T20:13:27.761Z <Rule:5:Rule.js:700> Rule#rule-kljc5802.evaluate() mutex acquired, evaluating 2021-02-25T20:13:27.762Z <Rule:5:Rule.js:704> Rule#rule-kljc5802 update rate is 0/min limit 60/min 2021-02-25T20:13:27.765Z <Rule:5:Rule.js:654> Rule#rule-kljc5802 evaluateExpressions() with 0 expressions 2021-02-25T20:13:27.767Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd trange after sdt=2/25/2021, 23:55:00 edt=2/25/2021, 20:13:00 now=2/25/2021, 20:13:27 2021-02-25T20:13:27.771Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd timer now scheduled for 2/25/2021, 23:55:00, 13292 secs from now 2021-02-25T20:13:27.774Z <Rule:5:Rule.js:714> Rule#rule-kljc5802.evaluate() trigger state false (was false)2021-02-26T00:00:00.129Z <Rule:5:Rule.js:635> Rule#rule-kljc5802 launching eval from timer-trigger notification by Timer#cond57lqecd 2021-02-26T00:00:00.131Z <Rule:5:Rule.js:697> Rule#rule-kljc5802 (Schedule - Festoon Lights OFF) evaluate() acquiring mutex 2021-02-26T00:00:00.136Z <Rule:5:Rule.js:635> Rule#rule-kljbrk9g launching eval from timer-trigger notification by Timer#cond57lqecd 2021-02-26T00:00:00.139Z <Rule:5:Rule.js:697> Rule#rule-kljbrk9g (Schedule - Lawn Lights OFF) evaluate() acquiring mutex 2021-02-26T00:00:00.141Z <Rule:5:Rule.js:700> Rule#rule-kljc5802.evaluate() mutex acquired, evaluating 2021-02-26T00:00:00.145Z <Rule:5:Rule.js:704> Rule#rule-kljc5802 update rate is 0/min limit 60/min 2021-02-26T00:00:00.147Z <Rule:5:Rule.js:654> Rule#rule-kljc5802 evaluateExpressions() with 0 expressions 2021-02-26T00:00:00.150Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd trange after sdt=2/26/2021, 23:55:00 edt=2/26/2021, 00:00:00 now=2/26/2021, 00:00:00 2021-02-26T00:00:00.152Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd timer now scheduled for 2/26/2021, 23:55:00, 86099 secs from now 2021-02-26T00:00:00.154Z <Rule:5:Rule.js:714> Rule#rule-kljc5802.evaluate() trigger state false (was false)2021-02-26T11:02:14.128Z <Rule:NOTICE> Rule#rule-kljc5802 configuration changed; reloading 2021-02-26T11:02:14.147Z <Rule:5:Rule.js:600> Rule#rule-kljc5802 reloading with new data 2021-02-26T11:02:14.150Z <Rule:NOTICE> Rule#rule-kljc5802 stopping rule 2021-02-26T11:02:14.152Z <Rule:5:Rule.js:581> Rule#rule-kljc5802 acquiring mutex 2021-02-26T11:02:14.157Z <Rule:5:Rule.js:584> Rule#rule-kljc5802 mutex acquired; unsubscribing from condition dependencies 2021-02-26T11:02:14.169Z <Rule:5:Rule.js:586> Rule#rule-kljc5802 saving states 2021-02-26T11:02:14.176Z <Rule:5:Rule.js:590> Rule#rule-kljc5802 stopped 2021-02-26T11:02:14.178Z <Rule:NOTICE> Rule Rule#rule-kljc5802 stopped 2021-02-26T11:02:14.180Z <Rule:5:Rule.js:555> Rule#rule-kljc5802 start(), awaiting mutex 2021-02-26T11:02:14.183Z <Rule:5:Rule.js:563> Rule#rule-kljc5802 restored states: trig=false, rule=false 2021-02-26T11:02:14.185Z <Rule:5:Rule.js:563> Rule#rule-kljc5802 subscribing to dependencies 2021-02-26T11:02:14.378Z <Rule:INFO> Rule#rule-kljc5802 (Schedule - Festoon Lights OFF) started 2021-02-26T11:02:14.381Z <Rule:5:Rule.js:567> Rule#rule-kljc5802 start() dependencies resolved, performing initial evaluation 2021-02-26T11:02:14.509Z <Rule:5:Rule.js:697> Rule#rule-kljc5802 (Schedule - Festoon Lights OFF) evaluate() acquiring mutex 2021-02-26T11:02:14.511Z <Rule:5:Rule.js:700> Rule#rule-kljc5802.evaluate() mutex acquired, evaluating 2021-02-26T11:02:14.518Z <Rule:5:Rule.js:704> Rule#rule-kljc5802 update rate is 0/min limit 60/min 2021-02-26T11:02:14.520Z <Rule:5:Rule.js:654> Rule#rule-kljc5802 evaluateExpressions() with 0 expressions 2021-02-26T11:02:14.523Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd trange after sdt=2/26/2021, 23:55:00 edt=2/26/2021, 11:02:00 now=2/26/2021, 11:02:14 2021-02-26T11:02:14.527Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd timer now scheduled for 2/26/2021, 23:55:00, 46365 secs from now 2021-02-26T11:02:14.529Z <Rule:5:Rule.js:714> Rule#rule-kljc5802.evaluate() trigger state false (was false) 2021-02-26T11:02:52.786Z <Rule:NOTICE> Rule#rule-kljc5802 configuration changed; reloading 2021-02-26T11:02:52.792Z <Rule:5:Rule.js:600> Rule#rule-kljc5802 reloading with new data 2021-02-26T11:02:52.794Z <Rule:NOTICE> Rule#rule-kljc5802 stopping rule 2021-02-26T11:02:52.797Z <Rule:5:Rule.js:581> Rule#rule-kljc5802 acquiring mutex 2021-02-26T11:02:52.803Z <Rule:5:Rule.js:584> Rule#rule-kljc5802 mutex acquired; unsubscribing from condition dependencies 2021-02-26T11:02:52.816Z <Rule:5:Rule.js:586> Rule#rule-kljc5802 saving states 2021-02-26T11:02:52.823Z <Rule:5:Rule.js:590> Rule#rule-kljc5802 stopped 2021-02-26T11:02:52.824Z <Rule:NOTICE> Rule Rule#rule-kljc5802 stopped 2021-02-26T11:02:52.828Z <Rule:5:Rule.js:555> Rule#rule-kljc5802 start(), awaiting mutex 2021-02-26T11:02:52.831Z <Rule:5:Rule.js:563> Rule#rule-kljc5802 restored states: trig=false, rule=false 2021-02-26T11:02:52.833Z <Rule:5:Rule.js:563> Rule#rule-kljc5802 subscribing to dependencies 2021-02-26T11:02:52.835Z <Rule:INFO> Rule#rule-kljc5802 (Schedule - Festoon Lights OFF) started 2021-02-26T11:02:52.838Z <Rule:5:Rule.js:567> Rule#rule-kljc5802 start() dependencies resolved, performing initial evaluation 2021-02-26T11:02:52.840Z <Rule:5:Rule.js:697> Rule#rule-kljc5802 (Schedule - Festoon Lights OFF) evaluate() acquiring mutex 2021-02-26T11:02:52.844Z <Rule:5:Rule.js:700> Rule#rule-kljc5802.evaluate() mutex acquired, evaluating 2021-02-26T11:02:52.846Z <Rule:5:Rule.js:704> Rule#rule-kljc5802 update rate is 1/min limit 60/min 2021-02-26T11:02:52.848Z <Rule:5:Rule.js:654> Rule#rule-kljc5802 evaluateExpressions() with 0 expressions 2021-02-26T11:02:52.850Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd trange after sdt=2/26/2021, 23:55:00 edt=2/26/2021, 11:02:00 now=2/26/2021, 11:02:52 2021-02-26T11:02:52.852Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd timer now scheduled for 2/26/2021, 23:55:00, 46327 secs from now 2021-02-26T11:02:52.854Z <Rule:5:Rule.js:714> Rule#rule-kljc5802.evaluate() trigger state false (was false) 2021-02-26T11:03:25.898Z <Rule:NOTICE> Rule#rule-kljc5802 configuration changed; reloading 2021-02-26T11:03:25.904Z <Rule:5:Rule.js:600> Rule#rule-kljc5802 reloading with new data 2021-02-26T11:03:25.905Z <Rule:NOTICE> Rule#rule-kljc5802 stopping rule 2021-02-26T11:03:25.908Z <Rule:5:Rule.js:581> Rule#rule-kljc5802 acquiring mutex 2021-02-26T11:03:25.913Z <Rule:5:Rule.js:584> Rule#rule-kljc5802 mutex acquired; unsubscribing from condition dependencies 2021-02-26T11:03:25.922Z <Rule:5:Rule.js:586> Rule#rule-kljc5802 saving states 2021-02-26T11:03:25.929Z <Rule:5:Rule.js:590> Rule#rule-kljc5802 stopped 2021-02-26T11:03:25.930Z <Rule:NOTICE> Rule Rule#rule-kljc5802 stopped 2021-02-26T11:03:25.933Z <Rule:5:Rule.js:555> Rule#rule-kljc5802 start(), awaiting mutex 2021-02-26T11:03:25.935Z <Rule:5:Rule.js:563> Rule#rule-kljc5802 restored states: trig=false, rule=false 2021-02-26T11:03:25.937Z <Rule:5:Rule.js:563> Rule#rule-kljc5802 subscribing to dependencies 2021-02-26T11:03:25.938Z <Rule:INFO> Rule#rule-kljc5802 (Schedule - Festoon Lights OFF) started 2021-02-26T11:03:25.940Z <Rule:5:Rule.js:567> Rule#rule-kljc5802 start() dependencies resolved, performing initial evaluation 2021-02-26T11:03:25.942Z <Rule:5:Rule.js:697> Rule#rule-kljc5802 (Schedule - Festoon Lights OFF) evaluate() acquiring mutex 2021-02-26T11:03:25.944Z <Rule:5:Rule.js:700> Rule#rule-kljc5802.evaluate() mutex acquired, evaluating 2021-02-26T11:03:25.945Z <Rule:5:Rule.js:704> Rule#rule-kljc5802 update rate is 1/min limit 60/min 2021-02-26T11:03:25.948Z <Rule:5:Rule.js:654> Rule#rule-kljc5802 evaluateExpressions() with 0 expressions 2021-02-26T11:03:25.950Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd trange after sdt=2/26/2021, 23:55:00 edt=2/26/2021, 11:03:00 now=2/26/2021, 11:03:25 2021-02-26T11:03:25.952Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd timer now scheduled for 2/26/2021, 23:55:00, 46294 secs from now 2021-02-26T11:03:25.954Z <Rule:5:Rule.js:714> Rule#rule-kljc5802.evaluate() trigger state false (was false) 2021-02-26T11:03:52.673Z <Rule:NOTICE> Rule#rule-kljc5802 configuration changed; reloading 2021-02-26T11:03:52.677Z <Rule:5:Rule.js:600> Rule#rule-kljc5802 reloading with new data 2021-02-26T11:03:52.693Z <Rule:NOTICE> Rule#rule-kljc5802 stopping rule 2021-02-26T11:03:52.695Z <Rule:5:Rule.js:581> Rule#rule-kljc5802 acquiring mutex 2021-02-26T11:03:52.701Z <Rule:5:Rule.js:584> Rule#rule-kljc5802 mutex acquired; unsubscribing from condition dependencies 2021-02-26T11:03:52.721Z <Rule:5:Rule.js:586> Rule#rule-kljc5802 saving states 2021-02-26T11:03:52.729Z <Rule:5:Rule.js:590> Rule#rule-kljc5802 stopped 2021-02-26T11:03:52.731Z <Rule:NOTICE> Rule Rule#rule-kljc5802 stopped 2021-02-26T11:03:52.733Z <Rule:5:Rule.js:555> Rule#rule-kljc5802 start(), awaiting mutex 2021-02-26T11:03:52.736Z <Rule:5:Rule.js:563> Rule#rule-kljc5802 restored states: trig=false, rule=false 2021-02-26T11:03:52.738Z <Rule:5:Rule.js:563> Rule#rule-kljc5802 subscribing to dependencies 2021-02-26T11:03:52.740Z <Rule:INFO> Rule#rule-kljc5802 (Schedule - Festoon Lights OFF) started 2021-02-26T11:03:52.742Z <Rule:5:Rule.js:567> Rule#rule-kljc5802 start() dependencies resolved, performing initial evaluation 2021-02-26T11:03:52.744Z <Rule:5:Rule.js:697> Rule#rule-kljc5802 (Schedule - Festoon Lights OFF) evaluate() acquiring mutex 2021-02-26T11:03:52.747Z <Rule:5:Rule.js:700> Rule#rule-kljc5802.evaluate() mutex acquired, evaluating 2021-02-26T11:03:52.749Z <Rule:5:Rule.js:704> Rule#rule-kljc5802 update rate is 1/min limit 60/min 2021-02-26T11:03:52.754Z <Rule:5:Rule.js:654> Rule#rule-kljc5802 evaluateExpressions() with 0 expressions 2021-02-26T11:03:52.757Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd trange after sdt=2/26/2021, 23:55:00 edt=2/26/2021, 11:03:00 now=2/26/2021, 11:03:52 2021-02-26T11:03:52.759Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd timer now scheduled for 2/26/2021, 23:55:00, 46267 secs from now 2021-02-26T11:03:52.761Z <Rule:5:Rule.js:714> Rule#rule-kljc5802.evaluate() trigger state false (was false) 2021-02-26T11:04:13.259Z <Rule:NOTICE> Rule#rule-kljc5802 configuration changed; reloading 2021-02-26T11:04:13.264Z <Rule:5:Rule.js:600> Rule#rule-kljc5802 reloading with new data 2021-02-26T11:04:13.265Z <Rule:NOTICE> Rule#rule-kljc5802 stopping rule 2021-02-26T11:04:13.266Z <Rule:5:Rule.js:581> Rule#rule-kljc5802 acquiring mutex 2021-02-26T11:04:13.271Z <Rule:5:Rule.js:584> Rule#rule-kljc5802 mutex acquired; unsubscribing from condition dependencies 2021-02-26T11:04:13.274Z <Rule:5:Rule.js:586> Rule#rule-kljc5802 saving states 2021-02-26T11:04:13.281Z <Rule:5:Rule.js:590> Rule#rule-kljc5802 stopped 2021-02-26T11:04:13.282Z <Rule:NOTICE> Rule Rule#rule-kljc5802 stopped 2021-02-26T11:04:13.284Z <Rule:5:Rule.js:555> Rule#rule-kljc5802 start(), awaiting mutex 2021-02-26T11:04:13.286Z <Rule:5:Rule.js:563> Rule#rule-kljc5802 restored states: trig=false, rule=false 2021-02-26T11:04:13.287Z <Rule:5:Rule.js:563> Rule#rule-kljc5802 subscribing to dependencies 2021-02-26T11:04:13.289Z <Rule:INFO> Rule#rule-kljc5802 (Schedule - Festoon Lights OFF) started 2021-02-26T11:04:13.290Z <Rule:5:Rule.js:567> Rule#rule-kljc5802 start() dependencies resolved, performing initial evaluation 2021-02-26T11:04:13.292Z <Rule:5:Rule.js:697> Rule#rule-kljc5802 (Schedule - Festoon Lights OFF) evaluate() acquiring mutex 2021-02-26T11:04:13.293Z <Rule:5:Rule.js:700> Rule#rule-kljc5802.evaluate() mutex acquired, evaluating 2021-02-26T11:04:13.295Z <Rule:5:Rule.js:704> Rule#rule-kljc5802 update rate is 2/min limit 60/min 2021-02-26T11:04:13.297Z <Rule:5:Rule.js:654> Rule#rule-kljc5802 evaluateExpressions() with 0 expressions 2021-02-26T11:04:13.299Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd trange after sdt=2/26/2021, 23:55:00 edt=2/26/2021, 11:04:00 now=2/26/2021, 11:04:13 2021-02-26T11:04:13.300Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd timer now scheduled for 2/26/2021, 23:55:00, 46246 secs from now 2021-02-26T11:04:13.302Z <Rule:5:Rule.js:714> Rule#rule-kljc5802.evaluate() trigger state false (was false)2021-02-26T11:04:15.369Z <Rule:5:Rule.js:700> Rule#rule-kljc5802.evaluate() mutex acquired, evaluating 2021-02-26T11:04:15.371Z <Rule:5:Rule.js:704> Rule#rule-kljc5802 update rate is 3/min limit 60/min 2021-02-26T11:04:15.373Z <Rule:5:Rule.js:654> Rule#rule-kljc5802 evaluateExpressions() with 0 expressions 2021-02-26T11:04:15.375Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd trange after sdt=2/26/2021, 23:55:00 edt=2/26/2021, 11:04:00 now=2/26/2021, 11:04:15 2021-02-26T11:04:15.377Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd timer now scheduled for 2/26/2021, 23:55:00, 46244 secs from now 2021-02-26T11:04:15.379Z <Rule:5:Rule.js:714> Rule#rule-kljc5802.evaluate() trigger state false (was false)2021-02-26T11:18:29.114Z <Rule:5:Rule.js:680> Rule#rule-kljc5802.evaluate() mutex acquired, evaluating 2021-02-26T11:18:29.117Z <Rule:5:Rule.js:684> Rule#rule-kljc5802 update rate is 1/min limit 60/min 2021-02-26T11:18:29.119Z <Rule:5:Rule.js:634> Rule#rule-kljc5802 evaluateExpressions() with 0 expressions 2021-02-26T11:18:29.124Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd trange after sdt=2/26/2021, 23:55:00 edt=2/26/2021, 11:18:00 now=2/26/2021, 11:18:29 2021-02-26T11:18:29.127Z <Rule:null> Rule#rule-kljc5802 cond cond57lqecd timer now scheduled for 2/26/2021, 23:55:00, 45390 secs from now 2021-02-26T11:18:29.130Z <Rule:5:Rule.js:694> Rule#rule-kljc5802.evaluate() trigger state false (was false) -
Grep'ing out specific lines of the log isn't really a productive thing to do, as there are other lines surrounding in context that may not contain the search string but are needed to show the full activity. It would not, for example, show an exception thrown. Just gzip the log and email it to me at the address given in the "SUPPORT" section of the about page; I'll take a look later this morning.
-
Not related but I am seeing these errors in the log:
Expression compilation error for deviceclass heatonly_thermostat hvac_control.mode: Error: Parse error on line 1: ...tochangeover:'auto'}[lower(value)] ?? vaDevice 190 is the Secure Boiler Relay Switch related to the Secure Thermostat device.
2021-02-25T18:03:47.240Z <VeraController:ERR> Exception/error while updating Entity#vera>device_190 2021-02-25T18:03:47.242Z <VeraController:CRIT> ReferenceError: expr is not defined ReferenceError: expr is not defined -
Are you in 21056?
Author of Multi-system Reactor and Reactor, DelayLight, Switchboard, and about a dozen other plugins that run on Vera and openLuup.
-
Are you in 21056?
@toggledbits Yes
Two more rules here both are set to run at 9am
One worked this morning OK and did its action, the other rule the bottom one in the screen shot, that didn't run its action.
This is the rule that didn't run, have I done something wrong ?
I've just updated to the latest version of MSR (reactor-0.1.21057-f143fd3-generic.tar) and now that rule that didn't run this morning looks like this:
-
I have created a lot of other rules, some of them also with Constraints and none of those rules say null or no data in the Constraints in the rules summary card.
I've gone through them all now again looking and it seems I only have two rules which I have highlighted above that don't run and they say or have said null or no data in Constraints.
All my other garden lights have turned on and off OK, but they are using a sunset offset not a specific set time.
But that rule to turn off the Festoon lights at 23:55pm has never run since I created it.
I also have rules for the window coverings setup for specific times in the morning and generally they have all run at their set times OK.
I will see what happens tomorrow at 9am with this "Lounge Blind Slats" one ?
Thanks
-
The 11:55pm rule that never worked since I created it, I deleted it. I then created it again exactly the same as I did before. Looking at its Summary card the Constraints stated no data / null etc. I then edited the rule and changed its time to 9:00am and saved. I then edited the rule again and set it back to 11:55pm and saved.
The rule now runs and turns off my lights at 11:55pm or it did last night at least anyway. So assume it will work every night now.
I created another new rule not related to run every night at 10:30pm and that one worked first time no problems, so not sure why I have had issues with a few rules.
The 9am rule to open the Lounge Blind Slats didn't run this morning again, so I've deleted it and recreated it, see what happens with that tomorrow morning ?
-
Remember two things:
- Log files are pretty good at telling what's going on, and really good at help me determine what's going on;
- Open PRs are my highest priority.
-
OK. Not seeing an email yet... you used the address in the "Support" section of the About page?
Author of Multi-system Reactor and Reactor, DelayLight, Switchboard, and about a dozen other plugins that run on Vera and openLuup.
