[Dovecot] Mail lost - maybe a bug???

[Marco Carcano]

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