MQTT Client Gateway / Node Controller / OTA

[Samuel235]

Exact same behaviour is happening. This is what is being printed to the serial monitor:

IP: 192.168.0.22
0;255;3;0;9;Attempting MQTT connection...
0;255;3;0;9;MQTT connected
0;255;3;0;9;Sending message on topic: Gateway1-out/0/255/0/0/18
0;255;3;0;9;Message arrived on topic: Gateway1-in/4/1/1/0/2
0;255;3;0;9;!TSF:MSG:SEND,0-0-4-4,s=1,c=1,t=2,pt=0,l=1,sg=0,ft=0,st=NACK:0
IP: 192.168.0.22
0;255;3;0;9;Attempting MQTT connection...
0;255;3;0;9;MQTT connected
0;255;3;0;9;Sending message on topic: Gateway1-out/0/255/0/0/18
0;255;3;0;9;Message arrived on topic: Gateway1-in/4/1/1/0/2
0;255;3;0;9;!TSF:MSG:SEND,0-0-4-4,s=1,c=1,t=2,pt=0,l=1,sg=0,ft=0,st=NACK:0
IP: 192.168.0.22
0;255;3;0;9;Attempting MQTT connection...
0;255;3;0;9;MQTT connected
0;255;3;0;9;Sending message on topic: Gateway1-out/0/255/0/0/18
0;255;3;0;9;Message arrived on topic: Gateway1-in/4/1/1/0/2
0;255;3;0;9;!TSF:MSG:SEND,0-0-4-4,s=1,c=1,t=2,pt=0,l=1,sg=0,ft=0,st=NACK:0

I'm not even certain that anything is wrong here. It just keeps reconnecting to the MQTT server, but it is actually working but i'm concerned about why its doing such inside of the serial monitor. I read somewhere that it does a 'touching base' case to keep it alive or something, but i also recall someone saying that was every 15 seconds or so, this is every 8 seconds (about). Do you happen to know what its sending to a MQTT topic 0/255/0/0/18 for, is this standard behaviour or just mine?

[maghac]

Not sure if mine did that, I can check later.

I'm using the latest Arduino IDE (1.8.1 or something like that)

[Samuel235]

@maghac - The same as the one I've been using apart from the last test then. Thanks for confirming that.

If you wouldn't mind checking a serial output on your later, that would be really appreciated.

[maghac]

Type 18 is the heartbeat message type, I think this is the last element in your MQTT topic so it looks fine I think. Can you monitor the MQTT broker and see what messages are passing through it? (e.g if you can see something being sent by the sensors)

[Samuel235]

@maghac - I know the sensors are sending messages, the gateway is responding as it should to them, i was just concerned about the gateway keep connecting itself to the MQTT server, i was a little worried in case there is a feature in Mosquitto broker that declines the connection if it detects any sort of brute force or anything like that.

[Samuel235]

@maghac

On my MQTT server i'm sure enough receiving a message from the gateway every time it says its reconnected in the serial monitor, sending its version number to the server. By the looks of the serial monitor, its actually reconnecting and not just sending a new message to the MQTT topic. I'm confused to why this is doing this, I had just assumed that the heartbeat message is just a re-sending on a message on that topic. Would like to know if this is the normal behaviour of the gateway to keep constantly reconnecting.

[maghac]

Mine doesn't reconnect. Here's the serial monitor on startup:

0;255;3;0;9;MCO:BGN:INIT GW,CP=RNNGE--,VER=2.1.1
0;255;3;0;9;TSF:LRT:OK
0;255;3;0;9;TSM:INIT
0;255;3;0;9;TSF:WUR:MS=0
scandone
state: 0 -> 2 (b0)
state: 2 -> 3 (0)
state: 3 -> 5 (10)
add 0
aid 14
cnt 

