No graph showed on Graph view

Post support questions that relate to the Windows 2003/2000/XP operating systems.

Moderators: Developers, Moderators

Post Reply
chairuou
Posts: 5
Joined: Sun May 28, 2006 3:37 am

No graph showed on Graph view

Post by chairuou »

Greatings,
Following is my installation:

OS: Win2k3 Std
Web server: IIS 6
Cacti: 0.8.6h with all pre-patches appllied
Cactid: 0.8.6g
MySQL: 5.0.21 (Manual install pack)
PHP: 5.1.4 (mannual install pack)
RRDTool (CYGWIN version): 1.2.12-cygwin (downloaded from Cacti's website as recommended)
Net-SNMP: 5.3.0.1-ssl-1-win32
Cygwin (cygwin1.dll version): 1.5.19 , cgywin1.dll version 1.5.18


All related permission on folder access for cacti/log; cacti/rra, cmd.exe properly set.
- rrd data created in cacti/rrd folder.
- attached is my log file.
I do not see any graph on Cisco 2620 XM router, just see the broken image ( red x and device name/description, when create device, SNMP info return:

Code: Select all

System: Cisco Internetwork Operating System Software IOS (tm) C2600 Software (C2600-IK9S-M), Version 12.3(3), RELEASE SOFTWARE (fc2) Copyright (c) 1986-2003 by cisco Systems, Inc. Compiled Tue 19-Aug-03 16:31 by dchih
Uptime: 162523988
Hostname: <deleted>
Location: 
Contact: 

I've searched around mailing list and this forum, also read the FAQ by BSOD006 carefully but can not solve the case by myself. Could you please give me some advises/solutions?

Thank you and regards,
chairuou.
Attachments
log.txt
Log from cacti/log folder.
(139.48 KiB) Downloaded 87 times
Broken Image when view Graphs
Broken Image when view Graphs
cacti-error.jpg (26.15 KiB) Viewed 2041 times
User avatar
BSOD2600
Cacti Moderator
Posts: 12171
Joined: Sat May 08, 2004 12:44 pm
Location: USA

Post by BSOD2600 »

hooray! finally someone who tries to help themselves and makes a decent post :-).

It seems the Poller Logging Level isn't set to debug, since your output is repeating the same thing over and over. Try setting it to low, click save. Then change it back to debug, click save. Seems there is a bug in cacti where the level doesn't always get set for some reason.

As for your lack of graphs, the fact the poller is timing out (aka maximum runtime of 292 seconds in the log file), is not a good thing. There are a wide range of reason why this can happen. Most often it's because the poller doesn't have the correct permissions to run properly. Are you sure the user who runs the cacti scheduled task has the proper permissions on all the files/exe's which cacti uses? Fire up Sysinternals.com Filemon and look for anything getting denied during a polling session.

If you go into Graph Management, click on a graph, then click on graph debug. What is the error message rrdtool says (I'm betting it can't find the .rrd file) ?
chairuou
Posts: 5
Joined: Sun May 28, 2006 3:37 am

Post by chairuou »

BSOD2600 wrote:hooray! finally someone who tries to help themselves and makes a decent post :-).
That came from your post template ;)

It seems the Poller Logging Level isn't set to debug, since your output is repeating the same thing over and over. Try setting it to low, click save. Then change it back to debug, click save. Seems there is a bug in cacti where the level doesn't always get set for some reason.

As for your lack of graphs, the fact the poller is timing out (aka maximum runtime of 292 seconds in the log file), is not a good thing. There are a wide range of reason why this can happen. Most often it's because the poller doesn't have the correct permissions to run properly. Are you sure the user who runs the cacti scheduled task has the proper permissions on all the files/exe's which cacti uses? Fire up Sysinternals.com Filemon and look for anything getting denied during a polling session.

If you go into Graph Management, click on a graph, then click on graph debug. What is the error message rrdtool says (I'm betting it can't find the .rrd file) ?
- DEBUG level set again.
- the user account used to run scheduled task is Local user account created on that box. That user had permission to read/write on folders cacti/log; cacti/rra; excutable on php.exe; cmd.exe. It also had full permission on Schedule task php.
- There are some interesting things after I tried to rename some DLL file from rrdtool which was extract to cacti directory at install phase:

