Multiple delivery problem

ivleon

Member
Apr 6, 2018
5
1
8
33
I have a multiple delivery of the same message problem.
The message successfully enters the queue, but after the postfix transfers the message to the smtp filter, the message doesn't leave the active queue. This causes the message to be sent again every time the postfix is restarted by the pmgmirror daemon. In the logs it looks like (the sender mail address has been changed):
Code:
# grep AD05481FED /var/log/mail.log
Apr 30 10:06:52 emx1 postfix/smtpd[19561]: AD05481FED: client=mail-it0-f47.google.com[209.85.214.47]
Apr 30 10:06:52 emx1 postfix/cleanup[19441]: AD05481FED: message-id=<CAXiAqQu0Bo84yeCr76rr2B_uT3YW5HD3s+CX0n50HYzQbhNBqg@mail.gmail.com>
Apr 30 10:06:53 emx1 postfix/qmgr[19418]: AD05481FED: from=<sender@example.com>, size=141638, nrcpt=1 (queue active)
Apr 30 10:07:12 emx1 postfix/qmgr[20803]: AD05481FED: from=<sender@example.com>, size=141638, nrcpt=1 (queue active)
Apr 30 10:11:11 emx1 postfix/qmgr[22426]: AD05481FED: from=<sender@example.com>, size=141638, nrcpt=1 (queue active)
Apr 30 10:15:11 emx1 postfix/qmgr[23825]: AD05481FED: from=<sender@example.com>, size=141638, nrcpt=1 (queue active)
Apr 30 10:19:11 emx1 postfix/qmgr[25183]: AD05481FED: from=<sender@example.com>, size=141638, nrcpt=1 (queue active)
Apr 30 10:23:11 emx1 postfix/qmgr[26821]: AD05481FED: from=<sender@example.com>, size=141638, nrcpt=1 (queue active)
Apr 30 10:27:12 emx1 postfix/qmgr[28215]: AD05481FED: from=<sender@example.com>, size=141638, nrcpt=1 (queue active)
Apr 30 10:31:12 emx1 postfix/qmgr[29573]: AD05481FED: from=<sender@example.com>, size=141638, nrcpt=1 (queue active)
Smtp filter in its turn puts the message back to the postfix queue with different id:
Code:
Apr 30 10:14:48 emx1 postfix/smtpd[22473]: connect from emx1.mydomain.com[127.0.0.1]
Apr 30 10:14:48 emx1 postfix/smtpd[22473]: AB57980F8A: client=emx1.mydomain.com[127.0.0.1], orig_client=mail-it0-f47.google.com[209.85.214.47]
Apr 30 10:14:48 emx1 postfix/cleanup[22505]: AB57980F8A: message-id=<CAXiAqQu0Bo84yeCr76rr2B_uT3YW5HD3s+CX0n50HYzQbhNBqg@mail.gmail.com>
Apr 30 10:14:48 emx1 postfix/qmgr[22426]: AB57980F8A: from=<sender@example.com>, size=142499, nrcpt=1 (queue active)
Apr 30 10:14:48 emx1 postfix/smtpd[22473]: disconnect from emx1.mydomain.com[127.0.0.1] ehlo=1 xforward=1 mail=1 rcpt=1 data=1 commands=5
Apr 30 10:14:49 emx1 postfix/smtp[22441]: AB57980F8A: to=<recipient@mydomain.com>, relay=mail.mydomain.com[10.1.10.60]:25, delay=0.73, delays=0.14/0/0.29/0.29, dsn=2.0.0, status=sent (250 9570622 message accepted for delivery)
Apr 30 10:14:49 emx1 postfix/qmgr[22426]: AB57980F8A: removed

Apr 30 10:18:29 emx1 postfix/smtpd[23884]: connect from emx1.mydomain.com[127.0.0.1]
Apr 30 10:18:29 emx1 postfix/smtpd[23884]: D8C7982005: client=emx1.mydomain.com[127.0.0.1], orig_client=mail-it0-f47.google.com[209.85.214.47]
Apr 30 10:18:29 emx1 postfix/cleanup[23890]: D8C7982005: message-id=<CAXiAqQu0Bo84yeCr76rr2B_uT3YW5HD3s+CX0n50HYzQbhNBqg@mail.gmail.com>
Apr 30 10:18:30 emx1 postfix/qmgr[23825]: D8C7982005: from=<sender@example.com>, size=142499, nrcpt=1 (queue active)
Apr 30 10:18:30 emx1 postfix/smtpd[23884]: disconnect from emx1.mydomain.com[127.0.0.1] ehlo=1 xforward=1 mail=1 rcpt=1 data=1 commands=5
Apr 30 10:18:30 emx1 postfix/smtp[23844]: D8C7982005: to=<recipient@mydomain.com>, relay=mail.mydomain.com[10.1.10.60]:25, delay=0.71, delays=0.14/0/0.28/0.29, dsn=2.0.0, status=sent (250 9570786 message accepted for delivery)
Apr 30 10:18:30 emx1 postfix/qmgr[23825]: D8C7982005: removed
This continues until I manually reenter the message in the queue (postsuper -r) or delete it (postsuper -d).
In most cases this problem happens to different users and different senders. I have not found any common things.
 

ivleon

Member
Apr 6, 2018
5
1
8
33
It makes no sense to debug edited logs - this just adds confusion.
The sender of message from logs above is abis@villaroyalephuket.com.
I do not know what do you get from the address of the sender, much less the recipient.
The problem occurs with completely different senders, not less than 10 times a day.
My log contains a very huge amount of real mailboxes. So, I can't put it on public access.
If you can (want) help me with this promblem, then I will give you all my logs, but not for public access.
Thank you.
 

About

The Proxmox community has been around for many years and offers help and support for Proxmox VE, Proxmox Backup Server, and Proxmox Mail Gateway.
We think our community is one of the best thanks to people like you!

Get your subscription!

The Proxmox team works very hard to make sure you are running the best software and getting stable updates and security enhancements, as well as quick enterprise support. Tens of thousands of happy customers have a Proxmox subscription. Get your own in 60 seconds.

Buy now!