dovecot - Jul 2006 - LDA Command time limit exceeded

I have many errors of this type in my logs:

2 * postfix/pipe[21511]: BC8DD3356A: to=<*****@******>, relay=dovecot,
delay=1001, status=bounced (Command time limit exceeded:
"/usr/local/dovecot-1.0-rc2/libexec/dovecot/deliver")

My command time limit is 1000s in postfix (more than 15 minutes)

After many check, I found that a lots of this error is not really an
error.

The mail is delivered in the mailbox, but postfix send an error message.
Like if Dovecot LDA process dont exit correctly after sending a mail.

Do you know this bug ?

As workaround i set the command time limit to 1400s but this is too long
for our customer. They need in time service.

We use an NFS server as storage for all our mail.

Output of nfstat:

Server nfs v3:
null       getattr    setattr    lookup     access     readlink
1       0% 744955962 21% 34845109  1% 397981329 11% 818838045 24% 0
0%
read       write      create     mkdir      symlink    mknod
649838729 19% 502171416 14% 29188492  0% 301741  0% 0       0% 0
0%
remove     rmdir      rename     link       readdir    readdirplus
54138192  1% 19903   0% 30702957  0% 27796623  0% 1294453  0% 84457031
2%
fsstat     fsinfo     pathconf   commit
48529   0% 31463   0% 0       0% 11339977  0%

Output of iostat:

Linux 2.4.27-3-686-smp (data.clm.net4all.ch)    21. 07. 06

cpu-moy:  %user   %nice    %sys %iowait   %idle
           0,16    0,00    1,65    0,00   98,19

Device:            tps    Blk_lus/s Blk_?crits/s    Blk_lus Blk_?crits
scsi/host0/bus0/target0/lun0/disc
                165,50       310,46       617,07 1800983948 3579692632
scsi/host0/bus0/target0/lun0/part1
                165,48       309,32       617,06 1794404866 3579616544
scsi/host0/bus0/target0/lun0/part5
                  0,02         1,13         0,01    6579064      76088

Thanks for your answers,




-- 
Net4all S.A.
Dominique Feyer
Administrateur Syst?me
Ch. de la Colline 5bis
CH-1007 Lausanne
dfeyer at net4all.ch

On Fri, 2006-07-21 at 18:51 +0200, Dominique Feyer
wrote:
> I have many errors of this type in my logs:
> 
> 2 * postfix/pipe[21511]: BC8DD3356A: to=<*****@******>,
relay=dovecot,
> delay=1001, status=bounced (Command time limit exceeded:
> "/usr/local/dovecot-1.0-rc2/libexec/dovecot/deliver")
> 
> My command time limit is 1000s in postfix (more than 15 minutes)
> 
> After many check, I found that a lots of this error is not really an
> error.
> 
> The mail is delivered in the mailbox, but postfix send an error message.
> Like if Dovecot LDA process dont exit correctly after sending a mail.
Well, it would really help to know where it's stuck. I don't see any
reason why it would be doing nothing for that long.

Could you just get a ps output, find a few minutes old deliver process
and then do both:

strace -p pid 2>log
(wait for a couple of seconds, then ctrl-c)

gdb attach pid
bt
(copy&paste the output)
quit

And show me what they said.

-------------- next part --------------
A non-text attachment was scrubbed...
Name: signature.asc
Type: application/pgp-signature
Size: 191 bytes
Desc: This is a digitally signed message part
URL:
<http://dovecot.org/pipermail/dovecot/attachments/20060811/38d4fe6d/attachment.bin>