I posted this to the Postfix mailing list, and one person said that it is ASSP that is the problem.I’ve had a few cases of the wrong people receiving emails.
Looking at maillog.txt, I can see that it is caused by Resend Mail: Mar-04-15 22:14:39 [Worker_1] Connected: session:7FC5559440C8 127.0.0.1:56663 > 127.0.0.1:25 > 127.0.0.1:10026 Mar-04-15 22:15:10 [Worker_1] 127.0.0.1 info: authentication - plain is used Mar-04-15 22:15:10 [Worker_1] 127.0.0.1 info: authentication (PLAIN) realms - foruser:[email protected] <http://bordo.com.au/>, user:[email protected] <http://bordo.com.au/> Mar-04-15 22:15:10 id-67710-07479 [Worker_1] 127.0.0.1 <[email protected] <mailto:[email protected]>> to: [email protected] <mailto:[email protected]> blocked email report Mar-04-15 22:15:11 [Worker_1] Info: queued command 'BlockReportFromQ' to MaintThread Mar-04-15 22:15:11 [Worker_1] Info: queued blocked mail request from [email protected] <mailto:[email protected]> Mar-04-15 22:15:12 [Worker_10000] Info: got command 'BlockReportFromQ' from command queue - 0 commands pending Mar-04-15 22:15:12 [Worker_10000] Info: processing queued blocked mail request from [email protected] <mailto:[email protected]> Mar-04-15 22:15:12 [Worker_10000] Info: BlockReport::modify::modify called Mar-04-15 22:15:12 [Worker_10000] Info: resend: no recipient found - adding (from) 'To: <[email protected] <mailto:[email protected]>>' for 1432.eml Mar-04-15 22:15:12 [Worker_10000] Error: unable to delete /Applications/assp/spam/1432.eml - No such file or directory Mar-04-15 22:15:15 [Worker_10000] Info: looking for files to (re)send Mar-04-15 22:15:15 [Worker_10000] (re)send - try to open: /Applications/assp/resendmail/1432.eml Mar-04-15 22:15:15 [Worker_10000] (re)send - process: /Applications/assp/resendmail/1432.eml (first time) Mar-04-15 22:15:15 [Worker_10000] (re)send - /Applications/assp/resendmail/1432.eml - From: [email protected] <mailto:[email protected]> - To: [email protected] <mailto:[email protected]> Mar-04-15 22:15:15 [Worker_10000] (re)send /Applications/assp/resendmail/1432.eml to host: 127.0.0.1:10026 (smtpDestination) Mar-04-15 22:15:15 [Worker_10000] Info: successful sent file /Applications/assp/resendmail/1432.eml to 127.0.0.1:10026 (smtpDestination) Mar-04-15 22:15:17 [Worker_10000] DMARCpol: searching for DMARC-agregate-reports to generate in 3 stored DMARC policy records Mar-04-15 22:15:38 [Worker_10000] Info: saving Stats in file asspstats.sav Mar-04-15 22:15:38 [Worker_10000] Info: saving ScoreStats in file asspscorestats.sav Mar-04-15 22:16:12 [Worker_1] Disconnected: session:7FC5559440C8 127.0.0.1 - processing time 93 seconds The file 1432.eml is now in assp/notspam/ folder. Running ASSP version 2.4.4(15059) Here’s the email I sent to the Postfix list: **** Just had one today. It was originally sent on 26 Feb, the wrong user just had it delivered today. Message should be to [email protected] <mailto:[email protected]>, but it is delivered to [email protected] <mailto:[email protected]>: Mar 4 22:15:15 mail postfix/smtpd[53229]: connect from localhost[127.0.0.1] Mar 4 22:15:15 mail postfix/smtpd[53229]: 279374563492: client=localhost[127.0.0.1] Mar 4 22:15:15 mail postfix/cleanup[53149]: 279374563492: message-id=<20150226073917.0001.CanonTxNo.4122@[192.168.1.78]> Mar 4 22:15:15 mail postfix/qmgr[122]: 279374563492: from=<[email protected] <mailto:[email protected]>>, size=40758, nrcpt=1 (queue active) Mar 4 22:15:15 mail postfix/smtpd[53229]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5 Mar 4 22:15:15 mail dovecot[53231]: lda([email protected] <mailto:[email protected]>): msgid=<20150226073917.0001.CanonTxNo.4122@[192.168.1.78]>: saved mail to INBOX Mar 4 22:15:15 mail postfix/pipe[53150]: 279374563492: to=<[email protected] <mailto:[email protected]>>, relay=dovecot, delay=0.03, delays=0.01/0/0/0.02, dsn=2.0.0, status=sent (delivered via dovecot service) Mar 4 22:15:15 mail postfix/qmgr[122]: 279374563492: removed Header info on message that was delivered to adam: Return-Path: <[email protected] <mailto:[email protected]>> Delivered-To: [email protected] <mailto:[email protected]> Received: from mail.bordo.com.au <http://mail.bordo.com.au/> (localhost [127.0.0.1]) by mail.bordo.com.au <http://mail.bordo.com.au/> (Postfix) with ESMTP id 279374563492 for <[email protected] <mailto:[email protected]>>; Wed, 4 Mar 2015 22:15:15 +1100 (EST) X-Assp-Resend-Blocked: mail.bordo.com.au <http://mail.bordo.com.au/> Received: from [192.168.1.78] ([192.168.1.78] helo=[192.168.1.78]) bymail.bordo.com.au <http://bymail.bordo.com.au/> with SMTPA (2.4.4); 26 Feb 2015 09:40:46 +1100 X-Priority: 3 (Normal) From: "[email protected] <mailto:[email protected]>"<[email protected] <mailto:[email protected]>> Subject: Attached Image Date: Thu, 26 Feb 2015 07:39:17 +1000 Message-Id: <20150226073917.0001.CanonTxNo.4122@[192.168.1.78]> Mime-Version: 1.0 X-Mailer: Canon MFP Content-Type: multipart/mixed;boundary="PDNMLKODAPBGBABABCEDPEALOMOG" To: <[email protected] <mailto:[email protected]>> Is it a Postfix or a Dovecot problem? This was the mail originally being sent: Feb 26 09:40:46 mail postfix/smtpd[93571]: connect from localhost[127.0.0.1] Feb 26 09:40:47 mail postfix/smtpd[93571]: 2DC2644E6BCB: client=localhost[127.0.0.1], sasl_method=PLAIN, [email protected] <mailto:[email protected]> Feb 26 09:40:48 mail postfix/cleanup[93574]: 2DC2644E6BCB: message-id=<20150226073917.0001.CanonTxNo.4122@[192.168.1.78]> Feb 26 09:40:48 mail postfix/qmgr[6200]: 2DC2644E6BCB: from=<[email protected] <mailto:[email protected]>>, size=40950, nrcpt=1 (queue active) Feb 26 09:40:48 mail postfix/smtpd[93571]: disconnect from localhost[127.0.0.1] ehlo=1 auth=1 mail=1 rcpt=1 data=1 quit=1 commands=6 Feb 26 09:40:48 mail dovecot[93585]: lda([email protected] <mailto:[email protected]>): msgid=<20150226073917.0001.CanonTxNo.4122@[192.168.1.78]>: saved mail to INBOX Feb 26 09:40:48 mail postfix/pipe[93576]: 2DC2644E6BCB: to=<[email protected] <mailto:[email protected]>>, relay=dovecot, delay=1.7, delays=1.6/0/0/0.17, dsn=2.0.0, status=sent (delivered via dovecot service) Feb 26 09:40:48 mail postfix/qmgr[6200]: 2DC2644E6BCB: removed So why would it resend it, and to a different recipient? Running Postfix 3.0.0, Dovecot 2.2 on Mac OS 10.7.5 Or maybe the Canon scanner is the problem. **** Any ideas? Thanks, James. ------------------------------------------------------------------------------ Dive into the World of Parallel Programming The Go Parallel Website, sponsored by Intel and developed in partnership with Slashdot Media, is your hub for all things parallel software development, from weekly thought leadership blogs to news, videos, case studies, tutorials and more. Take a look and join the conversation now. http://goparallel.sourceforge.net/ _______________________________________________ Assp-test mailing list [email protected] https://lists.sourceforge.net/lists/listinfo/assp-test
