Plugwise Ack/Protocol Issues

brownjl · March 26, 2020, 11:07am

Hello,

I see lots of plugwise messages in my logs complaining about failed acks and protocol errors. They seemingly appear in clusters every three minutes? IS there something that happens in the binding every three mins?

I’ve cut down my install to nothing but openhab, plugwise and its config. No other bindings or devices.

Does anyone else see the following in there logs?

2020-03-26 10:37:33.258 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0012000D6F0000768D80FEA8
2020-03-26 10:37:34.459 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0012000D6F0000769CE8F281
2020-03-26 10:37:35.660 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F00007695B4D0A2
2020-03-26 10:37:46.921 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F0000998DEE5B55
2020-03-26 10:37:48.258 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0012000D6F0000768D80FEA8
2020-03-26 10:37:49.459 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0012000D6F000076B6079B50
2020-03-26 10:37:50.660 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F000076B2240101
2020-03-26 10:37:51.861 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F00007695B4D0A2
2020-03-26 10:40:51.967 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0012000D6F0000769CE8F281
2020-03-26 10:40:53.167 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F0000998DEE5B55
2020-03-26 10:40:54.368 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F0000769CE9F230
2020-03-26 10:40:55.569 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0012000D6F0000769CE9E2A0
2020-03-26 10:41:06.018 [WARN ] [se.internal.PlugwiseMessageProcessor] - Plugwise protocol message error: ^E^E^C^C0000D7B900C19439{Info: Destination MAC:
2020-03-26 10:41:07.220 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F000076A355245B
2020-03-26 10:41:08.421 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0018000D6F0000768D80022B89
2020-03-26 10:41:08.648 [WARN ] [se.internal.PlugwiseMessageProcessor] - Plugwise protocol message error: #SENDING PING UNICAST: Macid: 0A03C237BDD77A6E
2020-03-26 10:41:09.849 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F0000998DEE5B55
2020-03-26 10:41:11.050 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F0000769CE9F230
2020-03-26 10:44:12.087 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F0000998DEE5B55
2020-03-26 10:47:32.293 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F0000998DEE5B55
2020-03-26 10:47:33.494 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0012000D6F0000768D80FEA8
2020-03-26 10:47:34.695 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F000076A489161B
2020-03-26 10:47:35.896 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F000076A355245B
2020-03-26 10:47:37.097 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F0000769CCAA709
2020-03-26 10:47:48.267 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0012000D6F0000768D80FEA8
2020-03-26 10:47:49.468 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F000076A489161B
2020-03-26 10:47:50.669 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F00007695B4D0A2
2020-03-26 10:47:51.870 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0012000D6F000076B2241191
2020-03-26 10:50:52.445 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F0000769CE9F230
2020-03-26 10:50:52.677 [WARN ] [se.internal.PlugwiseMessageProcessor] - Plugwise protocol CRC error: DA1A does not match C627 in message
2020-03-26 10:50:53.645 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F0000998DEE5B55
2020-03-26 10:51:07.672 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F0000998DEE5B55
2020-03-26 10:54:11.580 [WARN ] [se.internal.PlugwiseMessageProcessor] - Plugwise protocol CRC error: 7D85 does not match 36FD in message
2020-03-26 10:54:27.680 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F0000998DEE5B55
2020-03-26 10:57:32.785 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F0000998DEE5B55
2020-03-26 10:57:33.986 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0012000D6F0000768D80FEA8
2020-03-26 10:57:35.187 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F000076A489161B
2020-03-26 10:57:36.387 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F000076A355245B
2020-03-26 10:57:37.588 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F00007695B4D0A2
2020-03-26 10:57:46.858 [WARN ] [se.internal.PlugwiseMessageProcessor] - Plugwise protocol CRC error: E1E5 does not match 5CF1 in message
2020-03-26 10:57:48.276 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0012000D6F0000768D80FEA8
2020-03-26 10:57:49.477 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F000076A489161B
2020-03-26 10:57:50.678 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F00007695B4D0A2
2020-03-26 10:57:51.879 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0012000D6F000076B2241191
2020-03-26 11:00:52.914 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F0000998DEE5B55
2020-03-26 11:01:08.041 [WARN ] [gwise.internal.PlugwiseMessageSender] - Error sending: No ACK received after 1 second: 0023000D6F0000998DEE5B55

Thanks

James

brownjl · March 26, 2020, 11:09am

btw. I’ve even tried a second set of plugwise circles/circleplus and a stick and see the same results. I’ve done a free install of the server it runs on (ubuntu 18.0.4) incase there was something else in the system causing serial/usb issues.

James

H102 · March 26, 2020, 1:49pm

Set the binding log level to DEBUG or TRACE via the console and see if you get any additional info to help troubleshoot.