OH 2.5.10, openhabian - raspbian stretch on RPI 3.
I have such rule:
rule "Update timestamp" when Item gBathroom1Sensor received update or Item gFridgeSensor received update or Item gLivingroomSensor received update or Item gBedroom1Sensor received update or Item gCorridorMotion received update or Item gKitchenMotion received update or Item gBedroom1Motion received update or Item gBedroom2Motion received update or Item gBalconyMotion received update or Item gBathroom2Sensor received update or Item gDustSensor received update or Item gLivingroomThermostat received update or Item gFibaroMotion received update or Item gAeotecMotion received update then logInfo("Update timestamp", String::format("triggeringItem: %s, name: %s", triggeringItem, triggeringItem.name)) var lastUpdateItem = gLastUpdate.members.findFirst[ i | i != null && i.name == triggeringItem.name + "_lastUpdate" ] logInfo("Update timestamp", String::format("lastUpdateItem: %s", lastUpdateItem)) postUpdate(lastUpdateItem, new DateTimeType()) end
and sometimes it gives such log output:
2020-12-03 16:33:03.098 [INFO ] [rthome.model.script.Update timestamp] - triggeringItem: gLivingroomThermostat (Type=GroupItem, BaseType=NumberItem, Members=2, State=UNDEF, Label=null, Category=null), name: gLivingroomThermostat 2020-12-03 16:33:03.106 [INFO ] [rthome.model.script.Update timestamp] - triggeringItem: gLivingroomThermostat (Type=GroupItem, BaseType=NumberItem, Members=2, State=UNDEF, Label=null, Category=null), name: gLivingroomThermostat 2020-12-03 16:33:03.203 [ERROR] [ntime.internal.engine.RuleEngineImpl] - Rule 'Update timestamp': null 2020-12-03 16:33:03.215 [INFO ] [rthome.model.script.Update timestamp] - lastUpdateItem: gLivingroomThermostat_lastUpdate (Type=DateTimeItem, State=2020-12-03T16:28:06.249+0100, Label=Termostat Salon, Category=time, Groups=[gLastUpdate])
All items in when clause are groups. Those groups have couple of other items connected to each of them. Those other items are connected to binding channels (zwave, mqtt, etc…).
This error happens only if there are two updates of the same group in very short interval. In the attached log You see the first update is at 16:33:03.098 and the second at 16:33:03.106. It looks like the second update is happening during execution of the rule, because the logs are interleaved. But I don’t have any clue what is causing this error. I do not see any other symptoms of this error, everything seems to work fine, but the error is just annoying. It happens cuple of times per hour.