connected with hacker, channel 9
dhcp client start...
0;255;3;0;9;TSM:INIT:TSP OK
0;255;3;0;9;TSM:INIT:GW MODE
0;255;3;0;9;TSM:READY:ID=0,PAR=0,DIS=0
0;255;3;0;9;MCO:REG:NOT NEEDED
f r0, scandone
....ip:192.168.1.215,mask:255.255.255.0,gw:192.168.1.1
.IP: 192.168.1.215
0;255;3;0;9;MCO:BGN:STP
OTA init
Ready
IP address: 192.168.1.215
0;255;3;0;9;MCO:BGN:INIT OK,TSP=1
IP: 192.168.1.215
0;255;3;0;9;Attempting MQTT connection...
0;255;3;0;9;MQTT connected
0;255;3;0;9;Sending message on topic: mysensors-out/0/255/0/0/18
0;255;3;0;9;Message arrived on topic: mysensors-in/200/255/3/0/6
0;255;3;0;9;!TSF:RTE:200 UNKNOWN
0;255;3;0;9;!TSF:MSG:SEND,0-0-200-200,s=255,c=3,t=6,pt=0,l=1,sg=0,ft=0,st=NACK:M
0;255;3;0;9;Message arrived on topic: mysensors-in/254/255/3/0/6
0;255;3;0;9;!TSF:MSG:SEND,0-0-254-254,s=255,c=3,t=6,pt=0,l=1,sg=0,ft=0,st=NACK:M
0;255;3;0;9;Message arrived on topic: mysensors-in/222/255/3/0/6
0;255;3;0;9;!TSF:MSG:SEND,0-0-222-222,s=255,c=3,t=6,pt=0,l=1,sg=0,ft=0,st=NACK:M
0;255;3;0;9;Message arrived on topic: mysensors-in/222/255/3/0/1
0;255;3;0;9;!TSF:MSG:SEND,0-0-222-222,s=255,c=3,t=1,pt=0,l=10,sg=0,ft=0,st=NACK:1485810579
0;255;3;0;9;Message arrived on topic: mysensors-in/123/255/3/0/6
0;255;3;0;9;!TSF:MSG:SEND,0-0-123-123,s=255,c=3,t=6,pt=0,l=1,sg=0,ft=0,st=NACK:M
0;255;3;0;9;Message arrived on topic: mysensors-in/255/255/3/0/4
0;255;3;0;9;TSF:MSG:SEND,0-0-255-255,s=255,c=3,t=4,pt=0,l=3,sg=0,ft=0,st=OK:234
0;255;3;0;9;Message arrived on topic: mysensors-in/227/255/3/0/6
0;255;3;0;9;!TSF:MSG:SEND,0-0-227-227,s=255,c=3,t=6,pt=0,l=1,sg=0,ft=0,st=NACK:M
0;255;3;0;9;Message arrived on topic: mysensors-in/227/1/1/0/24
0;255;3;0;9;!TSF:MSG:SEND,0-0-227-227,s=1,c=1,t=24,pt=0,l=3,sg=0,ft=0,st=NACK:102
0;255;3;0;9;Message arrived on topic: mysensors-in/233/255/3/0/6
0;255;3;0;9;!TSF:MSG:SEND,0-0-233-233,s=255,c=3,t=6,pt=0,l=1,sg=0,ft=0,st=NACK:M
0;255;3;0;9;Message arrived on topic: mysensors-in/234/255/3/0/6
0;255;3;0;9;!TSF:MSG:SEND,0-0-234-234,s=255,c=3,t=6,pt=0,l=1,sg=0,ft=0,st=NACK:M
0;255;3;0;9;TSF:MSG:READ,227-227-0,s=1,c=1,t=17,pt=5,l=4,sg=0:7160
0;255;3;0;9;Sending message on topic: mysensors-out/227/1/1/0/17
0;255;3;0;9;TSF:MSG:READ,227-227-0,s=1,c=1,t=24,pt=5,l=4,sg=0:530
0;255;3;0;9;Sending message on topic: mysensors-out/227/1/1/0/24
0;255;3;0;9;TSF:MSG:READ,227-227-0,s=1,c=1,t=18,pt=7,l=5,sg=0:0.5300
0;255;3;0;9;Sending message on topic: mysensors-out/227/1/1/0/18
pm open,type:2 0
0;255;3;0;9;TSF:MSG:READ,227-227-0,s=1,c=1,t=17,pt=5,l=4,sg=0:7175
0;255;3;0;9;Sending message on topic: mysensors-out/227/1/1/0/17
0;255;3;0;9;TSF:MSG:READ,227-227-0,s=1,c=1,t=24,pt=5,l=4,sg=0:570
0;255;3;0;9;Sending message on topic: mysensors-out/227/1/1/0/24
0;255;3;0;9;TSF:MSG:READ,227-227-0,s=1,c=1,t=18,pt=7,l=5,sg=0:0.5700

After this, it's just continously getting data from sensor 227 (my power meter). My mosquitto broker is getting this:

mysensors-out/0/255/0/0/18 2.1.1
mysensors-out/227/1/1/0/17 7160
mysensors-out/227/1/1/0/24 530
mysensors-out/227/1/1/0/18 0.5300
mysensors-out/227/1/1/0/17 7175
mysensors-out/227/1/1/0/24 570
mysensors-out/227/1/1/0/18 0.5700
mysensors-out/227/1/1/0/17 7195

etc etc - it's just the one message on startup.

[Samuel235]

@maghac - Right okay. Atleast i now have someone else's to compare too. So, something is pushing it off the network OR it can't hold its connection.

My start up sequence:

