DEBUG! CMD[/usr/bin/svn info /opt/observium]  CMD EXITCODE[0] CMD RUNTIME[0.0101s] 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: 8843 Node Kind: directory Schedule: normal Last Changed Author: adama Last Changed Rev: 8841 Last Changed Date: 2017-09-12 16:30:58 +0200 (Tue, 12 Sep 2017) ] SQL[SELECT `attrib_value` FROM `observium_attribs` WHERE `attrib_type` = 'dbSchema';] SQL RUNTIME[0.00347686s] SQL[SELECT @@SESSION.sql_mode;] SQL RUNTIME[0.00019407s] SQL[SELECT `attrib_value` FROM `observium_attribs` WHERE `attrib_type` = 'current_rev';] SQL RUNTIME[0.00030088s] SQL[SELECT * FROM `config`] SQL RUNTIME[0.00026393s] CMD[/bin/hostname -f]  CMD EXITCODE[0] CMD RUNTIME[0.0001s] STDOUT[ observium.dom.prodware.net ]  ___ _ _ / _ \ | |__ ___ ___ _ __ __ __(_) _ _ _ __ ___ | | | || '_ \ / __| / _ \| '__|\ \ / /| || | | || '_ ` _ \ | |_| || |_) |\__ \| __/| | \ V / | || |_| || | | | | | \___/ |_.__/ |___/ \___||_| \_/ |_| \__,_||_| |_| |_| Observium Professional 17.9.8841 http://www.observium.org  SQL[SELECT `attrib_value` FROM `observium_attribs` WHERE `attrib_type` = 'latest_ver';] SQL RUNTIME[0.00045395s] SQL[SELECT `attrib_value` FROM `observium_attribs` WHERE `attrib_type` = 'latest_rev';] SQL RUNTIME[0.00019002s] SQL[SELECT `attrib_value` FROM `observium_attribs` WHERE `attrib_type` = 'latest_rev_date';] SQL RUNTIME[0.00020099s] There is a newer revision of Observium available! CMD[date "+%:z"]  CMD EXITCODE[0] CMD RUNTIME[0.0014s] STDOUT[ +02:00 ] SQL[SELECT TIMEDIFF(NOW(), UTC_TIMESTAMP);] SQL RUNTIME[0.00017309s] Version 17.9.8859 (15th October 2017) is 18 revisions ahead.  CMD[/opt/observium/scripts/distro]  CMD EXITCODE[0] CMD RUNTIME[0.1692s] STDOUT[ Linux|4.4.0-93-generic|amd64|Ubuntu|16.04|vmware ] CMD[/usr/bin/env python --version 2>&1]  CMD EXITCODE[0] CMD RUNTIME[0.001s] CMD EXITDELAY[10ms] STDOUT[ Python 2.7.12 ] SQL[SELECT version();] SQL RUNTIME[0.00017595s] CMD[/usr/bin/snmpget --version 2>&1]  CMD EXITCODE[0] CMD RUNTIME[0.0015s] STDOUT[ NET-SNMP version: 5.7.3 ] CMD[/usr/bin/rrdtool --version | head -n1]  CMD EXITCODE[0] CMD RUNTIME[0.0072s] CMD EXITDELAY[10ms] STDOUT[ RRDtool 1.5.5 Copyright by Tobias Oetiker ] CMD[/usr/sbin/apache2 -v | awk '/Server version:/ {print $3}']  CMD EXITCODE[0] CMD RUNTIME[0.0219s] STDOUT[ Apache/2.4.18 ] SQL[SELECT @@SESSION.sql_mode;] SQL RUNTIME[0.00017715s] SQL[SHOW VARIABLES LIKE 'character_set_connection'] SQL RUNTIME[0.00293803s] ##### Software versions #####   o OS  Linux 4.4.0-93-generic [amd64] (Ubuntu 16.04)  o Apache  2.4.18  o PHP  7.0.22-0ubuntu0.16.04.1 (OPcache: DISABLED)  o Python  2.7.12  o MySQL  5.7.19-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  Sunday, 15-Oct-17 00:05:09 CEST  o PHP  +02:00  o MySQL  +02:00 SQL[SELECT * FROM `alerts_maint` WHERE `maint_start` < '1508018709' AND `maint_end` > '1508018709'] SQL RUNTIME[0.00040102s] ##### Starting polling run at 2017-10-15 00:05:09 #####  SQL[SELECT `device_id` FROM `devices` WHERE `disabled` = 0 AND `hostname` LIKE 'cons01-ams01' ORDER BY `device_id` ASC] SQL RUNTIME[0.00032496s] SQL[SELECT * FROM `devices` WHERE `device_id` = '93'] SQL RUNTIME[0.00032806s] SQL[SELECT * FROM `entity_attribs` WHERE `entity_type` = 'device' AND `entity_id` = '93'] SQL RUNTIME[0.00023913s] SQL[SELECT * FROM `observium_processes` WHERE `process_name` = 'poller.php' AND `device_id` = '93'] SQL RUNTIME[0.00018001s] CMD[/bin/ps -ww -o pid,ppid,uid,gid,tty,stat,time,lstart,args -p 14282]  CMD EXITCODE[0] CMD RUNTIME[0.0198s] STDOUT[ PID PPID UID GID TT STAT TIME STARTED COMMAND 14282 9407 0 0 pts/0 S+ 00:00:00 Sun Oct 15 00:05:09 2017 php ./poller.php -m os -d -h cons01-ams01 ] CMD[/bin/ps -ww -o pid,ppid,uid,gid,tty,stat,time,lstart,args -p 9407]  CMD EXITCODE[0] CMD RUNTIME[0.0205s] STDOUT[ PID PPID UID GID TT STAT TIME STARTED COMMAND 9407 9376 0 0 pts/0 Ss 00:00:00 Sun Oct 15 00:04:50 2017 -bash ] SQL[INSERT INTO `observium_processes` (`process_pid`,`process_name`,`process_ppid`,`process_uid`,`process_command`,`process_start`,`device_id`) VALUES ('14282','poller.php','9407','0','php ./poller.php -m os -d -h cons01-ams01','1508018709','93')] SQL RUNTIME[0.00068092s] SQL[SELECT * FROM `alert_tests` WHERE 1] SQL RUNTIME[0.00033212s] Cached 30 alert rules. SQL[SELECT * FROM `alert_table` WHERE `device_id` = '93'] SQL RUNTIME[0.00031996s] ##### cons01-ams01 [93] #####   o OS  ios  o OS Group  cisco  o Last poll duration  3.45 seconds  o Last Polled  2017-10-15 00:00:19  o SNMP Version  v2c CMD[/usr/bin/fping -t 500 -c 1 -q 10.101.1.9 2>&1]  CMD EXITCODE[0] CMD RUNTIME[0.0142s] STDOUT[ 10.101.1.9 : xmt/rcv/%loss = 1/1/0%, min/avg/max = 11.6/11.6/11.6 ] CMD[/usr/bin/snmpget -v2c -c *** -Pu -OQUst -m SNMPv2-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'cons01-ams01':'161' sysObjectID.0 sysUpTime.0]  CMD EXITCODE[0] CMD RUNTIME[0.019s] STDOUT[ sysObjectID.0 = enterprises.9.1.471 sysUpTime.0 = 28559448 ] SNMP STATUS[TRUE]  o Device status  Device is reachable by PING (11.6ms) and SNMP (19.04ms) RRD /opt/observium/rrd/cons01-ams01/status.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/cons01-ams01/status.rrd N:1] RRD RUNTIME[0.0011s] RRD STDOUT[OK u:0.00 s:0.00 r:0.08] RRD_STATUS[TRUE]  RRD /opt/observium/rrd/cons01-ams01/ping.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/cons01-ams01/ping.rrd N:11.6] RRD RUNTIME[0.0011s] RRD STDOUT[OK u:0.00 s:0.00 r:0.08] RRD_STATUS[TRUE]  RRD /opt/observium/rrd/cons01-ams01/ping_snmp.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/cons01-ams01/ping_snmp.rrd N:19.04] RRD RUNTIME[0.0011s] RRD STDOUT[OK u:0.00 s:0.00 r:0.08] RRD_STATUS[TRUE]  SQL[SELECT * FROM `device_graphs` WHERE `device_id` = '93'] SQL RUNTIME[0.00033998s]  o Modules Enabled  system, os including: includes/polling/system.inc.php ##### Module Start: system #####  SQL[SELECT * FROM `observium_attribs`] SQL RUNTIME[0.00029111s]  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':'cons01-ams01':'161' sysUpTime.0 sysLocation.0 sysContact.0 sysName.0]  CMD EXITCODE[0] CMD RUNTIME[0.0209s] STDOUT[ sysUpTime.0 = 3:7:19:54.51 sysLocation.0 = Equinix AM5 (AMS01) sysContact.0 = noc@prodware.fr sysName.0 = cons01-ams01.dom.prodware.net ] 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':'cons01-ams01':'161' sysDescr.0]  CMD EXITCODE[0] CMD RUNTIME[0.02s] STDOUT[ Cisco IOS Software, C2600 Software (C2600-ADVSECURITYK9-M), Version 12.4(15)T14, RELEASE SOFTWARE (fc2) Technical Support: http://www.cisco.com/techsupport Copyright (c) 1986-2010 by Cisco Systems, Inc. Compiled Tue 17-Aug-10 05:40 by prod_rel_team ] 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':'cons01-ams01':'161' sysObjectID.0]  CMD EXITCODE[0] CMD RUNTIME[0.0189s] STDOUT[ .1.3.6.1.4.1.9.1.471 ] SNMP STATUS[TRUE] CMD[/usr/bin/snmpget -v2c -c *** -Pu -OQv -m SNMP-FRAMEWORK-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'cons01-ams01':'161' snmpEngineID.0]  CMD EXITCODE[0] CMD RUNTIME[0.0197s] STDOUT[ "80 00 00 09 03 00 00 12 D9 A2 76 A0 " ] SNMP STATUS[TRUE] CMD[/usr/bin/snmpget -v2c -c *** -Pu -OUqv -m SNMP-FRAMEWORK-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'cons01-ams01':'161' snmpEngineTime.0]  CMD EXITCODE[0] CMD RUNTIME[0.0197s] STDOUT[ 285574 ] SNMP STATUS[TRUE] Using SNMP Agent sysUpTime (285594 sec. => 3 days, 7h 19m 54s) RRD /opt/observium/rrd/cons01-ams01/uptime.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/cons01-ams01/uptime.rrd N:285594] RRD RUNTIME[0.0011s] RRD STDOUT[OK u:0.00 s:0.00 r:0.19] RRD_STATUS[TRUE]   o Uptime  3 days, 7h 19m 54s   /opt/observium/includes/polling/system.inc.php:253  array( [sysUpTime] => int(285594) [use] => string(9) "sysUpTime" [snmpEngineTime] => string(6) "285574" [uptime] => int(285594) [formatted] => string(18) "3 days, 7h 19m 54s" [message] => string(26) "Using SNMP Agent sysUpTime" [previous] => string(6) "285300" [diff] => int(-294) [rebooted] => int(0) )  o sysObjectID  .1.3.6.1.4.1.9.1.471  o snmpEngineID  8000000903000012D9A276A0  o sysDescr  Cisco IOS Software, C2600 Software (C2600-ADVSECURITYK9-M), Version 12.4(15)T14, RELEASE SOFTWARE (fc2) Technical Support: http://www.cisco.com/techsupport Copyright (c) 1986-2010 by Cisco Systems, Inc. Compiled Tue 17-Aug-10 05:40 by prod_rel_team  o sysName  cons01-ams01.dom.prodware.net  o Location  Equinix AM5 (AMS01) SQL[SELECT * FROM `devices_locations` WHERE `device_id` = '93'] SQL RUNTIME[0.00034189s]  o Module time  0.1115s including: includes/polling/os.inc.php ##### Module Start: os #####  SQL[SELECT * FROM `entPhysical` WHERE `device_id` = '93' AND `entPhysicalContainedIn` = '0'] SQL RUNTIME[0.00029302s]  o OS Poller  Group CMD[/usr/bin/snmpget -v2c -c *** -Pu -OQUst -m SNMPv2-MIB:CISCO-CONFIG-MAN-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp:/opt/observium/mibs/cisco 'udp':'cons01-ams01':'161' sysUpTime.0 ccmHistoryRunningLastChanged.0 ccmHistoryRunningLastSaved.0 ccmHistoryStartupLastChanged.0]  CMD EXITCODE[0] CMD RUNTIME[0.0324s] CMD EXITDELAY[10ms] STDOUT[ sysUpTime.0 = 28559463 ccmHistoryRunningLastChanged.0 = 3087 ccmHistoryRunningLastSaved.0 = 0 ccmHistoryStartupLastChanged.0 = 0 ] SNMP STATUS[TRUE] SQL[SELECT * FROM `entPhysical` WHERE `device_id` = '93' AND `entPhysicalClass` = 'module' AND `entPhysicalContainedIn` = '1' AND `entPhysicalSerialNum` != ''] SQL RUNTIME[0.00046802s]  o Hardware  ..................  o Version  12.4(15)T14  o Features  ADVSECURITYK9  o Serial  JHY0907K2PG  o Asset   ##### Cisco configuration ages #####   o sysUptime  2017-10-11 16:45:15 | 3 days, 7h 19m 54s  o Running  2017-10-11 16:45:46 | 3 days, 7h 19m 23s  o Saved  2017-10-11 16:45:15 | 3 days, 7h 19m 54s  o Startup  2017-10-11 16:45:15 | 3 days, 7h 19m 54s  o Module time  0.0470s ##### cons01-ams01 [93] completed poller modules at 2017-10-15 00:05:10 #####   o Graphs [checked]  ping, ping_snmp, uptime  o Poller time  0.2 seconds Updating cons01-ams01 -  > $update_array /opt/observium/includes/polling/functions.inc.php:752  array( [uptime] => int(285594) [last_polled] => array( [0] => string(5) "NOW()" ) [last_polled_timetaken] => double(0.2) [device_state] => string(74) "a:1:{s:15:"poller_mod_perf";a:2:{s:6:"system";d:0.1115;s:2:"os";d:0.047;}}" ) SQL[UPDATE `devices` set `uptime` ='285594',`last_polled` =NOW(),`last_polled_timetaken` ='0.2',`device_state` ='a:1:{s:15:\"poller_mod_perf\";a:2:{s:6:\"system\";d:0.1115;s:2:\"os\";d:0.047;}}' WHERE `device_id` = '93'] SQL RUNTIME[0.00089788s]  o Updated Data  uptime, last_polled, last_polled_timetaken, device_state SQL[UPDATE `alert_table` set `state` ='{\"metrics\":{\"device_status\":\"1\"}}',`count` ='0',`alert_status` ='1',`last_message` ='Checks OK',`last_checked` ='1508018710',`last_ok` ='1508018710' WHERE `alert_table_id` = '33'] SQL RUNTIME[0.00053000s] RRD /opt/observium/rrd/cons01-ams01/alert-33.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/cons01-ams01/alert-33.rrd N:1:1] RRD RUNTIME[0.0011s] RRD STDOUT[OK u:0.00 s:0.00 r:0.24] RRD_STATUS[TRUE]  SQL[UPDATE `alert_table` set `state` ='{\"metrics\":{\"mempool_perc\":null}}',`count` ='0',`alert_status` ='1',`last_message` ='Checks OK',`last_checked` ='1508018710',`last_ok` ='1508018710' WHERE `alert_table_id` = '2756'] SQL RUNTIME[0.00135612s] RRD /opt/observium/rrd/cons01-ams01/alert-2756.rrd already exists - no need to create. RRD CMD[update /opt/observium/rrd/cons01-ams01/alert-2756.rrd N:1:1] RRD RUNTIME[0.0012s] RRD STDOUT[OK u:0.00 s:0.00 r:0.25] RRD_STATUS[TRUE]  SQL[DELETE FROM `observium_processes` WHERE `process_pid` = '14282' AND `process_name` = 'poller.php' AND `device_id` = '93'] SQL RUNTIME[0.00065517s] SQL[INSERT INTO `perf_times` (`type`,`doing`,`start`,`duration`,`devices`) VALUES ('poll','cons01-ams01','1508018709.7294','0.508','1')] SQL RUNTIME[0.00116086s] ./poller.php: cons01-ams01 - 1 devices polled in 0.508 secs ##### Completed polling run at 2017-10-15 00:05:10 #####  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  0.508 secs  o Memory usage  12MB (peak: 14MB)  o MySQL Usage  Insert[2/0.002s] Update[3/0.003s] Delete[1/0.001s] Cell[4/0.001s] Row[9/0.008s] Rows[10/0.007s] Col[0/0s] (0.023s 4.46%)  o RRDTool Usage  update[6/0.007s] (0.007s 1.317%)  o SNMP Usage  snmpget[7/0.168s] (0.168s 33.053%)