LOOP try problem ...

[mup...@gmail.com]

Hello,

Just checked my log to see how things were operating and found this:

Jun 16 17:45:20 weewx-RPi weewx[76976] ERROR weewx.drivers.vantage: LOOP max tries (4) exceeded.

Jun 16 17:45:20 weewx-RPi weewx[76976] INFO weewx.engine: Main loop exiting. Shutting engine down.
Jun 16 17:45:20 weewx-RPi weewx[76976] CRITICAL __main__: Caught WeeWxIOError: Max tries exceeded while getting LOOP data.
Jun 16 17:45:20 weewx-RPi weewx[76976] CRITICAL __main__:     ****  Waiting 60 seconds then retrying...
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO __main__: retrying...
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO weewx.engine: Loading station type Vantage (weewx.drivers.vantage)
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO weewx.engine: StdConvert target unit is 0x1
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO weewx.wxservices: StdWXCalculate will use data binding wx_binding
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO weewx.engine: Archive will use data binding wx_binding
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO weewx.engine: Record generation will be attempted in 'software'
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO weewx.engine: Using archive interval of 300 seconds (software record generation)
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO weewx.restx: StationRegistry: Registration not requested.
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO weewx.restx: Wunderground-PWS: Data for station KCAPLACE82 will be posted
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO weewx.restx: PWSWeather: Data for station k6mle will be posted
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO weewx.restx: CWOP: Data for station K6MLE will be posted
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO weewx.restx: WOW: Posting not enabled.
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO weewx.restx: AWEKAS: Posting not enabled.
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO weewx.engine: 'pyephem' not detected, extended almanac data is not available
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO __main__: Starting up weewx version 4.8.0
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO weewx.engine: Clock error is 0.61 seconds (positive is fast)
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO weewx.engine: Using binding 'wx_binding' to database 'weewx.sdb'
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO weewx.manager: Starting backfill of daily summaries
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO weewx.manager: Daily summaries up to date
Jun 16 17:46:20 weewx-RPi weewx[76976] INFO weewx.engine: Starting main packet loop.
Jun 16 17:46:28 weewx-RPi weewx[76976] ERROR weewx.drivers.vantage: LOOP try #1; error: Expected to read 99 chars; got 0 instead
Jun 16 17:46:32 weewx-RPi weewx[76976] ERROR weewx.drivers.vantage: LOOP try #2; error: Expected to read 99 chars; got 0 instead
Jun 16 17:46:36 weewx-RPi weewx[76976] ERROR weewx.drivers.vantage: LOOP try #3; error: Expected to read 99 chars; got 0 instead
Jun 16 17:46:40 weewx-RPi weewx[76976] ERROR weewx.drivers.vantage: LOOP try #4; error: Expected to read 99 chars; got 0 instead

Jun 16 17:46:40 weewx-RPi weewx[76976] ERROR weewx.drivers.vantage: LOOP max tries (4) exceeded.

What might be causing this  I/O error?

Thanks,

Michael

[Tom Keffer]

It appears that "debug" is not on, so the information in the log will be limited. However, I would guess that weewxd is having trouble connecting with your Vantage.

Try setting debug=1 in weewx.conf, then restarting weewxd. Post the log from startup through the first reporting cycle. 

Also, any particular reason why you are using software record generation?

-tk

--
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 weewx-user+...@googlegroups.com.
To view this discussion on the web visit https://groups.google.com/d/msgid/weewx-user/008dc51c-2fa2-42b2-b2d1-b742d073519an%40googlegroups.com.

[mup...@gmail.com]

Thank you for your response.

I have set debug=1.  I had tried changing to software record generation to see what might change.  It is now back to hardware.

This is the log file upon restart:

