v8.2.0 - Tracking center not showing all log entries

jchamb2010

Member
Feb 8, 2023
11
2
8
I am currently experiencing an issue where the tracking center does not display all of the log entries associated with a particular email. For example if I search for the "To" address, the following logs are displayed in the tracking center:
Code:
2025-03-20T07:58:45.422546-04:00 host2 postfix/smtpd[937580]: connect from unknown[10.38.5.16]
2025-03-20T07:58:45.460012-04:00 host2 postfix/smtpd[937580]: 70406402B142: client=unknown[10.38.5.16]
2025-03-20T07:58:45.460915-04:00 host2 postfix/cleanup[937583]: 70406402B142: message-id=<202503201158.52KBwjir029749@SERVER.HOSTNAME.NET>
2025-03-20T07:58:45.461013-04:00 host2 postfix/cleanup[937583]: 70406402B142: info: header From: <FROM@DOMAIN.COM from unknown[10.38.5.16]; from=<FROM@DOMAIN.COM to=<TO_EMAIL_ADDRESS@gmail.com> proto=ESMTP helo=<SERVER.HOSTNAME.NET>
2025-03-20T07:58:45.461069-04:00 host2 postfix/cleanup[937583]: 70406402B142: info: header Subject: [[SUBJECT]] from unknown[10.38.5.16]; from=<FROM@DOMAIN.COM to=<TO_EMAIL_ADDRESS@gmail.com> proto=ESMTP helo=<SERVER.HOSTNAME.NET>
2025-03-20T07:58:45.462037-04:00 host2 postfix/qmgr[828194]: 70406402B142: from=<FROM@DOMAIN.COM, size=4058, nrcpt=1 (queue active)
2025-03-20T07:58:45.467359-04:00 host2 postfix/smtpd[937580]: disconnect from unknown[10.38.5.16] ehlo=2 starttls=1 mail=1 rcpt=1 data=1 quit=1 commands=7
2025-03-20T07:58:45.509566-04:00 host2 pmg-smtp-filter[936545]: 8368E67DC02F57B4ED: new mail message-id=<202503201158.52KBwjir029749@SERVER.HOSTNAME.NET>#012
2025-03-20T07:58:45.873305-04:00 host2 pmg-smtp-filter[936545]: 8368E67DC02F57B4ED: SA score=0/5 time=0.327 bayes=undefined autolearn=disabled hits=ALL_TRUSTED(-1),HTML_IMAGE_ONLY_32(0.001),HTML_IMAGE_RATIO_08(0.001),HTML_MESSAGE(0.001),KAM_DMARC_STATUS(0.01),MIME_HTML_ONLY(0.1)
2025-03-20T07:58:45.926849-04:00 host2 pmg-smtp-filter[936545]: 8368E67DC02F57B4ED: accept mail to <TO_EMAIL_ADDRESS@gmail.com> (D7B78403BF5E) (rule: Outgoing Spam Filter Bypass)
2025-03-20T07:58:45.929002-04:00 host2 pmg-smtp-filter[936545]: 8368E67DC02F57B4ED: processing time: 0.421 seconds (0.327, 0.035, 0)
2025-03-20T07:58:45.929386-04:00 host2 postfix/lmtp[937589]: 70406402B142: to=<TO_EMAIL_ADDRESS@gmail.com>, relay=127.0.0.1[127.0.0.1]:10023, delay=0.47, delays=0/0/0.04/0.42, dsn=2.5.0, status=sent (250 2.5.0 OK (8368E67DC02F57B4ED))
2025-03-20T07:58:45.929707-04:00 host2 postfix/qmgr[828194]: 70406402B142: removed

However, as you can see, the last entry is just saying it was sent over to localhost on port 10023 and doesn't show the actual communications with gmail's servers.
If I look in the logs for "D7B78403BF5E" (indicated at the end of the "accepted mail to" line) I get the following records:

Code:
2025-03-20T07:58:45.883769-04:00 host2 postfix/smtpd[937594]: D7B78403BF5E: client=localhost.localdomain[127.0.0.1], orig_client=unknown[10.38.5.16]
2025-03-20T07:58:45.924471-04:00 host2 postfix/cleanup[937583]: D7B78403BF5E: message-id=<202503201158.52KBwjir029749@SERVER.HOSTNAME.NET>
2025-03-20T07:58:45.926575-04:00 host2 postfix/qmgr[828194]: D7B78403BF5E: from=<FROM@DOMAIN.COM>, size=4267, nrcpt=1 (queue active)
2025-03-20T07:58:45.926849-04:00 host2 pmg-smtp-filter[936545]: 8368E67DC02F57B4ED: accept mail to <TO_TO_EMAIL_ADDRESS@gmail.com> (D7B78403BF5E) (rule: Outgoing Spam Filter Bypass)
2025-03-20T07:58:46.688364-04:00 host2 relay1/smtp[937607]: D7B78403BF5E: to=<TO_EMAIL_ADDRESS@gmail.com>, relay=gmail-smtp-in.l.google.com[74.125.129.26]:25, delay=0.81, delays=0.04/0.05/0.24/0.47, dsn=2.0.0, status=sent (250 2.0.0 OK  1742471926 af79cd13be357-7c573b76a02si1622818185a.78 - gsmtp)
2025-03-20T07:58:46.688521-04:00 host2 postfix/qmgr[828194]: D7B78403BF5E: removed

For some reason I cannot find these log entries in the tracking center, regardless of what I search for. Is this a bug?
 
relay1/smtp[937607]
do you have modifications to the postfix config (mostly master.cf.in ) - that might rename postfix services?

the Tracking Center is quite fast, but at the expense of being tightly relying on the logs having the expected formats ...

I hope this helps!
 
Thank you, I have added the following to master.cf.in:
Code:
relay1     unix  -       -       n       -       -       smtp
  -o smtp_bind_address=XXX.XXX.XXX.XXX
  -o smtp_helo_name=smtp1.host2.gateway.domain.com
  -o syslog_name=relay1
relay2     unix  -       -       n       -       -       smtp
  -o smtp_bind_address=XXX.XXX.XXX.XXX
  -o smtp_helo_name=smtp2.host2.gateway.domain.com
  -o syslog_name=relay2
[...]
relay15     unix  -       -       n       -       -       smtp
  -o smtp_bind_address=XXX.XXX.XXX.XXX
  -o smtp_helo_name=smtp15.host2.gateway.domain.com
  -o syslog_name=relay15

and the following to the main.cf.in
Code:
sender_dependent_default_transport_maps = randmap:{relay1,relay2,relay3,relay4,relay5,relay6,relay7,relay8,relay9,relay10,relay11,relay12,relay13,relay14,relay15}

In order to set up a round-robin. Is there a way for this type of round-robin setup to work properly with the tracking center? Would I just have to remove the -o syslog_name= lines? -- I'd prefer not to do that so that I can track which IP address a specific message went out on, but if that's what's needed I'll have to consider it.
 
Last edited: