Installation of Embedded MQTT Broker with 2.5.0-SNAPSHOT fails AND/OR connection refused

Tags: #<Tag:0x00007f7461776dc0>
  • Platform information:

    • OS: Ubuntu 18.04.2 LTS

    • Java Runtime Environment:
      openjdk version “1.8.0_202”
      OpenJDK Runtime Environment (Zulu 8.36.0.1-CA-linux64) (build 1.8.0_202-b05)
      OpenJDK 64-Bit Server VM (Zulu 8.36.0.1-CA-linux64) (build 25.202-b05, mixed mode)

    • openHAB version: 2.5.0-SNAPSHOT (#1561)

Yesterday my MQTT Instance (V2 Binding, internal OH MQTT Broker) works great on my OH 2.5 (sadly, idk the Version Nummer). Then i did update … never change a running system … and OH was not able to connect to the MQTT Broker:

 [hingStatusInfoChangedEvent] - 'mqtt:broker:openhabembedded' changed from OFFLINE to OFFLINE (COMMUNICATION_ERROR): Verbindung zu Server kann nicht hergestellt werden

I tried to reinstall (stopped OH, cleaned the cache, out commented the mqtt.thing file) the embedded broker (Moquette misc-mqttbroker - 2.5.0.SNAPSHOT) with no success:

[ERROR] [org.openhab.io.mqttembeddedbroker   ] - bundle org.openhab.io.mqttembeddedbroker:2.5.0.201903260112 (258)[org.openhab.io.mqttembeddedbroker.internal.EmbeddedBrokerService(304)] : The activate method has thrown an exception

[hingStatusInfoChangedEvent] - 'mqtt:broker:openhabembedded' changed from UNINITIALIZED to UNINITIALIZED (DISABLED)

and “can’t establish connection to server”

'mqtt:broker:openhabembedded' changed from OFFLINE to OFFLINE (COMMUNICATION_ERROR): Verbindung zu Server kann nicht hergestellt werden

==> /var/log/openhab2/openhab.log <==

 [INFO ] [.reconnect.PeriodicReconnectStrategy] - Try to restore connection to 'localhost'. Next attempt in 10000ms

==> /var/log/openhab2/events.log <==

 [hingStatusInfoChangedEvent] - 'mqtt:broker:openhabembedded' changed from OFFLINE (COMMUNICATION_ERROR): Verbindung zu Server kann nicht hergestellt werden to OFFLINE

==> /var/log/openhab2/openhab.log <==

 [INFO ] [.transport.mqtt.MqttBrokerConnection] - Starting MQTT broker connection to 'localhost' with clientid paho34229486255687 and file store '/var/lib/openhab2/mqtt/localhost'

==> /var/log/openhab2/events.log <==

 [hingStatusInfoChangedEvent] - 'mqtt:broker:openhabembedded' changed from OFFLINE to OFFLINE (COMMUNICATION_ERROR): Verbindung zu Server kann nicht hergestellt werden

==> /var/log/openhab2/openhab.log <==

 [INFO ] [.reconnect.PeriodicReconnectStrategy] - Try to restore connection to 'localhost'. Next attempt in 10000ms

==> /var/log/openhab2/events.log <==

 [hingStatusInfoChangedEvent] - 'mqtt:broker:openhabembedded' changed from OFFLINE (COMMUNICATION_ERROR): Verbindung zu Server kann nicht hergestellt werden to OFFLINE

==> /var/log/openhab2/openhab.log <==
 [INFO ] [.transport.mqtt.MqttBrokerConnection] - Starting MQTT broker connection to 'localhost' with clientid paho34229486255687 and file store '/var/lib/openhab2/mqtt/localhost'

==> /var/log/openhab2/events.log <==

[hingStatusInfoChangedEvent] - 'mqtt:broker:openhabembedded' changed from OFFLINE to OFFLINE (COMMUNICATION_ERROR): Verbindung zu Server kann nicht hergestellt werden

I configured the Broker only with a text file (Visual Studio):

Bridge mqtt:broker:openhabembedded "OH embedded Broker" [ host="localhost", port=1883, secure=false ]

Is this a known error of the snapshot or my misconfiguration? How can i rescue my system? (e.g.using a extern mosquitto server?)
I was so happy with my mqtt system: learned to filter out json strings, convert them to a number, calculate a new value and post the value on the knx bus. But … i crashed my system. :-0

(Off topic, skip if you do not want to read frustation: My user experience the last two months: steep learning curve, too many changes, new concepts (great), but confusing without documention and examples (bad). I never experienced a change that radical in the last 1…2…3 years. I hope OH will slow down its pace.)

2 Likes

downgrade to 2.4.0-1 (sudo apt-get install openhab2=2.4.0-1), same config file, no reboot: back in business!

(Off-Topic: This openhabian-config tool …:

Grafana+influxdb installation: no success (old repository entry) solution: manual installation
Downgrade: no success … manual installation.
Sadly the log output is unreadable, so the user has no feedback, if his action had suceeded.)
Hmmm …

Personally, I would recommend using the external Mosquitto server at this time. I’d give the embedded broker a bit of time to mature a bit before I’d rely on it.

I’d also stay away from the snapshot builds unless you want to help find and solve the many many problems that have popped up with the merge of ESH back into the OH core. Though I don’t think any of those changes should be a cause of the problem you are seeing.

It does sound like you may have discovered a bug in the embedded broker. Please file an issue on the openhab2-addons repo. See How to file an Issue for details if you need help.

@rlkoshak, why would you currently advice to go wit mosquitto (VS embedded broker)?
I’m currently getting into my first mqtt connection so I try to learn ‘the right thing’

That isn’t a general recommendation but a recommendation specific to OP’s situation.

My generic opinion is that I don’t have one. It doesn’t really make much of a difference. But because the OP was having trouble, I couldn’t tell what was causing the trouble, and setting up Mosquitto is so easy I recommend moving to that.

Thanks for the explanation

The snapshot build are not recommended right now. We are currently migrating all bindings to a new build system and it is likely that the packaging does not work as intended.

The actual change is that we no longer package external dependencies like the Moquette broker in this case with the bundle but only reference them as dependencies. That seem to have failed here.

Rich and David: Many thanks for your reply with your explanations and your patience! That make things clear!

:slight_smile:

Now we’re 2 months later… are we still on the general recommendation that the snapshot build is not recommended? Because I just upgraded too it and s#*t went downhill pretty fast :slight_smile: I’m about to rollback to the stable release, but I did the upgrade to snapshot release in an effort to get MQTT 2.x going (after my initial migration from 1.x with things not working consistently) - that was initially due to 1.x completely stopping working totally out of the blue.

While I greatly appreciate the effort of everyone involved in developing an open source home automation product such as OpenHAB, as the OP states it does seem to be going at a great rate of knots in the past 3-4 months, hopefully not to it’s detriment long term.

The buildsystem migration + reintegration of eclipse smarthome pretty much made openHAB an openHAB 3. Not the API (Application Programming Interface) changed, but the ABI (Application binary interface) did.

Every single addon need to be checked if it still works, most don’t. And a lot of maintainers disappeared. It’s like with the openHAB 1 -> openHAB 2 situation at the moment is my personal perception of things.

The core itself works. Kind of.

That’s why I have suggested in the Developer section to think about a more generic binding development, based on open standards, not so much tied to openHAB itself. That way we can share bindings with other communities and have potentially more maintainers.

1 Like

Any news here? I just installed a fresh 2.5.0 Milestone 3, and I am not able to set up a embedded MQTT broker. Getting the same error:

2019-10-13 18:45:31.449 [INFO ] [.reconnect.PeriodicReconnectStrategy] - Try to restore connection to 'localhost'. Next attempt in 10000ms
2019-10-13 18:45:31.463 [INFO ] [.transport.mqtt.MqttBrokerConnection] - Starting MQTT broker connection to 'localhost' with clientid paho4942958078057 and file store '/var/lib/openhab2/mqtt/localhost'

Any way to fix that?

Of course it’s not finished software, but wow, am I having problems with openHAB right now… Installed REST yesterday (because there seems to be no other way to add a tag to a item that was created in PaperUI. That installation pretty much screwed up my openHAB, MQTT wasn’t working anymore, after a reboot I did not have any bindings installed anymore… which is why I wanted to start from scratch.

Remember there are two parts. You need to install the embedded broker from the misc tab. It has some configuration parameters I think.

You have to separately install the MQTT binding. And then you create the MQTT broker Thing which is the connection to the broker.

It sounds like you’ve only installed the bindings and set up the broker Thing.

That might actually be the case. I probably forgot. Sorry about that.

Not sure what caused the problems with the REST installation yesterday… I wasn’t able to fix it, so I installed openHAB fresh. Must have missed installing the embedded broker.

I am now in the process of installing openHAB 2.4 fresh, I don’t think I need anything from 2.5. I’ll report back if I still have problems there :slight_smile:

The REST documentation and embedded mqtt broker both have issues in 2.5M3. Further reading can be found here in the testing thread
There has been some progress with a possible workaround in the situation with the REST documentation recently in this thread
The embedded mqtt broker has a file lock issue that is discussed in the testing thread with a work around as well

I have installed the MQTT binding as well as MQTT Broker Moquette 2.5.0.M3.
When I try to add a Thing with the MQTT Binding the MQTT Broker is not found and when I try to add it manually with the same IP address that openhab server I have an communication error.

Any suggestion on what I am doing wrong?

Attempt to communicate with the broker using mqttfx
confirm the broker is running
I’m using the same version and its working

what? describe better

post log with error please

(post withdrawn by author, will be automatically deleted in 96 hours unless flagged)

Hello Andrew,

mqttfx is showing a red flag “unable to connect to server”

I have uninstall the embedded MQTT broker and the MQTT binding and try to reinstall them after an openhab server reboot. I am running OpenHab 2.5.0.M3 on a window 10 PC

The MQTT binding install log is showing no error

MQTT binding install log
09:58:55.399 [INFO ] [.internal.service.FeaturesServiceImpl] - Adding features: openhab-binding-mqtt/[2.5.0.M3,2.5.0.M3]
09:59:04.394 [INFO ] [.internal.service.FeaturesServiceImpl] - Changes to perform:
09:59:04.397 [INFO ] [.internal.service.FeaturesServiceImpl] -   Region: root
09:59:04.397 [INFO ] [.internal.service.FeaturesServiceImpl] -     Bundles to install:
09:59:04.398 [INFO ] [.internal.service.FeaturesServiceImpl] -       mvn:org.eclipse.paho/org.eclipse.paho.client.mqttv3/1.2.1
09:59:04.398 [INFO ] [.internal.service.FeaturesServiceImpl] -       mvn:org.openhab.addons.bundles/org.openhab.binding.mqtt/2.5.0.M3
09:59:04.399 [INFO ] [.internal.service.FeaturesServiceImpl] -       mvn:org.openhab.addons.bundles/org.openhab.binding.mqtt.generic/2.5.0.M3
09:59:04.399 [INFO ] [.internal.service.FeaturesServiceImpl] -       mvn:org.openhab.addons.bundles/org.openhab.binding.mqtt.homeassistant/2.5.0.M3
09:59:04.400 [INFO ] [.internal.service.FeaturesServiceImpl] -       mvn:org.openhab.addons.bundles/org.openhab.binding.mqtt.homie/2.5.0.M3
09:59:04.400 [INFO ] [.internal.service.FeaturesServiceImpl] -       mvn:org.openhab.core.bundles/org.openhab.core.io.transport.mqtt/2.5.0.M3
09:59:04.405 [INFO ] [.internal.service.FeaturesServiceImpl] - Stopping bundles:
09:59:04.406 [INFO ] [.internal.service.FeaturesServiceImpl] -   swagger-jersey2-jaxrs/1.5.8.v20160511-1038
09:59:04.411 [INFO ] [.internal.service.FeaturesServiceImpl] -   reflections/0.9.10.v20160429-1435
09:59:04.413 [INFO ] [.internal.service.FeaturesServiceImpl] -   io.swagger.jaxrs/1.5.8
09:59:04.416 [INFO ] [.internal.service.FeaturesServiceImpl] -   com.eclipsesource.jaxrs.provider.swagger/1.1.1.201605111122
09:59:04.421 [INFO ] [.internal.service.FeaturesServiceImpl] - Installing bundles:
09:59:04.422 [INFO ] [.internal.service.FeaturesServiceImpl] -   mvn:org.eclipse.paho/org.eclipse.paho.client.mqttv3/1.2.1
09:59:04.439 [INFO ] [.internal.service.FeaturesServiceImpl] -   mvn:org.openhab.addons.bundles/org.openhab.binding.mqtt/2.5.0.M3
09:59:04.769 [INFO ] [.internal.service.FeaturesServiceImpl] -   mvn:org.openhab.addons.bundles/org.openhab.binding.mqtt.generic/2.5.0.M3
09:59:04.782 [INFO ] [.internal.service.FeaturesServiceImpl] -   mvn:org.openhab.addons.bundles/org.openhab.binding.mqtt.homeassistant/2.5.0.M3
09:59:04.796 [INFO ] [.internal.service.FeaturesServiceImpl] -   mvn:org.openhab.addons.bundles/org.openhab.binding.mqtt.homie/2.5.0.M3
09:59:04.898 [INFO ] [.internal.service.FeaturesServiceImpl] -   mvn:org.openhab.core.bundles/org.openhab.core.io.transport.mqtt/2.5.0.M3
09:59:05.043 [INFO ] [.internal.service.FeaturesServiceImpl] - Refreshing bundles:
09:59:05.045 [INFO ] [.internal.service.FeaturesServiceImpl] -     com.eclipsesource.jaxrs.provider.swagger/1.1.1.201605111122 (Wired to io.swagger.jaxrs/1.5.8 which is being refreshed)
09:59:05.045 [INFO ] [.internal.service.FeaturesServiceImpl] -     io.swagger.jaxrs/1.5.8 (Wired to reflections/0.9.10.v20160429-1435 which is being refreshed)
09:59:05.046 [INFO ] [.internal.service.FeaturesServiceImpl] -     reflections/0.9.10.v20160429-1435 (Should be wired to: com.google.guava/18.0.0 (through [reflections/0.9.10.v20160429-1435] osgi.wiring.package; resolution:=optional; filter:="(osgi.wiring.package=com.google.common.base)"))
09:59:05.047 [INFO ] [.internal.service.FeaturesServiceImpl] -     swagger-jersey2-jaxrs/1.5.8.v20160511-1038 (Wired to io.swagger.jaxrs/1.5.8 which is being refreshed)
09:59:05.304 [INFO ] [.internal.service.FeaturesServiceImpl] - Starting bundles:
09:59:05.305 [INFO ] [.internal.service.FeaturesServiceImpl] -   org.eclipse.paho.client.mqttv3/1.2.1
09:59:05.307 [INFO ] [.internal.service.FeaturesServiceImpl] -   org.openhab.core.io.transport.mqtt/2.5.0.M3
09:59:05.328 [INFO ] [.internal.service.FeaturesServiceImpl] -   org.openhab.binding.mqtt/2.5.0.M3
09:59:05.348 [INFO ] [.internal.service.FeaturesServiceImpl] -   org.openhab.binding.mqtt.generic/2.5.0.M3
09:59:05.361 [INFO ] [.internal.service.FeaturesServiceImpl] -   org.openhab.binding.mqtt.homeassistant/2.5.0.M3
09:59:05.381 [INFO ] [.internal.service.FeaturesServiceImpl] -   org.openhab.binding.mqtt.homie/2.5.0.M3
09:59:05.393 [INFO ] [.internal.service.FeaturesServiceImpl] - Done.
09:59:05.398 [INFO ] [smarthome.event.ExtensionEvent       ] - Extension 'binding-mqtt' has been installed.

The MQTT Embedded Broker install log is showing a bunch of error as you could see below:

MQTT Embedded Broker install log
10:00:25.136 [INFO ] [.internal.service.FeaturesServiceImpl] - Adding features: openhab-misc-mqttbroker/[2.5.0.M3,2.5.0.M3]
10:00:26.487 [INFO ] [.internal.service.FeaturesServiceImpl] - Changes to perform:
10:00:26.488 [INFO ] [.internal.service.FeaturesServiceImpl] -   Region: root
10:00:26.488 [INFO ] [.internal.service.FeaturesServiceImpl] -     Bundles to install:
10:00:26.489 [INFO ] [.internal.service.FeaturesServiceImpl] -       mvn:org.openhab.addons.bundles/org.openhab.io.mqttembeddedbroker/2.5.0.M3
10:00:26.490 [INFO ] [.internal.service.FeaturesServiceImpl] - Stopping bundles:
10:00:26.492 [INFO ] [.internal.service.FeaturesServiceImpl] -   swagger-jersey2-jaxrs/1.5.8.v20160511-1038
10:00:26.493 [INFO ] [.internal.service.FeaturesServiceImpl] -   reflections/0.9.10.v20160429-1435
10:00:26.494 [INFO ] [.internal.service.FeaturesServiceImpl] -   io.swagger.jaxrs/1.5.8
10:00:26.497 [INFO ] [.internal.service.FeaturesServiceImpl] -   com.eclipsesource.jaxrs.provider.swagger/1.1.1.201605111122
10:00:26.501 [INFO ] [.internal.service.FeaturesServiceImpl] - Installing bundles:
10:00:26.504 [INFO ] [.internal.service.FeaturesServiceImpl] -   mvn:org.openhab.addons.bundles/org.openhab.io.mqttembeddedbroker/2.5.0.M3
10:00:26.582 [INFO ] [.internal.service.FeaturesServiceImpl] - Refreshing bundles:
10:00:26.583 [INFO ] [.internal.service.FeaturesServiceImpl] -     com.eclipsesource.jaxrs.provider.swagger/1.1.1.201605111122 (Wired to io.swagger.jaxrs/1.5.8 which is being refreshed)
10:00:26.584 [INFO ] [.internal.service.FeaturesServiceImpl] -     io.swagger.jaxrs/1.5.8 (Wired to reflections/0.9.10.v20160429-1435 which is being refreshed)
10:00:26.586 [INFO ] [.internal.service.FeaturesServiceImpl] -     reflections/0.9.10.v20160429-1435 (Should be wired to: com.google.guava/18.0.0 (through [reflections/0.9.10.v20160429-1435] osgi.wiring.package; resolution:=optional; filter:="(osgi.wiring.package=com.google.common.base)"))
10:00:26.587 [INFO ] [.internal.service.FeaturesServiceImpl] -     swagger-jersey2-jaxrs/1.5.8.v20160511-1038 (Wired to io.swagger.jaxrs/1.5.8 which is being refreshed)
10:00:26.808 [INFO ] [.internal.service.FeaturesServiceImpl] - Starting bundles:
10:00:26.809 [INFO ] [.internal.service.FeaturesServiceImpl] -   org.openhab.io.mqttembeddedbroker/2.5.0.M3
10:00:26.828 [INFO ] [broker.internal.EmbeddedBrokerService] - Broker persistence file: mqttembedded.bin
10:00:26.833 [INFO ] [io.moquette.broker.Server            ] - Configuring message interceptors...
10:00:26.835 [INFO ] [quette.interception.BrokerInterceptor] - Initializing broker interceptor. InterceptorIds=[]
10:00:26.837 [INFO ] [io.moquette.broker.Server            ] - Using default SSL context creator
10:00:26.839 [INFO ] [io.moquette.broker.Server            ] - An io.moquette.broker.security.AcceptAllAuthenticator authenticator instance will be used
10:00:26.840 [INFO ] [io.moquette.broker.Server            ] - Authorizator policy io.moquette.broker.security.PermitAllAuthorizatorPolicy instance will be used
10:00:26.841 [INFO ] [io.moquette.persistence.H2Builder    ] - Initializing H2 store
10:00:26.888 [ERROR] [org.openhab.io.mqttembeddedbroker    ] - bundle org.openhab.io.mqttembeddedbroker:2.5.0.M3 (295)[org.openhab.io.mqttembeddedbroker.internal.EmbeddedBrokerService(296)] : The activate method has thrown an exception
java.lang.IllegalArgumentException: Could not deserialize [-84, -19, 0, 5, 115, 114, 0, 45, 105, 111, 46, 109, 111, 113, 117, 101, 116, 116, 101, 46, 98, 114, 111, 107, 101, 114, 46, 115, 117, 98, 115, 99, 114, 105, 112, 116, 105, 111, 110, 115, 46, 83, 117, 98, 115, 99, 114, 105, 112, 116, 105, 111, 110, -47, 11, -117, 54, 80, -6, 26, -58, 2, 0, 3, 76, 0, 8, 99, 108, 105, 101, 110, 116, 73, 100, 116, 0, 18, 76, 106, 97, 118, 97, 47, 108, 97, 110, 103, 47, 83, 116, 114, 105, 110, 103, 59, 76, 0, 12, 114, 101, 113, 117, 101, 115, 116, 101, 100, 81, 111, 115, 116, 0, 37, 76, 105, 111, 47, 110, 101, 116, 116, 121, 47, 104, 97, 110, 100, 108, 101, 114, 47, 99, 111, 100, 101, 99, 47, 109, 113, 116, 116, 47, 77, 113, 116, 116, 81, 111, 83, 59, 76, 0, 11, 116, 111, 112, 105, 99, 70, 105, 108, 116, 101, 114, 116, 0, 40, 76, 105, 111, 47, 109, 111, 113, 117, 101, 116, 116, 101, 47, 98, 114, 111, 107, 101, 114, 47, 115, 117, 98, 115, 99, 114, 105, 112, 116, 105, 111, 110, 115, 47, 84, 111, 112, 105, 99, 59, 120, 112, 116, 0, 20, 101, 109, 98, 101, 100,... [1.4.199/0]
        at org.h2.mvstore.DataUtils.newIllegalArgumentException(DataUtils.java:857) ~[?:?]
        at org.h2.mvstore.type.ObjectDataType.deserialize(ObjectDataType.java:376) ~[?:?]
        at org.h2.mvstore.type.ObjectDataType$SerializedObjectType.read(ObjectDataType.java:1547) ~[?:?]
        at org.h2.mvstore.type.ObjectDataType.read(ObjectDataType.java:231) ~[?:?]
        at org.h2.mvstore.type.ObjectDataType.read(ObjectDataType.java:114) ~[?:?]
        at org.h2.mvstore.Page$Leaf.readPayLoad(Page.java:1551) ~[?:?]
        at org.h2.mvstore.Page.read(Page.java:695) ~[?:?]
        at org.h2.mvstore.Page.read(Page.java:238) ~[?:?]
        at org.h2.mvstore.MVStore.readPage(MVStore.java:2187) ~[?:?]
        at org.h2.mvstore.MVMap.readPage(MVMap.java:554) ~[?:?]
        at org.h2.mvstore.MVMap.readOrCreateRootPage(MVMap.java:570) ~[?:?]
        at org.h2.mvstore.MVMap.setRootPos(MVMap.java:564) ~[?:?]
        at org.h2.mvstore.MVStore.openMap(MVStore.java:548) ~[?:?]
        at org.h2.mvstore.MVStore.openMap(MVStore.java:507) ~[?:?]
        at org.h2.mvstore.MVStore.openMap(MVStore.java:488) ~[?:?]
        at io.moquette.persistence.H2SubscriptionsRepository.<init>(H2SubscriptionsRepository.java:22) ~[?:?]
        at io.moquette.persistence.H2Builder.subscriptionsRepository(H2Builder.java:51) ~[?:?]
        at io.moquette.broker.Server.startServer(Server.java:167) ~[?:?]
        at org.openhab.io.mqttembeddedbroker.internal.EmbeddedBrokerService.startEmbeddedServer(EmbeddedBrokerService.java:310) ~[?:?]
        at org.openhab.io.mqttembeddedbroker.internal.EmbeddedBrokerService.initialize(EmbeddedBrokerService.java:195) ~[?:?]
        at org.openhab.io.mqttembeddedbroker.internal.EmbeddedBrokerService.activate(EmbeddedBrokerService.java:159) ~[?:?]
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:?]
        at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
        at java.lang.reflect.Method.invoke(Unknown Source) ~[?:?]
        at org.apache.felix.scr.impl.inject.methods.BaseMethod.invokeMethod(BaseMethod.java:228) ~[?:?]
        at org.apache.felix.scr.impl.inject.methods.BaseMethod.access$500(BaseMethod.java:41) ~[?:?]
        at org.apache.felix.scr.impl.inject.methods.BaseMethod$Resolved.invoke(BaseMethod.java:664) ~[?:?]
        at org.apache.felix.scr.impl.inject.methods.BaseMethod.invoke(BaseMethod.java:510) ~[?:?]
        at org.apache.felix.scr.impl.inject.methods.ActivateMethod.invoke(ActivateMethod.java:317) ~[?:?]
        at org.apache.felix.scr.impl.inject.methods.ActivateMethod.invoke(ActivateMethod.java:307) ~[?:?]
        at org.apache.felix.scr.impl.manager.SingleComponentManager.createImplementationObject(SingleComponentManager.java:340) ~[?:?]
        at org.apache.felix.scr.impl.manager.SingleComponentManager.createComponent(SingleComponentManager.java:114) ~[?:?]
        at org.apache.felix.scr.impl.manager.SingleComponentManager.getService(SingleComponentManager.java:982) ~[?:?]
        at org.apache.felix.scr.impl.manager.SingleComponentManager.getServiceInternal(SingleComponentManager.java:955) ~[?:?]
        at org.apache.felix.scr.impl.manager.SingleComponentManager.getService(SingleComponentManager.java:900) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse$1.run(ServiceFactoryUse.java:212) ~[?:?]
        at java.security.AccessController.doPrivileged(Native Method) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse.factoryGetService(ServiceFactoryUse.java:210) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse.getService(ServiceFactoryUse.java:111) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.ServiceConsumer$2.getService(ServiceConsumer.java:45) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.ServiceRegistrationImpl.getService(ServiceRegistrationImpl.java:508) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.getService(ServiceRegistry.java:461) ~[?:?]
        at org.eclipse.osgi.internal.framework.BundleContextImpl.getService(BundleContextImpl.java:624) ~[?:?]
        at com.eclipsesource.jaxrs.publisher.internal.ResourceTracker.addingService(ResourceTracker.java:39) ~[?:?]
        at org.osgi.util.tracker.ServiceTracker$Tracked.customizerAdding(ServiceTracker.java:941) ~[?:?]
        at org.osgi.util.tracker.ServiceTracker$Tracked.customizerAdding(ServiceTracker.java:870) ~[?:?]
        at org.osgi.util.tracker.AbstractTracked.trackAdding(AbstractTracked.java:256) ~[?:?]
        at org.osgi.util.tracker.AbstractTracked.track(AbstractTracked.java:229) ~[?:?]
        at org.osgi.util.tracker.ServiceTracker$Tracked.serviceChanged(ServiceTracker.java:901) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.FilteredServiceListener.serviceChanged(FilteredServiceListener.java:109) ~[?:?]
        at org.eclipse.osgi.internal.framework.BundleContextImpl.dispatchEvent(BundleContextImpl.java:920) ~[?:?]
        at org.eclipse.osgi.framework.eventmgr.EventManager.dispatchEvent(EventManager.java:230) ~[?:?]
        at org.eclipse.osgi.framework.eventmgr.ListenerQueue.dispatchEventSynchronous(ListenerQueue.java:148) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.publishServiceEventPrivileged(ServiceRegistry.java:862) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.publishServiceEvent(ServiceRegistry.java:801) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.ServiceRegistrationImpl.register(ServiceRegistrationImpl.java:127) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.registerService(ServiceRegistry.java:225) ~[?:?]
        at org.eclipse.osgi.internal.framework.BundleContextImpl.registerService(BundleContextImpl.java:469) ~[?:?]
        at org.apache.felix.scr.impl.manager.AbstractComponentManager$3.register(AbstractComponentManager.java:906) ~[?:?]
        at org.apache.felix.scr.impl.manager.AbstractComponentManager$3.register(AbstractComponentManager.java:892) ~[?:?]
        at org.apache.felix.scr.impl.manager.RegistrationManager.changeRegistration(RegistrationManager.java:128) ~[?:?]
        at org.apache.felix.scr.impl.manager.AbstractComponentManager.registerService(AbstractComponentManager.java:959) ~[?:?]
        at org.apache.felix.scr.impl.manager.AbstractComponentManager.activateInternal(AbstractComponentManager.java:732) ~[?:?]
        at org.apache.felix.scr.impl.manager.AbstractComponentManager.enableInternal(AbstractComponentManager.java:666) ~[?:?]
        at org.apache.felix.scr.impl.manager.AbstractComponentManager.enable(AbstractComponentManager.java:432) ~[?:?]
        at org.apache.felix.scr.impl.manager.ConfigurableComponentHolder.enableComponents(ConfigurableComponentHolder.java:665) ~[?:?]
        at org.apache.felix.scr.impl.BundleComponentActivator.initialEnable(BundleComponentActivator.java:338) ~[?:?]
        at org.apache.felix.scr.impl.Activator.loadComponents(Activator.java:382) ~[?:?]
        at org.apache.felix.scr.impl.Activator.access$200(Activator.java:49) ~[?:?]
        at org.apache.felix.scr.impl.Activator$ScrExtension.start(Activator.java:264) ~[?:?]
        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:482) ~[?:?]
        at org.osgi.util.tracker.BundleTracker$Tracked.customizerModified(BundleTracker.java:415) ~[?:?]
        at org.osgi.util.tracker.AbstractTracked.track(AbstractTracked.java:232) ~[?:?]
        at org.osgi.util.tracker.BundleTracker$Tracked.bundleChanged(BundleTracker.java:444) ~[?:?]
        at org.eclipse.osgi.internal.framework.BundleContextImpl.dispatchEvent(BundleContextImpl.java:908) ~[?:?]
        at org.eclipse.osgi.framework.eventmgr.EventManager.dispatchEvent(EventManager.java:230) ~[?:?]
        at org.eclipse.osgi.framework.eventmgr.ListenerQueue.dispatchEventSynchronous(ListenerQueue.java:148) ~[?:?]
        at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEventPrivileged(EquinoxEventPublisher.java:213) ~[?:?]
        at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEvent(EquinoxEventPublisher.java:120) ~[?:?]
        at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEvent(EquinoxEventPublisher.java:112) ~[?:?]
        at org.eclipse.osgi.internal.framework.EquinoxContainerAdaptor.publishModuleEvent(EquinoxContainerAdaptor.java:168) ~[?:?]
        at org.eclipse.osgi.container.Module.publishEvent(Module.java:476) ~[?:?]
        at org.eclipse.osgi.container.Module.start(Module.java:467) ~[?:?]
        at org.eclipse.osgi.internal.framework.EquinoxBundle.start(EquinoxBundle.java:383) ~[?:?]
        at org.eclipse.osgi.internal.framework.EquinoxBundle.start(EquinoxBundle.java:402) ~[?:?]
        at org.apache.karaf.features.internal.service.BundleInstallSupportImpl.startBundle(BundleInstallSupportImpl.java:165) ~[?:?]
        at org.apache.karaf.features.internal.service.FeaturesServiceImpl.startBundle(FeaturesServiceImpl.java:1153) ~[?:?]
        at org.apache.karaf.features.internal.service.Deployer.deploy(Deployer.java:1036) ~[?:?]
        at org.apache.karaf.features.internal.service.FeaturesServiceImpl.doProvision(FeaturesServiceImpl.java:1062) ~[?:?]
        at org.apache.karaf.features.internal.service.FeaturesServiceImpl.lambda$doProvisionInThread$13(FeaturesServiceImpl.java:998) ~[?:?]
        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.ClassNotFoundException: io.moquette.broker.subscriptions.Subscription cannot be found by com.h2database.mvstore_1.4.199
        at org.eclipse.osgi.internal.loader.BundleLoader.findClassInternal(BundleLoader.java:484) ~[?:?]
        at org.eclipse.osgi.internal.loader.BundleLoader.findClass(BundleLoader.java:395) ~[?:?]
        at org.eclipse.osgi.internal.loader.BundleLoader.findClass(BundleLoader.java:387) ~[?:?]
        at org.eclipse.osgi.internal.loader.ModuleClassLoader.loadClass(ModuleClassLoader.java:150) ~[?:?]
        at java.lang.ClassLoader.loadClass(Unknown Source) ~[?:?]
        at java.lang.Class.forName0(Native Method) ~[?:?]
        at java.lang.Class.forName(Unknown Source) ~[?:?]
        at java.io.ObjectInputStream.resolveClass(Unknown Source) ~[?:?]
        at java.io.ObjectInputStream.readNonProxyDesc(Unknown Source) ~[?:?]
        at java.io.ObjectInputStream.readClassDesc(Unknown Source) ~[?:?]
        at java.io.ObjectInputStream.readOrdinaryObject(Unknown Source) ~[?:?]
        at java.io.ObjectInputStream.readObject0(Unknown Source) ~[?:?]
        at java.io.ObjectInputStream.readObject(Unknown Source) ~[?:?]
        at org.h2.mvstore.type.ObjectDataType.deserialize(ObjectDataType.java:374) ~[?:?]
        ... 96 more
10:00:26.930 [INFO ] [broker.internal.EmbeddedBrokerService] - Broker persistence file: mqttembedded.bin
10:00:26.931 [INFO ] [io.moquette.broker.Server            ] - Configuring message interceptors...
10:00:26.936 [INFO ] [quette.interception.BrokerInterceptor] - Initializing broker interceptor. InterceptorIds=[]
10:00:26.936 [INFO ] [io.moquette.broker.Server            ] - Using default SSL context creator
10:00:26.937 [INFO ] [io.moquette.broker.Server            ] - An io.moquette.broker.security.AcceptAllAuthenticator authenticator instance will be used
10:00:26.940 [INFO ] [io.moquette.broker.Server            ] - Authorizator policy io.moquette.broker.security.PermitAllAuthorizatorPolicy instance will be used
10:00:26.941 [INFO ] [io.moquette.persistence.H2Builder    ] - Initializing H2 store
10:00:26.943 [ERROR] [org.openhab.io.mqttembeddedbroker    ] - bundle org.openhab.io.mqttembeddedbroker:2.5.0.M3 (295)[org.openhab.io.mqttembeddedbroker.internal.EmbeddedBrokerService(296)] : The activate method has thrown an exception
java.lang.IllegalStateException: The file is locked: nio:C:\Users\regis\openhab2\userdata\mqttembedded.bin [1.4.199/7]
        at org.h2.mvstore.DataUtils.newIllegalStateException(DataUtils.java:883) ~[?:?]
        at org.h2.mvstore.FileStore.open(FileStore.java:166) ~[?:?]
        at org.h2.mvstore.MVStore.<init>(MVStore.java:390) ~[?:?]
        at org.h2.mvstore.MVStore$Builder.open(MVStore.java:3343) ~[?:?]
        at io.moquette.persistence.H2Builder.initStore(H2Builder.java:40) ~[?:?]
        at io.moquette.broker.Server.startServer(Server.java:166) ~[?:?]
        at org.openhab.io.mqttembeddedbroker.internal.EmbeddedBrokerService.startEmbeddedServer(EmbeddedBrokerService.java:310) ~[?:?]
        at org.openhab.io.mqttembeddedbroker.internal.EmbeddedBrokerService.initialize(EmbeddedBrokerService.java:195) ~[?:?]
        at org.openhab.io.mqttembeddedbroker.internal.EmbeddedBrokerService.activate(EmbeddedBrokerService.java:159) ~[?:?]
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:?]
        at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[?:?]
        at java.lang.reflect.Method.invoke(Unknown Source) ~[?:?]
        at org.apache.felix.scr.impl.inject.methods.BaseMethod.invokeMethod(BaseMethod.java:228) ~[?:?]
        at org.apache.felix.scr.impl.inject.methods.BaseMethod.access$500(BaseMethod.java:41) ~[?:?]
        at org.apache.felix.scr.impl.inject.methods.BaseMethod$Resolved.invoke(BaseMethod.java:664) ~[?:?]
        at org.apache.felix.scr.impl.inject.methods.BaseMethod.invoke(BaseMethod.java:510) ~[?:?]
        at org.apache.felix.scr.impl.inject.methods.ActivateMethod.invoke(ActivateMethod.java:317) ~[?:?]
        at org.apache.felix.scr.impl.inject.methods.ActivateMethod.invoke(ActivateMethod.java:307) ~[?:?]
        at org.apache.felix.scr.impl.manager.SingleComponentManager.createImplementationObject(SingleComponentManager.java:340) ~[?:?]
        at org.apache.felix.scr.impl.manager.SingleComponentManager.createComponent(SingleComponentManager.java:114) ~[?:?]
        at org.apache.felix.scr.impl.manager.SingleComponentManager.getService(SingleComponentManager.java:982) ~[?:?]
        at org.apache.felix.scr.impl.manager.SingleComponentManager.getServiceInternal(SingleComponentManager.java:955) ~[?:?]
        at org.apache.felix.scr.impl.manager.AbstractComponentManager.activateInternal(AbstractComponentManager.java:756) ~[?:?]
        at org.apache.felix.scr.impl.manager.AbstractComponentManager.enableInternal(AbstractComponentManager.java:666) ~[?:?]
        at org.apache.felix.scr.impl.manager.AbstractComponentManager.enable(AbstractComponentManager.java:432) ~[?:?]
        at org.apache.felix.scr.impl.manager.ConfigurableComponentHolder.enableComponents(ConfigurableComponentHolder.java:665) ~[?:?]
        at org.apache.felix.scr.impl.BundleComponentActivator.initialEnable(BundleComponentActivator.java:338) ~[?:?]
        at org.apache.felix.scr.impl.Activator.loadComponents(Activator.java:382) ~[?:?]
        at org.apache.felix.scr.impl.Activator.access$200(Activator.java:49) ~[?:?]
        at org.apache.felix.scr.impl.Activator$ScrExtension.start(Activator.java:264) ~[?:?]
        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:482) ~[?:?]
        at org.osgi.util.tracker.BundleTracker$Tracked.customizerModified(BundleTracker.java:415) ~[?:?]
        at org.osgi.util.tracker.AbstractTracked.track(AbstractTracked.java:232) ~[?:?]
        at org.osgi.util.tracker.BundleTracker$Tracked.bundleChanged(BundleTracker.java:444) ~[?:?]
        at org.eclipse.osgi.internal.framework.BundleContextImpl.dispatchEvent(BundleContextImpl.java:908) ~[?:?]
        at org.eclipse.osgi.framework.eventmgr.EventManager.dispatchEvent(EventManager.java:230) ~[?:?]
        at org.eclipse.osgi.framework.eventmgr.ListenerQueue.dispatchEventSynchronous(ListenerQueue.java:148) ~[?:?]
        at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEventPrivileged(EquinoxEventPublisher.java:213) ~[?:?]
        at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEvent(EquinoxEventPublisher.java:120) ~[?:?]
        at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEvent(EquinoxEventPublisher.java:112) ~[?:?]
        at org.eclipse.osgi.internal.framework.EquinoxContainerAdaptor.publishModuleEvent(EquinoxContainerAdaptor.java:168) ~[?:?]
        at org.eclipse.osgi.container.Module.publishEvent(Module.java:476) ~[?:?]
        at org.eclipse.osgi.container.Module.start(Module.java:467) ~[?:?]
        at org.eclipse.osgi.internal.framework.EquinoxBundle.start(EquinoxBundle.java:383) ~[?:?]
        at org.eclipse.osgi.internal.framework.EquinoxBundle.start(EquinoxBundle.java:402) ~[?:?]
        at org.apache.karaf.features.internal.service.BundleInstallSupportImpl.startBundle(BundleInstallSupportImpl.java:165) ~[?:?]
        at org.apache.karaf.features.internal.service.FeaturesServiceImpl.startBundle(FeaturesServiceImpl.java:1153) ~[?:?]
        at org.apache.karaf.features.internal.service.Deployer.deploy(Deployer.java:1036) ~[?:?]
        at org.apache.karaf.features.internal.service.FeaturesServiceImpl.doProvision(FeaturesServiceImpl.java:1062) ~[?:?]
        at org.apache.karaf.features.internal.service.FeaturesServiceImpl.lambda$doProvisionInThread$13(FeaturesServiceImpl.java:998) ~[?:?]
        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.nio.channels.OverlappingFileLockException
        at sun.nio.ch.SharedFileLockTable.checkList(Unknown Source) ~[?:?]
        at sun.nio.ch.SharedFileLockTable.add(Unknown Source) ~[?:?]
        at sun.nio.ch.FileChannelImpl.tryLock(Unknown Source) ~[?:?]
        at org.h2.store.fs.FileNio.tryLock(FilePathNio.java:121) ~[?:?]
        at java.nio.channels.FileChannel.tryLock(Unknown Source) ~[?:?]
        at org.h2.mvstore.FileStore.open(FileStore.java:163) ~[?:?]
        ... 56 more
