DEBUG! CMD[/usr/bin/svn info /opt/observium] CMD EXITCODE[0] CMD RUNTIME[0.0179s] CMD EXITDELAY[10ms] STDOUT[ Path: . Working Copy Root Path: /opt/observium URL: http://svn.observium.org/svn/observium/branches/stable Relative URL: ^/observium/branches/stable Repository Root: http://svn.observium.org/svn Repository UUID: 61d68cd4-352d-0410-923a-c4978735b2b8 Revision: 9417 Node Kind: directory Schedule: normal Last Changed Author: adama Last Changed Rev: 9403 Last Changed Date: 2018-08-27 23:08:36 +0200 (Mon, 27 Aug 2018) ] SQL[SELECT `attrib_value` FROM `observium_attribs` WHERE `attrib_type` = 'dbSchema';] SQL RUNTIME[0.00010490s] SQL[SELECT @@SESSION.sql_mode;] SQL RUNTIME[0.00012779s] SQL[SELECT `attrib_value` FROM `observium_attribs` WHERE `attrib_type` = 'current_rev';] SQL RUNTIME[0.00008392s] SQL[SELECT * FROM `config`] SQL RUNTIME[0.00008988s] ___ _ _ / _ \ | |__ ___ ___ _ __ __ __(_) _ _ _ __ ___ | | | || '_ \ / __| / _ \| '__|\ \ / /| || | | || '_ ` _ \ | |_| || |_) |\__ \| __/| | \ V / | || |_| || | | | | | \___/ |_.__/ |___/ \___||_| \_/ |_| \__,_||_| |_| |_| Observium Professional 18.8.9403 http://www.observium.org SQL[SELECT `attrib_value` FROM `observium_attribs` WHERE `attrib_type` = 'latest_ver';] SQL RUNTIME[0.00008082s] SQL[SELECT `attrib_value` FROM `observium_attribs` WHERE `attrib_type` = 'latest_rev';] SQL RUNTIME[0.00008297s] SQL[SELECT `attrib_value` FROM `observium_attribs` WHERE `attrib_type` = 'latest_rev_date';] SQL RUNTIME[0.00004601s] There is a newer revision of Observium available! CMD[date "+%:z"] CMD EXITCODE[0] CMD RUNTIME[0.0007s] STDOUT[ +02:00 ] SQL[SELECT TIMEDIFF(NOW(), UTC_TIMESTAMP);] SQL RUNTIME[0.00015593s] Version 18.9.9428 (13th September 2018) is 25 revisions ahead. CMD[/opt/observium/scripts/distro] CMD EXITCODE[0] CMD RUNTIME[0.1079s] STDOUT[ Linux|4.9.0-8-amd64|amd64|Debian|9.5|vmware| ] CMD[/usr/bin/env python --version 2>&1] CMD EXITCODE[0] CMD RUNTIME[0.0045s] STDOUT[ Python 2.7.13 ] SQL[SELECT version();] SQL RUNTIME[0.00051498s] CMD[/usr/bin/snmpget --version 2>&1] CMD EXITCODE[0] CMD RUNTIME[0.0017s] CMD EXITDELAY[10ms] STDOUT[ NET-SNMP version: 5.7.3 ] CMD[/usr/bin/rrdtool --version | head -n1] CMD EXITCODE[0] CMD RUNTIME[0.0104s] STDOUT[ RRDtool 1.6.0 Copyright by Tobias Oetiker ] CMD[/usr/bin/fping -v 2>&1] CMD EXITCODE[0] CMD RUNTIME[0.0021s] CMD EXITDELAY[10ms] STDOUT[ /usr/bin/fping: Version 3.15 /usr/bin/fping: comments to david@schweikert.ch ] CMD[/usr/sbin/apache2 -v | awk '/Server version:/ {print $3}'] CMD EXITCODE[0] CMD RUNTIME[0.0254s] STDOUT[ Apache/2.4.25 ] SQL[SELECT @@SESSION.sql_mode;] SQL RUNTIME[0.00014901s] SQL[SHOW VARIABLES LIKE 'character_set_connection'] SQL RUNTIME[0.00043988s] ##### Software versions ##### o OS Linux 4.9.0-8-amd64 [amd64] (Debian 9.5) o Apache 2.4.25 o PHP 7.0.30-0+deb9u1 (OPcache: DISABLED) o Python 2.7.13 o MySQL 10.1.26-MariaDB-0+deb9u1 (extension: mysqli 5.0.12-dev) o SNMP NET-SNMP 5.7.3 o RRDtool 1.6.0 o Fping 3.15 (IPv4 and IPv6) ##### Memory Limit ##### o PHP Unlimited ##### MySQL mode ##### o MySQL NO_AUTO_CREATE_USER,NO_ENGINE_SUBSTITUTION ##### Charset info ##### o PHP UTF-8 o MySQL utf8 ##### Timezones info ##### o Date Thursday, 13-Sep-18 14:18:26 CEST o PHP +02:00 o MySQL +02:00 SQL[SELECT * FROM `alerts_maint` WHERE `maint_start` < '1536841106' AND `maint_end` > '1536841106'] SQL RUNTIME[0.00029016s] SQL[SELECT * FROM `alerts_maint_assoc` WHERE `maint_id` = '1'] SQL RUNTIME[0.00005794s] ##### Starting polling run at 2018-09-13 14:18:26 ##### SQL[SELECT `device_id` FROM `devices` WHERE `disabled` = 0 AND `hostname` LIKE 'eaton9px11000i.ipex.be' ORDER BY `device_id` ASC] SQL RUNTIME[0.00497293s] SQL[SELECT * FROM `devices` WHERE `device_id` = '104'] SQL RUNTIME[0.00048900s] SQL[SELECT * FROM `entity_attribs` WHERE `entity_type` = 'device' AND `entity_id` = '104'] SQL RUNTIME[0.00007010s] SQL[SELECT * FROM `observium_processes` WHERE `process_name` = 'poller.php' AND `device_id` = '104'] SQL RUNTIME[0.00018001s] SQL[INSERT INTO `observium_processes` (`process_pid`,`process_name`,`process_ppid`,`process_uid`,`process_command`,`process_start`,`device_id`) VALUES ('27599','poller.php','22298','0','php /opt/observium/poller.php -d -m os -h eaton9px11000i.ipex.be','1536841106','104')] SQL RUNTIME[0.00119805s] SQL[SELECT * FROM `alert_tests` WHERE 1] SQL RUNTIME[0.00005722s] Cached 21 alert rules. SQL[SELECT * FROM `alert_table` WHERE `device_id` = '104'] SQL RUNTIME[0.00018191s] ##### eaton9px11000i.ipex.be [104] ##### o OS mgeups o OS Group ups o Last poll duration 1.86 seconds o Last Polled 2018-09-13 14:18:03 o SNMP Version v1 CMD[/usr/bin/fping -t 500 -c 1 -q 192.168.0.8 2>&1] CMD EXITCODE[0] CMD RUNTIME[0.0052s] STDOUT[ 192.168.0.8 : xmt/rcv/%loss = 1/1/0%, min/avg/max = 0.42/0.42/0.42 ] DEBUG: SNMP Auth options = -v1 -c 'Zabbix' CMD[/usr/bin/snmpget -v1 -c 'Zabbix' -Pu -OQUs -m SNMPv2-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'eaton9px11000i.ipex.be':'161' sysObjectID.0 sysUpTime.0] CMD EXITCODE[0] CMD RUNTIME[0.0088s] STDOUT[ sysObjectID.0 = enterprises.705.1 sysUpTime.0 = 0:0:09:09.22 ] SNMP STATUS[TRUE] o Device status Device is reachable by PING (0.42ms) and SNMP (8.83ms) RRD /opt/observium/rrd/eaton9px11000i.ipex.be/status.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/eaton9px11000i.ipex.be/status.rrd N:1] RRD RUNTIME[0.0011s] RRD STDOUT[OK u:0.00 s:0.00 r:0.00] RRD_STATUS[TRUE] RRD /opt/observium/rrd/eaton9px11000i.ipex.be/ping.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/eaton9px11000i.ipex.be/ping.rrd N:0.42] RRD RUNTIME[0.0011s] RRD STDOUT[OK u:0.00 s:0.00 r:0.00] RRD_STATUS[TRUE] RRD /opt/observium/rrd/eaton9px11000i.ipex.be/ping_snmp.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/eaton9px11000i.ipex.be/ping_snmp.rrd N:8.83] RRD RUNTIME[0.0011s] RRD STDOUT[OK u:0.00 s:0.00 r:0.00] RRD_STATUS[TRUE] SQL[SELECT * FROM `device_graphs` WHERE `device_id` = '104'] SQL RUNTIME[0.00157309s] o Modules Enabled system, os including: includes/polling/system.inc.php ##### Module Start: system ##### SQL[SELECT `attrib_value` FROM `entity_attribs` WHERE `entity_type` = 'device' AND `entity_id` = '104' AND `attrib_type` = 'sysORID'] SQL RUNTIME[0.00006104s] SQL[SELECT `attrib_value` FROM `entity_attribs` WHERE `entity_type` = 'device' AND `entity_id` = '104' AND `attrib_type` = 'sysORID'] SQL RUNTIME[0.00004196s] SQL[SELECT * FROM `observium_attribs`] SQL RUNTIME[0.00005794s] o SNMPv2-MIB DEBUG: SNMP Auth options = -v1 -c 'Zabbix' CMD[/usr/bin/snmpget -v1 -c 'Zabbix' -Pu -OQUs -m SNMPv2-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'eaton9px11000i.ipex.be':'161' sysUpTime.0 sysLocation.0 sysContact.0 sysName.0] CMD EXITCODE[0] CMD RUNTIME[0.0172s] STDOUT[ sysUpTime.0 = 0:0:09:09.24 sysLocation.0 = Saintes sysContact.0 = Computer Room Manager sysName.0 = IPEX_UPS01 ] SNMP STATUS[TRUE] DEBUG: SNMP Auth options = -v1 -c 'Zabbix' CMD[/usr/bin/snmpget -v1 -c 'Zabbix' -Pu -OQUv -m SNMPv2-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'eaton9px11000i.ipex.be':'161' sysDescr.0] CMD EXITCODE[0] CMD RUNTIME[0.0068s] CMD EXITDELAY[10ms] STDOUT[ Eaton 9PX 11000i ] SNMP STATUS[TRUE] DEBUG: SNMP Auth options = -v1 -c 'Zabbix' CMD[/usr/bin/snmpget -v1 -c 'Zabbix' -Pu -OQUvn -m SNMPv2-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'eaton9px11000i.ipex.be':'161' sysObjectID.0] CMD EXITCODE[0] CMD RUNTIME[0.0069s] CMD EXITDELAY[10ms] STDOUT[ .1.3.6.1.4.1.705.1 ] SNMP STATUS[TRUE] Using SNMP Agent sysUpTime (549 sec. => 9m 9s) RRD /opt/observium/rrd/eaton9px11000i.ipex.be/uptime.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/eaton9px11000i.ipex.be/uptime.rrd N:549] RRD RUNTIME[0.0017s] RRD STDOUT[OK u:0.00 s:0.00 r:0.07] RRD_STATUS[TRUE] o Uptime 9m 9s o Last reboot 2018-09-13 14:09:17 /opt/observium/includes/polling/system.inc.php:281 array( [use] => string(9) "sysUpTime" [sysUpTime] => int(549) [uptime] => int(549) [formatted] => string(5) "9m 9s" [message] => string(26) "Using SNMP Agent sysUpTime" [previous] => string(3) "524" [diff] => int(-25) [last_rebooted] => string(10) "1536840557" [rebooted] => int(0) ) DEBUG: SNMP Auth options = -v1 -c 'Zabbix' CMD[/usr/bin/snmpget -v1 -c 'Zabbix' -Pu -OQUsn -m UCD-SNMP-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'eaton9px11000i.ipex.be':'161' .1.3.6.1.4.1.2021.10.1.5.1 .1.3.6.1.4.1.2021.10.1.5.2 .1.3.6.1.4.1.2021.10.1.5.3] CMD EXITCODE[2] CMD RUNTIME[0.0136s] STDOUT[ ] STDERR[ Error in packet Reason: (noSuchName) There is no such variable name in this MIB. Failed object: .1.3.6.1.4.1.2021.10.1.5.1 Error in packet Reason: (noSuchName) There is no such variable name in this MIB. Failed object: .1.3.6.1.4.1.2021.10.1.5.2 Error in packet Reason: (noSuchName) There is no such variable name in this MIB. Failed object: .1.3.6.1.4.1.2021.10.1.5.3 ] SNMP ERROR[#1000 - Failed response] SQL[SELECT * FROM `snmp_errors` WHERE `device_id` = '104' AND `error_code` = '1000' AND `snmp_cmd` = 'snmpget' AND `mib` = 'UCD-SNMP-MIB' AND `oid` = '.1.3.6.1.4.1.2021.10.1.5.1 .1.3.6.1.4.1.2021.10.1.5.2 .1.3.6.1.4.1.2021.10.1.5.3';] SQL RUNTIME[0.00038218s] SQL[UPDATE `snmp_errors` set `error_count` ='44847',`updated` ='1536841106' WHERE `error_id` = '1723'] SQL RUNTIME[0.00126696s] SNMP ERROR[#1000 - Failed response] SQL[SELECT * FROM `snmp_errors` WHERE `device_id` = '104' AND `error_code` = '1000' AND `snmp_cmd` = 'snmpget' AND `mib` = 'UCD-SNMP-MIB' AND `oid` = '.1.3.6.1.4.1.2021.10.1.5.1 .1.3.6.1.4.1.2021.10.1.5.2 .1.3.6.1.4.1.2021.10.1.5.3';] SQL RUNTIME[0.00019193s] SQL[UPDATE `snmp_errors` set `error_count` ='44848',`updated` ='1536841106' WHERE `error_id` = '1723'] SQL RUNTIME[0.00118089s] SNMP STATUS[FALSE] o sysObjectID .1.3.6.1.4.1.705.1 o snmpEngineID o sysDescr Eaton 9PX 11000i o sysName IPEX_UPS01 o Location Saintes SQL[SELECT * FROM `devices_locations` WHERE `device_id` = '104'] SQL RUNTIME[0.00005507s] o Module time 0.0842s including: includes/polling/os.inc.php ##### Module Start: os ##### DEBUG: SNMP Auth options = -v1 -c 'Zabbix' CMD[/usr/bin/snmpget -v1 -c 'Zabbix' -Pu -Oqv -m MG-SNMP-UPS-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp:/opt/observium/mibs/eaton 'udp':'eaton9px11000i.ipex.be':'161' upsmgIdentSerialNumber.0] CMD EXITCODE[0] CMD RUNTIME[0.0124s] STDOUT[ "G209E52010" ] SNMP STATUS[TRUE] Added OS param from SNMP definition walk: 'serial' = 'G209E52010' DEBUG: SNMP Auth options = -v1 -c 'Zabbix' CMD[/usr/bin/snmpget -v1 -c 'Zabbix' -Pu -Oqv -m MG-SNMP-UPS-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp:/opt/observium/mibs/eaton 'udp':'eaton9px11000i.ipex.be':'161' upsmgIdentFirmwareVersion.0] CMD EXITCODE[0] CMD RUNTIME[0.0114s] CMD EXITDELAY[10ms] STDOUT[ "02.22.0044" ] SNMP STATUS[TRUE] Added OS param from SNMP definition walk: 'version' = '02.22.0044' o OS Poller OS DEBUG: SNMP Auth options = -v1 -c 'Zabbix' CMD[/usr/bin/snmpget -v1 -c 'Zabbix' -Pu -OQv -m MG-SNMP-UPS-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp:/opt/observium/mibs/eaton 'udp':'eaton9px11000i.ipex.be':'161' upsmgIdentModelName.0] CMD EXITCODE[0] CMD RUNTIME[0.0109s] STDOUT[ "11000i" ] SNMP STATUS[TRUE] DEBUG: SNMP Auth options = -v1 -c 'Zabbix' CMD[/usr/bin/snmpget -v1 -c 'Zabbix' -Pu -OQv -m MG-SNMP-UPS-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp:/opt/observium/mibs/eaton 'udp':'eaton9px11000i.ipex.be':'161' upsmgIdentFamilyName.0] CMD EXITCODE[0] CMD RUNTIME[0.013s] CMD EXITDELAY[10ms] STDOUT[ "Eaton 9PX" ] SNMP STATUS[TRUE] DEBUG: SNMP Auth options = -v1 -c 'Zabbix' CMD[/usr/bin/snmpget -v1 -c 'Zabbix' -Pu -OQv -m MG-SNMP-UPS-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp:/opt/observium/mibs/eaton 'udp':'eaton9px11000i.ipex.be':'161' upsmgAgentFirmwareVersion.0] CMD EXITCODE[0] CMD RUNTIME[0.0142s] STDOUT[ "JB" ] SNMP STATUS[TRUE] o Hardware Eaton 9PX 11000i o Version 02.22.0044 o Features Firmware: JB o Serial G209E52010 o Asset o Module time 0.0923s ##### eaton9px11000i.ipex.be [104] completed poller modules at 2018-09-13 14:18:26 ##### o Graphs [checked] availability, ping, ping_snmp, uptime o Poller time 0.2069 seconds Updating eaton9px11000i.ipex.be - > $update_array /opt/observium/includes/polling/functions.inc.php:812 array( [uptime] => int(549) [last_polled] => array( [0] => string(5) "NOW()" ) [last_polled_timetaken] => double(0.2069) ) SQL[UPDATE `devices` set `uptime` ='549',`last_polled` =NOW(),`last_polled_timetaken` ='0.2069' WHERE `device_id` = '104'] SQL RUNTIME[0.00231314s] o Updated Data uptime, last_polled, last_polled_timetaken SQL[UPDATE `alert_table` set `state` ='{\"metrics\":{\"storage_perc\":null}}',`count` ='0',`alert_status` ='1',`last_message` ='Checks OK',`last_checked` ='1536841106',`last_ok` ='1536841106' WHERE `alert_table_id` = '3992'] SQL RUNTIME[0.00072098s] RRD /opt/observium/rrd/eaton9px11000i.ipex.be/alert-3992.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/eaton9px11000i.ipex.be/alert-3992.rrd N:1:1] RRD RUNTIME[0.003s] RRD STDOUT[OK u:0.00 s:0.00 r:0.19] RRD_STATUS[TRUE] SQL[UPDATE `alert_table` set `state` ='{\"metrics\":{\"device_status\":\"1\"}}',`count` ='0',`alert_status` ='1',`last_message` ='Checks OK',`last_checked` ='1536841106',`last_ok` ='1536841106' WHERE `alert_table_id` = '5049'] SQL RUNTIME[0.00095606s] RRD /opt/observium/rrd/eaton9px11000i.ipex.be/alert-5049.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/eaton9px11000i.ipex.be/alert-5049.rrd N:1:1] RRD RUNTIME[0.0022s] RRD STDOUT[OK u:0.00 s:0.00 r:0.19] RRD_STATUS[TRUE] SQL[DELETE FROM `observium_processes` WHERE `process_pid` = '27599' AND `process_name` = 'poller.php' AND `device_id` = '104'] SQL RUNTIME[0.00168705s] /opt/observium/poller.php: eaton9px11000i.ipex.be - 1 devices polled in 0.446 secs ##### Completed polling run at 2018-09-13 14:18:26 ##### o Devices Polled 1 o Poller Time 0.446 secs o Memory usage 12MB (peak: 14MB) o MySQL Usage Insert[1/0.001s] Update[5/0.007s] Delete[1/0.002s] Cell[4/0.002s] Row[11/0.003s] Rows[11/0.009s] Col[0/0s] (0.024s 5.353%) o RRDTool Usage update[6/0.01s] (0.01s 2.278%) o SNMP Usage snmpget[10/0.115s] (0.115s 25.829%)