Code: Select all

D:\cacti-0.8.6h>dir *.bak
 Volume in drive D is Second_VOL
 Volume Serial Number is 7227-0675

 Directory of D:\cacti-0.8.6h

07/30/2005  05:47 AM            77,824 cygart_lgpl_2-2.dll.bak
09/06/2005  06:12 PM           383,488 cygfreetype-6.dll.bak
07/11/2005  06:50 PM           235,520 cygpng12.dll.bak
07/02/2005  07:30 PM         1,295,582 cygwin1.dll.bak
               4 File(s)      1,992,414 bytes
               0 Dir(s)  27,025,166,336 bytes free
after that, look like cactid finding config for snmp in d:\cygwin which is location for my installed cygwin.
Another thing I see a newly created directory at D: as D:\USR .... see attached image.

Graph Debug mode turn on show rrdtool commands:

Code: Select all

RRDTool Command:

D:/cacti-0.8.6h/rrdtool.exe graph - \
--imgformat=PNG \
--start=-86400 \
--end=-300 \
--title="Cisco.Routers.Cisco.2620 XM - Traffic - Fa0/0" \
--rigid \
--base=1000 \
--height=120 \
--width=500 \
--alt-autoscale-max \
--lower-limit=0 \
--vertical-label="bits per second" \
--slope-mode \
DEF:a="D\:/cacti-0.8.6h/rra/cisco_routers_cisco_2620_xm_traffic_in_32.rrd":traffic_in:AVERAGE \
CDEF:cdefa=a,8,* \
CDEF:cdeff=a,8,* \
AREA:cdefa#00CF00:"Inbound"  \
GPRINT:cdefa:LAST:" Current\:%8.2lf %s"  \
GPRINT:cdefa:AVERAGE:"Average\:%8.2lf %s"  \
GPRINT:cdefa:MAX:"Maximum\:%8.2lf %s"  \
COMMENT:"Total In\:  0 bytes\n"  \
LINE1:cdeff#002A97:"Outbound"  \
GPRINT:cdeff:LAST:"Current\:%8.2lf %s"  \
GPRINT:cdeff:AVERAGE:"Average\:%8.2lf %s"  \
GPRINT:cdeff:MAX:"Maximum\:%8.2lf %s"  \
COMMENT:"Total Out\: 0 bytes" 

RRDTool Says:
Below is lastest log run cycle:

Code: Select all

