And here are the log lines from mail.log when I send a test message, just in case that helps anyone.
Jun 18 03:15:40 mail postfix/submission/smtpd[21926]: connect from 97-123-96-141.albq.qwest.net[97.123.96.141] Jun 18 03:15:42 mail postfix/submission/smtpd[21926]: 4E16C17A09B: client=97-123-96-141.albq.qwest.net[97.123.96.141], sasl_method=PLAIN, [email protected] Jun 18 03:15:42 mail postfix/cleanup[21933]: 4E16C17A09B: replace: header Received: from [172.30.10.247] (97-123-96-141.albq.qwest.net [97.123.96.141])??by mail.mydomain.com (Postfix) with ESMTPSA id 4E16C17A09B??for <[email protected]>; Sat, 18 Jun 2022 03:15:42 + from 97-123-96-141.albq.qwest.net[97.123.96.141]; from=<[email protected]> to=<[email protected]> proto=ESMTP helo=<[172.30.10.247]>: Received: from [127.0.0.1] (localhost [127.0.0.1])??by mail.mydomain.com (Postfix) with ESMTPSA id 4E16C17A09B??for <[email protected]>; Sat, 18 Jun 2022 03:15:42 +0000 (UTC) Jun 18 03:15:42 mail postfix/cleanup[21933]: 4E16C17A09B: message-id=<[email protected]> Jun 18 03:15:42 mail opendkim[863]: 4E16C17A09B: DKIM-Signature field added (s=default, d=mydomain.com) Jun 18 03:15:42 mail postfix/qmgr[2968]: 4E16C17A09B: from=<[email protected]>, size=557, nrcpt=2 (queue active) Jun 18 03:15:42 mail spamd[1749]: spamd: connection from ::1 [::1]:50480 to port 783, fd 5 Jun 18 03:15:42 mail spamd[1749]: spamd: setuid to gpgit succeeded Jun 18 03:15:42 mail spamd[1749]: spamd: processing message <[email protected]> for gpgit:1001 Jun 18 03:15:42 mail spamd[1750]: spamd: connection from ::1 [::1]:50482 to port 783, fd 5 Jun 18 03:15:42 mail spamd[1750]: spamd: setuid to gpgit succeeded Jun 18 03:15:42 mail postfix/submission/smtpd[21926]: disconnect from 97-123-96-141.albq.qwest.net[97.123.96.141] ehlo=2 starttls=1 auth=1 mail=1 rcpt=1 data=1 quit=1 commands=8 Jun 18 03:15:42 mail spamd[1750]: spamd: processing message <[email protected]> for gpgit:1001 Jun 18 03:15:43 mail spamd[1749]: spamd: clean message (-1.2/5.0) for gpgit:1001 in 0.5 seconds, 1084 bytes. Jun 18 03:15:43 mail spamd[1749]: spamd: result: . -1 - ALL_TRUSTED,DKIM_SIGNED,DKIM_VALID,DKIM_VALID_AU,DKIM_VALID_EF,TVD_SPACE_RATIO,URIBL_BLOCKED scantime=0.5,size=1084,user=gpgit,uid=1001,required_score=5.0,rhost=::1,raddr=::1,rport=50480,mid=<[email protected]>,autolearn=ham autolearn_force=no Jun 18 03:15:43 mail spamd[1128]: prefork: child states: IB Jun 18 03:15:44 mail spamd[1750]: spamd: clean message (-1.2/5.0) for gpgit:1001 in 1.4 seconds, 1084 bytes. Jun 18 03:15:44 mail spamd[1750]: spamd: result: . -1 - ALL_TRUSTED,DKIM_SIGNED,DKIM_VALID,DKIM_VALID_AU,DKIM_VALID_EF,TVD_SPACE_RATIO,URIBL_BLOCKED scantime=1.4,size=1084,user=gpgit,uid=1001,required_score=5.0,rhost=::1,raddr=::1,rport=50482,mid=<[email protected]>,autolearn=unavailable autolearn_force=no Jun 18 03:15:44 mail spamd[1128]: prefork: child states: II Jun 18 03:15:44 mail postfix/pipe[21934]: 4E16C17A09B: to=<[email protected]>, relay=gpgit-pipe, delay=2.1, delays=0.31/0.01/0/1.8, dsn=2.0.0, status=sent (delivered via gpgit-pipe service) Jun 18 03:15:44 mail postfix/pipe[21935]: 4E16C17A09B: to=<[email protected]>, relay=gpgit-pipe, delay=2.1, delays=0.31/0.02/0/1.8, dsn=2.0.0, status=sent (delivered via gpgit-pipe service) Jun 18 03:15:44 mail postfix/qmgr[2968]: 4E16C17A09B: removed Jun 18 03:15:44 mail postfix/pickup[21737]: 532FF17A09B: uid=1001 from=<[email protected]> Jun 18 03:15:44 mail postfix/cleanup[21952]: 532FF17A09B: message-id=<[email protected]> Jun 18 03:15:44 mail opendkim[863]: 532FF17A09B: DKIM-Signature field added (s=default, d=mydomain.com) Jun 18 03:15:44 mail postfix/qmgr[2968]: 532FF17A09B: from=<[email protected]>, size=1527, nrcpt=2 (queue active) Jun 18 03:15:44 mail postfix/pickup[21737]: 62D6A17A0A0: uid=1001 from=<[email protected]> Jun 18 03:15:44 mail postfix/cleanup[21952]: 62D6A17A0A0: message-id=<[email protected]> Jun 18 03:15:44 mail opendkim[863]: 62D6A17A0A0: DKIM-Signature field added (s=default, d=mydomain.com) Jun 18 03:15:44 mail postfix/qmgr[2968]: 62D6A17A0A0: from=<[email protected]>, size=1535, nrcpt=2 (queue active) Jun 18 03:15:44 mail postfix/smtpd[21957]: connect from localhost[127.0.0.1] Jun 18 03:15:44 mail postfix/smtpd[21957]: 8094B17A0A2: client=localhost[127.0.0.1] Jun 18 03:15:44 mail postfix/cleanup[21954]: 8094B17A0A2: message-id=<[email protected]> Jun 18 03:15:44 mail postfix/qmgr[2968]: 8094B17A0A2: from=<[email protected]>, size=2430, nrcpt=3 (queue active) Jun 18 03:15:44 mail postfix/smtpd[21957]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=2 data=1 quit=1 commands=6 Jun 18 03:15:44 mail amavis[19728]: (19728-09) Passed CLEAN {RelayedInbound,RelayedOpenRelay}, [127.0.0.1] <[email protected]> -> <[email protected]>,<[email protected]>, Message-ID: <[email protected]>, mail_id: FZ3nWI-M__7v, Hits: -, size: 2039, queued_as: 8094B17A0A2, dkim_sd=default:mydomain.com, 123 ms Jun 18 03:15:44 mail postfix/smtp[21953]: 532FF17A09B: to=<[email protected]>, relay=127.0.0.1[127.0.0.1]:10024, delay=1.9, delays=1.7/0.04/0/0.14, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 8094B17A0A2) Jun 18 03:15:44 mail postfix/smtp[21953]: 532FF17A09B: to=<[email protected]>, relay=127.0.0.1[127.0.0.1]:10024, delay=1.9, delays=1.7/0.04/0/0.14, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 8094B17A0A2) Jun 18 03:15:44 mail postfix/qmgr[2968]: 532FF17A09B: removed Jun 18 03:15:44 mail postfix/smtpd[21957]: connect from localhost[127.0.0.1] Jun 18 03:15:44 mail postfix/smtpd[21957]: 9B45817A09B: client=localhost[127.0.0.1] Jun 18 03:15:44 mail postfix/cleanup[21952]: 9B45817A09B: message-id=<[email protected]> Jun 18 03:15:44 mail postfix/qmgr[2968]: 9B45817A09B: from=<[email protected]>, size=2643, nrcpt=3 (queue active) Jun 18 03:15:44 mail postfix/smtpd[21957]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=2 data=1 quit=1 commands=6 Jun 18 03:15:44 mail amavis[19779]: (19779-09) Passed CLEAN {RelayedInbound}, [127.0.0.1] <[email protected]> -> <[email protected]>,<[email protected]>, Message-ID: <[email protected]>, mail_id: h4sjymJW2jCC, Hits: -, size: 2047, queued_as: 9B45817A09B, dkim_sd=default:mydomain.com, 170 ms Jun 18 03:15:44 mail postfix/smtp[21956]: 62D6A17A0A0: to=<[email protected]>, relay=127.0.0.1[127.0.0.1]:10024, delay=2, delays=1.7/0.02/0/0.18, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 9B45817A09B) Jun 18 03:15:44 mail postfix/smtp[21956]: 62D6A17A0A0: to=<[email protected]>, relay=127.0.0.1[127.0.0.1]:10024, delay=2, delays=1.7/0.02/0/0.18, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 9B45817A09B) Jun 18 03:15:44 mail postfix/qmgr[2968]: 62D6A17A0A0: removed Jun 18 03:15:44 mail dovecot: lmtp(21866): Connect from local Jun 18 03:15:44 mail dovecot: lmtp(21966): Connect from local Jun 18 03:15:44 mail dovecot: lmtp([email protected])<21866><S/9pKWBDrWJqVQAANmah8A>: sieve: msgid=<[email protected]>: stored mail into mailbox 'Sent' Jun 18 03:15:44 mail postfix/lmtp[21963]: 8094B17A0A2: to=<[email protected]>, relay=mail.mydomain.com[private/dovecot-lmtp], delay=0.22, delays=0.02/0.05/0.1/0.05, dsn=2.0.0, status=sent (250 2.0.0 <[email protected]> S/9pKWBDrWJqVQAANmah8A Saved) Jun 18 03:15:44 mail dovecot: lmtp(21866): Disconnect from local: Client has quit the connection (state=READY) Jun 18 03:15:44 mail dovecot: lmtp(21866): Connect from local Jun 18 03:15:44 mail dovecot: lmtp([email protected])<21866><oEmDLmBDrWJqVQAANmah8A>: sieve: msgid=<[email protected]>: stored mail into mailbox 'Sent' Jun 18 03:15:44 mail postfix/lmtp[21963]: 9B45817A09B: to=<[email protected]>, relay=mail.mydomain.com[private/dovecot-lmtp], delay=0.3, delays=0.01/0.1/0.03/0.16, dsn=2.0.0, status=sent (250 2.0.0 <[email protected]> oEmDLmBDrWJqVQAANmah8A Saved) Jun 18 03:15:44 mail dovecot: lmtp([email protected])<21966><KCCGLmBDrWLOVQAANmah8A>: sieve: msgid=<[email protected]>: stored mail into mailbox 'Sent' Jun 18 03:15:44 mail postfix/lmtp[21965]: 8094B17A0A2: to=<[email protected]>, relay=mail.mydomain.com[private/dovecot-lmtp], delay=0.42, delays=0.02/0.14/0.09/0.17, dsn=2.0.0, status=sent (250 2.0.0 <[email protected]> KCCGLmBDrWLOVQAANmah8A Saved) Jun 18 03:15:44 mail dovecot: lmtp(21966): Disconnect from local: Client has quit the connection (state=READY) Jun 18 03:15:44 mail dovecot: lmtp(21968): Connect from local Jun 18 03:15:44 mail dovecot: lmtp([email protected])<21968><T0JmOWBDrWLQVQAANmah8A>: sieve: msgid=<[email protected]>: stored mail into mailbox 'Sent' Jun 18 03:15:44 mail postfix/lmtp[21965]: 9B45817A09B: to=<[email protected]>, relay=mail.mydomain.com[private/dovecot-lmtp], delay=0.36, delays=0.01/0.29/0.03/0.03, dsn=2.0.0, status=sent (250 2.0.0 <[email protected]> T0JmOWBDrWLQVQAANmah8A Saved) Jun 18 03:15:45 mail dovecot: lmtp([email protected])<21866><INy2OGBDrWJqVQAANmah8A>: sieve: msgid=<[email protected]>: stored mail into mailbox 'Sent' Jun 18 03:15:45 mail postfix/lmtp[21963]: 9B45817A09B: to=<[email protected]>, relay=mail.mydomain.com[private/dovecot-lmtp], conn_use=2, delay=0.37, delays=0.01/0.3/0/0.05, dsn=2.0.0, status=sent (250 2.0.0 <[email protected]> INy2OGBDrWJqVQAANmah8A Saved) Jun 18 03:15:45 mail postfix/qmgr[2968]: 9B45817A09B: removed Jun 18 03:15:45 mail postfix/smtp[21913]: 8094B17A0A2: to=<[email protected]>, relay=filter.anotherdomain.com[216.24.56.70]:25, delay=0.82, delays=0.02/0/0.55/0.25, dsn=2.0.0, status=sent (250 Ok: queued as 4E14D2E40052) Jun 18 03:15:45 mail postfix/qmgr[2968]: 8094B17A0A2: removed Jun 18 03:15:46 mail dovecot: lmtp(21968): Disconnect from local: Remote closed connection (state=READY) Jun 18 03:15:47 mail dovecot: lmtp(21866): Disconnect from local: Remote closed connection (state=READY) Austin Witmer > On Jun 17, 2022, at 1:14 PM, Austin Witmer <[email protected]> wrote: > > Hello all! > > I have a server running dovecot & postfix. I have a user on my server who is > sending email via smtp on an HP printer and because of that, a copy of the > email is not placed in the sent folder like usually happens with clients like > outlook and thunderbird. > > I posted this problem on the dovecot mailing list, and they recommended that > I use sender_bcc_maps in postfix to bcc messages to myself and then use a > sieve script to place them in the sent folder. > > I got this working now but the trouble is that it is putting five copies of > the same email in my sent folder. Does anybody have any ideas on why this > might be happening? > > Thx! > > Austin Witmer
