[SOLVED] [RFXCOM] OH2 Dooya shutter control problem

Hi!

I’m trying to control my Dooya shutter motor with RFXtrx433E using the OH2 version of the binding.
I have successfully paired the device with RFXcom using this guide: Forum Topic.
It works like a charm using the RFX Manager software.

Then I installed the binding and tried to configure the control using the same guide. Used the following:
ID1 = 01
ID2 = 01
ID3 = 01
ID4 = 1
Unit Code = 1

Based on these values my combined ID should be 65793.17 which I used to create the thing on PaperUI.

It was not working so I turned on the debug logging for the binding to check what happens. First I encourted an existing bug in the binding (Error when connecting to RFXtrx device and timeout connection) which was solved by using the 2.1.0-Snapshot version of the binding mentioned for this problem on GitHub.

It solved the mentioned problem but the motor control is not working and I have this in my log:

08:14:27.134 [DEBUG] [binding.rfxcom.handler.RFXComHandler] - Received channel: rfxcom:blinds1:6bb5af78:shutter, command: DOWN
08:14:27.208 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Transmitting message 'Raw data = 09190600001010110100, Packet type = BLINDS1, Seq number = 0, Sub type = T6, Device Id = 65793.17, Command = CLOSE, Signal level = 0, Battery level = 0'
08:14:27.209 [TRACE] [rnal.connector.RFXComSerialConnector] - Send data (len=10): 09190600001010110100
08:14:27.329 [INFO ] [marthome.event.ItemStateChangedEvent] - rfxcom_blinds1_6bb5af78_shutter changed from NULL to 100
08:14:28.914 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'rfxcom_blinds1_6bb5af78_shutter' received command STOP
08:14:28.929 [DEBUG] [binding.rfxcom.handler.RFXComHandler] - Received channel: rfxcom:blinds1:6bb5af78:shutter, command: STOP
08:14:30.632 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'rfxcom_blinds1_6bb5af78_shutter' received command UP
08:14:30.643 [DEBUG] [binding.rfxcom.handler.RFXComHandler] - Received channel: rfxcom:blinds1:6bb5af78:shutter, command: UP
08:14:30.691 [INFO ] [marthome.event.ItemStateChangedEvent] - rfxcom_blinds1_6bb5af78_shutter changed from 100 to 0
08:14:33.457 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'rfxcom_blinds1_6bb5af78_shutter' received command STOP
08:14:33.476 [DEBUG] [binding.rfxcom.handler.RFXComHandler] - Received channel: rfxcom:blinds1:6bb5af78:shutter, command: STOP

It seems to me (based on reading a lot in this forum) it is transmitting wrong signal:
Example:
Data: 09 19 06 00 00 10 10 11 01 00
09 = default
19 = blinds1
06 = T6 subtype
00 = sequence code (don’t really know what it is)
00 = ID1
10 = ID2
10 = ID3
11 = Unit Code
01 = Command Code
00 = Signal Level

Seems to me I’m missing ID4 and I have wrong IDs…

Thanks for the help!

What version are you using, I see that palkie and me merged this back in Januari, see also https://github.com/openhab/openhab2-addons/pull/1339

I used what i’ve found here: https://github.com/openhab/openhab2-addons/issues/1611

This was the error what I’ve first encountered (no response issue) and then it was solved by this snapshot on the link… :slight_smile:

Update:
With the latest snapshot (17th of May) I see this:

