wviewweather.com

loonsailor · Joined: 05 Feb 2006 Posts: 15

When my house takes a power hit, wview doesn't restart correctly. The daemons come up, but they don't read the station or generate graphics or report to wunderground. After a normal restart, things work properly.

My system includes a Vantage Pro, connected via a Lantronix ethernet interface.

Here is the messages log from a normal startup:

Dec 29 23:21:04 aparicio wviewd[5024]: <3527127073> : radlib: wviewd started as a daemon ...
Dec 29 23:21:04 aparicio wviewd[5024]: <3527127177> : wview 3.2.1 starting ...
Dec 29 23:21:04 aparicio wviewd[5024]: <3527127177> : station interface: ethernet ...
Dec 29 23:21:04 aparicio wviewd[5024]: <3527127177> : Rain Season Start Month set to 7
Dec 29 23:21:04 aparicio wviewd[5024]: <3527127178> : Rain Storm Start Trigger set to 0.05 in/hr
Dec 29 23:21:04 aparicio wviewd[5024]: <3527127178> : Rain Storm Stop Time set to 12 hours
Dec 29 23:21:04 aparicio wviewd[5024]: <3527127178> : station polling interval set to 15 seconds
Dec 29 23:21:04 aparicio wviewd[5024]: <3527127210> : -- Station Init Start --
Dec 29 23:21:04 aparicio wviewd[5024]: <3527127211> : ethernetInit: connecting to VP @ 192.168.198.202:3001 ...
Dec 29 23:21:04 aparicio wviewd[5024]: <3527127702> : Vantage Pro on 192.168.198.202:3001 opened ...
Dec 29 23:21:04 aparicio wviewd[5024]: <3527127703> : starting too close to the top-of-minute, waiting 1 secs before continuing
Dec 29 23:21:05 aparicio wviewsqld[5028]: <3527128071> : radlib: wviewsqld started as a daemon ...
Dec 29 23:21:05 aparicio wviewsqld[5028]: <3527128072> : SQLDB: basic US archiving enabled -
Dec 29 23:21:05 aparicio wviewsqld[5028]: <3527128072> : SQLDB: to localhost table wviewDB.archive
Dec 29 23:21:05 aparicio htmlgend[5031]: <3527128693> : radlib: htmlgend started as a daemon ...
Dec 29 23:21:05 aparicio htmlgend[5031]: <3527128754> : generating to /var/wview/img
Dec 29 23:21:06 aparicio wvcwopd[5035]: <3527128862> : radlib: wvcwopd started as a daemon ...
Dec 29 23:21:06 aparicio wvcwopd[5035]: <3527128933> : CWOP: configured to submit station CW1634 data to:
Dec 29 23:21:06 aparicio wvcwopd[5035]: <3527128933> : CWOP: Primary: socal.aprs2.net:23:23
Dec 29 23:21:06 aparicio wvcwopd[5035]: <3527128934> : CWOP: Secondary: arizona.aprs2.net:23
Dec 29 23:21:06 aparicio wvcwopd[5035]: <3527128934> : CWOP: Tertiary: indiana.aprs2.net:23
Dec 29 23:21:06 aparicio wvwunderd[5040]: <3527129078> : radlib: wvwunderd started as a daemon ...
Dec 29 23:21:06 aparicio wviewftpd[5043]: <3527129101> : radlib: wviewftpd started as a daemon ...
Dec 29 23:21:06 aparicio wvwunderd[5040]: <3527129135> : WUNDERGROUND: configured to submit station KCABERKE6 data to wunderground.com
Dec 29 23:21:06 aparicio wviewftpd[5043]: <3527129149> : FTP: INIT: 7 rules added
Dec 29 23:21:06 aparicio wviewd[5024]: <3527129156> : station archive interval: 10 minutes
Dec 29 23:21:06 aparicio wviewd[5024]: <3527129258> : running...
Dec 29 23:21:06 aparicio htmlgend[5031]: <3527129319> : running...

Here is a faulty startup, after a power hit:

Dec 22 01:33:24 aparicio wviewd[5087]: <2843867564> : radlib: wviewd started as a daemon ...
Dec 22 01:33:24 aparicio wviewd[5087]: <2843867674> : wview 3.2.1 starting ...
Dec 22 01:33:24 aparicio wviewd[5087]: <2843867675> : station interface: ethernet ...
Dec 22 01:33:24 aparicio wviewd[5087]: <2843867675> : Rain Season Start Month set to 7
Dec 22 01:33:24 aparicio wviewd[5087]: <2843867675> : Rain Storm Start Trigger set to 0.05 in/hr
Dec 22 01:33:24 aparicio wviewd[5087]: <2843867675> : Rain Storm Stop Time set to 12 hours
Dec 22 01:33:24 aparicio wviewd[5087]: <2843867676> : station polling interval set to 15 seconds
Dec 22 01:33:24 aparicio wviewd[5087]: <2843867708> : -- Station Init Start --
Dec 22 01:33:24 aparicio wviewd[5087]: <2843867708> : ethernetInit: connecting to VP @ 192.168.198.202:3001 ...
Dec 22 01:33:25 aparicio wviewsqld[5091]: <2843868527> : radlib: wviewsqld started as a daemon ...
Dec 22 01:33:25 aparicio wviewsqld[5091]: <2843868528> : SQLDB: basic US archiving enabled -
Dec 22 01:33:25 aparicio wviewsqld[5091]: <2843868529> : SQLDB: to localhost table wviewDB.archive
Dec 22 01:33:25 aparicio htmlgend[5094]: <2843868774> : radlib: htmlgend started as a daemon ...
Dec 22 01:33:26 aparicio htmlgend[5094]: <2843868871> : generating to /var/wview/img
Dec 22 01:33:26 aparicio wvcwopd[5098]: <2843868952> : radlib: wvcwopd started as a daemon ...
Dec 22 01:33:26 aparicio wvcwopd[5098]: <2843868963> : CWOP: configured to submit station CW1634 data to:
Dec 22 01:33:26 aparicio wvcwopd[5098]: <2843868963> : CWOP: Primary: socal.aprs2.net:23:23
Dec 22 01:33:26 aparicio wvcwopd[5098]: <2843868963> : CWOP: Secondary: arizona.aprs2.net:23
Dec 22 01:33:26 aparicio wvcwopd[5098]: <2843868964> : CWOP: Tertiary: indiana.aprs2.net:23
Dec 22 01:33:26 aparicio wvwunderd[5101]: <2843869102> : radlib: wvwunderd started as a daemon ...
Dec 22 01:33:26 aparicio wvwunderd[5101]: <2843869144> : WUNDERGROUND: configured to submit station KCABERKE6 data to wunderground.com
Dec 22 01:33:26 aparicio wviewftpd[5104]: <2843869200> : radlib: wviewftpd started as a daemon ...
Dec 22 01:33:26 aparicio wviewftpd[5104]: <2843869243> : FTP: INIT: 7 rules added
Dec 22 01:33:26 aparicio htmlgend[5094]: <2843869404> : running...

As you can see, the VantagePro is never connected (the line after the ethernetInit). Also, I never get the message that wviewd is "running".

In looking at the source code, I don't see how this can happen. Both of those lines are generated by the stationInit function. My guess is that perhaps the lantronix is taking a long time to initialize when power comes back up (longer than the unix takes to boot?), but I still don't see how this happens, since the socket seems to be successfully opened as indicated by the lack of error messages. It's hard to simulate, since my wife would be pretty unhappy about my power cycling the house, and moving things to the same room is a bit of a pain as well.

Any suggestions?

Thanks in advance for any help.