MySensors Binding: Variable V_TEMP not present

Add-ons Bindings
1

Hello all,

I’m trying to get MySensors working, and I’ve hit a problem.

I’m using a serial gateway, and I have a single temp/humidity node. I’m on Openhab 2.5.7. Everything seems to be OK, except the temp and humidity items aren’t updated - my gateway shows as online, as do the two things I have for Node1/Child0, and Node1/Child1.

Here’s what the logs say:

14:17:43.780 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298043717 TSF:MSG:READ,1-1-0,s=1,c=1,t=0,pt=7,l=5,sg=0:23.45
14:17:43.782 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 1;1;1;0;0;23.45
14:17:43.784 [DEBUG] [ors.internal.gateway.MySensorsGateway] - Node 1 found in gateway
14:17:43.785 [DEBUG] [ors.internal.gateway.MySensorsGateway] - Child 1 found in node 1
14:17:43.786 [WARN ] [ors.internal.gateway.MySensorsGateway] - Variable V_TEMP not present
14:17:43.788 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298043727 TSF:MSG:READ,1-1-0,s=0,c=1,t=1,pt=7,l=5,sg=0:58.04
14:17:43.788 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 1;0;1;0;1;58.04
14:17:43.788 [DEBUG] [ors.internal.gateway.MySensorsGateway] - Node 1 found in gateway
14:17:43.789 [DEBUG] [ors.internal.gateway.MySensorsGateway] - Child 0 found in node 1
14:17:43.789 [WARN ] [ors.internal.gateway.MySensorsGateway] - Variable V_HUM not present

Any help would be greatly appreciated.

Cheers,

Jon

2

Here’s a more complete log snippet from when the sensors starts:

14:27:35.840 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298636876 TSF:MSG:READ,1-1-255,s=255,c=3,t=7,pt=0,l=0,sg=0:
14:27:35.843 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298636882 TSF:MSG:BC
14:27:35.844 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298636886 TSF:MSG:FPAR REQ,ID=1
14:27:35.846 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298636890 TSF:PNG:SEND,TO=0
14:27:35.847 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298636894 TSF:CKU:OK
14:27:35.849 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298636897 TSF:MSG:GWL OK
14:27:35.963 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298637001 TSF:MSG:SEND,0-0-1-1,s=255,c=3,t=8,pt=1,l=1,sg=0,ft=0,st=OK:0
14:27:37.858 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298638904 TSF:MSG:READ,1-1-0,s=255,c=3,t=24,pt=1,l=1,sg=0:1
14:27:37.862 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298638911 TSF:MSG:PINGED,ID=1,HP=1
14:27:37.874 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298638916 TSF:MSG:SEND,0-0-1-1,s=255,c=3,t=25,pt=1,l=1,sg=0,ft=0,st=OK:1
14:27:37.885 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298638932 TSF:MSG:READ,1-1-0,s=255,c=3,t=15,pt=6,l=2,sg=0:0100
14:27:37.898 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298638941 TSF:MSG:SEND,0-0-1-1,s=255,c=3,t=15,pt=6,l=2,sg=0,ft=0,st=OK:0100
14:27:37.903 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298638949 TSF:MSG:READ,1-1-0,s=255,c=0,t=17,pt=0,l=5,sg=0:2.3.2
14:27:37.904 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 1;255;0;0;17;2.3.2
14:27:37.904 [DEBUG] [ors.internal.gateway.MySensorsGateway] - Presentation Message received
14:27:37.906 [DEBUG] [sensors.factory.MySensorsCacheFactory] - Writing on cache given_ids, content: [0,1]
14:27:37.912 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298638958 TSF:MSG:READ,1-1-0,s=255,c=3,t=6,pt=1,l=1,sg=0:0
14:27:37.912 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 1;255;3;0;6;0
14:27:37.913 [DEBUG] [ors.internal.gateway.MySensorsGateway] - I_CONFIG request received from M, answering: (is imperial?)false
14:27:37.913 [DEBUG] [orsAbstractConnection$MySensorsWriter] - Sending to MySensors: 1;255;3;0;6;M
14:27:37.926 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298638973 TSF:MSG:SEND,0-0-1-1,s=255,c=3,t=6,pt=0,l=1,sg=0,ft=0,st=OK:M
14:27:37.935 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298638982 TSF:MSG:READ,1-1-0,s=255,c=3,t=11,pt=0,l=22,sg=0:TemperatureAndHumidity
14:27:37.938 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 1;255;3;0;11;TemperatureAndHumidity
14:27:37.947 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298638993 TSF:MSG:READ,1-1-0,s=255,c=3,t=12,pt=0,l=3,sg=0:1.0
14:27:37.948 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 1;255;3;0;12;1.0
14:27:37.961 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298639005 TSF:MSG:READ,1-1-0,s=0,c=0,t=7,pt=0,l=8,sg=0:Humidity
14:27:37.962 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 1;0;0;0;7;Humidity
14:27:37.962 [DEBUG] [ors.internal.gateway.MySensorsGateway] - Presentation Message received
14:27:37.963 [WARN ] [ors.internal.gateway.MySensorsGateway] - Presented child is alredy present in gateway
14:27:37.968 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298639015 TSF:MSG:READ,1-1-0,s=1,c=0,t=6,pt=0,l=11,sg=0:Temperature
14:27:37.970 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 1;1;0;0;6;Temperature
14:27:37.970 [DEBUG] [ors.internal.gateway.MySensorsGateway] - Presentation Message received
14:27:37.971 [WARN ] [ors.internal.gateway.MySensorsGateway] - Presented child is alredy present in gateway
14:27:37.982 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298639028 TSF:MSG:READ,1-1-0,s=255,c=3,t=26,pt=1,l=1,sg=0:2
14:27:37.989 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298639036 TSF:MSG:SEND,0-0-1-1,s=255,c=3,t=27,pt=1,l=1,sg=0,ft=0,st=OK:1
14:27:38.032 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298639077 TSF:MSG:READ,1-1-0,s=1,c=1,t=0,pt=7,l=5,sg=0:24.12
14:27:38.033 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 1;1;1;0;0;24.12
14:27:38.034 [DEBUG] [ors.internal.gateway.MySensorsGateway] - Node 1 found in gateway
14:27:38.035 [DEBUG] [ors.internal.gateway.MySensorsGateway] - Child 1 found in node 1
14:27:38.036 [WARN ] [ors.internal.gateway.MySensorsGateway] - Variable V_TEMP not present
14:27:38.040 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298639086 TSF:MSG:READ,1-1-0,s=0,c=1,t=1,pt=7,l=5,sg=0:63.50
14:27:38.041 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 1;0;1;0;1;63.50
14:27:38.041 [DEBUG] [ors.internal.gateway.MySensorsGateway] - Node 1 found in gateway
14:27:38.041 [DEBUG] [ors.internal.gateway.MySensorsGateway] - Child 0 found in node 1
14:27:38.042 [WARN ] [ors.internal.gateway.MySensorsGateway] - Variable V_HUM not present
14:27:38.054 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;9;1298639098 TSF:MSG:READ,1-1-0,s=255,c=3,t=0,pt=1,l=1,sg=0:100
14:27:38.054 [DEBUG] [orsAbstractConnection$MySensorsReader] - Message from gateway received: 1;255;3;0;0;100
14:27:38.055 [DEBUG] [ors.internal.gateway.MySensorsGateway] - Battery percent for node 1 update to: 100%
14:27:38.057 [DEBUG] [sensors.handler.MySensorsThingHandler] - Updating channel: battery value to: 100
14:27:38.058 [DEBUG] [sensors.handler.MySensorsThingHandler] - Setting last update for node/child 1/0 to 2020-10-05T14:27:38.000+1100
14:27:38.058 [DEBUG] [sensors.handler.MySensorsThingHandler] - Updating channel: battery value to: 100
14:27:38.059 [DEBUG] [sensors.handler.MySensorsThingHandler] - Setting last update for node/child 1/1 to 2020-10-05T14:27:38.000+1100
3

Would be nice to show how you have set up these items.
It will surely help find the issue.

4

They might have more skills here

5

Thanks guys.

I posted here purely because this forum is significantly more active than the mysensors forum. I figured if I didn’t make much progress here, I can always go and ask over there.

While I was in the process of debugging this further, I tried manually configuring the Node ID to a different ID and then the node worked fine. I think I just have had some sort of persistent state left over from previous testing with Node ID 1, and even though I had cleared the cache etc, it was still there.

Changing the node ID to 2 has resolved the issue.