[SOLVED] MySensors MQTT Gateway - offline

ribaaa

Re: OpenHAB Mysensors binding 2.4: cant get mqtt gateway online

I have strange problem with MQTT:
MySensors MQTT Gateway is offline, allthough lof is at one point saying that is connected?!

Here is log:

2019-07-06 18:21:56.815 [DEBUG] [nsors.handler.MySensorsBridgeHandler] - Initialization of the MySensors bridge

2019-07-06 18:21:56.862 [DEBUG] [ensors.factory.MySensorsCacheFactory] - Cache file: given_ids.cached exist.

2019-07-06 18:21:56.868 [DEBUG] [ensors.factory.MySensorsCacheFactory] - Cache (given_ids) content: []

2019-07-06 18:21:56.911 [DEBUG] [rotocol.mqtt.MySensorsMqttConnection] - Enabling connection watchdog

2019-07-06 18:21:56.937 [DEBUG] [org.openhab.binding.mysensors       ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.DiscoveryService}={service.id=404, service.bundleid=242, service.scope=singleton} - org.openhab.binding.mysensors

2019-07-06 18:21:56.944 [DEBUG] [.discovery.MySensorsDiscoveryService] - Starting MySensors discovery scan

2019-07-06 18:21:56.947 [DEBUG] [nsors.handler.MySensorsBridgeHandler] - Initialization of the MySensors bridge DONE!

2019-07-06 18:21:56.941 [DEBUG] [rotocol.mqtt.MySensorsMqttConnection] - Connected to MQTT broker!

2019-07-06 18:21:56.991 [DEBUG] [rotocol.mqtt.MySensorsMqttConnection] - Adding consumer for topic: mysensors-in/+/+/+/+/+

2019-07-06 18:21:57.029 [DEBUG] [rsAbstractConnection$MySensorsWriter] - Sending to MySensors: 0;0;3;0;2;

2019-07-06 18:21:57.036 [DEBUG] [rotocol.mqtt.MySensorsMqttConnection] - Sending MQTT Message: Topic: mysensors-out, Message: 0;0;3;0;2;

2019-07-06 18:21:58.045 [DEBUG] [rsAbstractConnection$MySensorsWriter] - Sending to MySensors: 0;0;3;0;2;

2019-07-06 18:21:58.082 [DEBUG] [rotocol.mqtt.MySensorsMqttConnection] - Sending MQTT Message: Topic: mysensors-out, Message: 0;0;3;0;2;

2019-07-06 18:21:59.026 [DEBUG] [rsAbstractConnection$MySensorsWriter] - Sending to MySensors: 0;0;3;0;2;

2019-07-06 18:21:59.029 [DEBUG] [rotocol.mqtt.MySensorsMqttConnection] - Sending MQTT Message: Topic: mysensors-out, Message: 0;0;3;0;2;

2019-07-06 18:22:00.026 [DEBUG] [rsAbstractConnection$MySensorsWriter] - Sending to MySensors: 0;0;3;0;2;

2019-07-06 18:22:00.030 [DEBUG] [rotocol.mqtt.MySensorsMqttConnection] - Sending MQTT Message: Topic: mysensors-out, Message: 0;0;3;0;2;

2019-07-06 18:22:01.026 [DEBUG] [rsAbstractConnection$MySensorsWriter] - Sending to MySensors: 0;0;3;0;2;

2019-07-06 18:22:01.029 [DEBUG] [rotocol.mqtt.MySensorsMqttConnection] - Sending MQTT Message: Topic: mysensors-out, Message: 0;0;3;0;2;

2019-07-06 18:22:02.027 [ERROR] [rotocol.mqtt.MySensorsMqttConnection] - Cannot start reading/writing thread, probably sync message (I_VERSION) not received. Try set startupCheckEnabled to false

2019-07-06 18:22:02.058 [INFO ] [ateway.MySensorsNetworkSanityChecker] - Network Sanity Checker thread stopped

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

2019-07-06 18:22:02.086 [hingStatusInfoChangedEvent] - 'mysensors:bridge-mqtt:728b59f4' changed from INITIALIZING to OFFLINE

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

2019-07-06 18:22:02.092 [DEBUG] [ensors.factory.MySensorsCacheFactory] - Writing on cache given_ids, content: []

2019-07-06 18:22:02.105 [ERROR] [rotocol.mqtt.MySensorsMqttConnection] - Failed connecting to bridge...next retry in 10 seconds (Retry No.:0)

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

