matthewwall / weewx-interceptor

weewx driver that intercepts web traffic from internet 'bridge' devices such as Acurite Access, ObserverIP, OS LW30x, LaCross GW1000U, FineOffset GW1000
GNU General Public License v3.0
104 stars 43 forks source link

Interceptor stopped working intermittently - empty queue #104

Open magnum61 opened 2 years ago

magnum61 commented 2 years ago

Hi all,

i do have an Ecowitt HP2551 and pulling the data via WeeWX Interceptor running as ecowitt-client.

Since this morning Weewx Interceptor shows only "empty queue" with debugging enabled. local Website is not updated and no data is uploaded to any of the web services.

Below is my logfile after i've restarted the weewx service. What can i do to get it back working? Device is a Raspberry 4 with Raspberry OS Bullseye installed. Worked for 2 weeks without issues

Tried reinstalling Interceptor, but the problem remain the same

Mär 08 20:25:54 Raspi42 systemd[1]: Starting LSB: weewx weather system...
░░ Subject: A start job for unit weewx.service has begun execution
░░ A start job for unit weewx.service has begun execution.
Mär 08 20:25:54 Raspi42 python3[7508]: weewx[7508] INFO __main__: Initializing weewx version 4.7.0
Mär 08 20:25:54 Raspi42 python3[7508]: weewx[7508] INFO __main__: Using Python 3.9.2 (default, Mar 12 2021, 04:06:34) 
Mär 08 20:25:54 Raspi42 python3[7508]: weewx[7508] INFO __main__: Platform Linux-5.10.92-v7l+-armv7l-with-glibc2.31
Mär 08 20:25:54 Raspi42 python3[7508]: weewx[7508] INFO __main__: Locale is 'de_DE.UTF-8'
Mär 08 20:25:54 Raspi42 python3[7508]: weewx[7508] INFO __main__: Using configuration file /etc/weewx/weewx.conf
Mär 08 20:25:54 Raspi42 python3[7508]: weewx[7508] INFO __main__: Debug is 1
Mär 08 20:25:54 Raspi42 python3[7508]: weewx[7508] INFO __main__: PID file is /var/run/weewx.pid
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG __main__: Initializing engine
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO weewx.engine: Loading station type Interceptor (user.interceptor)
Mär 08 20:25:54 Raspi42 weewx[7497]: Starting weewx weather system: weewx.
Mär 08 20:25:54 Raspi42 systemd[1]: Started LSB: weewx weather system.
░░ Subject: A start job for unit weewx.service has finished successfully
░░ A start job for unit weewx.service has finished successfully.
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO user.interceptor: driver version is 0.53
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO user.interceptor: device type: ecowitt-client
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO user.interceptor: mode is listen
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO user.interceptor: listen on :8100
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO user.interceptor: sensor map: {'pressure': 'pressure', 'barometer': 'barometer', 'outHumidity': 'humidity_out', 'inHumidity': 'humidity_in', 'outTemp': 'temperature_out', 'inTemp': 'temperature_in', 'windSpeed': 'wind_speed', 'windGust': 'wind_gust', 'windDir': 'wind_dir', 'windGustDir': 'wind_gust_dir', 'radiation': 'solar_radiation', 'dewpoint': 'dewpoint', 'windchill': 'windchill', 'rain': 'rain', 'rainRate': 'rain_rate', 'UV': 'uv', 'txBatteryStatus': 'battery', 'extraTemp1': 'temperature_1', 'extraTemp2': 'temperature_2', 'extraTemp3': 'temperature_3', 'extraHumid1': 'humidity_1', 'extraHumid2': 'humidity_2', 'soilTemp1': 'soil_temperature_1', 'soilTemp2': 'soil_temperature_2', 'soilMoist1': 'soil_moisture_1', 'soilMoist2': 'soil_moisture_2', 'soilMoist3': 'soil_moisture_3', 'soilMoist4': 'soil_moisture_4', 'leafWet1': 'leafwetness_1', 'leafWet2': 'leafwetness_2', 'pm2_5': 'pm2_5', 'extraTemp4': 'temperature_4', 'extraTemp5': 'temperature_5', 'extraTemp6': 'temperature_6', 'extraTemp7': 'temperature_7', 'extraTemp8': 'temperature_8', 'extraHumid3': 'humidity_3', 'extraHumid4': 'humidity_4', 'extraHumid5': 'humidity_5', 'extraHumid6': 'humidity_6', 'extraHumid7': 'humidity_7', 'extraHumid8': 'humidity_8', 'soilTemp3': 'soil_temperature_3', 'soilTemp4': 'soil_temperature_4'}
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: start tcp server
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service weewx.engine.StdTimeSynch
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service weewx.engine.StdTimeSynch
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service weewx.engine.StdConvert
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO weewx.engine: StdConvert target unit is 0x1
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service weewx.engine.StdConvert
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service weewx.engine.StdCalibrate
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service weewx.engine.StdCalibrate
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service weewx.engine.StdQC
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service weewx.engine.StdQC
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service weewx.wxservices.StdWXCalculate
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO weewx.wxservices: StdWXCalculate will use data binding wx_binding
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.manager: Daily summary version is 4.0
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service weewx.wxservices.StdWXCalculate
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service weewx.wxxtypes.StdWXXTypes
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service weewx.wxxtypes.StdWXXTypes
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service weewx.wxxtypes.StdPressureCooker
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service weewx.wxxtypes.StdPressureCooker
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service weewx.wxxtypes.StdRainRater
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service weewx.wxxtypes.StdRainRater
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service weewx.wxxtypes.StdDelta
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service weewx.wxxtypes.StdDelta
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service weewx.engine.StdArchive
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO weewx.engine: Archive will use data binding wx_binding
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO weewx.engine: Record generation will be attempted in 'hardware'
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO weewx.engine: Using archive interval of 60 seconds (specified in weewx configuration)
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Use LOOP data in hi/low calculations: 1
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service weewx.engine.StdArchive
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service weewx.restx.StdStationRegistry
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO weewx.restx: StationRegistry: Registration not requested.
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service weewx.restx.StdStationRegistry
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service weewx.restx.StdWunderground
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.restx: WU essentials: {}
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO weewx.restx: Wunderground-PWS: Data for station IROXHE1 will be posted
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service weewx.restx.StdWunderground
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service weewx.restx.StdPWSweather
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO weewx.restx: PWSWeather: Data for station RX14711 will be posted
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service weewx.restx.StdPWSweather
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service weewx.restx.StdCWOP
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO weewx.restx: CWOP: Posting not enabled.
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service weewx.restx.StdCWOP
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service weewx.restx.StdWOW
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO weewx.restx: WOW: Posting not enabled.
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service weewx.restx.StdWOW
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service weewx.restx.StdAWEKAS
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO weewx.restx: AWEKAS: Data will be uploaded for user volkskamera
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service weewx.restx.StdAWEKAS
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service user.weather365.Weather365
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO user.weather365: restx: Weather365: service version is 3.0
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO user.weather365: restx: Weather365: Data will be uploaded for station id 7X5CK4CK5R
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service user.weather365.Weather365
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service user.wetter.Wetter
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO user.wetter: service version is 0.7
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO user.wetter: wetter API version is 5.0.2 - 2015/06/01
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO user.wetter: Data will be uploaded for station id 20609
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service user.wetter.Wetter
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service user.windy.Windy
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO user.windy: version is 0.7
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO user.windy: Data will be uploaded to https://stations.windy.com/pws/update
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service user.windy.Windy
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service user.wcloud.WeatherCloud
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO user.wcloud: service version is 0.13
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO user.wcloud: Data will be uploaded for id=b9f494749e9b88e0
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service user.wcloud.WeatherCloud
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service user.windguru.WindGuru
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO user.windguru: service version is 0.2
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO user.windguru: Data will be uploaded for ROX1
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service user.windguru.WindGuru
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service weewx.engine.StdPrint
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service weewx.engine.StdPrint
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Loading service weewx.engine.StdReport
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.manager: Daily summary version is 4.0
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO weewx.engine: 'pyephem' detected, extended almanac data is available
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Finished loading service weewx.engine.StdReport
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO __main__: Starting up weewx version 4.7.0
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.engine: Station does not support reading the time
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO weewx.engine: Using binding 'wx_binding' to database 'weewx.sdb'
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO weewx.manager: Starting backfill of daily summaries
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO weewx.manager: Daily summaries up to date
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] INFO weewx.engine: Starting main packet loop.
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.manager: Daily summary version is 4.0
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.manager: Daily summary version is 4.0
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.manager: Daily summary version is 4.0
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.manager: Daily summary version is 4.0
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.manager: Daily summary version is 4.0
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.manager: Daily summary version is 4.0
Mär 08 20:25:54 Raspi42 python3[7511]: weewx[7511] DEBUG weewx.manager: Daily summary version is 4.0
Mär 08 20:25:57 Raspi42 sudo[7533]:       pi : TTY=pts/0 ; PWD=/etc/weewx ; USER=root ; COMMAND=/usr/bin/systemctl status weewx
Mär 08 20:26:04 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: empty queue
Mär 08 20:26:14 Raspi42 sudo[7571]:       pi : TTY=pts/0 ; PWD=/etc/weewx ; USER=root ; COMMAND=/usr/bin/systemctl status weewx
Mär 08 20:26:14 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: empty queue
Mär 08 20:26:24 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: empty queue
Mär 08 20:26:34 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: empty queue
Mär 08 20:26:44 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: empty queue
Mär 08 20:26:54 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: empty queue
Mär 08 20:27:04 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: empty queue
Mär 08 20:27:14 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: empty queue
Mär 08 20:27:24 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: empty queue
Mär 08 20:27:34 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: empty queue
Mär 08 20:27:44 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: empty queue
Mär 08 20:27:54 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: empty queue
Mär 08 20:28:04 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: empty queue
Mär 08 20:28:14 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: empty queue
Mär 08 20:28:24 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: empty queue
Mär 08 20:28:34 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: empty queue
Mär 08 20:28:44 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: empty queue
Mär 08 20:28:48 Raspi42 sudo[8319]:       pi : TTY=pts/0 ; PWD=/etc/weewx ; USER=root ; COMMAND=/usr/bin/systemctl status weewx
Mär 08 20:28:54 Raspi42 python3[7511]: weewx[7511] DEBUG user.interceptor: empty queue
Mär 08 20:28:56 Raspi42 sudo[8492]:       pi : TTY=pts/0 ; PWD=/etc/weewx ; USER=root ; COMMAND=/usr/bin/journalctl -xe
magnum61 commented 2 years ago

Short Update:

I've reinstalled WeeWX completely fresh on the same device after reimaging the operating system (Raspbian OS Bullseye) Right after restarting the service, the error with the empty queue appeared again.