DEBUG! CMD[/usr/bin/svn info /opt/observium]  CMD EXITCODE[0] CMD RUNTIME[0.0091s] 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: 8477 Node Kind: directory Schedule: normal Last Changed Author: adama Last Changed Rev: 8476 Last Changed Date: 2017-04-20 01:47:52 +0200 (Thu, 20 Apr 2017) ] SQL[SELECT `attrib_value` FROM `observium_attribs` WHERE `attrib_type` = 'dbSchema';] SQL RUNTIME[0.00021005s] SQL[SELECT @@SESSION.sql_mode;] SQL RUNTIME[0.00010300s] SQL[SELECT `attrib_value` FROM `observium_attribs` WHERE `attrib_type` = 'current_rev';] SQL RUNTIME[0.00016093s] SQL[SELECT * FROM `config`] SQL RUNTIME[0.00022006s] CMD[/bin/hostname -f]  CMD EXITCODE[0] CMD RUNTIME[0.0016s] STDOUT[ observium.dom.prodware.net ]  ___ _ _ / _ \ | |__ ___ ___ _ __ __ __(_) _ _ _ __ ___ | | | || '_ \ / __| / _ \| '__|\ \ / /| || | | || '_ ` _ \ | |_| || |_) |\__ \| __/| | \ V / | || |_| || | | | | | \___/ |_.__/ |___/ \___||_| \_/ |_| \__,_||_| |_| |_| Observium Professional 17.4.8476 http://www.observium.org  SQL[SELECT `attrib_value` FROM `observium_attribs` WHERE `attrib_type` = 'latest_ver';] SQL RUNTIME[0.00032210s] SQL[SELECT `attrib_value` FROM `observium_attribs` WHERE `attrib_type` = 'latest_rev';] SQL RUNTIME[0.00014687s] SQL[SELECT `attrib_value` FROM `observium_attribs` WHERE `attrib_type` = 'latest_rev_date';] SQL RUNTIME[0.00014114s] CMD[/opt/observium/scripts/distro]  CMD EXITCODE[0] CMD RUNTIME[0.0082s] STDOUT[ Linux|4.4.0-75-generic|amd64|Ubuntu|16.04|vmware ] CMD[/usr/bin/env python --version 2>&1]  CMD EXITCODE[0] CMD RUNTIME[0.0019s] STDOUT[ Python 2.7.12 ] SQL[SELECT version();] SQL RUNTIME[0.00017691s] CMD[/usr/bin/snmpget --version 2>&1]  CMD EXITCODE[0] CMD RUNTIME[0.0016s] STDOUT[ NET-SNMP version: 5.7.3 ] CMD[/usr/bin/rrdtool --version | head -n1]  CMD EXITCODE[0] CMD RUNTIME[0.0063s] STDOUT[ RRDtool 1.5.5 Copyright by Tobias Oetiker ] CMD[/usr/bin/env apache2 -v | awk '/Server version:/ {print $3}']  CMD EXITCODE[0] CMD RUNTIME[0.0265s] STDOUT[ Apache/2.4.18 ] CMD[date "+%:z"]  CMD EXITCODE[0] CMD RUNTIME[0.0014s] STDOUT[ +02:00 ] SQL[SELECT TIMEDIFF(NOW(), UTC_TIMESTAMP);] SQL RUNTIME[0.00016904s] SQL[SELECT @@SESSION.sql_mode;] SQL RUNTIME[0.00010991s] SQL[SHOW VARIABLES LIKE 'character_set_connection'] SQL RUNTIME[0.00199914s] ##### Software versions #####   o OS  Linux 4.4.0-75-generic [amd64] (Ubuntu 16.04|vmware)  o Apache  2.4.18  o PHP  7.0.15-0ubuntu0.16.04.4 (OPcache: DISABLED)  o Python  2.7.12  o MySQL  5.7.17-0ubuntu0.16.04.1 (extension: mysqli 5.0.12-dev)  o SNMP  NET-SNMP 5.7.3  o RRDtool  1.5.5 ##### Memory Limit #####   o PHP  Unlimited ##### MySQL mode #####   o MySQL  ##### Charset info #####   o PHP  UTF-8  o MySQL  utf8 ##### Timezones info #####   o Date  Thursday, 27-Apr-17 10:57:42 CEST  o PHP  +02:00  o MySQL  +02:00 SQL[SELECT * FROM `alerts_maint` WHERE `maint_start` < '1493283462' AND `maint_end` > '1493283462'] SQL RUNTIME[0.00037503s] ##### Starting polling run at 2017-04-27 10:57:42 #####  SQL[SELECT `device_id` FROM `devices` WHERE `disabled` = 0 AND `hostname` LIKE 'as01-par02-fab02' ORDER BY `device_id` ASC] SQL RUNTIME[0.00059414s] SQL[SELECT * FROM `devices` WHERE `device_id` = '71'] SQL RUNTIME[0.00031304s] SQL[SELECT * FROM `entity_attribs` WHERE `entity_type` = 'device' AND `entity_id` = '71'] SQL RUNTIME[0.00024009s] SQL[SELECT * FROM `observium_processes` WHERE `process_name` = 'poller.php' AND `device_id` = '71'] SQL RUNTIME[0.00018907s] CMD[/bin/ps -ww -o pid,ppid,uid,gid,tty,stat,time,lstart,args -p 2737]  CMD EXITCODE[0] CMD RUNTIME[0.014s] STDOUT[ PID PPID UID GID TT STAT TIME STARTED COMMAND 2737 2733 0 0 ? S 00:00:01 Thu Apr 27 10:55:01 2017 php /opt/observium/poller.php -q -h 71 ] CMD[/bin/ps -ww -o pid,ppid,uid,gid,tty,stat,time,lstart,args -p 20191]  CMD EXITCODE[0] CMD RUNTIME[0.0157s] STDOUT[ PID PPID UID GID TT STAT TIME STARTED COMMAND 20191 7260 0 0 pts/0 S+ 00:00:00 Thu Apr 27 10:57:41 2017 php ./poller.php -d -m os -h as01-par02-fab02 ] CMD[/bin/ps -ww -o pid,ppid,uid,gid,tty,stat,time,lstart,args -p 7260]  CMD EXITCODE[0] CMD RUNTIME[0.014s] STDOUT[ PID PPID UID GID TT STAT TIME STARTED COMMAND 7260 6526 0 0 pts/0 Ss 00:00:00 Thu Apr 27 10:35:05 2017 -bash ] SQL[INSERT INTO `observium_processes` (`process_pid`,`process_name`,`process_ppid`,`process_uid`,`process_command`,`process_start`,`device_id`) VALUES ('20191','poller.php','7260','0','php ./poller.php -d -m os -h as01-par02-fab02','1493283461','71')] SQL RUNTIME[0.11064410s] SQL[SELECT * FROM `alert_tests` WHERE 1] SQL RUNTIME[0.00041604s] Cached 29 alert rules. SQL[SELECT * FROM `alert_table` WHERE `device_id` = '71'] SQL RUNTIME[0.00316596s] ##### as01-par02-fab02 [71] #####   o OS  nos  o Last poll duration  203.95 seconds  o Last Polled  2017-04-27 10:53:27  o SNMP Version  v2c CMD[/usr/bin/fping -t 500 -c 1 -q 10.75.2.25 2>&1]  CMD EXITCODE[0] CMD RUNTIME[0.011s] CMD EXITDELAY[10ms] STDOUT[ 10.75.2.25 : xmt/rcv/%loss = 1/1/0%, min/avg/max = 9.32/9.32/9.32 ] CMD[/usr/bin/snmpget -v2c -c *** -Pu -OQUst -m SNMPv2-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'as01-par02-fab02':'161' sysObjectID.0 sysUpTime.0]  CMD EXITCODE[0] CMD RUNTIME[0.0188s] STDOUT[ sysObjectID.0 = enterprises.1588.3.3.1.164 sysUpTime.0 = 15936800 ] SNMP STATUS[TRUE]  o Device status  Device is reachable by PING (9.32ms) and SNMP (18.77ms) RRD /opt/observium/rrd/as01-par02-fab02/status.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/as01-par02-fab02/status.rrd N:1] RRD RUNTIME[0.0011s] RRD STDOUT[OK u:0.00 s:0.00 r:0.21] RRD_STATUS[TRUE]  RRD /opt/observium/rrd/as01-par02-fab02/ping.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/as01-par02-fab02/ping.rrd N:9.32] RRD RUNTIME[0.0011s] RRD STDOUT[OK u:0.00 s:0.00 r:0.21] RRD_STATUS[TRUE]  RRD /opt/observium/rrd/as01-par02-fab02/ping_snmp.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/as01-par02-fab02/ping_snmp.rrd N:18.77] RRD RUNTIME[0.0011s] RRD STDOUT[OK u:0.00 s:0.00 r:0.21] RRD_STATUS[TRUE]  SQL[SELECT * FROM `device_graphs` WHERE `device_id` = '71'] SQL RUNTIME[0.00032806s]  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` = '71' AND `attrib_type` = 'sysORID'] SQL RUNTIME[0.00021482s] SQL[SELECT * FROM `observium_attribs`] SQL RUNTIME[0.00016403s]  o SNMPv2-MIB  CMD[/usr/bin/snmpget -v2c -c *** -Pu -OQUs -m SNMPv2-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'as01-par02-fab02':'161' sysUpTime.0 sysLocation.0 sysContact.0 sysName.0]  CMD EXITCODE[0] CMD RUNTIME[0.0225s] STDOUT[ sysUpTime.0 = 1:20:16:08.00 sysLocation.0 = Alphalink TelcoCenter (PAR02) sysContact.0 = noc@prodware.fr sysName.0 = as01-par02-fab02 ] SNMP STATUS[TRUE] CMD[/usr/bin/snmpget -v2c -c *** -Pu -Oqv -m SNMPv2-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'as01-par02-fab02':'161' sysDescr.0]  CMD EXITCODE[0] CMD RUNTIME[0.0155s] STDOUT[ fab02-par02, BR-VDX6940-144S, Network Operating System Software Version 7.1.0a. ] SNMP STATUS[TRUE] CMD[/usr/bin/snmpget -v2c -c *** -Pu -Oqvn -m SNMPv2-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'as01-par02-fab02':'161' sysObjectID.0]  CMD EXITCODE[0] CMD RUNTIME[0.0193s] STDOUT[ .1.3.6.1.4.1.1588.3.3.1.164 ] SNMP STATUS[TRUE] CMD[/usr/bin/snmpget -v2c -c *** -Pu -Ovqn -m SNMP-FRAMEWORK-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'as01-par02-fab02':'161' snmpEngineID.0]  CMD EXITCODE[0] CMD RUNTIME[0.0083s] STDOUT[ "80 00 06 34 B2 10 00 00 27 F8 F0 FA 38 " ] SNMP STATUS[TRUE] CMD[/usr/bin/snmpget -v2c -c *** -Pu -Oqv -m HOST-RESOURCES-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'as01-par02-fab02':'161' hrSystemUptime.0]  CMD EXITCODE[0] CMD RUNTIME[0.0154s] STDOUT[ No Such Object available on this agent at this OID ] SNMP STATUS[FALSE] SNMP ERROR[#1000 - Failed response] SQL[SELECT * FROM `snmp_errors` WHERE `device_id` = '71' AND `error_code` = '1000' AND `snmp_cmd` = 'snmpget' AND `mib` = 'HOST-RESOURCES-MIB' AND `oid` = 'hrSystemUptime.0';] SQL RUNTIME[0.00041795s] SQL[UPDATE `snmp_errors` set `error_count` ='51913',`updated` ='1493283463' WHERE `error_id` = '1766'] SQL RUNTIME[0.06114697s] CMD[/usr/bin/snmpget -v2c -c *** -Pu -OUqv -m SNMP-FRAMEWORK-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'as01-par02-fab02':'161' snmpEngineTime.0]  CMD EXITCODE[0] CMD RUNTIME[0.0127s] STDOUT[ 159369 ] SNMP STATUS[TRUE] Using SNMP Agent snmpEngineTime (159369 sec. => 1 day, 20h 16m 9s) RRD /opt/observium/rrd/as01-par02-fab02/uptime.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/as01-par02-fab02/uptime.rrd N:159369] RRD RUNTIME[0.0011s] RRD STDOUT[OK u:0.00 s:0.00 r:0.38] RRD_STATUS[TRUE]   o Uptime  1 day, 20h 16m 9s   /opt/observium/includes/polling/system.inc.php:213  array( [sysUpTime] => int(159368) [hrSystemUptime] => bool(false) [use] => string(14) "snmpEngineTime" [snmpEngineTime] => string(6) "159369" [uptime] => string(6) "159369" [formatted] => string(17) "1 day, 20h 16m 9s" [message] => string(31) "Using SNMP Agent snmpEngineTime" [previous] => string(6) "158909" [diff] => int(-460) [rebooted] => int(0) )  o sysObjectID  .1.3.6.1.4.1.1588.3.3.1.164  o snmpEngineID  80000634B210000027F8F0FA38  o sysDescr  fab02-par02, BR-VDX6940-144S, Network Operating System Software Version 7.1.0a.  o sysName  as01-par02-fab02  o Location  Alphalink TelcoCenter (PAR02) SQL[SELECT * FROM `devices_locations` WHERE `device_id` = '71'] SQL RUNTIME[0.00035501s]  o Module time  0.1698s including: includes/polling/os.inc.php ##### Module Start: os #####  SQL[SELECT * FROM `entPhysical` WHERE `device_id` = '71' AND `entPhysicalContainedIn` = '0'] SQL RUNTIME[0.00027919s] CMD[/usr/bin/snmpget -v2c -c *** -Pu -Oqv -m SW-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp:/opt/observium/mibs/brocade 'udp':'as01-par02-fab02':'161' swFirmwareVersion.0]  CMD EXITCODE[0] CMD RUNTIME[0.0532s] STDOUT[ v7.1.0a ] SNMP STATUS[TRUE] Added OS param from SNMP definition walk: 'version' = 'v7.1.0a'  o OS Poller  OS  o Hardware  VDX6940-144S  o Version  7.1.0a  o Features    o Serial  CWY3850L014  o Asset    o Module time  0.0564s ##### as01-par02-fab02 [71] completed poller modules at 2017-04-27 10:57:43 #####   o Graphs [checked]  ping, ping_snmp, uptime  o Poller time  0.2754 seconds Updating as01-par02-fab02 -  > $update_array /opt/observium/includes/polling/functions.inc.php:760  array( [uptime] => string(6) "159369" [last_polled] => array( [0] => string(5) "NOW()" ) [last_polled_timetaken] => double(0.2754) [device_state] => string(102) "a:1:{s:15:"poller_mod_perf";a:2:{s:6:"system";d:0.16980000000000001;s:2:"os";d:0.056399999999999999;}}" ) SQL[UPDATE `devices` set `uptime` ='159369',`last_polled` =NOW(),`last_polled_timetaken` ='0.2754',`device_state` ='a:1:{s:15:\"poller_mod_perf\";a:2:{s:6:\"system\";d:0.16980000000000001;s:2:\"os\";d:0.056399999999999999;}}' WHERE `device_id` = '71'] SQL RUNTIME[0.10572219s]  o Updated Data  uptime, last_polled, last_polled_timetaken, device_state  > $data /opt/observium/includes/alerts.inc.php:61  array( [device_status] => string(1) "1" [device_status_type] => string(0) "" [device_ping] => string(4) "9.32" [device_snmp] => string(5) "18.77" [device_uptime] => string(6) "158909" [device_rebooted] => int(0) [device_duration_poll] => string(6) "203.95" ) SQL[UPDATE `alert_table` set `state` ='{\"metrics\":{\"device_status\":\"1\"}}',`count` ='0',`alert_status` ='1',`last_message` ='Checks OK',`last_checked` ='1493283463',`last_ok` ='1493283463' WHERE `alert_table_id` = '11'] SQL RUNTIME[0.10254788s] RRD /opt/observium/rrd/as01-par02-fab02/alert-11.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/as01-par02-fab02/alert-11.rrd N:1:1] RRD RUNTIME[0.0011s] RRD STDOUT[OK u:0.00 s:0.00 r:0.65] RRD_STATUS[TRUE]  SQL[UPDATE `alert_table` set `state` ='{\"metrics\":{\"mempool_perc\":null}}',`count` ='0',`alert_status` ='1',`last_message` ='Checks OK',`last_checked` ='1493283463',`last_ok` ='1493283463' WHERE `alert_table_id` = '1154'] SQL RUNTIME[0.20386600s] RRD /opt/observium/rrd/as01-par02-fab02/alert-1154.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/as01-par02-fab02/alert-1154.rrd N:1:1] RRD RUNTIME[0.0011s] RRD STDOUT[OK u:0.00 s:0.00 r:0.85] RRD_STATUS[TRUE]  SQL[DELETE FROM `observium_processes` WHERE `process_pid` = '20191' AND `process_name` = 'poller.php' AND `device_id` = '71'] SQL RUNTIME[0.20662403s] SQL[INSERT INTO `perf_times` (`type`,`doing`,`start`,`duration`,`devices`) VALUES ('poll','as01-par02-fab02','1493283462.8596','1.129','1')] SQL RUNTIME[0.05705595s] ./poller.php: as01-par02-fab02 - 1 devices polled in 1.129 secs ##### Completed polling run at 2017-04-27 10:57:44 #####  NOTE, $config['snmp']['hide_auth'] is set to TRUE, snmp community and snmp v3 auth hidden from debug output.  o Devices Polled  1  o Poller Time  1.129 secs  o Memory usage  12MB (peak: 12MB)  o MySQL Usage  Insert[2/0.168s] Update[4/0.474s] Delete[1/0.207s] Cell[4/0.001s] Row[10/0.004s] Rows[10/0.011s] Col[0/0s] (0.865s 76.579%)  o RRDTool Usage  update[6/0.007s] (0.007s 0.588%)  o SNMP Usage  snmpget[8/0.177s] (0.177s 15.663%)