On 2021-05-16 at 12:10:59 UTC-0400 (Sun, 16 May 2021 17:10:59 +0100)
Chris Green <c...@isbd.net>
is rumored to have said:
I have postfix running on my xubuntu 21.10 desktop machine and it's
working fine for sending mail from mutt which uses the 'sendmail'
interface.
However I have a script which attempts to send using localhost port 25
and that doesn't appear to work.
I am trying to debug it by connecting directly to port 25 on localhost
using telnet and composing mail that way. It appears to be sent
according to the postfix mail.log but it just disappears.
I.e., from mail.log, this message never arrives:-
May 16 16:57:23 esprimo postfix/smtpd[190440]: 865FE2C01D6:
client=localhost[127.0.0.1]
May 16 16:57:36 esprimo postfix/cleanup[190255]: 865FE2C01D6:
message-id=<20210516155723.865fe2c0...@esprimo.zbmc.eu>
May 16 16:57:36 esprimo postfix/qmgr[1316]: 865FE2C01D6:
from=<ch...@zbmc.eu>, size=356, nrcpt=1 (queue active)
May 16 16:57:37 esprimo postfix/smtp[190560]: 865FE2C01D6:
to=<ch...@isbd.co.uk>, relay=mail.gandi.net[217.70.178.9]:465,
delay=24, delays=23/0.01/0.57/0.36, dsn=2.0.0, status=sent (250 2.0.0
Ok: queued as 3D57D1C0003)
That mail was passed along to mail.gandi.net. I am guessing (as you've
not even described your mail routing config, much less included postconf
-n output...) that this is some sort of explicit transport config,
because the MX for isbd.co.uk points elsewhere. I'm also guessing that
since the mail was accepted with a '250' response, you have some sort of
mail handling agreement with Gandi.
Ask Gandi what happened to that message.
... but this one sent from mutt via postfix's sendmail arrives OK (you
can see it arriving):-
May 16 16:55:46 esprimo postfix/qmgr[1316]: 021532C0841:
from=<ch...@zbmc.eu>, size=425, nrcpt=1 (queue active)
May 16 16:55:46 esprimo postfix/smtp[190257]: 021532C0841:
to=<ch...@isbd.co.uk>, relay=mail.gandi.net[217.70.178.9]:465,
delay=0.54, delays=0.01/0/0.18/0.35, dsn=2.0.0, status=sent (250 2.0.0
Ok: queued as 68B71240003)
May 16 16:55:46 esprimo postfix/qmgr[1316]: 021532C0841: removed
Another message handed off to Gandi. That does not seem to be all of the
relevant log lines for that message. Search for earlier lines with the
same queue ID (021532C0841) which should include a 'cleanup' line noting
the message-id.
May 16 16:55:49 esprimo postfix/smtpd[190353]: connect from
p3plsmtp25-04-2.prod.phx3.secureserver.net[216.69.139.18]
May 16 16:55:50 esprimo postfix/smtpd[190353]: 2AEBF2C01EB:
client=p3plsmtp25-04-2.prod.phx3.secureserver.net[216.69.139.18]
May 16 16:55:50 esprimo postfix/cleanup[190255]: 2AEBF2C01EB:
message-id=<20210516155545.GC189386@esprimo>
May 16 16:55:50 esprimo postfix/qmgr[1316]: 2AEBF2C01EB:
from=<srs0=l8qg=kl=zbmc.eu=ch...@bounce.secureserver.net>, size=2507,
nrcpt=1 (queue active)
May 16 16:55:50 esprimo postfix/local[190332]: 2AEBF2C01EB:
to=<ch...@zbmc.eu>, relay=local, delay=0.49, delays=0.43/0/0/0.06,
dsn=2.0.0, status=sent (delivered to command:
/home/chris/.mutt/bin/filter.py)
May 16 16:55:50 esprimo postfix/qmgr[1316]: 2AEBF2C01EB: removed
Are you sure that this message which arrived from a GoDaddy machine
(216.69.139.18) is the same one passed 3 seconds earlier to Gandi? I
suspect that these are NOT the same message, as the message-id of this
inbound message implies that it was generated at 15:55:45, a full hour
before it came back to you. Also, this is "to" a different address than
the one just passed to Gandi.
So what's the difference? I *guess* that something in between must be
rejecting the first
one for some reason.
Ask Gandi where your missing mail went. They accepted it for relay.
If the 2 messages in the "working" log excerpt are in fact the same
message, that implies that you have a mail routing setup which involves
at least 2 external providers which sends mail originally to
ch...@isbd.co.uk on a trip around the world
just to get it redirected to the local address ch...@zbmc.eu.
--
Bill Cole
b...@scconsult.com or billc...@apache.org
(AKA @grumpybozo and many *@billmail.scconsult.com addresses)
Not Currently Available For Hire
