[SOLVED] MQTT for SONOFF/TASMOTA this is difficult

[boris03 (Boris)]

still the same problem on the pi

[vzorglub (Vincent Regaud)]

Un comment the lines for user and password:

broker.user=openhabian
broker.pwd=openhabian

On the tasmota:

Benutzer: openhabian
Passwort: openhabian

Reboot both

[boris03 (Boris)]

restarted both

same error

[boris03 (Boris)]

Now I was adding mqtt: to the beginning of all the 4 lines in cfg file and I am getting a different result. Something was happening! I am confused that the log shows now some old test id´s used before - where is that comong from how does it remember the old not working id´s??

log
2018-05-09 18:45:29.283 [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) [224:org.openhab.io.transport.mqtt:1.11.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-05-09 18:45:29.284 [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) [224:org.openhab.io.transport.mqtt:1.11.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-05-09 18:45:29.303 [ERROR] [t.mqtt.internal.MqttBrokerConnection] - MQTT connection to ‘broker’ was lost: Connection lost : ReasonCode 32109 : Cause : null
2018-05-09 18:45:29.305 [ERROR] [t.mqtt.internal.MqttBrokerConnection] - MQTT connection to ‘oh2mqtt’ was lost: Connection lost : ReasonCode 32109 : Cause : null
2018-05-09 18:45:29.305 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting connection helper to periodically try restore connection to broker ‘broker’
2018-05-09 18:45:29.306 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting connection helper to periodically try restore connection to broker ‘oh2mqtt’
2018-05-09 18:45:31.614 [INFO ] [basic.internal.servlet.WebAppServlet] - Stopped Basic UI
2018-05-09 18:45:39.319 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘oh2mqtt’
2018-05-09 18:45:39.319 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘broker’
2018-05-09 18:45:45.213 [INFO ] [ing.zwave.handler.ZWaveSerialHandler] - Stopped ZWave serial handler
2018-05-09 18:45:45.488 [INFO ] [penhab.io.transport.mqtt.MqttService] - Stopping broker connection ‘oh2mqtt’
2018-05-09 18:45:45.491 [INFO ] [penhab.io.transport.mqtt.MqttService] - Stopping broker connection ‘domus1’
2018-05-09 18:45:45.492 [INFO ] [penhab.io.transport.mqtt.MqttService] - Stopping broker connection ‘broker’
2018-05-09 18:45:45.493 [INFO ] [penhab.io.transport.mqtt.MqttService] - Stopping broker connection ‘sonoff1’
2018-05-09 18:45:45.663 [INFO ] [ui.habmin.internal.servlet.HABminApp] - Stopped HABmin servlet
2018-05-09 18:45:46.111 [INFO ] [arthome.ui.paper.internal.PaperUIApp] - Stopped Paper UI
2018-05-09 18:45:46.133 [INFO ] [panel.internal.HABPanelDashboardTile] - Stopped HABPanel
2018-05-09 18:45:46.148 [INFO ] [er.internal.HomeBuilderDashboardTile] - Stopped Home Builder
2018-05-09 18:45:46.173 [INFO ] [.dashboard.internal.DashboardService] - Stopped dashboard
2018-05-09 18:46:17.106 [INFO ] [er.internal.HomeBuilderDashboardTile] - Started Home Builder at /homebuilder
2018-05-09 18:46:18.495 [INFO ] [.dashboard.internal.DashboardService] - Started dashboard at http://192.168.1.3:8080
2018-05-09 18:46:18.507 [INFO ] [.dashboard.internal.DashboardService] - Started dashboard at https://192.168.1.3:8443
2018-05-09 18:46:34.305 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘fs20.items’
2018-05-09 18:46:34.406 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘G11.items’
2018-05-09 18:46:35.057 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘mapdb.persist’
2018-05-09 18:46:41.785 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘G11.rules’
2018-05-09 18:46:42.076 [INFO ] [thome.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007
2018-05-09 18:46:42.732 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘G11.sitemap’
2018-05-09 18:46:46.101 [INFO ] [basic.internal.servlet.WebAppServlet] - Started Basic UI at /basicui/app
2018-05-09 18:46:46.371 [INFO ] [arthome.ui.paper.internal.PaperUIApp] - Started Paper UI at /paperui
2018-05-09 18:46:46.484 [INFO ] [panel.internal.HABPanelDashboardTile] - Started HABPanel at /habpanel
2018-05-09 18:46:47.179 [WARN ] [io.transport.cul.CULLifecycleManager] - CUL config is NULL, doing nothing
2018-05-09 18:46:47.488 [INFO ] [penhab.io.transport.mqtt.MqttService] - MQTT Service initialization completed.
2018-05-09 18:46:47.492 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘oh2mqtt’
2018-05-09 18:46:47.521 [INFO ] [b.core.service.AbstractActiveService] - FritzBox refresh Service has been started
2018-05-09 18:46:47.713 [INFO ] [ui.habmin.internal.servlet.HABminApp] - Started HABmin servlet at /habmin
2018-05-09 18:46:47.816 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘domus1’
2018-05-09 18:46:47.895 [ERROR] [penhab.io.transport.mqtt.MqttService] - Error starting broker connection
org.eclipse.paho.client.mqttv3.MqttException: Unable to connect to server
at org.eclipse.paho.client.mqttv3.internal.TCPNetworkModule.start(TCPNetworkModule.java:79) [224:org.openhab.io.transport.mqtt:1.11.0]
at org.eclipse.paho.client.mqttv3.internal.ClientComms$ConnectBG.run(ClientComms.java:650) [224:org.openhab.io.transport.mqtt:1.11.0]
at java.lang.Thread.run(Thread.java:748) [?:?]
Caused by: java.net.ConnectException: Connection refused (Connection refused)
at java.net.PlainSocketImpl.socketConnect(Native Method) ~[?:?]
at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350) ~[?:?]
at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206) ~[?:?]
at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188) ~[?:?]
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392) ~[?:?]
at java.net.Socket.connect(Socket.java:589) ~[?:?]
at org.eclipse.paho.client.mqttv3.internal.TCPNetworkModule.start(TCPNetworkModule.java:70) ~[?:?]
… 2 more
2018-05-09 18:46:47.942 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘broker’
2018-05-09 18:46:48.005 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘sonoff1’
2018-05-09 18:46:48.087 [ERROR] [penhab.io.transport.mqtt.MqttService] - Error starting broker connection
org.eclipse.paho.client.mqttv3.MqttException: Unable to connect to server
at org.eclipse.paho.client.mqttv3.internal.TCPNetworkModule.start(TCPNetworkModule.java:79) [224:org.openhab.io.transport.mqtt:1.11.0]
at org.eclipse.paho.client.mqttv3.internal.ClientComms$ConnectBG.run(ClientComms.java:650) [224:org.openhab.io.transport.mqtt:1.11.0]
at java.lang.Thread.run(Thread.java:748) [?:?]
Caused by: java.net.ConnectException: Connection refused (Connection refused)
at java.net.PlainSocketImpl.socketConnect(Native Method) ~[?:?]
at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350) ~[?:?]
at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206) ~[?:?]
at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188) ~[?:?]
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392) ~[?:?]
at java.net.Socket.connect(Socket.java:589) ~[?:?]
at org.eclipse.paho.client.mqttv3.internal.TCPNetworkModule.start(TCPNetworkModule.java:70) ~[?:?]

