[SOLVED] MQTT will not connect

Hey there,
I’m trying to set up MQTT, but the log shows:

2018-10-28 00:17:57.258 [INFO ] [penhab.io.transport.mqtt.MqttService] - MQTT Service initialization completed.

2018-10-28 00:17:57.259 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘mosquitto’

2018-10-28 00:17:57.259 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘broker’

2018-10-28 00:17:57.293 [ERROR] [penhab.io.transport.mqtt.MqttService] - Error starting broker connection

org.eclipse.paho.client.mqttv3.MqttSecurityException: Not authorized to connect

at org.eclipse.paho.client.mqttv3.internal.ExceptionHelper.createMqttException(ExceptionHelper.java:28) [202:org.openhab.io.transport.mqtt:1.12.0]

at org.eclipse.paho.client.mqttv3.internal.ClientState.notifyReceivedAck(ClientState.java:990) [202:org.openhab.io.transport.mqtt:1.12.0]

at org.eclipse.paho.client.mqttv3.internal.CommsReceiver.run(CommsReceiver.java:118) [202:org.openhab.io.transport.mqtt:1.12.0]

at java.lang.Thread.run(Thread.java:748) [?:?]

2018-10-28 00:21:53.612 [INFO ] [penhab.io.transport.mqtt.MqttService] - MQTT Service initialization completed.

2018-10-28 00:21:53.613 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘mosquitto’

2018-10-28 00:21:53.623 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘broker’

2018-10-28 00:21:53.651 [ERROR] [penhab.io.transport.mqtt.MqttService] - Error starting broker connection

org.eclipse.paho.client.mqttv3.MqttSecurityException: Not authorized to connect

at org.eclipse.paho.client.mqttv3.internal.ExceptionHelper.createMqttException(ExceptionHelper.java:28) [202:org.openhab.io.transport.mqtt:1.12.0]

at org.eclipse.paho.client.mqttv3.internal.ClientState.notifyReceivedAck(ClientState.java:990) [202:org.openhab.io.transport.mqtt:1.12.0]

at org.eclipse.paho.client.mqttv3.internal.CommsReceiver.run(CommsReceiver.java:118) [202:org.openhab.io.transport.mqtt:1.12.0]

at java.lang.Thread.run(Thread.java:748) [?:?]

2018-10-28 00:24:03.487 [ERROR] [t.mqtt.internal.MqttBrokerConnection] - MQTT connection to broker was lost

org.eclipse.paho.client.mqttv3.MqttException: Connection lost

at org.eclipse.paho.client.mqttv3.internal.CommsReceiver.run(CommsReceiver.java:146) [202:org.openhab.io.transport.mqtt:1.12.0]

at java.lang.Thread.run(Thread.java:748) [?:?]

Caused by: java.io.EOFException

at java.io.DataInputStream.readByte(DataInputStream.java:267) ~[?:?]

at org.eclipse.paho.client.mqttv3.internal.wire.MqttInputStream.readMqttWireMessage(MqttInputStream.java:65) ~[?:?]

at org.eclipse.paho.client.mqttv3.internal.CommsReceiver.run(CommsReceiver.java:107) ~[?:?]

… 1 more

2018-10-28 00:24:03.490 [ERROR] [t.mqtt.internal.MqttBrokerConnection] - MQTT connection to ‘mosquitto’ was lost: Connection lost : ReasonCode 32109 : Cause : null

2018-10-28 00:24:03.491 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting connection helper to periodically try restore connection to broker ‘mosquitto’

2018-10-28 00:24:04.637 [INFO ] [basic.internal.servlet.WebAppServlet] - Stopped Basic UI

2018-10-28 00:24:13.499 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘mosquitto’

2018-10-28 00:24:14.917 [INFO ] [penhab.io.transport.mqtt.MqttService] - Stopping broker connection ‘mosquitto’

2018-10-28 00:24:14.917 [INFO ] [penhab.io.transport.mqtt.MqttService] - Stopping broker connection ‘broker’

2018-10-28 00:24:15.208 [INFO ] [arthome.ui.paper.internal.PaperUIApp] - Stopped Paper UI

2018-10-28 00:24:15.227 [INFO ] [panel.internal.HABPanelDashboardTile] - Stopped HABPanel

2018-10-28 00:24:15.232 [INFO ] [er.internal.HomeBuilderDashboardTile] - Stopped Home Builder

