Hello:
On one of three servers I am administering is currently running 74.0.4 on CentOS 7.5 (in a Virtuozzo container). I have a systemctl status process that runs often enough that I think it is causing a performance hit on the system.
Every few minutes I see the following process appear in the process log. (I've gone to watch it in the shell using top as well.)
/usr/bin/systemctl status dovecot.service with >90% CPU & about 10% memory (4GB available), the process runs for about a minute then ends. It starts up again after a minute or two and repeats.
I've tried to manually run the command to see what is going on and the output is MASSIVE!
I get the typical status information about the process
This output pauses for a few seconds then follows with what looks like the dovecot login/logout log from April until July. There are thousands of lines that are spit out here.
Does anyone have any idea why all the log output? Or for that matter why the process is running so often?
Thanks,
Michael
On one of three servers I am administering is currently running 74.0.4 on CentOS 7.5 (in a Virtuozzo container). I have a systemctl status process that runs often enough that I think it is causing a performance hit on the system.
Every few minutes I see the following process appear in the process log. (I've gone to watch it in the shell using top as well.)
/usr/bin/systemctl status dovecot.service with >90% CPU & about 10% memory (4GB available), the process runs for about a minute then ends. It starts up again after a minute or two and repeats.
I've tried to manually run the command to see what is going on and the output is MASSIVE!
I get the typical status information about the process
● dovecot.service - Dovecot Imap Server
Loaded: loaded (/etc/systemd/system/dovecot.service; enabled; vendor preset: disabled)
Active: active (running) since Sun 2018-08-19 15:41:22 EDT; 1 day 6h ago
Main PID: 1624 (dovecot)
CGroup: /system.slice/dovecot.service
├─ 684 dovecot/imap
├─ 742 dovecot/imap
├─ 743 dovecot/imap
├─ 744 dovecot/imap
├─ 745 dovecot/imap
├─ 1027 dovecot/imap
├─ 1035 dovecot/imap
├─ 1392 dovecot/imap
├─ 1394 dovecot/imap
├─ 1395 dovecot/imap
├─ 1396 dovecot/imap
├─ 1397 dovecot/imap
├─ 1399 dovecot/imap
├─ 1404 dovecot/imap
├─ 1405 dovecot/imap
├─ 1624 /usr/sbin/dovecot -F -c /etc/dovecot/dovecot.conf
├─ 1625 dovecot/pop3-login
├─ 1626 dovecot/imap-login
├─ 1627 dovecot/anvil
├─ 1628 dovecot/log
├─ 1630 dovecot/pop3-login
├─ 1631 dovecot/imap-login
├─ 1632 dovecot/config
├─ 1643 dovecot/imap
├─ 1652 dovecot/imap
├─ 1760 dovecot/imap
├─ 2639 dovecot/imap
├─ 2640 dovecot/imap
├─ 2646 dovecot/imap
├─ 2648 dovecot/imap
├─ 4490 dovecot/imap
├─ 5211 dovecot/imap
├─ 5212 dovecot/imap
├─ 6078 dovecot/imap
├─ 7071 dovecot/imap
├─ 7595 dovecot/imap
├─ 7623 dovecot/ssl-params
├─ 7852 dovecot/imap
├─ 7855 dovecot/imap
├─ 7992 dovecot/lmtp
├─ 8000 dovecot/auth -w
├─ 8002 dovecot/imap
├─ 8003 dovecot/imap
├─ 8168 dovecot/imap
├─11779 dovecot/imap
├─15338 dovecot/imap
├─20340 dovecot/indexer
├─20341 dovecot/indexer-worker
├─27071 dovecot/auth
├─29532 dovecot/imap
├─29621 dovecot/imap
├─29653 dovecot/imap
├─29659 dovecot/imap
├─31185 dovecot/imap
├─31273 dovecot/imap
├─31433 dovecot/imap
├─31434 dovecot/imap
├─31441 dovecot/imap
├─32013 dovecot/imap
└─32014 dovecot/imap
Loaded: loaded (/etc/systemd/system/dovecot.service; enabled; vendor preset: disabled)
Active: active (running) since Sun 2018-08-19 15:41:22 EDT; 1 day 6h ago
Main PID: 1624 (dovecot)
CGroup: /system.slice/dovecot.service
├─ 684 dovecot/imap
├─ 742 dovecot/imap
├─ 743 dovecot/imap
├─ 744 dovecot/imap
├─ 745 dovecot/imap
├─ 1027 dovecot/imap
├─ 1035 dovecot/imap
├─ 1392 dovecot/imap
├─ 1394 dovecot/imap
├─ 1395 dovecot/imap
├─ 1396 dovecot/imap
├─ 1397 dovecot/imap
├─ 1399 dovecot/imap
├─ 1404 dovecot/imap
├─ 1405 dovecot/imap
├─ 1624 /usr/sbin/dovecot -F -c /etc/dovecot/dovecot.conf
├─ 1625 dovecot/pop3-login
├─ 1626 dovecot/imap-login
├─ 1627 dovecot/anvil
├─ 1628 dovecot/log
├─ 1630 dovecot/pop3-login
├─ 1631 dovecot/imap-login
├─ 1632 dovecot/config
├─ 1643 dovecot/imap
├─ 1652 dovecot/imap
├─ 1760 dovecot/imap
├─ 2639 dovecot/imap
├─ 2640 dovecot/imap
├─ 2646 dovecot/imap
├─ 2648 dovecot/imap
├─ 4490 dovecot/imap
├─ 5211 dovecot/imap
├─ 5212 dovecot/imap
├─ 6078 dovecot/imap
├─ 7071 dovecot/imap
├─ 7595 dovecot/imap
├─ 7623 dovecot/ssl-params
├─ 7852 dovecot/imap
├─ 7855 dovecot/imap
├─ 7992 dovecot/lmtp
├─ 8000 dovecot/auth -w
├─ 8002 dovecot/imap
├─ 8003 dovecot/imap
├─ 8168 dovecot/imap
├─11779 dovecot/imap
├─15338 dovecot/imap
├─20340 dovecot/indexer
├─20341 dovecot/indexer-worker
├─27071 dovecot/auth
├─29532 dovecot/imap
├─29621 dovecot/imap
├─29653 dovecot/imap
├─29659 dovecot/imap
├─31185 dovecot/imap
├─31273 dovecot/imap
├─31433 dovecot/imap
├─31434 dovecot/imap
├─31441 dovecot/imap
├─32013 dovecot/imap
└─32014 dovecot/imap
This output pauses for a few seconds then follows with what looks like the dovecot login/logout log from April until July. There are thousands of lines that are spit out here.
Jul 02 19:55:45 kirk dovecot[1645]: imap(gheeg@REDACTED): Logged out in=422, out=1426, bytes=422/1426
Jul 02 19:55:54 kirk dovecot[1645]: imap-login: Login: user=<jasonboucher@REDACTED>, method=PLAIN, rip=REDACTED, lip=REDACTED, mpid=24725, TLS, sessi...Axwp9SuXHZJ>
Jul 02 19:55:54 kirk dovecot[1645]: imap(jasonboucher@REDACTED): Logged out in=497, out=1681, bytes=497/1681
Jul 02 19:56:04 kirk dovecot[1645]: imap-login: Login: user=<jasonboucher@REDACTED>, method=PLAIN, rip=REDACTED, lip=REDACTED, mpid=24740, TLS, sessi...AxwrNSuXHZJ>
Jul 02 19:56:05 kirk dovecot[1645]: imap(jasonboucher@REDACTED): Connection closed (COMPRESS finished 20.857 secs ago) in=106, out=536, bytes=106/536
Jul 02 19:56:05 kirk dovecot[1645]: imap(jasonboucher@REDACTED): Connection closed (No commands sent) in=0, out=424, bytes=0/424
Jul 02 19:56:11 kirk dovecot[1645]: lmtp(24763): Connect from local
Jul 02 19:56:11 kirk dovecot[1645]: lmtp(brotondo@REDACTED): XAPS NOTIFY {"dovecot-username":"brotondo@REDACTED","dovecot-mailbox":"INBOX"}
Jul 02 19:56:11 kirk dovecot[1645]: lmtp(brotondo@REDACTED): msgid=<CACeJT+5Ki8AD+jx7kPBXdd7=-H[email protected]>: saved mail to INBOX
Jul 02 19:55:54 kirk dovecot[1645]: imap-login: Login: user=<jasonboucher@REDACTED>, method=PLAIN, rip=REDACTED, lip=REDACTED, mpid=24725, TLS, sessi...Axwp9SuXHZJ>
Jul 02 19:55:54 kirk dovecot[1645]: imap(jasonboucher@REDACTED): Logged out in=497, out=1681, bytes=497/1681
Jul 02 19:56:04 kirk dovecot[1645]: imap-login: Login: user=<jasonboucher@REDACTED>, method=PLAIN, rip=REDACTED, lip=REDACTED, mpid=24740, TLS, sessi...AxwrNSuXHZJ>
Jul 02 19:56:05 kirk dovecot[1645]: imap(jasonboucher@REDACTED): Connection closed (COMPRESS finished 20.857 secs ago) in=106, out=536, bytes=106/536
Jul 02 19:56:05 kirk dovecot[1645]: imap(jasonboucher@REDACTED): Connection closed (No commands sent) in=0, out=424, bytes=0/424
Jul 02 19:56:11 kirk dovecot[1645]: lmtp(24763): Connect from local
Jul 02 19:56:11 kirk dovecot[1645]: lmtp(brotondo@REDACTED): XAPS NOTIFY {"dovecot-username":"brotondo@REDACTED","dovecot-mailbox":"INBOX"}
Jul 02 19:56:11 kirk dovecot[1645]: lmtp(brotondo@REDACTED): msgid=<CACeJT+5Ki8AD+jx7kPBXdd7=-H[email protected]>: saved mail to INBOX
Does anyone have any idea why all the log output? Or for that matter why the process is running so often?
Thanks,
Michael