Hi,
I'm running version 4.5.1, with the Interceptor set in 'ecowitt-client'.
I've had a long time issue with reports stopping, and have now caught one.
The log file snippet is shown below, but I'm at a loss to explain what's
happening, as there's no error message, just a strange behavior.
====================== weewx.log =========================
Apr 14 13:00:50 pete weewx[126266] message repeated 2 times: [ DEBUG
user.interceptor: empty queue]
Apr 14 13:00:52 pete weewx[126266] DEBUG user.interceptor: POST:
PASSKEY=XXXX&stationtype=EasyWeatherV1.5.6&dateutc=2021-04-14+02:59:56&tempinf=77.2&humidityin=54&baromrelin=29.968&baromabsin=30.024&tempf=78.8&humidity=53&winddir=94&windspeedmph=2.0&windgustmph=3.4&rainratein=0.000&eventrainin=0.000&dailyrainin=0.000&weeklyrainin=0.000&monthlyrainin=5.780&totalrainin=141.402&solarradiation=721.41&uv=8&model=WS2900
Apr 14 13:00:52 pete weewx[126266] DEBUG user.interceptor: raw data:
PASSKEY=XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX&stationtype=EasyWeatherV1.5.6&dateutc=2021-04-14+02:59:56&tempinf=77.2&humidityin=54&baromrelin=29.968&baromabsin=30.024&tempf=78.8&humidity=53&winddir=94&windspeedmph=2.0&windgustmph=3.4&rainratein=0.000&eventrainin=0.000&dailyrainin=0.000&weeklyrainin=0.000&monthlyrainin=5.780&totalrainin=141.402&solarradiation=721.41&uv=8&model=WS2900
Apr 14 13:00:52 pete weewx[126266] DEBUG user.interceptor: ignored
parameter PASSKEY=XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX
Apr 14 13:00:52 pete weewx[126266] DEBUG user.interceptor: ignored
parameter stationtype=EasyWeatherV1.5.6
Apr 14 13:00:52 pete weewx[126266] DEBUG user.interceptor: ignored
parameter baromrelin=29.968
Apr 14 13:00:52 pete weewx[126266] DEBUG user.interceptor: ignored
parameter eventrainin=0.000
Apr 14 13:00:52 pete weewx[126266] DEBUG user.interceptor: ignored
parameter dailyrainin=0.000
Apr 14 13:00:52 pete weewx[126266] DEBUG user.interceptor: ignored
parameter weeklyrainin=0.000
Apr 14 13:00:52 pete weewx[126266] DEBUG user.interceptor: ignored
parameter monthlyrainin=5.780
Apr 14 13:00:52 pete weewx[126266] DEBUG user.interceptor: ignored
parameter model=WS2900
Apr 14 13:00:52 pete weewx[126266] DEBUG user.interceptor: raw packet:
{'dateTime': 1618369196, 'usUnits': 1, 'temperature_in': 77.2,
'humidity_in': 54.0, 'pressure': 30.024, 'temperature_out': 78.8,
'humidity_out': 53.0, 'wind_dir': 94.0, 'wind_speed': 2.0, 'wind_gust':
3.4, 'rain_rate': 0.0, 'rain_total': 141.402, 'solar_radiation': 721.41,
'uv': 8.0, 'rain': 0.0}
Apr 14 13:00:52 pete weewx[126266] DEBUG user.interceptor: mapped packet:
{'dateTime': 1618369196, 'usUnits': 1, 'pressure': 30.024, 'outHumidity':
53.0, 'inHumidity': 54.0, 'outTemp': 78.8, 'inTemp': 77.2, 'windSpeed':
2.0, 'windGust': 3.4, 'windDir': 94.0, 'radiation': 721.41, 'rain': 0.0,
'rainRate': 0.0, 'UV': 8.0}
Apr 14 13:01:02 pete weewx[126266] DEBUG user.interceptor: empty queue
Apr 14 13:01:22 pete weewx[126266] message repeated 2 times: [ DEBUG
user.interceptor: empty queue]
Apr 14 13:01:24 pete weewx[126266] DEBUG user.interceptor: POST:
PASSKEY=XXXX&stationtype=EasyWeatherV1.5.6&dateutc=2021-04-14+03:00:56&tempinf=77.2&humidityin=54&baromrelin=29.968&baromabsin=30.024&tempf=78.8&humidity=53&winddir=139&windspeedmph=1.6&windgustmph=2.2&rainratein=0.000&eventrainin=0.000&dailyrainin=0.000&weeklyrainin=0.000&monthlyrainin=5.780&totalrainin=141.402&solarradiation=715.79&uv=8&model=WS2900
Apr 14 13:01:24 pete weewx[126266] DEBUG user.interceptor: raw data:
PASSKEY=XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX&stationtype=EasyWeatherV1.5.6&dateutc=2021-04-14+03:00:56&tempinf=77.2&humidityin=54&baromrelin=29.968&baromabsin=30.024&tempf=78.8&humidity=53&winddir=139&windspeedmph=1.6&windgustmph=2.2&rainratein=0.000&eventrainin=0.000&dailyrainin=0.000&weeklyrainin=0.000&monthlyrainin=5.780&totalrainin=141.402&solarradiation=715.79&uv=8&model=WS2900
Apr 14 13:01:24 pete weewx[126266] DEBUG user.interceptor: ignored
parameter PASSKEY=XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX
Apr 14 13:01:24 pete weewx[126266] DEBUG user.interceptor: ignored
parameter stationtype=EasyWeatherV1.5.6
Apr 14 13:01:24 pete weewx[126266] DEBUG user.interceptor: ignored
parameter baromrelin=29.968
Apr 14 13:01:24 pete weewx[126266] DEBUG user.interceptor: ignored
parameter eventrainin=0.000
Apr 14 13:01:24 pete weewx[126266] DEBUG user.interceptor: ignored
parameter dailyrainin=0.000
Apr 14 13:01:24 pete weewx[126266] DEBUG user.interceptor: ignored
parameter weeklyrainin=0.000
Apr 14 13:01:24 pete weewx[126266] DEBUG user.interceptor: ignored
parameter monthlyrainin=5.780
Apr 14 13:01:24 pete weewx[126266] DEBUG user.interceptor: ignored
parameter model=WS2900
Apr 14 13:01:24 pete weewx[126266] DEBUG user.interceptor: raw packet:
{'dateTime': 1618369256, 'usUnits': 1, 'temperature_in': 77.2,
'humidity_in': 54.0, 'pressure': 30.024, 'temperature_out': 78.8,
'humidity_out': 53.0, 'wind_dir': 139.0, 'wind_speed': 1.6, 'wind_gust':
2.2, 'rain_rate': 0.0, 'rain_total': 141.402, 'solar_radiation': 715.79,
'uv': 8.0, 'rain': 0.0}
Apr 14 13:01:24 pete weewx[126266] DEBUG user.interceptor: mapped packet:
{'dateTime': 1618369256, 'usUnits': 1, 'pressure': 30.024, 'outHumidity':
53.0, 'inHumidity': 54.0, 'outTemp': 78.8, 'inTemp': 77.2, 'windSpeed':
1.6, 'windGust': 2.2, 'windDir': 139.0, 'radiation': 715.79, 'rain': 0.0,
'rainRate': 0.0, 'UV': 8.0}
Apr 14 13:01:24 pete weewx[126266] INFO weewx.manager: Added record
2021-04-14 13:00:00 AEST (1618369200) to database 'weewx'
Apr 14 13:01:24 pete weewx[126266] INFO weewx.manager: Added record
2021-04-14 13:00:00 AEST (1618369200) to daily summary in 'weewx'
Apr 14 13:01:24 pete weewx[126266] DEBUG weewx.reportengine: Running
reports for latest time in the database.
Apr 14 13:01:24 pete weewx[126266] DEBUG weewx.reportengine: Running report
'SeasonsReport'
Apr 14 13:01:24 pete weewx[126266] DEBUG weewx.reportengine: Found
configuration file /etc/weewx/skins/Seasons/skin.conf for report
'SeasonsReport'
Apr 14 13:01:24 pete weewx[126266] DEBUG weewx.cheetahgenerator: Using
search list ['weewx.cheetahgenerator.Almanac',
'weewx.cheetahgenerator.Station', 'weewx.cheetahgenerator.Current',
'weewx.cheetahgenerator.Stats', 'weewx.cheetahgenerator.UnitInfo',
'weewx.cheetahgenerator.Extras', 'weewx.cheetahgenerator.JSONHelpers']
Apr 14 13:01:24 pete weewx[126266] INFO weewx.restx: MQTT: Published record
2021-04-14 13:00:00 AEST (1618369200)
Apr 14 13:01:24 pete weewx[126266] DEBUG weewx.manager: Daily summary
version is 4.0
Apr 14 13:01:25 pete weewx[126266] INFO weewx.restx: OWM: Published record
2021-04-14 13:00:00 AEST (1618369200)
Apr 14 13:01:25 pete weewx[126266] INFO weewx.cheetahgenerator: Generated 8
files for report SeasonsReport in 0.89 seconds
Apr 14 13:01:25 pete weewx[126266] DEBUG weewx.manager: Daily summary
version is 4.0
Apr 14 13:01:27 pete weewx[126266] INFO weewx.imagegenerator: Generated 30
images for report SeasonsReport in 2.27 seconds
Apr 14 13:01:27 pete weewx[126266] INFO weewx.reportengine: Copied 0 files
to /var/www/html/weewx
Apr 14 13:01:27 pete weewx[126266] DEBUG weewx.reportengine: Running report
'SmartphoneReport'
Apr 14 13:01:27 pete weewx[126266] DEBUG weewx.reportengine: Found
configuration file /etc/weewx/skins/Smartphone/skin.conf for report
'SmartphoneReport'
Apr 14 13:01:27 pete weewx[126266] DEBUG weewx.cheetahgenerator: Using
search list ['weewx.cheetahgenerator.Almanac',
'weewx.cheetahgenerator.Station', 'weewx.cheetahgenerator.Current',
'weewx.cheetahgenerator.Stats', 'weewx.cheetahgenerator.UnitInfo',
'weewx.cheetahgenerator.Extras', 'weewx.cheetahgenerator.JSONHelpers']
Apr 14 13:01:27 pete weewx[126266] DEBUG weewx.manager: Daily summary
version is 4.0
Apr 14 13:01:27 pete weewx[126266] INFO weewx.cheetahgenerator: Generated 6
files for report SmartphoneReport in 0.04 seconds
Apr 14 13:01:27 pete weewx[126266] DEBUG weewx.manager: Daily summary
version is 4.0
Apr 14 13:01:28 pete weewx[126266] INFO weewx.imagegenerator: Generated 12
images for report SmartphoneReport in 0.33 seconds
Apr 14 13:01:28 pete weewx[126266] INFO weewx.reportengine: Copied 0 files
to /var/www/html/weewx/smartphone
Apr 14 13:01:28 pete weewx[126266] DEBUG weewx.reportengine: Report
'MobileReport' not enabled. Skipping.
Apr 14 13:01:28 pete weewx[126266] DEBUG weewx.reportengine: Report
'StandardReport' not enabled. Skipping.
Apr 14 13:01:28 pete weewx[126266] DEBUG weewx.reportengine: Report 'FTP'
not enabled. Skipping.
Apr 14 13:01:28 pete weewx[126266] DEBUG weewx.reportengine: Report 'RSYNC'
not enabled. Skipping.
Apr 14 13:01:34 pete weewx[126266] DEBUG user.interceptor: empty queue
Apr 14 13:01:54 pete weewx[126266] message repeated 2 times: [ DEBUG
user.interceptor: empty queue]
Apr 14 13:01:57 pete weewx[126266] DEBUG user.interceptor: POST:
PASSKEY=XXXX&stationtype=EasyWeatherV1.5.6&dateutc=2021-04-14+12:00:00&tempinf=77.2&humidityin=54&baromrelin=29.962&baromabsin=30.018&tempf=78.8&humidity=55&winddir=81&windspeedmph=2.5&windgustmph=3.4&rainratein=0.000&eventrainin=0.000&dailyrainin=0.000&weeklyrainin=0.000&monthlyrainin=5.780&totalrainin=141.402&solarradiation=711.38&uv=8&model=WS2900
Apr 14 13:01:57 pete weewx[126266] DEBUG user.interceptor: raw data:
PASSKEY=XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX&stationtype=EasyWeatherV1.5.6&dateutc=2021-04-14+12:00:00&tempinf=77.2&humidityin=54&baromrelin=29.962&baromabsin=30.018&tempf=78.8&humidity=55&winddir=81&windspeedmph=2.5&windgustmph=3.4&rainratein=0.000&eventrainin=0.000&dailyrainin=0.000&weeklyrainin=0.000&monthlyrainin=5.780&totalrainin=141.402&solarradiation=711.38&uv=8&model=WS2900
Apr 14 13:01:57 pete weewx[126266] DEBUG user.interceptor: ignored
parameter PASSKEY=XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX
Apr 14 13:01:57 pete weewx[126266] DEBUG user.interceptor: ignored
parameter stationtype=EasyWeatherV1.5.6
Apr 14 13:01:57 pete weewx[126266] DEBUG user.interceptor: ignored
parameter baromrelin=29.962
Apr 14 13:01:57 pete weewx[126266] DEBUG user.interceptor: ignored
parameter eventrainin=0.000
Apr 14 13:01:57 pete weewx[126266] DEBUG user.interceptor: ignored
parameter dailyrainin=0.000
Apr 14 13:01:57 pete weewx[126266] DEBUG user.interceptor: ignored
parameter weeklyrainin=0.000
Apr 14 13:01:57 pete weewx[126266] DEBUG user.interceptor: ignored
parameter monthlyrainin=5.780
Apr 14 13:01:57 pete weewx[126266] DEBUG user.interceptor: ignored
parameter model=WS2900
Apr 14 13:01:57 pete weewx[126266] DEBUG user.interceptor: raw packet:
{'dateTime': 1618401600, 'usUnits': 1, 'temperature_in': 77.2,
'humidity_in': 54.0, 'pressure': 30.018, 'temperature_out': 78.8,
'humidity_out': 55.0, 'wind_dir': 81.0, 'wind_speed': 2.5, 'wind_gust':
3.4, 'rain_rate': 0.0, 'rain_total': 141.402, 'solar_radiation': 711.38,
'uv': 8.0, 'rain': 0.0}
Apr 14 13:01:57 pete weewx[126266] DEBUG user.interceptor: mapped packet:
{'dateTime': 1618401600, 'usUnits': 1, 'pressure': 30.018, 'outHumidity':
55.0, 'inHumidity': 54.0, 'outTemp': 78.8, 'inTemp': 77.2, 'windSpeed':
2.5, 'windGust': 3.4, 'windDir': 81.0, 'radiation': 711.38, 'rain': 0.0,
'rainRate': 0.0, 'UV': 8.0}
Apr 14 13:01:57 pete weewx[126266] INFO weewx.manager: Added record
2021-04-14 13:05:00 AEST (1618369500) to database 'weewx'
Apr 14 13:01:57 pete weewx[126266] INFO weewx.manager: Added record
2021-04-14 13:05:00 AEST (1618369500) to daily summary in 'weewx'
Apr 14 13:01:57 pete weewx[126266] DEBUG weewx.reportengine: Running
reports for latest time in the database.
Apr 14 13:01:57 pete weewx[126266] DEBUG weewx.reportengine: Running report
'SeasonsReport'
Apr 14 13:01:57 pete weewx[126266] DEBUG weewx.reportengine: Found
configuration file /etc/weewx/skins/Seasons/skin.conf for report
'SeasonsReport'
Apr 14 13:01:57 pete weewx[126266] DEBUG weewx.cheetahgenerator: Using
search list ['weewx.cheetahgenerator.Almanac',
'weewx.cheetahgenerator.Station', 'weewx.cheetahgenerator.Current',
'weewx.cheetahgenerator.Stats', 'weewx.cheetahgenerator.UnitInfo',
'weewx.cheetahgenerator.Extras', 'weewx.cheetahgenerator.JSONHelpers']
Apr 14 13:01:57 pete weewx[126266] DEBUG weewx.manager: Daily summary
version is 4.0
Apr 14 13:01:57 pete weewx[126266] INFO weewx.restx: MQTT: Published record
2021-04-14 13:05:00 AEST (1618369500)
Apr 14 13:01:57 pete weewx[126266] INFO weewx.restx: OWM: Published record
2021-04-14 13:05:00 AEST (1618369500)
Apr 14 13:01:58 pete weewx[126266] INFO weewx.cheetahgenerator: Generated 8
files for report SeasonsReport in 0.87 seconds
Apr 14 13:01:58 pete weewx[126266] DEBUG weewx.manager: Daily summary
version is 4.0
Apr 14 13:01:58 pete weewx[126266] INFO weewx.imagegenerator: Generated 15
images for report SeasonsReport in 0.29 seconds
Apr 14 13:01:58 pete weewx[126266] INFO weewx.reportengine: Copied 0 files
to /var/www/html/weewx
Apr 14 13:01:58 pete weewx[126266] DEBUG weewx.reportengine: Running report
'SmartphoneReport'
Apr 14 13:01:58 pete weewx[126266] DEBUG weewx.reportengine: Found
configuration file /etc/weewx/skins/Smartphone/skin.conf for report
'SmartphoneReport'
Apr 14 13:01:58 pete weewx[126266] DEBUG weewx.cheetahgenerator: Using
search list ['weewx.cheetahgenerator.Almanac',
'weewx.cheetahgenerator.Station', 'weewx.cheetahgenerator.Current',
'weewx.cheetahgenerator.Stats', 'weewx.cheetahgenerator.UnitInfo',
'weewx.cheetahgenerator.Extras', 'weewx.cheetahgenerator.JSONHelpers']
Apr 14 13:01:58 pete weewx[126266] DEBUG weewx.manager: Daily summary
version is 4.0
Apr 14 13:01:58 pete weewx[126266] INFO weewx.cheetahgenerator: Generated 6
files for report SmartphoneReport in 0.04 seconds
Apr 14 13:01:58 pete weewx[126266] DEBUG weewx.manager: Daily summary
version is 4.0
Apr 14 13:01:58 pete weewx[126266] INFO weewx.imagegenerator: Generated 6
images for report SmartphoneReport in 0.06 seconds
Apr 14 13:01:58 pete weewx[126266] INFO weewx.reportengine: Copied 0 files
to /var/www/html/weewx/smartphone
Apr 14 13:01:58 pete weewx[126266] DEBUG weewx.reportengine: Report
'MobileReport' not enabled. Skipping.
Apr 14 13:01:58 pete weewx[126266] DEBUG weewx.reportengine: Report
'StandardReport' not enabled. Skipping.
Apr 14 13:01:58 pete weewx[126266] DEBUG weewx.reportengine: Report 'FTP'
not enabled. Skipping.
Apr 14 13:01:58 pete weewx[126266] DEBUG weewx.reportengine: Report 'RSYNC'
not enabled. Skipping.
Apr 14 13:02:07 pete weewx[126266] DEBUG user.interceptor: empty queue
Apr 14 13:02:27 pete weewx[126266] message repeated 2 times: [ DEBUG
user.interceptor: empty queue]
Apr 14 13:02:28 pete weewx[126266] DEBUG user.interceptor: POST:
PASSKEY=XXXX&stationtype=EasyWeatherV1.5.6&dateutc=2021-04-14+03:01:56&tempinf=77.2&humidityin=54&baromrelin=29.962&baromabsin=30.018&tempf=78.6&humidity=55&winddir=68&windspeedmph=2.2&windgustmph=3.4&rainratein=0.000&eventrainin=0.000&dailyrainin=0.000&weeklyrainin=0.000&monthlyrainin=5.780&totalrainin=141.402&solarradiation=711.38&uv=8&model=WS2900
Apr 14 13:02:28 pete weewx[126266] DEBUG user.interceptor: raw data:
PASSKEY=XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX&stationtype=EasyWeatherV1.5.6&dateutc=2021-04-14+03:01:56&tempinf=77.2&humidityin=54&baromrelin=29.962&baromabsin=30.018&tempf=78.6&humidity=55&winddir=68&windspeedmph=2.2&windgustmph=3.4&rainratein=0.000&eventrainin=0.000&dailyrainin=0.000&weeklyrainin=0.000&monthlyrainin=5.780&totalrainin=141.402&solarradiation=711.38&uv=8&model=WS2900
Apr 14 13:02:28 pete weewx[126266] DEBUG user.interceptor: ignored
parameter PASSKEY=XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX
Apr 14 13:02:28 pete weewx[126266] DEBUG user.interceptor: ignored
parameter stationtype=EasyWeatherV1.5.6
Apr 14 13:02:28 pete weewx[126266] DEBUG user.interceptor: ignored
parameter baromrelin=29.962
Apr 14 13:02:28 pete weewx[126266] DEBUG user.interceptor: ignored
parameter eventrainin=0.000
Apr 14 13:02:28 pete weewx[126266] DEBUG user.interceptor: ignored
parameter dailyrainin=0.000
Apr 14 13:02:28 pete weewx[126266] DEBUG user.interceptor: ignored
parameter weeklyrainin=0.000
Apr 14 13:02:28 pete weewx[126266] DEBUG user.interceptor: ignored
parameter monthlyrainin=5.780
Apr 14 13:02:28 pete weewx[126266] DEBUG user.interceptor: ignored
parameter model=WS2900
Apr 14 13:02:28 pete weewx[126266] DEBUG user.interceptor: raw packet:
{'dateTime': 1618369316, 'usUnits': 1, 'temperature_in': 77.2,
'humidity_in': 54.0, 'pressure': 30.018, 'temperature_out': 78.6,
'humidity_out': 55.0, 'wind_dir': 68.0, 'wind_speed': 2.2, 'wind_gust':
3.4, 'rain_rate': 0.0, 'rain_total': 141.402, 'solar_radiation': 711.38,
'uv': 8.0, 'rain': 0.0}
Apr 14 13:02:28 pete weewx[126266] DEBUG user.interceptor: mapped packet:
{'dateTime': 1618369316, 'usUnits': 1, 'pressure': 30.018, 'outHumidity':
55.0, 'inHumidity': 54.0, 'outTemp': 78.6, 'inTemp': 77.2, 'windSpeed':
2.2, 'windGust': 3.4, 'windDir': 68.0, 'radiation': 711.38, 'rain': 0.0,
'rainRate': 0.0, 'UV': 8.0}
Apr 14 13:02:38 pete weewx[126266] DEBUG user.interceptor: empty queue
Apr 14 13:02:58 pete weewx[126266] message repeated 2 times: [ DEBUG
user.interceptor: empty queue]
=========================== end ========================
The behavior is that weewx seems to generate two reports is a short
interval, generally just after the hour, and then stops talking until
restarted. Once restarted, weewx will continue reporting for an hour, then
stop again until the next (now automated) restart.
Once this cycle begins, the only medium term fix is to restart the VM
that's running weewx.
I've noticed now that the interceptor sends a packet with a shonky
timestamp just before the second report. Maybe that's the cause. The
interceptor seems to collect it's wits and continues with good timestamps
after the problem packet. The reporter however, never recovers.
Hopefully this is enough to let someone give me pointers to where to look
next.
regards,
Russell C
--
You received this message because you are subscribed to the Google Groups
"weewx-user" group.
To unsubscribe from this group and stop receiving emails from it, send an email
to [email protected].
To view this discussion on the web visit
https://groups.google.com/d/msgid/weewx-user/95714733-c26f-45bb-8d1b-96e599ee1f70n%40googlegroups.com.