2019-07-06 18:23:22.767 [hingStatusInfoChangedEvent] - 'mqtt:systemBroker:mosquitto' changed from UNINITIALIZED to REMOVING

Any idea what this means

2019-07-06 18:22:02.027 [ERROR] [rotocol.mqtt.MySensorsMqttConnection] - Cannot start reading/writing thread, probably sync message (I_VERSION) not received. Try set startupCheckEnabled to false

Mosquitto log looks like it is working OK, at least to me?!

1562430021: mosquitto version 1.4.10 terminating
1562430038: mosquitto version 1.4.10 (build date Wed, 13 Feb 2019 00:45:38 +0000) starting
1562430038: Config loaded from /etc/mosquitto/mosquitto.conf.
1562430038: Opening ipv4 listen socket on port 1883.
1562430038: Opening ipv6 listen socket on port 1883.
1562430085: New connection from 127.0.0.1 on port 1883.
1562430085: New client connected from 127.0.0.1 as paho44685311961 (c1, k60, u'openhabian').
1562430085: Sending CONNACK to paho44685311961 (0, 0)
1562430116: Received SUBSCRIBE from paho44685311961
1562430116:     mysensors-in/+/+/+/+/+ (QoS 0)
1562430116: paho44685311961 0 mysensors-in/+/+/+/+/+
1562430116: Sending SUBACK to paho44685311961
1562430117: Received PUBLISH from paho44685311961 (d0, q0, r0, m0, 'mysensors-out/0/0/3/0/2', ... (0 bytes))
1562430118: Received PUBLISH from paho44685311961 (d0, q0, r0, m0, 'mysensors-out/0/0/3/0/2', ... (0 bytes))
1562430119: Received PUBLISH from paho44685311961 (d0, q0, r0, m0, 'mysensors-out/0/0/3/0/2', ... (0 bytes))
1562430120: Received PUBLISH from paho44685311961 (d0, q0, r0, m0, 'mysensors-out/0/0/3/0/2', ... (0 bytes))
1562430121: Received PUBLISH from paho44685311961 (d0, q0, r0, m0, 'mysensors-out/0/0/3/0/2', ... (0 bytes))
1562430181: Received PINGREQ from paho44685311961

TimO

Well, the Openhab and Mosquitto side looks good so far. I don't see a connection from the MySensors MQTT gateway in den Mosquitto log.
What gateway are you using?

ribaaa

MySensors MQTT gateway is offline.
I can not make it working .....
Here are my settings

org.eclipse.smarthome.mqttbroker.cfg

name=mosquitto
host=localhost
secure=false
port=1883
username=openhabian
retain=false
clientId=openhabRibaaa

mqtt-eventbus.cfg

broker=mosquitto

MySensors MQTT Gateway

Broker Name = mosquitto
Subscription Topic = mysensors-in
Publish Topic = mysensors-out
Enabled: "Enabled the startup check"
Enabled: "Enabled network sanity check"

TimO

@ribaaa What type of MQTT gateway are you using? RPi, Arduino...? I don't see it in den Mosquitto log. The Openhab side looks good, but there is no gateway responding to the requests send to Mosquitto.

ribaaa

It is RPI (NRF24L01 connected to GPIO pins)

TimO

@ribaaa Is the MySensors gateway service running and connected to Mosquitto?

ribaaa

Sorry for stupid question.
How do I check this?
I have did all steps according to
https://forum.mysensors.org/topic/9346/getting-mysensors-mqtt-gateway-working-on-openhab-2-2-stable (I did mqtt broker according to OH 2.3 requirement)
and did not manged to get MySensors MQTT Gateway online

ribaaa

I think I managed to set MySensors gateway, but still MQTT GW in OH is offline
Make options were:

./configure --my-transport=rf24 --my-gateway=mqtt --my-controller-ip-address=127.0.0.1 --my-mqtt-publish-topic-prefix=mysensors-out --my-mqtt-subscribe-topic-prefix=mysensors-in --my-mqtt-client-id=RibaaaMQTTgw --my-debug=enable --my-mqtt-user=openhabian

Here is Mosquitto log

