2015 Sep 06, 11:33 AM
(2015 Sep 05, 06:12 PM)dan Wrote: To give the SD card in the Raspberry Pi a long life the only log file SIP writes is the irrigation log. I don't know of a way to get output from the program when it starts from the init script.
If you can describe how your system is configured I will do the same here and look for the problem.
Hi dan!
The setup of system configured is all station in line I mean do not have a master pump.
I'm using relay board connected to my raspberry pi and the version installed of SIP is: 3.1.25 (2015-09-03).
There are not differences between the progam-1 and other programs except the time that is scheduled the execution.
I'm attaching a log output of console when I have the issue with program-1 failing (manual execution porgram-1 for one minute):
--- start log ---
pi@raspberrypi-:~/sip$ sudo sip.sh
sudo: sip.sh: command not found
pi@raspberrypi-:~/sip$ sudo python sip.py
Ignoring exception while loading the relay plug-in.
cannot import name pin_relay
Complementos cargados:
email_adj
mobile_app
monthly_adj
plugin_manager
proto
relay_board
signaling_examples
system_update
weather_adj
weather_level_adj
Comenzando tiempo de blucle
zones changed
[0, 0, 0, 0, 0, 0, 0, 0]
http://0.0.0.0:80/
Monthly Adjust: Setting water level to 90%
Email plugin is started
Checking weather status...
Checking rain status...
Good weather detected: Partly Cloudy. Removing rain delay.
Skipped wundergound data because of a parsing error for today
Using 7 days of information.
Water needed (7 days): 21.0mm
Total rainfall : 4.0mm
_______________________________-
Irrigation needed : 17.0mm
Weather Adjustment : 60.7%
192.168.1.128:57726 - - [06/Sep/2015 13:12:21] "HTTP/1.1 GET /" - 200 OK
192.168.1.128:57728 - - [06/Sep/2015 13:12:21] "HTTP/1.1 GET /" - 200 OK
192.168.1.128:57726 - - [06/Sep/2015 13:12:24] "HTTP/1.1 GET /static/themes/basic/base.css" - 200
192.168.1.128:57900 - - [06/Sep/2015 13:12:24] "HTTP/1.1 GET /static/scripts/jquery-1.8.2.min.js" - 200
192.168.1.128:57901 - - [06/Sep/2015 13:12:24] "HTTP/1.1 GET /static/scripts/behaviors.js" - 200
192.168.1.128:57902 - - [06/Sep/2015 13:12:24] "HTTP/1.1 GET /static/scripts/schedule.js" - 200
192.168.1.128:57903 - - [06/Sep/2015 13:12:24] "HTTP/1.1 GET /static/scripts/intervalSelect.js" - 200
192.168.1.128:57900 - - [06/Sep/2015 13:12:27] "HTTP/1.1 GET /static/themes/basic/logo.png" - 200
192.168.1.128:57726 - - [06/Sep/2015 13:12:27] "HTTP/1.1 GET /static/themes/basic/grass.jpg" - 200
192.168.1.128:57901 - - [06/Sep/2015 13:12:27] "HTTP/1.1 GET /static/themes/basic/on.png" - 200 192.168.1.128:57902 - - [06/Sep/2015 13:12:27] "HTTP/1.1 GET /static/themes/basic/home.png" - 200
Traceback (most recent call last):
File "/home/pi/sip/web/application.py", line 239, in process
return self.handle()
File "/home/pi/sip/web/application.py", line 229, in handle
fn, args = self._match(self.mapping, web.ctx.path)
File "/home/pi/sip/web/application.py", line 438, in _match
what, result = utils.re_subm('^' + pat + '$', what, value)
File "/home/pi/sip/web/utils.py", line 531, in re_subm
compiled_pat = re_compile(pat)
File "/home/pi/sip/web/utils.py", line 499, in __call__
update(block=True)
File "/home/pi/sip/web/utils.py", line 496, in update
self.running[key].release()
error: release unlocked lock
192.168.1.128:57904 - - [06/Sep/2015 13:12:28] "HTTP/1.1 GET /api/status" - 500 Internal Server Error
192.168.1.128:57903 - - [06/Sep/2015 13:12:29] "HTTP/1.1 GET /api/log" - 200 OK
192.168.1.128:57900 - - [06/Sep/2015 13:12:30] "HTTP/1.1 GET /static/themes/basic/whitestripes.png" - 200
192.168.1.128:57919 - - [06/Sep/2015 13:12:51] "HTTP/1.1 GET /vr" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:12:52] "HTTP/1.1 GET /api/log" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:12:59] "HTTP/1.1 GET /cr" - 303 See Other
zones changed
[1, 0, 0, 0, 0, 0, 0, 0]
192.168.1.128:57919 - - [06/Sep/2015 13:13:00] "HTTP/1.1 GET /" - 200 OK
192.168.1.128:57923 - - [06/Sep/2015 13:13:01] "HTTP/1.1 GET /static/themes/basic/off.png" - 200
192.168.1.128:57922 - - [06/Sep/2015 13:13:03] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:03] "HTTP/1.1 GET /api/log" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:04] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:06] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:08] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:10] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:11] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:13] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:15] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:16] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:18] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:20] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:22] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:23] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:25] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:27] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:28] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:30] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:32] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:34] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:35] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:37] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:39] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:40] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:42] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:44] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:45] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:47] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:49] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:51] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:52] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:54] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:56] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:13:57] "HTTP/1.1 GET /api/status" - 200 OK
zones changed
[0, 0, 0, 0, 0, 0, 0, 0]
zones changed
[0, 0, 0, 0, 0, 0, 0, 0]
192.168.1.128:57919 - - [06/Sep/2015 13:13:59] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:57919 - - [06/Sep/2015 13:14:00] "HTTP/1.1 GET /api/log" - 200 OK
--- end log ---
And this is the output log of sucessfull manual execution, 30seconds, after force command "sudo service sip stop" :
-- start log --
pi@raspberrypi-:~/sip$ sudo service sip stop
pi@raspberrypi-:~/sip$ sudo python sip.py
Ignoring exception while loading the relay plug-in.
cannot import name pin_relay
Complementos cargados:
email_adj
mobile_app
monthly_adj
plugin_manager
proto
relay_board
signaling_examples
system_update
weather_adj
weather_level_adj
Comenzando tiempo de blucle
zones changed
[0, 0, 0, 0, 0, 0, 0, 0]
http://0.0.0.0:80/
Monthly Adjust: Setting water level to 90%
Checking rain status...
Good weather detected: Partly Cloudy. Removing rain delay.
Checking weather status...
Email plugin is started
Skipped wundergound data because of a parsing error for today
Using 7 days of information.
Water needed (7 days): 21.0mm
Total rainfall : 4.0mm
_______________________________-
Irrigation needed : 17.0mm
Weather Adjustment : 60.7%
192.168.1.128:58081 - - [06/Sep/2015 13:29:07] "HTTP/1.1 GET /" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:07] "HTTP/1.1 GET /static/themes/basic/base.css" - 304 Not Modified
192.168.1.128:58086 - - [06/Sep/2015 13:29:07] "HTTP/1.1 GET /static/scripts/jquery-1.8.2.min.js" - 304 Not Modified
192.168.1.128:58087 - - [06/Sep/2015 13:29:08] "HTTP/1.1 GET /static/scripts/behaviors.js" - 304 Not Modified
192.168.1.128:58088 - - [06/Sep/2015 13:29:08] "HTTP/1.1 GET /static/scripts/schedule.js" - 304 Not Modified
192.168.1.128:58089 - - [06/Sep/2015 13:29:08] "HTTP/1.1 GET /static/scripts/intervalSelect.js" - 304 Not Modified
192.168.1.128:58086 - - [06/Sep/2015 13:29:08] "HTTP/1.1 GET /static/themes/basic/grass.jpg" - 304 Not Modified
192.168.1.128:58081 - - [06/Sep/2015 13:29:08] "HTTP/1.1 GET /static/themes/basic/logo.png" - 304 Not Modified
192.168.1.128:58087 - - [06/Sep/2015 13:29:08] "HTTP/1.1 GET /static/themes/basic/home.png" - 304 Not Modified192.168.1.128:58088 - - [06/Sep/2015 13:29:08] "HTTP/1.1 GET /static/themes/basic/on.png" - 304 Not Modified
192.168.1.128:58091 - - [06/Sep/2015 13:29:10] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58089 - - [06/Sep/2015 13:29:10] "HTTP/1.1 GET /api/log" - 200 OK
192.168.1.128:58089 - - [06/Sep/2015 13:29:10] "HTTP/1.1 GET /static/themes/basic/whitestripes.png" - 304 Not Modified
192.168.1.128:58081 - - [06/Sep/2015 13:29:10] "HTTP/1.1 GET /api/log" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:18] "HTTP/1.1 GET /vr" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:20] "HTTP/1.1 GET /api/log" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:27] "HTTP/1.1 GET /cr" - 303 See Other
zones changed
[1, 0, 0, 0, 0, 0, 0, 0]
192.168.1.128:58081 - - [06/Sep/2015 13:29:28] "HTTP/1.1 GET /" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:29] "HTTP/1.1 GET /api/log" - 200 OK
192.168.1.128:58099 - - [06/Sep/2015 13:29:29] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:30] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:31] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:32] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:33] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:35] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:36] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:37] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:39] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:40] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:41] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:42] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:43] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:45] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:46] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:47] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:48] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:50] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:51] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:52] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:53] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:54] "HTTP/1.1 GET /api/status" - 200 OK
zones changed
[0, 0, 0, 0, 0, 0, 0, 0]
zones changed
[0, 0, 0, 0, 0, 0, 0, 0]
192.168.1.128:58081 - - [06/Sep/2015 13:29:56] "HTTP/1.1 GET /api/status" - 200 OK
192.168.1.128:58081 - - [06/Sep/2015 13:29:56] "HTTP/1.1 GET /api/log" - 200 OK
--end log --
is there any way to see the output of script "sudo service sip stop" ?
thanks for your help!!