Moved to PG3; Rachio node won't connect to API

[atmarosi]

Was on PG2 and had the Rachio node working great; moved to PG3 recently and getting all the nodes set back up and noticed I can't get the valves to show up.  In the logs i see this (set it to debug on the logs and restarted the node):
 

2022-10-06 09:50:38,232 MQTT udi_interface.interface DEBUG interface:_message: QUEUING incoming message stop
2022-10-06 09:50:38,234 Command udi_interface.interface DEBUG interface:_parseInput: DEQUEING stop
2022-10-06 09:50:38,235 Command udi_interface.interface INFO interface:_handleInput: Received stop from Polyglot... Shutting Down.
2022-10-06 09:50:38,236 Command udi_interface.interface INFO interface:stop: Disconnecting from MQTT... localhost:1888
2022-10-06 09:50:38,238 Command udi_interface.interface INFO interface:_disconnect: MQTT Graceful disconnection.
2022-10-06 09:50:38,240 MQTT udi_interface.interface DEBUG interface:_startMqtt: MQTT: Done
2022-10-06 09:50:46,376 MainThread udi_interface INFO polylogger:set_basic_config: set_basic_config: enable=True level=30
2022-10-06 09:50:49,048 MainThread udi_interface INFO __init__:<module>: UDI Python Interface for Polyglot version 3 3.0.49 Starting...
2022-10-06 09:50:49,384 MainThread udi_interface.interface INFO interface:__init__: Initialization received from Polyglot V3 3.1.11 [ISY: 5.4.4, Slot: 1]
2022-10-06 09:50:49,387 MainThread udi_interface.interface INFO interface:__init__: Connect: Network Interface: {'addr': '172.16.69.211', 'netmask': '255.255.255.0', 'broadcast': '172.16.69.255'}
2022-10-06 09:50:49,389 Interface udi_interface.interface INFO interface:_startMqtt: Connecting to MQTT... localhost:1888
2022-10-06 09:50:49,392 MainThread udi_interface.interface INFO interface:updateProfile: Sending Install Profile command to Polyglot.
2022-10-06 09:50:49,394 MainThread udi_interface.interface WARNING interface:send: MQTT Send waiting on connection :: {'installprofile': {'reboot': False}}
2022-10-06 09:50:49,452 MQTT udi_interface.interface INFO interface:_connect: MQTT Connected with result code 0 (Success)
2022-10-06 09:50:49,454 MQTT udi_interface.interface INFO interface:_connect: MQTT Subscribing to topic: udi/pg3/ns/clients/00:0d:b9:XX:XX:XX_1 - MID: 1 Result: 0
2022-10-06 09:50:49,463 MQTT udi_interface.interface INFO interface:_subscribe: MQTT Subscribed Succesfully for Message ID: 1 - QoS: (0,)
2022-10-06 09:50:49,550 MQTT udi_interface.interface INFO interface:_message: Successfully set controller :: ST to 1 UOM 25
2022-10-06 09:50:52,547 MainThread udi_interface.interface WARNING interface:db_getNodeDrivers: controller not found in database.
2022-10-06 09:50:52,553 MainThread udi_interface.interface INFO interface:addNode: Adding node Rachio Bridge(controller) [None]
2022-10-06 09:50:52,555 MainThread udi_interface.interface INFO interface:setController: Using node "controller", driver "ST" for connection status.
2022-10-06 09:50:52,607 MQTT udi_interface.interface INFO interface:_message: custom data response {'customparamsdoc': '<h2>Configuration</h2>\n\n<ul>\n<li>REQUIRED: Key:\'api_key\' Value: See <a href="https://rachio.readme.io/v1.0/docs">here</a> for instructions on how to obtain Rachio API Key.</li>\n<li>REQUIRED: Key: \'host\' Value: External address for polyglot server (External static IP or Dynamic DNS host name). Not required or used for polyglot cloud.</li>\n<li>OPTIONAL: Key: \'port\' Value: External port (integer) for polyglot server. Note: This port must be opened through firewall and forwarded to the internal polyglot server. Defaults to \'3001\' if no entry given but opening port is not optional (required for Rachio websockets). ot required or used for polyglot cloud.</li>\n<li>OPTIONAL: Key:\'nodeAdditionInterval\' Value: On discovery, nodes will be added at this interval (in seconds).</li>\n</ul>\n\n<p>Additional notes available on the <a href="https://github.com/fahrer16/udi-rachio-poly">github page</a> for this node server</p>\n'}
2022-10-06 09:50:52,648 MQTT udi_interface.interface INFO interface:_message: Successfully set key = customparamsdoc
2022-10-06 09:50:52,777 MQTT udi_interface.interface DEBUG interface:_message: QUEUING incoming message getAll
2022-10-06 09:50:52,778 Command udi_interface.interface DEBUG interface:_parseInput: DEQUEING getAll
2022-10-06 09:50:52,780 MQTT udi_interface.interface DEBUG interface:_message: QUEUING incoming message getNsInfo
2022-10-06 09:50:52,783 Thread-3 udi_interface.custom DEBUG custom:clear: CUSTOM: Clear ...saving
2022-10-06 09:50:52,784 Command udi_interface.custom DEBUG custom:load: CUSTOM: load {}
2022-10-06 09:50:52,787 MQTT udi_interface.interface DEBUG interface:_message: QUEUING incoming message setController
2022-10-06 09:50:52,788 Thread-3 udi_interface.custom INFO custom:_save: Sending data notices to Polyglot.
2022-10-06 09:50:52,789 Command udi_interface.interface DEBUG interface:_handleInput: Key nsdata should be passed to node server.
2022-10-06 09:50:52,791 Thread-3 udi_interface.interface DEBUG interface:send: PUBLISHING {'set': [{'key': 'notices', 'value': {}}]}
2022-10-06 09:50:52,792 Command udi_interface.interface DEBUG interface:_handleInput: Key oauth should be passed to node server.
2022-10-06 09:50:52,795 Thread-3 udi_interface INFO rachio-poly:parameterHandler: Ensure router/firewall is set to forward requests to polyglot host on port 3001
2022-10-06 09:50:52,796 Command udi_interface.interface DEBUG interface:_parseInput: DEQUEING getNsInfo
2022-10-06 09:50:52,797 Thread-3 udi_interface DEBUG rachio-poly:parameterHandler: Trying default key file: certificate.pem
2022-10-06 09:50:52,798 Command udi_interface.interface DEBUG interface:_parseInput: DEQUEING setController
2022-10-06 09:50:52,800 Thread-3 udi_interface DEBUG rachio-poly:parameterHandler: Can't locate certificate, SSL disabled
2022-10-06 09:50:52,801 Command udi_interface.interface DEBUG interface:_handleInput: connection status node/driver update
2022-10-06 09:50:52,802 Thread-3 udi_interface DEBUG rachio-poly:parameterHandler: Starting Webhook Server on port 3001
2022-10-06 09:50:52,808 Thread-3 udi_interface INFO rachio-poly:testWebSocketConnectivity: Testing connectivity to XXXXXX.dyndns.org:3001
2022-10-06 09:50:52,850 Thread-3 udi_interface ERROR rachio-poly:testWebSocketConnectivity: Error reaching specified host:port externally (XXXXX.dyndns.org:3001). Please ensure entries are correct and the appropriate firewall ports have been opened (for local installs): [Errno 61] Connection refused
2022-10-06 09:50:52,852 Thread-3 udi_interface ERROR rachio-poly:parameterHandler: Webhook connectivity test failed, exiting
2022-10-06 09:50:52,852 Thread-3 udi_interface DEBUG rachio-poly:parameterHandler: Rachio "start" routine complete
2022-10-06 09:50:52,871 MQTT udi_interface.interface DEBUG interface:_message: QUEUING incoming message notices
2022-10-06 09:50:52,873 Command udi_interface.interface DEBUG interface:_parseInput: DEQUEING notices
2022-10-06 09:50:52,874 Command udi_interface.custom DEBUG custom:load: CUSTOM: load {}
2022-10-06 09:50:52,913 MQTT udi_interface.interface INFO interface:_message: Successfully set key = notices
2022-10-06 09:50:52,915 MQTT udi_interface.interface INFO interface:_message: Profile installation finished
2022-10-06 09:50:52,963 MQTT udi_interface.interface DEBUG interface:_message: QUEUING incoming message addnode
2022-10-06 09:50:52,965 Command udi_interface.interface DEBUG interface:_parseInput: DEQUEING addnode
2022-10-06 09:50:52,968 Thread-6 udi_interface INFO rachio-poly:start: Starting Rachio Polyglot v3 Node server version 4.0.4
2022-10-06 09:50:52,970 Command udi_interface.interface DEBUG interface:_handleResult: add node response: {'id': 'ceeee256-aba8-4737-88c7-f356a1077ba7', 'uuid': '00:0d:b9:53:35:94', 'profileNum': 1, 'address': 'controller', 'name': 'Rachio Bridge', 'nodeDefId': 'rachio', 'nls': None, 'hint': '0x00000000', 'controller': 0, 'primaryNode': 'controller', 'private': None, 'isPrimary': 1, 'enabled': 1, 'timeAdded': 1665072648333, 'timeModified': 1665072648333, 'dbVersion': 1}
2022-10-06 09:50:56,800 MQTT udi_interface.interface DEBUG interface:_message: QUEUING incoming message shortPoll
2022-10-06 09:50:56,802 Command udi_interface.interface DEBUG interface:_parseInput: DEQUEING shortPoll
2022-10-06 09:51:01,830 MQTT udi_interface.interface DEBUG interface:_message: QUEUING incoming message shortPoll
2022-10-06 09:51:01,832 Command udi_interface.interface DEBUG interface:_parseInput: DEQUEING shortPoll

I've got the port forward still in from when I was using PG2 and I'm able to reach it via telnetting from a machine not on my network (telnet XXXX.dyndns.org 3001) ...not sure what I'm missing.

Thanks!

 

Edited October 6, 2022 by atmarosi

[Goose66]

I have never used the Rachio node server before so maybe I shouldn't be commenting, but the error is "[Errno 61] Connection refused" which often means there is already a connection to the socket at that port. Is it possible that Polyglot v2 version is still running?