Hi. I switched from one PMG cluster to another. Everything is fine on the old cluster. But on the new one I don't see any SA Scores in the logs. grep -r "SA score" /var/log are empty.
grep -r "SA score" /var/log/
For example:
2025-03-12T05:52:31.687838+05:00 mx-04 postfix/smtpd[1082541]: connect from <domain>[<client ip-address>]
2025-03-12T05:52:32.314862+05:00 mx-04 postfix/smtpd[1082541]: Anonymous TLS connection established from <domain>[<client ip-address>]: TLSv1.3 with cipher TLS_AES_256_GCM_SHA384 (256/256 bits) key-exchange ECDHE (prime256v1) server-signature RSA-PSS (4096 bits) server-digest SHA256
2025-03-12T05:52:32.495309+05:00 mx-04 postfix/smtpd[1082541]: 78DC84160F: client=<domain>[<client ip-address>]
2025-03-12T05:52:32.672580+05:00 mx-04 postfix/cleanup[1083147]: 78DC84160F: message-id=<0da28d26d10f050e2b3178d2483c170fb4732d@<domain>>
2025-03-12T05:52:32.806438+05:00 mx-04 postfix/qmgr[3218151]: 78DC84160F: from=<sp@<domain>>, size=165675, nrcpt=1 (queue active)
2025-03-12T05:52:32.850927+05:00 mx-04 postfix/smtpd[1082541]: disconnect from <domain>[<client ip-address>] ehlo=2 starttls=1 mail=1 rcpt=1 data=1 quit=1 commands=7
2025-03-12T05:52:32.883701+05:00 mx-04 pmg-smtp-filter[1082630]: 4161167D0DAD0CF948: new mail message-id=<0da28d26d10f050e2b3178d2483c170fb4732d@<domain>>#012
2025-03-12T05:52:32.964803+05:00 mx-04 postfix/smtpd[1083156]: connect from localhost.localdomain[127.0.0.1]
2025-03-12T05:52:32.967003+05:00 mx-04 postfix/smtpd[1083156]: EC08B41614: client=localhost.localdomain[127.0.0.1], orig_client=<domain>[<client ip-address>]
2025-03-12T05:52:32.972121+05:00 mx-04 postfix/cleanup[1083147]: EC08B41614: message-id=<0da28d26d10f050e2b3178d2483c170fb4732d@<domain>>
2025-03-12T05:52:33.050619+05:00 mx-04 postfix/qmgr[3218151]: EC08B41614: from=<sp@<domain>>, size=165895, nrcpt=1 (queue active)
2025-03-12T05:52:33.050950+05:00 mx-04 postfix/smtpd[1083156]: disconnect from localhost.localdomain[127.0.0.1] ehlo=1 xforward=1 mail=1 rcpt=1 data=1 commands=5
2025-03-12T05:52:33.051268+05:00 mx-04 pmg-smtp-filter[1082630]: 4161167D0DAD0CF948: accept mail to <hr@<domain>> (EC08B41614) (rule: default-accept)
2025-03-12T05:52:33.058603+05:00 mx-04 pmg-smtp-filter[1082630]: 4161167D0DAD0CF948: processing time: 0.197 seconds (0, 0.061, 0)
2025-03-12T05:52:33.059351+05:00 mx-04 postfix/lmtp[1083149]: 78DC84160F: to=<hr@<domain>>, relay=127.0.0.1[127.0.0.1]:10024, delay=0.64, delays=0.39/0/0.04/0.21, dsn=2.5.0, status=sent (250 2.5.0 OK (4161167D0DAD0CF948))
2025-03-12T05:52:33.060099+05:00 mx-04 postfix/qmgr[3218151]: 78DC84160F: removed
2025-03-12T05:52:33.065344+05:00 mx-04 postfix/smtp[1083128]: Untrusted TLS connection established to <hostname>[<ip-address>]:25: TLSv1.2 with cipher ECDHE-RSA-AES256-GCM-SHA384 (256/256 bits)
2025-03-12T05:52:33.239275+05:00 mx-04 postfix/smtp[1083128]: EC08B41614: to=<hr@<domain>>, relay=<hostname>[<ip-address>]:25, delay=0.27, delays=0.08/0/0.02/0.16, dsn=2.6.0, status=sent (250 2.6.0 <0da28d26d10f050e2b3178d2483c170fb4732d@<domain>> [InternalId=25009594564677, Hostname=<hostname>] 167308 bytes in 0.151, 1080,180 KB/sec Queued mail for delivery)
2025-03-12T05:52:33.241018+05:00 mx-04 postfix/qmgr[3218151]: EC08B41614: removed
I Tried systemctl restart pmg-smtp-filter.service and check journalctl -u pmg-smtp-filter.service -n 50:
Mar 12 22:56:18 mx-04.<domain> pmg-smtp-filter[1109079]: 2025/03/12-22:56:18 Server closing!
Mar 12 22:56:18 mx-04.<domain> systemd[1]: pmg-smtp-filter.service: Deactivated successfully.
Mar 12 22:56:18 mx-04.<domain> systemd[1]: Stopped pmg-smtp-filter.service - Proxmox SMTP Filter Daemon.
Mar 12 22:56:18 mx-04.<domain> systemd[1]: pmg-smtp-filter.service: Consumed 7.624s CPU time.
Mar 12 22:56:18 mx-04.<domain> systemd[1]: Starting pmg-smtp-filter.service - Proxmox SMTP Filter Daemon...
Mar 12 22:56:19 mx-04.<domain> pmg-smtp-filter[1110454]: using pre-fork workers with min=2, max=40, min_spare=1, max_spare=4, max_requests=20
Mar 12 22:56:19 mx-04.<domain> pmg-smtp-filter[1110459]: Process Backgrounded
Mar 12 22:56:19 mx-04.<domain> pmg-smtp-filter[1110459]: 2025/03/12-22:56:19 main (type Net::Server:
reFork) starting! pid(1110459)
Mar 12 22:56:19 mx-04.<domain> pmg-smtp-filter[1110459]: Binding to TCP port 10023 on host 127.0.0.1 with IPv4
Mar 12 22:56:19 mx-04.<domain> pmg-smtp-filter[1110459]: Binding to TCP port 10024 on host 127.0.0.1 with IPv4
Mar 12 22:56:19 mx-04.<domain> pmg-smtp-filter[1110459]: Group Not Defined. Defaulting to EGID '0'
Mar 12 22:56:19 mx-04.<domain> pmg-smtp-filter[1110459]: User Not Defined. Defaulting to EUID '0'
Mar 12 22:56:19 mx-04.<domain> pmg-smtp-filter[1110459]: Setting up serialization via flock
Mar 12 22:56:19 mx-04.<domain> pmg-smtp-filter[1110459]: Filter daemon (re)started (max. 40 processes)
Mar 12 22:56:19 mx-04.<domain> systemd[1]: Started pmg-smtp-filter.service - Proxmox SMTP Filter Daemon.
Mar 12 22:56:22 mx-04.<domain> pmg-smtp-filter[1110459]: Beginning prefork (2 processes)
Mar 12 22:56:22 mx-04.<domain> pmg-smtp-filter[1110459]: Starting "2" children
I tried to turn the rules on and off in Mail Filter. I don't know what else to look at and check. I think I need help.
grep -r "SA score" /var/log/
For example:
2025-03-12T05:52:31.687838+05:00 mx-04 postfix/smtpd[1082541]: connect from <domain>[<client ip-address>]
2025-03-12T05:52:32.314862+05:00 mx-04 postfix/smtpd[1082541]: Anonymous TLS connection established from <domain>[<client ip-address>]: TLSv1.3 with cipher TLS_AES_256_GCM_SHA384 (256/256 bits) key-exchange ECDHE (prime256v1) server-signature RSA-PSS (4096 bits) server-digest SHA256
2025-03-12T05:52:32.495309+05:00 mx-04 postfix/smtpd[1082541]: 78DC84160F: client=<domain>[<client ip-address>]
2025-03-12T05:52:32.672580+05:00 mx-04 postfix/cleanup[1083147]: 78DC84160F: message-id=<0da28d26d10f050e2b3178d2483c170fb4732d@<domain>>
2025-03-12T05:52:32.806438+05:00 mx-04 postfix/qmgr[3218151]: 78DC84160F: from=<sp@<domain>>, size=165675, nrcpt=1 (queue active)
2025-03-12T05:52:32.850927+05:00 mx-04 postfix/smtpd[1082541]: disconnect from <domain>[<client ip-address>] ehlo=2 starttls=1 mail=1 rcpt=1 data=1 quit=1 commands=7
2025-03-12T05:52:32.883701+05:00 mx-04 pmg-smtp-filter[1082630]: 4161167D0DAD0CF948: new mail message-id=<0da28d26d10f050e2b3178d2483c170fb4732d@<domain>>#012
2025-03-12T05:52:32.964803+05:00 mx-04 postfix/smtpd[1083156]: connect from localhost.localdomain[127.0.0.1]
2025-03-12T05:52:32.967003+05:00 mx-04 postfix/smtpd[1083156]: EC08B41614: client=localhost.localdomain[127.0.0.1], orig_client=<domain>[<client ip-address>]
2025-03-12T05:52:32.972121+05:00 mx-04 postfix/cleanup[1083147]: EC08B41614: message-id=<0da28d26d10f050e2b3178d2483c170fb4732d@<domain>>
2025-03-12T05:52:33.050619+05:00 mx-04 postfix/qmgr[3218151]: EC08B41614: from=<sp@<domain>>, size=165895, nrcpt=1 (queue active)
2025-03-12T05:52:33.050950+05:00 mx-04 postfix/smtpd[1083156]: disconnect from localhost.localdomain[127.0.0.1] ehlo=1 xforward=1 mail=1 rcpt=1 data=1 commands=5
2025-03-12T05:52:33.051268+05:00 mx-04 pmg-smtp-filter[1082630]: 4161167D0DAD0CF948: accept mail to <hr@<domain>> (EC08B41614) (rule: default-accept)
2025-03-12T05:52:33.058603+05:00 mx-04 pmg-smtp-filter[1082630]: 4161167D0DAD0CF948: processing time: 0.197 seconds (0, 0.061, 0)
2025-03-12T05:52:33.059351+05:00 mx-04 postfix/lmtp[1083149]: 78DC84160F: to=<hr@<domain>>, relay=127.0.0.1[127.0.0.1]:10024, delay=0.64, delays=0.39/0/0.04/0.21, dsn=2.5.0, status=sent (250 2.5.0 OK (4161167D0DAD0CF948))
2025-03-12T05:52:33.060099+05:00 mx-04 postfix/qmgr[3218151]: 78DC84160F: removed
2025-03-12T05:52:33.065344+05:00 mx-04 postfix/smtp[1083128]: Untrusted TLS connection established to <hostname>[<ip-address>]:25: TLSv1.2 with cipher ECDHE-RSA-AES256-GCM-SHA384 (256/256 bits)
2025-03-12T05:52:33.239275+05:00 mx-04 postfix/smtp[1083128]: EC08B41614: to=<hr@<domain>>, relay=<hostname>[<ip-address>]:25, delay=0.27, delays=0.08/0/0.02/0.16, dsn=2.6.0, status=sent (250 2.6.0 <0da28d26d10f050e2b3178d2483c170fb4732d@<domain>> [InternalId=25009594564677, Hostname=<hostname>] 167308 bytes in 0.151, 1080,180 KB/sec Queued mail for delivery)
2025-03-12T05:52:33.241018+05:00 mx-04 postfix/qmgr[3218151]: EC08B41614: removed
I Tried systemctl restart pmg-smtp-filter.service and check journalctl -u pmg-smtp-filter.service -n 50:
Mar 12 22:56:18 mx-04.<domain> pmg-smtp-filter[1109079]: 2025/03/12-22:56:18 Server closing!
Mar 12 22:56:18 mx-04.<domain> systemd[1]: pmg-smtp-filter.service: Deactivated successfully.
Mar 12 22:56:18 mx-04.<domain> systemd[1]: Stopped pmg-smtp-filter.service - Proxmox SMTP Filter Daemon.
Mar 12 22:56:18 mx-04.<domain> systemd[1]: pmg-smtp-filter.service: Consumed 7.624s CPU time.
Mar 12 22:56:18 mx-04.<domain> systemd[1]: Starting pmg-smtp-filter.service - Proxmox SMTP Filter Daemon...
Mar 12 22:56:19 mx-04.<domain> pmg-smtp-filter[1110454]: using pre-fork workers with min=2, max=40, min_spare=1, max_spare=4, max_requests=20
Mar 12 22:56:19 mx-04.<domain> pmg-smtp-filter[1110459]: Process Backgrounded
Mar 12 22:56:19 mx-04.<domain> pmg-smtp-filter[1110459]: 2025/03/12-22:56:19 main (type Net::Server:
Mar 12 22:56:19 mx-04.<domain> pmg-smtp-filter[1110459]: Binding to TCP port 10023 on host 127.0.0.1 with IPv4
Mar 12 22:56:19 mx-04.<domain> pmg-smtp-filter[1110459]: Binding to TCP port 10024 on host 127.0.0.1 with IPv4
Mar 12 22:56:19 mx-04.<domain> pmg-smtp-filter[1110459]: Group Not Defined. Defaulting to EGID '0'
Mar 12 22:56:19 mx-04.<domain> pmg-smtp-filter[1110459]: User Not Defined. Defaulting to EUID '0'
Mar 12 22:56:19 mx-04.<domain> pmg-smtp-filter[1110459]: Setting up serialization via flock
Mar 12 22:56:19 mx-04.<domain> pmg-smtp-filter[1110459]: Filter daemon (re)started (max. 40 processes)
Mar 12 22:56:19 mx-04.<domain> systemd[1]: Started pmg-smtp-filter.service - Proxmox SMTP Filter Daemon.
Mar 12 22:56:22 mx-04.<domain> pmg-smtp-filter[1110459]: Beginning prefork (2 processes)
Mar 12 22:56:22 mx-04.<domain> pmg-smtp-filter[1110459]: Starting "2" children
I tried to turn the rules on and off in Mail Filter. I don't know what else to look at and check. I think I need help.