09:53:56.748 [DEBUG] [binding.rfxcom.handler.RFXComHandler] - Received channel: rfxcom:blinds1:6bb5af78:shutter, command: DOWN
09:53:56.776 [INFO ] [marthome.event.ItemStateChangedEvent] - rfxcom_blinds1_6bb5af78_shutter changed from NULL to 100
09:53:56.821 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Transmitting message 'Raw data = unknown, Packet type = BLINDS1, Seq number = 1, Sub type = T6, Device Id = 65793.17, Command = CLOSE, Signal level = 0, Battery level = 0'
09:53:56.832 [TRACE] [g.rfxcom.handler.RFXComBridgeHandler] - Transmitting data: 09190601001010110100
09:53:56.840 [TRACE] [rnal.connector.RFXComSerialConnector] - Send data (len=10): 09190601001010110100
09:53:57.579 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Message received: Raw data = 0402010100, Packet type = TRANSMITTER_MESSAGE, Seq number = 1, Sub type = RESPONSE, Response = ACK
09:53:57.585 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Transmitter response received: Raw data = 0402010100, Packet type = TRANSMITTER_MESSAGE, Seq number = 1, Sub type = RESPONSE, Response = ACK
09:53:57.587 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Command successfully transmitted, 'ACK' received
09:53:57.590 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'rfxcom_blinds1_6bb5af78_shutter' received command DOWN
09:54:00.398 [DEBUG] [binding.rfxcom.handler.RFXComHandler] - Received channel: rfxcom:blinds1:6bb5af78:shutter, command: STOP
09:54:00.400 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Transmitting message 'Raw data = unknown, Packet type = BLINDS1, Seq number = 2, Sub type = T6, Device Id = 65793.17, Command = STOP, Signal level = 0, Battery level = 0'
09:54:00.410 [TRACE] [g.rfxcom.handler.RFXComBridgeHandler] - Transmitting data: 09190602001010110200
09:54:00.412 [TRACE] [rnal.connector.RFXComSerialConnector] - Send data (len=10): 09190602001010110200
09:54:01.078 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Message received: Raw data = 0402010200, Packet type = TRANSMITTER_MESSAGE, Seq number = 2, Sub type = RESPONSE, Response = ACK
09:54:01.085 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Transmitter response received: Raw data = 0402010200, Packet type = TRANSMITTER_MESSAGE, Seq number = 2, Sub type = RESPONSE, Response = ACK
09:54:01.087 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Command successfully transmitted, 'ACK' received
09:54:01.088 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'rfxcom_blinds1_6bb5af78_shutter' received command STOP
09:54:03.036 [DEBUG] [binding.rfxcom.handler.RFXComHandler] - Received channel: rfxcom:blinds1:6bb5af78:shutter, command: UP
09:54:03.043 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Transmitting message 'Raw data = unknown, Packet type = BLINDS1, Seq number = 3, Sub type = T6, Device Id = 65793.17, Command = OPEN, Signal level = 0, Battery level = 0'
09:54:03.045 [TRACE] [g.rfxcom.handler.RFXComBridgeHandler] - Transmitting data: 09190603001010110000
09:54:03.045 [TRACE] [rnal.connector.RFXComSerialConnector] - Send data (len=10): 09190603001010110000
09:54:03.760 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Message received: Raw data = 0402010300, Packet type = TRANSMITTER_MESSAGE, Seq number = 3, Sub type = RESPONSE, Response = ACK
09:54:03.761 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Transmitter response received: Raw data = 0402010300, Packet type = TRANSMITTER_MESSAGE, Seq number = 3, Sub type = RESPONSE, Response = ACK
09:54:03.763 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Command successfully transmitted, 'ACK' received
09:54:03.765 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'rfxcom_blinds1_6bb5af78_shutter' received command UP
09:54:03.779 [INFO ] [marthome.event.ItemStateChangedEvent] - rfxcom_blinds1_6bb5af78_shutter changed from 100 to 0
09:54:04.740 [DEBUG] [binding.rfxcom.handler.RFXComHandler] - Received channel: rfxcom:blinds1:6bb5af78:shutter, command: STOP
09:54:04.741 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Transmitting message 'Raw data = unknown, Packet type = BLINDS1, Seq number = 4, Sub type = T6, Device Id = 65793.17, Command = STOP, Signal level = 0, Battery level = 0'
09:54:04.741 [TRACE] [g.rfxcom.handler.RFXComBridgeHandler] - Transmitting data: 09190604001010110200
09:54:04.742 [TRACE] [rnal.connector.RFXComSerialConnector] - Send data (len=10): 09190604001010110200
09:54:05.460 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Message received: Raw data = 0402010400, Packet type = TRANSMITTER_MESSAGE, Seq number = 4, Sub type = RESPONSE, Response = ACK
09:54:05.461 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Transmitter response received: Raw data = 0402010400, Packet type = TRANSMITTER_MESSAGE, Seq number = 4, Sub type = RESPONSE, Response = ACK
09:54:05.466 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Command successfully transmitted, 'ACK' received
09:54:05.468 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'rfxcom_blinds1_6bb5af78_shutter' received command STOP