10:00:26.951 [WARN ] [org.openhab.io.mqttembeddedbroker    ] - FrameworkEvent WARNING - org.openhab.io.mqttembeddedbroker
org.osgi.framework.ServiceException: org.apache.felix.scr.impl.manager.SingleComponentManager.getService() returned a null service object
        at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse.factoryGetService(ServiceFactoryUse.java:232) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse.getService(ServiceFactoryUse.java:111) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.ServiceConsumer$2.getService(ServiceConsumer.java:45) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.ServiceRegistrationImpl.getService(ServiceRegistrationImpl.java:508) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.getService(ServiceRegistry.java:461) ~[?:?]
        at org.eclipse.osgi.internal.framework.BundleContextImpl.getService(BundleContextImpl.java:624) ~[?:?]
        at com.eclipsesource.jaxrs.publisher.internal.ResourceTracker.addingService(ResourceTracker.java:39) ~[?:?]
        at org.osgi.util.tracker.ServiceTracker$Tracked.customizerAdding(ServiceTracker.java:941) ~[?:?]
        at org.osgi.util.tracker.ServiceTracker$Tracked.customizerAdding(ServiceTracker.java:870) ~[?:?]
        at org.osgi.util.tracker.AbstractTracked.trackAdding(AbstractTracked.java:256) ~[?:?]
        at org.osgi.util.tracker.AbstractTracked.track(AbstractTracked.java:229) ~[?:?]
        at org.osgi.util.tracker.ServiceTracker$Tracked.serviceChanged(ServiceTracker.java:901) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.FilteredServiceListener.serviceChanged(FilteredServiceListener.java:109) ~[?:?]
        at org.eclipse.osgi.internal.framework.BundleContextImpl.dispatchEvent(BundleContextImpl.java:920) ~[?:?]
        at org.eclipse.osgi.framework.eventmgr.EventManager.dispatchEvent(EventManager.java:230) ~[?:?]
        at org.eclipse.osgi.framework.eventmgr.ListenerQueue.dispatchEventSynchronous(ListenerQueue.java:148) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.publishServiceEventPrivileged(ServiceRegistry.java:862) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.publishServiceEvent(ServiceRegistry.java:801) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.ServiceRegistrationImpl.register(ServiceRegistrationImpl.java:127) ~[?:?]
        at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.registerService(ServiceRegistry.java:225) ~[?:?]
        at org.eclipse.osgi.internal.framework.BundleContextImpl.registerService(BundleContextImpl.java:469) ~[?:?]
        at org.apache.felix.scr.impl.manager.AbstractComponentManager$3.register(AbstractComponentManager.java:906) ~[?:?]
        at org.apache.felix.scr.impl.manager.AbstractComponentManager$3.register(AbstractComponentManager.java:892) ~[?:?]
        at org.apache.felix.scr.impl.manager.RegistrationManager.changeRegistration(RegistrationManager.java:128) ~[?:?]
        at org.apache.felix.scr.impl.manager.AbstractComponentManager.registerService(AbstractComponentManager.java:959) ~[?:?]
        at org.apache.felix.scr.impl.manager.AbstractComponentManager.activateInternal(AbstractComponentManager.java:732) ~[?:?]
        at org.apache.felix.scr.impl.manager.AbstractComponentManager.enableInternal(AbstractComponentManager.java:666) ~[?:?]
        at org.apache.felix.scr.impl.manager.AbstractComponentManager.enable(AbstractComponentManager.java:432) ~[?:?]
        at org.apache.felix.scr.impl.manager.ConfigurableComponentHolder.enableComponents(ConfigurableComponentHolder.java:665) ~[?:?]
        at org.apache.felix.scr.impl.BundleComponentActivator.initialEnable(BundleComponentActivator.java:338) ~[?:?]
        at org.apache.felix.scr.impl.Activator.loadComponents(Activator.java:382) ~[?:?]
        at org.apache.felix.scr.impl.Activator.access$200(Activator.java:49) ~[?:?]
        at org.apache.felix.scr.impl.Activator$ScrExtension.start(Activator.java:264) ~[?:?]
        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:482) ~[?:?]
        at org.osgi.util.tracker.BundleTracker$Tracked.customizerModified(BundleTracker.java:415) ~[?:?]
        at org.osgi.util.tracker.AbstractTracked.track(AbstractTracked.java:232) ~[?:?]
        at org.osgi.util.tracker.BundleTracker$Tracked.bundleChanged(BundleTracker.java:444) ~[?:?]
        at org.eclipse.osgi.internal.framework.BundleContextImpl.dispatchEvent(BundleContextImpl.java:908) ~[?:?]
        at org.eclipse.osgi.framework.eventmgr.EventManager.dispatchEvent(EventManager.java:230) ~[?:?]
        at org.eclipse.osgi.framework.eventmgr.ListenerQueue.dispatchEventSynchronous(ListenerQueue.java:148) ~[?:?]
        at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEventPrivileged(EquinoxEventPublisher.java:213) ~[?:?]
        at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEvent(EquinoxEventPublisher.java:120) ~[?:?]
        at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEvent(EquinoxEventPublisher.java:112) ~[?:?]
        at org.eclipse.osgi.internal.framework.EquinoxContainerAdaptor.publishModuleEvent(EquinoxContainerAdaptor.java:168) ~[?:?]
        at org.eclipse.osgi.container.Module.publishEvent(Module.java:476) ~[?:?]
        at org.eclipse.osgi.container.Module.start(Module.java:467) ~[?:?]
        at org.eclipse.osgi.internal.framework.EquinoxBundle.start(EquinoxBundle.java:383) ~[?:?]
        at org.eclipse.osgi.internal.framework.EquinoxBundle.start(EquinoxBundle.java:402) ~[?:?]
        at org.apache.karaf.features.internal.service.BundleInstallSupportImpl.startBundle(BundleInstallSupportImpl.java:165) ~[?:?]
        at org.apache.karaf.features.internal.service.FeaturesServiceImpl.startBundle(FeaturesServiceImpl.java:1153) ~[?:?]
        at org.apache.karaf.features.internal.service.Deployer.deploy(Deployer.java:1036) ~[?:?]
        at org.apache.karaf.features.internal.service.FeaturesServiceImpl.doProvision(FeaturesServiceImpl.java:1062) ~[?:?]
        at org.apache.karaf.features.internal.service.FeaturesServiceImpl.lambda$doProvisionInThread$13(FeaturesServiceImpl.java:998) ~[?:?]
        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) ~[?:?]
