[Dovecot] Mail lost - maybe a bug???
Marco Carcano
marco at carcano.ch
Fri Oct 28 01:55:09 EEST 2011
Hello everybody
I'm struggling against what seems a really serious trouble: sometimes
mail get lost
I did all the possible checks, but they seems really lost - I know is
absurd, but it seems so
it has been noticed by two users on my server: intially I tought that
was their mistake (mail deleted, mail into spam, ecc), but it wasn't
I deeply checked mail logs, and it seems that mail are delivered (the
path is postfix->amavis->dovecotlda) - log files says that messages
are delivered, but sometimes we lost a message.
I also tried to get into the Maildir and grep the subject of the lost
email: if it was addressed to more recipients I'm able to get it on
some of them, but not to all (look at the example below)
I hope I have clearly explained everything, otherwise let me
knowmydomain
now an extract from the log file:
Oct 27 11:20:29 srv001 postfix/smtpd[24562]: connect from usstlz-
psecap06.emerson.com[144.191.128.17]
Oct 27 11:20:30 srv001 postfix/smtpd[24562]: CE0B74E4A9F:
client=usstlz-psecap06.emerson.com[144.191.128.17]
Oct 27 11:20:31 srv001 postfix/cleanup[25157]: CE0B74E4A9F: warning:
header Subject: =?utf-8?B?
RW1lcnNvbiBHbG9iYWwgVXNlcnMgRXhjaGFuZ2UgMjAxMiBpbiBEw7xzc2VsZG9yZiA6IFJlaWNoZW4gU2llIGpldHp0IElocmUgUHLDpHNlbnRhdGlvbmVuIGVpbg
==?= from usstlz-psecap06.emerson.com[144.191.128.17]; from=<Emerson.News at emersonprocess.com
> to=<oil at mydomain.ch> proto=ESMTP helo=<USSTLZ-PSECAP06.EMERSON.COM>
Oct 27 11:20:31 srv001 postfix/cleanup[25157]: CE0B74E4A9F: message-
id=<e9447410-51fe-45ff-b624-197840b9a862 at usstlz-pinfez02.emrsn.org>
Oct 27 11:20:31 srv001 postfix/qmgr[11827]: CE0B74E4A9F: from=<Emerson.News at emersonprocess.com
>, size=22689, nrcpt=3 (queue active)
Oct 27 11:20:33 srv001 dovecot: imap(lromano): Disconnected: Logged
out bytes=632/34319
Oct 27 11:20:34 srv001 postfix/smtpd[25162]: connect from
localhost.localdomain[127.0.0.1]
Oct 27 11:20:34 srv001 postfix/smtpd[25162]: B16284E4AA2:
client=localhost.localdomain[127.0.0.1]
Oct 27 11:20:34 srv001 postfix/cleanup[25157]: B16284E4AA2: message-
id=<e9447410-51fe-45ff-b624-197840b9a862 at usstlz-pinfez02.emrsn.org>
Oct 27 11:20:34 srv001 postfix/qmgr[11827]: B16284E4AA2: from=<Emerson.News at emersonprocess.com
>, size=23094, nrcpt=3 (queue active)
Oct 27 11:20:34 srv001 amavis[22923]: (22923-01) Passed CLEAN,
[144.191.128.17] [155.177.20.144] <Emerson.News at emersonprocess.com> ->
<user1 at mydomain.local>,<user2 at mydomain.local>,<user3 at mydomain.local>,
Message-ID: <e9447410-51fe-45ff-b624-197840b9a862 at usstlz-pinfez02.emrsn.org
>, mail_id: 6rtF4927FAjt, Hits: -0.518, size: 22687, queued_as:
B16284E4AA2, 3293 ms
Oct 27 11:20:34 srv001 postfix/lmtp[25158]: CE0B74E4A9F: to=<user1 at mydomain.local
>, orig_to=<oil at mydomain.ch>, relay=127.0.0.1[127.0.0.1]:10024,
delay=4.2, delays=0.95/0.01/0.01/3.3, dsn=2.0.0, status=sent (250
2.0.0 from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as B16284E4AA2)
Oct 27 11:20:34 srv001 postfix/lmtp[25158]: CE0B74E4A9F: to=<user2 at mydomain.local
>, orig_to=<oil at mydomain.ch>, relay=127.0.0.1[127.0.0.1]:10024,
delay=4.2, delays=0.95/0.01/0.01/3.3, dsn=2.0.0, status=sent (250
2.0.0 from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as B16284E4AA2)
Oct 27 11:20:34 srv001 postfix/lmtp[25158]: CE0B74E4A9F: to=<user3 at mydomain.local
>, orig_to=<oil at mydomain.ch>, relay=127.0.0.1[127.0.0.1]:10024,
delay=4.2, delays=0.95/0.01/0.01/3.3, dsn=2.0.0, status=sent (250
2.0.0 from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as B16284E4AA2)
Oct 27 11:20:34 srv001 postfix/qmgr[11827]: CE0B74E4A9F: removed
Oct 27 11:20:34 srv001 dovecot: lda(user1): msgid=<e9447410-51fe-45ff-b624-197840b9a862 at usstlz-pinfez02.emrsn.org
>: saved mail to INBOX
Oct 27 11:20:34 srv001 postfix/pipe[25165]: B16284E4AA2: to=<user1 at mydomain.local
>, relay=dovecot, delay=0.04, delays=0.01/0.01/0/0.02, dsn=2.0.0,
status=sent (delivered via dovecot service)
Oct 27 11:20:34 srv001 dovecot: lda(user2): msgid=<e9447410-51fe-45ff-b624-197840b9a862 at usstlz-pinfez02.emrsn.org
>: saved mail to INBOX
Oct 27 11:20:34 srv001 postfix/pipe[25168]: B16284E4AA2: to=<user2 at mydomain.local
>, relay=dovecot, delay=0.04, delays=0.01/0.01/0/0.02, dsn=2.0.0,
status=sent (delivered via dovecot service)
Oct 27 11:20:34 srv001 dovecot: lda(user3): msgid=<e9447410-51fe-45ff-b624-197840b9a862 at usstlz-pinfez02.emrsn.org
>: saved mail to INBOX
Oct 27 11:20:34 srv001 postfix/pipe[25170]: B16284E4AA2: to=<user3 at mydomain.local
>, relay=dovecot, delay=0.05, delays=0.01/0.02/0/0.02, dsn=2.0.0,
status=sent (delivered via dovecot service)
Oct 27 11:20:34 srv001 postfix/qmgr[11827]: B16284E4AA2: removed
Oct 27 11:20:36 srv001 postfix/smtpd[24562]: disconnect from usstlz-
psecap06.emerson.com[144.191.128.17]
as you can see there was a message for oil at mydomain.ch (I obviously
changed the domain for privacy) - logs says that all the three users
got the email, but the third user didn't.
I do not know why and when it happens, but seldom we have this issue
maybe is there some kind of bug in the maildrop version I use? by the
way, I had this issue also before installing amavisd-new
now some infos:
CentOS 5.3
postfix-2.3.3-2.1.el5_2
amavisd-new-2.6.6-1.el5.rf
dovecot-2.0.11-1_126
dovecot-managesieve-0.2.2-15
dovecot-pigeonhole-0.2.2-15
users are on a Kerberized OpenLDAP
please help me because this is really driving me crazy -
don't leave me alone, please
Marco Carcano
More information about the dovecot
mailing list