Openhab won't start. Message "No service was found."

aleksey.kurchavy · June 27, 2025, 12:00pm

Platform information:
- Hardware: 2x AMD G-T56N Processor (x64) / 4GB RAM / 630GB HDD
- OS: Debian GNU/Linux 12 (bookworm)
- Java Runtime Environment: OpenJDK Runtime Environment Zulu17.46+19-CA (build 17.0.9+8-LTS)
- openHAB version: 4.3.5
Issue of the topic: Hi all, After rebooting my computer, Openhab stopped starting. When I open the ip address I see a blank screen and the message “No service was found.” Tried clearing cache and restoring backup - it didn’t help. Before this openhab worked for about three years without any problems.
Please post configurations (if applicable):
- Items configuration related to the issue
- Sitemap configuration related to the issue
- Rules code related to the issue
- Services configuration related to the issue
If logs where generated please post these here using code fences:

openhab.log

2025-06-27 14:15:57.727 [INFO ] [raf.deployer.features.osgi.Activator] - Deployment finished. Registering FeatureDeploymentListener
2025-06-27 14:15:59.932 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.jaas.command/4.4.6
2025-06-27 14:15:59.958 [INFO ] [ll.impl.action.osgi.CommandExtension] - Updating commands for bundle org.apache.karaf.jaas.command/4.4.6
2025-06-27 14:15:59.966 [INFO ] [ll.impl.action.osgi.CommandExtension] - Updating commands for bundle org.apache.karaf.jaas.command/4.4.6
2025-06-27 14:16:00.020 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.shell.commands/4.4.6
2025-06-27 14:16:00.024 [INFO ] [ll.impl.action.osgi.CommandExtension] - Updating commands for bundle org.apache.karaf.shell.commands/4.4.6
2025-06-27 14:16:00.031 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.deployer.kar/4.4.6
2025-06-27 14:16:00.046 [INFO ] [af.shell.impl.console.osgi.Activator] - Not starting local console. To activate set karaf.startLocalConsole=true
2025-06-27 14:16:00.100 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.wrapper.core/4.4.6
2025-06-27 14:16:00.223 [INFO ] [ROOT                                ] - bundle org.apache.felix.scr:2.2.6 (74) Starting with globalExtender setting: false
2025-06-27 14:16:00.243 [INFO ] [ROOT                                ] - bundle org.apache.felix.scr:2.2.6 (74)  Version = 2.2.6
2025-06-27 14:16:00.413 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.bundle.core/4.4.6
2025-06-27 14:16:00.467 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.config.command/4.4.6
2025-06-27 14:16:01.301 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.diagnostic.core/4.4.6
2025-06-27 14:16:01.363 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.features.command/4.4.6
2025-06-27 14:16:01.438 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.instance.core/4.4.6
2025-06-27 14:16:01.480 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.kar.core/4.4.6
2025-06-27 14:16:01.545 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.log.core/4.4.6
2025-06-27 14:16:01.592 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.package.core/4.4.6
2025-06-27 14:16:01.843 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.service.core/4.4.6
2025-06-27 14:16:02.013 [INFO ] [ll.impl.action.osgi.CommandExtension] - Command registration delayed for bundle org.apache.karaf.shell.ssh/4.4.6. Missing service: [org.apache.sshd.server.SshServer]
2025-06-27 14:16:02.078 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.system.core/4.4.6
2025-06-27 14:16:02.267 [INFO ] [tender.whiteboard.internal.Activator] - Starting Pax Web Whiteboard Extender
2025-06-27 14:16:02.645 [INFO ] [org.eclipse.jetty.util.log          ] - Logging initialized @19474ms to org.eclipse.jetty.util.log.Slf4jLog
2025-06-27 14:16:02.790 [INFO ] [j.pax.web.service.internal.Activator] - Scheduling Pax Web reconfiguration because configuration has changed
2025-06-27 14:16:02.803 [INFO ] [j.pax.web.service.internal.Activator] - Scheduling Pax Web reconfiguration because ServerControllerFactory has been registered
2025-06-27 14:16:02.806 [INFO ] [j.pax.web.service.internal.Activator] - EventAdmin support enabled, WAB events will be posted to EventAdmin topics.
2025-06-27 14:16:02.818 [INFO ] [j.pax.web.service.internal.Activator] - Pax Web Runtime started
2025-06-27 14:16:03.264 [INFO ] [j.pax.web.service.internal.Activator] - Configuring server controller org.ops4j.pax.web.service.jetty.internal.JettyServerController
2025-06-27 14:16:03.275 [INFO ] [jetty.internal.JettyServerController] - Configuring JettyServerController{configuration=33343aa7-7a14-4784-8692-cbe8e559c120,state=UNCONFIGURED}
2025-06-27 14:16:03.280 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Creating Jetty server instance using configuration properties.
2025-06-27 14:16:03.403 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Processing Jetty configuration from files: [/usr/share/openhab/runtime/etc/jetty.xml]
2025-06-27 14:16:03.591 [INFO ] [org.apache.cxf.bus.osgi.CXFActivator] - Adding the extensions from bundle org.apache.cxf.cxf-rt-frontend-jaxrs (69) [org.apache.cxf.jaxrs.JAXRSBindingFactory]
2025-06-27 14:16:03.607 [INFO ] [org.apache.cxf.bus.osgi.CXFActivator] - Adding the extensions from bundle org.apache.cxf.cxf-rt-rs-sse (71) [org.apache.cxf.transport.sse.SseProvidersExtension]
2025-06-27 14:16:03.621 [INFO ] [org.apache.cxf.bus.osgi.CXFActivator] - Adding the extensions from bundle org.apache.cxf.cxf-rt-transports-http (73) [org.apache.cxf.transport.http.HTTPTransportFactory, org.apache.cxf.transport.http.HTTPWSDLExtensionLoader, org.apache.cxf.transport.http.policy.HTTPClientAssertionBuilder, org.apache.cxf.transport.http.policy.HTTPServerAssertionBuilder, org.apache.cxf.transport.http.policy.NoOpPolicyInterceptorProvider]
2025-06-27 14:16:03.942 [INFO ] [blueprint.NamespaceHandlerRegisterer] - Aries Blueprint packages not available. So namespaces will not be registered
2025-06-27 14:16:04.026 [INFO ] [blueprint.NamespaceHandlerRegisterer] - Aries Blueprint packages not available. So namespaces will not be registered
2025-06-27 14:16:04.413 [INFO ] [blueprint.NamespaceHandlerRegisterer] - Aries Blueprint packages not available. So namespaces will not be registered
2025-06-27 14:16:04.482 [INFO ] [rd.activator.CxfJaxrsBundleActivator] - Registered RuntimeDelegate
2025-06-27 14:16:04.488 [INFO ] [rd.activator.CxfJaxrsBundleActivator] - Registered ClientBuilder
2025-06-27 14:16:04.505 [INFO ] [rd.activator.CxfJaxrsBundleActivator] - Registered SseEventSourceFactory
2025-06-27 14:16:04.508 [INFO ] [rd.activator.CxfJaxrsBundleActivator] - Registered SseEventSource.Builder
2025-06-27 14:16:05.123 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Found configured connector "0.0.0.0:8443": 0.0.0.0:8443
2025-06-27 14:16:05.142 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Creating non secure connector for address 0.0.0.0:8080
2025-06-27 14:16:05.146 [INFO ] [.service.jetty.internal.JettyFactory] - HTTP/2 ClearText support available, adding "h2c" protocol support to default connector
2025-06-27 14:16:05.191 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider com.ctc.wstx.stax.WstxEventFactory of service javax.xml.stream.XMLEventFactory in bundle com.fasterxml.woodstox.woodstox-core
2025-06-27 14:16:05.195 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider com.ctc.wstx.stax.WstxInputFactory of service javax.xml.stream.XMLInputFactory in bundle com.fasterxml.woodstox.woodstox-core
2025-06-27 14:16:05.227 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider com.ctc.wstx.dtd.DTDSchemaFactory of service org.codehaus.stax2.validation.XMLValidationSchemaFactory in bundle com.fasterxml.woodstox.woodstox-core
2025-06-27 14:16:05.232 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider com.ctc.wstx.msv.RelaxNGSchemaFactory of service org.codehaus.stax2.validation.XMLValidationSchemaFactory in bundle com.fasterxml.woodstox.woodstox-core
2025-06-27 14:16:05.252 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider com.ctc.wstx.msv.W3CSchemaFactory of service org.codehaus.stax2.validation.XMLValidationSchemaFactory in bundle com.fasterxml.woodstox.woodstox-core
2025-06-27 14:16:05.262 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.shell.ssh/4.4.6
2025-06-27 14:16:05.264 [INFO ] [.service.jetty.internal.JettyFactory] - Default Jetty connector created: default@3c97713d{HTTP/1.1, (http/1.1, h2c)}{0.0.0.0:8080}
2025-06-27 14:16:05.268 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Using configured 0.0.0.0:8443@7e44cebf{SSL, (ssl, http/1.1)}{0.0.0.0:8443} as secure connector for address: 0.0.0.0:8443
2025-06-27 14:16:05.271 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider com.ctc.wstx.stax.WstxOutputFactory of service javax.xml.stream.XMLOutputFactory in bundle com.fasterxml.woodstox.woodstox-core
2025-06-27 14:16:05.288 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Eagerly starting Jetty thread pool QueuedThreadPool[qtp1807625501]@6bbe2d1d{STOPPED,2<=0<=50,i=0,r=-1,q=0}[NO_TRY]
2025-06-27 14:16:05.305 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider de.focus_shift.jollyday.jackson.JacksonConfigurationService of service de.focus_shift.jollyday.core.spi.ConfigurationService in bundle de.focus_shift.jollyday-jackson
2025-06-27 14:16:05.335 [INFO ] [.service.jetty.internal.JettyFactory] - Adding JMX support to Jetty server
2025-06-27 14:16:05.372 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider org.eclipse.jetty.alpn.java.client.JDK9ClientALPNProcessor of service org.eclipse.jetty.io.ssl.ALPNProcessor$Client in bundle org.eclipse.jetty.alpn.java.client
2025-06-27 14:16:05.400 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider org.eclipse.jetty.alpn.java.server.JDK9ServerALPNProcessor of service org.eclipse.jetty.io.ssl.ALPNProcessor$Server in bundle org.eclipse.jetty.alpn.java.server
2025-06-27 14:16:05.424 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider org.eclipse.jetty.http.Http1FieldPreEncoder of service org.eclipse.jetty.http.HttpFieldPreEncoder in bundle org.eclipse.jetty.http
2025-06-27 14:16:05.441 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider org.eclipse.jetty.http2.hpack.HpackFieldPreEncoder of service org.eclipse.jetty.http.HttpFieldPreEncoder in bundle org.eclipse.jetty.http2.hpack
2025-06-27 14:16:05.467 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider org.eclipse.jetty.security.openid.OpenIdAuthenticatorFactory of service org.eclipse.jetty.security.Authenticator$Factory in bundle org.eclipse.jetty.openid
2025-06-27 14:16:05.497 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider org.eclipse.jetty.websocket.common.extensions.identity.IdentityExtension of service org.eclipse.jetty.websocket.api.extensions.Extension in bundle org.eclipse.jetty.websocket.common
2025-06-27 14:16:05.506 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider org.eclipse.jetty.websocket.common.extensions.fragment.FragmentExtension of service org.eclipse.jetty.websocket.api.extensions.Extension in bundle org.eclipse.jetty.websocket.common
2025-06-27 14:16:05.512 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider org.eclipse.jetty.websocket.common.extensions.compress.PerMessageDeflateExtension of service org.eclipse.jetty.websocket.api.extensions.Extension in bundle org.eclipse.jetty.websocket.common
2025-06-27 14:16:05.524 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider org.eclipse.jetty.websocket.common.extensions.compress.DeflateFrameExtension of service org.eclipse.jetty.websocket.api.extensions.Extension in bundle org.eclipse.jetty.websocket.common
2025-06-27 14:16:05.528 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider org.eclipse.jetty.websocket.common.extensions.compress.XWebkitDeflateFrameExtension of service org.eclipse.jetty.websocket.api.extensions.Extension in bundle org.eclipse.jetty.websocket.common
2025-06-27 14:16:05.555 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider org.eclipse.jetty.websocket.jsr356.JettyClientContainerProvider of service javax.websocket.ContainerProvider in bundle org.eclipse.jetty.websocket.javax.websocket
2025-06-27 14:16:05.564 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider org.eclipse.jetty.websocket.jsr356.server.ContainerDefaultConfigurator of service javax.websocket.server.ServerEndpointConfig$Configurator in bundle org.eclipse.jetty.websocket.javax.websocket.server
2025-06-27 14:16:05.589 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider org.eclipse.jetty.websocket.jsr356.server.deploy.WebSocketServerContainerInitializer of service javax.servlet.ServletContainerInitializer in bundle org.eclipse.jetty.websocket.javax.websocket.server
2025-06-27 14:16:05.607 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider org.eclipse.jetty.websocket.server.NativeWebSocketServletContainerInitializer of service javax.servlet.ServletContainerInitializer in bundle org.eclipse.jetty.websocket.server
2025-06-27 14:16:05.652 [INFO ] [j.pax.web.service.internal.Activator] - Starting server controller org.ops4j.pax.web.service.jetty.internal.JettyServerController
2025-06-27 14:16:05.661 [INFO ] [jetty.internal.JettyServerController] - Starting JettyServerController{configuration=33343aa7-7a14-4784-8692-cbe8e559c120,state=STOPPED}
2025-06-27 14:16:05.663 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Starting Server@13a8b4a7{STOPPED}[9.4.54.v20240208]
2025-06-27 14:16:05.671 [INFO ] [org.eclipse.jetty.server.Server     ] - jetty-9.4.54.v20240208; built: 2024-02-08T19:42:39.027Z; git: cef3fbd6d736a21e7d541a5db490381d95a2047d; jvm 17.0.9+8-LTS
2025-06-27 14:16:05.711 [INFO ] [org.eclipse.jetty.server.session    ] - DefaultSessionIdManager workerName=node0
2025-06-27 14:16:05.722 [INFO ] [org.eclipse.jetty.server.session    ] - No SessionScavenger set, using defaults
2025-06-27 14:16:05.730 [INFO ] [org.eclipse.jetty.server.session    ] - node0 Scavenging every 600000ms
2025-06-27 14:16:05.889 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.event/4.4.6
2025-06-27 14:16:05.994 [INFO ] [.jetty.server.handler.ContextHandler] - Started o.e.j.s.h.ContextHandler@51627e36{/static,null,AVAILABLE}
2025-06-27 14:16:06.329 [INFO ] [pse.jetty.util.ssl.SslContextFactory] - x509=X509@35b3b2bb(mykey,h=[openhab.org],a=[],w=[]) for Server@7039397f[provider=null,keyStore=file:///var/lib/openhab/etc/keystore,trustStore=file:///var/lib/openhab/etc/keystore]
2025-06-27 14:16:06.679 [INFO ] [org.openhab.core.Activator          ] - Starting openHAB 4.3.5 (Release Build)
2025-06-27 14:16:06.766 [INFO ] [lipse.jetty.server.AbstractConnector] - Started 0.0.0.0:8443@7e44cebf{SSL, (ssl, http/1.1)}{0.0.0.0:8443}
2025-06-27 14:16:06.790 [INFO ] [lipse.jetty.server.AbstractConnector] - Started default@3c97713d{HTTP/1.1, (http/1.1, h2c)}{0.0.0.0:8080}
2025-06-27 14:16:06.792 [INFO ] [org.eclipse.jetty.server.Server     ] - Started @23671ms
2025-06-27 14:16:06.812 [INFO ] [j.pax.web.service.internal.Activator] - Registering HttpService factory
2025-06-27 14:16:06.838 [INFO ] [j.pax.web.service.internal.Activator] - Registering HttpServiceRuntime
2025-06-27 14:16:06.842 [INFO ] [rd.activator.CxfJaxrsBundleActivator] - created whiteboard from configuration: {service.pid=org.apache.aries.jax.rs.whiteboard.default}
2025-06-27 14:16:06.846 [INFO ] [internal.StoppableHttpServiceFactory] - Binding HTTP Service for bundle: [org.ops4j.pax.web.pax-web-extender-whiteboard_8.0.27 [230]]
2025-06-27 14:16:07.558 [INFO ] [internal.StoppableHttpServiceFactory] - Binding HTTP Service for bundle: [org.apache.aries.jax.rs.whiteboard_2.0.2 [65]]
2025-06-27 14:16:07.578 [INFO ] [internal.BundleWhiteboardApplication] - No matching target context(s) for Whiteboard element ServletModel{id=ServletModel-3,name='cxf-servlet',urlPatterns=[/*],contexts=[]}. Filter: (osgi.http.whiteboard.context.name=default). Element may be re-registered later, when matching context/s is/are registered.
2025-06-27 14:16:07.680 [INFO ] [ax.web.service.spi.model.ServerModel] - Created new ServletContextModel{id=ServletContextModel-4,contextPath='/'}
2025-06-27 14:16:07.694 [INFO ] [jetty.internal.JettyServerController] - Receiving Batch{"Registration of OsgiContextModel{WB,id=OCM-1,name='default',path='/',bundle=org.ops4j.pax.web.pax-web-extender-whiteboard,context=(supplier)}", size=2}
2025-06-27 14:16:07.696 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Creating new Jetty context for ServletContextModel{id=ServletContextModel-4,contextPath='/'}
2025-06-27 14:16:07.988 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Adding OsgiContextModel{WB,id=OCM-1,name='default',path='/',bundle=org.ops4j.pax.web.pax-web-extender-whiteboard,context=(supplier)} to o.o.p.w.s.j.i.PaxWebServletContextHandler@575b726{/,null,STOPPED}
2025-06-27 14:16:08.008 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Changing default OSGi context model for o.o.p.w.s.j.i.PaxWebServletContextHandler@575b726{/,null,STOPPED}
2025-06-27 14:16:08.046 [INFO ] [.service.internal.HttpServiceEnabled] - Registering ServletModel{id=ServletModel-3,name='cxf-servlet',urlPatterns=[/*],contexts=[{WB,OCM-1,default,/}]}
2025-06-27 14:16:08.051 [INFO ] [jetty.internal.JettyServerController] - Receiving Batch{"Registration of ServletModel{id=ServletModel-3,name='cxf-servlet',urlPatterns=[/*],contexts=[{WB,OCM-1,default,/}]}", size=1}
2025-06-27 14:16:08.055 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Adding servlet ServletModel{id=ServletModel-3,name='cxf-servlet',urlPatterns=[/*],contexts=[{WB,OCM-1,default,/}]}
2025-06-27 14:16:08.095 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Starting Jetty context "/" with default Osgi Context OsgiContextModel{WB,id=OCM-1,name='default',path='/',bundle=org.ops4j.pax.web.pax-web-extender-whiteboard,context=(supplier)}
2025-06-27 14:16:08.214 [INFO ] [.jetty.server.handler.ContextHandler] - Started o.o.p.w.s.j.i.PaxWebServletContextHandler@575b726{/,null,AVAILABLE}
2025-06-27 14:16:08.217 [INFO ] [rvice.spi.servlet.OsgiServletContext] - Registering OsgiServletContext{model=OsgiContextModel{WB,id=OCM-1,name='default',path='/',bundle=org.ops4j.pax.web.pax-web-extender-whiteboard,context=(supplier)}} as OSGi service for "/" context path
2025-06-27 14:16:08.336 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Time zone set to '******'.
2025-06-27 14:16:08.353 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Location set to '******'.
2025-06-27 14:16:08.355 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Measurement system set to 'SI'.
2025-06-27 14:16:13.159 [INFO ] [internal.StoppableHttpServiceFactory] - Binding HTTP Service for bundle: [org.openhab.core.audio_4.3.5 [160]]
2025-06-27 14:16:13.169 [INFO ] [.service.internal.HttpServiceEnabled] - Registering ServletModel{id=ServletModel-6,name='/audio',urlPatterns=[/audio/*],contexts=[{WB,OCM-1,default,/}]}
2025-06-27 14:16:13.171 [INFO ] [jetty.internal.JettyServerController] - Receiving Batch{"Registration of ServletModel{id=ServletModel-6,name='/audio',urlPatterns=[/audio/*],contexts=[{WB,OCM-1,default,/}]}", size=1}
2025-06-27 14:16:13.174 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Adding servlet ServletModel{id=ServletModel-6,name='/audio',urlPatterns=[/audio/*],contexts=[{WB,OCM-1,default,/}]}
2025-06-27 14:16:16.559 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.openhab.core.io.console.karaf/4.3.5
2025-06-27 14:16:16.731 [INFO ] [internal.StoppableHttpServiceFactory] - Binding HTTP Service for bundle: [org.openhab.core.io.http_4.3.5 [178]]
2025-06-27 14:16:16.747 [INFO ] [jetty.internal.JettyServerController] - Receiving Batch{"Registration of OsgiContextModel{WB,id=OCM-7,name='default',path='/',bundle=org.openhab.core.io.http,ref={org.osgi.service.http.HttpContext, org.openhab.core.io.http.WrappingHttpContext}={service.id=281, osgi.http.whiteboard.context.name=oh-dfl-http-ctx, service.bundleid=178, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.io.http.internal.OpenHABHttpContext, osgi.http.whiteboard.context.path=/, component.id=157}}", size=1}
2025-06-27 14:16:16.749 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Adding OsgiContextModel{WB,id=OCM-7,name='default',path='/',bundle=org.openhab.core.io.http,ref={org.osgi.service.http.HttpContext, org.openhab.core.io.http.WrappingHttpContext}={service.id=281, osgi.http.whiteboard.context.name=oh-dfl-http-ctx, service.bundleid=178, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.io.http.internal.OpenHABHttpContext, osgi.http.whiteboard.context.path=/, component.id=157}} to o.o.p.w.s.j.i.PaxWebServletContextHandler@575b726{/,null,AVAILABLE}
2025-06-27 14:16:16.862 [INFO ] [internal.StoppableHttpServiceFactory] - Binding HTTP Service for bundle: [org.openhab.core.io.http.auth_4.3.5 [179]]
2025-06-27 14:16:16.869 [INFO ] [.service.internal.HttpServiceEnabled] - Registering ServletModel{id=ServletModel-9,name='/auth',urlPatterns=[/auth/*],contexts=[{WB,OCM-1,default,/}]}
2025-06-27 14:16:16.871 [INFO ] [jetty.internal.JettyServerController] - Receiving Batch{"Registration of ServletModel{id=ServletModel-9,name='/auth',urlPatterns=[/auth/*],contexts=[{WB,OCM-1,default,/}]}", size=1}
2025-06-27 14:16:16.874 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Adding servlet ServletModel{id=ServletModel-9,name='/auth',urlPatterns=[/auth/*],contexts=[{WB,OCM-1,default,/}]}
2025-06-27 14:16:16.896 [INFO ] [.service.internal.HttpServiceEnabled] - Registering ServletModel{id=ServletModel-10,name='/changePassword',urlPatterns=[/changePassword/*],contexts=[{WB,OCM-1,default,/}]}
2025-06-27 14:16:16.898 [INFO ] [jetty.internal.JettyServerController] - Receiving Batch{"Registration of ServletModel{id=ServletModel-10,name='/changePassword',urlPatterns=[/changePassword/*],contexts=[{WB,OCM-1,default,/}]}", size=1}
2025-06-27 14:16:16.901 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Adding servlet ServletModel{id=ServletModel-10,name='/changePassword',urlPatterns=[/changePassword/*],contexts=[{WB,OCM-1,default,/}]}
2025-06-27 14:16:16.936 [INFO ] [.service.internal.HttpServiceEnabled] - Registering ServletModel{id=ServletModel-11,name='/createApiToken',urlPatterns=[/createApiToken/*],contexts=[{WB,OCM-1,default,/}]}
2025-06-27 14:16:16.938 [INFO ] [jetty.internal.JettyServerController] - Receiving Batch{"Registration of ServletModel{id=ServletModel-11,name='/createApiToken',urlPatterns=[/createApiToken/*],contexts=[{WB,OCM-1,default,/}]}", size=1}
2025-06-27 14:16:16.940 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Adding servlet ServletModel{id=ServletModel-11,name='/createApiToken',urlPatterns=[/createApiToken/*],contexts=[{WB,OCM-1,default,/}]}
2025-06-27 14:16:17.310 [INFO ] [ax.web.service.spi.model.ServerModel] - Created new ServletContextModel{id=ServletContextModel-14,contextPath='/rest'}
2025-06-27 14:16:17.312 [INFO ] [jetty.internal.JettyServerController] - Receiving Batch{"Registration of OsgiContextModel{WB,id=OCM-12,name='context.foropenhab',path='/rest',bundle=org.apache.aries.jax.rs.whiteboard,ref={org.osgi.service.http.context.ServletContextHelper}={original.service.bundleid=183, osgi.jaxrs.application.base=rest, service.id=297, service.bundleid=65, service.scope=singleton, servlet.init.hide-service-list-page=true, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.io.rest.internal.RESTApplicationImpl, component.id=170, original.service.id=296, osgi.http.whiteboard.context.name=context.foropenhab, osgi.jaxrs.name=openhab, osgi.http.whiteboard.target=(osgi.http.endpoint=*), service.pid=org.apache.aries.jax.rs.whiteboard.default, osgi.http.whiteboard.context.path=/rest}}", size=2}
2025-06-27 14:16:17.314 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Creating new Jetty context for ServletContextModel{id=ServletContextModel-14,contextPath='/rest'}
2025-06-27 14:16:17.321 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Adding OsgiContextModel{WB,id=OCM-12,name='context.foropenhab',path='/rest',bundle=org.apache.aries.jax.rs.whiteboard,ref={org.osgi.service.http.context.ServletContextHelper}={original.service.bundleid=183, osgi.jaxrs.application.base=rest, service.id=297, service.bundleid=65, service.scope=singleton, servlet.init.hide-service-list-page=true, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.io.rest.internal.RESTApplicationImpl, component.id=170, original.service.id=296, osgi.http.whiteboard.context.name=context.foropenhab, osgi.jaxrs.name=openhab, osgi.http.whiteboard.target=(osgi.http.endpoint=*), service.pid=org.apache.aries.jax.rs.whiteboard.default, osgi.http.whiteboard.context.path=/rest}} to o.o.p.w.s.j.i.PaxWebServletContextHandler@556e0a73{/rest,null,STOPPED}
2025-06-27 14:16:17.330 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Changing default OSGi context model for o.o.p.w.s.j.i.PaxWebServletContextHandler@556e0a73{/rest,null,STOPPED}
2025-06-27 14:16:17.338 [INFO ] [.service.internal.HttpServiceEnabled] - Registering ServletModel{id=ServletModel-15,name='cxf-servlet',urlPatterns=[/*],contexts=[{WB,OCM-12,context.foropenhab,/rest}]}
2025-06-27 14:16:17.342 [INFO ] [jetty.internal.JettyServerController] - Receiving Batch{"Registration of ServletModel{id=ServletModel-15,name='cxf-servlet',urlPatterns=[/*],contexts=[{WB,OCM-12,context.foropenhab,/rest}]}", size=1}
2025-06-27 14:16:17.354 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Adding servlet ServletModel{id=ServletModel-15,name='cxf-servlet',urlPatterns=[/*],contexts=[{WB,OCM-12,context.foropenhab,/rest}]}
2025-06-27 14:16:17.357 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Starting Jetty context "/rest" with default Osgi Context OsgiContextModel{WB,id=OCM-12,name='context.foropenhab',path='/rest',bundle=org.apache.aries.jax.rs.whiteboard,ref={org.osgi.service.http.context.ServletContextHelper}={original.service.bundleid=183, osgi.jaxrs.application.base=rest, service.id=297, service.bundleid=65, service.scope=singleton, servlet.init.hide-service-list-page=true, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.io.rest.internal.RESTApplicationImpl, component.id=170, original.service.id=296, osgi.http.whiteboard.context.name=context.foropenhab, osgi.jaxrs.name=openhab, osgi.http.whiteboard.target=(osgi.http.endpoint=*), service.pid=org.apache.aries.jax.rs.whiteboard.default, osgi.http.whiteboard.context.path=/rest}}
2025-06-27 14:16:17.362 [INFO ] [.jetty.server.handler.ContextHandler] - Started o.o.p.w.s.j.i.PaxWebServletContextHandler@556e0a73{/rest,null,AVAILABLE}
2025-06-27 14:16:17.364 [INFO ] [rvice.spi.servlet.OsgiServletContext] - Registering OsgiServletContext{model=OsgiContextModel{WB,id=OCM-12,name='context.foropenhab',path='/rest',bundle=org.apache.aries.jax.rs.whiteboard,ref={org.osgi.service.http.context.ServletContextHelper}={original.service.bundleid=183, osgi.jaxrs.application.base=rest, service.id=297, service.bundleid=65, service.scope=singleton, servlet.init.hide-service-list-page=true, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.io.rest.internal.RESTApplicationImpl, component.id=170, original.service.id=296, osgi.http.whiteboard.context.name=context.foropenhab, osgi.jaxrs.name=openhab, osgi.http.whiteboard.target=(osgi.http.endpoint=*), service.pid=org.apache.aries.jax.rs.whiteboard.default, osgi.http.whiteboard.context.path=/rest}}} as OSGi service for "/rest" context path
2025-06-27 14:16:18.271 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:18.661 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:19.007 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:19.071 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:19.401 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:19.548 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:19.820 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:19.937 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:20.124 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:20.286 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:20.442 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:20.564 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:20.755 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:20.979 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:21.168 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:21.358 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:21.616 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:22.135 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:22.393 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:23.033 [INFO ] [internal.StoppableHttpServiceFactory] - Binding HTTP Service for bundle: [org.openhab.core.io.websocket_4.3.5 [195]]
2025-06-27 14:16:23.052 [INFO ] [.service.internal.HttpServiceEnabled] - Registering ServletModel{id=ServletModel-17,name='/ws',urlPatterns=[/ws/*],contexts=[{WB,OCM-1,default,/}]}
2025-06-27 14:16:23.054 [INFO ] [jetty.internal.JettyServerController] - Receiving Batch{"Registration of ServletModel{id=ServletModel-17,name='/ws',urlPatterns=[/ws/*],contexts=[{WB,OCM-1,default,/}]}", size=1}
2025-06-27 14:16:23.058 [INFO ] [ce.jetty.internal.JettyServerWrapper] - Adding servlet ServletModel{id=ServletModel-17,name='/ws',urlPatterns=[/ws/*],contexts=[{WB,OCM-1,default,/}]}
2025-06-27 14:16:23.293 [INFO ] [org.apache.cxf.endpoint.ServerImpl  ] - Setting the server's publish address to be /
2025-06-27 14:16:23.450 [INFO ] [ll.impl.action.osgi.CommandExtension] - Updating commands for bundle org.apache.karaf.jaas.command/4.4.6
2025-06-27 14:16:23.482 [INFO ] [ll.impl.action.osgi.CommandExtension] - Updating commands for bundle org.apache.karaf.jaas.command/4.4.6
2025-06-27 14:16:55.790 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'test.sitemap'
2025-06-27 14:16:57.062 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'nut.things'
2025-06-27 14:16:57.201 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'mqtt.things'
2025-06-27 14:16:57.493 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'rowter.things'
2025-06-27 14:16:57.599 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'cameras.things'
2025-06-27 14:16:57.655 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'jdbc.persist'
2025-06-27 14:16:57.820 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'mapdb.persist'
2025-06-27 14:16:57.846 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'hvac.items'
2025-06-27 14:16:58.634 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'ups.items'
2025-06-27 14:16:58.715 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'test.items'
2025-06-27 14:16:58.743 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'lights.items'
2025-06-27 14:16:58.885 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'zigbeeSensors.items'
2025-06-27 14:16:59.119 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'energymeter.items'
2025-06-27 14:16:59.345 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'locations.items'
2025-06-27 14:16:59.564 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'alarm.items'
2025-06-27 14:16:59.649 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'networking.items'
2025-06-27 14:16:59.765 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'presence.items'
2025-06-27 14:16:59.821 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'cameras.items'
2025-06-27 14:17:00.041 [INFO ] [aml.internal.YamlModelRepositoryImpl] - Adding YAML model tags/custom
2025-06-27 14:19:50.557 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.20.10:8443/overview's Observer 
2025-06-27 14:19:50.719 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.20.10:8443/workbox-1c3383c2.js's Observer 
2025-06-27 14:19:50.883 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.20.10:8443/service-worker.js's Observer 
2025-06-27 14:19:52.012 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.20.10:8443/service-worker.js's Observer 
2025-06-27 14:19:52.026 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.20.10:8443/workbox-1c3383c2.js's Observer 
2025-06-27 14:22:43.790 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.20.10:8443/overview's Observer 
2025-06-27 14:22:44.620 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.20.10:8443/service-worker.js's Observer

rlkoshak · June 27, 2025, 2:33pm

It’s really hard to read logs when they are not in code fences:

```
code goes here
```

As far as I can tell OH came up as expected. I see it loading your config files and I don’t see any errors that are unexpected.

Do you see stuff in events.log to indicate your Things came online and Items are updating?

But again, it’s hard to read logs like this so I may have missed something.

Have you cleared the cache in your browser and refreshed the page?

Do phone apps work?

aleksey.kurchavy · June 27, 2025, 4:31pm

Thanks for the response! I’ve tweaked the formatting of the logs in the previous post.
The event.log are completely empty. Usually when starting OH there is a record of initialization of things and changing the value of items. But now it is empty. In addition, the CPU load indicates that the openhab service is not active. It’s consuming 0.1% of the CPU power.
I cleared the browser cache. The app reports that OH is offline. Openhab cloud reports the same.

rlkoshak · June 27, 2025, 5:32pm

There’s no error or indications of a problem in the logs.

About all I can recommend is to reinstall OH and restore your backup. There is no other information to go on. Maybe someone can use the warning logs to make some guess, but what ever it is, since clearing the cache didn’t fix anything the problem has to either be your installation itself is corrupted somehow or your configs are wrong. If it were the latter we would see errors in the log.

aleksey.kurchavy · July 2, 2025, 7:09am

Unfortunately reinstalling OH did not help.

apt install --reinstall openhab

I also reinstalled Java.
OH does not start with both the empty configuration and the restored configuration.
After numerous restarts of the OH service, I found out the following: sometimes OH start like in the screenshot below. However, as you can see, items, rules, scripts, etc. are not loaded.

Oliver2 · July 2, 2025, 5:01pm

Can you start openhab console?
What is the output of

systemctl status openhab

Did you check permissions of your userdata and config directory and its content?

aleksey.kurchavy · July 3, 2025, 8:00am

thank you for your feedback
Yes, I’m sure the permissions on the folders and contents are correct

sudo openhab-cli info

Version:     4.3.5 (Build)

User:        openhab (Active Process 4255)
User Groups: openhab tty dialout audio

Directories: Folder Name      | Path                        | User:Group
             -----------      | ----                        | ----------
             OPENHAB_HOME     | /usr/share/openhab          | openhab:openhab
             OPENHAB_RUNTIME  | /usr/share/openhab/runtime  | openhab:openhab
             OPENHAB_USERDATA | /var/lib/openhab            | openhab:openhab
             OPENHAB_CONF     | /etc/openhab                | openhab:openhab
             OPENHAB_LOGDIR   | /var/log/openhab            | openhab:openhab
             OPENHAB_BACKUPS  | /var/lib/openhab/backups    | openhab:openhab

systemctl status openhab
● openhab.service - openHAB - empowering the smart home
     Loaded: loaded (/lib/systemd/system/openhab.service; disabled; preset: enabled)
     Active: active (running) since Wed 2025-07-02 16:53:43 MSK; 17h ago
       Docs: https://www.openhab.org/docs/
             https://community.openhab.org
   Main PID: 4255 (java)
      Tasks: 119 (limit: 4010)
     Memory: 569.5M
        CPU: 11min 56.986s
     CGroup: /system.slice/openhab.service
             └─4255 /usr/bin/java -XX:-UsePerfData -Dopenhab.home=/usr/share/openhab -Dopenhab.conf=/etc/openhab -Dopen>

the first thing I did when I found the problem

sudo openhab-cli reset-ownership
sudo openhab-cli clean-cache

I manually deleted the folders /usr/share/openhab/addons, /var/lib/openhab, /etc/openhab, then reinstalled openhab. Right now my configuration is empty and the web interface looks like this. It’s like some subsystems didn’t start.

Oliver2 · July 3, 2025, 10:14am

This does not look good. There are a lot of menu items missing in the sidebar and in the settings page.
This is either a browser cache problem (as Rich suggested, please open the page with your mobile phone) or some of your files are corrupted.

dr_t · July 4, 2025, 10:39pm

I came across this thread when searching for “No service was found”. I have the exact same problem. OpenHAB has been working fine for many years. Then a few days ago my dehumidifier automation stopped working. Then my air filter automation. And tonight, suddenly I see that my lights are bright at night (I have an automation set up to dim them automatically when it gets dark). I try to access the OpenHAB page. It’s not working. I reboot the virtual machine running OpenHAB. Now nothing works. If I try to access any web page on port 8080 of the OpenHAB server, I get “No service was found” and openhab.log logs a line of the form “[.transport.servlet.ServletController] - Can’t find the request for URL’s Observer”. URL is whatever page on the server I’m trying to access, e.g. http://openhab:8080/ or http://openhab:8080/settings/things etc. The Phoscon page on port 80 (i.e. http://openhab/) is working and sees Zigbee devices controlled by ConBEE II. Zigbee2MQTT is working - and getting data from sensors controlled by a remote Zigbee co-ordinator.

I changed absolutely nothing. I did not upgrade anything. It just stopped working out of the blue.

Oliver2 · July 4, 2025, 10:52pm

How old is your SD card? It might be your SD is corrupt.

dr_t · July 4, 2025, 11:59pm

Are you asking me or aleksey.kurchavy? In my case, OpenHAB is running in a virtual machine on a server with ECC RAM and mirrored ZFS pool for storage. Never had any data corruption.

aleksey.kurchavy · July 5, 2025, 7:39pm

Whats your VM guest operation sistem and the kernel version? Did you update the guest OS shortly before the crash?

aleksey.kurchavy · July 5, 2025, 7:52pm

I took a clean hard drive. Installed fresh debian-12.11.0-amd64. Installed zulu17.58.21-ca-jre17.0.15-linux_amd64. Then installed openhab 4.3.5 from the repository. I did not restore the configuration. This is a completely clean install. And got “No service was found.” ¯\(ツ)/¯
My opinion is openhab or some component is not compatible with fresh linux kernel or some package. I encountered an error on startup.

openhab.log

2025-07-05 22:56:53.672 [INFO ] [org.openhab.core.Activator          ] - Starting openHAB 4.3.5 (Release Build)
2025-07-05 22:57:25.176 [INFO ] [.core.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007
2025-07-05 22:57:42.919 [WARN ] [fig.discovery.addon.ip.IpAddonFinder] - bundle org.openhab.core.config.discovery.addon.ip:4.3.5 (264)[org.openhab.core.config.discovery.addon.ip.IpAddonFinder(338)] : Could not get service from ref {org.openhab.core.addon.AddonService}={service.id=365, service.bundleid=158, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), service.config.label=Community Marketplace, component.name=org.openhab.core.addon.marketplace.internal.community.CommunityMarketplaceAddonService, component.id=47, service.config.factory=false, service.config.category=system, service.pid=org.openhab.marketplace, service.config.description.uri=system:marketplace}
2025-07-05 22:57:42.936 [ERROR] [Events.Framework                    ] - FrameworkEvent ERROR
org.osgi.framework.ServiceException: Exception in org.apache.felix.scr.impl.manager.SingleComponentManager.getService()
	at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse.factoryGetService(ServiceFactoryUse.java:230) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse.getService(ServiceFactoryUse.java:118) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.serviceregistry.ServiceConsumer$2.getService(ServiceConsumer.java:48) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.serviceregistry.ServiceRegistrationImpl.getService(ServiceRegistrationImpl.java:547) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.getService(ServiceRegistry.java:534) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.framework.BundleContextImpl.getService(BundleContextImpl.java:660) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.apache.felix.scr.impl.manager.SingleRefPair.getServiceObject(SingleRefPair.java:88) ~[?:?]
	at org.apache.felix.scr.impl.inject.methods.BindMethod.getServiceObject(BindMethod.java:675) ~[?:?]
	at org.apache.felix.scr.impl.manager.DependencyManager.getServiceObject(DependencyManager.java:2612) ~[?:?]
	at org.apache.felix.scr.impl.manager.DependencyManager$MultipleDynamicCustomizer.prebind(DependencyManager.java:434) ~[?:?]
	at org.apache.felix.scr.impl.manager.DependencyManager.prebind(DependencyManager.java:1830) ~[?:?]
	at org.apache.felix.scr.impl.manager.AbstractComponentManager.collectDependencies(AbstractComponentManager.java:1060) ~[?:?]
	at org.apache.felix.scr.impl.manager.SingleComponentManager.getServiceInternal(SingleComponentManager.java:955) ~[?:?]
	at org.apache.felix.scr.impl.manager.SingleComponentManager.getService(SingleComponentManager.java:920) ~[?:?]
	at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse$1.run(ServiceFactoryUse.java:220) ~[org.eclipse.osgi-3.18.0.jar:?]
	at java.security.AccessController.doPrivileged(Unknown Source) ~[?:?]
	at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse.factoryGetService(ServiceFactoryUse.java:217) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse.getService(ServiceFactoryUse.java:118) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.serviceregistry.ServiceConsumer$2.getService(ServiceConsumer.java:48) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.serviceregistry.ServiceRegistrationImpl.getService(ServiceRegistrationImpl.java:547) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.getService(ServiceRegistry.java:534) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.framework.BundleContextImpl.getService(BundleContextImpl.java:660) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.apache.felix.scr.impl.manager.SingleRefPair.getServiceObject(SingleRefPair.java:88) ~[?:?]
	at org.apache.felix.scr.impl.inject.methods.BindMethod.getServiceObject(BindMethod.java:675) ~[?:?]
	at org.apache.felix.scr.impl.manager.DependencyManager.getServiceObject(DependencyManager.java:2612) ~[?:?]
	at org.apache.felix.scr.impl.manager.DependencyManager.doInvokeBindMethod(DependencyManager.java:2078) ~[?:?]
	at org.apache.felix.scr.impl.manager.DependencyManager.invokeBindMethod(DependencyManager.java:2061) ~[?:?]
	at org.apache.felix.scr.impl.manager.SingleComponentManager.invokeBindMethod(SingleComponentManager.java:443) ~[?:?]
	at org.apache.felix.scr.impl.manager.DependencyManager$MultipleDynamicCustomizer.addedService(DependencyManager.java:336) ~[?:?]
	at org.apache.felix.scr.impl.manager.DependencyManager$MultipleDynamicCustomizer.addedService(DependencyManager.java:304) ~[?:?]
	at org.apache.felix.scr.impl.manager.ServiceTracker$Tracked.customizerAdded(ServiceTracker.java:1232) ~[?:?]
	at org.apache.felix.scr.impl.manager.ServiceTracker$Tracked.customizerAdded(ServiceTracker.java:1152) ~[?:?]
	at org.apache.felix.scr.impl.manager.ServiceTracker$AbstractTracked.trackAdding(ServiceTracker.java:959) ~[?:?]
	at org.apache.felix.scr.impl.manager.ServiceTracker$AbstractTracked.track(ServiceTracker.java:895) ~[?:?]
	at org.apache.felix.scr.impl.manager.ServiceTracker$Tracked.serviceChanged(ServiceTracker.java:1184) ~[?:?]
	at org.apache.felix.scr.impl.BundleComponentActivator$ListenerInfo.serviceChanged(BundleComponentActivator.java:116) ~[?:?]
	at org.eclipse.osgi.internal.serviceregistry.FilteredServiceListener.serviceChanged(FilteredServiceListener.java:123) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.framework.BundleContextImpl.dispatchEvent(BundleContextImpl.java:961) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.framework.eventmgr.EventManager.dispatchEvent(EventManager.java:234) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.framework.eventmgr.ListenerQueue.dispatchEventSynchronous(ListenerQueue.java:151) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.publishServiceEventPrivileged(ServiceRegistry.java:937) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.publishServiceEvent(ServiceRegistry.java:874) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.serviceregistry.ServiceRegistrationImpl.register(ServiceRegistrationImpl.java:141) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.registerService(ServiceRegistry.java:262) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.framework.BundleContextImpl.registerService(BundleContextImpl.java:500) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.apache.felix.scr.impl.manager.AbstractComponentManager$3.register(AbstractComponentManager.java:929) ~[?:?]
	at org.apache.felix.scr.impl.manager.AbstractComponentManager$3.register(AbstractComponentManager.java:915) ~[?:?]
	at org.apache.felix.scr.impl.manager.RegistrationManager.changeRegistration(RegistrationManager.java:133) ~[?:?]
	at org.apache.felix.scr.impl.manager.AbstractComponentManager.registerService(AbstractComponentManager.java:984) ~[?:?]
	at org.apache.felix.scr.impl.manager.AbstractComponentManager.activateInternal(AbstractComponentManager.java:752) ~[?:?]
	at org.apache.felix.scr.impl.manager.AbstractComponentManager.enableInternal(AbstractComponentManager.java:674) ~[?:?]
	at org.apache.felix.scr.impl.manager.AbstractComponentManager.enable(AbstractComponentManager.java:437) ~[?:?]
	at org.apache.felix.scr.impl.manager.ConfigurableComponentHolder.enableComponents(ConfigurableComponentHolder.java:671) ~[?:?]
	at org.apache.felix.scr.impl.BundleComponentActivator.initialEnable(BundleComponentActivator.java:310) ~[?:?]
	at org.apache.felix.scr.impl.Activator.loadComponents(Activator.java:593) ~[?:?]
	at org.apache.felix.scr.impl.Activator.access$200(Activator.java:74) ~[?:?]
	at org.apache.felix.scr.impl.Activator$ScrExtension.start(Activator.java:460) ~[?:?]
	at org.apache.felix.scr.impl.AbstractExtender.createExtension(AbstractExtender.java:196) ~[?:?]
	at org.apache.felix.scr.impl.AbstractExtender.modifiedBundle(AbstractExtender.java:169) ~[?:?]
	at org.apache.felix.scr.impl.AbstractExtender.modifiedBundle(AbstractExtender.java:49) ~[?:?]
	at org.osgi.util.tracker.BundleTracker$Tracked.customizerModified(BundleTracker.java:488) ~[osgi.core-8.0.0.jar:?]
	at org.osgi.util.tracker.BundleTracker$Tracked.customizerModified(BundleTracker.java:420) ~[osgi.core-8.0.0.jar:?]
	at org.osgi.util.tracker.AbstractTracked.track(AbstractTracked.java:232) ~[osgi.core-8.0.0.jar:?]
	at org.osgi.util.tracker.BundleTracker$Tracked.bundleChanged(BundleTracker.java:450) ~[osgi.core-8.0.0.jar:?]
	at org.eclipse.osgi.internal.framework.BundleContextImpl.dispatchEvent(BundleContextImpl.java:949) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.framework.eventmgr.EventManager.dispatchEvent(EventManager.java:234) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.framework.eventmgr.ListenerQueue.dispatchEventSynchronous(ListenerQueue.java:151) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEventPrivileged(EquinoxEventPublisher.java:229) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEvent(EquinoxEventPublisher.java:138) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEvent(EquinoxEventPublisher.java:130) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.framework.EquinoxContainerAdaptor.publishModuleEvent(EquinoxContainerAdaptor.java:217) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.container.Module.publishEvent(Module.java:499) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.container.Module.start(Module.java:486) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.framework.EquinoxBundle.start(EquinoxBundle.java:445) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.eclipse.osgi.internal.framework.EquinoxBundle.start(EquinoxBundle.java:464) ~[org.eclipse.osgi-3.18.0.jar:?]
	at org.apache.karaf.features.internal.service.BundleInstallSupportImpl.startBundle(BundleInstallSupportImpl.java:165) ~[?:?]
	at org.apache.karaf.features.internal.service.FeaturesServiceImpl.startBundle(FeaturesServiceImpl.java:1160) ~[?:?]
	at org.apache.karaf.features.internal.service.Deployer.deploy(Deployer.java:1041) ~[?:?]
	at org.apache.karaf.features.internal.service.FeaturesServiceImpl.doProvision(FeaturesServiceImpl.java:1069) ~[?:?]
	at org.apache.karaf.features.internal.service.FeaturesServiceImpl.lambda$doProvisionInThread$13(FeaturesServiceImpl.java:1004) ~[?:?]
	at java.util.concurrent.FutureTask.run(Unknown Source) ~[?:?]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) ~[?:?]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) ~[?:?]
	at java.lang.Thread.run(Unknown Source) ~[?:?]
Caused by: java.lang.IllegalStateException: Could not obtain lock
	at org.apache.felix.scr.impl.manager.AbstractComponentManager.obtainLock(AbstractComponentManager.java:242) ~[?:?]
	at org.apache.felix.scr.impl.manager.AbstractComponentManager.obtainStateLock(AbstractComponentManager.java:289) ~[?:?]
	at org.apache.felix.scr.impl.manager.SingleComponentManager.getService(SingleComponentManager.java:908) ~[?:?]
	at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse$1.run(ServiceFactoryUse.java:220) ~[org.eclipse.osgi-3.18.0.jar:?]
	at java.security.AccessController.doPrivileged(Unknown Source) ~[?:?]
	at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse.factoryGetService(ServiceFactoryUse.java:217) ~[org.eclipse.osgi-3.18.0.jar:?]
	... 83 more
2025-07-05 23:00:56.780 [WARN ] [.io.rest.auth.internal.TokenResource] - Couldn't find a user with a session matching the provided refresh_token
2025-07-05 23:00:56.784 [WARN ] [.io.rest.auth.internal.TokenResource] - Token issuing failed: invalid_grant
2025-07-05 23:00:57.800 [WARN ] [org.eclipse.jetty.server.HttpChannel] - handleException /fonts/Framework7Icons-Regular.woff2 java.io.IOException: Close SendCallback@30599140[PROCESSING][i=HTTP/1.1{s=200,h=5,cl=107416},cb=org.eclipse.jetty.server.HttpChannel$SendCallback@54c96136] in state PROCESSING
2025-07-05 23:01:10.123 [INFO ] [p.auth.internal.AuthorizePageServlet] - First user account created: alexey
2025-07-05 23:01:14.603 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Time zone set to 'Europe/Moscow'.
2025-07-05 23:01:14.605 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Locale set to 'ru_RU'.

dr_t · July 5, 2025, 9:39pm

I was running Linux Debian 10 (amd64). I don’t know the kernel version any more. Because my OpenHAB installation is running so many things in my house which were not working at all, I was working frantically doing anything I could to try to fix the issue. The first thing I did was to upgrade Debian to Debian 12.11 (kernel version 6.1.0), then I removed OpenHAB, deConz, zulu, and reinstalled everything, the latest versions (I kept Zulu at 17). The problem remained.

At some point I started getting a lot of org.apache.cxf.interceptor.Fault messages when something was trying to access http://internal.id.core.openhab.org/ . I checked my routing setup and the router was configured to load balance OpenHAB virtual machine’s outbound internet accesses via several different WAN ports. I changed the setting on the router so that everything from the OpenHAB virtual machine now goes out via a single WAN port. As soon as I did that, everything immediately started working again. Hmm? ET calls home? Does OpenHAB require Internet access to work?

aleksey.kurchavy · July 5, 2025, 10:55pm

I figured out what’s causing it. Thanks Doctor T for giving me the idea with the WLAN ports. I live in Russia. Now the state is actively introducing censorship. Big ISPs like cloudflare and digital ocean are blocked with DPI.

I disconnected the ethernet cable in my server
then restarted the openhab service
waited for it to fully start and put the cable back in place. And everything worked as normal.

Why is openhab accessing the servers on startup?

rlkoshak · July 5, 2025, 11:04pm

No but with a default install it downloads the add-ons on demand and that requires Internet access. Some bindings can only work if there is Internet access as well.

Because with a default install it installsb the add-on by downloading then from the internet.

If you need an offline OH, you can install the ooenhab-addons package (sudo apt install ooenhab-addons) or download the add-ons KAR file from OH’s download page and put the .kar file in OH’s add-ons folder. Then it will install add-ons from that instead of downloading them from the Internet.

And again, certain add-ons require Internet to work also.

dr_t · July 5, 2025, 11:11pm

But I have (and always had) openhab-addons installed?

aleksey.kurchavy · July 5, 2025, 11:26pm

I didn’t install any addons at all in the new install.
I declined the default ones offered.

justaoldman · July 6, 2025, 2:11am

If I recall under setting add on Management the default setting is to access Remote repository for add on installation, so it tries to pull the manifest down. also, I seem to recall one of the dev’s explaining the way the community add-ons are stored also triggers a call to the OpenHab “mothership” too since the community add-ons also require internet access to load that list as well. Either one of those may be the “ET phone home” scenario you are seeing.