0;255;3;0;9;MCO:BGN:INIT GW,CP=RNNGA--,VER=2.1.1
0;255;3;0;9;TSM:INIT
0;255;3;0;9;TSF:WUR:MS=0
0;255;3;0;9;TSM:INIT:TSP OK
0;255;3;0;9;TSM:INIT:GW MODE
0;255;3;0;9;TSM:READY:ID=0,PAR=0,DIS=0
0;255;3;0;9;MCO:REG:NOT NEEDED
IP: 192.168.0.22
0;255;3;0;9;MCO:BGN:STP
0;255;3;0;9;MCO:BGN:INIT OK,TSP=1
IP: 192.168.0.22
0;255;3;0;9;Attempting MQTT connection...
IP: 192.168.0.22
0;255;3;0;9;Attempting MQTT connection...
IP: 192.168.0.22
0;255;3;0;9;Attempting MQTT connection...
IP: 192.168.0.22
0;255;3;0;9;Attempting MQTT connection...
IP: 192.168.0.22
0;255;3;0;9;Attempting MQTT connection...
IP: 192.168.0.22
0;255;3;0;9;Attempting MQTT connection...
IP: 192.168.0.22
0;255;3;0;9;Attempting MQTT connection...
IP: 192.168.0.22
0;255;3;0;9;Attempting MQTT connection...
IP: 192.168.0.22
0;255;3;0;9;Attempting MQTT connection...
IP: 192.168.0.22
0;255;3;0;9;Attempting MQTT connection...
IP: 192.168.0.22
0;255;3;0;9;Attempting MQTT connection...
0;255;3;0;9;MQTT connected
0;255;3;0;9;Sending message on topic: Gateway1-out/0/255/0/0/18
0;255;3;0;9;Message arrived on topic: Gateway1-in/4/1/1/0/2
0;255;3;0;9;!TSF:MSG:SEND,0-0-4-4,s=1,c=1,t=2,pt=0,l=1,sg=0,ft=0,st=NACK:0

The start is different to mine, that is probably because you're running that on a ESP8266, right?

I have connected to the MQTT server with MQTTFX, which is a MQTT monitoring tool. Not too familiar with it right now but i can't see the server dropping any connections or anything, it almost seems like the gateway is stuck in a loop.

[gohan]

Did you try to swap the mega for an arduino uno? Or swap the w5100 shield? Just to see if there is any difference, so we can exclude any hw issues

[Samuel235]

@gohan - The only thing that be causing this is software as the 1.6 branch works perfectly on this setup with the same sketch but back when it was 1.6 development.

So, if i'm thinking correctly, even if there is a issue between software and hardware, it should be fixable through software, hope this makes sense to anyone other than myself. I don't have an UNO, the only other thing i have is a nano. I'm currently using a W5100 shield, not module, but i do have some modules here, but they were a pain to get working before and hence why i made the switch to the shield.

EDIT: I can confirm that the shield is working properly as i have ran a http test sketch and i'm able to communicate from my web browser to the arduino. So it must be a software issue.

[Samuel235]

Update: I have tried MySensors versions V2.0, V2.1.1 and even the development branch. From what I can work out, V1.6 when it was a development branch got released as V2.0. But that isn't working either, not sure what state it was in before I changed to V2.1.1 as i never monitored the gateway before i reinstalled the new version.

Either way, none are working, they're all giving me the same result. Therefor i'm attempting to find an issue else where on the network other than MySensors. I'm going to try a new MQTT broker, on a different machine. If this gives the same result then its time to troubleshoot my network. Then if that doesn't show anything i think its safe to revert back to looking through my Gateway software.

[Samuel235]

I can confirm that the issues is not MySensors, I've just created a virtual machine running Ubuntu and installed Mosquitto there. Connected the gateway and perfect functionality. Everything is working as intended with a nice silent serial output until a message is sent to the gateway.

[maghac]

I suppose this is on your own LAN, so there are no firewalls or anything that could block the MQTT traffic? Can you see anything in the mosquitto log?

[Samuel235]

@maghac - It is on the LAN, no firewalls that are stopping it unless they're on the ubuntu box themselves but i had a quick look at that at the start of my issues and the two ports were open for MQTT. So unless something is up with the allowance settings, then its not that. I'm about to find the location of the MQTT logs to check that now. I'm connected to the MQTT server with MQTT.fx and the log is filling with commands, can't see anything obvious right now. Will check the logs on the machine to see any issues recorded.

Would you expect to see anything in any of the logs specifically or just check them all? Do you happen to know where they're located?

[Samuel235]

UPDATE: The issue has been resolved.

I have no clue why it has only just became and issue because my OpenHAB hasn't been upgraded or modified since day one. But the issue was that the OpenHAB install was attempting to join the MQTT broker (on the same system) with the same ID as the MySensors Gateway. Once i changed my config of OpenHAB MQTT connection, its all working perfect now.

Please, if you see anyone having this issue, point them to this message. I may add it to the controller section or ask a MOD/ADMIN to add it to the OpenHAB controller page if they feel its something that maybe worth pointing out.

Thank you all for your continued help with this. Now, time to get back to the issue at heart. I will be testing the use of MyController today without having to disconnect OpenHAB at all.

[mfalkvidd]

@Samuel235 great that you found the problem, and thanks for reporting back.

[Samuel235]

@mfalkvidd - In the process of monitoring the network now to check everything is still normal behaviour. I may be getting a random message published, keeping an eye on this. I would say if I do have an issue, it has nothing to do with software though :)

I'm looking into MyController as we speak just for the OTA updates alone then returning to normal controller.

[Samuel235]

Update: I've got a MQTT/persistence error on MyController, so i'm waiting on a software developer for them to advise me on a solution.

[jkandasa]

@Samuel235 What is the error are you facing? Did you report anywhere?

[Samuel235]

@jkandasa - You have replied to my post, just about to post a reply for you.

For others joining about this error, please see linked thread as this thread is just for the use of MyController for OTA updates only.