[Dovecot] Problem with lmtp director proxy

[Angel L. Mateo]

El 13/06/12 14:59, Timo Sirainen escribió:
> On Wed, 2012-06-13 at 08:58 +0200, Angel L. Mateo wrote:
>> 	I have checked in almost every error I had that the error is produced
>> whenever happens a timeout of 30 seconds between opening the connection
>> between the director and backend server and the final delivery of the
>> message in the user's mailbox.
>>
>> 	When I have mails with just a few of recipients, I have no problem
>> because this 30 seconds timeout is never reached. But when I have mails
>> with more recipients and my storage has workload it is sometimes reached.
>
> Ah, so it's not really a bug. I thought it might be because there had
> been such problems before.
>
>> 	But I haven't found any configuration for this 30 seconds timeout. What
>> could it be this option? Because I have configured proxy_timeout=120 in
>> proxy configuration:
>>
>> pass_attrs =
>> irisMailbox=userdb_mail,homeDirectory=userdb_home,uidNumber=userdb_uid,gidNumber=userdb_gid,=proxy=y,=proxy_timeout=120,irisMailHost=host
>
> This should work..
>
>> lmtp/commands.c:#define LMTP_PROXY_DEFAULT_TIMEOUT_MSECS (1000*30)
>
> This is the default, but proxy_timeout should override it.
>
	But then, why timeout is reached after only 30 seconds? Could it be 
other define timeout like DIRECTOR_CONNECTION_DONE_TIMEOUT_MSECS?

> What do you get in logs with auth_debug=yes?
>
	I've got always auth_debug=yes. In the director server, logs are:

Jun 12 11:40:39 myotis41 dovecot: lmtp(6595): Connect from 155.54.212.167
Jun 12 11:40:39 myotis41 dovecot: lmtp(6595): Debug: auth input: 
user=user1 proxy host=155.54.211.163 proxy_refresh=450
Jun 12 11:40:39 myotis41 dovecot: lmtp(6595): Debug: auth input: 
user=user2 proxy host=155.54.211.163 proxy_refresh=450
....  (more users, a total of 34 recipients)
Jun 12 11:40:39 myotis41 dovecot: lmtp(6595): Debug: auth input: 
user=myuser proxy host=155.54.211.164 proxy_refresh=450
...
Jun 12 11:41:09 myotis41 dovecot: lmtp(6595): Disconnect from 
155.54.212.167: Client quit (in reset)

	but I have checked with newer errors, all I see in logs are "Connect 
from" and "Disconnect from" messages. The logs "lmtp...Debug:" are not 
produced any more (maybe because director has this information yet?)

	At backend servers are:

Jun 12 11:40:38 myotis34 dovecot: lmtp(16824): Connect from 155.54.211.186
Jun 12 11:40:38 myotis34 dovecot: lmtp(16824, <user1>): wJ9BD7YM10
+4QQAAG5O5Qg: sieve: 
msgid=<182283367.48.1339494011054.JavaMail.tomcat at sakai-prod4>: stored 
mail into mailbox 'INBOX'
...
Jun 12 11:41:10 myotis34 dovecot: lmtp(16824, <myuser>): wJ9BD7YM10+4QQA
AG5O5Qg: sieve: 
msgid=<182283367.48.1339494011054.JavaMail.tomcat at sakai-prod4>: stored 
mail into mailbox 'INBOX'