05/29/2006 11:00:00 AM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select count(*) from poller_item"
05/29/2006 11:00:00 AM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select id from host where disabled = '' order by id"
05/29/2006 11:00:00 AM - CMDPHP: Poller[0] DEBUG: SQL Exec: "replace into settings (name,value) values ('path_webroot','d:/cacti-0.8.6h')"
05/29/2006 11:00:00 AM - CMDPHP: Poller[0] DEBUG: SQL Exec: "truncate table poller_time"
05/29/2006 11:00:00 AM - POLLER: Poller[0] DEBUG: About to Spawn a Remote Process [CMD: D:/cacti-0.8.6h/cactid.exe, ARGS:  0 9]
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '4': 'SELECT value FROM settings WHERE name = 'path_php_binary''
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '4': OK
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: The path_php variable is D:/php-5.1.4/php.exe
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '5': 'SELECT value FROM settings WHERE name = 'availability_method''
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '5': OK
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: The availability_method variable is 1
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '6': 'SELECT value FROM settings WHERE name = 'ping_recovery_count''
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '6': OK
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: The ping_recovery_count variable is 3
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '7': 'SELECT value FROM settings WHERE name = 'ping_failure_count''
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '7': OK
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: The ping_failure_count variable is 2
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '8': 'SELECT value FROM settings WHERE name = 'ping_method''
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '8': OK
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: The ping_method variable is 2
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '9': 'SELECT value FROM settings WHERE name = 'ping_retries''
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '9': OK
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: The ping_retries variable is 1
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '10': 'SELECT value FROM settings WHERE name = 'ping_timeout''
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '10': OK
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: The ping_timeout variable is 400
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '11': 'SELECT value FROM settings WHERE name = 'log_perror''
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '11': OK
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: The log_perror variable is 1
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '12': 'SELECT value FROM settings WHERE name = 'log_pwarn''
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '12': OK
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: The log_pwarn variable is 1
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '13': 'SELECT value FROM settings WHERE name = 'log_pstats''
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '13': OK
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: The log_pstats variable is 1
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '14': 'SELECT value FROM settings WHERE name = 'max_threads''
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '14': OK
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: The threads variable is 1
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '15': 'SELECT value FROM settings WHERE name = 'poller_interval''
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '15': OK
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: The polling interval is the system default
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '16': 'SELECT value FROM settings WHERE name = 'concurrent_processes''
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '16': OK
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: The number of concurrent processes is 1
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '17': 'SELECT value FROM settings WHERE name = 'script_timeout''
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '17': OK
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: The script timeout is 25
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '18': 'SELECT value FROM settings WHERE name = 'php_servers''
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '18': OK
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: The number of php script servers to run is 1
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '19': 'SELECT action FROM poller_item WHERE action=2 AND host_id BETWEEN 0 AND 9 LIMIT 1'
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '19': OK
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: StartHost='0', EndHost='9', TotalPHPScripts='0'
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: The PHP Script Server is Not Required
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '20': 'SELECT value FROM settings WHERE name = 'max_get_size''
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '20': OK
05/29/2006 11:00:00 AM - CACTID: Poller[0] DEBUG: The Maximum SNMP OID Get Size is 10
05/29/2006 11:00:00 AM - CACTID: Poller[0] CACTID: Version 0.8.6f starting
05/29/2006 11:00:00 AM - CACTID: Poller[0] MYSQL: Connecting to MySQL database 'cacti' on '127.0.0.1'...
05/29/2006 11:00:00 AM - CACTID: Poller[0] MYSQL: Connected to MySQL database 'cacti' on '127.0.0.1'...
05/29/2006 11:00:00 AM - CACTID: Poller[0] CACTID: Initializing Net-SNMP API
05/29/2006 11:00:01 AM - CMDPHP: Poller[0] DEBUG: SQL Exec: "replace into settings (name,value) values ('date',NOW())"
05/29/2006 11:00:01 AM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select poller_id,end_time from poller_time where poller_id = 0"
05/29/2006 11:00:01 AM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select  poller_output.output,  poller_output.time,  poller_output.local_data_id,  poller_item.rrd_path,  poller_item.rrd_name,  poller_item.rrd_num  from (poller_output,poller_item)  where (poller_output.local_data_id=poller_item.local_data_id and poller_output.rrd_name=poller_item.rrd_name)"
05/29/2006 11:00:02 AM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select poller_id,end_time from poller_time where poller_id = 0"
05/29/2006 11:00:02 AM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select  poller_output.output,  poller_output.time,  poller_output.local_data_id,  poller_item.rrd_path,  poller_item.rrd_name,  poller_item.rrd_num  from (poller_output,poller_item)  where (poller_output.local_data_id=poller_item.local_data_id and poller_output.rrd_name=poller_item.rrd_name)"
05/29/2006 11:00:03 AM - CACTID: Poller[0] CACTID: Initializing PHP Script Server
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '21': 'SELECT id FROM host WHERE disabled='' AND id BETWEEN 0 AND 9 ORDER BY id'
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '21': OK
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: Initial Value of Active Threads is 0
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: Valid Thread to be Created
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: In Poller, About to Start Polling of Host
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: The Value of Active Threads is 1
05/29/2006 11:00:03 AM - CACTID: Poller[0] MYSQL: Connecting to MySQL database 'cacti' on '127.0.0.1'...
05/29/2006 11:00:03 AM - CACTID: Poller[0] MYSQL: Connected to MySQL database 'cacti' on '127.0.0.1'...
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '22': 'SELECT action,hostname,snmp_community,snmp_version,snmp_username,snmp_password,rrd_name,rrd_path,arg1,arg2,arg3,local_data_id,rrd_num,snmp_port,snmp_timeout FROM poller_item WHERE host_id=0 ORDER BY arg1'
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '22': OK
05/29/2006 11:00:03 AM - CACTID: Poller[0] Host[0] DEBUG: HOST COMPLETE: About to Exit Host Polling Thread Function
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: The Value of Active Threads is 0
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: Valid Thread to be Created
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: The Value of Active Threads is 1
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: In Poller, About to Start Polling of Host
05/29/2006 11:00:03 AM - CACTID: Poller[0] MYSQL: Connecting to MySQL database 'cacti' on '127.0.0.1'...
05/29/2006 11:00:03 AM - CACTID: Poller[0] MYSQL: Connected to MySQL database 'cacti' on '127.0.0.1'...
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '23': 'SELECT id, hostname,snmp_community,snmp_username,snmp_password,snmp_version,snmp_port,snmp_timeout,status,status_event_count,status_fail_date,status_rec_date,status_last_error,min_time,max_time,cur_time,avg_time,total_polls,failed_polls,availability FROM host WHERE id=9'
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '23': OK
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: The UDP Ping return_code was -1, errno was 104, total_time was 30999.8989
05/29/2006 11:00:03 AM - CACTID: Poller[0] Host[9] PING Result: UDP: Ping timed out
05/29/2006 11:00:03 AM - CACTID: Poller[0] Host[9] SNMP Result: SNMP not performed due to setting or ping result
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: MySQL Insert ID '0': 'update host set status='1',status_event_count='9', status_fail_date='2006-05-29 10:20:00',status_rec_date='0000-00-00 00:00:00',status_last_error='SNMP not performed due to setting or ping result, UDP: Ping timed out',min_time='9.999990',max_time='47.000050',cur_time='47.000050',avg_time='47.000050',total_polls='10',failed_polls='9',availability='10.0000' where id='9''
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: MySQL Insert ID '0': OK
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '24': 'SELECT action,hostname,snmp_community,snmp_version,snmp_username,snmp_password,rrd_name,rrd_path,arg1,arg2,arg3,local_data_id,rrd_num,snmp_port,snmp_timeout FROM poller_item WHERE host_id=9 ORDER BY arg1'
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: MySQL Query ID '24': OK
05/29/2006 11:00:03 AM - CACTID: Poller[0] Host[9] DEBUG: HOST COMPLETE: About to Exit Host Polling Thread Function
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: The Value of Active Threads is 0
05/29/2006 11:00:03 AM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select poller_id,end_time from poller_time where poller_id = 0"
05/29/2006 11:00:03 AM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select  poller_output.output,  poller_output.time,  poller_output.local_data_id,  poller_item.rrd_path,  poller_item.rrd_name,  poller_item.rrd_num  from (poller_output,poller_item)  where (poller_output.local_data_id=poller_item.local_data_id and poller_output.rrd_name=poller_item.rrd_name)"
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: MySQL Insert ID '1': 'replace into settings (name,value) values ('date',NOW())'
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: MySQL Insert ID '1': OK
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: MySQL Insert ID '2': 'insert into poller_time (poller_id, start_time, end_time) values (0, NOW(), NOW())'
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: MySQL Insert ID '2': OK
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: Thread Cleanup Complete
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: PHP Script Server Pipes Closed
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: Allocated Variable Memory Freed
05/29/2006 11:00:03 AM - CACTID: Poller[0] CACTID: Net-SNMP API Shutdown Completed
05/29/2006 11:00:03 AM - CACTID: Poller[0] DEBUG: MYSQL Free & Close Completed
05/29/2006 11:00:03 AM - CACTID: Poller[0] Time: 3.0780 s, Threads: 1, Hosts: 2
05/29/2006 11:00:04 AM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select poller_id,end_time from poller_time where poller_id = 0"
05/29/2006 11:00:04 AM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select  poller_output.output,  poller_output.time,  poller_output.local_data_id,  poller_item.rrd_path,  poller_item.rrd_name,  poller_item.rrd_num  from (poller_output,poller_item)  where (poller_output.local_data_id=poller_item.local_data_id and poller_output.rrd_name=poller_item.rrd_name)"
05/29/2006 11:00:04 AM - SYSTEM STATS: Time:4.0257 Method:cactid Processes:1 Threads:1 Hosts:2 HostsPerProcess:2 DataSources:10 RRDsProcessed:0
05/29/2006 11:00:04 AM - CMDPHP: Poller[0] DEBUG: SQL Exec: "replace into settings (name,value) values ('stats_poller','Time:4.0257 Method:cactid Processes:1 Threads:1 Hosts:2 HostsPerProcess:2 DataSources:10 RRDsProcessed:0')"
05/29/2006 11:00:04 AM - CMDPHP: Poller[0] DEBUG: SQL Exec: "truncate table poller_output"
05/29/2006 11:00:04 AM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select count(*) from poller_command"
Attachments
Shedule task for Poller.
Shedule task for Poller.
cacti-schedule.JPG (15.03 KiB) Viewed 2024 times
Folder automatic created at D: for perssist SNMP data.
Folder automatic created at D: for perssist SNMP data.
cacti-snmp-perssit-wrong-path.JPG (44.58 KiB) Viewed 2024 times
Cacti user denied to access d:cygwin after renamed some DLL file came with rrdtool.
Cacti user denied to access d:cygwin after renamed some DLL file came with rrdtool.
cacti-cygwin-config-snmp-lookup-denied.JPG (53.67 KiB) Viewed 2024 times
cacti-full-log.zip
Log file of cacti since it start 1st time.
&gt; 1MB after extracted
(34.93 KiB) Downloaded 95 times
chairuou
Posts: 5
Joined: Sun May 28, 2006 3:37 am

