The problem is that the device is UP but observium mark it as down when I run the command that you have given me. If I run it a second time, the debug gives the output. Anyway, here we are
root@banana:/opt/observium# ./poller.php -d -m ospf -h cisco
DEBUG!
Observium CE 0.15.6.6430
Poller
CMD[/opt/observium/scripts/distro]
EXITCODE[0]
RUNTIME[0.0597s]
STDOUT[
Linux|3.2.0-4-amd64|amd64|Debian|7.9
]
CMD[/usr/bin/env python --version 2>&1]
EXITCODE[0]
RUNTIME[0.0048s]
STDOUT[
Python 2.7.3
]
SQL[SELECT version()]
RUNTIME[0.00039983s]
CMD[/usr/bin/snmpget --version 2>&1]
EXITCODE[0]
RUNTIME[0.0036s]
STDOUT[
NET-SNMP version: 5.4.3
]
CMD[/usr/bin/rrdtool --version |head -n1]
EXITCODE[0]
RUNTIME[0.0145s]
STDOUT[
]
Software versions:
OS: Linux 3.2.0-4-amd64 [amd64] (Debian 7.9)
PHP: 5.4.45-0+deb7u2
Python: Python 2.7.3
MySQL: 5.5.46-0+deb7u1
SNMP: NET-SNMP 5.4.3
RRDtool: 1.4.7
Starting polling run:
SQL[SELECT `device_id` FROM `devices` WHERE `disabled` = 0 AND `hostname` LIKE 'cisco' ORDER BY `device_id` ASC]
RUNTIME[0.00168800s]
SQL[SELECT * FROM `devices` WHERE `device_id` = '13']
RUNTIME[0.00124693s]
SQL[SELECT * FROM `devices_attribs` WHERE `device_id` = '13']
RUNTIME[0.00027514s]
cisco 13 ios (cisco)
CMD[/usr/bin/fping -t 500 -c 1 -q 192.168.0.1 2>&1]
EXITCODE[0]
RUNTIME[0.0079s]
STDOUT[
192.168.0.1 : xmt/rcv/%loss = 1/1/0%, min/avg/max = 1.30/1.30/1.30
]
SQL[SELECT `version` FROM `dbSchema`;]
RUNTIME[0.00029898s]
CMD[/usr/bin/snmpget -v2c -c *** -Pu -OQUst -m SNMPv2-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'cisco':'161' sysObjectID.0 sysUpTime.0]
EXITCODE[0]
RUNTIME[0.0216s]
STDOUT[
sysObjectID.0 = enterprises.9.1.1274
sysUpTime.0 = 12730812
]
SNMP_STATUS[TRUE]
RRD /opt/observium/rrd/cisco/status.rrd already exists - no need to create.
RRD[cmd[update /opt/observium/rrd/cisco/status.rrd N:1]
stdout[OK u:0.00 s:0.01 r:0.04]
stderr[]]
RRD /opt/observium/rrd/cisco/ping.rrd already exists - no need to create.
RRD[cmd[update /opt/observium/rrd/cisco/ping.rrd N:1.30]
stdout[OK u:0.00 s:0.01 r:0.04]
stderr[]]
RRD /opt/observium/rrd/cisco/ping_snmp.rrd already exists - no need to create.
RRD[cmd[update /opt/observium/rrd/cisco/ping_snmp.rrd N:29.38]
stdout[OK u:0.00 s:0.01 r:0.05]
stderr[]]
SQL[SELECT * FROM `device_graphs` WHERE `device_id` = '13']
RUNTIME[0.00036597s]
including: includes/polling/system.inc.php
CMD[/usr/bin/snmpget -v2c -c *** -Pu -OQUs -m SNMPv2-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'cisco':'161' sysUpTime.0 sysLocation.0 sysContact.0 sysName.0]
EXITCODE[0]
RUNTIME[0.0279s]
STDOUT[
sysUpTime.0 = 1:11:21:48.17
sysLocation.0 = London,England,United Kingdom
]
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':'cisco':'161' sysDescr.0]
EXITCODE[0]
RUNTIME[0.0251s]
STDOUT[
Cisco IOS Software, C880 Software (C880DATA-UNIVERSALK9-M), Version 15.4(3)M4, RELEASE SOFTWARE (fc1)
Copyright (c) 1986-2015 by Cisco Systems, Inc.
Compiled Sun 27-Sep-15 08:56 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':'cisco':'161' sysObjectID.0]
EXITCODE[0]
RUNTIME[0.0254s]
STDOUT[
.1.3.6.1.4.1.9.1.1274
]
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':'cisco':'161' snmpEngineID.0]
EXITCODE[0]
RUNTIME[0.0224s]
STDOUT[
"80 00 00 09 03 00 A4 93 4C 73 0A 2E "
]
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':'cisco':'161' snmpEngineTime.0]
EXITCODE[0]
RUNTIME[0.0219s]
STDOUT[
127276
]
SNMP_STATUS[TRUE]
Using SNMP Agent sysUpTime (127308 sec. => 1 day, 11h 21m 48s)
RRD /opt/observium/rrd/cisco/uptime.rrd already exists - no need to create.
RRD[cmd[update /opt/observium/rrd/cisco/uptime.rrd N:127308]
stdout[OK u:0.00 s:0.01 r:0.21]
stderr[]]
Uptime: 1 day, 11h 21m 48s
Array
(
[sysUpTime] => 127308
[use] => sysUpTime
[snmpEngineTime] => 127276
[uptime] => 127308
[formatted] => 1 day, 11h 21m 48s
[message] => Using SNMP Agent sysUpTime
[previous] => 127296
[diff] => -12
[rebooted] => 0
)
SQL[SELECT * FROM `devices_locations` WHERE `device_id` = '13']
RUNTIME[0.00041199s]
Module [ system ] time: 0.1608s
including: includes/polling/os.inc.php
SQL[SELECT * FROM `entPhysical` WHERE `device_id` = '13' AND `entPhysicalContainedIn` = '0']
RUNTIME[0.00030303s]
SQL[SELECT * FROM `devices_attribs` WHERE `device_id` = '13']
RUNTIME[0.00009608s]
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':'cisco':'161' sysUpTime.0 ccmHistoryRunningLastChanged.0 ccmHistoryRunningLastSaved.0 ccmHistoryStartupLastChanged.0]
EXITCODE[0]
RUNTIME[0.0444s]
STDOUT[
sysUpTime.0 = 12730835
ccmHistoryRunningLastChanged.0 = 10719628
ccmHistoryRunningLastSaved.0 = 11174925
ccmHistoryStartupLastChanged.0 = 11174925
]
SNMP_STATUS[TRUE]
Cisco configuration ages
sysUptime : 2015-12-16 09:46:23 | 1 day, 11h 21m 48s
Running : 2015-12-17 15:32:59 | 5h 35m 12s
Saved : 2015-12-17 16:48:52 | 4h 19m 19s
Startup : 2015-12-17 16:48:52 | 4h 19m 19s
Hardware: CISCO887VA-K9 Version: 15.4(3)M4 Features: UNIVERSALK9 Serial: FGL1621234J Asset:
Module [ os ] time: 0.0643s
including: includes/polling/ospf.inc.php
OSPF: Processes:
SQL[SELECT * FROM `ospf_instances` WHERE `device_id` = '13']
RUNTIME[0.00058198s]
CMD[/usr/bin/snmpbulkwalk -v2c -c *** -Pu -OQUs -m OSPF-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'cisco':'161' ospfGeneralGroup]
EXITCODE[0]
RUNTIME[0.0387s]
STDOUT[
ospfRouterId.0 = 192.168.0.1
ospfAdminStat.0 = enabled
ospfVersionNumber.0 = version2
ospfAreaBdrRtrStatus.0 = false
ospfASBdrRtrStatus.0 = true
ospfExternLsaCount.0 = 1
ospfExternLsaCksumSum.0 = 43614
ospfTOSSupport.0 = false
ospfOriginateNewLsas.0 = 4
ospfRxNewLsas.0 = 14
ospfExtLsdbLimit.0 = -1
ospfMulticastExtensions.0 = 0
ospfExitOverflowInterval.0 = 0
ospfDemandExtensions.0 = true
]
SNMP_STATUS[TRUE]
CMD[/usr/bin/snmpbulkwalk -v2c -c *** -Pu -OQUs -m OSPF-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'cisco':'161' ospfAreaEntry]
EXITCODE[0]
RUNTIME[0.0418s]
STDOUT[
ospfAreaId.0.0.0.0 = 0.0.0.0
ospfAuthType.0.0.0.0 = none
ospfImportAsExtern.0.0.0.0 = importExternal
ospfSpfRuns.0.0.0.0 = 13
ospfAreaBdrRtrCount.0.0.0.0 = 0
ospfAsBdrRtrCount.0.0.0.0 = 1
ospfAreaLsaCount.0.0.0.0 = 3
ospfAreaLsaCksumSum.0.0.0.0 = 59675
ospfAreaSummary.0.0.0.0 = sendAreaSummary
ospfAreaStatus.0.0.0.0 = active
]
SNMP_STATUS[TRUE]
CMD[/usr/bin/snmpbulkwalk -v2c -c *** -Pu -OQUs -m OSPF-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'cisco':'161' ospfIfEntry]
EXITCODE[0]
RUNTIME[0.0409s]
STDOUT[
ospfIfIpAddress.192.168.0.1.0 = 192.168.0.1
ospfAddressLessIf.192.168.0.1.0 = 0
ospfIfAreaId.192.168.0.1.0 = 0.0.0.0
ospfIfType.192.168.0.1.0 = broadcast
ospfIfAdminStat.192.168.0.1.0 = enabled
ospfIfRtrPriority.192.168.0.1.0 = 1
ospfIfTransitDelay.192.168.0.1.0 = 1
ospfIfRetransInterval.192.168.0.1.0 = 5
ospfIfHelloInterval.192.168.0.1.0 = 10
ospfIfRtrDeadInterval.192.168.0.1.0 = 40
ospfIfPollInterval.192.168.0.1.0 = 120
ospfIfState.192.168.0.1.0 = backupDesignatedRouter
ospfIfDesignatedRouter.192.168.0.1.0 = 192.168.0.6
ospfIfBackupDesignatedRouter.192.168.0.1.0 = 192.168.0.1
ospfIfEvents.192.168.0.1.0 = 2
ospfIfAuthKey.192.168.0.1.0 = ""
ospfIfStatus.192.168.0.1.0 = active
ospfIfMulticastForwarding.192.168.0.1.0 = blocked
ospfIfDemand.192.168.0.1.0 = false
ospfIfAuthType.192.168.0.1.0 = none
]
SNMP_STATUS[TRUE]
CMD[/usr/bin/snmpbulkwalk -v2c -c *** -Pu -OQUs -m OSPF-MIB -M /opt/observium/mibs/rfc:/opt/observium/mibs/net-snmp 'udp':'cisco':'161' ospfNbrEntry]
EXITCODE[0]
RUNTIME[0.0416s]
STDOUT[
ospfNbrIpAddr.192.168.0.6.0 = 192.168.0.6
ospfNbrAddressLessIndex.192.168.0.6.0 = 0
ospfNbrRtrId.192.168.0.6.0 = 192.168.30.1
ospfNbrOptions.192.168.0.6.0 = 2
ospfNbrPriority.192.168.0.6.0 = 1
ospfNbrState.192.168.0.6.0 = full
ospfNbrEvents.192.168.0.6.0 = 6
ospfNbrLsRetransQLen.192.168.0.6.0 = 0
ospfNbmaNbrStatus.192.168.0.6.0 = active
ospfNbmaNbrPermanence.192.168.0.6.0 = dynamic
ospfNbrHelloSuppressed.192.168.0.6.0 = false
]
SNMP_STATUS[TRUE]
Polled: Array
(
[0] => Array
(
[ospfRouterId] => 192.168.0.1
[ospfAdminStat] => enabled
[ospfVersionNumber] => version2
[ospfAreaBdrRtrStatus] => false
[ospfASBdrRtrStatus] => true
[ospfExternLsaCount] => 1
[ospfExternLsaCksumSum] => 43614
[ospfTOSSupport] => false
[ospfOriginateNewLsas] => 4
[ospfRxNewLsas] => 14
[ospfExtLsdbLimit] => -1
[ospfMulticastExtensions] => 0
[ospfExitOverflowInterval] => 0
[ospfDemandExtensions] => true
)
)
Database: Array
(
[0] => Array
(
[device_id] => 13
[ospf_instance_id] => 0
[ospfRouterId] => 192.168.0.1
[ospfAdminStat] => enabled
[ospfVersionNumber] => version2
[ospfAreaBdrRtrStatus] => false
[ospfASBdrRtrStatus] => true
[ospfExternLsaCount] => 1
[ospfExternLsaCksumSum] => 43614
[ospfTOSSupport] => false
[ospfOriginateNewLsas] => 4
[ospfRxNewLsas] => 14
[ospfExtLsdbLimit] => -1
[ospfMulticastExtensions] => 0
[ospfExitOverflowInterval] => 0
[ospfDemandExtensions] => true
)
)
. Areas:
SQL[SELECT * FROM `ospf_areas` WHERE `device_id` = '13']
RUNTIME[0.00085807s]
poll
Polled: Array
(
[0.0.0.0] => Array
(
[ospfAreaId] => 0.0.0.0
[ospfAuthType] => none
[ospfImportAsExtern] => importExternal
[ospfSpfRuns] => 13
[ospfAreaBdrRtrCount] => 0
[ospfAsBdrRtrCount] => 1
[ospfAreaLsaCount] => 3
[ospfAreaLsaCksumSum] => 59675
[ospfAreaSummary] => sendAreaSummary
[ospfAreaStatus] => active
)
)
Database: Array
(
[0.0.0.0] => Array
(
[device_id] => 13
[ospfAreaId] => 0.0.0.0
[ospfAuthType] => none
[ospfImportAsExtern] => importExternal
[ospfSpfRuns] => 13
[ospfAreaBdrRtrCount] => 0
[ospfAsBdrRtrCount] => 1
[ospfAreaLsaCount] => 3
[ospfAreaLsaCksumSum] => 59675
[ospfAreaSummary] => sendAreaSummary
[ospfAreaStatus] => active
)
)
none=noneimportExternal=importExternal13=130=01=13=359675=59675sendAreaSummary=sendAreaSummaryactive=active. Ports:
SQL[SELECT * FROM `ospf_ports` WHERE `device_id` = '13']
RUNTIME[0.00055003s]
Polled: Array
(
[192.168.0.1.0] => Array
(
[ospfIfIpAddress] => 192.168.0.1
[ospfAddressLessIf] => 0
[ospfIfAreaId] => 0.0.0.0
[ospfIfType] => broadcast
[ospfIfAdminStat] => enabled
[ospfIfRtrPriority] => 1
[ospfIfTransitDelay] => 1
[ospfIfRetransInterval] => 5
[ospfIfHelloInterval] => 10
[ospfIfRtrDeadInterval] => 40
[ospfIfPollInterval] => 120
[ospfIfState] => backupDesignatedRouter
[ospfIfDesignatedRouter] => 192.168.0.6
[ospfIfBackupDesignatedRouter] => 192.168.0.1
[ospfIfEvents] => 2
[ospfIfAuthKey] =>
[ospfIfStatus] => active
[ospfIfMulticastForwarding] => blocked
[ospfIfDemand] => false
[ospfIfAuthType] => none
)
)
Database: Array
(
[192.168.0.1.0] => Array
(
[device_id] => 13
[port_id] => 0
[ospf_port_id] => 192.168.0.1.0
[ospfIfIpAddress] =>
[ospfAddressLessIf] => 0
[ospfIfAreaId] =>
[ospfIfType] =>
[ospfIfAdminStat] =>
[ospfIfRtrPriority] =>
[ospfIfTransitDelay] =>
[ospfIfRetransInterval] =>
[ospfIfHelloInterval] =>
[ospfIfRtrDeadInterval] =>
[ospfIfPollInterval] =>
[ospfIfState] =>
[ospfIfDesignatedRouter] =>
[ospfIfBackupDesignatedRouter] =>
[ospfIfEvents] =>
[ospfIfAuthKey] =>
[ospfIfStatus] =>
[ospfIfMulticastForwarding] =>
[ospfIfDemand] =>
[ospfIfAuthType] =>
)
)
SQL[SELECT A.`port_id` FROM ipv4_addresses AS A, ports AS I WHERE A.ipv4_address = '192.168.0.1' AND I.port_id = A.port_id AND I.device_id = '13']
RUNTIME[0.00022006s]
SQL[UPDATE `ospf_ports` set `ospfIfIpAddress` ='192.168.0.1',`port_id` ='140',`ospfIfAreaId` ='0.0.0.0',`ospfIfType` ='broadcast',`ospfIfAdminStat` ='enabled',`ospfIfRtrPriority` ='1',`ospfIfTransitDelay` ='1',`ospfIfRetransInterval` ='5',`ospfIfHelloInterval` ='10',`ospfIfRtrDeadInterval` ='40',`ospfIfPollInterval` ='120',`ospfIfState` ='backupDesignatedRouter',`ospfIfDesignatedRouter` ='192.168.0.6',`ospfIfBackupDesignatedRouter` ='192.168.0.1',`ospfIfEvents` ='2',`ospfIfStatus` ='active',`ospfIfMulticastForwarding` ='blocked',`ospfIfDemand` ='false',`ospfIfAuthType` ='none' WHERE `device_id` = '13' AND `ospf_port_id` = '192.168.0.1.0']
RUNTIME[0.00754905s]
U Neighbours:
SQL[SELECT * FROM `ospf_nbrs` WHERE `device_id` = '13']
RUNTIME[0.00103998s]
Polled: Array
(
[192.168.0.6.0] => Array
(
[ospfNbrIpAddr] => 192.168.0.6
[ospfNbrAddressLessIndex] => 0
[ospfNbrRtrId] => 192.168.30.1
[ospfNbrOptions] => 2
[ospfNbrPriority] => 1
[ospfNbrState] => full
[ospfNbrEvents] => 6
[ospfNbrLsRetransQLen] => 0
[ospfNbmaNbrStatus] => active
[ospfNbmaNbrPermanence] => dynamic
[ospfNbrHelloSuppressed] => false
)
)
Database: Array
(
[192.168.0.6.0] => Array
(
[device_id] => 13
[port_id] => 0
[ospf_nbr_id] => 192.168.0.6.0
[ospfNbrIpAddr] => 192.168.0.6
[ospfNbrAddressLessIndex] => 0
[ospfNbrRtrId] => 192.168.30.1
[ospfNbrOptions] => 2
[ospfNbrPriority] => 1
[ospfNbrState] => full
[ospfNbrEvents] => 6
[ospfNbrLsRetransQLen] => 0
[ospfNbmaNbrStatus] => active
[ospfNbmaNbrPermanence] => dynamic
[ospfNbrHelloSuppressed] => false
)
)
SQL[SELECT A.`port_id` FROM ipv4_addresses AS A, nbrs AS I WHERE A.ipv4_address = '192.168.0.6' AND I.port_id = A.port_id AND I.device_id = '13']
RUNTIME[0.00047898s]
192.168.0.6|192.168.0.6
0|0
192.168.30.1|192.168.30.1
2|2
1|1
full|full
6|6
0|0
active|active
dynamic|dynamic
false|false
SQL[UPDATE `ospf_nbrs` set `port_id` =NULL WHERE `device_id` = '13' AND `ospf_nbr_id` = '192.168.0.6.0']
RUNTIME[0.00143194s]
URRD /opt/observium/rrd/cisco/ospf-statistics.rrd already exists - no need to create.
RRD[cmd[update /opt/observium/rrd/cisco/ospf-statistics.rrd N:1:1:1:1]
stdout[OK u:0.00 s:0.01 r:0.53]
stderr[]]
Module [ ospf ] time: 0.2514s
Graphs [checked]: ping, ping_snmp, uptime
Polled in 0.5361 seconds
Updating cisco - Array
(
[uptime] => 127308
[last_polled] => Array
(
[0] => NOW()
)
[last_polled_timetaken] => 0.5361
[device_state] => a:1:{s:15:"poller_mod_perf";a:3:{s:6:"system";s:6:"0.1608";s:2:"os";s:6:"0.0643";s:4:"ospf";s:6:"0.2514";}}
)
SQL[UPDATE `devices` set `uptime` ='127308',`last_polled` =NOW(),`last_polled_timetaken` ='0.5361',`device_state` ='a:1:{s:15:\"poller_mod_perf\";a:3:{s:6:\"system\";s:6:\"0.1608\";s:2:\"os\";s:6:\"0.0643\";s:4:\"ospf\";s:6:\"0.2514\";}}' WHERE `device_id` = '13']
RUNTIME[0.00207877s]
UPDATED!
SQL[INSERT INTO `perf_times` (`type`,`doing`,`start`,`duration`,`devices`) VALUES ('poll','cisco','1450386492.0854','0.652','1')]
RUNTIME[0.00049019s]
./poller.php: cisco - 1 devices polled in 0.652 secs
NOTE, $config['snmp']['hide_auth'] sets as TRUE, snmp community and snmp v3 auth hidden from debug output.
Memory usage: 4.25MB (peak: 4.25MB)
MySQL: Cell[3/0.01s] Row[3/0.01s] Rows[6/0.02s] Column[0/0s] Update[3/0.02s] Insert[1/0s] Delete[0/0s]
root@banana:/opt/observium#