Unable to Add Z-wave Stick With RFC2217 on 3.3.0

tuaris · December 1, 2022, 6:07am

I have been using OpenHAB 2 with my Aeotec Z-Stick using ser2net and socat for several years. I decided to do an upgrade to 3.3.0 and went with trying out the RFC2217 option.

Unfortunately it does not appear to work, just says it’s offline. Even after rebooting all the things.

The logs on the OpenHAB server don’t seem to offer much insight into helping me determine what’s wrong:

==> /var/log/openhab/openhab.log <==
2022-12-01 00:49:33.824 [INFO ] [org.openhab.ui.internal.UIService   ] - Started UI on port 8080
2022-12-01 00:49:34.469 [INFO ] [ab.ui.habpanel.internal.HABPanelTile] - Started HABPanel at /habpanel
2022-12-01 00:49:38.833 [INFO ] [zwave.handler.ZWaveControllerHandler] - Attempting to add listener when controller is null
2022-12-01 00:49:41.765 [INFO ] [e.automation.internal.RuleEngineImpl] - Rule engine started.
2022-12-01 00:49:44.031 [INFO ] [ve.internal.protocol.ZWaveController] - Starting ZWave controller
2022-12-01 00:49:44.031 [INFO ] [ve.internal.protocol.ZWaveController] - ZWave timeout is set to 5000ms. Soft reset is false.
2022-12-01 00:49:56.527 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 16: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:50:26.522 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 16: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:50:31.521 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 16: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:50:56.524 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 16: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:51:26.515 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 16: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:51:56.512 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 16: Not initialized (ie node unknown), ignoring message.

==> /var/log/openhab/events.log <==
2022-12-01 00:52:06.113 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zwave:serial_zstick:09a2c7c858' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to UNINITIALIZED
2022-12-01 00:52:06.147 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zwave:serial_zstick:09a2c7c858' changed from UNINITIALIZED to UNINITIALIZED (DISABLED)

==> /var/log/openhab/openhab.log <==
2022-12-01 00:52:13.470 [INFO ] [zwave.handler.ZWaveControllerHandler] - Attempting to add listener when controller is null

==> /var/log/openhab/events.log <==
2022-12-01 00:52:13.481 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zwave:serial_zstick:09a2c7c858' changed from UNINITIALIZED (DISABLED) to INITIALIZING
2022-12-01 00:52:13.482 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zwave:serial_zstick:09a2c7c858' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline

==> /var/log/openhab/openhab.log <==
2022-12-01 00:52:18.502 [INFO ] [ve.internal.protocol.ZWaveController] - Starting ZWave controller
2022-12-01 00:52:18.502 [INFO ] [ve.internal.protocol.ZWaveController] - ZWave timeout is set to 5000ms. Soft reset is false.
2022-12-01 00:52:26.511 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 16: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:52:56.500 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 16: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:53:17.572 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 15: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:53:18.560 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 15: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:53:19.549 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 15: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:53:20.549 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 15: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:53:26.500 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 16: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:53:56.501 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 16: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:53:56.799 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 16: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:53:57.111 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 16: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:53:57.399 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 16: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:54:00.319 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 10: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:54:00.410 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 10: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:54:00.498 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 10: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:54:00.587 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 10: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:54:26.501 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 16: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:54:56.502 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 16: Not initialized (ie node unknown), ignoring message.
2022-12-01 00:55:26.501 [WARN ] [nal.protocol.ZWaveTransactionManager] - NODE 16: Not initialized (ie node unknown), ignoring message.

Is the RFC2217 feature on OpenHAB 3.3 functional? If so, what did I miss?

apella12 · December 1, 2022, 3:24pm

Not an expert on the RFC, but from the logs it looks like two controllers. Did you create a new bridge with OH3? Compare the bridge UID of the devices in the zwave XML folder with the UID of the bridge on the controller UI page. You didn’t say, but are your devices offline too?

system · January 12, 2023, 7:25am

This topic was automatically closed 41 days after the last reply. New replies are no longer allowed.