Script fails after upgrade from 0.8.6f to 0.8.6g
Moderators: Developers, Moderators
Script fails after upgrade from 0.8.6f to 0.8.6g
I use a script that generates a number of variables. The script has been working fine under 0.8.6f. After upgrade to 0.8.6g i get an error:
Result from CMD not valid. Partial Result:
Here is my log output from 0.8.6f :
10/04/2005 01:50:04 PM - CMDPHP: Poller[0] Host[0] DS[60] CMD: /etc/cacti/rttMonLatestJitterOper.pl public 192.168.58.4,
output: MinPosSD:1 MaxPosSD:3 AvgPosSD:1 MinNegSD:1 MaxNegSD:3 AvgNegSD:1 MinPosDS:1 MaxPosDS:2 AvgPosDS:1 MinNegDS:1
MaxNegDS:3 AvgNegDS:1 LossSD:0 LossDS:0 OoS:0 MiA:0 OWMinSD:17 OWMaxSD:21 OWAvgSD:18 OWMinDS:16 OWMaxDS:19 OWAvgDS:18
-And here's the output after upgrade to 0.8.6g:
10/04/2005 03:25:03 PM - CMDPHP: Poller[0] Host[0] DS[60] WARNING: Result from CMD not valid. Partial Result:
10/04/2005 03:25:03 PM - CMDPHP: Poller[0] Host[0] DS[60] CMD: /etc/cacti/rttMonLatestJitterOper.pl public 192.168.58.4,
output: U
When running the script manually as user "cactiuser" i get the expected result:
[cactiuser@goofy ~]$ /etc/cacti/rttMonLatestJitterOper.pl public 192.168.58.4
MinPosSD:1 MaxPosSD:22 AvgPosSD:1 MinNegSD:1 MaxNegSD:14 AvgNegSD:1 MinPosDS:1 MaxPosDS:175 AvgPosDS:3 MinNegDS:1
MaxNegDS:22 AvgNegDS:4 LossSD:0 LossDS:0 OoS:0 MiA:0 OWMinSD:16 OWMaxSD:39 OWAvgSD:17 OWMinDS:17 OWMaxDS:309 OWAvgDS:39
Here's cactiuser's crontab:
0,5,10,15,20,25,30,35,40,45,50,55 * * * *
php /var/www/html/cacti/poller.php > /dev/null 2>&1
I don't quite know where to go from here. Is it possible to narrow down what happens during script execution. Logging level is set to debug.
Thanks in advance..
Result from CMD not valid. Partial Result:
Here is my log output from 0.8.6f :
10/04/2005 01:50:04 PM - CMDPHP: Poller[0] Host[0] DS[60] CMD: /etc/cacti/rttMonLatestJitterOper.pl public 192.168.58.4,
output: MinPosSD:1 MaxPosSD:3 AvgPosSD:1 MinNegSD:1 MaxNegSD:3 AvgNegSD:1 MinPosDS:1 MaxPosDS:2 AvgPosDS:1 MinNegDS:1
MaxNegDS:3 AvgNegDS:1 LossSD:0 LossDS:0 OoS:0 MiA:0 OWMinSD:17 OWMaxSD:21 OWAvgSD:18 OWMinDS:16 OWMaxDS:19 OWAvgDS:18
-And here's the output after upgrade to 0.8.6g:
10/04/2005 03:25:03 PM - CMDPHP: Poller[0] Host[0] DS[60] WARNING: Result from CMD not valid. Partial Result:
10/04/2005 03:25:03 PM - CMDPHP: Poller[0] Host[0] DS[60] CMD: /etc/cacti/rttMonLatestJitterOper.pl public 192.168.58.4,
output: U
When running the script manually as user "cactiuser" i get the expected result:
[cactiuser@goofy ~]$ /etc/cacti/rttMonLatestJitterOper.pl public 192.168.58.4
MinPosSD:1 MaxPosSD:22 AvgPosSD:1 MinNegSD:1 MaxNegSD:14 AvgNegSD:1 MinPosDS:1 MaxPosDS:175 AvgPosDS:3 MinNegDS:1
MaxNegDS:22 AvgNegDS:4 LossSD:0 LossDS:0 OoS:0 MiA:0 OWMinSD:16 OWMaxSD:39 OWAvgSD:17 OWMinDS:17 OWMaxDS:309 OWAvgDS:39
Here's cactiuser's crontab:
0,5,10,15,20,25,30,35,40,45,50,55 * * * *
php /var/www/html/cacti/poller.php > /dev/null 2>&1
I don't quite know where to go from here. Is it possible to narrow down what happens during script execution. Logging level is set to debug.
Thanks in advance..
- gandalf
- Developer
- Posts: 22383
- Joined: Thu Dec 02, 2004 2:46 am
- Location: Muenster, Germany
- Contact:
It seems to be a perl script that fails. Does this occur to all perl scripts? What about changing the Data Input Method to contain "/usr/bin/perl < your command>" instead of "<your command>" (if perl is installed in /usr/bin/perl of course)? You will have to "Clear Poller Cache" afterwards.
Reinhard
Reinhard
I tried to add the path to perl, but i get the same result:
10/04/2005 07:55:03 PM - CMDPHP: Poller[0] Host[0] DS[60] CMD: /usr/bin/perl /etc/cacti/rttMonLatestJitterOper.pl public 192.168.58.4, output: U
All other scripts (included with cacti) work just fine. My script differs in being home-made and being located in /etc/cacti/ whereas other scripts are located in cacti-dir/scripts.
First i suspected a permission problem, but my cactiuser executes the script manually just fine?!?
/peter
10/04/2005 07:55:03 PM - CMDPHP: Poller[0] Host[0] DS[60] CMD: /usr/bin/perl /etc/cacti/rttMonLatestJitterOper.pl public 192.168.58.4, output: U
All other scripts (included with cacti) work just fine. My script differs in being home-made and being located in /etc/cacti/ whereas other scripts are located in cacti-dir/scripts.
First i suspected a permission problem, but my cactiuser executes the script manually just fine?!?
/peter
I moved the script to cacti-dir/scripts/ - checked permissions again.. Same result: output: U
Anybody who can point me in some direction?
Is it possible to further debug the actual output from the script when run under the Script Server. According to documentation this should be possible, but when I try the Script_Server.php "dies" with:
WARNING: Function does not exist
ERROR: Input Expected, Script Server Terminating
- And no further info!!?
Any input is appreciated
/peter
Anybody who can point me in some direction?
Is it possible to further debug the actual output from the script when run under the Script Server. According to documentation this should be possible, but when I try the Script_Server.php "dies" with:
WARNING: Function does not exist
ERROR: Input Expected, Script Server Terminating
- And no further info!!?
Any input is appreciated
/peter
- TheWitness
- Developer
- Posts: 17007
- Joined: Tue May 14, 2002 5:08 pm
- Location: MI, USA
- Contact:
How long does this script take to run? Run one poll in DEBUG using the following arguments:
"php <path_cacti>/cmd.php <host_id> <host_id>"
Where host_id is a host utilizing this script. Then post your STDOUT and Cacti log of that polling cycle.
TheWitness
"php <path_cacti>/cmd.php <host_id> <host_id>"
Where host_id is a host utilizing this script. Then post your STDOUT and Cacti log of that polling cycle.
TheWitness
True understanding begins only when we realize how little we truly understand...
Life is an adventure, let yours begin with Cacti!
Author of dozens of Cacti plugins and customization's. Advocate of LAMP, MariaDB, IBM Spectrum LSF and the world of batch. Creator of IBM Spectrum RTM, author of quite a bit of unpublished work and most of Cacti's bugs.
_________________
Official Cacti Documentation
GitHub Repository with Supported Plugins
Percona Device Packages (no support)
Interesting Device Packages
For those wondering, I'm still here, but lost in the shadows. Yearning for less bugs. Who want's a Cacti 1.3/2.0? Streams anyone?
Life is an adventure, let yours begin with Cacti!
Author of dozens of Cacti plugins and customization's. Advocate of LAMP, MariaDB, IBM Spectrum LSF and the world of batch. Creator of IBM Spectrum RTM, author of quite a bit of unpublished work and most of Cacti's bugs.
_________________
Official Cacti Documentation
GitHub Repository with Supported Plugins
Percona Device Packages (no support)
Interesting Device Packages
For those wondering, I'm still here, but lost in the shadows. Yearning for less bugs. Who want's a Cacti 1.3/2.0? Streams anyone?
Hi,
Done ! ... this also produces the expected output. See below:
(fyi. The script is renamed to 'saa_collector.pl')
-->STDOUT:
[cactiuser@goofy root]$ php /var/www/html/cacti/cmd.php 0 0
PHP Warning: Module 'mysql' already loaded in Unknown on line 0
[cactiuser@goofy root]$
-->And the Cacti log output:
10/05/2005 03:49:03 PM - PHPSVR: Poller[0] DEBUG: SERVER: cmd
10/05/2005 03:49:03 PM - PHPSVR: Poller[0] DEBUG: GETCWD: /root
10/05/2005 03:49:03 PM - PHPSVR: Poller[0] DEBUG: DIRNAM: /var/www/html/cacti
10/05/2005 03:49:03 PM - PHPSVR: Poller[0] DEBUG: FILENM: /var/www/html/cacti/script_server.php
10/05/2005 03:49:03 PM - PHPSVR: Poller[0] PHP Script Server has Started - Parent is cmd
10/05/2005 03:49:03 PM - CMDPHP: Poller[0] PHP Script Server Started Properly
10/05/2005 03:49:04 PM - CMDPHP: Poller[0] Host[0] DS[60] CMD: perl /var/www/html/cacti/scripts/saa_collector.pl public 192.168.58.4, output: MinPosSD:1 MaxPosSD:3 AvgPosSD:1 MinNegSD:1 MaxNegSD:2 AvgNegSD:1 MinPosDS:1 MaxPosDS:10 AvgPosDS:1 MinNegDS:1 MaxNegDS:9 AvgNegDS:1 LossSD:0 LossDS:0 OoS:0 MiA:0 OWMinSD:14 OWMaxSD:19 OWAvgSD:16 OWMinDS:17 OWMaxDS:27 OWAvgDS:20
10/05/2005 03:49:04 PM - PHPSVR: Poller[0] DEBUG: PHP Script Server Shutdown request received, exiting
10/05/2005 03:49:05 PM - CMDPHP: Poller[0] Time: 1.6519 s, Theads: N/A, Hosts: 0
Thanks,
Peter
Done ! ... this also produces the expected output. See below:
(fyi. The script is renamed to 'saa_collector.pl')
-->STDOUT:
[cactiuser@goofy root]$ php /var/www/html/cacti/cmd.php 0 0
PHP Warning: Module 'mysql' already loaded in Unknown on line 0
[cactiuser@goofy root]$
-->And the Cacti log output:
10/05/2005 03:49:03 PM - PHPSVR: Poller[0] DEBUG: SERVER: cmd
10/05/2005 03:49:03 PM - PHPSVR: Poller[0] DEBUG: GETCWD: /root
10/05/2005 03:49:03 PM - PHPSVR: Poller[0] DEBUG: DIRNAM: /var/www/html/cacti
10/05/2005 03:49:03 PM - PHPSVR: Poller[0] DEBUG: FILENM: /var/www/html/cacti/script_server.php
10/05/2005 03:49:03 PM - PHPSVR: Poller[0] PHP Script Server has Started - Parent is cmd
10/05/2005 03:49:03 PM - CMDPHP: Poller[0] PHP Script Server Started Properly
10/05/2005 03:49:04 PM - CMDPHP: Poller[0] Host[0] DS[60] CMD: perl /var/www/html/cacti/scripts/saa_collector.pl public 192.168.58.4, output: MinPosSD:1 MaxPosSD:3 AvgPosSD:1 MinNegSD:1 MaxNegSD:2 AvgNegSD:1 MinPosDS:1 MaxPosDS:10 AvgPosDS:1 MinNegDS:1 MaxNegDS:9 AvgNegDS:1 LossSD:0 LossDS:0 OoS:0 MiA:0 OWMinSD:14 OWMaxSD:19 OWAvgSD:16 OWMinDS:17 OWMaxDS:27 OWAvgDS:20
10/05/2005 03:49:04 PM - PHPSVR: Poller[0] DEBUG: PHP Script Server Shutdown request received, exiting
10/05/2005 03:49:05 PM - CMDPHP: Poller[0] Time: 1.6519 s, Theads: N/A, Hosts: 0
Thanks,
Peter
- TheWitness
- Developer
- Posts: 17007
- Joined: Tue May 14, 2002 5:08 pm
- Location: MI, USA
- Contact:
It looks like "mysql.so" is included twice in your php.ini file. Remove that and I would bet your problem will correct itself.
TheWitness
TheWitness
PHP Warning: Module 'mysql' already loaded in Unknown on line 0
True understanding begins only when we realize how little we truly understand...
Life is an adventure, let yours begin with Cacti!
Author of dozens of Cacti plugins and customization's. Advocate of LAMP, MariaDB, IBM Spectrum LSF and the world of batch. Creator of IBM Spectrum RTM, author of quite a bit of unpublished work and most of Cacti's bugs.
_________________
Official Cacti Documentation
GitHub Repository with Supported Plugins
Percona Device Packages (no support)
Interesting Device Packages
For those wondering, I'm still here, but lost in the shadows. Yearning for less bugs. Who want's a Cacti 1.3/2.0? Streams anyone?
Life is an adventure, let yours begin with Cacti!
Author of dozens of Cacti plugins and customization's. Advocate of LAMP, MariaDB, IBM Spectrum LSF and the world of batch. Creator of IBM Spectrum RTM, author of quite a bit of unpublished work and most of Cacti's bugs.
_________________
Official Cacti Documentation
GitHub Repository with Supported Plugins
Percona Device Packages (no support)
Interesting Device Packages
For those wondering, I'm still here, but lost in the shadows. Yearning for less bugs. Who want's a Cacti 1.3/2.0? Streams anyone?
I removed the loading of mysql.so from php.ini. Apparently it gets loaded somewhere else.
Then I did a new test - I still get the right output from the script when it's run via 'php cmd.php 0 0'.
But I see a interesting behaviour now... The scheduled 5 min runs still don't work, but if I do the manual 'php cmd.php 0 0' then the next scheduled run "sees" the script output?!?, but the next and the following fails. So the 'php cmd.php 0 0' somehow influences on the next scheduled run. Below is the output from the manual command. Further down I've included cacti.log output from scheduled run which includes the script data. As I pointed out this only occurs after the manual intervention.
I am able to reproduce this scenario.
--> STDOUT
[cactiuser@goofy cacti]$ php cmd.php 0 0
[cactiuser@goofy cacti]$
--> CACTI.LOG - Manual
10/06/2005 09:06:49 AM - PHPSVR: Poller[0] DEBUG: SERVER: cmd
10/06/2005 09:06:49 AM - PHPSVR: Poller[0] DEBUG: GETCWD: /var/www/html/cacti
10/06/2005 09:06:49 AM - PHPSVR: Poller[0] DEBUG: DIRNAM: /var/www/html/cacti
10/06/2005 09:06:49 AM - PHPSVR: Poller[0] DEBUG: FILENM: /var/www/html/cacti/script_server.php
10/06/2005 09:06:49 AM - PHPSVR: Poller[0] PHP Script Server has Started - Parent is cmd
10/06/2005 09:06:49 AM - CMDPHP: Poller[0] PHP Script Server Started Properly
10/06/2005 09:06:50 AM - CMDPHP: Poller[0] Host[0] DS[60] CMD: perl /var/www/html/cacti/scripts/saa_collector.pl public 192.168.58.4, output: MinPosSD:1 MaxPosSD:58 AvgPosSD:1 MinNegSD:1 MaxNegSD:15 AvgNegSD:1 MinPosDS:1 MaxPosDS:7 AvgPosDS:1 MinNegDS:1 MaxNegDS:4 AvgNegDS:1 LossSD:0 LossDS:0 OoS:0 MiA:0 OWMinSD:16 OWMaxSD:75 OWAvgSD:18 OWMinDS:16 OWMaxDS:24 OWAvgDS:18
10/06/2005 09:06:50 AM - PHPSVR: Poller[0] DEBUG: PHP Script Server Shutdown request received, exiting
10/06/2005 09:06:50 AM - CMDPHP: Poller[0] Time: 1.8982 s, Theads: N/A, Hosts: 0
-->Scheduled run - after manually running 'php cmd.php 0 0'
10/06/2005 09:45:02 AM - POLLER: Poller[0] DEBUG: About to Spawn a Remote Process [CMD: /usr/bin/php, ARGS: -q /var/www/html/cacti/cmd.php 0 20]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'MinPosSD:1' [map MinPosSD->MinPosSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'MaxPosSD:9' [map MaxPosSD->MaxPosSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'AvgPosSD:1' [map AvgPosSD->AvgPosSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'MinNegSD:1' [map MinNegSD->MinNegSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'MaxNegSD:9' [map MaxNegSD->MaxNegSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'AvgNegSD:1' [map AvgNegSD->AvgNegSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'MinPosDS:1' [map MinPosDS->MinPosDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'MaxPosDS:2' [map MaxPosDS->MaxPosDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'AvgPosDS:1' [map AvgPosDS->AvgPosDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'MinNegDS:1' [map MinNegDS->MinNegDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'MaxNegDS:3' [map MaxNegDS->MaxNegDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'AvgNegDS:1' [map AvgNegDS->AvgNegDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'LossSD:0' [map LossSD->LossSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'LossDS:0' [map LossDS->LossDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'OoS:0' [map OoS->OoS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'MiA:0' [map MiA->MiA]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'OWMinSD:17' [map OWMinSD->OWMinSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'OWMaxSD:27' [map OWMaxSD->OWMaxSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'OWAvgSD:19' [map OWAvgSD->OWAvgSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'OWMinDS:14' [map OWMinDS->OWMinDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'OWMaxDS:20' [map OWMaxDS->OWMaxDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'OWAvgDS:17' [map OWAvgDS->OWAvgDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/owminds_60.rrd --template MinPosSD:MaxPosSD:AvgPosSD:MinNegSD:MaxNegSD:AvgNegSD:MinPosDS:MaxPosDS:AvgPosDS:MinNegDS:MaxNegDS:AvgNegDS:LossSD:LossDS:OoS:MiA:OWMinSD:OWMaxSD:OWAvgSD:OWMinDS:OWMaxDS:OWAvgDS 1128584486:1:9:1:1:9:1:1:2:1:1:3:1:0:0:0:0:17:27:19:14:20:17
10/06/2005 09:45:03 AM - PHPSVR: Poller[0] DEBUG: SERVER: cmd
10/06/2005 09:45:03 AM - PHPSVR: Poller[0] DEBUG: GETCWD: /home/cactiuser
10/06/2005 09:45:03 AM - PHPSVR: Poller[0] DEBUG: DIRNAM: /var/www/html/cacti
10/06/2005 09:45:03 AM - PHPSVR: Poller[0] DEBUG: FILENM: /var/www/html/cacti/script_server.php
10/06/2005 09:45:03 AM - PHPSVR: Poller[0] PHP Script Server has Started - Parent is cmd10/06/2005 09:45:03 AM - CMDPHP: Poller[0] PHP Script Server Started Properly
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[0] DS[60] WARNING: Result from CMD not valid. Partial Result:
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[0] DS[60] CMD: perl /var/www/html/cacti/scripts/saa_collector.pl public 192.168.58.4, output: U
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[1] SNMP: Device does not require SNMP
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[1] No host availability check possible for '127.0.0.1'.
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[1] DS[3] CMD: perl /var/www/html/cacti/scripts/linux_memory.pl MemFree:, output: 820884
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[1] DS[4] CMD: perl /var/www/html/cacti/scripts/linux_memory.pl SwapFree:, output: 2031608
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[1] DS[5] CMD: perl /var/www/html/cacti/scripts/loadavg_multi.pl, output: 1min:0.00 5min:0.02 10min:0.01
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[1] DS[6] CMD: perl /var/www/html/cacti/scripts/unix_users.pl, output: 2
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[1] DS[7] CMD: perl /var/www/html/cacti/scripts/unix_processes.pl, output: 81
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[5] SNMP: Host responded to SNMP
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[5] RECACHE: Processing 1 items in the auto reindex cache for '192.168.2.1'.
10/06/2005 09:45:04 AM - POLLER: Poller[0] Parsed MULTI output field '1min:0.00' [map 1min->load_1min]
10/06/2005 09:45:04 AM - POLLER: Poller[0] Parsed MULTI output field '5min:0.02' [map 5min->load_5min]
10/06/2005 09:45:04 AM - POLLER: Poller[0] Parsed MULTI output field '10min:0.01' [map 10min->load_15min]
10/06/2005 09:45:04 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/owminds_60.rrd --template 1128584702:U
10/06/2005 09:45:04 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/localhost_mem_buffers_3.rrd --template mem_buffers 1128584702:820884
10/06/2005 09:45:04 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/localhost_mem_swap_4.rrd --template mem_swap 1128584702:2031608
10/06/2005 09:45:04 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/localhost_load_1min_5.rrd --template load_1min:load_5min:load_15min 1128584702:0.00:0.02:0.01
10/06/2005 09:45:04 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/localhost_users_6.rrd --template users 1128584702:2
10/06/2005 09:45:04 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/localhost_proc_7.rrd --template proc 1128584702:81
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[5] DS[14] SNMP: v1: 192.168.2.1, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.1, output: 2929553558
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[5] DS[14] SNMP: v1: 192.168.2.1, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.1, output: 3113569275
10/06/2005 09:45:05 AM - CMDPHP: Poller[0] Host[5] DS[15] SNMP: v1: 192.168.2.1, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.2, output: 35606930
10/06/2005 09:45:05 AM - CMDPHP: Poller[0] Host[5] DS[15] SNMP: v1: 192.168.2.1, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.2, output: 510636017
10/06/2005 09:45:05 AM - CMDPHP: Poller[0] Host[6] SNMP: Host responded to SNMP
10/06/2005 09:45:05 AM - CMDPHP: Poller[0] Host[6] RECACHE: Processing 1 items in the auto reindex cache for '192.168.2.2'.
10/06/2005 09:45:05 AM - CMDPHP: Poller[0] Host[6] DS[16] SNMP: v1: 192.168.2.2, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.1, output: 2419872627
10/06/2005 09:45:05 AM - CMDPHP: Poller[0] Host[6] DS[16] SNMP: v1: 192.168.2.2, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.1, output: 1262478772
10/06/2005 09:45:05 AM - CMDPHP: Poller[0] Host[6] DS[17] SNMP: v1: 192.168.2.2, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.2, output: 360243287
10/06/2005 09:45:05 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/ap_1200_oest_traffic_in_16.rrd --template traffic_in:traffic_out 1128584702:2419872627:1262478772
10/06/2005 09:45:05 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/pix_oest_traffic_in_15.rrd --template traffic_out:traffic_in 1128584702:510636017:35606930
10/06/2005 09:45:05 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/pix_oest_traffic_in_14.rrd --template traffic_in:traffic_out 1128584702:3113569275:2929553558
10/06/2005 09:45:05 AM - CMDPHP: Poller[0] Host[6] DS[17] SNMP: v1: 192.168.2.2, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.2, output: 3711755799
10/06/2005 09:45:05 AM - CMDPHP: Poller[0] Host[14] SNMP: Host responded to SNMP
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[14] RECACHE: Processing 1 items in the auto reindex cache for '192.168.2.3'.
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[14] DS[63] SNMP: v1: 192.168.2.3, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.1, output: 3516806304
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[14] DS[63] SNMP: v1: 192.168.2.3, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.1, output: 3510398213
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[15] SNMP: Host responded to SNMP
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[15] RECACHE: Processing 1 items in the auto reindex cache for '192.168.58.4'.
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[15] DS[64] SNMP: v1: 192.168.58.4, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.4, output: 4227773028
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[15] DS[64] SNMP: v1: 192.168.58.4, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.4, output: 4221417612
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[16] SNMP: Host responded to SNMP
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[16] RECACHE: Processing 1 items in the auto reindex cache for '192.168.58.1'.
10/06/2005 09:45:06 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/c1720_rtr_master_traffic_in_64.rrd --template traffic_in:traffic_out 1128584702:4221417612:4227773028
10/06/2005 09:45:06 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/c1720_rtr_responder_traffic_in_63.rrd --template traffic_out:traffic_in 1128584702:3516806304:3510398213
10/06/2005 09:45:06 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/ap_1200_oest_traffic_in_17.rrd --template traffic_out:traffic_in 1128584702:3711755799:360243287
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[16] DS[65] SNMP: v1: 192.168.58.1, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.1, output: 861861148
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[16] DS[65] SNMP: v1: 192.168.58.1, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.1, output: 923686839
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[16] DS[66] SNMP: v1: 192.168.58.1, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.2, output: 762957392
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[16] DS[66] SNMP: v1: 192.168.58.1, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.2, output: 684238087
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[20] SNMP: Host responded to SNMP
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[20] RECACHE: Processing 1 items in the auto reindex cache for '192.168.58.3'.
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[20] DS[96] SNMP: v1: 192.168.58.3, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.1, output: 1661309272
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[20] DS[96] SNMP: v1: 192.168.58.3, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.1, output: 3043682355
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[20] DS[97] SNMP: v1: 192.168.58.3, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.3, output: 1903316336
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[20] DS[97] SNMP: v1: 192.168.58.3, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.3, output: 1112701593
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[20] DS[98] SNMP: v1: 192.168.58.3, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.5, output: 526868053
10/06/2005 09:45:07 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/catalyst_3550_traffic_in_97.rrd --template traffic_out:traffic_in 1128584702:1903316336:1112701593
10/06/2005 09:45:07 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/catalyst_3550_traffic_in_96.rrd --template traffic_in:traffic_out 1128584702:3043682355:1661309272
10/06/2005 09:45:07 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/pix501_traffic_in_66.rrd --template traffic_out:traffic_in 1128584702:762957392:684238087
10/06/2005 09:45:07 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/pix501_traffic_in_65.rrd --template traffic_in:traffic_out 1128584702:923686839:861861148
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[20] DS[98] SNMP: v1: 192.168.58.3, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.5, output: 3839857369
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[20] DS[99] SNMP: v1: 192.168.58.3, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.7, output: 171296861
10/06/2005 09:45:08 AM - CMDPHP: Poller[0] Host[20] DS[99] SNMP: v1: 192.168.58.3, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.7, output: 92933258
10/06/2005 09:45:08 AM - CMDPHP: Poller[0] Host[20] DS[100] SNMP: v1: 192.168.58.3, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.24, output: 1943212332
10/06/2005 09:45:08 AM - CMDPHP: Poller[0] Host[20] DS[100] SNMP: v1: 192.168.58.3, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.24, output: 1943553631
10/06/2005 09:45:08 AM - PHPSVR: Poller[0] DEBUG: PHP Script Server Shutdown request received, exiting
10/06/2005 09:45:08 AM - CMDPHP: Poller[0] Time: 5.1210 s, Theads: N/A, Hosts: 7
10/06/2005 09:45:08 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/catalyst_3550_traffic_in_100.rrd --template traffic_out:traffic_in 1128584702:1943212332:1943553631
10/06/2005 09:45:08 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/catalyst_3550_traffic_in_99.rrd --template traffic_in:traffic_out 1128584702:92933258:171296861
10/06/2005 09:45:08 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/catalyst_3550_traffic_in_98.rrd --template traffic_in:traffic_out 1128584702:3839857369:526868053
10/06/2005 09:45:08 AM - SYSTEM STATS: Time:6.2308 Method:cmd.php Processes:1 Threads:N/A Hosts:8 HostsPerProcess:8 DataSources:32 RRDsProcessed:20
10/06/2005 09:45:08 AM - POLLER: Poller[0] DEBUG: About to Spawn a Remote Process [CMD: /usr/bin/php, ARGS: -q /var/www/html/cacti/poller_commands.php]
10/06/2005 09:45:08 AM - POLLER: Poller[0] DEBUG: About to Spawn a Remote Process [CMD: /usr/bin/php, ARGS: -q /var/www/html/cacti/poller_export.php]
Thanks,
/peter
Then I did a new test - I still get the right output from the script when it's run via 'php cmd.php 0 0'.
But I see a interesting behaviour now... The scheduled 5 min runs still don't work, but if I do the manual 'php cmd.php 0 0' then the next scheduled run "sees" the script output?!?, but the next and the following fails. So the 'php cmd.php 0 0' somehow influences on the next scheduled run. Below is the output from the manual command. Further down I've included cacti.log output from scheduled run which includes the script data. As I pointed out this only occurs after the manual intervention.
I am able to reproduce this scenario.
--> STDOUT
[cactiuser@goofy cacti]$ php cmd.php 0 0
[cactiuser@goofy cacti]$
--> CACTI.LOG - Manual
10/06/2005 09:06:49 AM - PHPSVR: Poller[0] DEBUG: SERVER: cmd
10/06/2005 09:06:49 AM - PHPSVR: Poller[0] DEBUG: GETCWD: /var/www/html/cacti
10/06/2005 09:06:49 AM - PHPSVR: Poller[0] DEBUG: DIRNAM: /var/www/html/cacti
10/06/2005 09:06:49 AM - PHPSVR: Poller[0] DEBUG: FILENM: /var/www/html/cacti/script_server.php
10/06/2005 09:06:49 AM - PHPSVR: Poller[0] PHP Script Server has Started - Parent is cmd
10/06/2005 09:06:49 AM - CMDPHP: Poller[0] PHP Script Server Started Properly
10/06/2005 09:06:50 AM - CMDPHP: Poller[0] Host[0] DS[60] CMD: perl /var/www/html/cacti/scripts/saa_collector.pl public 192.168.58.4, output: MinPosSD:1 MaxPosSD:58 AvgPosSD:1 MinNegSD:1 MaxNegSD:15 AvgNegSD:1 MinPosDS:1 MaxPosDS:7 AvgPosDS:1 MinNegDS:1 MaxNegDS:4 AvgNegDS:1 LossSD:0 LossDS:0 OoS:0 MiA:0 OWMinSD:16 OWMaxSD:75 OWAvgSD:18 OWMinDS:16 OWMaxDS:24 OWAvgDS:18
10/06/2005 09:06:50 AM - PHPSVR: Poller[0] DEBUG: PHP Script Server Shutdown request received, exiting
10/06/2005 09:06:50 AM - CMDPHP: Poller[0] Time: 1.8982 s, Theads: N/A, Hosts: 0
-->Scheduled run - after manually running 'php cmd.php 0 0'
10/06/2005 09:45:02 AM - POLLER: Poller[0] DEBUG: About to Spawn a Remote Process [CMD: /usr/bin/php, ARGS: -q /var/www/html/cacti/cmd.php 0 20]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'MinPosSD:1' [map MinPosSD->MinPosSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'MaxPosSD:9' [map MaxPosSD->MaxPosSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'AvgPosSD:1' [map AvgPosSD->AvgPosSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'MinNegSD:1' [map MinNegSD->MinNegSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'MaxNegSD:9' [map MaxNegSD->MaxNegSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'AvgNegSD:1' [map AvgNegSD->AvgNegSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'MinPosDS:1' [map MinPosDS->MinPosDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'MaxPosDS:2' [map MaxPosDS->MaxPosDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'AvgPosDS:1' [map AvgPosDS->AvgPosDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'MinNegDS:1' [map MinNegDS->MinNegDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'MaxNegDS:3' [map MaxNegDS->MaxNegDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'AvgNegDS:1' [map AvgNegDS->AvgNegDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'LossSD:0' [map LossSD->LossSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'LossDS:0' [map LossDS->LossDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'OoS:0' [map OoS->OoS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'MiA:0' [map MiA->MiA]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'OWMinSD:17' [map OWMinSD->OWMinSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'OWMaxSD:27' [map OWMaxSD->OWMaxSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'OWAvgSD:19' [map OWAvgSD->OWAvgSD]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'OWMinDS:14' [map OWMinDS->OWMinDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'OWMaxDS:20' [map OWMaxDS->OWMaxDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] Parsed MULTI output field 'OWAvgDS:17' [map OWAvgDS->OWAvgDS]
10/06/2005 09:45:02 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/owminds_60.rrd --template MinPosSD:MaxPosSD:AvgPosSD:MinNegSD:MaxNegSD:AvgNegSD:MinPosDS:MaxPosDS:AvgPosDS:MinNegDS:MaxNegDS:AvgNegDS:LossSD:LossDS:OoS:MiA:OWMinSD:OWMaxSD:OWAvgSD:OWMinDS:OWMaxDS:OWAvgDS 1128584486:1:9:1:1:9:1:1:2:1:1:3:1:0:0:0:0:17:27:19:14:20:17
10/06/2005 09:45:03 AM - PHPSVR: Poller[0] DEBUG: SERVER: cmd
10/06/2005 09:45:03 AM - PHPSVR: Poller[0] DEBUG: GETCWD: /home/cactiuser
10/06/2005 09:45:03 AM - PHPSVR: Poller[0] DEBUG: DIRNAM: /var/www/html/cacti
10/06/2005 09:45:03 AM - PHPSVR: Poller[0] DEBUG: FILENM: /var/www/html/cacti/script_server.php
10/06/2005 09:45:03 AM - PHPSVR: Poller[0] PHP Script Server has Started - Parent is cmd10/06/2005 09:45:03 AM - CMDPHP: Poller[0] PHP Script Server Started Properly
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[0] DS[60] WARNING: Result from CMD not valid. Partial Result:
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[0] DS[60] CMD: perl /var/www/html/cacti/scripts/saa_collector.pl public 192.168.58.4, output: U
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[1] SNMP: Device does not require SNMP
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[1] No host availability check possible for '127.0.0.1'.
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[1] DS[3] CMD: perl /var/www/html/cacti/scripts/linux_memory.pl MemFree:, output: 820884
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[1] DS[4] CMD: perl /var/www/html/cacti/scripts/linux_memory.pl SwapFree:, output: 2031608
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[1] DS[5] CMD: perl /var/www/html/cacti/scripts/loadavg_multi.pl, output: 1min:0.00 5min:0.02 10min:0.01
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[1] DS[6] CMD: perl /var/www/html/cacti/scripts/unix_users.pl, output: 2
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[1] DS[7] CMD: perl /var/www/html/cacti/scripts/unix_processes.pl, output: 81
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[5] SNMP: Host responded to SNMP
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[5] RECACHE: Processing 1 items in the auto reindex cache for '192.168.2.1'.
10/06/2005 09:45:04 AM - POLLER: Poller[0] Parsed MULTI output field '1min:0.00' [map 1min->load_1min]
10/06/2005 09:45:04 AM - POLLER: Poller[0] Parsed MULTI output field '5min:0.02' [map 5min->load_5min]
10/06/2005 09:45:04 AM - POLLER: Poller[0] Parsed MULTI output field '10min:0.01' [map 10min->load_15min]
10/06/2005 09:45:04 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/owminds_60.rrd --template 1128584702:U
10/06/2005 09:45:04 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/localhost_mem_buffers_3.rrd --template mem_buffers 1128584702:820884
10/06/2005 09:45:04 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/localhost_mem_swap_4.rrd --template mem_swap 1128584702:2031608
10/06/2005 09:45:04 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/localhost_load_1min_5.rrd --template load_1min:load_5min:load_15min 1128584702:0.00:0.02:0.01
10/06/2005 09:45:04 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/localhost_users_6.rrd --template users 1128584702:2
10/06/2005 09:45:04 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/localhost_proc_7.rrd --template proc 1128584702:81
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[5] DS[14] SNMP: v1: 192.168.2.1, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.1, output: 2929553558
10/06/2005 09:45:04 AM - CMDPHP: Poller[0] Host[5] DS[14] SNMP: v1: 192.168.2.1, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.1, output: 3113569275
10/06/2005 09:45:05 AM - CMDPHP: Poller[0] Host[5] DS[15] SNMP: v1: 192.168.2.1, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.2, output: 35606930
10/06/2005 09:45:05 AM - CMDPHP: Poller[0] Host[5] DS[15] SNMP: v1: 192.168.2.1, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.2, output: 510636017
10/06/2005 09:45:05 AM - CMDPHP: Poller[0] Host[6] SNMP: Host responded to SNMP
10/06/2005 09:45:05 AM - CMDPHP: Poller[0] Host[6] RECACHE: Processing 1 items in the auto reindex cache for '192.168.2.2'.
10/06/2005 09:45:05 AM - CMDPHP: Poller[0] Host[6] DS[16] SNMP: v1: 192.168.2.2, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.1, output: 2419872627
10/06/2005 09:45:05 AM - CMDPHP: Poller[0] Host[6] DS[16] SNMP: v1: 192.168.2.2, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.1, output: 1262478772
10/06/2005 09:45:05 AM - CMDPHP: Poller[0] Host[6] DS[17] SNMP: v1: 192.168.2.2, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.2, output: 360243287
10/06/2005 09:45:05 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/ap_1200_oest_traffic_in_16.rrd --template traffic_in:traffic_out 1128584702:2419872627:1262478772
10/06/2005 09:45:05 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/pix_oest_traffic_in_15.rrd --template traffic_out:traffic_in 1128584702:510636017:35606930
10/06/2005 09:45:05 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/pix_oest_traffic_in_14.rrd --template traffic_in:traffic_out 1128584702:3113569275:2929553558
10/06/2005 09:45:05 AM - CMDPHP: Poller[0] Host[6] DS[17] SNMP: v1: 192.168.2.2, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.2, output: 3711755799
10/06/2005 09:45:05 AM - CMDPHP: Poller[0] Host[14] SNMP: Host responded to SNMP
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[14] RECACHE: Processing 1 items in the auto reindex cache for '192.168.2.3'.
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[14] DS[63] SNMP: v1: 192.168.2.3, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.1, output: 3516806304
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[14] DS[63] SNMP: v1: 192.168.2.3, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.1, output: 3510398213
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[15] SNMP: Host responded to SNMP
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[15] RECACHE: Processing 1 items in the auto reindex cache for '192.168.58.4'.
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[15] DS[64] SNMP: v1: 192.168.58.4, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.4, output: 4227773028
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[15] DS[64] SNMP: v1: 192.168.58.4, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.4, output: 4221417612
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[16] SNMP: Host responded to SNMP
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[16] RECACHE: Processing 1 items in the auto reindex cache for '192.168.58.1'.
10/06/2005 09:45:06 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/c1720_rtr_master_traffic_in_64.rrd --template traffic_in:traffic_out 1128584702:4221417612:4227773028
10/06/2005 09:45:06 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/c1720_rtr_responder_traffic_in_63.rrd --template traffic_out:traffic_in 1128584702:3516806304:3510398213
10/06/2005 09:45:06 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/ap_1200_oest_traffic_in_17.rrd --template traffic_out:traffic_in 1128584702:3711755799:360243287
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[16] DS[65] SNMP: v1: 192.168.58.1, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.1, output: 861861148
10/06/2005 09:45:06 AM - CMDPHP: Poller[0] Host[16] DS[65] SNMP: v1: 192.168.58.1, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.1, output: 923686839
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[16] DS[66] SNMP: v1: 192.168.58.1, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.2, output: 762957392
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[16] DS[66] SNMP: v1: 192.168.58.1, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.2, output: 684238087
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[20] SNMP: Host responded to SNMP
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[20] RECACHE: Processing 1 items in the auto reindex cache for '192.168.58.3'.
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[20] DS[96] SNMP: v1: 192.168.58.3, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.1, output: 1661309272
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[20] DS[96] SNMP: v1: 192.168.58.3, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.1, output: 3043682355
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[20] DS[97] SNMP: v1: 192.168.58.3, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.3, output: 1903316336
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[20] DS[97] SNMP: v1: 192.168.58.3, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.3, output: 1112701593
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[20] DS[98] SNMP: v1: 192.168.58.3, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.5, output: 526868053
10/06/2005 09:45:07 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/catalyst_3550_traffic_in_97.rrd --template traffic_out:traffic_in 1128584702:1903316336:1112701593
10/06/2005 09:45:07 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/catalyst_3550_traffic_in_96.rrd --template traffic_in:traffic_out 1128584702:3043682355:1661309272
10/06/2005 09:45:07 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/pix501_traffic_in_66.rrd --template traffic_out:traffic_in 1128584702:762957392:684238087
10/06/2005 09:45:07 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/pix501_traffic_in_65.rrd --template traffic_in:traffic_out 1128584702:923686839:861861148
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[20] DS[98] SNMP: v1: 192.168.58.3, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.5, output: 3839857369
10/06/2005 09:45:07 AM - CMDPHP: Poller[0] Host[20] DS[99] SNMP: v1: 192.168.58.3, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.7, output: 171296861
10/06/2005 09:45:08 AM - CMDPHP: Poller[0] Host[20] DS[99] SNMP: v1: 192.168.58.3, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.7, output: 92933258
10/06/2005 09:45:08 AM - CMDPHP: Poller[0] Host[20] DS[100] SNMP: v1: 192.168.58.3, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.24, output: 1943212332
10/06/2005 09:45:08 AM - CMDPHP: Poller[0] Host[20] DS[100] SNMP: v1: 192.168.58.3, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.24, output: 1943553631
10/06/2005 09:45:08 AM - PHPSVR: Poller[0] DEBUG: PHP Script Server Shutdown request received, exiting
10/06/2005 09:45:08 AM - CMDPHP: Poller[0] Time: 5.1210 s, Theads: N/A, Hosts: 7
10/06/2005 09:45:08 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/catalyst_3550_traffic_in_100.rrd --template traffic_out:traffic_in 1128584702:1943212332:1943553631
10/06/2005 09:45:08 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/catalyst_3550_traffic_in_99.rrd --template traffic_in:traffic_out 1128584702:92933258:171296861
10/06/2005 09:45:08 AM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool update /var/www/html/cacti/rra/catalyst_3550_traffic_in_98.rrd --template traffic_in:traffic_out 1128584702:3839857369:526868053
10/06/2005 09:45:08 AM - SYSTEM STATS: Time:6.2308 Method:cmd.php Processes:1 Threads:N/A Hosts:8 HostsPerProcess:8 DataSources:32 RRDsProcessed:20
10/06/2005 09:45:08 AM - POLLER: Poller[0] DEBUG: About to Spawn a Remote Process [CMD: /usr/bin/php, ARGS: -q /var/www/html/cacti/poller_commands.php]
10/06/2005 09:45:08 AM - POLLER: Poller[0] DEBUG: About to Spawn a Remote Process [CMD: /usr/bin/php, ARGS: -q /var/www/html/cacti/poller_export.php]
Thanks,
/peter
- TheWitness
- Developer
- Posts: 17007
- Joined: Tue May 14, 2002 5:08 pm
- Location: MI, USA
- Contact:
Have you considered that your cron may not know where to locate the "perl" binary? Why don't you change the data input method to point to the full perl path, then clear your poller cache.
TheWitness
TheWitness
True understanding begins only when we realize how little we truly understand...
Life is an adventure, let yours begin with Cacti!
Author of dozens of Cacti plugins and customization's. Advocate of LAMP, MariaDB, IBM Spectrum LSF and the world of batch. Creator of IBM Spectrum RTM, author of quite a bit of unpublished work and most of Cacti's bugs.
_________________
Official Cacti Documentation
GitHub Repository with Supported Plugins
Percona Device Packages (no support)
Interesting Device Packages
For those wondering, I'm still here, but lost in the shadows. Yearning for less bugs. Who want's a Cacti 1.3/2.0? Streams anyone?
Life is an adventure, let yours begin with Cacti!
Author of dozens of Cacti plugins and customization's. Advocate of LAMP, MariaDB, IBM Spectrum LSF and the world of batch. Creator of IBM Spectrum RTM, author of quite a bit of unpublished work and most of Cacti's bugs.
_________________
Official Cacti Documentation
GitHub Repository with Supported Plugins
Percona Device Packages (no support)
Interesting Device Packages
For those wondering, I'm still here, but lost in the shadows. Yearning for less bugs. Who want's a Cacti 1.3/2.0? Streams anyone?
Yes, - Cron doesn't have problems finding perl for the other scripts as it shows in the cacti log output from my previous post.
I tried to change it anyway, also cleared the cache. But still:
10/06/2005 12:25:03 PM - CMDPHP: Poller[0] Host[0] DS[60] CMD: /usr/bin/perl /var/www/html/cacti/scripts/saa_collector.pl public 192.168.58.4, output: U
Again, I can force it to process my script data, by doing a 'php cmd.php 0 0' prior to a scheduled run.
Isn't it possible somehow to see the full output from the poller?
Thanks,
/peter
I tried to change it anyway, also cleared the cache. But still:
10/06/2005 12:25:03 PM - CMDPHP: Poller[0] Host[0] DS[60] CMD: /usr/bin/perl /var/www/html/cacti/scripts/saa_collector.pl public 192.168.58.4, output: U
Again, I can force it to process my script data, by doing a 'php cmd.php 0 0' prior to a scheduled run.
Isn't it possible somehow to see the full output from the poller?
Thanks,
/peter
- gandalf
- Developer
- Posts: 22383
- Joined: Thu Dec 02, 2004 2:46 am
- Location: Muenster, Germany
- Contact:
Yes. Change yourSurin wrote:Isn't it possible somehow to see the full output from the poller?
to look likeHere's cactiuser's crontab:
0,5,10,15,20,25,30,35,40,45,50,55 * * * *
php /var/www/html/cacti/poller.php > /dev/null 2>&1
and you'll always find the result of the last crontab poller run in this very fileHere's cactiuser's crontab:
0,5,10,15,20,25,30,35,40,45,50,55 * * * *
php /var/www/html/cacti/poller.php > /var/www/html/cacti/log/poller.log 2>&1
Reinhard
The same problem - crontab fails, but manual execution of the poller.php is correct. I also tried almost everything.
My solution was as follows:
1)
In th 'Data Input Methods' I changed the script's path
FROM: <path>/myscript.py <arg>
TO: /usr/local/bin/python <path>/myscript.py <arg>
2)
Deleted the corespondig Graph. (Don't know if it was necessary)
3)
Cleared the Poller's Cache
Now it is working as supposed to!
My solution was as follows:
1)
In th 'Data Input Methods' I changed the script's path
FROM: <path>/myscript.py <arg>
TO: /usr/local/bin/python <path>/myscript.py <arg>
2)
Deleted the corespondig Graph. (Don't know if it was necessary)
3)
Cleared the Poller's Cache
Now it is working as supposed to!
Hi,
I did change my path; /usr/bin/perl <path_cacti>/scripts/saa_collector.pl <community> <ipaddress>
No change in behaviour..
BUT, if I delete my .rrd files related to this script, then it works exactly once. The next scheduled run fails. If I delete the .rrd again, then it works again, but only that one time...
Below is the poller output, after deletion of the .rrd:
10/07/2005 04:00:03 PM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool
create /var/www/html/cacti/rra/owminds_60.rrd --step 300 DS:MinNegSD:GAUGE:600:0:500
DS:AvgNegSD:GAUGE:600:0:500 DS:AvgPosSD:GAUGE:600:0:500 DS:MinPosSD:GAUGE:600:0:500
DS:MinNegDS:GAUGE:600:0:100 DS:AvgPosDS:GAUGE:600:0:500 DS:MinPosDS:GAUGE:600:0:500
DS:LossDS:GAUGE:600:0:500 DS:MiA:GAUGE:600:0:500 DS:MaxPosDS:GAUGE:600:0:500
DS:MaxNegSD:GAUGE:600:0:500 DS:OWMinSD:GAUGE:600:0:500 DS:LossSD:GAUGE:600:0:500
DS:MaxNegDS:GAUGE:600:0:500 DS:MaxPosSD:GAUGE:600:0:500 DS:OoS:GAUGE:600:0:500
DS:OWAvgDS:GAUGE:600:0:500 DS:OWAvgSD:GAUGE:600:0:500 DS:OWMaxDS:GAUGE:600:0:500
DS:OWMaxSD:GAUGE:600:0:500 DS:OWMinDS:GAUGE:600:0:500 DS:AvgNegDS:GAUGE:600:0:500
RRA:AVERAGE:0.5:1:600 RRA:AVERAGE:0.5:6:700 RRA:AVERAGE:0.5:24:775
RRA:AVERAGE:0.5:288:797 RRA:MAX:0.5:1:600 RRA:MAX:0.5:6:700 RRA:MAX:0.5:24:775
RRA:MAX:0.5:288:797
So the problem is easily reproducible - I have a feeling this could be a timing problem.
Cheers,
/peter
I did change my path; /usr/bin/perl <path_cacti>/scripts/saa_collector.pl <community> <ipaddress>
No change in behaviour..
BUT, if I delete my .rrd files related to this script, then it works exactly once. The next scheduled run fails. If I delete the .rrd again, then it works again, but only that one time...
Below is the poller output, after deletion of the .rrd:
10/07/2005 04:00:03 PM - POLLER: Poller[0] CACTI2RRD: /usr/local/rrdtool-1.2.11/bin/rrdtool
create /var/www/html/cacti/rra/owminds_60.rrd --step 300 DS:MinNegSD:GAUGE:600:0:500
DS:AvgNegSD:GAUGE:600:0:500 DS:AvgPosSD:GAUGE:600:0:500 DS:MinPosSD:GAUGE:600:0:500
DS:MinNegDS:GAUGE:600:0:100 DS:AvgPosDS:GAUGE:600:0:500 DS:MinPosDS:GAUGE:600:0:500
DS:LossDS:GAUGE:600:0:500 DS:MiA:GAUGE:600:0:500 DS:MaxPosDS:GAUGE:600:0:500
DS:MaxNegSD:GAUGE:600:0:500 DS:OWMinSD:GAUGE:600:0:500 DS:LossSD:GAUGE:600:0:500
DS:MaxNegDS:GAUGE:600:0:500 DS:MaxPosSD:GAUGE:600:0:500 DS:OoS:GAUGE:600:0:500
DS:OWAvgDS:GAUGE:600:0:500 DS:OWAvgSD:GAUGE:600:0:500 DS:OWMaxDS:GAUGE:600:0:500
DS:OWMaxSD:GAUGE:600:0:500 DS:OWMinDS:GAUGE:600:0:500 DS:AvgNegDS:GAUGE:600:0:500
RRA:AVERAGE:0.5:1:600 RRA:AVERAGE:0.5:6:700 RRA:AVERAGE:0.5:24:775
RRA:AVERAGE:0.5:288:797 RRA:MAX:0.5:1:600 RRA:MAX:0.5:6:700 RRA:MAX:0.5:24:775
RRA:MAX:0.5:288:797
So the problem is easily reproducible - I have a feeling this could be a timing problem.
Cheers,
/peter
- gandalf
- Developer
- Posts: 22383
- Joined: Thu Dec 02, 2004 2:46 am
- Location: Muenster, Germany
- Contact:
So what is the runtime of your script? See Settings -> Poller to change the timeout value.
Another approach for long running scripts is to
- generate a script that is scheduled every 5 min and writes the result into some scratch file (e.g. like the actual script)
- have another script scheduled by the crontab for cacti that only reads the scratch file
Reinhard
Another approach for long running scripts is to
- generate a script that is scheduled every 5 min and writes the result into some scratch file (e.g. like the actual script)
- have another script scheduled by the crontab for cacti that only reads the scratch file
Reinhard
- TheWitness
- Developer
- Posts: 17007
- Joined: Tue May 14, 2002 5:08 pm
- Location: MI, USA
- Contact:
Please post your perl script.
TheWitness
TheWitness
True understanding begins only when we realize how little we truly understand...
Life is an adventure, let yours begin with Cacti!
Author of dozens of Cacti plugins and customization's. Advocate of LAMP, MariaDB, IBM Spectrum LSF and the world of batch. Creator of IBM Spectrum RTM, author of quite a bit of unpublished work and most of Cacti's bugs.
_________________
Official Cacti Documentation
GitHub Repository with Supported Plugins
Percona Device Packages (no support)
Interesting Device Packages
For those wondering, I'm still here, but lost in the shadows. Yearning for less bugs. Who want's a Cacti 1.3/2.0? Streams anyone?
Life is an adventure, let yours begin with Cacti!
Author of dozens of Cacti plugins and customization's. Advocate of LAMP, MariaDB, IBM Spectrum LSF and the world of batch. Creator of IBM Spectrum RTM, author of quite a bit of unpublished work and most of Cacti's bugs.
_________________
Official Cacti Documentation
GitHub Repository with Supported Plugins
Percona Device Packages (no support)
Interesting Device Packages
For those wondering, I'm still here, but lost in the shadows. Yearning for less bugs. Who want's a Cacti 1.3/2.0? Streams anyone?
Who is online
Users browsing this forum: No registered users and 2 guests