SOLVED: Cacti not creating rrd files for SNMP - Generic OID

[vincentvega]

Hi All

I am new to cacti and network monitoring in general.

I have a standard cacti + spine running on a ubuntu 14.04 VM.

I am trying to generate a data source using the "SNMP - Generic OID" template.

Code: Select all

Data Source Debug

/usr/bin/rrdtool create \
/var/lib/cacti/rra/sparky_vm_snmp_oid_12.rrd \
--step 300  \
DS:snmp_oid:GAUGE:600:0:100 \
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 \

Code: Select all

sudo find / -name *.rrd
/var/lib/cacti/rra/localhost_proc_7.rrd
/var/lib/cacti/rra/localhost_mem_buffers_3.rrd
/var/lib/cacti/rra/localhost_mem_swap_4.rrd
/var/lib/cacti/rra/localhost_users_6.rrd
/var/lib/cacti/rra/localhost_load_1min_5.rrd
/var/lib/cacti/rra/sparky_vm_ping_13.rrd

As you can see the rrd file does not exist, yet now errors are shown in the log when set to DEBUG level.

I successfully created the following data source using the "UNIX - Ping Host" template.

Code: Select all

Data Source Debug

/usr/bin/rrdtool create \
/var/lib/cacti/rra/sparky_vm_ping_13.rrd \
--step 300  \
DS:ping:GAUGE:600:0:5000 \
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 \

This proves that cacti is able to create rrd files, so im thinking it is something specific to the "SNMP - Generic OID" template.

I have tried deleting and re-creating the data source a number of times and have waited for a number of polling intervals.

Any suggestions would be appreciated.

[vincentvega]

cacti log file output at DEBUG level

Code: Select all