sudo tail -f /var/log/syslog
Jun 17 08:08:11 weewx-RPi weewx[76976] ERROR weewx.drivers.vantage: LOOP max tries (4) exceeded.
Jun 17 08:08:11 weewx-RPi weewx[76976] INFO weewx.engine: Main loop exiting. Shutting engine down.
Jun 17 08:08:11 weewx-RPi weewx[76976] CRITICAL __main__: Caught WeeWxIOError: Max tries exceeded while getting LOOP data.
Jun 17 08:08:11 weewx-RPi weewx[76976] CRITICAL __main__:     ****  Waiting 60 seconds then retrying...
Jun 17 08:09:02 weewx-RPi systemd[1]: Stopping LSB: weewx weather system...
Jun 17 08:09:02 weewx-RPi weewx[76976] INFO __main__: Received signal TERM (15).
Jun 17 08:09:07 weewx-RPi weewx[83683]: Stopping weewx weather system: weewx..
Jun 17 08:09:07 weewx-RPi systemd[1]: weewx.service: Succeeded.
Jun 17 08:09:07 weewx-RPi systemd[1]: Stopped LSB: weewx weather system.
Jun 17 08:09:07 weewx-RPi systemd[1]: weewx.service: Consumed 2min 1.510s CPU time.
Jun 17 08:09:37 weewx-RPi systemd[1]: Starting LSB: weewx weather system...
Jun 17 08:09:37 weewx-RPi weewx[83740] INFO __main__: Initializing weewx version 4.8.0
Jun 17 08:09:37 weewx-RPi weewx[83740] INFO __main__: Using Python 3.9.2 (default, Feb 28 2021, 17:03:44) #012[GCC 10.2.1 20210110]
Jun 17 08:09:37 weewx-RPi weewx[83740] INFO __main__: Platform Linux-5.15.32-v8+-aarch64-with-glibc2.31
Jun 17 08:09:37 weewx-RPi weewx[83740] INFO __main__: Locale is 'en_US.UTF-8'
Jun 17 08:09:37 weewx-RPi weewx[83740] INFO __main__: Using configuration file /etc/weewx/weewx.conf
Jun 17 08:09:37 weewx-RPi weewx[83740] INFO __main__: Debug is 1
Jun 17 08:09:37 weewx-RPi weewx[83740] INFO __main__: PID file is /var/run/weewx.pid
Jun 17 08:09:37 weewx-RPi weewx[83743] DEBUG __main__: Initializing engine
Jun 17 08:09:37 weewx-RPi weewx[83743] INFO weewx.engine: Loading station type Vantage (weewx.drivers.vantage)
Jun 17 08:09:37 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Driver version is 3.2.3
Jun 17 08:09:37 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Option loop_request=1
Jun 17 08:09:37 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Opened up serial port /dev/ttyS0; baud 19200; timeout 4.00
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Gentle wake up of console successful
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Hardware type is 16
Jun 17 08:09:38 weewx-RPi weewx[83729]: Starting weewx weather system: weewx.
Jun 17 08:09:38 weewx-RPi systemd[1]: Started LSB: weewx weather system.
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: ISS ID is 1
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Hardware name: Vantage Pro2
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.engine.StdTimeSynch
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.engine.StdTimeSynch
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.engine.StdConvert
Jun 17 08:09:38 weewx-RPi weewx[83743] INFO weewx.engine: StdConvert target unit is 0x1
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.engine.StdConvert
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.engine.StdCalibrate
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.engine.StdCalibrate
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.engine.StdQC
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.engine.StdQC
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.wxservices.StdWXCalculate
Jun 17 08:09:38 weewx-RPi weewx[83743] INFO weewx.wxservices: StdWXCalculate will use data binding wx_binding
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.manager: Daily summary version is 4.0
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.wxservices.StdWXCalculate
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.wxxtypes.StdWXXTypes
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.wxxtypes.StdWXXTypes
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.wxxtypes.StdPressureCooker
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.wxxtypes.StdPressureCooker
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.wxxtypes.StdRainRater
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.wxxtypes.StdRainRater
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.wxxtypes.StdDelta
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.wxxtypes.StdDelta
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.engine.StdArchive
Jun 17 08:09:38 weewx-RPi weewx[83743] INFO weewx.engine: Archive will use data binding wx_binding
Jun 17 08:09:38 weewx-RPi weewx[83743] INFO weewx.engine: Record generation will be attempted in 'hardware'
Jun 17 08:09:38 weewx-RPi weewx[83743] ERROR weewx.engine: The archive interval in the configuration file (300) does not match the station hardware interval (1800).
Jun 17 08:09:38 weewx-RPi weewx[83743] INFO weewx.engine: Using archive interval of 1800 seconds (specified by hardware)
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Use LOOP data in hi/low calculations: 1
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.engine.StdArchive
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.restx.StdStationRegistry
Jun 17 08:09:38 weewx-RPi weewx[83743] INFO weewx.restx: StationRegistry: Registration not requested.
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.restx.StdStationRegistry
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.restx.StdWunderground
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.restx: WU essentials: {}
Jun 17 08:09:38 weewx-RPi weewx[83743] INFO weewx.restx: Wunderground-PWS: Data for station KCAPLACE82 will be posted
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.restx.StdWunderground
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.restx.StdPWSweather
Jun 17 08:09:38 weewx-RPi weewx[83743] INFO weewx.restx: PWSWeather: Data for station k6mle will be posted
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.restx.StdPWSweather
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.restx.StdCWOP
Jun 17 08:09:38 weewx-RPi weewx[83743] INFO weewx.restx: CWOP: Data for station K6MLE will be posted
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.restx.StdCWOP
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.restx.StdWOW
Jun 17 08:09:38 weewx-RPi weewx[83743] INFO weewx.restx: WOW: Posting not enabled.
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.restx.StdWOW
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.restx.StdAWEKAS
Jun 17 08:09:38 weewx-RPi weewx[83743] INFO weewx.restx: AWEKAS: Posting not enabled.
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.restx.StdAWEKAS
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.engine.StdPrint
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.engine.StdPrint
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.engine.StdReport
Jun 17 08:09:38 weewx-RPi weewx[83743] INFO weewx.engine: 'pyephem' not detected, extended almanac data is not available
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.engine.StdReport
Jun 17 08:09:38 weewx-RPi weewx[83743] INFO __main__: Starting up weewx version 4.8.0
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Gentle wake up of console successful
Jun 17 08:09:38 weewx-RPi weewx[83743] INFO weewx.engine: Clock error is 1.68 seconds (positive is fast)
Jun 17 08:09:38 weewx-RPi weewx[83743] INFO weewx.engine: Using binding 'wx_binding' to database 'weewx.sdb'
Jun 17 08:09:38 weewx-RPi weewx[83743] INFO weewx.manager: Starting backfill of daily summaries
Jun 17 08:09:38 weewx-RPi weewx[83743] INFO weewx.manager: Daily summaries up to date
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Getting archive packets since 2022-06-17 08:00:00 PDT (1655478000)
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Gentle wake up of console successful
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.manager: Daily summary version is 4.0
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.manager: Daily summary version is 4.0
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.manager: Daily summary version is 4.0
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Retrieving 0 page(s); starting index= 0
Jun 17 08:09:38 weewx-RPi weewx[83743] INFO weewx.engine: Starting main packet loop.
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Gentle wake up of console successful
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Requesting 200 LOOP packets.
Jun 17 08:09:38 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Gentle wake up of console successful
Jun 17 08:09:47 weewx-RPi weewx[83743] ERROR weewx.drivers.vantage: LOOP try #1; error: Expected to read 99 chars; got 0 instead
Jun 17 08:09:51 weewx-RPi weewx[83743] ERROR weewx.drivers.vantage: LOOP try #2; error: Expected to read 99 chars; got 0 instead
Jun 17 08:09:55 weewx-RPi weewx[83743] ERROR weewx.drivers.vantage: LOOP try #3; error: Expected to read 99 chars; got 0 instead
Jun 17 08:09:59 weewx-RPi weewx[83743] ERROR weewx.drivers.vantage: LOOP try #4; error: Expected to read 99 chars; got 0 instead
Jun 17 08:09:59 weewx-RPi weewx[83743] ERROR weewx.drivers.vantage: LOOP max tries (4) exceeded.
Jun 17 08:09:59 weewx-RPi weewx[83743] INFO weewx.engine: Main loop exiting. Shutting engine down.
Jun 17 08:09:59 weewx-RPi weewx[83743] DEBUG weewx.restx: Shut down CWOP thread.
Jun 17 08:09:59 weewx-RPi weewx[83743] DEBUG weewx.restx: Shut down PWSWeather thread.
Jun 17 08:09:59 weewx-RPi weewx[83743] DEBUG weewx.restx: Shut down Wunderground-PWS thread.
Jun 17 08:09:59 weewx-RPi weewx[83743] CRITICAL __main__: Caught WeeWxIOError: Max tries exceeded while getting LOOP data.
Jun 17 08:09:59 weewx-RPi weewx[83743] CRITICAL __main__:     ****  Waiting 60 seconds then retrying...
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO __main__: retrying...
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG __main__: Initializing engine
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO weewx.engine: Loading station type Vantage (weewx.drivers.vantage)
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Driver version is 3.2.3
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Option loop_request=1
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Opened up serial port /dev/ttyS0; baud 19200; timeout 4.00
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Gentle wake up of console successful
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Hardware type is 16
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: ISS ID is 1
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Hardware name: Vantage Pro2
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.engine.StdTimeSynch
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.engine.StdTimeSynch
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.engine.StdConvert
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO weewx.engine: StdConvert target unit is 0x1
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.engine.StdConvert
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.engine.StdCalibrate
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.engine.StdCalibrate
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.engine.StdQC
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.engine.StdQC
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.wxservices.StdWXCalculate
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO weewx.wxservices: StdWXCalculate will use data binding wx_binding
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.manager: Daily summary version is 4.0
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.wxservices.StdWXCalculate
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.wxxtypes.StdWXXTypes
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.wxxtypes.StdWXXTypes
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.wxxtypes.StdPressureCooker
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.wxxtypes.StdPressureCooker
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.wxxtypes.StdRainRater
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.wxxtypes.StdRainRater
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.wxxtypes.StdDelta
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.wxxtypes.StdDelta
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.engine.StdArchive
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO weewx.engine: Archive will use data binding wx_binding
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO weewx.engine: Record generation will be attempted in 'hardware'
Jun 17 08:10:59 weewx-RPi weewx[83743] ERROR weewx.engine: The archive interval in the configuration file (300) does not match the station hardware interval (1800).
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO weewx.engine: Using archive interval of 1800 seconds (specified by hardware)
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Use LOOP data in hi/low calculations: 1
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.engine.StdArchive
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.restx.StdStationRegistry
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO weewx.restx: StationRegistry: Registration not requested.
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.restx.StdStationRegistry
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.restx.StdWunderground
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.restx: WU essentials: {}
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO weewx.restx: Wunderground-PWS: Data for station KCAPLACE82 will be posted
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.restx.StdWunderground
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.restx.StdPWSweather
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO weewx.restx: PWSWeather: Data for station k6mle will be posted
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.restx.StdPWSweather
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.restx.StdCWOP
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO weewx.restx: CWOP: Data for station K6MLE will be posted
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.restx.StdCWOP
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.restx.StdWOW
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO weewx.restx: WOW: Posting not enabled.
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.restx.StdWOW
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.restx.StdAWEKAS
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO weewx.restx: AWEKAS: Posting not enabled.
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.restx.StdAWEKAS
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.engine.StdPrint
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.engine.StdPrint
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Loading service weewx.engine.StdReport
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO weewx.engine: 'pyephem' not detected, extended almanac data is not available
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.engine: Finished loading service weewx.engine.StdReport
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO __main__: Starting up weewx version 4.8.0
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Gentle wake up of console successful
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO weewx.engine: Clock error is 1.41 seconds (positive is fast)
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO weewx.engine: Using binding 'wx_binding' to database 'weewx.sdb'
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.manager: Daily summary version is 4.0
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO weewx.manager: Starting backfill of daily summaries
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO weewx.manager: Daily summaries up to date
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Getting archive packets since 2022-06-17 08:00:00 PDT (1655478000)
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.manager: Daily summary version is 4.0
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.manager: Daily summary version is 4.0
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Gentle wake up of console successful
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Retrieving 0 page(s); starting index= 0
Jun 17 08:10:59 weewx-RPi weewx[83743] INFO weewx.engine: Starting main packet loop.
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Gentle wake up of console successful
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Requesting 200 LOOP packets.
Jun 17 08:10:59 weewx-RPi weewx[83743] DEBUG weewx.drivers.vantage: Gentle wake up of console successful
Jun 17 08:11:07 weewx-RPi weewx[83743] ERROR weewx.drivers.vantage: LOOP try #1; error: Expected to read 99 chars; got 0 instead
Jun 17 08:11:11 weewx-RPi weewx[83743] ERROR weewx.drivers.vantage: LOOP try #2; error: Expected to read 99 chars; got 0 instead
Jun 17 08:11:15 weewx-RPi weewx[83743] ERROR weewx.drivers.vantage: LOOP try #3; error: Expected to read 99 chars; got 0 instead
Jun 17 08:11:19 weewx-RPi weewx[83743] ERROR weewx.drivers.vantage: LOOP try #4; error: Expected to read 99 chars; got 0 instead
Jun 17 08:11:19 weewx-RPi weewx[83743] ERROR weewx.drivers.vantage: LOOP max tries (4) exceeded.
Jun 17 08:11:19 weewx-RPi weewx[83743] INFO weewx.engine: Main loop exiting. Shutting engine down.
Jun 17 08:11:19 weewx-RPi weewx[83743] DEBUG weewx.restx: Shut down CWOP thread.
Jun 17 08:11:19 weewx-RPi weewx[83743] DEBUG weewx.restx: Shut down PWSWeather thread.
Jun 17 08:11:19 weewx-RPi weewx[83743] DEBUG weewx.restx: Shut down Wunderground-PWS thread.
Jun 17 08:11:19 weewx-RPi weewx[83743] CRITICAL __main__: Caught WeeWxIOError: Max tries exceeded while getting LOOP data.
Jun 17 08:11:19 weewx-RPi weewx[83743] CRITICAL __main__:     ****  Waiting 60 seconds then retrying...

