Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

nut-monitor service fails even though nut-monitor seems to work #1086

Closed
Gooberpatrol66 opened this issue Sep 2, 2021 · 2 comments
Closed

nut-monitor service fails even though nut-monitor seems to work #1086

Gooberpatrol66 opened this issue Sep 2, 2021 · 2 comments
Labels
service/daemon start/stop General subject for starting and stopping NUT daemons (drivers, server, monitor); also BG/FG/Debug systemd

Comments

@Gooberpatrol66
Copy link

The systemd service fails even though the output seems to indicate
that nut-monitor is communicating successfully with the UPS.

Gentoo Linux

Nut v2.7.4-r7 (installed from distro package)

UPS: Tripplite SU1500RTXLCD2U (controlled by pfsense)

Here's the unit file:

[Unit]
Description=Network UPS Tools - power device monitor and shutdown controller
After=local-fs.target network.target nut-server.service
OnFailure=systemd-monitor@%n.service

[Service]
ExecStart=/usr/sbin/upsmon -DDDDDDD
PIDFile=/run/upsmon.pid
Type=forking

[Install]
WantedBy=multi-user.target

journalctl output:

-- Boot 93e0d5b24bac491994a2ea5cce08cdcc --
Aug 16 23:45:40 gentoodesktop systemd[1]: Starting Network UPS Tools -
power device monitor and shutdown controller...
░░ Subject: A start job for unit nut-monitor.service has begun execution
░░ Defined-By: systemd
░░ Support: https://gentoo.org/support/
░░
░░ A start job for unit nut-monitor.service has begun execution.
░░
░░ The job identifier is 107.
Aug 16 23:45:40 gentoodesktop upsmon[1943]: kill: No such process
Aug 16 23:45:40 gentoodesktop upsmon[1943]:    0.000000        UPS:
tripplite1@pfsense (slave) (power value 1)
Aug 16 23:45:40 gentoodesktop upsmon[1943]:    0.000019        UPS:
heartbeat@localhost (monitoring only)
Aug 16 23:45:40 gentoodesktop upsmon[1943]:    0.000051        Using
power down flag file /etc/killpower
Aug 16 23:45:40 gentoodesktop upsmon[1943]:    0.000127        debug
level is '8'
Aug 16 23:45:40 gentoodesktop upsmon[1944]:    0.003931        Trying
to connect to UPS [tripplite1@pfsense]
Aug 16 23:45:52 gentoodesktop upsmon[1944]:   12.452582        UPS
[tripplite1@pfsense]: connect failed: No such host
Aug 16 23:45:52 gentoodesktop upsmon[1944]:   12.452600
do_notify: ntype 0x0005 (COMMBAD)
Aug 16 23:45:52 gentoodesktop upsmon[1944]:   12.452725        Trying
to connect to UPS [heartbeat@localhost]
Aug 16 23:45:52 gentoodesktop upsmon[1944]:   12.453032        Can not
connect to localhost in SSL, continue uncrypted
Aug 16 23:45:52 gentoodesktop upsmon[1944]:   12.457065        Logged
into UPS heartbeat@localhost
Aug 16 23:45:52 gentoodesktop upsmon[1944]:   12.457104
pollups: heartbeat@localhost
Aug 16 23:45:52 gentoodesktop upsmon[1944]:   12.457110
get_var: heartbeat@localhost / status
Aug 16 23:45:52 gentoodesktop upsmon[1944]:   12.457142
parse_status: [OL]
Aug 16 23:45:52 gentoodesktop upsmon[1944]:   12.457148        parsing: [OL]
Aug 16 23:45:52 gentoodesktop upsmon[1944]:   12.457151
ups_on_line: heartbeat@localhost (first time)
Aug 16 23:45:52 gentoodesktop upsmon[1944]:   12.457154        Current
power value: 1
Aug 16 23:45:52 gentoodesktop upsmon[1944]:   12.457157        Minimum
power value: 1
Aug 16 23:45:57 gentoodesktop upsmon[1944]:   17.457224        Trying
to connect to UPS [tripplite1@pfsense]
Aug 16 23:45:57 gentoodesktop upsmon[1944]:   17.457992        Can not
connect to pfsense in SSL, continue uncrypted
Aug 16 23:45:57 gentoodesktop upsmon[1944]:   17.458515        Logged
into UPS tripplite1@pfsense
Aug 16 23:45:57 gentoodesktop upsmon[1944]:   17.458525
pollups: tripplite1@pfsense
Aug 16 23:45:57 gentoodesktop upsmon[1944]:   17.458529
get_var: tripplite1@pfsense / status
Aug 16 23:45:57 gentoodesktop upsmon[1944]:   17.458629
parse_status: [OL]
Aug 16 23:45:57 gentoodesktop upsmon[1944]:   17.458637
do_notify: ntype 0x0004 (COMMOK)
Aug 16 23:45:57 gentoodesktop upsmon[1944]:   17.458640
Communications with UPS tripplite1@pfsense established
Aug 16 23:45:57 gentoodesktop upsmon[1944]:   17.458811        parsing: [OL]
Aug 16 23:45:57 gentoodesktop upsmon[1944]:   17.458822
ups_on_line: tripplite1@pfsense (first time)
Aug 16 23:45:57 gentoodesktop upsmon[1944]:   17.458824
pollups: heartbeat@localhost
Aug 16 23:45:57 gentoodesktop upsmon[1944]:   17.458826
get_var: heartbeat@localhost / status
Aug 16 23:45:57 gentoodesktop upsmon[1944]:   17.458880
parse_status: [OL]
Aug 16 23:45:57 gentoodesktop upsmon[1944]:   17.458887        parsing: [OL]
Aug 16 23:45:57 gentoodesktop upsmon[1944]:   17.458890
ups_on_line: heartbeat@localhost (no change)
Aug 16 23:45:57 gentoodesktop upsmon[1944]:   17.458892        Current
power value: 1
Aug 16 23:45:57 gentoodesktop upsmon[1944]:   17.458894        Minimum
power value: 1
Aug 16 23:45:57 gentoodesktop upsmon[2076]: wall: /dev/pts/0: No such
file or directory
Aug 16 23:45:57 gentoodesktop upsmon[2076]: wall: /dev/pts/1: No such
file or directory
Aug 16 23:45:57 gentoodesktop upsmon[2076]: wall: /dev/pts/11: No such
file or directory
Aug 16 23:45:57 gentoodesktop upsmon[2076]: wall: /dev/pts/8: No such
file or directory
Aug 16 23:45:57 gentoodesktop upsmon[2076]: wall: /dev/pts/4: No such
file or directory
Aug 16 23:45:57 gentoodesktop upsmon[2076]: wall: /dev/pts/9: No such
file or directory
Aug 16 23:45:57 gentoodesktop upsmon[2075]: Network UPS Tools upsmon 2.7.4
Aug 16 23:46:00 gentoodesktop upsmon[1947]: Failed to connect to
parent and failed to create parent: No such file or directory
Aug 16 23:46:00 gentoodesktop upssched[1947]: Failed to connect to
parent and failed to create parent: No such file or directory
Aug 16 23:46:00 gentoodesktop upsmon[1946]: Network UPS Tools upsmon 2.7.4
Aug 16 23:46:04 gentoodesktop upsmon[1944]:   22.458958
pollups: tripplite1@pfsense
Aug 16 23:46:04 gentoodesktop upsmon[1944]:   22.458973
get_var: tripplite1@pfsense / status
Aug 16 23:46:04 gentoodesktop upsmon[1944]:   22.459248
parse_status: [OL]
Aug 16 23:46:04 gentoodesktop upsmon[1944]:   22.459251        parsing: [OL]
Aug 16 23:46:04 gentoodesktop upsmon[1944]:   22.459253
ups_on_line: tripplite1@pfsense (no change)
Aug 16 23:46:04 gentoodesktop upsmon[1944]:   22.459255
pollups: heartbeat@localhost
Aug 16 23:46:04 gentoodesktop upsmon[1944]:   22.459257
get_var: heartbeat@localhost / status
Aug 16 23:46:04 gentoodesktop upsmon[1944]:   22.459293
parse_status: [OL]
Aug 16 23:46:04 gentoodesktop upsmon[1944]:   22.459296        parsing: [OL]
Aug 16 23:46:04 gentoodesktop upsmon[1944]:   22.459299
ups_on_line: heartbeat@localhost (no change)
Aug 16 23:46:04 gentoodesktop upsmon[1944]:   22.459301        Current
power value: 1
Aug 16 23:46:04 gentoodesktop upsmon[1944]:   22.459304        Minimum
power value: 1
Aug 16 23:46:07 gentoodesktop upsmon[1944]:   27.459380
pollups: tripplite1@pfsense
Aug 16 23:46:07 gentoodesktop upsmon[1944]:   27.459394
get_var: tripplite1@pfsense / status
Aug 16 23:46:07 gentoodesktop upsmon[1944]:   27.459677
parse_status: [OL]
Aug 16 23:46:07 gentoodesktop upsmon[1944]:   27.459681        parsing: [OL]
Aug 16 23:46:07 gentoodesktop upsmon[1944]:   27.459682
ups_on_line: tripplite1@pfsense (no change)
Aug 16 23:46:07 gentoodesktop upsmon[1944]:   27.459684
pollups: heartbeat@localhost
Aug 16 23:46:07 gentoodesktop upsmon[1944]:   27.459686
get_var: heartbeat@localhost / status
Aug 16 23:46:07 gentoodesktop upsmon[1944]:   27.459722
parse_status: [OL]
Aug 16 23:46:07 gentoodesktop upsmon[1944]:   27.459725        parsing: [OL]
Aug 16 23:46:07 gentoodesktop upsmon[1944]:   27.459727
ups_on_line: heartbeat@localhost (no change)
Aug 16 23:46:07 gentoodesktop upsmon[1944]:   27.459729        Current
power value: 1
Aug 16 23:46:07 gentoodesktop upsmon[1944]:   27.459731        Minimum
power value: 1
Aug 16 23:46:12 gentoodesktop upsmon[1944]:   32.459807
pollups: tripplite1@pfsense
Aug 16 23:46:12 gentoodesktop upsmon[1944]:   32.459822
get_var: tripplite1@pfsense / status
Aug 16 23:46:12 gentoodesktop upsmon[1944]:   32.460038
parse_status: [OL]
Aug 16 23:46:12 gentoodesktop upsmon[1944]:   32.460041        parsing: [OL]
Aug 16 23:46:12 gentoodesktop upsmon[1944]:   32.460043
ups_on_line: tripplite1@pfsense (no change)
Aug 16 23:46:12 gentoodesktop upsmon[1944]:   32.460044
pollups: heartbeat@localhost
Aug 16 23:46:12 gentoodesktop upsmon[1944]:   32.460046
get_var: heartbeat@localhost / status
Aug 16 23:46:12 gentoodesktop upsmon[1944]:   32.460086
parse_status: [OL]
Aug 16 23:46:12 gentoodesktop upsmon[1944]:   32.460088        parsing: [OL]
Aug 16 23:46:12 gentoodesktop upsmon[1944]:   32.460089
ups_on_line: heartbeat@localhost (no change)
Aug 16 23:46:12 gentoodesktop upsmon[1944]:   32.460091        Current
power value: 1
Aug 16 23:46:12 gentoodesktop upsmon[1944]:   32.460093        Minimum
power value: 1
Aug 16 23:46:19 gentoodesktop upsmon[1944]:   39.140972
pollups: tripplite1@pfsense
Aug 16 23:46:19 gentoodesktop upsmon[1944]:   39.140986
get_var: tripplite1@pfsense / status
Aug 16 23:46:19 gentoodesktop upsmon[1944]:   39.141227
parse_status: [OL]
Aug 16 23:46:19 gentoodesktop upsmon[1944]:   39.141230        parsing: [OL]
Aug 16 23:46:19 gentoodesktop upsmon[1944]:   39.141232
ups_on_line: tripplite1@pfsense (no change)
Aug 16 23:46:19 gentoodesktop upsmon[1944]:   39.141234
pollups: heartbeat@localhost
Aug 16 23:46:19 gentoodesktop upsmon[1944]:   39.141236
get_var: heartbeat@localhost / status
Aug 16 23:46:19 gentoodesktop upsmon[1944]:   39.141286
parse_status: [OL]
Aug 16 23:46:19 gentoodesktop upsmon[1944]:   39.141288        parsing: [OL]
Aug 16 23:46:19 gentoodesktop upsmon[1944]:   39.141290
ups_on_line: heartbeat@localhost (no change)
Aug 16 23:46:19 gentoodesktop upsmon[1944]:   39.141292        Current
power value: 1
Aug 16 23:46:19 gentoodesktop upsmon[1944]:   39.141294        Minimum
power value: 1
Aug 16 23:46:24 gentoodesktop upsmon[1944]:   44.141355
pollups: tripplite1@pfsense
Aug 16 23:46:24 gentoodesktop upsmon[1944]:   44.141371
get_var: tripplite1@pfsense / status
Aug 16 23:46:24 gentoodesktop upsmon[1944]:   44.141610
parse_status: [OL]
Aug 16 23:46:24 gentoodesktop upsmon[1944]:   44.141613        parsing: [OL]
Aug 16 23:46:24 gentoodesktop upsmon[1944]:   44.141615
ups_on_line: tripplite1@pfsense (no change)
Aug 16 23:46:24 gentoodesktop upsmon[1944]:   44.141617
pollups: heartbeat@localhost
Aug 16 23:46:24 gentoodesktop upsmon[1944]:   44.141618
get_var: heartbeat@localhost / status
Aug 16 23:46:24 gentoodesktop upsmon[1944]:   44.141652
parse_status: [OL]
Aug 16 23:46:24 gentoodesktop upsmon[1944]:   44.141654        parsing: [OL]
Aug 16 23:46:24 gentoodesktop upsmon[1944]:   44.141656
ups_on_line: heartbeat@localhost (no change)
Aug 16 23:46:24 gentoodesktop upsmon[1944]:   44.141658        Current
power value: 1
Aug 16 23:46:24 gentoodesktop upsmon[1944]:   44.141659        Minimum
power value: 1
Aug 16 23:46:29 gentoodesktop upsmon[1944]:   49.141723
pollups: tripplite1@pfsense
Aug 16 23:46:29 gentoodesktop upsmon[1944]:   49.141737
get_var: tripplite1@pfsense / status
Aug 16 23:46:29 gentoodesktop upsmon[1944]:   49.141981
parse_status: [OL]
Aug 16 23:46:29 gentoodesktop upsmon[1944]:   49.141985        parsing: [OL]
Aug 16 23:46:29 gentoodesktop upsmon[1944]:   49.141987
ups_on_line: tripplite1@pfsense (no change)
Aug 16 23:46:29 gentoodesktop upsmon[1944]:   49.141989
pollups: heartbeat@localhost
Aug 16 23:46:29 gentoodesktop upsmon[1944]:   49.141990
get_var: heartbeat@localhost / status
Aug 16 23:46:29 gentoodesktop upsmon[1944]:   49.142026
parse_status: [OL]
Aug 16 23:46:29 gentoodesktop upsmon[1944]:   49.142028        parsing: [OL]
Aug 16 23:46:29 gentoodesktop upsmon[1944]:   49.142030
ups_on_line: heartbeat@localhost (no change)
Aug 16 23:46:29 gentoodesktop upsmon[1944]:   49.142032        Current
power value: 1
Aug 16 23:46:29 gentoodesktop upsmon[1944]:   49.142034        Minimum
power value: 1
Aug 16 23:46:34 gentoodesktop upsmon[1944]:   54.142098
pollups: tripplite1@pfsense
Aug 16 23:46:34 gentoodesktop upsmon[1944]:   54.142116
get_var: tripplite1@pfsense / status
Aug 16 23:46:34 gentoodesktop upsmon[1944]:   54.142405
parse_status: [OL]
Aug 16 23:46:34 gentoodesktop upsmon[1944]:   54.142411        parsing: [OL]
Aug 16 23:46:34 gentoodesktop upsmon[1944]:   54.142415
ups_on_line: tripplite1@pfsense (no change)
Aug 16 23:46:34 gentoodesktop upsmon[1944]:   54.142418
pollups: heartbeat@localhost
Aug 16 23:46:34 gentoodesktop upsmon[1944]:   54.142420
get_var: heartbeat@localhost / status
Aug 16 23:46:34 gentoodesktop upsmon[1944]:   54.142463
parse_status: [OL]
Aug 16 23:46:34 gentoodesktop upsmon[1944]:   54.142466        parsing: [OL]
Aug 16 23:46:34 gentoodesktop upsmon[1944]:   54.142468
ups_on_line: heartbeat@localhost (no change)
Aug 16 23:46:34 gentoodesktop upsmon[1944]:   54.142471        Current
power value: 1
Aug 16 23:46:34 gentoodesktop upsmon[1944]:   54.142473        Minimum
power value: 1
Aug 16 23:46:39 gentoodesktop upsmon[1944]:   59.142539
pollups: tripplite1@pfsense
Aug 16 23:46:39 gentoodesktop upsmon[1944]:   59.142560
get_var: tripplite1@pfsense / status
Aug 16 23:46:39 gentoodesktop upsmon[1944]:   59.142807
parse_status: [OL]
Aug 16 23:46:39 gentoodesktop upsmon[1944]:   59.142810        parsing: [OL]
Aug 16 23:46:39 gentoodesktop upsmon[1944]:   59.142812
ups_on_line: tripplite1@pfsense (no change)
Aug 16 23:46:39 gentoodesktop upsmon[1944]:   59.142815
pollups: heartbeat@localhost
Aug 16 23:46:39 gentoodesktop upsmon[1944]:   59.142817
get_var: heartbeat@localhost / status
Aug 16 23:46:39 gentoodesktop upsmon[1944]:   59.142859
parse_status: [OL]
Aug 16 23:46:39 gentoodesktop upsmon[1944]:   59.142862        parsing: [OL]
Aug 16 23:46:39 gentoodesktop upsmon[1944]:   59.142865
ups_on_line: heartbeat@localhost (no change)
Aug 16 23:46:39 gentoodesktop upsmon[1944]:   59.142867        Current
power value: 1
Aug 16 23:46:39 gentoodesktop upsmon[1944]:   59.142869        Minimum
power value: 1
Aug 16 23:46:44 gentoodesktop upsmon[1944]:   64.142936
pollups: tripplite1@pfsense
Aug 16 23:46:44 gentoodesktop upsmon[1944]:   64.142961
get_var: tripplite1@pfsense / status
Aug 16 23:46:44 gentoodesktop upsmon[1944]:   64.143253
parse_status: [OL]
Aug 16 23:46:44 gentoodesktop upsmon[1944]:   64.143263        parsing: [OL]
Aug 16 23:46:44 gentoodesktop upsmon[1944]:   64.143267
ups_on_line: tripplite1@pfsense (no change)
Aug 16 23:46:44 gentoodesktop upsmon[1944]:   64.143271
pollups: heartbeat@localhost
Aug 16 23:46:44 gentoodesktop upsmon[1944]:   64.143275
get_var: heartbeat@localhost / status
Aug 16 23:46:44 gentoodesktop upsmon[1944]:   64.143339
parse_status: [OL]
Aug 16 23:46:44 gentoodesktop upsmon[1944]:   64.143343        parsing: [OL]
Aug 16 23:46:44 gentoodesktop upsmon[1944]:   64.143346
ups_on_line: heartbeat@localhost (no change)
Aug 16 23:46:44 gentoodesktop upsmon[1944]:   64.143349        Current
power value: 1
Aug 16 23:46:44 gentoodesktop upsmon[1944]:   64.143353        Minimum
power value: 1
Aug 16 23:46:51 gentoodesktop upsmon[1944]:   69.143418
pollups: tripplite1@pfsense
Aug 16 23:46:51 gentoodesktop upsmon[1944]:   69.143432
get_var: tripplite1@pfsense / status
Aug 16 23:46:51 gentoodesktop upsmon[1944]:   69.143670
parse_status: [OL]
Aug 16 23:46:51 gentoodesktop upsmon[1944]:   69.143673        parsing: [OL]
Aug 16 23:46:51 gentoodesktop upsmon[1944]:   69.143676
ups_on_line: tripplite1@pfsense (no change)
Aug 16 23:46:51 gentoodesktop upsmon[1944]:   69.143678
pollups: heartbeat@localhost
Aug 16 23:46:51 gentoodesktop upsmon[1944]:   69.143680
get_var: heartbeat@localhost / status
Aug 16 23:46:51 gentoodesktop upsmon[1944]:   69.143721
parse_status: [OL]
Aug 16 23:46:51 gentoodesktop upsmon[1944]:   69.143724        parsing: [OL]
Aug 16 23:46:51 gentoodesktop upsmon[1944]:   69.143727
ups_on_line: heartbeat@localhost (no change)
Aug 16 23:46:51 gentoodesktop upsmon[1944]:   69.143730        Current
power value: 1
Aug 16 23:46:51 gentoodesktop upsmon[1944]:   69.143732        Minimum
power value: 1
Aug 16 23:46:54 gentoodesktop upsmon[1944]:   74.143797
pollups: tripplite1@pfsense
Aug 16 23:46:54 gentoodesktop upsmon[1944]:   74.143818
get_var: tripplite1@pfsense / status
Aug 16 23:46:54 gentoodesktop upsmon[1944]:   74.144094
parse_status: [OL]
Aug 16 23:46:54 gentoodesktop upsmon[1944]:   74.144097        parsing: [OL]
Aug 16 23:46:54 gentoodesktop upsmon[1944]:   74.144099
ups_on_line: tripplite1@pfsense (no change)
Aug 16 23:46:54 gentoodesktop upsmon[1944]:   74.144100
pollups: heartbeat@localhost
Aug 16 23:46:54 gentoodesktop upsmon[1944]:   74.144103
get_var: heartbeat@localhost / status
Aug 16 23:46:54 gentoodesktop upsmon[1944]:   74.144143
parse_status: [OL]
Aug 16 23:46:54 gentoodesktop upsmon[1944]:   74.144147        parsing: [OL]
Aug 16 23:46:54 gentoodesktop upsmon[1944]:   74.144150
ups_on_line: heartbeat@localhost (no change)
Aug 16 23:46:54 gentoodesktop upsmon[1944]:   74.144153        Current
power value: 1
Aug 16 23:46:54 gentoodesktop upsmon[1944]:   74.144155        Minimum
power value: 1
Aug 16 23:46:59 gentoodesktop upsmon[1944]:   79.144221
pollups: tripplite1@pfsense
Aug 16 23:46:59 gentoodesktop upsmon[1944]:   79.144249
get_var: tripplite1@pfsense / status
Aug 16 23:46:59 gentoodesktop upsmon[1944]:   79.144484
parse_status: [OL]
Aug 16 23:46:59 gentoodesktop upsmon[1944]:   79.144489        parsing: [OL]
Aug 16 23:46:59 gentoodesktop upsmon[1944]:   79.144491
ups_on_line: tripplite1@pfsense (no change)
Aug 16 23:46:59 gentoodesktop upsmon[1944]:   79.144494
pollups: heartbeat@localhost
Aug 16 23:46:59 gentoodesktop upsmon[1944]:   79.144497
get_var: heartbeat@localhost / status
Aug 16 23:46:59 gentoodesktop upsmon[1944]:   79.144554
parse_status: [OL]
Aug 16 23:46:59 gentoodesktop upsmon[1944]:   79.144558        parsing: [OL]
Aug 16 23:46:59 gentoodesktop upsmon[1944]:   79.144560
ups_on_line: heartbeat@localhost (no change)
Aug 16 23:46:59 gentoodesktop upsmon[1944]:   79.144563        Current
power value: 1
Aug 16 23:46:59 gentoodesktop upsmon[1944]:   79.144566        Minimum
power value: 1
Aug 16 23:47:04 gentoodesktop upsmon[1944]:   84.144636
pollups: tripplite1@pfsense
Aug 16 23:47:04 gentoodesktop upsmon[1944]:   84.144664
get_var: tripplite1@pfsense / status
Aug 16 23:47:04 gentoodesktop upsmon[1944]:   84.144934
parse_status: [OL]
Aug 16 23:47:04 gentoodesktop upsmon[1944]:   84.144942        parsing: [OL]
Aug 16 23:47:04 gentoodesktop upsmon[1944]:   84.144945
ups_on_line: tripplite1@pfsense (no change)
Aug 16 23:47:04 gentoodesktop upsmon[1944]:   84.144947
pollups: heartbeat@localhost
Aug 16 23:47:04 gentoodesktop upsmon[1944]:   84.144950
get_var: heartbeat@localhost / status
Aug 16 23:47:04 gentoodesktop upsmon[1944]:   84.145008
parse_status: [OL]
Aug 16 23:47:04 gentoodesktop upsmon[1944]:   84.145013        parsing: [OL]
Aug 16 23:47:04 gentoodesktop upsmon[1944]:   84.145015
ups_on_line: heartbeat@localhost (no change)
Aug 16 23:47:04 gentoodesktop upsmon[1944]:   84.145018        Current
power value: 1
Aug 16 23:47:04 gentoodesktop upsmon[1944]:   84.145021        Minimum
power value: 1
Aug 16 23:47:09 gentoodesktop upsmon[1944]:   89.145087
pollups: tripplite1@pfsense
Aug 16 23:47:09 gentoodesktop upsmon[1944]:   89.145107
get_var: tripplite1@pfsense / status
Aug 16 23:47:09 gentoodesktop upsmon[1944]:   89.145389
parse_status: [OL]
Aug 16 23:47:09 gentoodesktop upsmon[1944]:   89.145394        parsing: [OL]
Aug 16 23:47:09 gentoodesktop upsmon[1944]:   89.145397
ups_on_line: tripplite1@pfsense (no change)
Aug 16 23:47:09 gentoodesktop upsmon[1944]:   89.145399
pollups: heartbeat@localhost
Aug 16 23:47:09 gentoodesktop upsmon[1944]:   89.145404
get_var: heartbeat@localhost / status
Aug 16 23:47:09 gentoodesktop upsmon[1944]:   89.145450
parse_status: [OL]
Aug 16 23:47:09 gentoodesktop upsmon[1944]:   89.145453        parsing: [OL]
Aug 16 23:47:09 gentoodesktop upsmon[1944]:   89.145455
ups_on_line: heartbeat@localhost (no change)
Aug 16 23:47:09 gentoodesktop upsmon[1944]:   89.145458        Current
power value: 1
Aug 16 23:47:09 gentoodesktop upsmon[1944]:   89.145460        Minimum
power value: 1
Aug 16 23:47:12 gentoodesktop systemd[1]: nut-monitor.service: start
operation timed out. Terminating.
Aug 16 23:47:12 gentoodesktop upsmon[1944]:   91.852466        Signal
15: exiting
Aug 16 23:47:12 gentoodesktop upsmon[1944]:   91.852486
Dropping connection to UPS [tripplite1@pfsense]
Aug 16 23:47:12 gentoodesktop upsmon[1944]:   91.852556
Dropping connection to UPS [heartbeat@localhost]
Aug 16 23:47:12 gentoodesktop upsmon[1944]: Network UPS Tools upsmon 2.7.4
Aug 16 23:47:12 gentoodesktop systemd[1]: nut-monitor.service: Failed
with result 'timeout'.
░░ Subject: Unit failed
░░ Defined-By: systemd
░░ Support: https://gentoo.org/support/
░░
░░ The unit nut-monitor.service has entered the 'failed' state with
result 'timeout'.
Aug 16 23:47:12 gentoodesktop systemd[1]: Failed to start Network UPS
Tools - power device monitor and shutdown controller.
░░ Subject: A start job for unit nut-monitor.service has failed
░░ Defined-By: systemd
░░ Support: https://gentoo.org/support/
░░
░░ A start job for unit nut-monitor.service has finished with a failure.
░░
░░ The job identifier is 107 and the job result is failed.
Aug 16 23:47:12 gentoodesktop systemd[1]: nut-monitor.service:
Triggering OnFailure= dependencies.
Aug 16 23:47:12 gentoodesktop systemd[1]: nut-monitor.service:
Consumed 2.054s CPU time.
░░ Subject: Resources consumed by unit runtime
░░ Defined-By: systemd
░░ Support: https://gentoo.org/support/
░░
░░ The unit nut-monitor.service completed and consumed the indicated resources.
@jimklimov
Copy link
Member

