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:a...@bordo.com.au, user:a...@bordo.com.au Mar-04-15 22:15:10 id-67710-07479 [Worker_1] 127.0.0.1 <a...@bordo.com.au> to: asspbl...@bordo.com.au 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 a...@bordo.com.au 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 a...@bordo.com.au 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: <a...@bordo.com.au>' 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: scan...@bordo.com.au - To: a...@bordo.com.au 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 i...@bordo.com.au <mailto:i...@bordo.com.au>, but it is delivered to a...@bordo.com.au <mailto:a...@bordo.com.au>: 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=<scan...@bordo.com.au <mailto:scan...@bordo.com.au>>, 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(a...@bordo.com.au <mailto:a...@bordo.com.au>): msgid=<20150226073917.0001.CanonTxNo.4122@[192.168.1.78]>: saved mail to INBOX Mar 4 22:15:15 mail postfix/pipe[53150]: 279374563492: to=<a...@bordo.com.au <mailto:a...@bordo.com.au>>, 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: <scan...@bordo.com.au <mailto:scan...@bordo.com.au>> Delivered-To: a...@bordo.com.au <mailto:a...@bordo.com.au> 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 <a...@bordo.com.au <mailto:a...@bordo.com.au>>; 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: "scan...@bordo.com.au <mailto:scan...@bordo.com.au>"<scan...@bordo.com.au <mailto:scan...@bordo.com.au>> 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: <a...@bordo.com.au <mailto:a...@bordo.com.au>> 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, sasl_username=scan...@bordo.com.au <mailto:sasl_username=scan...@bordo.com.au> 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=<scan...@bordo.com.au <mailto:scan...@bordo.com.au>>, 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(i...@bordo.com.au <mailto:i...@bordo.com.au>): msgid=<20150226073917.0001.CanonTxNo.4122@[192.168.1.78]>: saved mail to INBOX Feb 26 09:40:48 mail postfix/pipe[93576]: 2DC2644E6BCB: to=<i...@bordo.com.au <mailto:i...@bordo.com.au>>, 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 Assp-test@lists.sourceforge.net https://lists.sourceforge.net/lists/listinfo/assp-test
