From Perl Cockroach, 7 Years ago, written in DOS.
This paste is a reply to Re: Untitled from Violet Penguin - go back
Embed
Viewing differences between Re: Untitled and poller debug
LibreNMS Discovery
Poller
Version info:
Commit SHA: d8fcdc9ae3cf7a5cdafca865c9ada7551f85a03f
Commit Date: 1492555376
DB Schema: 185
PHP: 7.0.8-0ubuntu0.16.04.1
MySQL: 10.0.25-MariaDB-0ubuntu0.16.04.1
RRDTool: 1.5.5
SNMP: NET-SNMP 5.7.3
DEBUG!
SQL[[0;33mSELECT version FROM `dbSchema` ORDER BY version DESC LIMIT 1[0m] 
DB Schema already up to date.
Starting polling run:

SQL[[0;33mSELECT * FROM `devices` WHERE status = 1 AND disabled `disabled` = 0 AND `hostname` LIKE '3.3.3.3' ORDER BY device_id DESC[0m] 
`device_id` ASC[0m] 
SQL[[0;33mSELECT * FROM devices_attribs WHERE `device_id` = '94'[0m] 
Hostname: 3.3.3.3.3 94 enterasys 3
Device ID: 94
OS: enterasys

SQL[[0;33mINSERT INTO `device_perf` (`xmt`,`rcv`,`loss`,`min`,`max`,`avg`,`device_id`,`timestamp`)  VALUES ('5','5','0','27.2','32.6','29.('5','5','0','26.9','28.1','27.6','94',NOW())[0m] 
SNMP Check response code: 0

0
SNMP[[0;36m/usr/bin/snmpget -v2c -c COMMUNITY -OQnUst -m SNMPv2-MIB:HOST-RESOURCES-MIB:SNMP-FRAMEWORK-MIB -M /opt/librenms/mibs:/opt/librenms/mibs/enterasys udp:HOSTNAME:161 sysUpTime.0 sysLocation.0 sysContact.0 sysName.0 sysObjectID.0[0m]
sysUpTime.0 = 563036140
sysLocation.0 = Xenon
sysContact.0 = 
sysName.0 = Xenon XEN Core SW
sysObjectID.0 = enterprises.56*

SNMP[[0;36m/usr/bin/snmpget -v2c -c COMMUNITY -OvQ -m SNMPv2-MIB:HOST-RESOURCES-MIB:SNMP-FRAMEWORK-MIB -M /opt/librenms/mibs:/opt/librenms/mibs/enterasys udp:HOSTNAME:161 sysDescr.0[0m]
Enterasys Networks, Inc. N3 Chassis Rev *7 02/28/2012--11:59 ofc

SNMP[[0;36m/usr/bin/snmpget -v2c -c COMMUNITY -OQnUst -m HOST-RESOURCES-MIB:SNMP-FRAMEWORK-MIB -M /opt/librenms/mibs:/opt/librenms/mibs/enterasys udp:HOSTNAME:161 snmpEngineTime.0 hrSystemUptime.0[0m]
snmpEngineTime.0 = 5630361
hrSystemUptime.0 = No Such Object available on this agent at this OID

Using SNMP Agent Uptime (5630361s)
  RRD[[0;32mupdate 3.3.3.3/uptime.rrd N:5630361 --daemon unix:/var/run/rrdcached.sock[0m]
[[0;31mRRD Disabled[0m]Uptime: 65 days, 3h 59m 21s
SQL[[0;33mSELECT `lat`,`lng` FROM `locations` WHERE `location`='Xenon' LIMIT 1[0m] 
Google geocode engine being used
Bad lat / lng received
Modules status: Global+ OS  Device  
#### Load disco poller module mempools ####
SQL[[0;33mSELECT COUNT(*) FROM `mempools` mempools WHERE `device_id` device_id '94' AND `mempool_type` = 'cemp'[0m] 
SNMP[[0;36m/usr/bin/snmpbulkwalk 
'94'[0m] 
Mempool RAM device 1: SNMP[[0;36m/usr/bin/snmpget 
-v2c -c COMMUNITY  -OQUs COMMUNITY -OvQ -m ENTERASYS-RESOURCE-UTILIZATION-MIB -M /opt/librenms/mibs:/opt/librenms/mibs/enterasys udp:HOSTNAME:161 etsysResourceStorageTable[0m]
etsysResourceStorageDescr.
etsysResourceStorageAvailable.10011001.ram.1 = RAM device 1
etsysResourceStorageDescr.
1[0m]
36474

SNMP[[0;36m/usr/bin/snmpget -v2c -c COMMUNITY -OvQ -m ENTERASYS-RESOURCE-UTILIZATION-MIB -M /opt/librenms/mibs:/opt/librenms/mibs/enterasys udp:HOSTNAME:161 etsysResourceStorageSize.
10011001.flash.1 ram.1[0m]
262144

86.09% RRD[[0;32mupdate 3.3.3.3/mempool-enterasys-10011001.rrd N:231086080:37349376 --daemon unix:/var/run/rrdcached.sock[0m]
[[0;31mRRD Disabled[0m]SQL[[0;33mUPDATE `mempools` set `mempool_used` ='231086080',`mempool_perc` ='86.09',`mempool_free` ='37349376',`mempool_total` ='268435456' WHERE `mempool_id` 
Images & Miscellaneous
etsysResourceStorageDescr.10011001.flash.2 = Nonvolatile Data Storage
etsysResourceStorageDescr.
'136'[0m] 

Mempool RAM device 1: SNMP[[0;36m/usr/bin/snmpget -v2c -c COMMUNITY -OvQ -m ENTERASYS-RESOURCE-UTILIZATION-MIB -M /opt/librenms/mibs:/opt/librenms/mibs/enterasys udp:HOSTNAME:161 etsysResourceStorageAvailable.
10011002.ram.1 = RAM device 1
etsysResourceStorageDescr.
1[0m]
37226

SNMP[[0;36m/usr/bin/snmpget -v2c -c COMMUNITY -OvQ -m ENTERASYS-RESOURCE-UTILIZATION-MIB -M /opt/librenms/mibs:/opt/librenms/mibs/enterasys udp:HOSTNAME:161 etsysResourceStorageSize.
10011002.flash.1 ram.1[0m]
262144

85.8% RRD[[0;32mupdate 3.3.3.3/mempool-enterasys-10011002.rrd N:230316032:38119424 --daemon unix:/var/run/rrdcached.sock[0m]
[[0;31mRRD Disabled[0m]SQL[[0;33mUPDATE `mempools` set `mempool_used` ='230316032',`mempool_perc` ='85.8',`mempool_free` ='38119424',`mempool_total` ='268435456' WHERE `mempool_id` 
Images & Miscellaneous
etsysResourceStorageDescr.10011002.flash.2 = Nonvolatile Data Storage
etsysResourceStorageDescr.
'137'[0m] 

Mempool RAM device 1: SNMP[[0;36m/usr/bin/snmpget -v2c -c COMMUNITY -OvQ -m ENTERASYS-RESOURCE-UTILIZATION-MIB -M /opt/librenms/mibs:/opt/librenms/mibs/enterasys udp:HOSTNAME:161 etsysResourceStorageAvailable.
10011003.ram.1 = RAM device 1
etsysResourceStorageDescr.10011003.flash.1 = Images & Miscellaneous
etsysResourceStorageDescr.10011003.flash.2 = Nonvolatile Data Storage
1[0m]
38226

SNMP[[0;36m/usr/bin/snmpget -v2c -c COMMUNITY -OvQ -m ENTERASYS-RESOURCE-UTILIZATION-MIB -M /opt/librenms/mibs:/opt/librenms/mibs/enterasys udp:HOSTNAME:161 
etsysResourceStorageSize.10011001.ram.1 = 262144
etsysResourceStorageSize.10011001.flash.1 = 16384
etsysResourceStorageSize.10011001.flash.2 = 16384
etsysResourceStorageSize.10011002.ram.1 = 262144
etsysResourceStorageSize.10011002.flash.1 = 16384
etsysResourceStorageSize.10011002.flash.2 = 16384
etsysResourceStorageSize.
10011003.ram.1 = 262144
etsysResourceStorageSize.10011003.flash.1 = 16384
etsysResourceStorageSize.10011003.flash.2 = 16384
etsysResourceStorageAvailable.10011001.ram.1 = 36474
etsysResourceStorageAvailable.10011001.flash.1 = 2714
etsysResourceStorageAvailable.10011001.flash.2 = 14052
etsysResourceStorageAvailable.10011002.ram.1 = 37226
etsysResourceStorageAvailable.10011002.flash.1 = 3622
etsysResourceStorageAvailable.10011002.flash.2 = 13968
etsysResourceStorageAvailable.10011003.ram.1 = 38226
etsysResourceStorageAvailable.10011003.flash.1 = 3622
etsysResourceStorageAvailable.10011003.flash.2 = 13972

etsysResourceStorageDescr.10011001.ram.1 = RAM device 1 || etsysResourceStorageDescr || 10011001 || ram || 1
etsysResourceStorageDescr.10011001.flash.1 = Images & Miscellaneous || etsysResourceStorageDescr || 10011001 || flash || 1
etsysResourceStorageDescr.10011001.flash.2 = Nonvolatile Data Storage || etsysResourceStorageDescr || 10011001 || flash || 2
etsysResourceStorageDescr.10011002.ram.1 = RAM device 1 || etsysResourceStorageDescr || 10011002 || ram || 1
etsysResourceStorageDescr.10011002.flash.1 = Images & Miscellaneous || etsysResourceStorageDescr || 10011002 || flash || 1
etsysResourceStorageDescr.10011002.flash.2 = Nonvolatile Data Storage || etsysResourceStorageDescr || 10011002 || flash || 2
etsysResourceStorageDescr.10011003.ram.1 = RAM device 1 || etsysResourceStorageDescr || 10011003 || ram || 1
etsysResourceStorageDescr.10011003.flash.1 = Images & Miscellaneous || etsysResourceStorageDescr || 10011003 || flash || 1
etsysResourceStorageDescr.10011003.flash.2 = Nonvolatile Data Storage || etsysResourceStorageDescr || 10011003 || flash || 2
etsysResourceStorageSize.10011001.ram.1 = 262144 || etsysResourceStorageSize || 10011001 || ram || 1
etsysResourceStorageSize.10011001.flash.1 = 16384 || etsysResourceStorageSize || 10011001 || flash || 1
etsysResourceStorageSize.10011001.flash.2 = 16384 || etsysResourceStorageSize || 10011001 || flash || 2
etsysResourceStorageSize.10011002.ram.1 = 262144 || etsysResourceStorageSize || 10011002 || ram || 1
etsysResourceStorageSize.10011002.flash.1 = 16384 || etsysResourceStorageSize || 10011002 || flash || 1
etsysResourceStorageSize.10011002.flash.2 = 16384 || etsysResourceStorageSize || 10011002 || flash || 2
etsysResourceStorageSize.10011003.ram.1 = 262144 || etsysResourceStorageSize || 10011003 || ram || 1
etsysResourceStorageSize.10011003.flash.1 = 16384 || etsysResourceStorageSize || 10011003 || flash || 1
etsysResourceStorageSize.10011003.flash.2 = 16384 || etsysResourceStorageSize || 10011003 || flash || 2
etsysResourceStorageAvailable.10011001.ram.1 = 36474 || etsysResourceStorageAvailable || 10011001 || ram || 1
etsysResourceStorageAvailable.10011001.flash.1 = 2714 || etsysResourceStorageAvailable || 10011001 || flash || 1
etsysResourceStorageAvailable.10011001.flash.2 = 14052 || etsysResourceStorageAvailable || 10011001 || flash || 2
etsysResourceStorageAvailable.10011002.ram.1 = 37226 || etsysResourceStorageAvailable || 10011002 || ram || 1
etsysResourceStorageAvailable.10011002.flash.1 = 3622 || etsysResourceStorageAvailable || 10011002 || flash || 1
etsysResourceStorageAvailable.10011002.flash.2 = 13968 || etsysResourceStorageAvailable || 10011002 || flash || 2
etsysResourceStorageAvailable.10011003.ram.1 = 38226 || etsysResourceStorageAvailable || 10011003 || ram || 1
etsysResourceStorageAvailable.10011003.flash.1 = 3622 || etsysResourceStorageAvailable || 10011003 || flash || 1
etsysResourceStorageAvailable.10011003.flash.2 = 13972 || etsysResourceStorageAvailable || 10011003 || flash || 2
Discover Mempool: 10011001, enterasys, RAM device 1, 1, 1, 
SQL[[0;33mSELECT COUNT(mempool_id) FROM `mempools` WHERE `mempool_index` = '10011001' AND `device_id` = '94' AND `mempool_type` = 'enterasys'[0m] 
.SQL[[0;33mUPDATE `mempools` set `mempool_descr` ='RAM device 1',`entPhysicalIndex` ='1' WHERE device_id='94' AND mempool_index='10011001' AND mempool_type='enterasys'[0m] 
Discover Mempool: 10011002, enterasys, RAM device 1, 1, 1, 
SQL[[0;33mSELECT COUNT(mempool_id) FROM `mempools` WHERE `mempool_index` = '10011002' AND `device_id` = '94' AND `mempool_type` = 'enterasys'[0m] 
.SQL[[0;33mUPDATE `mempools` set `mempool_descr` ='RAM device 1',`entPhysicalIndex` ='1' WHERE device_id='94' AND mempool_index='10011002' AND mempool_type='enterasys'[0m] 
Discover Mempool: 10011003, enterasys, RAM device 1, 1, 1, 
SQL[[0;33mSELECT COUNT(mempool_id) FROM `mempools` WHERE `mempool_index` = '10011003' AND `device_id` = '94' AND `mempool_type` = 'enterasys'[0m] 
.SQL[[0;33mUPDATE `mempools` set `mempool_descr` ='RAM device 1',`entPhysicalIndex` ='1' WHERE device_id='94' AND mempool_index='10011003' AND mempool_type='enterasys'[0m] 
SNMP[[0;36m/usr/bin/snmpbulkwalk -v2c -c COMMUNITY -OQUs -m NETSWITCH-MIB -M /opt/librenms/mibs:/opt/librenms/mibs/enterasys:/opt/librenms/mibs/hp udp:HOSTNAME:161 hpLocal[0m]
hpLocalMem = No Such Object available on this agent at this OID

SNMP[[0;36m/usr/bin/snmpbulkwalk -v2c -c COMMUNITY -OQUs -m NETSWITCH-MIB -M /opt/librenms/mibs:/opt/librenms/mibs/enterasys:/opt/librenms/mibs/hp udp:HOSTNAME:161 hpGlobal[0m]
hpGlobalMem = No Such Object available on this agent at this OID

SNMP[[0;36m/usr/bin/snmpbulkwalk -v2c -c COMMUNITY -OQUs -m HOST-RESOURCES-MIB:HOST-RESOURCES-TYPES:NetWare-Host-Ext-MIB -M /opt/librenms/mibs:/opt/librenms/mibs/enterasys udp:HOSTNAME:161 hrStorageEntry[0m]
hrStorageEntry = No Such Object available on this agent at this OID

Array
(
    [enterasys] => Array
        (
            [10011001] => 1
            [10011002] => 1
            [10011003] => 1
        )

)
SQL[[0;33mSELECT * FROM `mempools` WHERE `device_id`  = '94'[0m] 
10011001 -> enterasys
10011002 -> enterasys
10011003 -> enterasys


>> Runtime for discovery module 'mempools': 0.5630 seconds with 41240 bytes
#### Unload disco module mempools ####

SQL[[0;33mSELECT attrib_value FROM devices_attribs WHERE `device_id` = '94' AND `attrib_type` = 'poll_mib' [0m] 
SQL[[0;33mUPDATE `devices` set `last_discovered` =NOW(),`last_discovered_timetaken` ='4.654' WHERE `device_id` = '94'[0m] 
Discovered in 4.654 seconds

SQL[[0;33mINSERT INTO `perf_times` (`type`,`doing`,`start`,`duration`,`devices`,`poller`)  VALUES ('discover','3.
1[0m]
262144

85.42% RRD[[0;32mupdate 3.
3.3.3','1492591831.1205','4.694','1','HQ_switch01\n')[0m] 
./discovery.
3/mempool-enterasys-10011003.rrd N:229292032:39143424 --daemon unix:/var/run/rrdcached.sock[0m]
[[0;31mRRD Disabled[0m]SQL[[0;33mUPDATE `mempools` set `mempool_used` ='229292032',`mempool_perc` ='85.42',`mempool_free` ='39143424',`mempool_total` ='268435456' WHERE `mempool_id` = '138'[0m] 


>> Runtime for poller module 'mempools': 0.2574 seconds with 4552 bytes
#### Unload poller module mempools ####

RRD[[0;32mupdate 3.3.3.3/poller-perf-mempools.rrd N:0.25742292404175 --daemon unix:/var/run/rrdcached.sock[0m]
[[0;31mRRD Disabled[0m]### Start Device Groups ###
SQL[[0;33mSELECT * FROM device_groups ORDER BY name[0m] 
SQL[[0;33mSELECT DISTINCT(devices.device_id) FROM devices WHERE  devices.device_id='94' AND (devices.os REGEXP "PIX.*" || devices.os REGEXP "ASA.*" ) LIMIT 1[0m] 
SQL[[0;33mSELECT DISTINCT(devices.device_id) FROM devices WHERE  devices.device_id='94' AND (devices.os REGEXP "IOS.*" ) LIMIT 1[0m] 
SQL[[0;33mSELECT DISTINCT(devices.device_id) FROM devices WHERE  devices.device_id='94' AND (devices.hardware REGEXP "N7.*" || devices.hardware REGEXP "N3.*" ) LIMIT 1[0m] 
SQL[[0;33mSELECT DISTINCT(devices.device_id) FROM devices WHERE  devices.device_id='94' AND (devices.os REGEXP "Enterasys.*" ) LIMIT 1[0m] 
SQL[[0;33mSELECT DISTINCT(devices.device_id) FROM devices WHERE  devices.device_id='94' AND (devices.os REGEXP "Microsoft.*" || devices.os REGEXP "Linux.*" ) LIMIT 1[0m] 
SQL[[0;33mSELECT DISTINCT(devices.device_id) FROM devices WHERE  devices.device_id='94' AND (devices.os REGEXP "NX.*" ) LIMIT 1[0m] 
SQL[[0;33mSELECT `device_group_id` FROM `device_group_device` WHERE `device_id`='94'[0m] 
Groups Added: 
Groups Removed: 
### End Device Groups ###
RRD[[0;32mupdate 3.3.3.3/poller-perf.rrd N:4.473 --daemon unix:/var/run/rrdcached.sock[0m]
[[0;31mRRD Disabled[0m]RRD[[0;32mupdate 3.3.3.3/ping-perf.rrd N:27.6 --daemon unix:/var/run/rrdcached.sock[0m]
[[0;31mRRD Disabled[0m]Polled in 4.473 seconds
Updating 3.3.3.3
SQL[[0;33mUPDATE `devices` set `uptime` ='5630361',`last_ping` =NOW(),`last_ping_timetaken` ='27.6',`last_polled` =NOW(),`last_polled_timetaken` ='4.473' WHERE `device_id` = '94'[0m] 
UPDATED!
#### Start Alerts ####
SQL[[0;33mSELECT `device_group_id` FROM `device_group_device` WHERE `device_id`='94'[0m] 
SQL[[0;33mSELECT alert_schedule.schedule_id FROM alert_schedule LEFT JOIN alert_schedule_items ON alert_schedule.schedule_id=alert_schedule_items.schedule_id WHERE ( alert_schedule_items.target = '94' || alert_schedule_items.target = 'g5' || alert_schedule_items.target = 'g6' ) && ((alert_schedule.recurring = 0 AND (NOW() BETWEEN alert_schedule.start AND alert_schedule.end)) OR (alert_schedule.recurring = 1 AND (alert_schedule.start_recurring_dt <= date_format(NOW(), '[1;33m-[0;35m-%d') AND (end_recurring_dt >= date_format(NOW(), '[1;33m-[0;35m-%d') OR end_recurring_dt is NULL OR end_recurring_dt = '0000-00-00' OR end_recurring_dt = '')) AND (date_format(now(), '%H:%i:%s') BETWEEN `start_recurring_hr` AND end_recurring_hr) AND (recurring_day LIKE CONCAT('%',date_format(now(), '[0;37m'),'%') OR recurring_day is null or recurring_day = ''))) LIMIT 1[0m] 
SQL[[0;33mSELECT `device_group_id` FROM `device_group_device` WHERE `device_id`='94'[0m] 
SQL[[0;33mSELECT alert_rules.* FROM alert_rules LEFT JOIN alert_map ON alert_rules.id=alert_map.rule WHERE alert_rules.disabled = 0 && ( (alert_rules.device_id = -1 || alert_rules.device_id = '94' ) || alert_map.target = '94'  || alert_map.target = 'g5' || alert_map.target = 'g6' )[0m] 
#### End Alerts ####
SQL[[0;33mINSERT INTO `perf_times` (`type`,`doing`,`start`,`duration`,`devices`,`poller`)  VALUES ('poll','3.3.3.3','1492591888.4672','4.522','1','HQ_switch01\n')[0m] 
./poller.
php 3.3.3.3 2017-04-19 10:50:35 10:51:32 - 1 devices discovered polled in 4.694 522 secs
SNMP: Get[1/0.04s] Get[10/0.42s] Walk [3/0.42s]
[0/0.00s]
MySQL: Cell[7/0.Cell[9/0.00s] Row[1/0.00s] Rows[5/0.Rows[7/0.00s] Column[0/0.Column[3/0.00s] Update[4/0.00s] Insert[2/0.00s] Delete[0/0.00s]