Post by chairuou »

After all above and tried lot of ways to find out what's wrong with installation and configuration, I decide to restart from scratch, rename cacti to another name, reinstall it, re-apply all patches, drop the database and recreate it.
change rrd extracted to cacti/rrd and cactid to cacti/cactid folder.
Add device, SNMP result information from router, but view ing graph in Graph Management with Graph Debug turned on show up some error with RRDTool command as attached image. data file generated in cacti/rra folder. cacti.log as below:

Code: Select all

05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select cacti from version"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select id from user_auth where username='guest'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select   user_auth_realm.realm_id   from   user_auth_realm   where user_auth_realm.user_id='1'   and user_auth_realm.realm_id='15'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select username from user_auth where id=1"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select realm_id from user_auth_realm where user_id=1"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='logging_header'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='logging_header'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='log_destination'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='log_destination'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='log_snmp'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='log_snmp'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='log_graph'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='log_graph'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='log_export'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='log_export'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='poller_header'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='poller_header'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='log_verbosity'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='log_verbosity'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='log_pstats'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='log_pstats'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='log_pwarn'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='log_pwarn'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='log_perror'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='log_perror'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='versions_header'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='versions_header'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='snmp_version'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='snmp_version'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='rrdtool_version'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='rrdtool_version'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='snmp_header'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='snmp_header'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='snmp_ver'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='snmp_ver'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='snmp_community'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='snmp_community'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='snmp_username'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='snmp_username'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='snmp_password'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='snmp_password'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='snmp_timeout'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='snmp_timeout'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='snmp_port'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='snmp_port'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='snmp_retries'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='snmp_retries'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='other_header'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='other_header'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select value from settings where name='remove_verification'"
05/29/2006 02:24:24 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select value from settings where name='remove_verification'"
05/29/2006 02:24:29 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select count(*) from poller_item"
05/29/2006 02:24:29 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select id from host where disabled = '' order by id"
05/29/2006 02:24:29 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "replace into settings (name,value) values ('path_webroot','d:/cacti-0.8.6h')"
05/29/2006 02:24:29 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "truncate table poller_time"
05/29/2006 02:24:29 PM - POLLER: Poller[0] DEBUG: About to Spawn a Remote Process [CMD: d:/php-5.1.4/php.exe, ARGS: -q d:/cacti-0.8.6h/cmd.php 0 2]
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select * from host where (disabled = '' and id >= 0 and id <= 2) ORDER by id"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "SELECT * from poller_item WHERE (host_id >= 0 and host_id <= 2) ORDER by host_id"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "SELECT count(*) from poller_item WHERE (action=2 AND (host_id >= 0 and host_id <= 2))"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] Host[2] SNMP: Host responded to SNMP
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "update host set  status = '3',  status_event_count = '0',  status_fail_date = '0000-00-00 00:00:00',  status_rec_date = '0000-00-00 00:00:00',  status_last_error = '',  min_time = '4.84000',  max_time = '5.23',  cur_time = '5.23',  avg_time = '5.0333333333333',  total_polls = '6',  failed_polls = '0',  availability = '100'  where hostname = '10.89.10.1'"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select     poller_reindex.data_query_id,     poller_reindex.action,     poller_reindex.op,     poller_reindex.assert_value,     poller_reindex.arg1     from poller_reindex     where poller_reindex.host_id=2"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] Host[2] RECACHE: Processing 1 items in the auto reindex cache for '10.89.10.1'.
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "update poller_reindex set assert_value='389953901' where host_id='2' and data_query_id='1' and arg1='.1.3.6.1.2.1.1.3.0'"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] Host[2] DS[11] SNMP: v1: 10.89.10.1, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.4, output: 4236980115
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "insert into poller_output (local_data_id,rrd_name,time,output) values (11,'traffic_out','2006-05-29 14:24:30','4236980115')"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] Host[2] DS[11] SNMP: v1: 10.89.10.1, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.4, output: 1855578746
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "insert into poller_output (local_data_id,rrd_name,time,output) values (11,'traffic_in','2006-05-29 14:24:30','1855578746')"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] Host[2] DS[12] SNMP: v1: 10.89.10.1, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.5, output: 0
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "insert into poller_output (local_data_id,rrd_name,time,output) values (12,'traffic_out','2006-05-29 14:24:30','0')"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] Host[2] DS[12] SNMP: v1: 10.89.10.1, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.5, output: 0
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "insert into poller_output (local_data_id,rrd_name,time,output) values (12,'traffic_in','2006-05-29 14:24:30','0')"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] Host[2] DS[10] SNMP: v1: 10.89.10.1, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.3, output: 160328792
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "insert into poller_output (local_data_id,rrd_name,time,output) values (10,'traffic_in','2006-05-29 14:24:30','160328792')"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] Host[2] DS[10] SNMP: v1: 10.89.10.1, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.3, output: 491635945
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "insert into poller_output (local_data_id,rrd_name,time,output) values (10,'traffic_out','2006-05-29 14:24:30','491635945')"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] Host[2] DS[9] SNMP: v1: 10.89.10.1, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.2, output: 2182523447
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "insert into poller_output (local_data_id,rrd_name,time,output) values (9,'traffic_out','2006-05-29 14:24:30','2182523447')"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] Host[2] DS[9] SNMP: v1: 10.89.10.1, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.2, output: 3177173449
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "insert into poller_output (local_data_id,rrd_name,time,output) values (9,'traffic_in','2006-05-29 14:24:30','3177173449')"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] Host[2] DS[8] SNMP: v1: 10.89.10.1, dsname: traffic_out, oid: .1.3.6.1.2.1.2.2.1.16.1, output: 3777126737
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "insert into poller_output (local_data_id,rrd_name,time,output) values (8,'traffic_out','2006-05-29 14:24:30','3777126737')"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] Host[2] DS[8] SNMP: v1: 10.89.10.1, dsname: traffic_in, oid: .1.3.6.1.2.1.2.2.1.10.1, output: 2285385564
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "insert into poller_output (local_data_id,rrd_name,time,output) values (8,'traffic_in','2006-05-29 14:24:30','2285385564')"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] Time: 0.0792 s, Theads: N/A, Hosts: 1
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "insert into poller_time (poller_id, start_time, end_time) values (0, NOW(), NOW())"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "replace into settings (name,value) values ('date',NOW())"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select poller_id,end_time from poller_time where poller_id = 0"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Assoc: "select  poller_output.output,  poller_output.time,  poller_output.local_data_id,  poller_item.rrd_path,  poller_item.rrd_name,  poller_item.rrd_num  from (poller_output,poller_item)  where (poller_output.local_data_id=poller_item.local_data_id and poller_output.rrd_name=poller_item.rrd_name)"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "delete from poller_output where local_data_id='11' and rrd_name='traffic_out' and time='2006-05-29 14:24:30'"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "delete from poller_output where local_data_id='11' and rrd_name='traffic_in' and time='2006-05-29 14:24:30'"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "delete from poller_output where local_data_id='12' and rrd_name='traffic_out' and time='2006-05-29 14:24:30'"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "delete from poller_output where local_data_id='12' and rrd_name='traffic_in' and time='2006-05-29 14:24:30'"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "delete from poller_output where local_data_id='10' and rrd_name='traffic_in' and time='2006-05-29 14:24:30'"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "delete from poller_output where local_data_id='10' and rrd_name='traffic_out' and time='2006-05-29 14:24:30'"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "delete from poller_output where local_data_id='9' and rrd_name='traffic_out' and time='2006-05-29 14:24:30'"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "delete from poller_output where local_data_id='9' and rrd_name='traffic_in' and time='2006-05-29 14:24:30'"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "delete from poller_output where local_data_id='8' and rrd_name='traffic_out' and time='2006-05-29 14:24:30'"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "delete from poller_output where local_data_id='8' and rrd_name='traffic_in' and time='2006-05-29 14:24:30'"
05/29/2006 02:24:30 PM - POLLER: Poller[0] CACTI2RRD: d:/cacti-0.8.6h/rrd/rrdtool.exe update D:\cacti-0.8.6h\rra\cisco_router_hanoi_2620xm_traffic_in_11.rrd --template traffic_out:traffic_in 1148887470:4236980115:1855578746
05/29/2006 02:24:30 PM - POLLER: Poller[0] CACTI2RRD: d:/cacti-0.8.6h/rrd/rrdtool.exe update D:\cacti-0.8.6h\rra\cisco_router_hanoi_2620xm_traffic_in_12.rrd --template traffic_out:traffic_in 1148887470:0:0
05/29/2006 02:24:30 PM - POLLER: Poller[0] CACTI2RRD: d:/cacti-0.8.6h/rrd/rrdtool.exe update D:\cacti-0.8.6h\rra\cisco_router_hanoi_2620xm_traffic_in_10.rrd --template traffic_in:traffic_out 1148887470:160328792:491635945
05/29/2006 02:24:30 PM - POLLER: Poller[0] CACTI2RRD: d:/cacti-0.8.6h/rrd/rrdtool.exe update D:\cacti-0.8.6h\rra\cisco_router_hanoi_2620xm_traffic_in_9.rrd --template traffic_out:traffic_in 1148887470:2182523447:3177173449
05/29/2006 02:24:30 PM - POLLER: Poller[0] CACTI2RRD: d:/cacti-0.8.6h/rrd/rrdtool.exe update D:\cacti-0.8.6h\rra\cisco_router_hanoi_2620xm_traffic_in_8.rrd --template traffic_out:traffic_in 1148887470:3777126737:2285385564
05/29/2006 02:24:30 PM - SYSTEM STATS: Time:1.0651 Method:cmd.php Processes:1 Threads:N/A Hosts:2 HostsPerProcess:2 DataSources:10 RRDsProcessed:5
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "replace into settings (name,value) values ('stats_poller','Time:1.0651 Method:cmd.php Processes:1 Threads:N/A Hosts:2 HostsPerProcess:2 DataSources:10 RRDsProcessed:5')"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Exec: "truncate table poller_output"
05/29/2006 02:24:30 PM - CMDPHP: Poller[0] DEBUG: SQL Cell: "select count(*) from poller_command"

