at _ClientAPI._commandTimeout (http://192.168.1.100:8111/client/ClientAPI.js:807:179
Seeing this randomly when returning to open browser tab after being away awhile. Once, maybe twice a day.
"What did you do to trigger it?" Literally nothing, just walked away and returned and there it was.
Actions taken in reasonably close proximity to this particular instance of it popping up: I'd restarted the MSR container in Portainer.
I'll try to grab some logs here shortly.
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.
This post does not apply to users of Intel/AMD-based systems. If you are using a Reactor image tagged latest-amd64 or stable-amd64, then this post does not apply to you. It also does not apply to bare-metal installs; it's for users of docker images on ARM-based systems only (principally Raspberry Pi hosts, but could be others).
After January 15, 2026, I will no longer produce the aarch64-tagged docker image for Reactor. The ARM images will be arm64 for 64-bit operating systems, and armv7l for 32-bit operating systems.
For those of you running a container from the aarch64 image today, this will be a relatively simple change: you just need to switch the image used for your docker container to a differently-tagged image. If you are using docker-compose, then this is a relatively simple matter of changing the image line in your docker-compose.yaml file and then stopping (docker-compose down) and restarting (docker-compose up -d) your Reactor daemon.
But there's a catch... not all of you can safely just switch from the aarch64 image to the arm64 image. And, you can't just trust the output of uname -m, for example, because this exposes the CPU architecture, but not the word size of the OS running on that CPU.
For Raspberry Pi systems, the transition to 64-bit operating systems was long (starting in 2016) and not always obvious — although there was a first "official" 64-bit OS for RPis in 2020, it did not become a default recommendation in the Raspberry Pi Imager until 2021, and then that was only the default for Pi 3/4 systems with >4GB RAM; it was 2022 before it was universally recommended for all 64-bit CPUs regardless of RAM size. Depending on when you first imaged your RPi system and what default you may have been offered/chosen, you could today easily have a 64-bit CPU Raspberry Pi running a 32-bit version of the operating system. Upgrades along the way would not change this; changing it to fully 64-bit requires a full reimage of the system.
To establish if your OS is 64- or 32-bit, log in to your Pi and run: sudo dpkg-architecture -q DEB_HOST_ARCH. If the response is arm64 or aarch64, then you are running a 64-bit OS and you should use the arm64-tagged image. If it's anything else, you are running a 32-bit OS, and you should use the armv7l-tagged image.
pi@rpi4-1:~ $ sudo dpkg-architecture -q DEB_HOST_ARCH
armhf
pi@rpi4-1:~ $ uname -m
aarch64
pi@rpi4-1:~ $
In the example above, the uname command reports that the CPU is 64-bit architecture (aarch64), which is true for the host on which I ran these commands, but the DEB_HOST_ARCH value is armhf, indicating a 32-bit operating system. This system has to use the armv7l-tagged image.
Other systems will have their own ways of determining the word size of the running OS. Since the majority of Reactor users running ARM systems are on Raspberry Pis, I am able to supply the above instructions, but if you happen to have a different ARM system, you'll need to do some web searching to figure out how to expose that information. Or, you can just try the arm64 image, and if it doesn't start up, try the armv7l image.
Remember to always back up your system before making any changes.
For everyone, please make this change as soon as possible, and if you have any trouble finding a working image, please (1) go back to the current aarch64 image; and (2) let me know in this thread along with as much detail about your host system as you can offer (including the output of the dpkg-architecture command mentioned above).
Hi,
I'm in the process of migrating from a Raspberry Pi 4 (ARMv7) to a Raspberry Pi 5 (ARMv8/aarch64), but I’ve run into an issue: there is no proper ARMv8/aarch64 image available.
None of the existing images run on the Pi 5 - they all exit immediately with code 139 (segmentation fault), which typically indicates that the binaries inside the image are not compatible with the ARM64/aarch64 architecture used by the Pi 5.
Would it be possible to publish a correct ARMv8/aarch64 (linux/arm64) image?
Building one should be relatively straightforward using docker buildx with multi-arch support. For example, my own Node.js images are built this way:
docker buildx build --push \
-t <localrepo>/<project>:<tag> \
--platform=linux/arm64,linux/amd64 \
--file ./apps/<project>/Dockerfile .
This produces both the AMD64 and ARM64/v8 variants automatically.
Also, as a side note, it may be best to avoid using Alpine as the base image for the ARM64 build, since musl-based builds often cause compatibility issues and unnecessary headaches. A glibc-based base image (e.g., Debian or Ubuntu) tends to work far more reliably on ARM64, especially for Node.js applications.
@toggledbits - tagging you in case you missed this.
Thanks,
mgvra
Sorry to write here without trying, but I’m flying today.
Am I correct if i say that script action with alarm() makes it possible to execute a reaction in a given interval, lets say 15 seconds or 3.5 minutes?
That sounds amazing, since I’ve used weird tricks, including a custom controller, just to do this.
@toggledbits Do you know if this is related to that PR or is it a change they made in 2025.11.1?
[latest-25310]2025-11-11T13:16:24.319Z <HassController:INFO> HassController#hass perform x_hass_input_datetime.set_datetime on Entity#hass>input_datetime_vvb_dag with { "time": "10:45" }
[latest-25310]2025-11-11T13:16:24.320Z <HassController:INFO> HassController#hass: sending payload for x_hass_input_datetime.set_datetime on Entity#hass>input_datetime_vvb_dag action: { "type": "call_service", "service_data": { "date": (null), "time": "10:45", "datetime": (null), "timestamp": (null) }, "domain": "input_datetime", "service": "set_datetime", "target": { "entity_id": "input_datetime.vvb_dag" } }
[latest-25310]2025-11-11T13:16:24.321Z <HassController:ERR> HassController#hass request 1762866984320<2025-11-11 14:16:24> (call_service) failed: [Error] Not a parseable type for dictionary value @ data['date'] [-]
[latest-25310]2025-11-11T13:16:24.321Z <HassController:WARN> HassController#hass action x_hass_input_datetime.set_datetime({ "time": "10:45" }) on Entity#hass>input_datetime_vvb_dag failed!
[latest-25310]2025-11-11T13:16:24.321Z <HassController:INFO> Service call payload:
{"type":"call_service","service_data":{"date":null,"time":"10:45","datetime":null,"timestamp":null},"domain":"input_datetime","service":"set_datetime","target":{"entity_id":"input_datetime.vvb_dag"},"id":1762866984320}
[latest-25310]2025-11-11T13:16:24.322Z <HassController:INFO> Service data:
{"fields":{"date":{"example":"\"2019-04-20\"","selector":{"text":{"multiline":false,"multiple":false}}},"time":{"example":"\"05:04:20\"","selector":{"time":{}}},"datetime":{"example":"\"2019-04-20 05:04:20\"","selector":{"text":{"multiline":false,"multiple":false}}},"timestamp":{"selector":{"number":{"min":0,"max":9223372036854776000,"mode":"box","step":1}}}},"target":{"entity":[{"domain":["input_datetime"]}]}}
[latest-25310]2025-11-11T13:16:24.322Z <Engine:ERR> Engine#1 reaction rule-mgb8pfhs:S step 0 perform x_hass_input_datetime.set_datetime failed: [Error] Not a parseable type for dictionary value @ data['date'] [-]
[latest-25310]2025-11-11T13:16:24.322Z <Engine:INFO> Engine#1 action args: { "time": "10:45" }
[latest-25310]2025-11-11T13:16:24.322Z <Engine:INFO> Resuming reaction Sätt Schema VVB i Home Assistant<AKTIV> (rule-mgb8pfhs:S) from step 1
[latest-25310]2025-11-11T13:16:24.323Z <HassController:INFO> HassController#hass perform x_hass_input_datetime.set_datetime on Entity#hass>input_datetime_vvb_natt with { "time": "03:00", "timestamp": 0 }
[latest-25310]2025-11-11T13:16:24.323Z <HassController:INFO> HassController#hass: sending payload for x_hass_input_datetime.set_datetime on Entity#hass>input_datetime_vvb_natt action: { "type": "call_service", "service_data": { "date": (null), "time": "03:00", "datetime": (null), "timestamp": 0 }, "domain": "input_datetime", "service": "set_datetime", "target": { "entity_id": "input_datetime.vvb_natt" } }
[latest-25310]2025-11-11T13:16:24.324Z <HassController:ERR> HassController#hass request 1762866984323<2025-11-11 14:16:24> (call_service) failed: [Error] Not a parseable type for dictionary value @ data['date'] [-]
[latest-25310]2025-11-11T13:16:24.324Z <HassController:WARN> HassController#hass action x_hass_input_datetime.set_datetime({ "time": "03:00", "timestamp": 0 }) on Entity#hass>input_datetime_vvb_natt failed!
[latest-25310]2025-11-11T13:16:24.324Z <HassController:INFO> Service call payload:
{"type":"call_service","service_data":{"date":null,"time":"03:00","datetime":null,"timestamp":0},"domain":"input_datetime","service":"set_datetime","target":{"entity_id":"input_datetime.vvb_natt"},"id":1762866984323}
[latest-25310]2025-11-11T13:16:24.324Z <HassController:INFO> Service data:
{"fields":{"date":{"example":"\"2019-04-20\"","selector":{"text":{"multiline":false,"multiple":false}}},"time":{"example":"\"05:04:20\"","selector":{"time":{}}},"datetime":{"example":"\"2019-04-20 05:04:20\"","selector":{"text":{"multiline":false,"multiple":false}}},"timestamp":{"selector":{"number":{"min":0,"max":9223372036854776000,"mode":"box","step":1}}}},"target":{"entity":[{"domain":["input_datetime"]}]}}
[latest-25310]2025-11-11T13:16:24.324Z <Engine:ERR> Engine#1 reaction rule-mgb8pfhs:S step 1 perform x_hass_input_datetime.set_datetime failed: [Error] Not a parseable type for dictionary value @ data['date'] [-]
[latest-25310]2025-11-11T13:16:24.324Z <Engine:INFO> Engine#1 action args: { "time": "03:00", "timestamp": 0 }
[latest-25310]2025-11-11T13:16:24.325Z <Engine:INFO> Resuming reaction Sätt Schema VVB i Home Assistant<AKTIV> (rule-mgb8pfhs:S) from step 2
[latest-25310]2025-11-11T13:16:24.325Z <Engine:INFO> Sätt Schema VVB i Home Assistant<AKTIV> all actions completed.
Hello,
I currently have an office light (connected via a Leviton Zwave Dimmer switch) controlled from a Gen5 Aeotech Zwave switch installed on my Synology 720+ NAS. I run HA(2025.11.10) in a virtual machine from my NAS and Reactor on the container manager of the same NAS. Prior to updating to 25304 the rule I had set to turn the light on to a specific dimming value worked correctly. Now the rule appears to follow the decision tree, however the reaction does not trigger setting the dimming or turning on the office light?
Strangely I can still turn the light on and off as well as dim it directly from HASS..? I have tried using the ''try this action'' button in the rules reaction setting and it will not control the light and does not throw an error flagÉ
Please help,
P.S
Reactor has been rock steady for me over the last few years and I'm a big fan of this solution.
Hello all.. been a minute! I recently rebuilt my Z wave network and migrated to a new z wave stick. In order to prevent any downtime I kept my original z wave network up and ran a docker version of Z Wave JS UI with my new controller. This way I could add device by device without having any devices down.
I finally moved all the devices over to my new stick today. The final step was to migrate everything from my Docker instance of Z Wave JS UI to the HA add-on of Z Wave JS UI. However during this migration some of the names didn't populate correctly which I later managed to import back into Z Wave JS UI. The issue was in Reactor it is stuck on the default names and the entities are not updating. I removed the controller from Reactor, restarted, hard refreshed, and added the controller back however the new entity names have not updated. Also it seems like the old entities from my previous instance of Z Wave JS UI are lingering and not being marked as dead (I believe a certain amount of time needs to lapse before they're marked as dead in Reactor).
My goal is to basically purge all the entities for the 'ZWaveJS' controller in Reactor so it can pull all the updated entity names and only the entities that exist in Z Wave JS UI. I cannot find a quick way to do this, I know entities can be deleted one by one, but with over 100 entities this would take long
I am guessing that if I added the controller with a new name in in the Reactor config it would pull the updated entities and names but I think that would break my rules since the entity IDs would change (I made sure to name all the entities the exact same as they were previously to prevent this issue).
I'm slowly migrating all my stuff to MQTT under MSR, so I have a central place to integrate everything (and, in a not-so-distant future, to remove virtual devices from my Vera and leave it running zwave only).
Anyway, here's my reactor-mqtt-contrib package:
https://github.com/dbochicchio/reactor-mqtt-contrib
Simply download yaml files (everything or just the ones you need) and you're good to go.
I have mapped my most useful devices, but I'll add others soon. Feel free to ask for specific templates, since I've worked a lot in the last weeks to understand and operate them.
The templates are supporting both init and query, so you have always up-to-date devices at startup, and the ability to poll them. Online status is supported as well, so you can get disconnected devices with a simple expression.
Many-many thanks to @toggledbits for its dedication, support, and patience with me and my requests
Constraints (no data) rule actions have never run
-
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.
-
OK. Not seeing an email yet... you used the address in the "Support" section of the About page?
-
@cw-kid I removed your post just for my own anti-spam/scraping reduction, no other reason. The address you showed is fine. If you know how to reach me in my primary domain, that's fine too. I just point out the About page because it will always be there.