2018-10-28 00:24:15.241 [INFO ] [.dashboard.internal.DashboardService] - Stopped Dashboard

Here is my services/mqtt.cfg:

mosquitto.url=tcp://localhost:1883
#mosquitto.clientId=
mosquitto.user=openhab
mosquitto.pwd=habian
mosquitto.qos=0
mosquitto.retain=true
mosquitto.async=false
#mosquitto.lwt=

Of course mosquitto is running, and i can connect from MQTTfx using the username (openhab) and password (habian)

Try this:

mosquitto.url=tcp://127.0.0.1:1883
#mosquitto.clientId=
mosquitto.user=openhab
mosquitto.pwd=habian
#mosquitto.qos=0
#mosquitto.retain=true
#mosquitto.async=false
#mosquitto.lwt=

No, that didn’t seem to do the trick

2018-10-28 00:50:20.696 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘mosquitto’

2018-10-28 00:51:47.731 [ERROR] [t.mqtt.internal.MqttBrokerConnection] - MQTT connection to broker was lost

org.eclipse.paho.client.mqttv3.MqttException: Connection lost

at org.eclipse.paho.client.mqttv3.internal.CommsReceiver.run(CommsReceiver.java:146) [202:org.openhab.io.transport.mqtt:1.12.0]

at java.lang.Thread.run(Thread.java:748) [?:?]

Caused by: java.io.EOFException

at java.io.DataInputStream.readByte(DataInputStream.java:267) ~[?:?]

at org.eclipse.paho.client.mqttv3.internal.wire.MqttInputStream.readMqttWireMessage(MqttInputStream.java:65) ~[?:?]

at org.eclipse.paho.client.mqttv3.internal.CommsReceiver.run(CommsReceiver.java:107) ~[?:?]

… 1 more

2018-10-28 00:51:47.781 [ERROR] [t.mqtt.internal.MqttBrokerConnection] - MQTT connection to ‘mosquitto’ was lost: Connection lost : ReasonCode 32109 : Cause : null

2018-10-28 00:51:47.781 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting connection helper to periodically try restore connection to broker ‘mosquitto’

2018-10-28 00:51:48.904 [INFO ] [basic.internal.servlet.WebAppServlet] - Stopped Basic UI

2018-10-28 00:51:57.788 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘mosquitto’

2018-10-28 00:51:59.099 [INFO ] [penhab.io.transport.mqtt.MqttService] - Stopping broker connection ‘mosquitto’

2018-10-28 00:51:59.353 [INFO ] [arthome.ui.paper.internal.PaperUIApp] - Stopped Paper UI

2018-10-28 00:51:59.364 [INFO ] [panel.internal.HABPanelDashboardTile] - Stopped HABPanel

2018-10-28 00:51:59.371 [INFO ] [er.internal.HomeBuilderDashboardTile] - Stopped Home Builder

2018-10-28 00:51:59.380 [INFO ] [.dashboard.internal.DashboardService] - Stopped Dashboard

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

2018-10-28 00:52:24.757 [INFO ] [er.internal.HomeBuilderDashboardTile] - Started Home Builder at /homebuilder

2018-10-28 00:52:26.328 [INFO ] [.dashboard.internal.DashboardService] - Started Dashboard at http://192.168.1.68:8080

2018-10-28 00:52:26.336 [INFO ] [.dashboard.internal.DashboardService] - Started Dashboard at https://192.168.1.68:8443