10:00:27.017 [INFO ] [.internal.service.FeaturesServiceImpl] - Done.
10:00:27.063 [INFO ] [smarthome.event.ExtensionEvent       ] - Extension 'misc-mqttbroker' has been installed.

When I then try to add manually an MQTT broker thing I have the following log

MQTT Broker thing log
10:06:26.200 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - ‘mqtt:broker:8a390cec’ changed from UNINITIALIZED to INITIALIZING
10:06:26.210 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - ‘mqtt:broker:8a390cec’ changed from INITIALIZING to OFFLINE
10:06:26.236 [INFO ] [o.transport.mqtt.MqttBrokerConnection] - Starting MQTT broker connection to ‘192.168.1.40’ with clientid paho648077132000 and file store ‘C:\Users\regis\openhab2\userdata\mqtt\192.168.1.40’
10:06:28.292 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - ‘mqtt:broker:8a390cec’ changed from OFFLINE to OFFLINE (COMMUNICATION_ERROR): Timeout
10:06:28.292 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - ‘mqtt:broker:8a390cec’ changed from OFFLINE (COMMUNICATION_ERROR): Timeout to OFFLINE (COMMUNICATION_ERROR): Unable to connect to server

this is your issue. Please follow steps in linked thread for workaround. The issue is now solved but the change did not make it in time for M4 release. Any of the snapshots shortly after M4 should contain the fix

link to git hub issue

more info