[vzorglub (Vincent Regaud)]

You have old config files somewhere
You need to do a bit of a clean-up

Follow this:

Clear the Cache

Often when one encounters a problem with OH, particularly after an update, OH will refuse to run or certain parts of OH stop working. Some reported errors include: 500 or 404 errors when accessing the UIs lots of exceptions from Jetty or other core components in openhab.log OH refuses to start at all The first step in debugging the problem is to clear the tmp and cache. Installed OH If you are running an installed OH (openHABian, installed using apt or yum): openhab-cli stop openhab-cl…

[boris03 (Boris)]

I think it is done !!!

Deleted content of these tmp and cache folders

and realized by the way that the system is building an additioanl file mqtt.config with this content:

So the Openhab.log is now quite clean and shows me only two lines for MQTT.
I assume this is correct?

[vzorglub (Vincent Regaud)]

Yes this is correct

Now on your tasmota:

Benutzer: openhab
Passwort: openhabian

Restart it

[boris03 (Boris)]

says connected (verbunden)

in some other comments I saw people adding commands like:

broker.retain=true
broker.async=false
is this necessary or handled via tasmota already?

[vzorglub (Vincent Regaud)]

No these are not necessary leave them as they are
You are now ready to get data from tasmota via mosquitto to openHAB!!
Well done

[boris03 (Boris)]

Vincent you are the man!!!

[boris03 (Boris)]

Please one last question,

Now both clients are connected to the broker and I can start with the items …
I just think about adding additional sonoffs, how are they separated?

Is it then the topic name as defined in each sonoff?
If Yes where is that reflected in that command example below?