01/07/2016 11:20:01 PM - SYSTEM STATS: Time:0.1069 Method:spine Processes:1 Threads:1 Hosts:2 HostsPerProcess:2 DataSources:6 RRDsProcessed:6
01/07/2016 11:20:01 PM - POLLER: Poller[0] CACTI2RRD: /usr/bin/rrdtool update /var/lib/cacti/rra/localhost_mem_buffers_3.rrd --template mem_buffers 1452169201:1326156
01/07/2016 11:20:01 PM - POLLER: Poller[0] CACTI2RRD: /usr/bin/rrdtool update /var/lib/cacti/rra/localhost_mem_swap_4.rrd --template mem_swap 1452169201:2095100
01/07/2016 11:20:01 PM - POLLER: Poller[0] CACTI2RRD: /usr/bin/rrdtool update /var/lib/cacti/rra/localhost_load_1min_5.rrd --template load_1min:load_5min:load_15min 1452169201:0.00:0.01:0.05
01/07/2016 11:20:01 PM - POLLER: Poller[0] CACTI2RRD: /usr/bin/rrdtool update /var/lib/cacti/rra/localhost_users_6.rrd --template users 1452169201:1
01/07/2016 11:20:01 PM - POLLER: Poller[0] CACTI2RRD: /usr/bin/rrdtool update /var/lib/cacti/rra/localhost_proc_7.rrd --template proc 1452169201:137
01/07/2016 11:20:01 PM - POLLER: Poller[0] CACTI2RRD: /usr/bin/rrdtool update /var/lib/cacti/rra/sparky_vm_ping_13.rrd --template ping 1452169201:0.014
01/07/2016 11:20:01 PM - POLLER: Poller[0] Parsed MULTI output field '10min:0.05' [map 10min->load_15min]
01/07/2016 11:20:01 PM - POLLER: Poller[0] Parsed MULTI output field '5min:0.01' [map 5min->load_5min]
01/07/2016 11:20:01 PM - POLLER: Poller[0] Parsed MULTI output field '1min:0.00' [map 1min->load_1min]
01/07/2016 10:20:01 PM - SPINE: Poller[0] Time: 0.0440 s, Threads: 1, Hosts: 2
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: Net-SNMP Close Completed
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: MYSQL Free & Close Completed
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: Allocated Variable Memory Freed
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: PHP Script Server Pipes Closed
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: Thread Cleanup Complete
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The Value of Active Threads is 0
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] TH[1] DEBUG: HOST COMPLETE: About to Exit Host Polling Thread Function
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] TH[1] Total Time: 0.034 Seconds
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] TH[1] DS[13] SCRIPT: perl /usr/share/cacti/site/scripts/ping.pl 127.0.0.1, output: 0.014
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] DEBUG: The NIFTY POPEN returned the following File Descriptor 7
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] TH[1] DS[7] SCRIPT: perl /usr/share/cacti/site/scripts/unix_processes.pl, output: 137
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] DEBUG: The NIFTY POPEN returned the following File Descriptor 7
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] TH[1] DS[6] SCRIPT: perl /usr/share/cacti/site/scripts/unix_users.pl , output: 1
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] DEBUG: The NIFTY POPEN returned the following File Descriptor 7
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] TH[1] DS[5] SCRIPT: /usr/bin/perl /usr/share/cacti/site/scripts/loadavg_multi.pl, output: 1min:0.00 5min:0.01 10min:0.05
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] DEBUG: The NIFTY POPEN returned the following File Descriptor 7
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] TH[1] DS[4] SCRIPT: perl /usr/share/cacti/site/scripts/linux_memory.pl SwapFree:, output: 2095100
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] DEBUG: The NIFTY POPEN returned the following File Descriptor 7
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] TH[1] DS[3] SCRIPT: perl /usr/share/cacti/site/scripts/linux_memory.pl MemFree:, output: 1326156
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] DEBUG: The NIFTY POPEN returned the following File Descriptor 7
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] TH[1] NOTE: There are '6' Polling Items for this Host
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] TH[1] Host has no information for recache.
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] PING: Result UDP: Host is Alive
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] DEBUG: UDP Host Alive, Try Count:1, Time:0.0210 ms
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[1] DEBUG: Entering UDP Ping
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The Value of Active Threads is 1
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: In Poller, About to Start Polling of Host
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: Valid Thread to be Created
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The Value of Active Threads is 0
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[0] TH[1] DEBUG: HOST COMPLETE: About to Exit Host Polling Thread Function
01/07/2016 10:20:01 PM - SPINE: Poller[0] Host[0] TH[1] Total Time: 0.00035 Seconds
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The Value of Active Threads is 1
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: In Poller, About to Start Polling of Host
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: Valid Thread to be Created
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: Initial Value of Active Threads is 0
01/07/2016 10:20:01 PM - SPINE: Poller[0] NOTE: Spine is behaving in a 0.8.7g+ manner
01/07/2016 10:20:01 PM - SPINE: Poller[0] NOTE: Spine will support multithread device polling.
01/07/2016 10:20:01 PM - SPINE: Poller[0] SPINE: Initializing PHP Script Server(s)
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: Issues with SNMP Header Version information, assuming old version of Net-SNMP.
01/07/2016 10:20:01 PM - SPINE: Poller[0] SPINE: Initializing Net-SNMP API
01/07/2016 10:20:01 PM - SPINE: Poller[0] WARNING: Spine NOT running asroot. This is required if using ICMP. Please run "chmod +s;chown root:root spine" to resolve.
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: MySQL is Thread Safe!
01/07/2016 10:20:01 PM - SPINE: Poller[0] Version 0.8.8b starting
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The Maximum SNMP OID Get Size is 10
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The PHP Script Server is Not Required
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: StartHost='0', EndHost='1', TotalPHPScripts='0'
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The number of php script servers to run is 1
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The script timeout is 25
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The number of concurrent processes is 1
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The polling interval is 300 seconds
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The threads variable is 1
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The log_pstats variable is 0
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The boost_redirect variable is 0
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The log_pwarn variable is 0
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The log_perror variable is 1
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The snmp_retries variable is 3
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The ping_timeout variable is 400
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The ping_retries variable is 1
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The ping_method variable is 2
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The ping_failure_count variable is 2
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The ping_recovery_count variable is 3
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The availability_method variable is 2
01/07/2016 10:20:01 PM - SPINE: Poller[0] DEBUG: The path_php variable is /usr/bin/php
01/07/2016 11:20:01 PM - POLLER: Poller[0] DEBUG: About to Spawn a Remote Process [CMD: /usr/sbin/spine, ARGS: 0 1]
01/07/2016 11:20:01 PM - POLLER: Poller[0] NOTE: Poller Int: '300', Cron Int: '300', Time Since Last: '300', Max Runtime '298', Poller Runs: '1'
01/07/2016 11:16:06 PM - WEBUI: Cacti Log Cleared from Web Management Interface 

[vincentvega]

after a long night staring at this i figured it out.

I was modifying the default localhost device that ships with cacti (which I have renamed to sparky_vm)

In device settings, it has the snmp version set to none.

Setting this to version 1 solved the issue.