I have reinstalled the whole OH2 system. Used the latest stable Debian with manual install (instead of openhabian). Used the 2.1 snapshot for both OH2 and for the rfxcom addon (18. 05. 2017).

First I encountered the gnu.io problem so I used feature:install in Karaf console to get rid of this problem. Everything went well then and the addon started to work. Now I have different log entries:

21:13:47.576 [INFO ] [marthome.event.ItemStateChangedEvent] - RFXCOMBlinds1Actuator_Shutter changed from 100 to 0
21:13:48.298 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Message received: Raw data = 0402010B00, Packet type = TRANSMITTER_MESSAGE, Seq number = 11, Sub type = RESPONSE, Response = ACK
21:13:48.298 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Transmitter response received: Raw data = 0402010B00, Packet type = TRANSMITTER_MESSAGE, Seq number = 11, Sub type = RESPONSE, Response = ACK
21:13:48.301 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Command successfully transmitted, 'ACK' received
21:13:48.309 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'RFXCOMBlinds1Actuator_Shutter' received command UP
21:13:49.143 [DEBUG] [binding.rfxcom.handler.RFXComHandler] - Received channel: rfxcom:blinds1:193b9f48:shutter, command: STOP
21:13:49.146 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Transmitting message 'Raw data = unknown, Packet type = BLINDS1, Seq number = 12, Sub type = T6, Device Id = 65793.17, Command = STOP, Signal level = 0, Battery level = 0'
21:13:49.862 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Message received: Raw data = 0402010C00, Packet type = TRANSMITTER_MESSAGE, Seq number = 12, Sub type = RESPONSE, Response = ACK
21:13:49.863 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Transmitter response received: Raw data = 0402010C00, Packet type = TRANSMITTER_MESSAGE, Seq number = 12, Sub type = RESPONSE, Response = ACK
21:13:49.867 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Command successfully transmitted, 'ACK' received
21:13:49.869 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'RFXCOMBlinds1Actuator_Shutter' received command STOP
21:14:24.636 [DEBUG] [binding.rfxcom.handler.RFXComHandler] - Received channel: rfxcom:blinds1:193b9f48:shutter, command: DOWN
21:14:24.637 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Transmitting message 'Raw data = unknown, Packet type = BLINDS1, Seq number = 13, Sub type = T6, Device Id = 65793.17, Command = CLOSE, Signal level = 0, Battery level = 0'
21:14:24.644 [INFO ] [marthome.event.ItemStateChangedEvent] - RFXCOMBlinds1Actuator_Shutter changed from 0 to 100
21:14:25.357 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Message received: Raw data = 0402010D00, Packet type = TRANSMITTER_MESSAGE, Seq number = 13, Sub type = RESPONSE, Response = ACK
21:14:25.358 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Transmitter response received: Raw data = 0402010D00, Packet type = TRANSMITTER_MESSAGE, Seq number = 13, Sub type = RESPONSE, Response = ACK
21:14:25.361 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Command successfully transmitted, 'ACK' received
21:14:25.362 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'RFXCOMBlinds1Actuator_Shutter' received command DOWN

Don’t really know how raw data changed I used the same ID as before. Still not working and motor doing nothing :sob:

I would appreciate any kind of help.

Just figured out but I think the wiki page for the add-on must be updated with an example.

There is no need to add it like described here anymore.

I converted 0101011 to DEC and added .1 at the end. so my OH2 ID: 1052689.1

It is working and I can control it.