openHAB 2.0 binding

seeers

Thanks for the suggestions and the change. Maybe it`s not necessary. Today I could observe how the gateway was rebooted by openhab by Shutting down the serial connection.
I have added a "heartbeat" to my gateway, every minute a Serial.writeline "State:OK". Of course an exception appears in the openhab binding... I do not understand why the binding was down: ...Shutting down serial connection!...

11:29:43.176 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: State:OK
11:29:43.177 [WARN ] [rsAbstractConnection$MySensorsReader] - Exception on reading from connection
java.text.ParseException: class java.text.ParseException : Message length is not > 4   .....

11:29:43.181 [DEBUG] [col.serial.MySensorsSerialConnection] - Request disconnection flag setted to: true
11:29:44.873 [INFO ] [col.serial.MySensorsSerialConnection] - Connection request disconnection...
11:29:44.874 [DEBUG] [col.serial.MySensorsSerialConnection] - Request disconnection flag setted to: false
11:29:44.874 [DEBUG] [col.serial.MySensorsSerialConnection] - Shutting down serial connection!
11:29:44.875 [DEBUG] [rsAbstractConnection$MySensorsWriter] - Stopping Writer thread
11:29:44.876 [WARN ] [rsAbstractConnection$MySensorsWriter] - Interrupted MySensorsWriter
11:29:44.877 [DEBUG] [rsAbstractConnection$MySensorsReader] - Stopping Reader thread
11:29:44.882 [WARN ] [rsAbstractConnection$MySensorsReader] - Interrupted MySensorsReader
.....
11:29:44.901 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:temperature:gateway:Temp_OG_KSued_2' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR)
11:29:44.905 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:humidity:gateway:Hum__OG_KSued' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR)
.....
11:29:48.132 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;14;Gateway startup complete.
11:29:48.132 [INFO ] [rs.internal.gateway.MySensorsGateway] - Node 0 available again!
11:29:48.133 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;0;0;18;2.1.1
11:29:48.133 [WARN ] [col.serial.MySensorsSerialConnection] - Skipping I_VERSION connection test, not recommended...
11:29:48.137 [DEBUG] [ensors.factory.MySensorsCacheFactory] - Writing on cache given_ids, content: [0,32,1,33,34,35,11,12,13,14,21,22,23,24,26,27,31]
11:29:48.138 [INFO ] [col.serial.MySensorsSerialConnection] - Successfully connected to MySensors Bridge.
11:29:48.138 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Presentation Message received
11:29:48.138 [DEBUG] [ensors.handler.MySensorsThingHandler] - MySensors Bridge Status updated to ONLINE for device: mysensors:temperature:gateway:Temp_KG_Flur_1
....
11:29:48.140 [DEBUG] [ensors.handler.MySensorsThingHandler] - MySensors Bridge Status updated to ONLINE for device: mysensors:humidity:gateway:Hum__KG_Wasch
11:29:48.142 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:bridge-ser:gateway' changed from OFFLINE to ONLINE
....

stolly82

This post is deleted!

stolly82

Dear together,

I can´t find out, why one things are not working if I save another thing with the same NodeID but different ChildID.

Example:
I have two things, one button and one door sensor.

The button is working until I add a new thing with the same nodeID (Relay).

If I save the button again, it´s working again but the Relay isn´t working again.

21:07:58.514 [INFO ] [smarthome.event.ThingUpdatedEvent   ] - Thing 'mysensors:light:Relais_Wohnzimmer_hinten_1' has been updated.
21:07:58.518 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Adding device MySensorsNode [nodeId=16, childNumber=1, chidldList={1=MySensorsChild [childId=1, nodeValue={V_WATT=MySensorsVariableVWatt [value=null], V_STATUS=MySensorsVariableVStatus [value=null], V_VAR2=MySensorsVariableVVar2 [value=null], V_VAR1=MySensorsVariableVVar1 [value=null], V_VAR3=MySensorsVariableVVar3 [value=null], V_VAR4=MySensorsVariableVVar4 [value=null], V_VAR5=MySensorsVariableVVar5 [value=null]}]}]
21:07:58.520 [DEBUG] [ensors.handler.MySensorsThingHandler] - Event listener for node 16-1 not registered yet, registering...
21:08:00.332 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:08:00.337 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:08:00.347 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 14
21:08:00.352 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:08:00.370 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 14/2 to 2017-09-09T21:08:00.000+0200
21:08:10.860 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 16;2;1;0;16;0
21:08:10.865 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 16 found in gateway
21:08:10.869 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 not present in node 16
21:08:10.944 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 16;2;1;0;16;1
21:08:10.949 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 16 found in gateway
21:08:10.952 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 not present in node 16
21:08:11.012 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:08:11.016 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:08:11.019 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 14
21:08:11.022 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:08:11.050 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 14/2 to 2017-09-09T21:08:11.000+0200
21:08:11.241 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 16;1;1;0;2;1
21:08:11.247 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 16 found in gateway
21:08:11.251 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 1 found in node 16
21:08:11.254 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: status(V_STATUS) value to: ON
21:08:11.271 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 16/1 to 2017-09-09T21:08:11.000+0200
21:08:11.275 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: status(V_STATUS) value to: ON
21:08:11.292 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_Wohnzimmer_hinten_1 changed from OFF to ON
21:08:11.295 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 16/1 to 2017-09-09T21:08:11.000+0200
21:08:12.196 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 16;1;1;0;2;0
21:08:12.199 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 16 found in gateway
21:08:12.201 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 1 found in node 16
21:08:12.204 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: status(V_STATUS) value to: OFF
21:08:12.219 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 16/1 to 2017-09-09T21:08:12.000+0200
21:08:12.222 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: status(V_STATUS) value to: OFF
21:08:12.239 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_Wohnzimmer_hinten_1 changed from ON to OFF
21:08:12.242 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 16/1 to 2017-09-09T21:08:12.000+0200
21:08:14.093 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 16;1;1;0;2;1
21:08:14.097 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 16 found in gateway
21:08:14.099 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 1 found in node 16
21:08:14.101 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: status(V_STATUS) value to: ON
21:08:14.118 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 16/1 to 2017-09-09T21:08:14.000+0200
21:08:14.121 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: status(V_STATUS) value to: ON
21:08:14.137 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_Wohnzimmer_hinten_1 changed from OFF to ON
21:08:14.147 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 16/1 to 2017-09-09T21:08:14.000+0200
21:08:14.574 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 16;1;1;0;2;0
21:08:14.578 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 16 found in gateway
21:08:14.581 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 1 found in node 16
21:08:14.584 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: status(V_STATUS) value to: OFF
21:08:14.603 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 16/1 to 2017-09-09T21:08:14.000+0200
21:08:14.607 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: status(V_STATUS) value to: OFF
21:08:14.628 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_Wohnzimmer_hinten_1 changed from ON to OFF
21:08:14.632 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 16/1 to 2017-09-09T21:08:14.000+0200
21:08:15.823 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;2;2.1.1
21:08:20.282 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:08:20.286 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:08:20.290 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 14
21:08:20.293 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:08:20.319 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 14/2 to 2017-09-09T21:08:20.000+0200
21:08:21.117 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 16;2;1;0;16;0
21:08:21.122 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 16 found in gateway
21:08:21.126 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 not present in node 16
21:08:21.232 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 16;2;1;0;16;1
21:08:21.237 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 16 found in gateway
21:08:21.243 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 not present in node 16
21:08:22.162 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 16;2;1;0;16;0
21:08:22.168 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 16 found in gateway
21:08:22.174 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 not present in node 16
21:08:22.592 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 16;2;1;0;16;1
21:08:22.596 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 16 found in gateway
21:08:22.599 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 not present in node 16
21:08:23.331 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 16;2;1;0;16;0
21:08:23.334 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 16 found in gateway
21:08:23.337 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 not present in node 16
21:08:23.491 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 16;2;1;0;16;1
21:08:23.495 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 16 found in gateway
21:08:23.506 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 not present in node 16
21:08:30.411 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:08:30.414 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:08:30.417 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 14
21:08:30.421 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:08:30.447 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 14/2 to 2017-09-09T21:08:30.000+0200
21:08:40.313 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:08:40.317 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:08:40.326 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 14
21:08:40.330 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:08:40.352 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 14/2 to 2017-09-09T21:08:40.000+0200
21:08:50.328 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:08:50.332 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:08:50.337 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 14
21:08:50.342 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:08:50.367 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 14/2 to 2017-09-09T21:08:50.000+0200
21:08:55.944 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 1;5;1;0;18;4653.2749
21:08:55.950 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 1 found in gateway
21:08:55.954 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 5 found in node 1
21:08:55.959 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: kwh(V_KWH) value to: 4653.2749
21:08:55.978 [INFO ] [marthome.event.ItemStateChangedEvent] - Stromzaeler_K changed from 4653.1982 to 4653.2749
21:08:55.983 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 1/5 to 2017-09-09T21:08:55.000+0200
21:09:00.403 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:09:00.409 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:09:00.413 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 14
21:09:00.418 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:09:00.449 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 14/2 to 2017-09-09T21:09:00.000+0200
21:09:10.370 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:09:10.375 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:09:10.378 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 14
21:09:10.382 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:09:10.411 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 14/2 to 2017-09-09T21:09:10.000+0200
21:09:15.971 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 1;5;1;0;24;6979929
21:09:15.974 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 1 found in gateway
21:09:15.977 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 5 found in node 1
21:09:15.980 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: var1(V_VAR1) value to: 6979929
21:09:15.998 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 1/5 to 2017-09-09T21:09:15.000+0200
21:09:16.193 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 1;5;1;0;18;4653.2866
21:09:16.196 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 1 found in gateway
21:09:16.198 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 5 found in node 1
21:09:16.203 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: kwh(V_KWH) value to: 4653.2866
21:09:16.221 [INFO ] [marthome.event.ItemStateChangedEvent] - Stromzaeler_K changed from 4653.2749 to 4653.2866
21:09:16.233 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 1/5 to 2017-09-09T21:09:16.000+0200
21:09:16.296 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;2;2.1.1
21:09:20.390 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:09:20.394 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:09:20.398 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 14
21:09:20.402 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:09:20.424 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 14/2 to 2017-09-09T21:09:20.000+0200
21:09:30.464 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:09:30.470 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:09:30.475 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 14
21:09:30.481 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:09:30.510 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 14/2 to 2017-09-09T21:09:30.000+0200
21:09:40.469 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:09:40.473 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:09:40.477 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 14
21:09:40.482 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:09:40.505 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 14/2 to 2017-09-09T21:09:40.000+0200
21:10:00.627 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:10:00.629 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:10:00.634 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 14
21:10:00.640 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:10:00.666 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 14/2 to 2017-09-09T21:10:00.000+0200
21:10:10.690 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:10:10.696 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:10:10.701 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 14
21:10:10.707 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:10:10.749 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 14/2 to 2017-09-09T21:10:10.000+0200
21:10:15.893 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;2;2.1.1
21:10:17.669 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 1;5;1;0;18;4653.3081
21:10:17.673 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 1 found in gateway
21:10:17.675 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 5 found in node 1
21:10:17.678 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: kwh(V_KWH) value to: 4653.3081
21:10:17.702 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 1/5 to 2017-09-09T21:10:17.000+0200
21:10:17.703 [INFO ] [marthome.event.ItemStateChangedEvent] - Stromzaeler_K changed from 4653.2866 to 4653.3081
21:10:20.537 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:10:20.541 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:10:20.546 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 14
21:10:20.551 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:10:20.590 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 14/2 to 2017-09-09T21:10:20.000+0200
21:10:30.566 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:10:30.569 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:10:30.576 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 14
21:10:30.582 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:10:30.602 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 14/2 to 2017-09-09T21:10:30.000+0200
21:10:34.691 [DEBUG] [ensors.handler.MySensorsThingHandler] - Configuation update for thing 16-2: {nodeUpdateTimeout=-1, smartSleep=false, requestHeartbeatResponse=false, childUpdateTimeout=-1, childId=2, nodeId=16, revertState=true, requestAck=false}
21:10:34.727 [INFO ] [smarthome.event.ThingUpdatedEvent   ] - Thing 'mysensors:door:Button_Wohnzimmer_1' has been updated.
21:10:34.726 [DEBUG] [ensors.handler.MySensorsThingHandler] - Configuration: MySensorsSensorConfiguration [nodeId=16, childId=2, requestAck=false, revertState=true, smartSleep=false, childUpdateTimeout=-1, nodeUpdateTimeout=-1, requestHeartbeatResponse=false]
21:10:34.740 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Adding device MySensorsNode [nodeId=16, childNumber=1, chidldList={2=MySensorsChild [childId=2, nodeValue={V_VAR2=MySensorsVariableVVar2 [value=null], V_VAR1=MySensorsVariableVVar1 [value=null], V_TRIPPED=MySensorsVariableVTripped [value=null], V_VAR3=MySensorsVariableVVar3 [value=null], V_VAR4=MySensorsVariableVVar4 [value=null], V_VAR5=MySensorsVariableVVar5 [value=null], V_ARMED=MySensorsVariableVArmed [value=null]}]}]
21:10:34.752 [DEBUG] [ensors.handler.MySensorsThingHandler] - Event listener for node 16-2 not registered yet, registering...
21:10:37.699 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 1;5;1;0;24;6979975
21:10:37.704 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 1 found in gateway
21:10:37.709 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 5 found in node 1
21:10:37.714 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: var1(V_VAR1) value to: 6979975
21:10:37.734 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 1/5 to 2017-09-09T21:10:37.000+0200
21:10:37.821 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 1;5;1;0;18;4653.3169
21:10:37.827 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 1 found in gateway
21:10:37.833 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 5 found in node 1
21:10:37.839 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: kwh(V_KWH) value to: 4653.3169
21:10:37.859 [INFO ] [marthome.event.ItemStateChangedEvent] - Stromzaeler_K changed from 4653.3081 to 4653.3169
21:10:37.875 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 1/5 to 2017-09-09T21:10:37.000+0200
21:10:40.611 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:10:40.616 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:10:40.621 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 14
21:10:40.626 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:10:40.647 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 14/2 to 2017-09-09T21:10:40.000+0200
21:10:46.592 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 16;1;1;0;2;1
21:10:46.598 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 16 found in gateway
21:10:46.602 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 1 not present in node 16
21:10:48.047 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 16;1;1;0;2;0
21:10:48.052 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 16 found in gateway
21:10:48.056 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 1 not present in node 16
21:10:50.179 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 16;2;1;0;16;0
21:10:50.184 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 16 found in gateway
21:10:50.186 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 16
21:10:50.188 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: CLOSED
21:10:50.200 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_Wohnzimmer_hinten_2 changed from OPEN to CLOSED
21:10:50.204 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 16/2 to 2017-09-09T21:10:50.000+0200
21:10:50.387 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 16;2;1;0;16;1
21:10:50.389 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 16 found in gateway
21:10:50.391 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 16
21:10:50.393 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:10:50.413 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_Wohnzimmer_hinten_2 changed from CLOSED to OPEN
21:10:50.422 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 16/2 to 2017-09-09T21:10:50.000+0200
21:10:50.616 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:10:50.619 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:10:50.621 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 14
21:10:50.623 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:10:50.665 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 14/2 to 2017-09-09T21:10:50.000+0200
21:11:00.858 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:11:00.865 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:11:00.869 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 found in node 14
21:11:00.871 [DEBUG] [ensors.handler.MySensorsThingHandler] - Updating channel: tripped(V_TRIPPED) value to: OPEN
21:11:00.889 [DEBUG] [ensors.handler.MySensorsThingHandler] - Setting last update for node/child 14/2 to 2017-09-09T21:11:00.000+0200

And it´s really with any type of things like that. All nodes are working perfect in OH2 if I have only one childID as a thing. If I add the second the first is not longer working.

21:37:34.353 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:37:34.358 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:37:34.363 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 not present in node 14
21:37:44.381 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:37:44.386 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:37:44.390 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 not present in node 14
21:37:54.400 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:37:54.405 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:37:54.409 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 not present in node 14
21:38:04.417 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:38:04.419 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:38:04.425 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 not present in node 14
21:38:10.730 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:38:10.738 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 1 found in node 14
21:38:10.738 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_Aussenstrahler_hinten changed from OFF to ON
21:38:10.742 [DEBUG] [rsAbstractConnection$MySensorsWriter] - Sending to MySensors: 14;1;1;0;2;1
21:38:10.744 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'Switch_Aussenstrahler_hinten' received command ON
21:38:13.428 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:38:13.430 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 1 found in node 14
21:38:13.432 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'Switch_Aussenstrahler_hinten' received command OFF
21:38:13.437 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_Aussenstrahler_hinten changed from ON to OFF
21:38:13.437 [DEBUG] [rsAbstractConnection$MySensorsWriter] - Sending to MySensors: 14;1;1;0;2;0
21:38:14.454 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 14;2;1;0;16;1
21:38:14.457 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Node 14 found in gateway
21:38:14.459 [DEBUG] [rs.internal.gateway.MySensorsGateway] - Child 2 not present in node 14

matt shepherd

Have you tried using Mqtt? I've recently set up a motion sensor with a mqtt gateway and it seems to be more reliable. The motion just sends a 1 for motion or 0 for no motion (obvs). I have a rule that says turn lights on if motion state =1 .You don't have to worry about connecting 'things' with openhab as you use the mqtt binding.

stolly82

@matt-shepherd
for now not.
The problem is more, that openhab 2 accepts only one device per Node with the 2.0 binding. It doesn´t matter if it it a motion sensor or if it is a second relay.

Alway´s if I setup a second thing with a existing ChildID,... the first Thing is not working anymore (LOG = Child x not present in Node x ).

I tried to install on a second Raspberry with OpenHab2 and MySensors2.0 binding (Openhabian) and there is the same issue.

That´s really really strange.

mick

I would like to attempt the irrigation controller with this binding, I believe the "light" thing is used. This only has channels: Status, Battery, LastUpdate. Is it possible to add more channels to the light thing ?, ie: V_VAR1 ... V_VAR3, regards.

andreacioni

@mick you aren't the first asking that :sweat_smile: . I opened a new issue on GitHub (https://github.com/tobof/openhab2-addons/issues/95) to discuss about adding it to the binding.

mick

Cheers @andreacioni - fingers crossed :+1:

doctor64

@TimO just updated to version 2.2.0.201708090807 of binding and get exception in network check

22:41:33.015 [DEBUG] [rsAbstractConnection$MySensorsWriter] - Sending to MySensors: 0;0;3;0;2;
22:41:33.029 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;2;2.1.1
22:41:36.015 [DEBUG] [ateway.MySensorsNetworkSanityChecker] - Network sanity check: PASSED
22:41:36.015 [DEBUG] [ateway.MySensorsNetworkSanityChecker] - Sending I_HEARTBEAT_REQUESTs
22:41:36.016 [DEBUG] [rsAbstractConnection$MySensorsWriter] - Sending to MySensors: 0;255;3;0;18;
22:41:36.032 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 0;255;3;0;22;436674305
22:41:36.116 [DEBUG] [rsAbstractConnection$MySensorsWriter] - Sending to MySensors: 1;255;3;0;18;
22:41:36.217 [DEBUG] [rsAbstractConnection$MySensorsWriter] - Sending to MySensors: 2;255;3;0;18;
22:41:36.317 [DEBUG] [rsAbstractConnection$MySensorsWriter] - Sending to MySensors: 3;255;3;0;18;
22:41:36.398 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 3;255;3;0;22;717683
22:41:36.418 [DEBUG] [rsAbstractConnection$MySensorsWriter] - Sending to MySensors: 4;255;3;0;18;
22:41:36.518 [DEBUG] [rsAbstractConnection$MySensorsWriter] - Sending to MySensors: 5;255;3;0;18;
22:41:36.619 [DEBUG] [rsAbstractConnection$MySensorsWriter] - Sending to MySensors: 6;255;3;0;18;
22:41:36.652 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 5;255;3;0;22;9428217
22:41:36.683 [DEBUG] [rsAbstractConnection$MySensorsReader] - Message from gateway received: 6;255;3;0;22;3111897
22:41:39.016 [DEBUG] [ateway.MySensorsNetworkSanityChecker] - Node 1 request heartbreat answer, missing null of 10
22:41:39.016 [ERROR] [ateway.MySensorsNetworkSanityChecker] - Exception in network sanity thread checker
java.lang.NullPointerException
	at org.openhab.binding.mysensors.internal.gateway.MySensorsNetworkSanityChecker.checkHeartbeatsResponse(MySensorsNetworkSanityChecker.java:178)[195:org.openhab.binding.mysensors:2.2.0.201708090807]
	at org.openhab.binding.mysensors.internal.gateway.MySensorsNetworkSanityChecker.run(MySensorsNetworkSanityChecker.java:122)[195:org.openhab.binding.mysensors:2.2.0.201708090807]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)[:1.8.0_144]
	at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)[:1.8.0_144]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)[:1.8.0_144]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)[:1.8.0_144]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)[:1.8.0_144]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)[:1.8.0_144]
	at java.lang.Thread.run(Thread.java:748)[:1.8.0_144]

andreacioni

Hi @doctor64, could you please post your things configuration file?

doctor64

@andreacioni All mySensors item defined using auto-discovery, so no things file in configuration. I'm think you mean this file? 0_1506175698221_org.eclipse.smarthome.core.thing.Thing.json

andreacioni

@doctor64 it is enough, I can replicate it. Thanks for reporting this issue :smile: . You can keep track of it here: https://github.com/tobof/openhab2-addons/issues/97

gonzalonal

Today brand new setup with fail results.

I have installed a brand new OH2 snapshot build #1047 and the latest relese of the binding available.

I am using just a single node as ethernet gateway. After a couple of minutes the binding stops sending the messages to the node. It logs as it would send them but nothing is really sent out. I have sniffed the connection with wireshark.

Sometimes, while looking the binding debug logs at OH2 console, it hangs and I have to restablish the connection. This last issue seems more related to OH2 itself but maybe something wrong in the binding is causing it. Again, the is not a single clue in the logs about this.

I have just installed the OH2.1 stable release with the latest release of the binding and everything runs great yet.

Anyone with a similar experience?

AndrewZ

@gonzalonal I've observed something similar on my system, as I recall the binding wasn't even able to establish the initial connection to a gateway. Have OH upgraded today from an earlier build (~3 weeks old).

jocke4u

This post is deleted!

Skorpilein

Is it possible to implement RS485 Gateway? Or it works with Serial Gateway?

รอเรือ

I get this in my log sometimes:

[WARN ] [.discovery.MySensorsDiscoveryService] - Cannot automatic discover thing node: 0, child: 255 please insert it manually

I use MySensors Binding 2.3.0.201801160936 on a serial gateway with mysensors 2.2.0

Where shall I insert the thing node and what should it look like?

openHAB 2.0 binding

20

12.0k

11.2k

113.4k