TIA!
chairuou
Attachments
RRDTool command error result in Graph Debug turned on.
RRDTool command error result in Graph Debug turned on.
cacti-error-reinstall.JPG (48.38 KiB) Viewed 2004 times
User avatar
BSOD2600
Cacti Moderator
Posts: 12171
Joined: Sat May 08, 2004 12:44 pm
Location: USA

Post by BSOD2600 »

Do you have rrdtool 1.2 selected in Cacti's settings?
chairuou
Posts: 5
Joined: Sun May 28, 2006 3:37 am

Post by chairuou »

BSOD2600 wrote:Do you have rrdtool 1.2 selected in Cacti's settings?
You're the Man ;) I correct it after post previous message and everything look ok now.
The error came at first installation phase caused by me when I manually delete all files in cacti/rra but database in MySQL still keep some info., after drop database and recreate it, rrd data generated as well.

btw, anyone know why |query_ifAlias| result truncated? I add it to Graph title but it truncated.

TIA.
chairuou
User avatar
BSOD2600
Cacti Moderator
Posts: 12171
Joined: Sat May 08, 2004 12:44 pm
Location: USA

Post by BSOD2600 »

Try Settings -> Visual and then increasing the Maximum Title Lengths. you'll probably need to refresh the graph for the longer name to show up.
Post Reply

Who is online

Users browsing this forum: No registered users and 0 guests