There is a difference in MailScanner logging when a SUCCESS DSN is
created and when it is not created.
Wietse Venema via Postfix-users:
> Nuno Pereira via Postfix-users:
> > Logs of message with success DSN sent:
> >
> > Mar 31 13:26:16 MAIL01 postfix/cleanup[1444410]: 21069213F:
> > message-id=<!&!AAAAAAAAAAAuAAAAAAAAAHAXE34T8Y9Ei+rbVgA87vYBAMO2jhD3dRHOtM0AqgC7t
> > uYAAAAAAA4AABAAAAB+0ZLW85dyTYzsfdF+fjJNAQAAAAA=@otherdomain.com>
> > Mar 31 13:26:19 MAIL01 MailScanner[1402982]: Requeue: 21069213F.A0295 to
> > C91CB2217
> > Mar 31 13:26:19 MAIL01 dovecot:
> > lmtp(nuno.pere...@virtualdomain.com)<1448368><CCo8BWvRJmSwGRYAi7tdOA>:
> > msgid=<!&!AAAAAAAAAAAuAAAAAAAAAHAXE34T8Y9Ei+rbVgA87vYBAMO2jhD3dRHOtM0AqgC7tuYAAA
> > AAAA4AABAAAAB+0ZLW85dyTYzsfdF+fjJNAQAAAAA=@otherdomain.com>: saved mail to
> > INBOX
> > Mar 31 13:26:19 MAIL01 dovecot: lmtp(1448368): Disconnect from local:
> > Client has
> > quit the connection (state=READY)
> > Mar 31 13:26:19 MAIL01 postfix/lmtp[1444780]: C91CB2217:
> > to=<nuno.pere...@realdomain.com>,
> > relay=mail01.nortenet.pt[private/dovecot-lmtp], delay=3,
> > delays=2.9/0/0/0.07,
> > dsn=2.0.0, status=sent (250 2.0.0 <nuno.pere...@realdomain.com>
> > CCo8BWvRJmSwGRYAi7tdOA Saved)
> > Mar 31 13:26:19 MAIL01 postfix/cleanup[1444410]: 26C44213F:
> > message-id=<20230331122619.26c442...@mail01.nortenet.pt>
> > Mar 31 13:26:19 MAIL01 postfix/qmgr[3435793]: 26C44213F: from=<>, size=3618,
> > nrcpt=1 (queue active)
> > Mar 31 13:26:19 MAIL01 postfix/bounce[1449644]: C91CB2217: sender delivery
> > status notification: 26C44213F
> > Mar 31 13:26:19 MAIL01 postfix/qmgr[3435793]: C91CB2217: removed
> > Mar 31 13:26:19 MAIL01 postfix/smtp[1449595]: 26C44213F:
> > to=<nuno.pere...@otherdomain.com>,
> > relay=a.mx.interacesso.pt[212.13.45.18]:25,
> > delay=0.02, delays=0/0/0.02/0, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued
> > as
> > 2BAA81D38)
> > Mar 31 13:26:19 MAIL01 postfix/qmgr[3435793]: 26C44213F: removed
>
> Above a DSN is created with:
>
> > Mar 31 13:26:19 MAIL01 postfix/bounce[1449644]: C91CB2217: sender delivery
> > status notification: 26C44213F
Note that the above has no MailWatch logging.
> > Logs of message with success DSN not sent:
> >
> > Mar 31 13:25:39 MAIL01 postfix/cleanup[1444410]: E3F7220E5:
> > message-id=<!&!AAAAAAAAAAAuAAAAAAAAAHAXE34T8Y9Ei+rbVgA87vYBAMO2jhD3dRHOtM0AqgC7t
> > uYAAAAAAA4AABAAAAAEaRBcggJbQphyIaiykwwrAQAAAAA=@otherdomain.com>
> > Mar 31 13:25:43 MAIL01 MailScanner[1402982]: Requeue: E3F7220E5.A2EE1 to
> > 048FA228D
> > Mar 31 13:26:19 MAIL01 postfix/qmgr[3435793]: C91CB2217:
> > from=<nuno.pere...@otherdomain.com>, size=27235, nrcpt=1 (queue active)
> > Mar 31 13:25:43 MAIL01 postfix/qmgr[3435793]: 048FA228D:
> > from=<nuno.pere...@otherdomain.com>, size=20866, nrcpt=1 (queue active)
> > Mar 31 13:25:43 MAIL01 dovecot: lmtp(1448368): Connect from local
> > Mar 31 13:25:43 MAIL01 MailScanner[1402982]: Unscanned: Delivered 1 messages
> > Mar 31 13:25:43 MAIL01 MailScanner[1402982]: Deleted 1 messages from
> > processing-database
> > Mar 31 13:25:43 MAIL01 MailScanner[1402982]: MailWatch: Logging message
> > E3F7220E5.A2EE1 to SQL
> > Mar 31 13:25:43 MAIL01 MailScanner[1405172]: MailWatch: E3F7220E5.A2EE1:
> > Logged
> > to MailWatch SQL
> > Mar 31 13:25:43 MAIL01 dovecot:
> > lmtp(nuno.pere...@interacesso.pt)<1448368><iPZaA0fRJmSwGRYAi7tdOA>:
> > msgid=<!&!AAAAAAAAAAAuAAAAAAAAAHAXE34T8Y9Ei+rbVgA87vYBAMO2jhD3dRHOtM0AqgC7tuYAAA
> > AAAA4AABAAAAAEaRBcggJbQphyIaiykwwrAQAAAAA=@otherdomain.com>: saved mail to
> > INBOX
> > Mar 31 13:25:43 MAIL01 postfix/lmtp[1448361]: 048FA228D:
> > to=<nuno.pere...@realdomain.com>, orig_to=<nuno.pere...@virtualdomain.com>,
> > relay=mail01.nortenet.pt[private/dovecot-lmtp], delay=3.2,
> > delays=3.1/0/0/0.06,
> > dsn=2.0.0, status=sent (250 2.0.0 <nuno.pere...@realdomain.com>
> > iPZaA0fRJmSwGRYAi7tdOA Saved)
> > Mar 31 13:25:43 MAIL01 postfix/qmgr[3435793]: 048FA228D: removed
>
> Here, no sender notification is created: there is no logging that says:
>
> > MAIL01 postfix/bounce[XXX]: YYYY: sender delivery
> > status notification: ZZZZ
Note that this message had "MailScanner" logging that the first mssage had not:
> > Mar 31 13:25:43 MAIL01 MailScanner[1402982]: Unscanned: Delivered 1 messages
> > Mar 31 13:25:43 MAIL01 MailScanner[1402982]: Deleted 1 messages from
> > processing-database
> > Mar 31 13:25:43 MAIL01 MailScanner[1402982]: MailWatch: Logging message
> > E3F7220E5.A2EE1 to SQL
> > Mar 31 13:25:43 MAIL01 MailScanner[1405172]: MailWatch: E3F7220E5.A2EE1:
> > Logged
> > to MailWatch SQL
"Deleted 1 messages from processing-database" could that be the
lost SUCCESS DSN?
> If you still believe that this is a Postfix problem, then you MUST
> reproduce the problem WITHOUT USING MailScanner.
And I'll keep that requirement.
Wietse
_______________________________________________
Postfix-users mailing list -- postfix-users@postfix.org
To unsubscribe send an email to postfix-users-le...@postfix.org
