I can't get cacti to render snmp graphics
Moderators: Developers, Moderators
I can't get cacti to render snmp graphics
I have used much simpler programs like mib browser and in 10 minutes you can learn to make a graph.
I have installed the version of cacti on windows and on ubuntu, I have spent 2.5 days on each version, I have read quite a bit in a language that is not my own, and I am about to throw in the towel.
The only light I have managed to get has been editing usr/share/cacti/site/resource/snmp_queries/interface.xml and replacing its first 2 oids with the oids that interest me, only then have I managed to read something from the device.
I'm using cacti 1.2.26 +ds1-1 ubuntu and cacti-spine 1.2.25-1build2 installed with synaptic
This is what I get on the screen where I get something:
Total: 0.000000, Delta: 0.000000, Data query XML file found at '/usr/share/cacti/site/resource/snmp_queries/interface.xml'
Total: 0.000000, Delta: 0.000000, Running Data Query [13].
Total: 0.000000, Delta: 0.000000, Found type = '3' [SNMP Query].
Total: 0.000000, Delta: 0.000000, Parsing XML file ok.
Total: 0.000000, Delta: 0.000000, Bulk Walk Size is fixed at 1.
Total: 0.010000, Delta: 0.010000, Running SNMP Get for NUM of indexes @ '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10' index count:
Total: 0.010000, Delta: 0.000000, Running SNMP Walk for list of indexes @ '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10' index count: 9
Total: 0.010000, Delta: 0.000000, Index found at OID: '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.1' value: '27.7'
Total: 0.010000, Delta: 0.000000, Index found on OID: '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.2' value: '28.8'
Total: 0.010000, Delta: 0.000000, Index found on OID: '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.3' value: '27.1'
Total: 0.010000, Delta: 0.000000, Index found on OID: '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.4' value: '28.0'
Total: 0.010000, Delta: 0.000000, Index found on OID: '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.5' value: '28.9'
Total: 0.010000, Delta: 0.000000, Index found on OID: '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.6' value: '40.0'
Total: 0.010000, Delta: 0.000000, Index found on OID: '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.7' value: '29.1'
Total: 0.010000, Delta: 0.000000, Index found on OID: '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.8' value: '26.4'
Total: 0.010000, Delta: 0.000000, Index found on OID: '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.9' value: '32.9'
Click to display the data query output for field 'ifIndex'
Click Click to show the data query output for the field 'ifOperStatus'
Click to show the data query output for the field 'ifAdminStatus'
Click to show the data query output for the field 'ifDescr'
Click to show the data query output for the field 'ifName'
Associated Data Queries
And this is its corresponding log:
2024-09-20 23:00:02 - SYSTEM MAINT STATS: Time:0.00
2024-09-20 23:00:02 - SYSTEM DSSTATS STATS: Time:0.00 Type:HOURLY
2024-09-20 23:00:02 - SYSTEM STATS: Time:1.2173 Method:spine Processes:1 Threads:1 Hosts:1 HostsPerProcess:1 DataSources:7 RRDsProcessed:7
2024-09-21 01:00:02 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] Time: 0.6165 s, Threads: 1, Devices: 2
2024-09-21 01:00:02 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Net-SNMP Close Completed
2024-09-21 01:00:02 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: MYSQL Free & Close Completed
2024-09-21 01:00:02 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Allocated Variable Memory Freed
2024-09-21 01:00:02 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: PHP Script Server Pipes Closed
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: SS[0] Script Server Shutdown Started
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Thread Cleanup Complete
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Closing Local Connection Pool ID 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:UPDATE poller_time SET end_time=NOW() WHERE poller_id=1 AND pid=77612
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:REPLACE INTO settings (name,value) VALUES ('date',NOW())
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: DTF: device = 1, host_id = 1, host_thread = 1, host_threads = 1, host_data_ids = 0, complete = 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] INFO: Thread complete for Device[enensys sfn] and 0 to 0 sources
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: DTF: device = 0, host_id = 0, host_thread = 1, host_threads = 1, host_data_ids = 0, complete = 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] INFO: Thread complete for Device[System Device] and 0 to 0 sources
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] The final count of Threads is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] Time: 0.5126 s, Threads: 1, Devices: 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Net-SNMP Close Completed
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: MYSQL Free & Close Completed
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Allocated Variable Memory Freed
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: PHP Script Server Pipes Closed
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Thread Cleanup Complete
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Closing Local Connection Pool ID 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:UPDATE poller_time SET end_time=NOW() WHERE poller_id=1 AND pid=77609
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:REPLACE INTO settings (name,value) VALUES ('date',NOW())
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [END] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [START] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: DTF: device = 0, host_id = 0, host_thread = 1, host_threads = 1, host_data_ids = 0, complete = 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] INFO: Thread complete for Device[System Device] and 0 to 0 sources
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [END] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [START] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] The final count of Threads is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Available Threads is 1 (0 outstanding)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Device[enensys sfn] HT[1] The Device Thread has cleaned up.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Device[enensys sfn] HT[1] DEBUG: HOST COMPLETE: About to Exit Device Polling Thread Function
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Freeing Local Pool ID 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: SQL:UPDATE host SET polling_time = 1726873201.488 - 1726873201.463 WHERE id = 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] Total Time: 0.014 Seconds
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: SQL:INSERT INTO poller_output (local_data_id, rrd_name, time, output) VALUES (1, 'snmp_oid', FROM_UNIXTIME(1726873201), 'U'),(2, 'polling_time', FROM_UNIXTIME(1726873201), '0.022'),(3, 'uptime', FROM_UNIXTIME(1726873201), '1468200'),(4, 'ping', FROM_UNIXTIME(1726873201), 'U'),(5, 'CPUUtil', FROM_UNIXTIME(1726873201), 'U'),(6, 'Input', FROM_UNIXTIME(1726873201), 'U'),(7, '', FROM_UNIXTIME(1726873201), 'Time:1.2344 Method:spine Processes:1 Threads:1 Hosts:1 HostsPerProcess:1 DataSources:7 RRDsProcessed:7') ON DUPLICATE KEY UPDATE output=VALUES(output)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Setting up writes to local database
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] DS[enensys sfn - Batery Voltage] Graphs[enensys sfn - Battery Voltage] TT[1.15] SNMP: v2: 10.5.120.101, dsname: Input, oid: .1.3.6.1.2.1.33.1.2.5.0, value: U
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] DS[enensys sfn - CPU Usage] Graphs[enensys sfn - CPU Usage (5 min.), enensys sfn - CPU Usage (5 min.)] TT[1.14] SNMP: v2: 10.5.120.101, dsname: CPUUtil, oid: .1.3.6.1.4.1.9148.3.2.1.1.1.0, value: U
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] DS[enensys sfn -] Graphs[enensys sfn -] TT[1.11] SNMP: v2: 10.5.120.101, dsname: snmp_oid, oid: 1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10, value: U
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] DS[Cacti Stats - Main Poller] Graphs[Cacti Stats - Main Poller Runtime] TT[0.53] SS[0] SERVER: /usr/share/cacti/site/scripts/ss_poller.php ss_poller, output: Time:1.2344 Method:spine Processes:1 Threads:1 Hosts:1 HostsPerProcess:1 DataSources:7 RRDsProcessed:7
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] DS[enensys sfn - Ping Host] Graphs[enensys sfn - Ping Latency] TT[3.78] SCRIPT: perl /usr/share/cacti/site/scripts/ping.pl '', output: U
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Available Scripts is 20 (0 outstanding)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Device[enensys sfn] DEBUG: The NIFTY POPEN returned the following File Descriptor 11
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] The executable is '/usr/bin/perl' in 'perl /usr/share/cacti/site/scripts/ping.pl '''
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] DS[enensys sfn - Uptime] Graphs[enensys sfn - Uptime] TT[0.31] SS[0] SERVER: /usr/share/cacti/site/scripts/ss_hstats.php ss_hstats '1' uptime, output: 1468200
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] DS[enensys sfn - Polling Time] Graphs[enensys sfn - Polling Time] TT[0.51] SS[0] SERVER: /usr/share/cacti/site/scripts/ss_hstats.php ss_hstats '1' polling_time, output: 0.022
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] INFO: SNMP Device '10.5.120.101:161' has a timeout of 1000000 (1000), with 3 retries
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] NOTE: There are '7' Polling Items for this Device
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: SQL:SELECT SQL_NO_CACHE 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, snmp_auth_protocol, snmp_priv_passphrase, snmp_priv_protocol, snmp_context, snmp_engine_id FROM poller_item WHERE host_id = 1 AND poller_id = 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] Device has no information for recache.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: SQL:SELECT SQL_NO_CACHE data_query_id, action, op, assert_value, arg1 FROM poller_reindex WHERE host_id = 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: SQL:UPDATE host SET status='3', status_event_count='0', status_fail_date=FROM_UNIXTIME(1970), status_rec_date=FROM_UNIXTIME(1970), status_last_error='Device did not respond to SNMP', min_time='0.577210', max_time='4.380000', cur_time='0.597950', avg_time='0.871979', total_polls='180', failed_polls='69', availability='61.6667', snmp_sysDescr='Linux enensys 3.14.32-epr #1 PREEMPT Fri Mar 4 14:09:43 CET 2016 armv5tel', snmp_sysObjectID='iso.3.6.1.4.1.8072.3.2.10', snmp_sysUpTimeInstance='1468200', snmp_sysContact='contact@enensys.com', snmp_sysName='enensys', snmp_sysLocation='Enensys, Rennes, France' WHERE id='1'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device [1] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.6.0'); [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.6.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.6.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.6.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.6.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.6.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.6.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.6.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.6.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device [1] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.6.0');
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device [1] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.5.0'); [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.5.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.5.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.5.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.5.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.5.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.5.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.5.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.5.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device [1] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.5.0');
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device [1] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.4.0'); [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.4.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.4.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.4.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.4.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.4.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.4.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.4.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.4.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device [1] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.4.0');
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDGB: Device[enensys sfn] poll_result = snmp_get(host, '.1.3.6.1.6.3.10.2.1.3.0'); [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.6.3.10.2.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.6.3.10.2.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.6.3.10.2.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.6.3.10.2.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.6.3.10.2.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.6.3.10.2.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.6.3.10.2.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.6.3.10.2.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device[enensys sfn] poll_result = snmp_get(host, '.1.3.6.1.6.3.10.2.1.3.0');
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDGB: Device[enensys sfn] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.3.0'); [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device[enensys sfn] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.3.0');
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device[enensys sfn] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.2.0'); [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.2.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.2.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.2.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.2.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.2.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.2.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.2.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.2.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device[enensys sfn] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.2.0');
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device[enensys sfn] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.1.0'); [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.1.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.1.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.1.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.1.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.1.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.1.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.1.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.1.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device[enensys sfn] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.1.0');
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] Updating Full System Information Table
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] Checking for System Information Update
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] SNMP Result: Device responded to SNMP
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: Entering SNMP Ping
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] INFO: SNMP Device '10.5.120.101:161' has a timeout of 1000000 (1000), with 3 retries
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] get_namebyhost(10.5.120.101) - No delimiter, assume full hostname
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] get_namebyhost(10.5.120.101) - Allocating name_t
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: SQL:SELECT SQL_NO_CACHE id, hostname, snmp_community, snmp_version, snmp_username, snmp_password, snmp_auth_protocol, snmp_priv_passphrase, snmp_priv_protocol, snmp_context, snmp_engine_id, snmp_port, snmp_timeout, max_oids, availability_method, ping_method, ping_port, ping_timeout, ping_retries, status, status_event_count, UNIX_TIMESTAMP(status_fail_date), UNIX_TIMESTAMP(status_rec_date), status_last_error, min_time, max_time, cur_time, avg_time, total_polls, failed_polls, availability, snmp_sysUpTimeInstance, snmp_sysDescr, snmp_sysObjectID, snmp_sysContact, snmp_sysName, snmp_sysLocation FROM host WHERE id = 1 AND deleted = ''
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Allocating Local Pool ID 0.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Checking Local Pool ID 0.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Traversing Local Connection Pool for free connection.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Device[enensys sfn] HT[1] In Poller, About to Start Polling
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] WARNING: Device[enensys sfn] polling sleeping while waiting for 1 Threads to End
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: DTS: device = 1, host_id = 1, host_thread = 1, host_threads = 1, host_data_ids = 0, complete = 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Available Threads is 0 (1 outstanding)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Valid Thread to be Created (134869306836672)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Available Threads is 1 (0 outstanding)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Device[System Device] HT[1] The Device Thread has cleaned up.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Device[System Device] HT[1] DEBUG: HOST COMPLETE: About to Exit Device Polling Thread Function
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Freeing Local Pool ID 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: SQL:UPDATE host SET polling_time = 1726873201.464 - 1726873201.463 WHERE id = 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[System Device] HT[1] Total Time: 0.00032 Seconds
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: SQL:SELECT SQL_NO_CACHE 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, snmp_auth_protocol, snmp_priv_passphrase, snmp_priv_protocol, snmp_context, snmp_engine_id FROM poller_item WHERE host_id = 0 AND poller_id = 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for pool
I have installed the version of cacti on windows and on ubuntu, I have spent 2.5 days on each version, I have read quite a bit in a language that is not my own, and I am about to throw in the towel.
The only light I have managed to get has been editing usr/share/cacti/site/resource/snmp_queries/interface.xml and replacing its first 2 oids with the oids that interest me, only then have I managed to read something from the device.
I'm using cacti 1.2.26 +ds1-1 ubuntu and cacti-spine 1.2.25-1build2 installed with synaptic
This is what I get on the screen where I get something:
Total: 0.000000, Delta: 0.000000, Data query XML file found at '/usr/share/cacti/site/resource/snmp_queries/interface.xml'
Total: 0.000000, Delta: 0.000000, Running Data Query [13].
Total: 0.000000, Delta: 0.000000, Found type = '3' [SNMP Query].
Total: 0.000000, Delta: 0.000000, Parsing XML file ok.
Total: 0.000000, Delta: 0.000000, Bulk Walk Size is fixed at 1.
Total: 0.010000, Delta: 0.010000, Running SNMP Get for NUM of indexes @ '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10' index count:
Total: 0.010000, Delta: 0.000000, Running SNMP Walk for list of indexes @ '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10' index count: 9
Total: 0.010000, Delta: 0.000000, Index found at OID: '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.1' value: '27.7'
Total: 0.010000, Delta: 0.000000, Index found on OID: '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.2' value: '28.8'
Total: 0.010000, Delta: 0.000000, Index found on OID: '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.3' value: '27.1'
Total: 0.010000, Delta: 0.000000, Index found on OID: '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.4' value: '28.0'
Total: 0.010000, Delta: 0.000000, Index found on OID: '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.5' value: '28.9'
Total: 0.010000, Delta: 0.000000, Index found on OID: '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.6' value: '40.0'
Total: 0.010000, Delta: 0.000000, Index found on OID: '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.7' value: '29.1'
Total: 0.010000, Delta: 0.000000, Index found on OID: '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.8' value: '26.4'
Total: 0.010000, Delta: 0.000000, Index found on OID: '.1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.9' value: '32.9'
Click to display the data query output for field 'ifIndex'
Click Click to show the data query output for the field 'ifOperStatus'
Click to show the data query output for the field 'ifAdminStatus'
Click to show the data query output for the field 'ifDescr'
Click to show the data query output for the field 'ifName'
Associated Data Queries
And this is its corresponding log:
2024-09-20 23:00:02 - SYSTEM MAINT STATS: Time:0.00
2024-09-20 23:00:02 - SYSTEM DSSTATS STATS: Time:0.00 Type:HOURLY
2024-09-20 23:00:02 - SYSTEM STATS: Time:1.2173 Method:spine Processes:1 Threads:1 Hosts:1 HostsPerProcess:1 DataSources:7 RRDsProcessed:7
2024-09-21 01:00:02 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] Time: 0.6165 s, Threads: 1, Devices: 2
2024-09-21 01:00:02 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Net-SNMP Close Completed
2024-09-21 01:00:02 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: MYSQL Free & Close Completed
2024-09-21 01:00:02 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Allocated Variable Memory Freed
2024-09-21 01:00:02 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: PHP Script Server Pipes Closed
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: SS[0] Script Server Shutdown Started
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Thread Cleanup Complete
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Closing Local Connection Pool ID 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:UPDATE poller_time SET end_time=NOW() WHERE poller_id=1 AND pid=77612
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:REPLACE INTO settings (name,value) VALUES ('date',NOW())
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: DTF: device = 1, host_id = 1, host_thread = 1, host_threads = 1, host_data_ids = 0, complete = 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] INFO: Thread complete for Device[enensys sfn] and 0 to 0 sources
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: DTF: device = 0, host_id = 0, host_thread = 1, host_threads = 1, host_data_ids = 0, complete = 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] INFO: Thread complete for Device[System Device] and 0 to 0 sources
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] The final count of Threads is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] Time: 0.5126 s, Threads: 1, Devices: 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Net-SNMP Close Completed
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: MYSQL Free & Close Completed
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Allocated Variable Memory Freed
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: PHP Script Server Pipes Closed
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Thread Cleanup Complete
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Closing Local Connection Pool ID 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:UPDATE poller_time SET end_time=NOW() WHERE poller_id=1 AND pid=77609
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:REPLACE INTO settings (name,value) VALUES ('date',NOW())
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [END] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [START] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: DTF: device = 0, host_id = 0, host_thread = 1, host_threads = 1, host_data_ids = 0, complete = 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] INFO: Thread complete for Device[System Device] and 0 to 0 sources
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [END] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [START] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] The final count of Threads is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Available Threads is 1 (0 outstanding)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Device[enensys sfn] HT[1] The Device Thread has cleaned up.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Device[enensys sfn] HT[1] DEBUG: HOST COMPLETE: About to Exit Device Polling Thread Function
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Freeing Local Pool ID 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: SQL:UPDATE host SET polling_time = 1726873201.488 - 1726873201.463 WHERE id = 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] Total Time: 0.014 Seconds
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: SQL:INSERT INTO poller_output (local_data_id, rrd_name, time, output) VALUES (1, 'snmp_oid', FROM_UNIXTIME(1726873201), 'U'),(2, 'polling_time', FROM_UNIXTIME(1726873201), '0.022'),(3, 'uptime', FROM_UNIXTIME(1726873201), '1468200'),(4, 'ping', FROM_UNIXTIME(1726873201), 'U'),(5, 'CPUUtil', FROM_UNIXTIME(1726873201), 'U'),(6, 'Input', FROM_UNIXTIME(1726873201), 'U'),(7, '', FROM_UNIXTIME(1726873201), 'Time:1.2344 Method:spine Processes:1 Threads:1 Hosts:1 HostsPerProcess:1 DataSources:7 RRDsProcessed:7') ON DUPLICATE KEY UPDATE output=VALUES(output)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Setting up writes to local database
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] DS[enensys sfn - Batery Voltage] Graphs[enensys sfn - Battery Voltage] TT[1.15] SNMP: v2: 10.5.120.101, dsname: Input, oid: .1.3.6.1.2.1.33.1.2.5.0, value: U
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] DS[enensys sfn - CPU Usage] Graphs[enensys sfn - CPU Usage (5 min.), enensys sfn - CPU Usage (5 min.)] TT[1.14] SNMP: v2: 10.5.120.101, dsname: CPUUtil, oid: .1.3.6.1.4.1.9148.3.2.1.1.1.0, value: U
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] DS[enensys sfn -] Graphs[enensys sfn -] TT[1.11] SNMP: v2: 10.5.120.101, dsname: snmp_oid, oid: 1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10, value: U
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] DS[Cacti Stats - Main Poller] Graphs[Cacti Stats - Main Poller Runtime] TT[0.53] SS[0] SERVER: /usr/share/cacti/site/scripts/ss_poller.php ss_poller, output: Time:1.2344 Method:spine Processes:1 Threads:1 Hosts:1 HostsPerProcess:1 DataSources:7 RRDsProcessed:7
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] DS[enensys sfn - Ping Host] Graphs[enensys sfn - Ping Latency] TT[3.78] SCRIPT: perl /usr/share/cacti/site/scripts/ping.pl '', output: U
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Available Scripts is 20 (0 outstanding)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Device[enensys sfn] DEBUG: The NIFTY POPEN returned the following File Descriptor 11
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] The executable is '/usr/bin/perl' in 'perl /usr/share/cacti/site/scripts/ping.pl '''
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] DS[enensys sfn - Uptime] Graphs[enensys sfn - Uptime] TT[0.31] SS[0] SERVER: /usr/share/cacti/site/scripts/ss_hstats.php ss_hstats '1' uptime, output: 1468200
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] DS[enensys sfn - Polling Time] Graphs[enensys sfn - Polling Time] TT[0.51] SS[0] SERVER: /usr/share/cacti/site/scripts/ss_hstats.php ss_hstats '1' polling_time, output: 0.022
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] INFO: SNMP Device '10.5.120.101:161' has a timeout of 1000000 (1000), with 3 retries
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] NOTE: There are '7' Polling Items for this Device
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: SQL:SELECT SQL_NO_CACHE 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, snmp_auth_protocol, snmp_priv_passphrase, snmp_priv_protocol, snmp_context, snmp_engine_id FROM poller_item WHERE host_id = 1 AND poller_id = 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] HT[1] Device has no information for recache.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: SQL:SELECT SQL_NO_CACHE data_query_id, action, op, assert_value, arg1 FROM poller_reindex WHERE host_id = 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: SQL:UPDATE host SET status='3', status_event_count='0', status_fail_date=FROM_UNIXTIME(1970), status_rec_date=FROM_UNIXTIME(1970), status_last_error='Device did not respond to SNMP', min_time='0.577210', max_time='4.380000', cur_time='0.597950', avg_time='0.871979', total_polls='180', failed_polls='69', availability='61.6667', snmp_sysDescr='Linux enensys 3.14.32-epr #1 PREEMPT Fri Mar 4 14:09:43 CET 2016 armv5tel', snmp_sysObjectID='iso.3.6.1.4.1.8072.3.2.10', snmp_sysUpTimeInstance='1468200', snmp_sysContact='contact@enensys.com', snmp_sysName='enensys', snmp_sysLocation='Enensys, Rennes, France' WHERE id='1'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device [1] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.6.0'); [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.6.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.6.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.6.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.6.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.6.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.6.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.6.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.6.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device [1] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.6.0');
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device [1] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.5.0'); [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.5.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.5.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.5.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.5.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.5.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.5.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.5.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.5.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device [1] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.5.0');
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device [1] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.4.0'); [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.4.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.4.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.4.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.4.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.4.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.4.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.4.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.4.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device [1] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.4.0');
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDGB: Device[enensys sfn] poll_result = snmp_get(host, '.1.3.6.1.6.3.10.2.1.3.0'); [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.6.3.10.2.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.6.3.10.2.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.6.3.10.2.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.6.3.10.2.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.6.3.10.2.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.6.3.10.2.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.6.3.10.2.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.6.3.10.2.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device[enensys sfn] poll_result = snmp_get(host, '.1.3.6.1.6.3.10.2.1.3.0');
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDGB: Device[enensys sfn] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.3.0'); [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device[enensys sfn] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.3.0');
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device[enensys sfn] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.2.0'); [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.2.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.2.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.2.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.2.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.2.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.2.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.2.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.2.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device[enensys sfn] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.2.0');
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device[enensys sfn] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.1.0'); [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.1.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.1.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.1.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.1.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.1.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.1.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.1.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.1.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: Device[enensys sfn] poll_result = snmp_get(host, '.1.3.6.1.2.1.1.1.0');
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] Updating Full System Information Table
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] Checking for System Information Update
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] SNMP Result: Device responded to SNMP
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_sess_sync_response(.1.3.6.1.2.1.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_add_null_var(.1.3.6.1.2.1.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_parse_oid(.1.3.6.1.2.1.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.3.0) [complete]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: snmp_pdu_create(.1.3.6.1.2.1.1.3.0)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] DEBUG: Entering SNMP Ping
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[enensys sfn] INFO: SNMP Device '10.5.120.101:161' has a timeout of 1000000 (1000), with 3 retries
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] get_namebyhost(10.5.120.101) - No delimiter, assume full hostname
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] get_namebyhost(10.5.120.101) - Allocating name_t
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: SQL:SELECT SQL_NO_CACHE id, hostname, snmp_community, snmp_version, snmp_username, snmp_password, snmp_auth_protocol, snmp_priv_passphrase, snmp_priv_protocol, snmp_context, snmp_engine_id, snmp_port, snmp_timeout, max_oids, availability_method, ping_method, ping_port, ping_timeout, ping_retries, status, status_event_count, UNIX_TIMESTAMP(status_fail_date), UNIX_TIMESTAMP(status_rec_date), status_last_error, min_time, max_time, cur_time, avg_time, total_polls, failed_polls, availability, snmp_sysUpTimeInstance, snmp_sysDescr, snmp_sysObjectID, snmp_sysContact, snmp_sysName, snmp_sysLocation FROM host WHERE id = 1 AND deleted = ''
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Allocating Local Pool ID 0.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Checking Local Pool ID 0.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Traversing Local Connection Pool for free connection.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Device[enensys sfn] HT[1] In Poller, About to Start Polling
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] WARNING: Device[enensys sfn] polling sleeping while waiting for 1 Threads to End
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: DTS: device = 1, host_id = 1, host_thread = 1, host_threads = 1, host_data_ids = 0, complete = 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Available Threads is 0 (1 outstanding)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Valid Thread to be Created (134869306836672)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Available Threads is 1 (0 outstanding)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Device[System Device] HT[1] The Device Thread has cleaned up.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Device[System Device] HT[1] DEBUG: HOST COMPLETE: About to Exit Device Polling Thread Function
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Freeing Local Pool ID 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: SQL:UPDATE host SET polling_time = 1726873201.464 - 1726873201.463 WHERE id = 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] Device[System Device] HT[1] Total Time: 0.00032 Seconds
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEVDBG: SQL:SELECT SQL_NO_CACHE 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, snmp_auth_protocol, snmp_priv_passphrase, snmp_priv_protocol, snmp_context, snmp_engine_id FROM poller_item WHERE host_id = 0 AND poller_id = 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for pool
Last edited by xugmu on Sat Sep 21, 2024 12:11 pm, edited 2 times in total.
Re: Please I've been trying to make a simple SNMP graph for 5 days
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Allocating Local Pool ID 0.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Checking Local Pool ID 0.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Traversing Local Connection Pool for free connection.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Device[System Device] HT[1] In Poller, About to Start Polling
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE COUNT(local_data_id) FROM poller_item WHERE host_id=1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: DTS: device = 0, host_id = 0, host_thread = 1, host_threads = 1, host_data_ids = 0, complete = 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Available Threads is 0 (1 outstanding)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Valid Thread to be Created (134869306836672)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE COUNT(local_data_id) FROM poller_item WHERE host_id=0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Initial Value of Available Threads is 1 (0 outstanding)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_14
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_13
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_12
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_11
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_10
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_9
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_8
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_7
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_6
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_5
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_4
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_3
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for syslog
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for ghbn
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for seteuid
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:INSERT INTO poller_time (poller_id, pid, start_time, end_time) VALUES (1, 77612, NOW(), '0000-00-00 00:00:00')
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE id, device_threads, picount, picount/device_threads AS tppi FROM host INNER JOIN (SELECT host_id, COUNT(*) AS picount FROM poller_item GROUP BY host_id) AS pi ON host.id = pi.host_id WHERE disabled = '' AND id BETWEEN 1 AND 1 AND host.poller_id = 1 ORDER BY picount DESC
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SHOW COLUMNS FROM host LIKE 'poller_id'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: SS[0] Confirmed PHP Script Server running using readfd[10], writefd[9]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: SS[0] PHP Script Server Child FORK Success
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: SS[0] PHP Script Server About to FORK Child Process
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: SS[0] PHP Script Server Routine Starting
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Initializing PHP Script Server(s)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Issues with SNMP Header Version information, assuming old version of Net-SNMP.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Initializing Net-SNMP API
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Spine has got ICMP
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Spine has cap_net_raw capability.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Capability CAP_NET_RAW is set.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'ONLY_FULL_GROUP_BY', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'NO_ZERO_DATE', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'STRICT_TRANS_TABLES', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'STRICT_ALL_TABLES', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'TRADITIONAL', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'NO_AUTO_VALUE_ON_ZERO', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'ONLY_FULL_GROUP_BY', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'NO_ZERO_IN_DATE', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'NO_ZERO_DATE', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Total Connections made 2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Creating Local Connection 0.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Creating Local Connection Pool of 1 threads.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Total Connections made 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Selective Debug Devices 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:INSERT INTO settings (name, value) VALUES ('spine_capabilities', '{ authProtocols: "MD5,SHA", privProtocols: "DES,AES128" }') ON DUPLICATE KEY UPDATE value = VALUES(value)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The Maximum SNMP OID Get Size is 10
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'max_get_size'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The PHP Script Server is Required
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: StartDevice='1', EndDevice='1', TotalPHPScripts='1'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE action FROM poller_item WHERE action=2 AND host_id BETWEEN 1 AND 1 LIMIT 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The number of snmp ports on the system is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'total_snmp_ports'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The number of active data source profiles is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'active_profiles'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The number of php script servers to run is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'php_servers'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The spine_log_level variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'spine_log_level'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The selective_device_debug variable is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'selective_device_debug'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The script timeout is 25
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'script_timeout'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The number of concurrent processes is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'concurrent_processes'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The polling interval is 300 seconds
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'poller_interval'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The threads variable is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE threads FROM poller WHERE id = '1'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The log_pstats variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'log_pstats'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The boost_rrd_update_enable variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'boost_rrd_update_enable'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The boost_redirect variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'boost_redirect'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The log_pwarn variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'log_pwarn'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The log_perror variable is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'log_perror'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The snmp_retries variable is 3
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'snmp_retries'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The ping_timeout variable is 400
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_timeout'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The ping_retries variable is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_retries'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The ping_method variable is 2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_method'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The ping_failure_count variable is 2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_failure_count'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The ping_recovery_count variable is 3
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_recovery_count'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The availability_method variable is 2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'availability_method'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The path_php variable is /usr/bin/php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'path_php_binary'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEBUG: Available Threads is 1 (0 outstanding)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEBUG: Device[System Device] HT[1] The Device Thread has cleaned up.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEBUG: Device[System Device] HT[1] DEBUG: HOST COMPLETE: About to Exit Device Polling Thread Function
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [END] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [START] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEBUG: Freeing Local Pool ID 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [END] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [START] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [END] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [START] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEVDBG: SQL:UPDATE host SET polling_time = 1726873201.311 - 1726873201.310 WHERE id = 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [END] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [START] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] Device[System Device] HT[1] Total Time: 0.00024 Seconds
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEVDBG: SQL:SELECT SQL_NO_CACHE 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, snmp_auth_protocol, snmp_priv_passphrase, snmp_priv_protocol, snmp_context, snmp_engine_id FROM poller_item WHERE host_id = 0 AND poller_id = 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [END] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [START] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEBUG: Allocating Local Pool ID 0.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEBUG: Checking Local Pool ID 0.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEBUG: Traversing Local Connection Pool for free connection.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [END] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [START] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEBUG: Device[System Device] HT[1] In Poller, About to Start Polling
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [END] Mutex unlock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [RET] Returning lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [START] Mutex unlock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] WARNING: Device[System Device] polling sleeping while waiting for 1 Threads to End
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: DTS: device = 0, host_id = 0, host_thread = 1, host_threads = 1, host_data_ids = 0, complete = 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Available Threads is 0 (1 outstanding)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Valid Thread to be Created (133342934599360)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [END] Mutex lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [START] Mutex lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [END] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [START] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [END] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [START] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE COUNT(local_data_id) FROM poller_item WHERE host_id=0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Initial Value of Available Threads is 1 (0 outstanding)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_14
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_13
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_12
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_11
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_10
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_9
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_8
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_7
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_6
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_5
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_4
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_3
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for syslog
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for ghbn
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for seteuid
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:INSERT INTO poller_time (poller_id, pid, start_time, end_time) VALUES (1, 77609, NOW(), '0000-00-00 00:00:00')
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE id, device_threads, picount, picount/device_threads AS tppi FROM host INNER JOIN (SELECT host_id, COUNT(*) AS picount FROM poller_item GROUP BY host_id) AS pi ON host.id = pi.host_id WHERE disabled = '' AND id BETWEEN 0 AND 0 AND host.poller_id = 1 ORDER BY picount DESC
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SHOW COLUMNS FROM host LIKE 'poller_id'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Initializing PHP Script Server(s)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Issues with SNMP Header Version information, assuming old version of Net-SNMP.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Initializing Net-SNMP API
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Spine has got ICMP
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Spine has cap_net_raw capability.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Capability CAP_NET_RAW is set.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'ONLY_FULL_GROUP_BY', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'NO_ZERO_DATE', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'STRICT_TRANS_TABLES', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'STRICT_ALL_TABLES', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'TRADITIONAL', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'NO_AUTO_VALUE_ON_ZERO', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'ONLY_FULL_GROUP_BY', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'NO_ZERO_IN_DATE', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'NO_ZERO_DATE', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Total Connections made 2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Creating Local Connection 0.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Creating Local Connection Pool of 1 threads.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Total Connections made 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Selective Debug Devices 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:INSERT INTO settings (name, value) VALUES ('spine_capabilities', '{ authProtocols: "MD5,SHA", privProtocols: "DES,AES128" }') ON DUPLICATE KEY UPDATE value = VALUES(value)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The Maximum SNMP OID Get Size is 10
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'max_get_size'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The PHP Script Server is Not Required
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: StartDevice='0', EndDevice='0', TotalPHPScripts='0'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE action FROM poller_item WHERE action=2 AND host_id BETWEEN 0 AND 0 LIMIT 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The number of snmp ports on the system is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'total_snmp_ports'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The number of active data source profiles is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'active_profiles'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The number of php script servers to run is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'php_servers'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The spine_log_level variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'spine_log_level'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The selective_device_debug variable is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'selective_device_debug'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The script timeout is 25
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'script_timeout'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The number of concurrent processes is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'concurrent_processes'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The polling interval is 300 seconds
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'poller_interval'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The threads variable is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE threads FROM poller WHERE id = '1'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The log_pstats variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'log_pstats'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The boost_rrd_update_enable variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'boost_rrd_update_enable'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The boost_redirect variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'boost_redirect'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The log_pwarn variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'log_pwarn'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The log_perror variable is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'log_perror'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The snmp_retries variable is 3
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'snmp_retries'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The ping_timeout variable is 400
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_timeout'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The ping_retries variable is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_retries'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The ping_method variable is 2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_method'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The ping_failure_count variable is 2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_failure_count'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The ping_recovery_count variable is 3
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_recovery_count'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The availability_method variable is 2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'availability_method'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The path_php variable is /usr/bin/php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'path_php_binary'
2024-09-20 22:59:49 - WEBUI NOTE: Cacti Log file /var/log/cacti/cacti.log, Removed by user admin
2024-09-20 22:59:49 - WEBUI NOTE: Cacti Log Cleared from Web Management Interface.
best regards
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Checking Local Pool ID 0.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Traversing Local Connection Pool for free connection.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] DEBUG: Device[System Device] HT[1] In Poller, About to Start Polling
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [END] Mutex unlock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [RET] Returning lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869306836672] LOCKS: [START] Mutex unlock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE COUNT(local_data_id) FROM poller_item WHERE host_id=1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: DTS: device = 0, host_id = 0, host_thread = 1, host_threads = 1, host_data_ids = 0, complete = 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Available Threads is 0 (1 outstanding)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Valid Thread to be Created (134869306836672)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [END] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [START] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE COUNT(local_data_id) FROM poller_item WHERE host_id=0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Initial Value of Available Threads is 1 (0 outstanding)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_14
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_13
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_12
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_11
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_10
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_9
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_8
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_7
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_6
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_5
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_4
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_3
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for syslog
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for ghbn
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for seteuid
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] LOCKS: [RET] Returning attr for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:INSERT INTO poller_time (poller_id, pid, start_time, end_time) VALUES (1, 77612, NOW(), '0000-00-00 00:00:00')
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE id, device_threads, picount, picount/device_threads AS tppi FROM host INNER JOIN (SELECT host_id, COUNT(*) AS picount FROM poller_item GROUP BY host_id) AS pi ON host.id = pi.host_id WHERE disabled = '' AND id BETWEEN 1 AND 1 AND host.poller_id = 1 ORDER BY picount DESC
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SHOW COLUMNS FROM host LIKE 'poller_id'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: SS[0] Confirmed PHP Script Server running using readfd[10], writefd[9]
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: SS[0] PHP Script Server Child FORK Success
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: SS[0] PHP Script Server About to FORK Child Process
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: SS[0] PHP Script Server Routine Starting
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Initializing PHP Script Server(s)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Issues with SNMP Header Version information, assuming old version of Net-SNMP.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Initializing Net-SNMP API
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Spine has got ICMP
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Spine has cap_net_raw capability.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Capability CAP_NET_RAW is set.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'ONLY_FULL_GROUP_BY', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'NO_ZERO_DATE', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'STRICT_TRANS_TABLES', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'STRICT_ALL_TABLES', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'TRADITIONAL', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'NO_AUTO_VALUE_ON_ZERO', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'ONLY_FULL_GROUP_BY', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'NO_ZERO_IN_DATE', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'NO_ZERO_DATE', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Total Connections made 2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Creating Local Connection 0.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Creating Local Connection Pool of 1 threads.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Total Connections made 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: Selective Debug Devices 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:INSERT INTO settings (name, value) VALUES ('spine_capabilities', '{ authProtocols: "MD5,SHA", privProtocols: "DES,AES128" }') ON DUPLICATE KEY UPDATE value = VALUES(value)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The Maximum SNMP OID Get Size is 10
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'max_get_size'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The PHP Script Server is Required
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: StartDevice='1', EndDevice='1', TotalPHPScripts='1'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE action FROM poller_item WHERE action=2 AND host_id BETWEEN 1 AND 1 LIMIT 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The number of snmp ports on the system is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'total_snmp_ports'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The number of active data source profiles is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'active_profiles'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The number of php script servers to run is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'php_servers'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The spine_log_level variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'spine_log_level'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The selective_device_debug variable is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'selective_device_debug'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The script timeout is 25
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'script_timeout'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The number of concurrent processes is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'concurrent_processes'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The polling interval is 300 seconds
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'poller_interval'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The threads variable is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE threads FROM poller WHERE id = '1'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The log_pstats variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'log_pstats'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The boost_rrd_update_enable variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'boost_rrd_update_enable'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The boost_redirect variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'boost_redirect'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The log_pwarn variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'log_pwarn'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The log_perror variable is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'log_perror'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The snmp_retries variable is 3
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'snmp_retries'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The ping_timeout variable is 400
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_timeout'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The ping_retries variable is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_retries'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The ping_method variable is 2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_method'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The ping_failure_count variable is 2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_failure_count'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The ping_recovery_count variable is 3
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_recovery_count'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The availability_method variable is 2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'availability_method'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEBUG: The path_php variable is /usr/bin/php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77612] PT[134869345150400] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'path_php_binary'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEBUG: Available Threads is 1 (0 outstanding)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEBUG: Device[System Device] HT[1] The Device Thread has cleaned up.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEBUG: Device[System Device] HT[1] DEBUG: HOST COMPLETE: About to Exit Device Polling Thread Function
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [END] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [START] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEBUG: Freeing Local Pool ID 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [END] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [START] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [END] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [START] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEVDBG: SQL:UPDATE host SET polling_time = 1726873201.311 - 1726873201.310 WHERE id = 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [END] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [START] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] Device[System Device] HT[1] Total Time: 0.00024 Seconds
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEVDBG: SQL:SELECT SQL_NO_CACHE 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, snmp_auth_protocol, snmp_priv_passphrase, snmp_priv_protocol, snmp_context, snmp_engine_id FROM poller_item WHERE host_id = 0 AND poller_id = 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [END] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [START] Mutex unlock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEBUG: Allocating Local Pool ID 0.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEBUG: Checking Local Pool ID 0.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEBUG: Traversing Local Connection Pool for free connection.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [END] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [RET] Returning lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [START] Mutex lock for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] DEBUG: Device[System Device] HT[1] In Poller, About to Start Polling
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [END] Mutex unlock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [RET] Returning lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342934599360] LOCKS: [START] Mutex unlock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] WARNING: Device[System Device] polling sleeping while waiting for 1 Threads to End
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: DTS: device = 0, host_id = 0, host_thread = 1, host_threads = 1, host_data_ids = 0, complete = 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Available Threads is 0 (1 outstanding)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Valid Thread to be Created (133342934599360)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [END] Mutex lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [START] Mutex lock for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [END] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [START] Mutex unlock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [END] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [START] Mutex lock for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE COUNT(local_data_id) FROM poller_item WHERE host_id=0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Initial Value of Available Threads is 1 (0 outstanding)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for host_time
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for thdet
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_14
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_13
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_12
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_11
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_10
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_9
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_8
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_7
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_6
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_5
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_4
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_3
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php_proc_0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for syslog
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for pool
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for ghbn
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for seteuid
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] LOCKS: [RET] Returning attr for snmp
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:INSERT INTO poller_time (poller_id, pid, start_time, end_time) VALUES (1, 77609, NOW(), '0000-00-00 00:00:00')
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE id, device_threads, picount, picount/device_threads AS tppi FROM host INNER JOIN (SELECT host_id, COUNT(*) AS picount FROM poller_item GROUP BY host_id) AS pi ON host.id = pi.host_id WHERE disabled = '' AND id BETWEEN 0 AND 0 AND host.poller_id = 1 ORDER BY picount DESC
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SHOW COLUMNS FROM host LIKE 'poller_id'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Initializing PHP Script Server(s)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Issues with SNMP Header Version information, assuming old version of Net-SNMP.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Initializing Net-SNMP API
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Spine has got ICMP
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Spine has cap_net_raw capability.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Capability CAP_NET_RAW is set.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'ONLY_FULL_GROUP_BY', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'NO_ZERO_DATE', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'STRICT_TRANS_TABLES', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'STRICT_ALL_TABLES', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'TRADITIONAL', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'NO_AUTO_VALUE_ON_ZERO', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'ONLY_FULL_GROUP_BY', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'NO_ZERO_IN_DATE', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SET SESSION sql_mode = (SELECT REPLACE(@@sql_mode,'NO_ZERO_DATE', ''))
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Total Connections made 2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Creating Local Connection 0.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Creating Local Connection Pool of 1 threads.
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Total Connections made 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: Selective Debug Devices 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:INSERT INTO settings (name, value) VALUES ('spine_capabilities', '{ authProtocols: "MD5,SHA", privProtocols: "DES,AES128" }') ON DUPLICATE KEY UPDATE value = VALUES(value)
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The Maximum SNMP OID Get Size is 10
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'max_get_size'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The PHP Script Server is Not Required
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: StartDevice='0', EndDevice='0', TotalPHPScripts='0'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE action FROM poller_item WHERE action=2 AND host_id BETWEEN 0 AND 0 LIMIT 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The number of snmp ports on the system is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'total_snmp_ports'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The number of active data source profiles is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'active_profiles'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The number of php script servers to run is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'php_servers'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The spine_log_level variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'spine_log_level'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The selective_device_debug variable is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'selective_device_debug'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The script timeout is 25
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'script_timeout'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The number of concurrent processes is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'concurrent_processes'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The polling interval is 300 seconds
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'poller_interval'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The threads variable is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE threads FROM poller WHERE id = '1'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The log_pstats variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'log_pstats'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The boost_rrd_update_enable variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'boost_rrd_update_enable'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The boost_redirect variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'boost_redirect'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The log_pwarn variable is 0
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'log_pwarn'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The log_perror variable is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'log_perror'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The snmp_retries variable is 3
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'snmp_retries'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The ping_timeout variable is 400
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_timeout'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The ping_retries variable is 1
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_retries'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The ping_method variable is 2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_method'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The ping_failure_count variable is 2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_failure_count'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The ping_recovery_count variable is 3
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'ping_recovery_count'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The availability_method variable is 2
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'availability_method'
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEBUG: The path_php variable is /usr/bin/php
2024-09-21 01:00:01 - SPINE: Poller[Main Poller] PID[77609] PT[133342964401600] DEVDBG: SQL:SELECT SQL_NO_CACHE value FROM settings WHERE name = 'path_php_binary'
2024-09-20 22:59:49 - WEBUI NOTE: Cacti Log file /var/log/cacti/cacti.log, Removed by user admin
2024-09-20 22:59:49 - WEBUI NOTE: Cacti Log Cleared from Web Management Interface.
best regards
Re: I can't get cacti to render snmp graphics
Try to explain to us, what you need, which values you need add to graph
Let the Cacti grow!
Re: I can't get cacti to render snmp graphics
Thanks for the reply. The values I need to add to the graphs are positive numbers with a decimal, negative numbers with a decimal and numbers with a scientific expression such as 4.5e-3. The ping and uptime values are well represented in their respective graphs.The device is an edgeprobe from the enensys brand.
Re: I can't get cacti to render snmp graphics
please show any screenshot where ping and uptime values are in requested format
Let the Cacti grow!
Re: I can't get cacti to render snmp graphics
I have been looking at ping and uptime graphs for the last few days, but today I am trying to move forward. I have uninstalled Cacti and installed it again on Ubuntu. Although I am trying to use templates to try to move forward a bit, the result is frustrating.
It is a very easy device to ask for data and it responds well. I would appreciate step-by-step help to simply get two or three real-time graphs of OID values.
Best regards
It is a very easy device to ask for data and it responds well. I would appreciate step-by-step help to simply get two or three real-time graphs of OID values.
Best regards
Re: I can't get cacti to render snmp graphics
Hi, Macan,I don't know if it is in the requested format but this is something I have been able to get.
- Attachments
-
- Captura desde 2024-09-24 20-41-13.png (189.92 KiB) Viewed 600 times
Re: I can't get cacti to render snmp graphics
if you need graph single OID, here is howto
https://docs.cacti.net/Graph-a-Single-SNMP-OID.md
https://docs.cacti.net/Graph-a-Single-SNMP-OID.md
Let the Cacti grow!
Re: I can't get cacti to render snmp graphics
I have done what that page says and the result is very similar to what I got before. It calls my attention that, although I enter the OID that I need in SNMP - Generic OID Template, the device returns me a result of an OID that I have not requested.It gives me the impression that the program is not creating XML files with my data and the results that I get are from the XML files that the program brings by default. I attach an image of the device.
- Attachments
-
- Captura desde 2024-09-26 15-04-09.png (201.46 KiB) Viewed 506 times
-
- Captura desde 2024-09-26 15-04-24.png (243.9 KiB) Viewed 506 times
Re: I can't get cacti to render snmp graphics
The result of a request Net-SNMP - Get Device I/O :
- Attachments
-
- Captura desde 2024-09-26 16-04-13.png (233 KiB) Viewed 506 times
Re: I can't get cacti to render snmp graphics
It seems that you are trying monitor any linux machine. Is it right? You are using net-snmp template which contains a lot of data queries and graph templates. But your device doesn't respond these queries. Check my screenshot - you have to have not zeros here.
Maybe your snmp is configured incorrectly and doesn't return requested data.
Try from your cacti server snmp walk
snmpwalk -c your_community -v2c 10.5.120.101 .1.3.6.1.2.1.2
Maybe your snmp is configured incorrectly and doesn't return requested data.
Try from your cacti server snmp walk
snmpwalk -c your_community -v2c 10.5.120.101 .1.3.6.1.2.1.2
- Attachments
-
- cacti_queries.png (50.65 KiB) Viewed 481 times
Let the Cacti grow!
Re: I can't get cacti to render snmp graphics
I understand what you mean with your screenshot, I must be doing something wrong when the template doesn't return any results. I'll keep investigating there.
juan@juan-HP-Desktop-M01-F1xxx:~/Escritorio$ snmpwalk -c public -v2c 10.5.120.101 .1.3.6.1.2.1.2
iso.3.6.1.2.1.2 = No Such Object available on this agent at this OID
juan@juan-HP-Desktop-M01-F1xxx:~/Escritorio$ snmpwalk -c public -v2c 10.5.120.101 .1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10
iso.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.1 = STRING: "30.2"
juan@juan-HP-Desktop-M01-F1xxx:~/Escritorio$ snmpwalk -c public -v2c 10.5.120.101 .1.3.6.1.2.1.2
iso.3.6.1.2.1.2 = No Such Object available on this agent at this OID
juan@juan-HP-Desktop-M01-F1xxx:~/Escritorio$ snmpwalk -c public -v2c 10.5.120.101 .1.3.6.1.4.1.23986.14.1.2.1.1.1.1.10
iso.3.6.1.4.1.23986.14.1.2.1.1.1.1.10.1 = STRING: "30.2"
Re: I can't get cacti to render snmp graphics
This OID is for NIC information:
iso.3.6.1.2.1.2 = No Such Object available on this agent at this OID - No data returned, so cacti cannot graph anything about NIC
1) possible misconfiguration of snmpd configuration.
2) your device hasn't information about NICs in snmp
Example of configuration from centos 8:
/etc/snmp/snmpd.conf:
rocommunity public
iso.3.6.1.2.1.2 = No Such Object available on this agent at this OID - No data returned, so cacti cannot graph anything about NIC
1) possible misconfiguration of snmpd configuration.
2) your device hasn't information about NICs in snmp
Example of configuration from centos 8:
/etc/snmp/snmpd.conf:
rocommunity public
Let the Cacti grow!
Who is online
Users browsing this forum: No registered users and 0 guests