openHAB 4.3 Release Discussion

Setup, Configuration and Use News & Important Changes
204

Thank you for the release of OH 4.3!

Following the upgrade to 4.3 from 4.2 about a week ago I have occasionally been running into an issue at OH startup, where the rule engine will not start and the system does not go beyond runlevel 40. There is no error messages in the log that would suggest anything has gone wrong. There is just no log message that rule engine has loaded, and no messages for runlevels above 40, plus none of the messages that the different rules have been loaded.
(I am using a files-based configuration, and all my rules are JS rules).
Surprisingly, everything else seems to be running ok, items and things work, persistence works, UI is there and works. Just everything dependent on / triggered by rules will not work.

At this point I have no inkling what might be causing this. I cannot readily reproduce it, it only happens occasionally at startup. So far it has happened 2, probably 3 times over the past week, and is readily fixed by restarting OH.
I have a bash script that will shutdown OH every night, run a backup and some admin tasks, and then start up OH again. This had been working well for a couple of years now (since OH 2.x), but now I have seen that OH misfire twice (On Dec 26 and Dec 21). Plus, I recall that the first start of OH after the upgrade to 4.3 (via Openhabian on Dec 19) led to a similar issue; at that point I blamed it on the update process (it would not have been the first OH update that ran into errors on first boot, only for those issues to disappear following another restart).

Other than the OH update (and adding one Shelly device that the 4.2 binding did not yet support) I have not made any changes to the system. So this new issue seems to be related to the update.

Any thoughts or suggestions how to follow up on this issue?

I have added logs below, first log is the failed startup, second log is from a successful startup.
There is a couple of warnings in the logs, but those have been around for a while and occur in successful boots, as well. (Although, the number of repeat “enabled CORS for REST API” messages seems to have gone up a lot ever since 4.x)

Failed startup:

2024-12-26 04:17:20.409 [INFO ] [org.openhab.core.Activator          ] - Starting openHAB 4.3.0 (Release Build)
2024-12-26 04:17:21.734 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Time zone set to 'Europe/Berlin'.
2024-12-26 04:17:21.752 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Location set to '50.246027566901375,8.645961284637453'.
2024-12-26 04:17:21.755 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Locale set to 'en_DE'.
2024-12-26 04:17:29.631 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:29.641 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:29.722 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:29.942 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:30.024 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:30.252 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:30.334 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:30.395 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:30.459 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:30.553 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:30.674 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:30.781 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:30.936 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:31.056 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:31.198 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:31.389 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:31.568 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:31.775 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:32.098 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:32.363 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:32.992 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:36.800 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'generic.items'
2024-12-26 04:17:38.134 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model '_groupscharts.items'
2024-12-26 04:17:39.248 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'allother.items'
2024-12-26 04:17:39.597 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'heizung.items'
2024-12-26 04:17:40.146 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model '_kontrollzentrum.items'
2024-12-26 04:17:40.327 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'kameras.items'
2024-12-26 04:17:40.384 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'fritz.items'
2024-12-26 04:17:40.889 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'electricity.items'
2024-12-26 04:17:41.839 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'shelly.items'
2024-12-26 04:17:43.249 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'mqtt.items'
2024-12-26 04:17:43.894 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'homematic.items'
2024-12-26 04:17:45.121 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'mapdb.persist'
2024-12-26 04:17:45.271 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'jdbc.persist'
2024-12-26 04:17:46.258 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'Philipp.sitemap'
2024-12-26 04:17:46.589 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'haus.sitemap'
2024-12-26 04:17:49.248 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'mqtt-32.things'
2024-12-26 04:17:49.476 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'mail.things'
2024-12-26 04:17:49.496 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'http.things'
2024-12-26 04:17:49.520 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'network.things'
2024-12-26 04:17:52.854 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:53.144 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:53.613 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:53.988 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:17:59.215 [INFO ] [.core.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007
2024-12-26 04:18:00.002 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'mailer.rules'
2024-12-26 04:18:05.151 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:18:05.581 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:18:05.940 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:18:06.542 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:18:06.952 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:18:08.395 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:18:09.304 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:18:10.157 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:18:10.804 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:18:11.203 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:18:11.599 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:18:18.405 [WARN ] [ty.util.ssl.SslContextFactory.config] - Trusting all certificates configured for Client@40700e63[provider=null,keyStore=null,trustStore=null]
2024-12-26 04:18:18.408 [WARN ] [ty.util.ssl.SslContextFactory.config] - No Client EndPointIdentificationAlgorithm configured for Client@40700e63[provider=null,keyStore=null,trustStore=null]
2024-12-26 04:18:18.628 [WARN ] [rg.openhab.core.io.net.exec.ExecUtil] - Failed to execute commandLine '[arping, --help]'
2024-12-26 04:18:18.656 [INFO ] [.network.internal.utils.NetworkUtils] - CIDR prefix is smaller than /24 on interface with address 192.168.178.100/23, truncating to /24, some addresses might be lost
2024-12-26 04:18:18.674 [WARN ] [rg.openhab.core.io.net.exec.ExecUtil] - Failed to execute commandLine '[arping, --help]'
2024-12-26 04:18:18.828 [WARN ] [ty.util.ssl.SslContextFactory.config] - Trusting all certificates configured for Client@19132859[provider=null,keyStore=null,trustStore=null]
2024-12-26 04:18:18.832 [WARN ] [ty.util.ssl.SslContextFactory.config] - No Client EndPointIdentificationAlgorithm configured for Client@19132859[provider=null,keyStore=null,trustStore=null]
2024-12-26 04:18:18.936 [INFO ] [nding.http.internal.HttpThingHandler] - Using the secure client for thing 'http:url:pihole'.
2024-12-26 04:18:19.243 [INFO ] [ternal.dhcp.DHCPPacketListenerServer] - DHCP request packet listener online
2024-12-26 04:18:20.051 [INFO ] [nternal.manager.ShellyManagerServlet] - Shelly Manager started at http(s)://192.168.178.100:8080/shelly/manager
2024-12-26 04:18:20.654 [WARN ] [ty.util.ssl.SslContextFactory.config] - Trusting all certificates configured for Client@58ee44a3[provider=null,keyStore=null,trustStore=null]
2024-12-26 04:18:20.657 [WARN ] [ty.util.ssl.SslContextFactory.config] - No Client EndPointIdentificationAlgorithm configured for Client@58ee44a3[provider=null,keyStore=null,trustStore=null]
2024-12-26 04:18:21.064 [INFO ] [.transport.mqtt.MqttBrokerConnection] - Starting MQTT broker connection to '192.168.178.32' with clientid openhab
2024-12-26 04:18:29.637 [INFO ] [persistence.jdbc.internal.JdbcMapper] - JDBC::openConnection: Driver is available::Yank setupDataSource
2024-12-26 04:18:29.952 [INFO ] [io.openhabcloud.internal.CloudClient] - Connected to the openHAB Cloud service (UUID = b3...fb, base URL = http://localhost:8080)
2024-12-26 04:18:38.872 [INFO ] [ab.ui.habpanel.internal.HABPanelTile] - Started HABPanel at /habpanel
2024-12-26 04:18:38.887 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 04:18:42.910 [INFO ] [openhab.event.StartlevelEvent       ] - Startlevel '30' reached.
2024-12-26 04:18:42.914 [INFO ] [openhab.event.StartlevelEvent       ] - Startlevel '40' reached.
2024-12-26 04:18:46.060 [WARN ] [core.thing.internal.ThingManagerImpl] - Initializing handler for thing 'mqtt:topic:mosquitto32:senec' takes more than 5000ms.
2024-12-26 04:18:47.399 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellyplug-s-ab8abd: INFO: New firmware available: current version: 20230503-101129/v1.13.0-g9aed950, new version: 20230913-113421/v1.14.0-gcb84623
2024-12-26 04:18:47.959 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellyswitch25-40f520231dce: INFO: New firmware available: current version: 20230503-095750/v1.13.0-g9aed950, new version: 20230913-112234/v1.14.0-gcb84623
2024-12-26 04:18:48.382 [INFO ] [y.internal.handler.ShellyBaseHandler] - shelly1pm-84cca8ad90ec: INFO: New firmware available: current version: 20230503-101420/v1.13.0-g9aed950, new version: 20230913-113709/v1.14.0-gcb84623
2024-12-26 04:18:48.397 [INFO ] [ternal.communicator.client.RpcClient] - Interface 'WIRED' on gateway '3014F711A0001F5A4993F0B8' not available, disabling support
2024-12-26 04:18:48.667 [INFO ] [ommunicator.AbstractHomematicGateway] - HmGatewayInfo[id=CCU,type=CCU2,firmware=3.61.7.20220226,address=QEQ0690360,rf=true,wired=false,hmip=true,cuxd=true,group=true]
2024-12-26 04:18:48.913 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellyem3-d8bfc01a8351: INFO: New firmware available: current version: 20230510-083155/v1.13.1-gda6f9f2, new version: 20230913-114244/v1.14.0-gcb84623
2024-12-26 04:19:02.446 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellyplug-s-801b55: INFO: New firmware available: current version: 20230503-101129/v1.13.0-g9aed950, new version: 20230913-113421/v1.14.0-gcb84623
2024-12-26 04:19:03.483 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellyuni-3c6105e4f397: INFO: New firmware available: current version: 20230503-102354/v1.13.0-g9aed950, new version: 20230913-114521/v1.14.0-gcb84623
2024-12-26 04:19:04.090 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellyrgbw2-ddcd3b: INFO: New firmware available: current version: 20230511-223416/v1.13.1-gb0b8c19, new version: 20230913-131259/v1.14.0-gcb84623
2024-12-26 04:19:05.906 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellyuni-e8db84d651a4: INFO: New firmware available: current version: 20230503-102354/v1.13.0-g9aed950, new version: 20230913-114521/v1.14.0-gcb84623
2024-12-26 04:19:07.094 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellyplug-s-203fbc: INFO: New firmware available: current version: 20230503-101129/v1.13.0-g9aed950, new version: 20230913-113421/v1.14.0-gcb84623
2024-12-26 04:19:08.673 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellyplug-s-51cf58: INFO: New firmware available: current version: 20230503-101129/v1.13.0-g9aed950, new version: 20230913-113421/v1.14.0-gcb84623
2024-12-26 04:19:09.844 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellydimmer-d4627d: INFO: New firmware available: current version: 20230510-082818/v1.13.1-gda6f9f2, new version: 20230913-113908/v1.14.0-gcb84623
2024-12-26 04:19:11.738 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellydimmer2-e8db84d789ba: INFO: New firmware available: current version: 20230510-082920/v1.13.1-gda6f9f2, new version: 20230913-114008/v1.14.0-gcb84623
2024-12-26 04:19:16.835 [INFO ] [ng.homematic.internal.misc.MiscUtils] - Datapoint name 'Alarmzone 1' contains invalid characters, new Datapoint name 'Alarmzone_1'
2024-12-26 04:19:16.863 [INFO ] [ng.homematic.internal.misc.MiscUtils] - Datapoint name '${ruleTmpProgramName}' contains invalid characters, new Datapoint name '__ruleTmpProgramName_'
2024-12-26 04:19:16.866 [INFO ] [ng.homematic.internal.misc.MiscUtils] - Datapoint name 'Dummy Schalter BĂŒro' contains invalid characters, new Datapoint name 'Dummy_Schalter_B_ro'
2024-12-26 04:19:19.239 [WARN ] [ternal.handler.HomematicThingHandler] - Value for datapoint HmDatapoint[name=POWERUP_OFFDELAY_VALUE,value=101,defaultValue=0,type=INTEGER,minValue=0,maxValue=31,options=null,readOnly=false,readable=true,unit=null,description=POWERUP_OFFDELAY_VALUE,info=null,paramsetType=MASTER,virtual=false,trigger=false] is outside of valid range, using default value for config.
2024-12-26 04:19:24.366 [WARN ] [ternal.handler.HomematicThingHandler] - Value for datapoint HmDatapoint[name=POWERUP_OFFDELAY_VALUE,value=101,defaultValue=0,type=INTEGER,minValue=0,maxValue=31,options=null,readOnly=false,readable=true,unit=null,description=POWERUP_OFFDELAY_VALUE,info=null,paramsetType=MASTER,virtual=false,trigger=false] is outside of valid range, using default value for config.
2024-12-26 04:19:25.597 [WARN ] [ternal.handler.HomematicThingHandler] - Value for datapoint HmDatapoint[name=POWERUP_OFFDELAY_VALUE,value=101,defaultValue=0,type=INTEGER,minValue=0,maxValue=31,options=null,readOnly=false,readable=true,unit=null,description=POWERUP_OFFDELAY_VALUE,info=null,paramsetType=MASTER,virtual=false,trigger=false] is outside of valid range, using default value for config.
2024-12-26 04:20:45.422 [WARN ] [network.InMemoryMessageExchangeStore] - coap Exchange[L355] with manual token overrides existing Exchange[L118] with open request: KeyToken[192.168.178.42:5683-]
2024-12-26 04:21:06.995 [WARN ] [core.thing.internal.ThingManagerImpl] - Channel types or config descriptions for thing 'avmfritz:FRITZ_DECT_200:192_168_178_1:087610387976' are missing in the respective registry for more than 120s. In case it does not happen immediately after an upgrade, it should be fixed in the binding.
2024-12-26 04:21:06.998 [WARN ] [core.thing.internal.ThingManagerImpl] - Channel types or config descriptions for thing 'avmfritz:FRITZ_DECT_210:192_168_178_1:116570069763' are missing in the respective registry for more than 120s. In case it does not happen immediately after an upgrade, it should be fixed in the binding.
2024-12-26 04:21:07.000 [WARN ] [core.thing.internal.ThingManagerImpl] - Channel types or config descriptions for thing 'avmfritz:FRITZ_DECT_210:192_168_178_1:116570077336' are missing in the respective registry for more than 120s. In case it does not happen immediately after an upgrade, it should be fixed in the binding.

Successful startup:

2024-12-26 09:34:10.855 [INFO ] [org.openhab.core.Activator          ] - Starting openHAB 4.3.0 (Release Build)
2024-12-26 09:34:12.461 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Time zone set to 'Europe/Berlin'.
2024-12-26 09:34:12.481 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Location set to '50.246027566901375,8.645961284637453'.
2024-12-26 09:34:12.484 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Locale set to 'en_DE'.
2024-12-26 09:34:15.017 [WARN ] [.transport.servlet.ServletController] - Can't find the request for http://raspberrypi3:8080/rest/events's Observer 
2024-12-26 09:34:20.920 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:20.929 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:20.996 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:21.204 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:21.276 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:21.494 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:21.568 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:21.624 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:21.763 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:21.852 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:22.002 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:22.138 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:22.281 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:22.409 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:22.550 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:22.746 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:22.902 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:23.083 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:23.408 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:23.615 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:24.211 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:28.151 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'generic.items'
2024-12-26 09:34:29.557 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model '_groupscharts.items'
2024-12-26 09:34:31.497 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'allother.items'
2024-12-26 09:34:31.993 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'heizung.items'
2024-12-26 09:34:33.016 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model '_kontrollzentrum.items'
2024-12-26 09:34:33.322 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'kameras.items'
2024-12-26 09:34:33.438 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'fritz.items'
2024-12-26 09:34:34.202 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'electricity.items'
2024-12-26 09:34:35.761 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'shelly.items'
2024-12-26 09:34:38.121 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'mqtt.items'
2024-12-26 09:34:39.290 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'homematic.items'
2024-12-26 09:34:41.006 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'mapdb.persist'
2024-12-26 09:34:41.162 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'jdbc.persist'
2024-12-26 09:34:42.215 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'Philipp.sitemap'
2024-12-26 09:34:42.517 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'haus.sitemap'
2024-12-26 09:34:45.040 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'mqtt-32.things'
2024-12-26 09:34:45.262 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'mail.things'
2024-12-26 09:34:45.285 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'http.things'
2024-12-26 09:34:45.313 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'network.things'
2024-12-26 09:34:49.609 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:49.935 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:50.550 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:50.969 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:34:56.316 [INFO ] [.core.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007
2024-12-26 09:34:57.292 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'mailer.rules'
2024-12-26 09:35:02.334 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:35:02.647 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:35:03.241 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:35:04.203 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:35:04.546 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:35:05.883 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:35:06.007 [WARN ] [.transport.servlet.ServletController] - Can't find the request for http://192.168.178.100:8080/rest/items/GefrierschrankStecker192168178123MeterTotalKWHLastDay's Observer 
2024-12-26 09:35:06.015 [WARN ] [.transport.servlet.ServletController] - Can't find the request for http://192.168.178.100:8080/rest/items/Kuehlschrank192168178131MeterTotalKWHLastDay's Observer 
2024-12-26 09:35:06.096 [WARN ] [.transport.servlet.ServletController] - Can't find the request for http://192.168.178.100:8080/rest/items/Kuechenleuchte192168178159MeterTotalKWHLastDay's Observer 
2024-12-26 09:35:06.519 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:35:07.256 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:35:07.709 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:35:08.087 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:35:08.533 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:35:14.615 [WARN ] [ty.util.ssl.SslContextFactory.config] - Trusting all certificates configured for Client@77558909[provider=null,keyStore=null,trustStore=null]
2024-12-26 09:35:14.623 [WARN ] [ty.util.ssl.SslContextFactory.config] - No Client EndPointIdentificationAlgorithm configured for Client@77558909[provider=null,keyStore=null,trustStore=null]
2024-12-26 09:35:14.832 [WARN ] [rg.openhab.core.io.net.exec.ExecUtil] - Failed to execute commandLine '[arping, --help]'
2024-12-26 09:35:14.868 [INFO ] [.network.internal.utils.NetworkUtils] - CIDR prefix is smaller than /24 on interface with address 192.168.178.100/23, truncating to /24, some addresses might be lost
2024-12-26 09:35:14.888 [WARN ] [rg.openhab.core.io.net.exec.ExecUtil] - Failed to execute commandLine '[arping, --help]'
2024-12-26 09:35:15.039 [WARN ] [ty.util.ssl.SslContextFactory.config] - Trusting all certificates configured for Client@3ee7149f[provider=null,keyStore=null,trustStore=null]
2024-12-26 09:35:15.048 [WARN ] [ty.util.ssl.SslContextFactory.config] - No Client EndPointIdentificationAlgorithm configured for Client@3ee7149f[provider=null,keyStore=null,trustStore=null]
2024-12-26 09:35:15.167 [INFO ] [nding.http.internal.HttpThingHandler] - Using the secure client for thing 'http:url:pihole'.
2024-12-26 09:35:15.399 [INFO ] [ternal.dhcp.DHCPPacketListenerServer] - DHCP request packet listener online
2024-12-26 09:35:16.365 [INFO ] [nternal.manager.ShellyManagerServlet] - Shelly Manager started at http(s)://192.168.178.100:8080/shelly/manager
2024-12-26 09:35:17.022 [WARN ] [ty.util.ssl.SslContextFactory.config] - Trusting all certificates configured for Client@1cf02fdd[provider=null,keyStore=null,trustStore=null]
2024-12-26 09:35:17.029 [WARN ] [ty.util.ssl.SslContextFactory.config] - No Client EndPointIdentificationAlgorithm configured for Client@1cf02fdd[provider=null,keyStore=null,trustStore=null]
2024-12-26 09:35:17.697 [INFO ] [.transport.mqtt.MqttBrokerConnection] - Starting MQTT broker connection to '192.168.178.32' with clientid openhab
2024-12-26 09:35:25.989 [INFO ] [persistence.jdbc.internal.JdbcMapper] - JDBC::openConnection: Driver is available::Yank setupDataSource
2024-12-26 09:35:26.290 [INFO ] [io.openhabcloud.internal.CloudClient] - Connected to the openHAB Cloud service (UUID = b3...fb, base URL = http://localhost:8080)
2024-12-26 09:35:33.393 [INFO ] [ab.ui.habpanel.internal.HABPanelTile] - Started HABPanel at /habpanel
2024-12-26 09:35:33.413 [INFO ] [e.io.rest.internal.filter.CorsFilter] - enabled CORS for REST API.
2024-12-26 09:35:33.683 [INFO ] [openhab.event.StartlevelEvent       ] - Startlevel '30' reached.
2024-12-26 09:35:33.687 [INFO ] [openhab.event.StartlevelEvent       ] - Startlevel '40' reached.
2024-12-26 09:35:38.165 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellyswitch25-40f520231dce: INFO: New firmware available: current version: 20230503-095750/v1.13.0-g9aed950, new version: 20230913-112234/v1.14.0-gcb84623
2024-12-26 09:35:38.254 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellyplug-s-ab8abd: INFO: New firmware available: current version: 20230503-101129/v1.13.0-g9aed950, new version: 20230913-113421/v1.14.0-gcb84623
2024-12-26 09:35:38.622 [INFO ] [ternal.communicator.client.RpcClient] - Interface 'WIRED' on gateway '3014F711A0001F5A4993F0B8' not available, disabling support
2024-12-26 09:35:38.825 [INFO ] [ommunicator.AbstractHomematicGateway] - HmGatewayInfo[id=CCU,type=CCU2,firmware=3.61.7.20220226,address=QEQ0690360,rf=true,wired=false,hmip=true,cuxd=true,group=true]
2024-12-26 09:35:41.266 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellyem3-d8bfc01a8351: INFO: New firmware available: current version: 20230510-083155/v1.13.1-gda6f9f2, new version: 20230913-114244/v1.14.0-gcb84623
2024-12-26 09:35:41.285 [INFO ] [y.internal.handler.ShellyBaseHandler] - shelly1pm-84cca8ad90ec: INFO: New firmware available: current version: 20230503-101420/v1.13.0-g9aed950, new version: 20230913-113709/v1.14.0-gcb84623
2024-12-26 09:35:41.577 [WARN ] [core.thing.internal.ThingManagerImpl] - Initializing handler for thing 'mqtt:topic:mosquitto32:senec' takes more than 5000ms.
2024-12-26 09:35:55.004 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellyplug-s-801b55: INFO: New firmware available: current version: 20230503-101129/v1.13.0-g9aed950, new version: 20230913-113421/v1.14.0-gcb84623
2024-12-26 09:35:55.340 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellyuni-3c6105e4f397: INFO: New firmware available: current version: 20230503-102354/v1.13.0-g9aed950, new version: 20230913-114521/v1.14.0-gcb84623
2024-12-26 09:35:55.345 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellyrgbw2-ddcd3b: INFO: New firmware available: current version: 20230511-223416/v1.13.1-gb0b8c19, new version: 20230913-131259/v1.14.0-gcb84623
2024-12-26 09:35:58.440 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellyuni-e8db84d651a4: INFO: New firmware available: current version: 20230503-102354/v1.13.0-g9aed950, new version: 20230913-114521/v1.14.0-gcb84623
2024-12-26 09:35:59.024 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellyplug-s-203fbc: INFO: New firmware available: current version: 20230503-101129/v1.13.0-g9aed950, new version: 20230913-113421/v1.14.0-gcb84623
2024-12-26 09:36:05.207 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellyplug-s-51cf58: INFO: New firmware available: current version: 20230503-101129/v1.13.0-g9aed950, new version: 20230913-113421/v1.14.0-gcb84623
2024-12-26 09:36:07.523 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellydimmer-d4627d: INFO: New firmware available: current version: 20230510-082818/v1.13.1-gda6f9f2, new version: 20230913-113908/v1.14.0-gcb84623
2024-12-26 09:36:07.573 [INFO ] [ng.homematic.internal.misc.MiscUtils] - Datapoint name 'Alarmzone 1' contains invalid characters, new Datapoint name 'Alarmzone_1'
2024-12-26 09:36:07.625 [INFO ] [ng.homematic.internal.misc.MiscUtils] - Datapoint name '${ruleTmpProgramName}' contains invalid characters, new Datapoint name '__ruleTmpProgramName_'
2024-12-26 09:36:07.643 [INFO ] [ng.homematic.internal.misc.MiscUtils] - Datapoint name 'Dummy Schalter BĂŒro' contains invalid characters, new Datapoint name 'Dummy_Schalter_B_ro'
2024-12-26 09:36:10.203 [INFO ] [y.internal.handler.ShellyBaseHandler] - shellydimmer2-e8db84d789ba: INFO: New firmware available: current version: 20230510-082920/v1.13.1-gda6f9f2, new version: 20230913-114008/v1.14.0-gcb84623
2024-12-26 09:36:16.950 [WARN ] [ternal.handler.HomematicThingHandler] - Value for datapoint HmDatapoint[name=POWERUP_OFFDELAY_VALUE,value=101,defaultValue=0,type=INTEGER,minValue=0,maxValue=31,options=null,readOnly=false,readable=true,unit=null,description=POWERUP_OFFDELAY_VALUE,info=null,paramsetType=MASTER,virtual=false,trigger=false] is outside of valid range, using default value for config.
2024-12-26 09:36:21.000 [WARN ] [ternal.handler.HomematicThingHandler] - Value for datapoint HmDatapoint[name=POWERUP_OFFDELAY_VALUE,value=101,defaultValue=0,type=INTEGER,minValue=0,maxValue=31,options=null,readOnly=false,readable=true,unit=null,description=POWERUP_OFFDELAY_VALUE,info=null,paramsetType=MASTER,virtual=false,trigger=false] is outside of valid range, using default value for config.
2024-12-26 09:36:22.424 [WARN ] [ternal.handler.HomematicThingHandler] - Value for datapoint HmDatapoint[name=POWERUP_OFFDELAY_VALUE,value=101,defaultValue=0,type=INTEGER,minValue=0,maxValue=31,options=null,readOnly=false,readable=true,unit=null,description=POWERUP_OFFDELAY_VALUE,info=null,paramsetType=MASTER,virtual=false,trigger=false] is outside of valid range, using default value for config.
2024-12-26 09:36:29.846 [INFO ] [e.automation.internal.RuleEngineImpl] - Rule engine started.
2024-12-26 09:36:33.739 [INFO ] [ort.loader.AbstractScriptFileWatcher] - (Re-)Loading script '/etc/openhab/automation/js/_raffstores.js'
2024-12-26 09:36:33.758 [INFO ] [openhab.event.StartlevelEvent       ] - Startlevel '50' reached.
2024-12-26 09:36:33.776 [INFO ] [openhab.event.StartlevelEvent       ] - Startlevel '70' reached.
2024-12-26 09:36:38.819 [INFO ] [openhab.event.StartlevelEvent       ] - Startlevel '80' reached.
2024-12-26 09:36:38.833 [INFO ] [openhab.event.StartlevelEvent       ] - Startlevel '100' reached.
2024-12-26 09:36:39.521 [INFO ] [ort.loader.AbstractScriptFileWatcher] - (Re-)Loading script '/etc/openhab/automation/js/utils/checkItemsInitialized.js'
2024-12-26 09:36:41.832 [INFO ] [ort.loader.AbstractScriptFileWatcher] - (Re-)Loading script '/etc/openhab/automation/js/rules__kontrollzentrum.js'
2024-12-26 09:36:43.689 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules__kontrollzentrum #001 Set Kontrollzentrum defaults
2024-12-26 09:36:44.078 [INFO ] [cript.file.rules__kontrollzentrum.js] - Reached StartLevel 100 and starting --- [#001 Set Kontrollzentrum defaults]
2024-12-26 09:36:44.142 [INFO ] [cript.file.rules__kontrollzentrum.js] - (1): WarmwasserModusStandard set to 1 --- [#001 Set Kontrollzentrum defaults]
2024-12-26 09:36:44.161 [INFO ] [cript.file.rules__kontrollzentrum.js] - (2): WarmwasserModusAus set to 0 --- [#001 Set Kontrollzentrum defaults]
2024-12-26 09:36:44.172 [INFO ] [cript.file.rules__kontrollzentrum.js] - (3): WarmwasserTempNormal set to 40 --- [#001 Set Kontrollzentrum defaults]
2024-12-26 09:36:44.183 [INFO ] [cript.file.rules__kontrollzentrum.js] - (4): WarmwasserTempAbgesenkt set to 37 --- [#001 Set Kontrollzentrum defaults]
2024-12-26 09:36:44.194 [INFO ] [cript.file.rules__kontrollzentrum.js] - (5): WarmwasserTempErhoeht set to 45 --- [#001 Set Kontrollzentrum defaults]
2024-12-26 09:36:44.204 [INFO ] [cript.file.rules__kontrollzentrum.js] - (6): WarmwasserTempMinimum set to 15 --- [#001 Set Kontrollzentrum defaults]
2024-12-26 09:36:44.215 [INFO ] [cript.file.rules__kontrollzentrum.js] - (7): HeizmodusWinterNormal set to 4 --- [#001 Set Kontrollzentrum defaults]
2024-12-26 09:36:44.227 [INFO ] [cript.file.rules__kontrollzentrum.js] - (8): HeizmodusWinterAbgesenkt set to 5 --- [#001 Set Kontrollzentrum defaults]
2024-12-26 09:36:44.238 [INFO ] [cript.file.rules__kontrollzentrum.js] - (9): HeizungWinterZieltemp set to 21.5 --- [#001 Set Kontrollzentrum defaults]
2024-12-26 09:36:44.250 [INFO ] [cript.file.rules__kontrollzentrum.js] - (10): KuehlmodusSommerNormal set to 8 --- [#001 Set Kontrollzentrum defaults]
2024-12-26 09:36:44.261 [INFO ] [cript.file.rules__kontrollzentrum.js] - (11): KuehlungSommerZieltemp set to 17 --- [#001 Set Kontrollzentrum defaults]
2024-12-26 09:36:44.272 [INFO ] [cript.file.rules__kontrollzentrum.js] - (12): HeizmodusAus set to 0 --- [#001 Set Kontrollzentrum defaults]
2024-12-26 09:36:44.284 [INFO ] [cript.file.rules__kontrollzentrum.js] - (13): PresenceOverride set to OFF --- [#001 Set Kontrollzentrum defaults]
2024-12-26 09:36:44.335 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules__kontrollzentrum #002 Control Things offline
2024-12-26 09:36:44.359 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules__kontrollzentrum #003 Startup Init
2024-12-26 09:36:44.457 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules__kontrollzentrum #004 Regular refresh states
2024-12-26 09:36:44.470 [INFO ] [ort.loader.AbstractScriptFileWatcher] - (Re-)Loading script '/etc/openhab/automation/js/rules_electricity.js'
2024-12-26 09:36:45.635 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_electricity #001 Stromverbrauch pro Jahr
2024-12-26 09:36:45.694 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_electricity #004 Strom calculated items
2024-12-26 09:36:45.747 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_electricity #005 Strom calculated time period items
2024-12-26 09:36:45.774 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_electricity #007 Query PV Forecast
2024-12-26 09:36:45.792 [INFO ] [ort.loader.AbstractScriptFileWatcher] - (Re-)Loading script '/etc/openhab/automation/js/rules_hausautomatik.js'
2024-12-26 09:36:47.213 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #001 Sonos auto off
2024-12-26 09:36:47.246 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #002 Sonos Philipp Repeat off
2024-12-26 09:36:47.279 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #003 Sonos auto on
2024-12-26 09:36:47.313 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #004 Raffstores Kinder runter
2024-12-26 09:36:47.347 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #005 Raffstores Kinder rauf
2024-12-26 09:36:47.476 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #006 Couchlicht, Treppenhaus oben und unten an
2024-12-26 09:36:47.516 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #007 Lichterkette und Stehlampe oben an
2024-12-26 09:36:47.547 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #008 Nachts alle Lichter aus, Markisen rein, BĂŒro aus
2024-12-26 09:36:47.575 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #009 Sommermodus fĂŒr die SĂŒdfenster
2024-12-26 09:36:47.596 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #010 Sommermodus fĂŒr die Westfenster
2024-12-26 09:36:47.619 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #011 Sommermodus BĂŒro Kai
2024-12-26 09:36:47.643 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #012 Sommermodus Fenster Dach auf
2024-12-26 09:36:47.670 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #013 Sommermodus Fenster Dach zu
2024-12-26 09:36:47.693 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #014 Niemand mehr zuhause
2024-12-26 09:36:47.719 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #015 Jemand nach Hause zurĂŒckgekommen
2024-12-26 09:36:47.745 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #016 Alarmanlage abends an
2024-12-26 09:36:47.766 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #017 Alarmanlage morgends aus
2024-12-26 09:36:47.789 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #018 Presence Logging
2024-12-26 09:36:47.812 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #019 Bewegungsmelder KĂŒchentĂŒr
2024-12-26 09:36:47.833 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_hausautomatik #020 Ventilatoren Clara Schrank
2024-12-26 09:36:47.845 [INFO ] [ort.loader.AbstractScriptFileWatcher] - (Re-)Loading script '/etc/openhab/automation/js/rules_heizung.js'
2024-12-26 09:36:48.956 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_heizung #001 Heizungssteuerung
2024-12-26 09:36:48.990 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_heizung #002 Alle Heizregler steuern
2024-12-26 09:36:49.012 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_heizung #003 Heizung berechnete Zeitwerte
2024-12-26 09:36:49.034 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_heizung #004 Warmwasser opportunistische PV Steuerung
2024-12-26 09:36:49.056 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_heizung #005 Heizung opportunistische PV Steuerung
2024-12-26 09:36:49.084 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_heizung #006 Warmwasser Presets umsetzen
2024-12-26 09:36:49.109 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_heizung #007 Set Wohnzimmertemperatur
2024-12-26 09:36:49.132 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_heizung #009 Shelly TRV Virtual Relais
2024-12-26 09:36:49.152 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_heizung #010 Temperatur Alarme
2024-12-26 09:36:49.229 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_heizung #011 Heizregler beobachten und timestampen
2024-12-26 09:36:49.282 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_heizung #012 Thermostate Maintenance - regelmĂ€ĂŸig bewegen
2024-12-26 09:36:49.305 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_heizung #013 Catch Thermostate in Maintenance Mode
2024-12-26 09:36:49.315 [INFO ] [ort.loader.AbstractScriptFileWatcher] - (Re-)Loading script '/etc/openhab/automation/js/rules_licht.js'
2024-12-26 09:36:49.978 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_licht #001 Bodenleuchte Wohnzimmer Gesamtdimmer Aktion
2024-12-26 09:36:50.012 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_licht #002 Bodenleuchte Wohnzimmer Gesamtdimmer Level setzen
2024-12-26 09:36:50.042 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_licht #003 Gartenschuppen BWM Counter
2024-12-26 09:36:50.066 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_licht #004 HaustĂŒr BWM Counter
2024-12-26 09:36:50.088 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_licht #005 Licht calculated time period items
2024-12-26 09:36:50.114 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_licht #006 Gartenhaus Licht virtuellen Schalter setzen
2024-12-26 09:36:50.140 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_licht #007 Gartenhaus Licht virtuellen Schalter empfangen und umsetzen
2024-12-26 09:36:50.152 [INFO ] [ort.loader.AbstractScriptFileWatcher] - (Re-)Loading script '/etc/openhab/automation/js/rules_misc.js'
2024-12-26 09:36:50.773 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_misc #001 Calculate water counter increments
2024-12-26 09:36:50.800 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_misc #002 Calculate water consumption 24h/30d
2024-12-26 09:36:50.825 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_misc #003 Updates percentage value of Zisterne water level
2024-12-26 09:36:50.843 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_misc #004 Restart OH
2024-12-26 09:36:50.864 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_misc #005 Reboot Raspberry Pi
2024-12-26 09:36:50.875 [INFO ] [ort.loader.AbstractScriptFileWatcher] - (Re-)Loading script '/etc/openhab/automation/js/rules_mqtt.js'
2024-12-26 09:36:51.598 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS mqtt #001 check ebusd is running and has signal
2024-12-26 09:36:51.622 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS mqtt #002 checks triggering updating ebus polling
2024-12-26 09:36:51.644 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS mqtt #003 Increment the heatpump Pumpe / Flamme counters
2024-12-26 09:36:51.666 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS mqtt #004 Increment the Cycle counter
2024-12-26 09:36:51.692 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS mqtt #005 Ochsner mqtt item update
2024-12-26 09:36:51.712 [INFO ] [ort.loader.AbstractScriptFileWatcher] - (Re-)Loading script '/etc/openhab/automation/js/rules_raffstoresetc.js'
2024-12-26 09:36:52.196 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_raffstoresetc #001 Raffstore Markisen (Homematic) Presets Logging to logfile
2024-12-26 09:36:52.219 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_raffstoresetc #002 Raffstores (Homematic) identify Preset
2024-12-26 09:36:52.247 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_raffstoresetc #003 Scan raffstores (Homematic) from refresh states
2024-12-26 09:36:52.269 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_raffstoresetc #004 Action raffstore preset commands
2024-12-26 09:36:52.291 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_raffstoresetc #005 Markisen Switches Actions
2024-12-26 09:36:52.312 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_raffstoresetc #006 Markisen Switches State Updates
2024-12-26 09:36:52.324 [INFO ] [ort.loader.AbstractScriptFileWatcher] - (Re-)Loading script '/etc/openhab/automation/js/rules_schalter.js'
2024-12-26 09:36:52.770 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_schalter #001 Schalter Arbeitszimmer
2024-12-26 09:36:52.790 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_schalter #002 Klingel HaustĂŒr
2024-12-26 09:36:52.809 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_schalter #003 Liebe Kinder Clara
2024-12-26 09:36:52.828 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_schalter #004 Liebe Kinder Philipp
2024-12-26 09:36:52.852 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_schalter #005 Virtueller Schalter an Fenster DG auf/zu
2024-12-26 09:36:52.880 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_schalter #006 Fenster DG auf/zu an virtueller Schalter
2024-12-26 09:36:52.908 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_schalter #007 Switch Clara Ventilatoren
2024-12-26 09:36:52.919 [INFO ] [ort.loader.AbstractScriptFileWatcher] - (Re-)Loading script '/etc/openhab/automation/js/rules_testing.js'
2024-12-26 09:36:53.259 [INFO ] [ort.loader.AbstractScriptFileWatcher] - (Re-)Loading script '/etc/openhab/automation/js/rules_wetter.js'
2024-12-26 09:36:53.563 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_wetter #002 Set Außentemperatur
2024-12-26 09:36:53.584 [INFO ] [.openhab.automation.openhab-js.rules] - Adding rule: JS rules_wetter #003 Check weather station running
2024-12-26 09:36:53.594 [INFO ] [ort.loader.AbstractScriptFileWatcher] - (Re-)Loading script '/etc/openhab/automation/js/data/thermostats.js'
2024-12-26 09:36:53.880 [INFO ] [ort.loader.AbstractScriptFileWatcher] - (Re-)Loading script '/etc/openhab/automation/js/utils/utils.js'
2024-12-26 09:37:12.658 [INFO ] [automation.script.file.rules_mqtt.js] - ebus polling triggered. (Current: 7732823, Previous: 0) --- [#002 checks triggering updating ebus polling]
2024-12-26 09:37:12.717 [INFO ] [automation.script.file.rules_mqtt.js] - ebus polling was triggered by OchsnerUpdatePolling --- [#005 Ochsner mqtt item update]
2024-12-26 09:37:55.806 [WARN ] [core.thing.internal.ThingManagerImpl] - Channel types or config descriptions for thing 'avmfritz:FRITZ_DECT_200:192_168_178_1:087610387976' are missing in the respective registry for more than 120s. In case it does not happen immediately after an upgrade, it should be fixed in the binding.
2024-12-26 09:37:55.810 [WARN ] [core.thing.internal.ThingManagerImpl] - Channel types or config descriptions for thing 'avmfritz:FRITZ_DECT_210:192_168_178_1:116570069763' are missing in the respective registry for more than 120s. In case it does not happen immediately after an upgrade, it should be fixed in the binding.
2024-12-26 09:37:55.812 [WARN ] [core.thing.internal.ThingManagerImpl] - Channel types or config descriptions for thing 'avmfritz:FRITZ_DECT_210:192_168_178_1:116570077336' are missing in the respective registry for more than 120s. In case it does not happen immediately after an upgrade, it should be fixed in the binding.
205

Hello,

after updating OH from 4.2.1 to 4.3 the items of a page won’t be updated in my installation. I have already created a post in the topic of the IP camera binding (IpCamera: New IP Camera Binding - #2985 by andy294), cause I can reprdoduce it, after opening a page with IP cams. But maybe this is only a side effect and somebody of this topic has an idea, what the reason could be.

206

Hi all,
update from 4.2.3 to 4.3.0 went quite well. As expected my MQTT things showed up as new things since I use homeassistant autodetect. I deleted the old things and added new things as advised.
There is a glitch with the channels. As stated before channels first disappear from UI but come back after while. For any reason, all channels seem to be there twice:

image
image1132×428 30.5 KB

Channel name is there “raw” and extended by sensor type, e.g. battery_state and battery_state_sensor. When I look in the code for the thing, the topics are listed correct but the channels exist twice. I have no idea for the reason.

UID: mqtt:homeassistant:mosquitto:zigbee2mqtt_5F0xa4c1386eb3be521a
label: Smoke_AZ
thingTypeUID: mqtt:homeassistant_zigbee2mqtt_5F0xa4c1386eb3be521a
configuration:
  topics:
    - binary_sensor/0xa4c1386eb3be521a/smoke
    - binary_sensor/0xa4c1386eb3be521a/tamper
    - sensor/0xa4c1386eb3be521a/battery_state
    - sensor/0xa4c1386eb3be521a/last_seen
    - sensor/0xa4c1386eb3be521a/linkquality
  basetopic: homeassistant
bridgeUID: mqtt:broker:mosquitto
channels:
  - id: battery_state
    channelTypeUID: mqtt:ha-string
    label: Battery state
    configuration:
      component: sensor
      config:
        - '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{
          value_json.state
          }}"},{"topic":"zigbee2mqtt/Smoke_AZ/availability","value_template":"{{
          value_json.state
          }}"}],"availability_mode":"all","device":{"identifiers":["zigbee2mqtt_0xa4c1386eb3be521a"],"manufacturer":"Tuya","model":"Smoke
          sensor
          (TS0601_smoke_6)","name":"Smoke_AZ","via_device":"zigbee2mqtt_bridge_0x00124b002c3a0d4d"},"enabled_by_default":true,"name":"Battery
          state","object_id":"smoke_az_battery_state","origin":{"name":"Zigbee2MQTT","sw":"1.42.0","url":"https://www.zigbee2mqtt.io"},"state_topic":"zigbee2mqtt/Smoke_AZ","unique_id":"0xa4c1386eb3be521a_battery_state_zigbee2mqtt","value_template":"{{
          value_json.battery_state }}"}'
      nodeid: "0xa4c1386eb3be521a"
      objectid:
        - battery_state
  - id: battery_state_sensor
    channelTypeUID: mqtt:ha-string
    label: Battery state
    configuration:
      component: sensor
      config:
        - '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{
          value_json.state
          }}"},{"topic":"zigbee2mqtt/Smoke_AZ/availability","value_template":"{{
          value_json.state
          }}"}],"availability_mode":"all","device":{"identifiers":["zigbee2mqtt_0xa4c1386eb3be521a"],"manufacturer":"Tuya","model":"Smoke
          sensor
          (TS0601_smoke_6)","name":"Smoke_AZ","via_device":"zigbee2mqtt_bridge_0x00124b002c3a0d4d"},"enabled_by_default":true,"name":"Battery
          state","object_id":"smoke_az_battery_state","origin":{"name":"Zigbee2MQTT","sw":"1.42.0","url":"https://www.zigbee2mqtt.io"},"state_topic":"zigbee2mqtt/Smoke_AZ","unique_id":"0xa4c1386eb3be521a_battery_state_zigbee2mqtt","value_template":"{{
          value_json.battery_state }}"}'
      nodeid: "0xa4c1386eb3be521a"
      objectid:
        - battery_state
.... (more channels)

Any ideas?

Thanks

207

Hmm
 that looks like it’s hit the code for duplicate components (things that have the same name, but of different types), but for some reason it left the “base” channel as well. I’ve seen this once, and disabling and re-enabling the thing was enough to get the duplicate channels to disappear. Have you tried that, and/or restarted openHAB?

208

Hi, can someone running 4.3 confirm if this issue still exist?
https://github.com/openhab/openhab-core/issues/4447

If sharedcache works for dsl .rules files

You can find the test rule here for a quick test

209

They don’t currently work in file based rulesdsl in 4.3.0

210

Thanks for checking

211

Same here. But also with HomeAssistant Mqtt-Things provided with zigbee2mqtt.

212

Thank you for the quick fix!

213
1 Like
215

restart

217

Moderator’s request:
Folks, this thread is to help with issues that all openHAB users have or might have because of changes that the new openHAB release 4.3 introduced.

Please open your very own thread when you have an issue with updating to 4.3 and refrain from posting in this thread unless you think it might be of benefit to others such as when you found a solution or when it helps to identify common issues with those changes 4.3 introduced.
Thank you.

2 Likes
218

I feel addressed, please excuse me.

219

Can someone help me resolve this warning after upgrading to 4.3 Stable?

pi@openhabian:~ $ openhab-cli console

SLF4J(W): No SLF4J providers were found.
SLF4J(W): Defaulting to no-operation (NOP) logger implementation
SLF4J(W): See SLF4J Error Codes for further details.
SLF4J(W): Class path contains SLF4J bindings targeting slf4j-api versions 1.7.x or earlier.
SLF4J(W): Ignoring binding found at [jar:file:/usr/share/openhab/runtime/system/org/apache/karaf/org.apache.karaf.client/4.4.6/org.apache.karaf.client-4.4.6.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J(W): See SLF4J Error Codes for an explanation.
Logging in as openhab
Password:

Here’s the write up about it, no clue how to resolve it.

This message is a warning and not an error. It is reported when no SLF4J providers could be found on the class path. SLF4J requires a logging provider because it is a logging API and not an logging implementation. Placing one (and only one) of the many available providers such as slf4j-nop.jar slf4j-simple.jar , slf4j-reload4j.jar , slf4j-jdk14.jar or logback-classic.jar on the class path will solve the problem.

220

I started OH several times, sometimes additional channels disappear but come back later. Linking items to channels and saving changes on thing will bring back additional channels.

221

Tested 4.3 and I really like the new zigbee2mqtt, zwavejs integration. It works much better than my transforms which was a bit buggy. Good work!

222

This is a known problem and an issue is open for it. It’s not a fatal error and everything else should work.

1 Like
223

This solution to increase the HABPanel speed back with 3.x that worked with first 4.3.x snapshot stopped working now with 4.3 Stable.

Reason is known from the post below it, not sure @arctus will fix or not. It’s very important to me with 2600+ items, it really helped with HABPanel display performance across 4 tablets.

[SOLVED] HABPanel sluggish - Apps & Services / HABPanel - openHAB Community

Best, Jay

224

If you are using openhab behind an nginx proxy, maybe your problem is related to the nginx configuration.

I had the same problem and described a solution here:

Openhab 4.x and log viewer behind nginx proxy

225

I think, I have found the solution for my problem.
On the page layout where I Configure Grid Layout, I have checked the mark Scaling to ON.
After setting this button to OFF, the refresh of the page in the browser is working without problems.