Wietse Venema:
> Frank Brendel:
> > Here's the Postfix log and the queue file.
> >
> > Aug 30 13:02:23 elvmwlx94.eurolog.com postfix/smtpd[56532] 57850C4DC9:
> > client=unknown[194.50.162.68]
> > Aug 30 13:02:23 elvmwlx94.eurolog.com postfix/cleanup[55311]
> > 57850C4DC9: message-id=<>
> > Aug 30 13:02:23 elvmwlx94.eurolog.com postfix/qmgr[63719] 57850C4DC9:
> > from=<a...@eurolog.com>, size=103176, nrcpt=12 (queue active)
> > Aug 30 13:02:23 elvmwlx94.eurolog.com postfix/qmgr[63719] warning:
> > Unexpected record type 'X' at offset 105234
> > Aug 30 13:02:23 elvmwlx94.eurolog.com postfix/qmgr[63719] warning:
> > saving corrupt file "57850C4DC9" from queue "active" to queue "corrupt"
> >
> >
> > Between these log entries are some other qmgr logs with the same PID
> > too. Maybe you want the whole log section with some lines before and
> > after?
>
> The "unexpected record" problem does not reproduce on my test system
> (Fedora Core) which uses gcc.
>
> Now I know that FreeBSD is CLANG based which is farily aggressive
> so I'll see if I can reproduce this on a FreeBSD 13 VM that I
> already have.
Postfix 3.7.2 built with CLANG from the official Postfix source
release on FreeBSD 13.1-RC3 also does not reproduce the problem.
It attempts to deliver the message as expected.
% cc -v
FreeBSD clang version 13.0.0 (g...@github.com:llvm/llvm-project.git
llvmorg-13.0.0-0-gd7b669b3a303)
Target: x86_64-unknown-freebsd13.1
Thread model: posix
InstalledDir: /usr/bin
and
% uname -a
FreeBSD freebsd131.porcupine.org 13.1-RC3 FreeBSD 13.1-RC3
releng/13.1-n250110-ec2fbe4b1ec GENERIC amd64
and
% egrep '^(CC|OPT)' Makefile
CC = cc -I. -I../../include -I/usr/local/include -DHAS_DEV_URANDOM
-DHAS_PCRE=2 -I/usr/local/include -UUSE_DYNAMIC_LIBS -DDEF_SHLIB_DIR=\"no\"
-UUSE_DYNAMIC_MAPS $(WARN)
OPT = -O
OPTS = 'WARN=$(WARN)'
I'll look into FreeBSD 12.3 later. I don't have a VM with that OS.
Wietse
> Details
> =======
>
> I copied your file into /var/spool/postfix/incoming and did "chmod
> 700 and "chown postfix".
> At that point we should have the same conditions as on your machine.
>
> In fact, I made a mistake, and the message was delivered to my relayhost:
>
> Aug 30 08:46:55 wzv postfix/qmgr[417146]: 57850A22B0:
> from=<a...@eurolog.com>, size=103176, nrcpt=12 (queue active)
> Aug 30 08:46:55 wzv postfix/tlsproxy[417370]: CONNECT to [168.100.3.2]:25
> Aug 30 08:46:55 wzv postfix/tlsproxy[417370]: Untrusted TLS connection
> established to spike.porcupine.org[168.100.3.2]:25: TLSv1.3 with cipher
> TLS_AES_256_GCM_SHA384 (256/256 bits) key-exchange X25519 server-signature
> RSA-PSS (2048 bits) server-digest SHA256
> Aug 30 08:46:55 wzv postfix/smtp[417367]: Untrusted TLS connection
> established to spike.porcupine.org[168.100.3.2]:25: TLSv1.3 with cipher
> TLS_AES_256_GCM_SHA384 (256/256 bits) key-exchange X25519 server-signature
> RSA-PSS (2048 bits) server-digest SHA256
> Aug 30 08:46:55 wzv postfix/tlsproxy[417370]: DISCONNECT [168.100.3.2]:25
> Aug 30 08:46:55 wzv postfix/smtp[417367]: 57850A22B0:
> to=<auftragsmanagement.illin...@mosolf.de>,
> relay=spike.porcupine.org[168.100.3.2]:25, delay=6272,
> delays=6272/0.06/0.07/0.05, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as
> 4MH6Wg2yvCzJrP1)
> Aug 30 08:46:55 wzv postfix/smtp[417367]: 57850A22B0:
> to=<melanie.schwit...@mosolf.de>, relay=spike.porcupine.org[168.100.3.2]:25,
> delay=6272, delays=6272/0.06/0.07/0.05, dsn=2.0.0, status=sent (250 2.0.0 Ok:
> queued as 4MH6Wg2yvCzJrP1)
> Aug 30 08:46:55 wzv postfix/smtp[417367]: 57850A22B0:
> to=<bjoern.dannenm...@mosolf.de>, relay=spike.porcupine.org[168.100.3.2]:25,
> delay=6272, delays=6272/0.06/0.07/0.05, dsn=2.0.0, status=sent (250 2.0.0 Ok:
> queued as 4MH6Wg2yvCzJrP1)
> Aug 30 08:46:55 wzv postfix/smtp[417367]: 57850A22B0:
> to=<anne.meh...@porsche.de>, relay=spike.porcupine.org[168.100.3.2]:25,
> delay=6272, delays=6272/0.06/0.07/0.05, dsn=2.0.0, status=sent (250 2.0.0 Ok:
> queued as 4MH6Wg2yvCzJrP1)
> Aug 30 08:46:55 wzv postfix/smtp[417367]: 57850A22B0:
> to=<denice.lidmi...@porsche.de>, relay=spike.porcupine.org[168.100.3.2]:25,
> delay=6272, delays=6272/0.06/0.07/0.05, dsn=2.0.0, status=sent (250 2.0.0 Ok:
> queued as 4MH6Wg2yvCzJrP1)
> Aug 30 08:46:55 wzv postfix/smtp[417367]: 57850A22B0:
> to=<fabian.hasenhue...@porsche.de>,
> relay=spike.porcupine.org[168.100.3.2]:25, delay=6272,
> delays=6272/0.06/0.07/0.05, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as
> 4MH6Wg2yvCzJrP1)
> Aug 30 08:46:55 wzv postfix/smtp[417367]: 57850A22B0:
> to=<fabian.ha...@porsche.de>, relay=spike.porcupine.org[168.100.3.2]:25,
> delay=6272, delays=6272/0.06/0.07/0.05, dsn=2.0.0, status=sent (250 2.0.0 Ok:
> queued as 4MH6Wg2yvCzJrP1)
> Aug 30 08:46:55 wzv postfix/smtp[417367]: 57850A22B0:
> to=<heiko.hasenma...@porsche.de>, relay=spike.porcupine.org[168.100.3.2]:25,
> delay=6272, delays=6272/0.06/0.07/0.05, dsn=2.0.0, status=sent (250 2.0.0 Ok:
> queued as 4MH6Wg2yvCzJrP1)
> Aug 30 08:46:55 wzv postfix/smtp[417367]: 57850A22B0:
> to=<jan-robin.ho...@porsche.de>, relay=spike.porcupine.org[168.100.3.2]:25,
> delay=6272, delays=6272/0.06/0.07/0.05, dsn=2.0.0, status=sent (250 2.0.0 Ok:
> queued as 4MH6Wg2yvCzJrP1)
> Aug 30 08:46:55 wzv postfix/smtp[417367]: 57850A22B0:
> to=<marcel.koe...@porsche.de>, relay=spike.porcupine.org[168.100.3.2]:25,
> delay=6272, delays=6272/0.06/0.07/0.05, dsn=2.0.0, status=sent (250 2.0.0 Ok:
> queued as 4MH6Wg2yvCzJrP1)
> Aug 30 08:46:55 wzv postfix/smtp[417367]: 57850A22B0:
> to=<sandra.sante...@porsche.de>, relay=spike.porcupine.org[168.100.3.2]:25,
> delay=6272, delays=6272/0.06/0.07/0.05, dsn=2.0.0, status=sent (250 2.0.0 Ok:
> queued as 4MH6Wg2yvCzJrP1)
> Aug 30 08:46:55 wzv postfix/smtp[417367]: 57850A22B0:
> to=<tuncay.nav...@porsche.de>, relay=spike.porcupine.org[168.100.3.2]:25,
> delay=6272, delays=6272/0.06/0.07/0.05, dsn=2.0.0, status=sent (250 2.0.0 Ok:
> queued as 4MH6Wg2yvCzJrP1)
> Aug 30 08:46:55 wzv postfix/qmgr[417146]: 57850A22B0: removed
>
> The relay host attempted to deliver the message, and 9 of the 12
> recipients were greylisted.
>
> Aug 30 08:46:55 spike postfix/smtpd[84124]: 4MH6Wg2yvCzJrP1:
> client=wzv.porcupine.org[168.100.3.7]
> Aug 30 08:46:55 spike postfix/cleanup[84126]: 4MH6Wg2yvCzJrP1:
> message-id=<4mh6wg2yvczj...@spike.porcupine.org>
> Aug 30 08:46:55 spike postfix/qmgr[8759]: 4MH6Wg2yvCzJrP1:
> from=<a...@eurolog.com>, size=103621, nrcpt=12 (queue active)
> Aug 30 08:46:56 spike postfix/smtp[84128]: 4MH6Wg2yvCzJrP1: host
> mail02.fw.porsche.de[84.21.34.174] said: 450 4.2.0 <a...@eurolog.com>: Sender
> address rejected: Greylisted, see
> http://postgrey.schweikert.ch/help/porsche.de.html (in reply to RCPT TO
> command)
> Aug 30 08:46:56 spike postfix/smtp[84128]: 4MH6Wg2yvCzJrP1: host
> mail02.fw.porsche.de[84.21.34.174] said: 450 4.2.0 <a...@eurolog.com>: Sender
> address rejected: Greylisted, see
> http://postgrey.schweikert.ch/help/porsche.de.html (in reply to RCPT TO
> command)
> Aug 30 08:46:56 spike postfix/smtp[84128]: 4MH6Wg2yvCzJrP1: host
> mail02.fw.porsche.de[84.21.34.174] said: 450 4.2.0 <a...@eurolog.com>: Sender
> address rejected: Greylisted, see
> http://postgrey.schweikert.ch/help/porsche.de.html (in reply to RCPT TO
> command)
> Aug 30 08:46:56 spike postfix/smtp[84128]: 4MH6Wg2yvCzJrP1: host
> mail02.fw.porsche.de[84.21.34.174] said: 450 4.2.0 <a...@eurolog.com>: Sender
> address rejected: Greylisted, see
> http://postgrey.schweikert.ch/help/porsche.de.html (in reply to RCPT TO
> command)
> Aug 30 08:46:56 spike postfix/smtp[84128]: 4MH6Wg2yvCzJrP1: host
> mail02.fw.porsche.de[84.21.34.174] said: 450 4.2.0 <a...@eurolog.com>: Sender
> address rejected: Greylisted, see
> http://postgrey.schweikert.ch/help/porsche.de.html (in reply to RCPT TO
> command)
> Aug 30 08:46:56 spike postfix/smtp[84128]: 4MH6Wg2yvCzJrP1: host
> mail02.fw.porsche.de[84.21.34.174] said: 450 4.2.0 <a...@eurolog.com>: Sender
> address rejected: Greylisted, see
> http://postgrey.schweikert.ch/help/porsche.de.html (in reply to RCPT TO
> command)
> Aug 30 08:46:56 spike postfix/smtp[84128]: 4MH6Wg2yvCzJrP1: host
> mail02.fw.porsche.de[84.21.34.174] said: 450 4.2.0 <a...@eurolog.com>: Sender
> address rejected: Greylisted, see
> http://postgrey.schweikert.ch/help/porsche.de.html (in reply to RCPT TO
> command)
> Aug 30 08:46:56 spike postfix/smtp[84128]: 4MH6Wg2yvCzJrP1: host
> mail02.fw.porsche.de[84.21.34.174] said: 450 4.2.0 <a...@eurolog.com>: Sender
> address rejected: Greylisted, see
> http://postgrey.schweikert.ch/help/porsche.de.html (in reply to RCPT TO
> command)
> Aug 30 08:46:56 spike postfix/smtp[84128]: 4MH6Wg2yvCzJrP1: host
> mail02.fw.porsche.de[84.21.34.174] said: 450 4.2.0 <a...@eurolog.com>: Sender
> address rejected: Greylisted, see
> http://postgrey.schweikert.ch/help/porsche.de.html (in reply to RCPT TO
> command)
> Aug 30 08:46:58 spike postfix/smtp[84128]: 4MH6Wg2yvCzJrP1:
> to=<anne.meh...@porsche.de>, relay=mail.fw.porsche.de[84.21.34.159]:25,
> delay=3.2, delays=0.045/0.024/3/0.14, dsn=4.2.0, status=deferred (host
> mail.fw.porsche.de[84.21.34.159] said: 450 4.2.0 <a...@eurolog.com>: Sender
> address rejected: Greylisted, see
> http://postgrey.schweikert.ch/help/porsche.de.html (in reply to RCPT TO
> command))
> Aug 30 08:46:58 spike postfix/smtp[84128]: 4MH6Wg2yvCzJrP1:
> to=<denice.lidmi...@porsche.de>, relay=mail.fw.porsche.de[84.21.34.159]:25,
> delay=3.2, delays=0.045/0.024/3/0.14, dsn=4.2.0, status=deferred (host
> mail.fw.porsche.de[84.21.34.159] said: 450 4.2.0 <a...@eurolog.com>: Sender
> address rejected: Greylisted, see
> http://postgrey.schweikert.ch/help/porsche.de.html (in reply to RCPT TO
> command))
> Aug 30 08:46:58 spike postfix/smtp[84128]: 4MH6Wg2yvCzJrP1:
> to=<fabian.hasenhue...@porsche.de>,
> relay=mail.fw.porsche.de[84.21.34.159]:25, delay=3.2,
> delays=0.045/0.024/3/0.14, dsn=4.2.0, status=deferred (host
> mail.fw.porsche.de[84.21.34.159] said: 450 4.2.0 <a...@eurolog.com>: Sender
> address rejected: Greylisted, see
> http://postgrey.schweikert.ch/help/porsche.de.html (in reply to RCPT TO
> command))
> Aug 30 08:46:58 spike postfix/smtp[84128]: 4MH6Wg2yvCzJrP1:
> to=<fabian.ha...@porsche.de>, relay=mail.fw.porsche.de[84.21.34.159]:25,
> delay=3.2, delays=0.045/0.024/3/0.14, dsn=4.2.0, status=deferred (host
> mail.fw.porsche.de[84.21.34.159] said: 450 4.2.0 <a...@eurolog.com>: Sender
> address rejected: Greylisted, see
> http://postgrey.schweikert.ch/help/porsche.de.html (in reply to RCPT TO
> command))
> Aug 30 08:46:58 spike postfix/smtp[84128]: 4MH6Wg2yvCzJrP1:
> to=<heiko.hasenma...@porsche.de>, relay=mail.fw.porsche.de[84.21.34.159]:25,
> delay=3.2, delays=0.045/0.024/3/0.14, dsn=4.2.0, status=deferred (host
> mail.fw.porsche.de[84.21.34.159] said: 450 4.2.0 <a...@eurolog.com>: Sender
> address rejected: Greylisted, see
> http://postgrey.schweikert.ch/help/porsche.de.html (in reply to RCPT TO
> command))
> Aug 30 08:46:58 spike postfix/smtp[84128]: 4MH6Wg2yvCzJrP1:
> to=<jan-robin.ho...@porsche.de>, relay=mail.fw.porsche.de[84.21.34.159]:25,
> delay=3.2, delays=0.045/0.024/3/0.14, dsn=4.2.0, status=deferred (host
> mail.fw.porsche.de[84.21.34.159] said: 450 4.2.0 <a...@eurolog.com>: Sender
> address rejected: Greylisted, see
> http://postgrey.schweikert.ch/help/porsche.de.html (in reply to RCPT TO
> command))
> Aug 30 08:46:58 spike postfix/smtp[84128]: 4MH6Wg2yvCzJrP1:
> to=<marcel.koe...@porsche.de>, relay=mail.fw.porsche.de[84.21.34.159]:25,
> delay=3.2, delays=0.045/0.024/3/0.15, dsn=4.2.0, status=deferred (host
> mail.fw.porsche.de[84.21.34.159] said: 450 4.2.0 <a...@eurolog.com>: Sender
> address rejected: Greylisted, see
> http://postgrey.schweikert.ch/help/porsche.de.html (in reply to RCPT TO
> command))
> Aug 30 08:46:58 spike postfix/smtp[84128]: 4MH6Wg2yvCzJrP1:
> to=<sandra.sante...@porsche.de>, relay=mail.fw.porsche.de[84.21.34.159]:25,
> delay=3.2, delays=0.045/0.024/3/0.15, dsn=4.2.0, status=deferred (host
> mail.fw.porsche.de[84.21.34.159] said: 450 4.2.0 <a...@eurolog.com>: Sender
> address rejected: Greylisted, see
> http://postgrey.schweikert.ch/help/porsche.de.html (in reply to RCPT TO
> command))
> Aug 30 08:46:58 spike postfix/smtp[84128]: 4MH6Wg2yvCzJrP1:
> to=<tuncay.nav...@porsche.de>, relay=mail.fw.porsche.de[84.21.34.159]:25,
> delay=3.2, delays=0.045/0.024/3/0.15, dsn=4.2.0, status=deferred (host
> mail.fw.porsche.de[84.21.34.159] said: 450 4.2.0 <a...@eurolog.com>: Sender
> address rejected: Greylisted, see
> http://postgrey.schweikert.ch/help/porsche.de.html (in reply to RCPT TO
> command))
> Aug 30 08:46:58 spike postfix/smtp[84127]: 4MH6Wg2yvCzJrP1:
> to=<auftragsmanagement.illin...@mosolf.de>,
> relay=mxtls.expurgate.net[195.190.135.121]:25, delay=3.4,
> delays=0.045/0.013/1.4/2, dsn=2.0.0, status=sent (250 OK
> id=tlsNG-90aa6e/1661863618-407E8B0A-684B2E44/0/0)
> Aug 30 08:46:58 spike postfix/smtp[84127]: 4MH6Wg2yvCzJrP1:
> to=<melanie.schwit...@mosolf.de>,
> relay=mxtls.expurgate.net[195.190.135.121]:25, delay=3.4,
> delays=0.045/0.013/1.4/2, dsn=2.0.0, status=sent (250 OK
> id=tlsNG-90aa6e/1661863618-407E8B0A-684B2E44/0/0)
> Aug 30 08:46:58 spike postfix/smtp[84127]: 4MH6Wg2yvCzJrP1:
> to=<bjoern.dannenm...@mosolf.de>,
> relay=mxtls.expurgate.net[195.190.135.121]:25, delay=3.4,
> delays=0.045/0.013/1.4/2, dsn=2.0.0, status=sent (250 OK
> id=tlsNG-90aa6e/1661863618-407E8B0A-684B2E44/0/0)
>
> I placed the message on hold.
>
> Wietse
