PostSRSd not running

Troy · July 1, 2024, 11:55pm

The mail log shows lots of lines like:

Jul  1 19:50:52 p115 postfix/smtpd[19212]: warning: connect to TCP map 127.0.0.1:10002: Connection refused
Jul  1 19:50:52 p115 postfix/cleanup[19213]: warning: connect to TCP map 127.0.0.1:10002: Connection refused

And

Jul  1 19:50:51 p115 postfix/cleanup[18846]: warning: tcp:127.0.0.1:10002 lookup error for "richard@redacted.ca"
Jul  1 19:50:51 p115 postfix/cleanup[18846]: warning: 40BC560145C58: recipient_canonical_maps map lookup problem for richard@redacted.ca -- message not accepted, try again later

Some digging shows that port 10002 and 10001 are not active and PostSRSd is not running.

[root@p115 postfix]# systemctl status postsrsd
● postsrsd.service - PostSRSd Daemon
   Loaded: loaded (/etc/systemd/system/postsrsd.service; enabled; vendor preset: disabled)
   Active: failed (Result: start-limit) since Mon 2024-07-01 19:47:24 EDT; 3s ago
     Docs: man:postsrsd(8)
  Process: 18984 ExecStart=/usr/share/postsrsd/postsrsd-systemd-launcher (code=exited, status=1/FAILURE)
 Main PID: 18984 (code=exited, status=1/FAILURE)

Jul 01 19:47:24 p115.lithium.hosting systemd[1]: Started PostSRSd Daemon.
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: postsrsd.service: main process exited, code=exited, status=1/FAILURE
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: Unit postsrsd.service entered failed state.
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: postsrsd.service failed.
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: postsrsd.service holdoff time over, scheduling restart.
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: Stopped PostSRSd Daemon.
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: start request repeated too quickly for postsrsd.service
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: Failed to start PostSRSd Daemon.
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: Unit postsrsd.service entered failed state.
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: postsrsd.service failed.

I checked the config in /etc/default/postsrsd and it matches that of a working server, same with the postfix configs.

I ran upcp -vsb mail/configure-postfix and no errors were reported. Restarted postfix and postsrsd and it will won’t run. No apparent logs tied directly to postsrsd so I’m unsure what to do next.

msaladna · July 2, 2024, 11:55am

journalctl -n40 -u postsrsd, last 10 lines from systemctl status were failed restarts.

Troy · July 2, 2024, 1:34pm

-- Logs begin at Mon 2024-07-01 18:50:33 EDT, end at Tue 2024-07-02 09:33:32 EDT. --
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: Unit postsrsd.service entered failed state.
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: postsrsd.service failed.
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: postsrsd.service holdoff time over, scheduling restart.
Jul 01 19:47:23 p115.lithium.hosting postsrsd-systemd-launcher[18970]: postconf: warning: /etc/postfix/main.cf: unused parameter: respectful_lo
Jul 01 19:47:23 p115.lithium.hosting postsrsd-systemd-launcher[18970]: postsrsd: Cannot change to chroot: No such file or directory
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: Stopped PostSRSd Daemon.
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: Started PostSRSd Daemon.
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: postsrsd.service: main process exited, code=exited, status=1/FAILURE
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: Unit postsrsd.service entered failed state.
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: postsrsd.service failed.
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: postsrsd.service holdoff time over, scheduling restart.
Jul 01 19:47:23 p115.lithium.hosting postsrsd-systemd-launcher[18975]: postconf: warning: /etc/postfix/main.cf: unused parameter: respectful_lo
Jul 01 19:47:23 p115.lithium.hosting postsrsd-systemd-launcher[18975]: postsrsd: Cannot change to chroot: No such file or directory
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: Stopped PostSRSd Daemon.
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: Started PostSRSd Daemon.
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: postsrsd.service: main process exited, code=exited, status=1/FAILURE
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: Unit postsrsd.service entered failed state.
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: postsrsd.service failed.
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: postsrsd.service holdoff time over, scheduling restart.
Jul 01 19:47:23 p115.lithium.hosting postsrsd-systemd-launcher[18980]: postconf: warning: /etc/postfix/main.cf: unused parameter: respectful_lo
Jul 01 19:47:23 p115.lithium.hosting postsrsd-systemd-launcher[18980]: postsrsd: Cannot change to chroot: No such file or directory
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: Stopped PostSRSd Daemon.
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: Started PostSRSd Daemon.
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: postsrsd.service: main process exited, code=exited, status=1/FAILURE
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: Unit postsrsd.service entered failed state.
Jul 01 19:47:23 p115.lithium.hosting systemd[1]: postsrsd.service failed.
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: postsrsd.service holdoff time over, scheduling restart.
Jul 01 19:47:24 p115.lithium.hosting postsrsd-systemd-launcher[18984]: postconf: warning: /etc/postfix/main.cf: unused parameter: respectful_lo
Jul 01 19:47:24 p115.lithium.hosting postsrsd-systemd-launcher[18984]: postsrsd: Cannot change to chroot: No such file or directory
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: Stopped PostSRSd Daemon.
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: Started PostSRSd Daemon.
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: postsrsd.service: main process exited, code=exited, status=1/FAILURE
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: Unit postsrsd.service entered failed state.
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: postsrsd.service failed.
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: postsrsd.service holdoff time over, scheduling restart.
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: Stopped PostSRSd Daemon.
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: start request repeated too quickly for postsrsd.service
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: Failed to start PostSRSd Daemon.
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: Unit postsrsd.service entered failed state.
Jul 01 19:47:24 p115.lithium.hosting systemd[1]: postsrsd.service failed.

msaladna · July 2, 2024, 3:11pm

rpm -qi postsrsd

Servers should be on PostSRSd 1.12-20240611.0.ga06dc34.apnscp. If not, yum update -y postsrsd

Troy · July 2, 2024, 4:57pm

[root@p115 ~]# rpm -qi postsrsd
Name        : postsrsd
Version     : 1.12
Release     : 20240611.0.ga06dc34.apnscp
Architecture: x86_64
Install Date: Wed 12 Jun 2024 08:55:49 AM EDT
Group       : System Environment/Daemons
Size        : 49685
License     : GPL-2.0
Signature   : RSA/SHA256, Tue 11 Jun 2024 02:22:46 PM EDT, Key ID 3f9dd9ce321f362d
Source RPM  : postsrsd-1.12-20240611.0.ga06dc34.apnscp.src.rpm
Build Date  : Tue 11 Jun 2024 02:21:55 PM EDT
Build Host  : dolly.apisnetworks.com
Relocations : (not relocatable)
URL         : https://github.com/roehling/postsrsd
Summary     : SRS daemon for Postfix
Description :
PostSRSd provides the Sender Rewriting Scheme (SRS) via TCP-based lookup tables
for Postfix. SRS is needed if your mail server acts as forwarder.

msaladna · July 2, 2024, 7:12pm

Thanks for the bug report.

yum clean all
yum update -y postsrsd
systemctl restart postsrsd

Troy · July 2, 2024, 8:28pm

No package updated, FWIW this server is still CentOS 7, it’s on the list to be replaced but hasn’t been replaced yet.

msaladna · July 2, 2024, 9:07pm

C7 went EOL June 30. Give it a go once more.

Troy · July 2, 2024, 9:16pm

Yep, am aware
That patch fixed it, thanks!