1562532386: Config loaded from /etc/mosquitto/mosquitto.conf.
1562532386: Opening ipv4 listen socket on port 1883.
1562532386: Opening ipv6 listen socket on port 1883.
1562532386: New connection from 127.0.0.1 on port 1883.
1562532386: New client connected from 127.0.0.1 as RibaaaMQTTgw (c1, k15).
1562532386: Sending CONNACK to RibaaaMQTTgw (0, 0)
1562532386: Received PUBLISH from RibaaaMQTTgw (d0, q0, r0, m0, 'mysensors-out/0/255/0/0/18', ... (5 bytes))
1562532386: Received SUBSCRIBE from RibaaaMQTTgw
1562532386:     mysensors-in/+/+/+/+/+ (QoS 0)
1562532386: RibaaaMQTTgw 0 mysensors-in/+/+/+/+/+
1562532386: Sending SUBACK to RibaaaMQTTgw
1562532424: Received PINGREQ from RibaaaMQTTgw
1562532424: Sending PINGRESP to RibaaaMQTTgw
1562532425: Received PUBLISH from RibaaaMQTTgw (d0, q0, r0, m0, 'mysensors-out/3/1/1/0/16', ... (1 bytes))
1562532425: Received PUBLISH from RibaaaMQTTgw (d0, q0, r0, m0, 'mysensors-out/3/254/1/0/38', ... (4 bytes))
1562532432: New connection from 127.0.0.1 on port 1883.
1562532433: New client connected from 127.0.0.1 as paho45203016857 (c1, k60, u'openhabian').
1562532433: Sending CONNACK to paho45203016857 (0, 0)
1562532439: Received PINGREQ from RibaaaMQTTgw
1562532439: Sending PINGRESP to RibaaaMQTTgw

RibaaaMQTTgw is MySensors GW
paho45203016857 is client from org.eclipse.smarthome.mqttbroker.cfg file ( I base that conclusion on username)

Here are MySensors logs

Jul 07 22:46:25 INFO  Starting gateway...
Jul 07 22:46:25 INFO  Protocol version - 2.3.1
Jul 07 22:46:26 DEBUG MCO:BGN:INIT GW,CP=RNNGL---,REL=255,VER=2.3.1
Jul 07 22:46:26 DEBUG TSF:LRT:OK
Jul 07 22:46:26 DEBUG TSM:INIT
Jul 07 22:46:26 DEBUG TSF:WUR:MS=0
Jul 07 22:46:26 DEBUG TSM:INIT:TSP OK
Jul 07 22:46:26 DEBUG TSM:INIT:GW MODE
Jul 07 22:46:26 DEBUG TSM:READY:ID=0,PAR=0,DIS=0
Jul 07 22:46:26 DEBUG MCO:REG:NOT NEEDED
Jul 07 22:46:26 DEBUG MCO:BGN:STP
Jul 07 22:46:26 DEBUG MCO:BGN:INIT OK,TSP=1
Jul 07 22:46:26 DEBUG GWT:RMQ:MQTT RECONNECT
Jul 07 22:46:26 ERROR connect: Connection refused
Jul 07 22:46:26 ERROR failed to connect
Jul 07 22:46:26 DEBUG TSM:READY:NWD REQ
Jul 07 22:46:26 DEBUG TSF:MSG:SEND,0-0-255-255,s=255,c=3,t=20,pt=0,l=0,sg=0,ft=0,st=OK:
Jul 07 22:46:26 DEBUG GWT:RMQ:MQTT RECONNECT
Jul 07 22:46:26 ERROR connect: Connection refused
Jul 07 22:46:26 ERROR failed to connect

..... more RECONNECT retries

Jul 07 22:46:26 DEBUG GWT:RMQ:MQTT RECONNECT
Jul 07 22:46:26 ERROR connect: Connection refused
Jul 07 22:46:26 ERROR failed to connect
Jul 07 22:46:26 DEBUG GWT:RMQ:MQTT RECONNECT
Jul 07 22:46:26 DEBUG connected to 127.0.0.1
Jul 07 22:46:26 DEBUG GWT:RMQ:MQTT CONNECTED
Jul 07 22:46:26 DEBUG GWT:TPS:TOPIC=mysensors-out/0/255/0/0/18,MSG SENT
Jul 07 22:46:33 DEBUG TSF:MSG:READ,3-3-0,s=1,c=1,t=16,pt=2,l=2,sg=0:1
Jul 07 22:46:33 DEBUG GWT:TPS:TOPIC=mysensors-out/3/1/1/0/16,MSG SENT
Jul 07 22:46:35 DEBUG TSF:MSG:READ,3-3-0,s=1,c=1,t=16,pt=2,l=2,sg=0:0

ribaaa

I managed to get it online...... somehow?!

TimO

@ribaaa My guess: you restarted Openhab or the binding. I'm glad it works now!

[SOLVED] MySensors MQTT Gateway - offline

24

11.7k

11.2k

113.1k