Switch Switch1 {mqtt=">[broker:myhome/bedroom/switch1:command:ON:1],>[broker:myhome/bedroom/switch1:command:OFF:0],<[broker:myhome/bedroom/switch1:state:ON:1],<[broker:myhome/bedroom/switch1:state:OFF:0"}

[vzorglub (Vincent Regaud)]

This sonoff that we have just configured has the topic of sonoff1

So your item becomes:

Switch Switch1 {mqtt=">[broker:cmnd/sonoff1/POWER:command:*:default],<[broker:stat/sonoff1/POWER:state:default" }

See:

arendst/Sonoff-Tasmota

[epicurean (J Wee)]

I am having trouble getting proper binding from MQTT broker (eclipse) to Openhab2.3 . Both are installed as docker containers inside Synology 6.2. Both containers IP set as net=host.
I just want to control 2 tasmota flashed Sonoff basic with openhab. Not even out of the gate with the first one.

I followed the posts in this thread but have been unsuccessful.

my mqtt.cfg is:
broker.url=tcp://192.168.1.113:1883
broker.user=“openhab”
broker.pwd=“openhabian”

My first sonoff configuration:
host: 192.168.1.113
port: 1883
user: openhab
password: openhabian
client-id : sonoff1

What am I doing wrong?

[vzorglub (Vincent Regaud)]

Remove the quotes in the mqtt.cfg:

broker.url=tcp://192.168.1.113:1883
broker.user=openhab
broker.pwd=openhabian

[epicurean (J Wee)]

Thank you.
This is my log after a restart after taking out the quotes:

2018-09-25 07:18:17.534 [INFO ] [er.internal.HomeBuilderDashboardTile] - Started Home Builder at /homebuilder
2018-09-25 07:18:18.524 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Time zone set to ‘Asia/Kuala_Lumpur’.
2018-09-25 07:18:18.526 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Locale set to ‘en_SG’.
2018-09-25 07:18:19.072 [INFO ] [.dashboard.internal.DashboardService] - Started Dashboard at http://192.168.1.113:8080
2018-09-25 07:18:19.076 [INFO ] [.dashboard.internal.DashboardService] - Started Dashboard at https://192.168.1.113:8443
2018-09-25 07:18:22.659 [INFO ] [thome.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007
2018-09-25 07:18:23.478 [INFO ] [basic.internal.servlet.WebAppServlet] - Started Basic UI at /basicui/app
2018-09-25 07:18:23.626 [INFO ] [arthome.ui.paper.internal.PaperUIApp] - Started Paper UI at /paperui
2018-09-25 07:18:23.678 [INFO ] [panel.internal.HABPanelDashboardTile] - Started HABPanel at /habpanel
2018-09-25 07:18:23.873 [WARN ] [penhab.io.transport.mqtt.MqttService] - Unrecognized property: broker.clientid
2018-09-25 07:18:23.873 [INFO ] [penhab.io.transport.mqtt.MqttService] - MQTT Service initialization completed.
2018-09-25 07:18:23.874 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘’
2018-09-25 07:18:24.139 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘broker’

[vzorglub (Vincent Regaud)]

Yeah it’s working

[epicurean (J Wee)]

What is the error that says unrecognized property:broker.clientid?
Do I need to add a broker.clientId line in my mqtt.cfg?

[vzorglub (Vincent Regaud)]

It’s only a warning.
Show me your mqtt.cfg. All of it.

[epicurean (J Wee)]

This is all of my mqtt.cfg

broker.url=tcp://192.168.1.113:1883
broker.clientId=XPE6
broker.user=openhab
broker.pwd=openhabian

I just saw an error in my log:

2018-09-25 08:00:02.563 [ERROR] [org.apache.felix.configadmin ] - Cannot use configuration org.openhab.mqtt for [org.openhab.core.scriptengine.action.ActionService, org.osgi.service.cm.ManagedService, id=318, bundle=200/mvn:org.openhab.action/org.openhab.action.mqtt/1.12.0]: No visibility to configuration bound to mvn:org.openhab.io/org.openhab.io.transport.mqtt/1.12.0

[vzorglub (Vincent Regaud)]

Clear the cache see:

Clear the Cache

Often when one encounters a problem with OH, particularly after an update, OH will refuse to run or certain parts of OH stop working. Some reported errors include: 500 or 404 errors when accessing the UIs lots of exceptions from Jetty or other core components in openhab.log OH refuses to start at all The first step in debugging the problem is to clear the tmp and cache. Installed OH If you are running an installed OH (openHABian, installed using apt or yum): openhab-cli stop openhab-cl…