WeatherFlow Log not showing errors seen in PG3 log

[johnnyt]

It's come to my attention that the WeatherFlow NS log does not report errors that are reported in PG3 log. 

Below are two examples from this morning (using latest 3.0.25 version of NS, with log level set to "Info"):

Example 1: 

PG3 Log entries
11/23/2022, 10:15:04 [pg3] warn: ISY Response: [Try: 1] [00:21:b9:02:55:cd] :: [ECONNABORTED] :: 5036.919286ms - http://192.168.200.251:80/rest/ns/6/nodes/n006_207296/report/status/GV4/1.94/32
11/23/2022, 10:15:04 [pg3] warn: ISY Response: [Try: 1] [00:21:b9:02:55:cd] :: [ECONNABORTED] :: 5015.150309ms - http://192.168.200.251:80/rest/ns/6/nodes/n006_207296/report/status/GUST/1.94/32

WeatherFlow log entries:
2022-11-23 10:14:56,819 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: DEWPT to -2.5 UOM 4
2022-11-23 10:14:57,567 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: GV0 to -1.4 UOM 4
2022-11-23 10:14:57,610 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: ATMPRES to 1023.223 UOM 118
2022-11-23 10:14:58,738 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: CLIHUM to 75.7 UOM 22
2022-11-23 10:14:58,741 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: BARPRES to 1013.24 UOM 118
2022-11-23 10:14:59,447 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: SPEED to 1.94 UOM 32
2022-11-23 10:14:59,490 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: BATLVL to 2.371 UOM 72

PG3 error occurs here for next two updates but Weatherflow log gives appearance of successful update

2022-11-23 10:15:08,898 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: GV4 to 1.94 UOM 32
2022-11-23 10:15:08,940 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: GUST to 1.94 UOM 32

2022-11-23 10:15:09,278 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: LUMIN to 15778 UOM 36
2022-11-23 10:15:10,019 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: SOLRAD to 131 UOM 74
2022-11-23 10:15:10,061 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: UV to 1.29 UOM 71
2022-11-23 10:15:10,764 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: GV3 to 297 UOM 76
2022-11-23 10:15:10,807 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: WINDDIR to 297 UOM 76
2022-11-23 10:15:25,789 MQTT       udi_interface.interface INFO     interface:_message: Successfully set controller :: GV4 to 7 UOM 57

 

Example 2: 

PG3 log entries:

11/23/2022, 10:25:03 [pg3] warn: ISY Response: [Try: 1] [00:21:b9:02:55:cd] :: [ECONNABORTED] :: 5036.783711ms - http://192.168.200.251:80/rest/ns/6/nodes/n006_207296/report/status/UV/0.54/71
11/23/2022, 10:25:03 [pg3] warn: ISY Response: [Try: 1] [00:21:b9:02:55:cd] :: [ECONNABORTED] :: 5015.511116ms - http://192.168.200.251:80/rest/ns/6/nodes/n006_207296/report/status/SOLRAD/61/74

WeatherFlow log entries:  
2022-11-23 10:24:56,556 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: CLIHUM to 75.05 UOM 22
2022-11-23 10:24:57,663 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: GV4 to 0.0 UOM 32
2022-11-23 10:24:57,705 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: SPEED to 0.0 UOM 32
2022-11-23 10:24:58,398 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: LUMIN to 7227 UOM 36
2022-11-23 10:24:58,440 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: GUST to 0.0 UOM 32

PG3 error occurs here for next two updates but Weatherflow log gives appearance of successful update

2022-11-23 10:25:07,861 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: UV to 0.54 UOM 71
2022-11-23 10:25:07,901 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: SOLRAD to 61 UOM 74

2022-11-23 10:25:08,242 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: WINDDIR to 0 UOM 76
2022-11-23 10:25:08,613 MQTT       udi_interface.interface INFO     interface:_message: Successfully set 207296 :: GV3 to 0 UOM 76
2022-11-23 10:25:25,578 MQTT       udi_interface.interface INFO     interface:_message: Successfully set controller :: GV4 to 7 UOM 57

 

[bpwwer]

I don't see any errors from PG3, just warnings.

I've mentioned this before, PG3 makes 3 attempts to send the information to the ISY.  Above shows that the first attempt failed, but the second attempt succeeded so that's not an error.