2018-10-28 00:52:35.343 [INFO ] [thome.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007

2018-10-28 00:52:36.765 [INFO ] [basic.internal.servlet.WebAppServlet] - Started Basic UI at /basicui/app

2018-10-28 00:52:36.953 [INFO ] [arthome.ui.paper.internal.PaperUIApp] - Started Paper UI at /paperui

2018-10-28 00:52:37.024 [INFO ] [panel.internal.HABPanelDashboardTile] - Started HABPanel at /habpanel

2018-10-28 00:52:37.331 [INFO ] [penhab.io.transport.mqtt.MqttService] - MQTT Service initialization completed.

2018-10-28 00:52:37.344 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘mosquitto’

here is my mosquitto log:

1540678350: mosquitto version 1.4.10 (build date Wed, 17 Oct 2018 19:03:03 +0200) starting
1540678350: Config loaded from /etc/mosquitto/mosquitto.conf.
1540678350: Opening ipv4 listen socket on port 1883.
1540678350: Opening ipv6 listen socket on port 1883.
1540678374: New connection from 127.0.0.1 on port 1883.
1540678374: New client connected from 127.0.0.1 as paho27327795303 (c1, k60, u’openhab’).
1540678374: New connection from 127.0.0.1 on port 1883.
1540678374: Socket error on client , disconnecting.
1540678374: New connection from 127.0.0.1 on port 1883.
1540678374: Socket error on client , disconnecting.
1540678527: Client paho27327795303 disconnected.
1540678527: New connection from 192.168.1.68 on port 1883.
1540678527: New client connected from 192.168.1.68 as paho27327795303 (c1, k60, u’openhab’).
1540678527: New connection from 127.0.0.1 on port 1883.
1540678527: Socket error on client , disconnecting.
1540678527: New connection from 127.0.0.1 on port 1883.
1540678527: Socket error on client , disconnecting.
1540678677: New connection from 127.0.0.1 on port 1883.
1540678677: Socket error on client , disconnecting.
1540678677: New connection from 127.0.0.1 on port 1883.
1540678677: Socket error on client , disconnecting.
1540678913: Client paho27327795303 disconnected.
1540678913: New connection from 127.0.0.1 on port 1883.
1540678913: New client connected from 127.0.0.1 as paho27327795303 (c1, k60, u’openhab’).
1540678913: New connection from 127.0.0.1 on port 1883.
1540678913: Socket error on client , disconnecting.
1540678913: New connection from 127.0.0.1 on port 1883.
1540678913: Socket error on client , disconnecting.
1540679043: Error in poll: Interrupted system call.
1540679043: mosquitto version 1.4.10 terminating
1540679069: mosquitto version 1.4.10 (build date Wed, 17 Oct 2018 19:03:03 +0200) starting
1540679069: Config loaded from /etc/mosquitto/mosquitto.conf.
1540679069: Opening ipv4 listen socket on port 1883.
1540679069: Opening ipv6 listen socket on port 1883.
1540679093: New connection from 127.0.0.1 on port 1883.
1540679093: New client connected from 127.0.0.1 as paho26801249050 (c1, k60, u’openhab’).
1540679866: Error in poll: Interrupted system call.
1540679866: mosquitto version 1.4.10 terminating
1540679891: mosquitto version 1.4.10 (build date Wed, 17 Oct 2018 19:03:03 +0200) starting
1540679891: Config loaded from /etc/mosquitto/mosquitto.conf.
1540679891: Opening ipv4 listen socket on port 1883.
1540679891: Opening ipv6 listen socket on port 1883.
1540679912: New connection from 127.0.0.1 on port 1883.
1540679912: New client connected from 127.0.0.1 as paho24296032746 (c1, k60, u’openhab’).
1540680128: Error in poll: Interrupted system call.
1540680128: mosquitto version 1.4.10 terminating
1540680154: mosquitto version 1.4.10 (build date Wed, 17 Oct 2018 19:03:03 +0200) starting
1540680154: Config loaded from /etc/mosquitto/mosquitto.conf.
1540680154: Opening ipv4 listen socket on port 1883.
1540680154: Opening ipv6 listen socket on port 1883.
1540680175: New connection from 127.0.0.1 on port 1883.
1540680175: New client connected from 127.0.0.1 as paho24509276138 (c1, k60, u’openhab’).
1540680620: Client paho24509276138 disconnected.
1540680620: New connection from 127.0.0.1 on port 1883.
1540680620: New client connected from 127.0.0.1 as paho24509276138 (c1, k60, u’openhab’).
1540680707: Error in poll: Interrupted system call.
1540680707: mosquitto version 1.4.10 terminating
1540680733: mosquitto version 1.4.10 (build date Wed, 17 Oct 2018 19:03:03 +0200) starting
1540680733: Config loaded from /etc/mosquitto/mosquitto.conf.
1540680733: Opening ipv4 listen socket on port 1883.
1540680733: Opening ipv6 listen socket on port 1883.
1540680757: New connection from 127.0.0.1 on port 1883.

1540680707: Error in poll: Interrupted system call.

And

2018-10-28 00:51:47.781 [ERROR] [t.mqtt.internal.MqttBrokerConnection] - MQTT connection to 'mosquitto' was lost: Connection lost : ReasonCode 32109 : Cause : null

Are (I think the same error)
I don’t know, to be honest.

Do you have the mqtt action installed?

No, its fresh install, mqtt was the first binding I was going to install.

Here is my mosquitto.conf

pid_file /var/run/mosquitto.pid

persistence true
persistence_location /var/lib/mosquitto/

log_dest file /var/log/mosquitto/mosquitto.log

include_dir /etc/mosquitto/conf.d

allow_anonymous false
password_file /etc/mosquitto/passwordfile.txt

Comment these out
This is trouble waiting to happen
mqtt persistence is difficult to tame

#persistence true
#persistence_location /var/lib/mosquitto/

And restart your whole system

ok, did that, same error persists

2018-10-28 00:52:37.344 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘mosquitto’

2018-10-28 01:13:50.054 [ERROR] [t.mqtt.internal.MqttBrokerConnection] - MQTT connection to broker was lost

org.eclipse.paho.client.mqttv3.MqttException: Connection lost

at org.eclipse.paho.client.mqttv3.internal.CommsReceiver.run(CommsReceiver.java:146) [202:org.openhab.io.transport.mqtt:1.12.0]

at java.lang.Thread.run(Thread.java:748) [?:?]

Caused by: java.io.EOFException

at java.io.DataInputStream.readByte(DataInputStream.java:267) ~[?:?]

at org.eclipse.paho.client.mqttv3.internal.wire.MqttInputStream.readMqttWireMessage(MqttInputStream.java:65) ~[?:?]

at org.eclipse.paho.client.mqttv3.internal.CommsReceiver.run(CommsReceiver.java:107) ~[?:?]

… 1 more

2018-10-28 01:13:50.114 [ERROR] [t.mqtt.internal.MqttBrokerConnection] - MQTT connection to ‘mosquitto’ was lost: Connection lost : ReasonCode 32109 : Cause : null

2018-10-28 01:13:50.114 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting connection helper to periodically try restore connection to broker ‘mosquitto’

I just updated my passwordsfile created a second user, and I am able to use this one from MQTTfx.

Uninstall the binding
Restart openHAB
Install the binding again…
I never seen this error before. So it’s worth a try

1 Like

ok, i uninstalled using “bundle:uninstall 200” and rebooted the whole system. But that error is still showing up in the log. so I guess I didn’t really uninstall i. Can you tell me how, please
EDIT: ok, i uninstalled through paper ui and this time its gone.

Same thing…

018-10-28 01:44:43.887 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘mosquitto’

2018-10-28 01:46:54.266 [ERROR] [t.mqtt.internal.MqttBrokerConnection] - MQTT connection to broker was lost

org.eclipse.paho.client.mqttv3.MqttException: Connection lost

at org.eclipse.paho.client.mqttv3.internal.CommsReceiver.run(CommsReceiver.java:146) [209:org.openhab.io.transport.mqtt:1.12.0]

at java.lang.Thread.run(Thread.java:748) [?:?]

Caused by: java.io.EOFException

at java.io.DataInputStream.readByte(DataInputStream.java:267) ~[?:?]

at org.eclipse.paho.client.mqttv3.internal.wire.MqttInputStream.readMqttWireMessage(MqttInputStream.java:65) ~[?:?]

at org.eclipse.paho.client.mqttv3.internal.CommsReceiver.run(CommsReceiver.java:107) ~[?:?]

… 1 more

2018-10-28 01:46:54.327 [ERROR] [t.mqtt.internal.MqttBrokerConnection] - MQTT connection to ‘mosquitto’ was lost: Connection lost : ReasonCode 32109 : Cause : null

2018-10-28 01:46:54.328 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting connection helper to periodically try restore connection to broker ‘mosquitto’

Just some more info. Its a fresh debian 9 server running on a VirtualBox vm. Mosquito (and openHAB) were installed using the openHABian install tool.

OK, I’ve tried switching to the testing release. no change. Please can anyone help me?

I have found something in the forum:
Uncomment and change the clientId. Make sure that the clientId is DIFFERENT for ALL clients

mosquitto.url=tcp://127.0.0.1:1883
mosquitto.clientId=openhab2
mosquitto.user=openhab
mosquitto.pwd=habian
#mosquitto.qos=0
#mosquitto.retain=true
#mosquitto.async=false
#mosquitto.lwt=

It seems like that did it. Thanks a lot!

Please click the square box on the post that provided the solution to mark as solved.

Thanks.

Please mark the thread as solved. Thanks
You need to tick the post that provided the solution, like this:
hc_292