jimklimov commented Nov 14, 2021 •
edited

I think there may be several issues in play here:

  1. Early in the log, it says that "pfsense" hostname is not resolved - but it is later; probably a race between naming service startup and NUT components (maybe you should order the services predictably?) or just "pfsense" registers by DHCP or similar as it boots?

  2. upsmon starts with debug enabled, this keeps it foregrounded (not sure quickly if it also forgoes the split of unprivileged monitoring child process vs root parent able to shutdown) - so a "Forking" service type is probably not applicable, and "Simple" or some such might be better (assuming systemd kills it by timeout since the child process never appears).

There are several discussions and PRs to separate foreground/background behavior from debug enablement, such as #123, #349 and #683, so this may change in later NUT master branch iterations and eventually releases.

@jimklimov jimklimov added systemd service/daemon start/stop General subject for starting and stopping NUT daemons (drivers, server, monitor); also BG/FG/Debug labels Nov 14, 2021
@Gooberpatrol66
Copy link
Author

I figured out this happened because I broke a symlink from /var/run -> /run, so systemd would look for a PID file in a different place than the daemon wrote it. So, this is invalid. My bad.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
service/daemon start/stop General subject for starting and stopping NUT daemons (drivers, server, monitor); also BG/FG/Debug systemd
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@jimklimov @Gooberpatrol66