========

It's odd that I seem to get some reporting to CWOP and Weatherunderground, but still have this shut down issue.

[Tom Keffer]

This time, it is using hardware record generation. Did you change it? Also, the hardware archive interval is 1/2 hour, which may be longer than what you want / expect.

When downloading archive records from the logger, it is starting from page zero, index zero, which is usually indicative of an empty logger. What kind of logger is this? The standard one from Davis, or a 3rd party logger?

Try removing the logger, then reseating it.

You can also try resetting the logger. See the wiki section Corrupt station memory.

To view this discussion on the web visit https://groups.google.com/d/msgid/weewx-user/331ea29e-d6fa-4910-86e2-de0cdf584038n%40googlegroups.com.

[mup...@gmail.com]

I did change back to hardware record generation.

The hardware archive interval is being set for me.  Not sure how I'd change it, or what might be a better value.

This is the Davis logger and I did take your recommendation and re-seat it.

[Tom Keffer]

The default is 1800 seconds. To change it, either see the guide that came with the logger, or use the utility wee_device with the --set-interval option.

Did you try resetting the logger using the directions in the wiki section Corrupt station memory?

To view this discussion on the web visit https://groups.google.com/d/msgid/weewx-user/7b83e3a6-f38f-46db-88de-03789819efbfn%40googlegroups.com.

[mup...@gmail.com]

I used the wee_device utility and cleared the archive records.

Using the same utility, I've set the interval to 10 minutes.

tail command reports that archive memory has been cleared.  Now I wait ...

[Graham Eddy]

not the reported problem, but config error needs to be fixed nonetheless

[mup...@gmail.com]

Hello Graham,

Can you enlighten me just a bit more?  Where is the "config error"?

Thank you!

[Graham Eddy]

as tom noted, you need to configure the vp2 console device to 300 secs to get reports each 5 mins (or change weewx.conf file to 1800 secs if every 30 mins sufficient)

this would not cause the read errors on the vp2, so is off-topic, but worth pointing out.

cheers

[mup...@gmail.com]

I've changed to running on a RPi3 B.  It's back up and running, however, the LOOP error still exists.  After a time, however, I see that the system initializes and posts data again! 

NTP is running and keeping the time in sync, so I don't think it's a time issue.  To say I'm baffled, would be an understatement!