DEBUG! CMD[/usr/bin/svn info /opt/observium]  CMD EXITCODE[0] CMD RUNTIME[0.0123s] 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.00033879s] SQL[SELECT @@SESSION.sql_mode;] SQL RUNTIME[0.00011897s] SQL[SELECT `attrib_value` FROM `observium_attribs` WHERE `attrib_type` = 'current_rev';] SQL RUNTIME[0.00016022s] SQL[SELECT * FROM `config`] SQL RUNTIME[0.00021911s] 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.00031877s] SQL[SELECT `attrib_value` FROM `observium_attribs` WHERE `attrib_type` = 'latest_rev';] SQL RUNTIME[0.00019813s] SQL[SELECT `attrib_value` FROM `observium_attribs` WHERE `attrib_type` = 'latest_rev_date';] SQL RUNTIME[0.00015593s] CMD[/opt/observium/scripts/distro]  CMD EXITCODE[0] CMD RUNTIME[0.0084s] 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.002s] STDOUT[ Python 2.7.12 ] SQL[SELECT version();] SQL RUNTIME[0.00020981s] CMD[/usr/bin/snmpget --version 2>&1]  CMD EXITCODE[0] CMD RUNTIME[0.0024s] CMD EXITDELAY[10ms] STDOUT[ NET-SNMP version: 5.7.3 ] CMD[/usr/bin/rrdtool --version | head -n1]  CMD EXITCODE[0] CMD RUNTIME[0.0073s] 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.0239s] 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.00032616s] SQL[SELECT @@SESSION.sql_mode;] SQL RUNTIME[0.00012398s] SQL[SHOW VARIABLES LIKE 'character_set_connection'] SQL RUNTIME[0.01624107s] ##### 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:51 CEST  o PHP  +02:00  o MySQL  +02:00 SQL[SELECT * FROM `alerts_maint` WHERE `maint_start` < '1493283471' AND `maint_end` > '1493283471'] SQL RUNTIME[0.00027680s] ##### Starting polling run at 2017-04-27 10:57:51 #####  SQL[SELECT `device_id` FROM `devices` WHERE `disabled` = 0 AND `hostname` LIKE 'as03-par02-fab02' ORDER BY `device_id` ASC] SQL RUNTIME[0.00051093s] SQL[SELECT * FROM `devices` WHERE `device_id` = '73'] SQL RUNTIME[0.00037217s] SQL[SELECT * FROM `entity_attribs` WHERE `entity_type` = 'device' AND `entity_id` = '73'] SQL RUNTIME[0.00026488s] SQL[SELECT * FROM `observium_processes` WHERE `process_name` = 'poller.php' AND `device_id` = '73'] SQL RUNTIME[0.00020504s] CMD[/bin/ps -ww -o pid,ppid,uid,gid,tty,stat,time,lstart,args -p 21499]  CMD EXITCODE[0] CMD RUNTIME[0.0142s] STDOUT[ PID PPID UID GID TT STAT TIME STARTED COMMAND 21499 7260 0 0 pts/0 S+ 00:00:00 Thu Apr 27 10:57:50 2017 php ./poller.php -d -m os -h as03-par02-fab02 ] CMD[/bin/ps -ww -o pid,ppid,uid,gid,tty,stat,time,lstart,args -p 7260]  CMD EXITCODE[0] CMD RUNTIME[0.0161s] 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 ('21499','poller.php','7260','0','php ./poller.php -d -m os -h as03-par02-fab02','1493283470','73')] SQL RUNTIME[0.09946799s] SQL[SELECT * FROM `alert_tests` WHERE 1] SQL RUNTIME[0.00046706s] Cached 29 alert rules. SQL[SELECT * FROM `alert_table` WHERE `device_id` = '73'] SQL RUNTIME[0.00222898s] ##### as03-par02-fab02 [73] #####   o OS  nos  o Last poll duration  0.39 seconds  o Last Polled  2017-04-27 10:57:24  o SNMP Version  v2c CMD[/usr/bin/fping -t 500 -c 1 -q 10.75.2.27 2>&1]  CMD EXITCODE[0] CMD RUNTIME[0.0035s] STDOUT[ 10.75.2.27 : xmt/rcv/%loss = 1/1/0%, min/avg/max = 1.76/1.76/1.76 ] CMD[/usr/bin/snmpget -v2c -c *** -Pu -OQUst -m SNMPv2-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'as03-par02-fab02':'161' sysObjectID.0 sysUpTime.0]  CMD EXITCODE[0] CMD RUNTIME[0.022s] STDOUT[ sysObjectID.0 = enterprises.1588.3.3.1.131 sysUpTime.0 = 15938100 ] SNMP STATUS[TRUE]  o Device status  Device is reachable by PING (1.76ms) and SNMP (21.97ms) RRD /opt/observium/rrd/as03-par02-fab02/status.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/as03-par02-fab02/status.rrd N:1] RRD RUNTIME[0.0011s] RRD STDOUT[OK u:0.00 s:0.00 r:0.16] RRD_STATUS[TRUE]  RRD /opt/observium/rrd/as03-par02-fab02/ping.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/as03-par02-fab02/ping.rrd N:1.76] RRD RUNTIME[0.0011s] RRD STDOUT[OK u:0.00 s:0.00 r:0.17] RRD_STATUS[TRUE]  RRD /opt/observium/rrd/as03-par02-fab02/ping_snmp.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/as03-par02-fab02/ping_snmp.rrd N:21.97] RRD RUNTIME[0.0011s] RRD STDOUT[OK u:0.00 s:0.00 r:0.17] RRD_STATUS[TRUE]  SQL[SELECT * FROM `device_graphs` WHERE `device_id` = '73'] SQL RUNTIME[0.00044703s]  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` = '73' AND `attrib_type` = 'sysORID'] SQL RUNTIME[0.00027800s] SQL[SELECT * FROM `observium_attribs`] SQL RUNTIME[0.00021291s]  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':'as03-par02-fab02':'161' sysUpTime.0 sysLocation.0 sysContact.0 sysName.0]  CMD EXITCODE[0] CMD RUNTIME[0.0177s] STDOUT[ sysUpTime.0 = 1:20:16:21.00 sysLocation.0 = Alphalink TelcoCenter (PAR02) sysContact.0 = noc@prodware.fr sysName.0 = as03-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':'as03-par02-fab02':'161' sysDescr.0]  CMD EXITCODE[0] CMD RUNTIME[0.0214s] STDOUT[ fab02-par02, BR-VDX6740, 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':'as03-par02-fab02':'161' sysObjectID.0]  CMD EXITCODE[0] CMD RUNTIME[0.0089s] STDOUT[ .1.3.6.1.4.1.1588.3.3.1.131 ] 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':'as03-par02-fab02':'161' snmpEngineID.0]  CMD EXITCODE[0] CMD RUNTIME[0.016s] STDOUT[ "80 00 06 34 B2 10 00 50 EB 1A F8 E3 FC " ] 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':'as03-par02-fab02':'161' hrSystemUptime.0]  CMD EXITCODE[0] CMD RUNTIME[0.0193s] 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` = '73' AND `error_code` = '1000' AND `snmp_cmd` = 'snmpget' AND `mib` = 'HOST-RESOURCES-MIB' AND `oid` = 'hrSystemUptime.0';] SQL RUNTIME[0.00034595s] SQL[UPDATE `snmp_errors` set `error_count` ='51443',`updated` ='1493283471' WHERE `error_id` = '1764'] SQL RUNTIME[0.08494711s] CMD[/usr/bin/snmpget -v2c -c *** -Pu -OUqv -m SNMP-FRAMEWORK-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'as03-par02-fab02':'161' snmpEngineTime.0]  CMD EXITCODE[0] CMD RUNTIME[0.0154s] STDOUT[ 159381 ] SNMP STATUS[TRUE] Using SNMP Agent sysUpTime (159381 sec. => 1 day, 20h 16m 21s) RRD /opt/observium/rrd/as03-par02-fab02/uptime.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/as03-par02-fab02/uptime.rrd N:159381] RRD RUNTIME[0.0011s] RRD STDOUT[OK u:0.00 s:0.00 r:0.37] RRD_STATUS[TRUE]   o Uptime  1 day, 20h 16m 21s   /opt/observium/includes/polling/system.inc.php:213  array( [sysUpTime] => int(159381) [hrSystemUptime] => bool(false) [use] => string(9) "sysUpTime" [snmpEngineTime] => string(6) "159381" [uptime] => int(159381) [formatted] => string(18) "1 day, 20h 16m 21s" [message] => string(26) "Using SNMP Agent sysUpTime" [previous] => string(6) "159353" [diff] => int(-28) [rebooted] => int(0) )  o sysObjectID  .1.3.6.1.4.1.1588.3.3.1.131  o snmpEngineID  80000634B2100050EB1AF8E3FC  o sysDescr  fab02-par02, BR-VDX6740, Network Operating System Software Version 7.1.0a.  o sysName  as03-par02-fab02  o Location  Alphalink TelcoCenter (PAR02) SQL[SELECT * FROM `devices_locations` WHERE `device_id` = '73'] SQL RUNTIME[0.00038600s]  o Module time  0.2016s including: includes/polling/os.inc.php ##### Module Start: os #####  SQL[SELECT * FROM `entPhysical` WHERE `device_id` = '73' AND `entPhysicalContainedIn` = '0'] SQL RUNTIME[0.00032711s] 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':'as03-par02-fab02':'161' swFirmwareVersion.0]  CMD EXITCODE[0] CMD RUNTIME[0.02s] STDOUT[ No Such Instance currently exists at this OID ] SNMP STATUS[FALSE] SNMP ERROR[#1000 - Failed response] SQL[SELECT * FROM `snmp_errors` WHERE `device_id` = '73' AND `error_code` = '1000' AND `snmp_cmd` = 'snmpget' AND `mib` = 'SW-MIB' AND `oid` = 'swFirmwareVersion.0';] SQL RUNTIME[0.00045204s] SQL[UPDATE `snmp_errors` set `error_count` ='51443',`updated` ='1493283471' WHERE `error_id` = '1769'] SQL RUNTIME[0.08573318s]  o OS Poller  OS  o Hardware  VDX-6740-24-R  o Version    o Features    o Serial  CPL3849L074  o Asset    o Module time  0.1101s ##### as03-par02-fab02 [73] completed poller modules at 2017-04-27 10:57:52 #####   o Graphs [checked]  ping, ping_snmp, uptime  o Poller time  0.3468 seconds Updating as03-par02-fab02 -  > $update_array /opt/observium/includes/polling/functions.inc.php:760  array( [uptime] => int(159381) [last_polled] => array( [0] => string(5) "NOW()" ) [last_polled_timetaken] => double(0.3468) [device_state] => string(75) "a:1:{s:15:"poller_mod_perf";a:2:{s:6:"system";d:0.2016;s:2:"os";d:0.1101;}}" ) SQL[UPDATE `devices` set `uptime` ='159381',`last_polled` =NOW(),`last_polled_timetaken` ='0.3468',`device_state` ='a:1:{s:15:\"poller_mod_perf\";a:2:{s:6:\"system\";d:0.2016;s:2:\"os\";d:0.1101;}}' WHERE `device_id` = '73'] SQL RUNTIME[0.18585801s]  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) "1.76" [device_snmp] => string(5) "21.97" [device_uptime] => string(6) "159353" [device_rebooted] => int(0) [device_duration_poll] => string(4) "0.39" ) SQL[UPDATE `alert_table` set `state` ='{\"metrics\":{\"device_status\":\"1\"}}',`count` ='0',`alert_status` ='1',`last_message` ='Checks OK',`last_checked` ='1493283472',`last_ok` ='1493283472' WHERE `alert_table_id` = '13'] SQL RUNTIME[0.11868691s] RRD /opt/observium/rrd/as03-par02-fab02/alert-13.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/as03-par02-fab02/alert-13.rrd N:1:1] RRD RUNTIME[0.0012s] RRD STDOUT[OK u:0.00 s:0.00 r:0.79] RRD_STATUS[TRUE]  SQL[UPDATE `alert_table` set `state` ='{\"metrics\":{\"mempool_perc\":null}}',`count` ='0',`alert_status` ='1',`last_message` ='Checks OK',`last_checked` ='1493283472',`last_ok` ='1493283472' WHERE `alert_table_id` = '1628'] SQL RUNTIME[0.14590406s] RRD /opt/observium/rrd/as03-par02-fab02/alert-1628.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/as03-par02-fab02/alert-1628.rrd N:1:1] RRD RUNTIME[0.0012s] RRD STDOUT[OK u:0.00 s:0.00 r:0.94] RRD_STATUS[TRUE]  SQL[DELETE FROM `observium_processes` WHERE `process_pid` = '21499' AND `process_name` = 'poller.php' AND `device_id` = '73'] SQL RUNTIME[0.09673500s] SQL[INSERT INTO `perf_times` (`type`,`doing`,`start`,`duration`,`devices`) VALUES ('poll','as03-par02-fab02','1493283471.4928','1.129','1')] SQL RUNTIME[0.12207103s] ./poller.php: as03-par02-fab02 - 1 devices polled in 1.129 secs ##### Completed polling run at 2017-04-27 10:57:52 #####  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.222s] Update[5/0.622s] Delete[1/0.097s] Cell[4/0.001s] Row[11/0.005s] Rows[10/0.024s] Col[0/0s] (0.971s 85.983%)  o RRDTool Usage  update[6/0.007s] (0.007s 0.603%)  o SNMP Usage  snmpget[8/0.155s] (0.155s 13.731%)