poller debug

From Perl Cockroach, 6 Years ago, written in DOS.
This paste is a reply to Re: Untitled from Violet Penguin - view diff
URL https://p.libren.ms/view/7d6652ba
Embed
Download Paste or View Raw
  1. LibreNMS Poller
  2. Version info:
  3. Commit SHA: d8fcdc9ae3cf7a5cdafca865c9ada7551f85a03f
  4. Commit Date: 1492555376
  5. DB Schema: 185
  6. PHP: 7.0.8-0ubuntu0.16.04.1
  7. MySQL: 10.0.25-MariaDB-0ubuntu0.16.04.1
  8. RRDTool: 1.5.5
  9. SNMP: NET-SNMP 5.7.3
  10. DEBUG!
  11. Starting polling run:
  12.  
  13. SQL[[0;33mSELECT * FROM `devices` WHERE `disabled` = 0 AND `hostname` = '3.3.3.3' ORDER BY `device_id` ASC[0m]
  14. SQL[[0;33mSELECT * FROM devices_attribs WHERE `device_id` = '94'[0m]
  15. Hostname: 3.3.3.3
  16. Device ID: 94
  17. OS: enterasys
  18.  
  19. SQL[[0;33mINSERT INTO `device_perf` (`xmt`,`rcv`,`loss`,`min`,`max`,`avg`,`device_id`,`timestamp`)  VALUES ('5','5','0','26.9','28.1','27.6','94',NOW())[0m]
  20. SNMP Check response code: 0
  21. 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]
  22. sysUpTime.0 = 563036140
  23. sysLocation.0 = Xenon
  24. sysContact.0 =
  25. sysName.0 = Xenon XEN Core SW
  26. sysObjectID.0 = enterprises.56*
  27.  
  28. 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]
  29. Enterasys Networks, Inc. N3 Chassis Rev *7 02/28/2012--11:59 ofc
  30.  
  31. 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]
  32. snmpEngineTime.0 = 5630361
  33. hrSystemUptime.0 = No Such Object available on this agent at this OID
  34.  
  35. Using SNMP Agent Uptime (5630361s)
  36.   RRD[[0;32mupdate 3.3.3.3/uptime.rrd N:5630361 --daemon unix:/var/run/rrdcached.sock[0m]
  37. [[0;31mRRD Disabled[0m]Uptime: 65 days, 3h 59m 21s
  38. SQL[[0;33mSELECT `lat`,`lng` FROM `locations` WHERE `location`='Xenon' LIMIT 1[0m]
  39. Google geocode engine being used
  40. Bad lat / lng received
  41. Modules status: Global+ OS  Device  
  42. #### Load poller module mempools ####
  43. SQL[[0;33mSELECT * FROM mempools WHERE device_id = '94'[0m]
  44. 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.10011001.ram.1[0m]
  45. 36474
  46.  
  47. 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[0m]
  48. 262144
  49.  
  50. 86.09% RRD[[0;32mupdate 3.3.3.3/mempool-enterasys-10011001.rrd N:231086080:37349376 --daemon unix:/var/run/rrdcached.sock[0m]
  51. [[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` = '136'[0m]
  52.  
  53. 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[0m]
  54. 37226
  55.  
  56. 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.ram.1[0m]
  57. 262144
  58.  
  59. 85.8% RRD[[0;32mupdate 3.3.3.3/mempool-enterasys-10011002.rrd N:230316032:38119424 --daemon unix:/var/run/rrdcached.sock[0m]
  60. [[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` = '137'[0m]
  61.  
  62. 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[0m]
  63. 38226
  64.  
  65. 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.10011003.ram.1[0m]
  66. 262144
  67.  
  68. 85.42% RRD[[0;32mupdate 3.3.3.3/mempool-enterasys-10011003.rrd N:229292032:39143424 --daemon unix:/var/run/rrdcached.sock[0m]
  69. [[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]
  70.  
  71.  
  72. >> Runtime for poller module 'mempools': 0.2574 seconds with 4552 bytes
  73. #### Unload poller module mempools ####
  74.  
  75. RRD[[0;32mupdate 3.3.3.3/poller-perf-mempools.rrd N:0.25742292404175 --daemon unix:/var/run/rrdcached.sock[0m]
  76. [[0;31mRRD Disabled[0m]### Start Device Groups ###
  77. SQL[[0;33mSELECT * FROM device_groups ORDER BY name[0m]
  78. 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]
  79. SQL[[0;33mSELECT DISTINCT(devices.device_id) FROM devices WHERE  devices.device_id='94' AND (devices.os REGEXP "IOS.*" ) LIMIT 1[0m]
  80. 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]
  81. SQL[[0;33mSELECT DISTINCT(devices.device_id) FROM devices WHERE  devices.device_id='94' AND (devices.os REGEXP "Enterasys.*" ) LIMIT 1[0m]
  82. 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]
  83. SQL[[0;33mSELECT DISTINCT(devices.device_id) FROM devices WHERE  devices.device_id='94' AND (devices.os REGEXP "NX.*" ) LIMIT 1[0m]
  84. SQL[[0;33mSELECT `device_group_id` FROM `device_group_device` WHERE `device_id`='94'[0m]
  85. Groups Added:
  86. Groups Removed:
  87. ### End Device Groups ###
  88. RRD[[0;32mupdate 3.3.3.3/poller-perf.rrd N:4.473 --daemon unix:/var/run/rrdcached.sock[0m]
  89. [[0;31mRRD Disabled[0m]RRD[[0;32mupdate 3.3.3.3/ping-perf.rrd N:27.6 --daemon unix:/var/run/rrdcached.sock[0m]
  90. [[0;31mRRD Disabled[0m]Polled in 4.473 seconds
  91. Updating 3.3.3.3
  92. 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]
  93. UPDATED!
  94. #### Start Alerts ####
  95. SQL[[0;33mSELECT `device_group_id` FROM `device_group_device` WHERE `device_id`='94'[0m]
  96. 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('%!!(())%') OR recurring_day is null or recurring_day = ''))) LIMIT 1[0m]
  97. SQL[[0;33mSELECT `device_group_id` FROM `device_group_device` WHERE `device_id`='94'[0m]
  98. 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]
  99. #### End Alerts ####
  100. 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]
  101. ./poller.php 3.3.3.3 2017-04-19 10:51:32 - 1 devices polled in 4.522 secs
  102. SNMP: Get[10/0.42s] Walk [0/0.00s]
  103. MySQL: Cell[9/0.00s] Row[1/0.00s] Rows[7/0.00s] Column[3/0.00s] Update[4/0.00s] Insert[2/0.00s] Delete[0/0.00s]
  104.  


Reply to "poller debug"