openHAB 2.0 binding

Feji

This post is deleted!

seeers

Hi, I use OpenHAB 2.1 with the OpenHAB 2.0 Binding on a Raspberry Pi with a serial RS485 gateway connected with a FTDI to USB. Sometimes the gateway freezes (at the moment i don´t know why). After pushing the reset button everything works for the next hours/days.
I´d like to reset the gateway automatically from openhab. Is it possible to reset the Gateway with this binding ? (Send DTR to the FTDI)

TimO

Hi @seeers !

Interesting idea. I suppose the arduino IDE is doing this via avrdude and we won't be able to call avrdude from within the binding. If someone has an idea on how to reset an arduino via serial/usb from within java I could look into it.

gonzalonal

@TimO you just need to toggle the DTR line.

Try:
serialPort.setDTR(true);
Thread.sleep(500);
serialPort.open();
serialPort.setDTR(false);

TimO

@gonzalonal Thanks for the hint!
For that a switch of NRSerial library to SerialPort is neccessary. A first try looks promising, but I'm not able to test it against hardware yet. Maybe @seeers might give it a try:

JAR-File

I've tested with the following bridge configuration:

Bridge mysensors:bridge-ser:gateway [ serialPort="/dev/pts/20", hardReset=false, sendDelay=200, startupCheckEnabled=true, networkSanCheckEnabled=true, networkSanCheckInterval=1, networkSanCheckConnectionFailAttempts=1 ] {
  }

The sanity check needs to fail two times. After that it will try to disconnect (and do the hardReset via DTR) and reconnect.

Log (in debug) should look like:

[DEBUG] [.p.s.MySensorsSerialConnection:138  ] - Trying to reset of attached gateway with DTR
[DEBUG] [.p.s.MySensorsSerialConnection:146  ] - Finished reset of attached gateway with DTR

I suppose only FTDI based gateways will react on that? What about sensebender gateway?

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!

openHAB 2.0 binding

22

11.7k

11.2k

113.1k