How can we help?


Watering on a restricted day

Comments

5 comments

  • Avatar
    RainMachine Support

    Hi, Atlantauser
    Indeed that won't supposed to happen on a restricted day. 
    It might be a mobile app bug that we have to investigate. Do you know if the program really started to water?

    Thank you,
    RainMachine Support

    0
    Comment actions Permalink
  • Avatar
    Atlantauser (Edited )

    Yes, and when i opened the app on my phone it was counting down from 24 hours... no idea what that was. When I stopped it, i could find no trace of it running or water history showing any watering today. it's really weird. I'm glad I caught it before it ran for more than 20 minutes or so.

    0
    Comment actions Permalink
  • Avatar
    RainMachine Support

    Oh, 24hours running time for a zone?
    What RainMachine mobile app are you using? iOS or Android and what type of mobile phone/tablet?
    Thank you,
    RainMachine Support

    0
    Comment actions Permalink
  • Avatar
    RainMachine Nicholas

    You will receive a notification if a program wanted to start but couldn't because of a restriction. The notification will also tell the reason. Are you positive that your sprinklers had actually run ?

     

    0
    Comment actions Permalink
  • Avatar
    Atlantauser

    Yes, I'm sure it was running the actual sprinklers. I looked at the log data and I believe it's because it was running with inaccurate time for quite a while. Log snippet below, but leading up to this it had TONS of errors about parsing data from NOAA and WUnderground.  Then all of a sudden it appears it figured out how to reset its time properly. I don't think it's working properly yet though. The about screen shows 100% CPU. I haven't logged into it on SSH yet to figure out what's consuming it.

     

     

    2018-08-15 06:33:05,003 - INFO  - noaa-parser:87 - Fetching Daily data from https://graphical.weather.gov/xml/sample_products/browser_interface/ndfdBrowserClientByDay.php 
    2018-08-15 06:37:45,001 - ERROR - rmParser:133 - *** Error in parser 'NOAA Parser' while downloading data from https://graphical.weather.gov/xml/sample_products/browser_interface/ndfdBrowserClientByDay.php?lat=33.9334244&lon=-84.3143956&startDate=2018-08-15&format=24+hourly&numDays=6&Unit=e, error: 
    2018-08-15 06:42:25,001 - ERROR - rmParser:133 - *** Error in parser 'WUnderground Parser' while downloading data from http://api.wunderground.com/api/15a58660a67a5603/geolookup/conditions/forecast10day/yesterday/q/pws:KGADUNWO10.json, error: 
    2018-08-15 06:42:25,003 - ERROR - rmParserManager:167 -   * Cannot execute parser WUnderground Parser
    2018-08-15 06:42:25,005 - ERROR - rmParserManager:168 - 'NoneType' object has no attribute 'read'
    Traceback (most recent call last):
      File "./RMParserFramework/rmParserManager.py", line 164, in run
      File "./RMParserFramework/rmParser.py", line 47, in timedPerform
      File "/rainmachine-app/RMParserFramework/parsers/wunderground-parser.py", line 77, in perform
        jsonContent = d.read()
    AttributeError: 'NoneType' object has no attribute 'read'
    2018-08-15 06:43:25,045 - INFO  - noaa-parser:83 - Fetching Hourly data from https://noaa.rainmachine.com/xml/sample_products/browser_interface/ndfdXMLclient.php
    2018-08-15 06:48:05,001 - ERROR - rmParser:133 - *** Error in parser 'NOAA Parser' while downloading data from https://noaa.rainmachine.com/xml/sample_products/browser_interface/ndfdXMLclient.php?lat=33.9334244&lon=-84.3143956&startDate=2018-08-15&format=24+hourly&numDays=6&Unit=e, error: 
    2018-08-15 06:48:05,003 - INFO  - noaa-parser:87 - Fetching Daily data from https://noaa.rainmachine.com/xml/sample_products/browser_interface/ndfdBrowserClientByDay.php 
    2018-08-15 06:52:45,001 - ERROR - rmParser:133 - *** Error in parser 'NOAA Parser' while downloading data from https://noaa.rainmachine.com/xml/sample_products/browser_interface/ndfdBrowserClientByDay.php?lat=33.9334244&lon=-84.3143956&startDate=2018-08-15&format=24+hourly&numDays=6&Unit=e, error: 
    2018-08-15 06:52:45,003 - INFO  - noaa-parser:83 - Fetching Hourly data from https://forecast.rainmachine.com/xml/sample_products/browser_interface/ndfdXMLclient.php
    2018-08-15 06:53:25,045 - ERROR - rmParser:27 - *** Timeout occurred while running a parser: Timer expired
    2018-08-15 06:53:25,048 - ERROR - rmParser:133 - *** Error in parser 'NOAA Parser' while downloading data from https://forecast.rainmachine.com/xml/sample_products/browser_interface/ndfdXMLclient.php?lat=33.9334244&lon=-84.3143956&startDate=2018-08-15&format=24+hourly&numDays=6&Unit=e&token=px808345forc, error: Timer expired
    2018-08-15 06:53:25,049 - INFO  - noaa-parser:87 - Fetching Daily data from https://forecast.rainmachine.com/xml/sample_products/browser_interface/ndfdBrowserClientByDay.php 
    2018-08-15 06:57:01,394 - WARNING - rmSimulator:319 - Data computed without forecast info. Nothing will be saved into simulator.allData table.
    2018-08-15 06:57:01,407 - INFO  - rmPrograms:743 - Automatic Cycles [{'zoneLinesData': [userPercentage:1, coef:1.0, flag:0, calc_wd:0, active:True, zid:1, duration:100, order:1, userPercentage:1, coef:1.0, flag:0, calc_wd:0, active:True, zid:2, duration:100, order:2, userPercentage:1, coef:1.0, flag:0, calc_wd:0, active:True, zid:3, duration:100, order:3, userPercentage:1, coef:1.0, flag:0, calc_wd:0, active:True, zid:4, duration:100, order:4], 'cycle': 0}]
    2018-08-15 06:57:01,412 - INFO  - rmProgramScheduler:184 - Zone 1 is not simulated won't carry available water
    2018-08-15 06:57:01,414 - INFO  - rmProgramScheduler:184 - Zone 2 is not simulated won't carry available water
    2018-08-15 06:57:01,416 - INFO  - rmProgramScheduler:184 - Zone 3 is not simulated won't carry available water
    2018-08-15 06:57:01,418 - INFO  - rmProgramScheduler:184 - Zone 4 is not simulated won't carry available water
    2018-08-15 06:57:01,421 - INFO  - rmProgramScheduler:242 - Program 1 added to watering queue and/or watering history
    2018-08-15 06:57:01,425 - INFO  - rmProgramSchedulerWatering:232 - Watering - starting zone: (uid=None, pid=1, zid=1, ust='2018-08-15 06:57:00', rst='2018-08-15 06:57:01', ud=100, md=100, rd=0, aw=0, flag=0, manual=False, running=True)
    2018-08-14 06:56:58,481 - INFO  - noaa-parser:83 - Fetching Hourly data from https://graphical.weather.gov/xml/sample_products/browser_interface/ndfdXMLclient.php
    2018-08-14 06:57:09,873 - INFO  - rmMixer:123 - *** DATA IN THE PAST: 2018-08-13 00:00:00
    2018-08-14 06:57:09,884 - INFO  - rmMixer:124 - *** Received data: ('2018-08-13 00:00:00', temp=28.600000000000001/1, minTemp=None/0, maxTemp=None/0, rh=71/1, minRh=None/0, maxRh=None/0, wind=0.17000000000000001/1, solarRad=None/0, skyCover=None/0, rain=0/1, et0=None/0, pop=None/0, qpf=None/0, condition=None/0, pressure=97.569999999999993/1, dewPoint=18.600000000000001/1, userData=None, minTemp=19.199999999999999/0, maxTemp=37.899999999999999/0, minRH=24/0, maxRH=71/0, et0cal=None, et0final=None)
    2018-08-14 07:19:20,928 - INFO  - rmProgramSchedulerWatering:272 - UpdateZone available water: 0
    2018-08-14 07:19:20,972 - INFO  - rmProgramSchedulerWatering:140 - Watering - zone finished: (uid=None, pid=1, zid=1, ust='2018-08-15 06:57:00', rst='2018-08-15 06:57:01', ud=100, md=100, rd=-85061, aw=0, flag=1, manual=False, running=False)
    2018-08-14 07:41:32,107 - INFO  - rmMainManager:216 - Upgrade checked.
    2018-08-14 08:16:36,550 - INFO  - rmMainManager:216 - Upgrade checked.
    2018-08-14 08:17:25,453 - INFO  - rmMainManager:216 - Upgrade checked.
    2018-08-14 08:19:09,860 - INFO  - rmMainManager:216 - Upgrade checked.
    2018-08-14 09:43:01,685 - INFO  - rmMainManager:216 - Upgrade checked.
    2018-08-14 09:52:55,884 - INFO  - rmMainManager:216 - Upgrade checked.
    2018-08-14 09:53:14,049 - INFO  - rmMainManager:216 - Upgrade checked.
    2018-08-14 09:54:04,174 - INFO  - rmMainManager:216 - Upgrade checked.
    2018-08-14 09:54:24,467 - INFO  - rmMainManager:216 - Upgrade checked.
    2018-08-15 10:34:53,140 - INFO  - rmMainManager:216 - Upgrade checked.
    ---------------------------- PROGRAM SIMULATION LOG -----------------------------
    2018-08-14 06:57:10,168 - INFO  - rmSimulator:254 - Skipping old day 1534132800 < 1534305600 from simulation.
    2018-08-14 06:57:10,173 - INFO  - rmSimulator:254 - Skipping old day 1534132800 < 1534305600 from simulation.
    2018-08-14 06:57:10,176 - INFO  - rmSimulator:254 - Skipping old day 1534219200 < 1534305600 from simulation.
    2018-08-14 06:57:10,187 - INFO  - rmSimulator:254 - Skipping old day 1534219200 < 1534305600 from simulation.
    2018-08-14 06:57:10,216 - INFO  - rmSimulator:354 - Correction for the past enabled. Program 1 will try to use AW from main db first.
    2018-08-14 06:57:10,338 - INFO  - rmSimulator:904 - Timestamp 1533960000 ForecastDay 1534305600
    2018-08-14 06:57:10,357 - INFO  - rmSimulator:907 - getting available water for program 1 from main db with value None
    2018-08-14 06:57:10,359 - INFO  - rmSimulator:908 -  > __getAvailableWater from wd_log: None
    2018-08-14 06:57:10,363 - INFO  - rmSimulator:912 - getting available water for program 1 from simulator db with value None
    2018-08-14 06:57:10,367 - INFO  - rmSimulator:916 - pid=1, zone 1: no AW record, defaulting to 0.0 for day 2018-08-11 00:00:00
    2018-08-14 06:57:10,375 - INFO  - rmSimulator:904 - Timestamp 1533960000 ForecastDay 1534305600
    2018-08-14 06:57:10,385 - INFO  - rmSimulator:907 - getting available water for program 1 from main db with value None
    2018-08-14 06:57:10,394 - INFO  - rmSimulator:908 -  > __getAvailableWater from wd_log: None
    2018-08-14 06:57:10,400 - INFO  - rmSimulator:912 - getting available water for program 1 from simulator db with value None
    2018-08-14 06:57:10,402 - INFO  - rmSimulator:916 - pid=1, zone 2: no AW record, defaulting to 0.0 for day 2018-08-11 00:00:00
    2018-08-14 06:57:10,405 - INFO  - rmSimulator:904 - Timestamp 1533960000 ForecastDay 1534305600
    2018-08-14 06:57:10,436 - INFO  - rmSimulator:907 - getting available water for program 1 from main db with value None
    2018-08-14 06:57:10,438 - INFO  - rmSimulator:908 -  > __getAvailableWater from wd_log: None
    2018-08-14 06:57:10,441 - INFO  - rmSimulator:912 - getting available water for program 1 from simulator db with value None
    2018-08-14 06:57:10,446 - INFO  - rmSimulator:916 - pid=1, zone 3: no AW record, defaulting to 0.0 for day 2018-08-11 00:00:00
    2018-08-14 06:57:10,453 - INFO  - rmSimulator:904 - Timestamp 1533960000 ForecastDay 1534305600
    2018-08-14 06:57:10,462 - INFO  - rmSimulator:907 - getting available water for program 1 from main db with value None
    2018-08-14 06:57:10,464 - INFO  - rmSimulator:908 -  > __getAvailableWater from wd_log: None
    2018-08-14 06:57:10,481 - INFO  - rmSimulator:912 - getting available water for program 1 from simulator db with value None
    2018-08-14 06:57:10,483 - INFO  - rmSimulator:916 - pid=1, zone 4: no AW record, defaulting to 0.0 for day 2018-08-11 00:00:00
    2018-08-14 06:57:10,485 - INFO  - rmSimulator:500 - 
    * Program Coefficients (pid=1, fake=False, ignoreInternetWeather=0, day=2018-08-15 00:00:00)
    	- pastStart=2018-08-11 00:00:00, futureEnd=2018-08-18 00:00:00, pastMultiplier=4, futureMultiplier=3
    	- qpfReal=0.00, qpfUsed=None, qpfEst=6.53, historyQpf=6.53, et0Real=23.85, et0Used=None, et0Est=14.54, historyEt0=14.54
    	- et0Avg=5.61 detailsReal=[et0(a)=5.61, qpf(i)=None], [et0(a)=5.61, qpf(i)=None], [et0(m)=7.19, qpf(i)=None], [et0(m)=5.44, qpf(m)=0.00], detailsHistory=[et0(m)=5.33, qpf(i)=None], [et0(m)=4.84, qpf(m)=1.53], [et0(m)=4.37, qpf(m)=5.00]
    	 zone  lastAW  newAW  chEt0  waterFF  corrPast  water%  waterNeeded  fielCap  cropCoef  zoneType  userDuration
    	    1    0.00   0.00  14.54     5.10     0.00   37.91      5.10       21.92      0.80       2        300.00
    	    2    0.00   0.00  14.54     5.10     0.00   37.91      5.10       21.92      0.80       2        300.00
    	    3    0.00   0.00  14.54     5.10     0.00   37.91      5.10       21.92      0.80       2        300.00
    	    4    0.00   0.00  14.54     8.01     0.00   47.61      8.01       95.98      1.00       7        300.00
    
    2018-08-14 06:57:10,582 - INFO  - rmSimulator:354 - Correction for the past enabled. Program 1 will try to use AW from main db
    0
    Comment actions Permalink

Please sign in to leave a comment.