librenms@LibreNMS:~$ ./poller.php -h OSMC -d -v -m applications LibreNMS Poller SQL[select `migration` from `migrations` order by `id` desc limit 1 [] 0.27ms] SQL[select count(*) as aggregate from `migrations` limit 1 [] 0.25ms] SQL[select version() [] 0.15ms] =================================== Version info: Commit SHA: 759dcb1babf7eb7af52192d30377962c783bb61c Commit Date: 1641825018 DB Schema: 2021_11_29_165436_improve_ports_search_index (229) PHP: 7.4.25 MySQL: 10.5.12-MariaDB-0+deb11u1 RRDTool: 1.7.2 SNMP: 5.9 ==================================DEBUG! Updating os_def.cache Override poller modules: applications Starting polling run: SQL[SELECT * FROM `devices` WHERE `disabled` = 0 AND `hostname` = 'OSMC' ORDER BY `device_id` ASC [] 0.58ms] SQL[select * from `devices` where `device_id` = ? limit 1 [8] 0.29ms] SQL[select * from `devices_attribs` where `devices_attribs`.`device_id` = ? and `devices_attribs`.`device_id` is not null [8] 0.22ms] Attempting to initialize OS: linux Attempting to initialize Group OS: unix OS initialized: LibreNMS\OS\Shared\Unix Hostname: OSMC Device ID: 8 OS: linux Assigned IP: 10.227.196.4 (unix) [FPING] '/usr/bin/fping' '-e' '-q' '-c' '2' '-p' '200' '-t' '200' '-O' '0' '10.227.196.4' response: xmt/rcv/%loss = 2/2/0%, min/avg/max = 0.381/0.394/0.406 SNMP['/usr/bin/snmpget' '-M' '/opt/librenms/mibs' '-v3' '-l' 'authPriv' '-n' "" '-x' 'AES' '-X' '$Q0GLnG1DhzzNgc6C$sKGJwu' '-a' 'SHA' '-A' '$efjyExR81kNw!PBi#6AbRAx' '-u' 'LibreNMS' '-OQXUte' 'udp:10.227.196.4:161' 'SNMPv2-MIB::sysObjectID.0'] SNMPv2-MIB::sysObjectID.0 = SNMPv2-SMI::enterprises.8072.3.2.10 SQL[insert into `device_perf` (`min`, `max`, `avg`, `xmt`, `rcv`, `loss`, `device_id`, `timestamp`) values (?, ?, ?, ?, ?, ?, ?, ?) [0.381,0.406,0.394,2,2,0,8,"2022-01-11 22:47:08"] 0.33ms] SQL[update `devices` set `last_ping_timetaken` = ? where `device_id` = ? [0.394,8] 0.27ms] RRD[last OSMC/ping-perf.rrd --daemon unix:/var/run/rrdcached.sock] RRDtool Output: 1641933900 OK u:0.00 s:0.00 r:0.23 RRD[update OSMC/ping-perf.rrd N:0.394 --daemon unix:/var/run/rrdcached.sock] RRDtool Output: SQL[select * from `device_outages` where `device_outages`.`device_id` = ? and `device_outages`.`device_id` is not null and `up_again` is null order by `going_down` desc limit 1 [8] 0.37ms] Modules status: Global+ OS Device #### Load poller module core #### SNMP['/usr/bin/snmpget' '-M' '/opt/librenms/mibs' '-v3' '-l' 'authPriv' '-n' "" '-x' 'AES' '-X' '$Q0GLnG1DhzzNgc6C$sKGJwu' '-a' 'SHA' '-A' '$efjyExR81kNw!PBi#6AbRAx' '-u' 'LibreNMS' '-OQXUte' '-On' 'udp:10.227.196.4:161' 'SNMPv2-MIB::sysDescr.0' 'SNMPv2-MIB::sysObjectID.0' 'SNMPv2-MIB::sysUpTime.0' 'SNMPv2-MIB::sysName.0'] .1.3.6.1.2.1.1.1.0 = Linux osmc 5.10.78-2-osmc #1 SMP PREEMPT Wed Nov 17 04:52:11 UTC 2021 aarch64 .1.3.6.1.2.1.1.2.0 = .1.3.6.1.4.1.8072.3.2.10 .1.3.6.1.2.1.1.3.0 = 64599151 .1.3.6.1.2.1.1.5.0 = osmc SNMP['/usr/bin/snmpget' '-M' '/opt/librenms/mibs' '-v3' '-l' 'authPriv' '-n' "" '-x' 'AES' '-X' '$Q0GLnG1DhzzNgc6C$sKGJwu' '-a' 'SHA' '-A' '$efjyExR81kNw!PBi#6AbRAx' '-u' 'LibreNMS' '-OQXUte' 'udp:10.227.196.4:161' 'SNMP-FRAMEWORK-MIB::snmpEngineTime.0' 'HOST-RESOURCES-MIB::hrSystemUptime.0'] SNMP-FRAMEWORK-MIB::snmpEngineTime.0 = 645992 HOST-RESOURCES-MIB::hrSystemUptime.0 = 129330069 Uptime seconds: 1293301 RRD[last OSMC/uptime.rrd --daemon unix:/var/run/rrdcached.sock] RRDtool Output: 1641933900 OK u:0.00 s:0.00 r:0.28 RRD[update OSMC/uptime.rrd N:1293301 --daemon unix:/var/run/rrdcached.sock] RRDtool Output: OK u:0.00 s:0.00 r:0.23 Uptime: 14 days 23 hours 15 minutes 1 second SQL[update `devices` set `uptime` = ? where `device_id` = ? [1293301,8] 0.31ms] >> Runtime for poller module 'core': 0.0487 seconds with 56984 bytes >> SNMP: [2/0.05s] MySQL: [1/0.00s] RRD: [2/0.00s] #### Unload poller module core #### RRD[last OSMC/poller-perf-core.rrd --daemon unix:/var/run/rrdcached.sock] RRDtool Output: 1641933900 OK u:0.00 s:0.00 r:0.28 RRD[update OSMC/poller-perf-core.rrd N:0.048726797103882 --daemon unix:/var/run/rrdcached.sock] RRDtool Output: OK u:0.00 s:0.00 r:0.27 Modules status: Global+ OS Device #### Load poller module applications #### SQL[SELECT * FROM `applications` WHERE `device_id` = ? [8] 0.26ms] Application: docker, app_id=10SNMP['/usr/bin/snmpget' '-v3' '-l' 'authPriv' '-n' "" '-a' 'SHA' '-A' '$efjyExR81kNw!PBi#6AbRAx' '-u' 'LibreNMS' '-x' 'AES' '-X' '$Q0GLnG1DhzzNgc6C$sKGJwu' '-Oqv' '-m' 'NET-SNMP-EXTEND-MIB' '-M' '/opt/librenms/mibs' 'udp:10.227.196.4:161' 'nsExtendOutputFull.6.100.111.99.107.101.114'] {"version":"1","data":[{"container":"rtorrent_logs","pids":1,"memory":{"used":"1.68MiB","limit":"3.705GiB","perc":"0.04%"},"cpu":"0.01%"},{"container":"rtorrent","pids":150,"memory":{"used":"334.7MiB","limit":"3.705GiB","perc":"8.82%"},"cpu":"0.28%"},{"container":"rtorrent_geoip","pids":10,"memory":{"used":"25.9MiB","limit":"3.705GiB","perc":"0.68%"},"cpu":"0.00%"}],"error":"0","errorString":""} RRD[last OSMC/app-docker-10-rtorrent_logs.rrd --daemon unix:/var/run/rrdcached.sock] RRDtool Output: 1641933900 OK u:0.00 s:0.01 r:3.12 RRD[update OSMC/app-docker-10-rtorrent_logs.rrd N:0.01:1:3978213457:1761607:0.04 --daemon unix:/var/run/rrdcached.sock] RRDtool Output: OK u:0.00 s:0.00 r:0.28 RRD[last OSMC/app-docker-10-rtorrent.rrd --daemon unix:/var/run/rrdcached.sock] RRDtool Output: 1641933900 OK u:0.00 s:0.01 r:3.12 RRD[update OSMC/app-docker-10-rtorrent.rrd N:0.28:150:3978213457:350958387:8.82 --daemon unix:/var/run/rrdcached.sock] RRDtool Output: OK u:0.00 s:0.00 r:3.12 OK u:0.00 s:0.00 r:3.12 RRD[last OSMC/app-docker-10-rtorrent_geoip.rrd --daemon unix:/var/run/rrdcached.sock] RRDtool Output: 1641933900 OK u:0.00 s:0.01 r:3.12 RRD[update OSMC/app-docker-10-rtorrent_geoip.rrd N:0:10:3978213457:27158118:0.68 --daemon unix:/var/run/rrdcached.sock] RRDtool Output: SQL[UPDATE `applications` set `app_state`=?,`app_status`=?,`timestamp`=NOW() WHERE `app_id` = ? ["OK","",10] 0.3ms] SQL[SELECT * FROM `application_metrics` WHERE app_id=? [10] 0.22ms] : .....SQL[UPDATE `application_metrics` set `value`=?,`value_prev`=? WHERE app_id=? && metric=? [0.28,0.36,10,"rtorrent_cpu_usage"] 0.15ms] U..SQL[UPDATE `application_metrics` set `value`=?,`value_prev`=? WHERE app_id=? && metric=? [350958387,350643814,10,"rtorrent_mem_used"] 0.18ms] U...... Application: os-updates, app_id=12SNMP['/usr/bin/snmpget' '-v3' '-l' 'authPriv' '-n' "" '-a' 'SHA' '-A' '$efjyExR81kNw!PBi#6AbRAx' '-u' 'LibreNMS' '-x' 'AES' '-X' '$Q0GLnG1DhzzNgc6C$sKGJwu' '-Oqv' '-m' 'NET-SNMP-EXTEND-MIB' '-M' '/opt/librenms/mibs' 'udp:10.227.196.4:161' '.1.3.6.1.4.1.8072.1.3.2.4.1.2.8.111.115.117.112.100.97.116.101.1'] 0 RRD[last OSMC/app-os-updates-12.rrd --daemon unix:/var/run/rrdcached.sock] RRDtool Output: 1641933900 OK u:0.00 s:0.01 r:3.19 RRD[update OSMC/app-os-updates-12.rrd N:0 --daemon unix:/var/run/rrdcached.sock] RRDtool Output: OK u:0.00 s:0.00 r:3.12 SQL[UPDATE `applications` set `app_state`=?,`app_status`=?,`timestamp`=NOW() WHERE `app_id` = ? ["OK","0",12] 0.31ms] SQL[SELECT * FROM `application_metrics` WHERE app_id=? [12] 0.24ms] : . >> Runtime for poller module 'applications': 2.9104 seconds with 13040 bytes >> SNMP: [2/2.91s] MySQL: [7/0.02s] RRD: [10/0.00s] #### Unload poller module applications #### RRD[last OSMC/poller-perf-applications.rrd --daemon unix:/var/run/rrdcached.sock] RRDtool Output: 1641933900 OK u:0.00 s:0.01 r:3.19 RRD[update OSMC/poller-perf-applications.rrd N:2.9103600978851 --daemon unix:/var/run/rrdcached.sock] RRDtool Output: OK u:0.00 s:0.00 r:3.19 RRD[last OSMC/poller-perf.rrd --daemon unix:/var/run/rrdcached.sock] RRDtool Output: 1641933900 OK u:0.00 s:0.01 r:3.19 RRD[update OSMC/poller-perf.rrd N:3.197 --daemon unix:/var/run/rrdcached.sock] RRDtool Output: OK u:0.00 s:0.00 r:3.19 Polled in 3.197 seconds ### Start Device Groups ### SQL[select * from `device_groups` [] 0.14ms] SQL[select * from `device_group_device` where `device_group_device`.`device_id` = ? [8] 0.18ms] Groups Added: Groups Removed: ### End Device Groups, runtime: 0.0027s ### #### Start Alerts #### SQL[select `device_groups`.*, `device_group_device`.`device_id` as `pivot_device_id`, `device_group_device`.`device_group_id` as `pivot_device_group_id` from `device_groups` inner join `device_group_device` on `device_groups`.`id` = `device_group_device`.`device_group_id` where `device_group_device`.`device_id` = ? [8] 0.19ms] SQL[select * from `locations` where `locations`.`id` = ? limit 1 [3] 0.2ms] SQL[select exists(select * from `alert_schedule` where (`start` <= ? and `end` >= ? and (`recurring` = ? or (`recurring` = ? and ((time(`start`) < time xss=removed> ?) or (time(`start`) > time(`end`) and (time(`end`) <= ? or time(`start`) > ?))) and (`recurring_day` like ? or `recurring_day` is null)))) and (exists (select * from `devices` inner join `alert_schedulables` on `devices`.`device_id` = `alert_schedulables`.`alert_schedulable_id` where `alert_schedule`.`schedule_id` = `alert_schedulables`.`schedule_id` and `alert_schedulables`.`alert_schedulable_type` = ? and `alert_schedulables`.`alert_schedulable_id` = ?) or exists (select * from `locations` inner join `alert_schedulables` on `locations`.`id` = `alert_schedulables`.`alert_schedulable_id` where `alert_schedule`.`schedule_id` = `alert_schedulables`.`schedule_id` and `alert_schedulables`.`alert_schedulable_type` = ? and `alert_schedulables`.`alert_schedulable_id` = ?))) as `exists` ["2022-01-11T20:47:11.620045Z","2022-01-11T20:47:11.620045Z",0,1,"20:47:11","20:47:11","20:47:11","20:47:11","%","device",8,"location",3] 0.45ms] SQL[select * from `devices` where `devices`.`device_id` = ? limit 1 [8] 0.31ms] SQL[SELECT DISTINCT a.* FROM alert_rules a LEFT JOIN alert_device_map d ON a.id=d.rule_id AND (a.invert_map = 0 OR a.invert_map = 1 AND d.device_id = ?) LEFT JOIN alert_group_map g ON a.id=g.rule_id AND (a.invert_map = 0 OR a.invert_map = 1 AND g.group_id IN (SELECT DISTINCT device_group_id FROM device_group_device WHERE device_id = ?)) LEFT JOIN alert_location_map l ON a.id=l.rule_id AND (a.invert_map = 0 OR a.invert_map = 1 AND l.location_id IN (SELECT DISTINCT location_id FROM devices WHERE device_id = ?)) LEFT JOIN device_group_device dg ON g.group_id=dg.device_group_id AND dg.device_id = ? WHERE a.disabled = 0 AND ( (d.device_id IS NULL AND g.group_id IS NULL) OR (a.invert_map = 0 AND (d.device_id=? OR dg.device_id=?)) OR (a.invert_map = 1 AND (d.device_id != ? OR d.device_id IS NULL) AND (dg.device_id != ? OR dg.device_id IS NULL)) ) [8,8,8,8,8,8,8,8] 0.67ms] #### End Alerts #### ./poller.php OSMC 2022-01-11 22:47:11 - 1 devices polled in 3.408 secs SNMP [5/2.98s]: Snmpget[5/2.98s] SQL [27/0.09s]: Select[20/0.07s] Insert[1/0.00s] Update[6/0.02s] RRD [18/0.00s]: Other[9/0.00s] Update[9/0.00s] librenms@LibreNMS:~$