Multiple delivery problem

[ivleon]

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):

# 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:

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.

 

[dietmar]

It makes no sense to debug edited logs - this just adds confusion.

 

[ivleon]

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.