[Dovecot] dovecot from debian lenny-backports does not accept connections

Joelly Alexander alex at joelly.net
Fri May 14 22:18:00 EEST 2010


hi,

dovecot from the debian lenny backports does not successfully accept 
incomming imap or imaps connections;
when the client connect i can see the clients ip address in an 
imap-process but the client cannot succesfully connect and retries this 
several times where an new imap-process is bound until the maximum 
connections per client is reached;
when the client is closed the imap-processes on the server stay opened, 
even when dovecot will be restarted or stopped - the processes needs to 
killed manually;


--- snip ---
2010-05-14 02:24:42 auth(default): Info: client in: AUTH        1       
PLAIN   service=imap    secured     lip=y.y.y.y      rip=x.x.x.x      
lport=993       rport=1411
2010-05-14 02:24:42 auth(default): Info: client out: CONT       1
2010-05-14 02:24:42 auth(default): Info: client in: CONT        1       
AGFsZXhAdXZzdCrhdAB5YWxpbWVybw==
2010-05-14 02:24:42 auth-worker(default): Info: 
sql(alex at domain.tld,x.x.x.x): query: SELECT username AS user, password, 
'/var/vmail/domain.tld/alex' AS userdb_home, 
'maildir:/var/vmail/domain.tld/alex' AS userdb_mail, 150 AS userdb_uid, 
8 AS userdb_gid FROM mailbox WHERE username = 'alex at domain.tld' AND 
active = '1'
2010-05-14 02:24:42 auth(default): Info: client out: OK 1       
user=alex at domain.tld
2010-05-14 02:24:42 auth(default): Info: master in: REQUEST     2       
2177    1
2010-05-14 02:24:42 auth(default): Info: 
prefetch(alex at domain.tld,x.x.x.x): success
2010-05-14 02:24:42 auth(default): Info: master out: USER       2       
alex at domain.tld    home=/var/vmail/domain.tld/alex        
mail=maildir:/var/vmail/domain.tld/alex    uid=150 gid=8
2010-05-14 02:24:42 imap-login: Info: Login: user=<alex at domain.tld>, 
method=PLAIN, rip=x.x.x.x, lip=y.y.y.y, TLS
2010-05-14 02:24:42 IMAP(alex at domain.tld): Info: Loading modules from 
directory: /usr/lib/dovecot/modules/imap
2010-05-14 02:24:42 IMAP(alex at domain.tld): Info: Module loaded: 
/usr/lib/dovecot/modules/imap/lib10_quota_plugin.so
2010-05-14 02:24:42 IMAP(alex at domain.tld): Info: Module loaded: 
/usr/lib/dovecot/modules/imap/lib11_imap_quota_plugin.so
2010-05-14 02:24:42 IMAP(alex at domain.tld): Info: Effective uid=150, 
gid=8, home=/var/vmail/domain.tld/alex
2010-05-14 02:24:42 IMAP(alex at domain.tld): Info: Quota root: 
name=storage=102400 backend=maildir args=
2010-05-14 02:24:42 IMAP(alex at domain.tld): Info: maildir: 
data=/var/vmail/domain.tld/alex
2010-05-14 02:24:42 IMAP(alex at domain.tld): Info: maildir++: 
root=/var/vmail/domain.tld/alex, index=, control=, 
inbox=/var/vmail/domain.tld/alex
2010-05-14 02:24:42 auth(default): Info: new auth connection: pid=2186
2010-05-14 02:24:45 auth(default): Info: client in: AUTH        1       
PLAIN   service=imap    secured     lip=y.y.y.y      rip=x.x.x.x      
lport=993       rport=1412
2010-05-14 02:24:45 auth(default): Info: client out: CONT       1
2010-05-14 02:24:45 auth(default): Info: client in: CONT        1       
AGFsZXhAdXZzdCrhdAB5YWxpbWVybw==
2010-05-14 02:24:45 auth-worker(default): Info: 
sql(alex at domain.tld,x.x.x.x): query: SELECT username AS user, password, 
'/var/vmail/domain.tld/alex' AS userdb_home, 
'maildir:/var/vmail/domain.tld/alex' AS userdb_mail, 150 AS userdb_uid, 
8 AS userdb_gid FROM mailbox WHERE username = 'alex at domain.tld' AND 
active = '1'
2010-05-14 02:24:45 auth(default): Info: client out: OK 1       
user=alex at domain.tld
2010-05-14 02:24:45 auth(default): Info: master in: REQUEST     3       
2075    1
2010-05-14 02:24:45 auth(default): Info: 
prefetch(alex at domain.tld,x.x.x.x): success
2010-05-14 02:24:45 auth(default): Info: master out: USER       3       
alex at domain.tld    home=/var/vmail/domain.tld/alex        
mail=maildir:/var/vmail/domain.tld/alex    uid=150 gid=8
2010-05-14 02:24:45 imap-login: Info: Login: user=<alex at domain.tld>, 
method=PLAIN, rip=x.x.x.x, lip=y.y.y.y, TLS
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: Loading modules from 
directory: /usr/lib/dovecot/modules/imap
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: Module loaded: 
/usr/lib/dovecot/modules/imap/lib10_quota_plugin.so
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: Module loaded: 
/usr/lib/dovecot/modules/imap/lib11_imap_quota_plugin.so
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: Effective uid=150, 
gid=8, home=/var/vmail/domain.tld/alex
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: Quota root: 
name=storage=102400 backend=maildir args=
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: maildir: 
data=/var/vmail/domain.tld/alex
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: maildir++: 
root=/var/vmail/domain.tld/alex, index=, control=, 
inbox=/var/vmail/domain.tld/alex
2010-05-14 02:24:45 auth(default): Info: new auth connection: pid=2189
2010-05-14 02:24:45 auth(default): Info: new auth connection: pid=2188
2010-05-14 02:24:45 auth(default): Info: client in: AUTH        1       
PLAIN   service=imap    secured     lip=y.y.y.y      rip=x.x.x.x      
lport=993       rport=1413
2010-05-14 02:24:45 auth(default): Info: client out: CONT       1
2010-05-14 02:24:45 auth(default): Info: client in: CONT        1       
AGFsZXhAdXZzdC5hdABrYWxpbWVybw==
2010-05-14 02:24:45 auth-worker(default): Info: 
sql(alex at domain.tld,x.x.x.x): query: SELECT username AS user, password, 
'/var/vmail/domain.tld/alex' AS userdb_home, 
'maildir:/var/vmail/domain.tld/alex' AS userdb_mail, 150 AS userdb_uid, 
8 AS userdb_gid FROM mailbox WHERE username = 'alex at domain.tld' AND 
active = '1'
2010-05-14 02:24:45 auth(default): Info: client out: OK 1       
user=alex at domain.tld
2010-05-14 02:24:45 auth(default): Info: master in: REQUEST     4       
2186    1
2010-05-14 02:24:45 auth(default): Info: 
prefetch(alex at domain.tld,x.x.x.x): success
2010-05-14 02:24:45 auth(default): Info: master out: USER       4       
alex at domain.tld    home=/var/vmail/domain.tld/alex        
mail=maildir:/var/vmail/domain.tld/alex    uid=150 gid=8
2010-05-14 02:24:45 imap-login: Info: Login: user=<alex at domain.tld>, 
method=PLAIN, rip=x.x.x.x, lip=y.y.y.y, TLS
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: Loading modules from 
directory: /usr/lib/dovecot/modules/imap
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: Module loaded: 
/usr/lib/dovecot/modules/imap/lib10_quota_plugin.so
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: Module loaded: 
/usr/lib/dovecot/modules/imap/lib11_imap_quota_plugin.so
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: Effective uid=150, 
gid=8, home=/var/vmail/domain.tld/alex
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: Quota root: 
name=storage=102400 backend=maildir args=
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: maildir: 
data=/var/vmail/domain.tld/alex
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: maildir++: 
root=/var/vmail/domain.tld/alex, index=, control=, 
inbox=/var/vmail/domain.tld/alex
2010-05-14 02:24:45 auth(default): Info: client in: AUTH        1       
PLAIN   service=imap    secured     lip=y.y.y.y      rip=x.x.x.x      
lport=993       rport=1414
2010-05-14 02:24:45 auth(default): Info: client out: CONT       1
2010-05-14 02:24:45 auth(default): Info: client in: CONT        1       
AGFsZXhAdXZzdC5hdABrYWxpbWVybw==
2010-05-14 02:24:45 auth-worker(default): Info: 
sql(alex at domain.tld,x.x.x.x): query: SELECT username AS user, password, 
'/var/vmail/domain.tld/alex' AS userdb_home, 
'maildir:/var/vmail/domain.tld/alex' AS userdb_mail, 150 AS userdb_uid, 
8 AS userdb_gid FROM mailbox WHERE username = 'alex at domain.tld' AND 
active = '1'
2010-05-14 02:24:45 auth(default): Info: client out: OK 1       
user=alex at domain.tld
2010-05-14 02:24:45 auth(default): Info: master in: REQUEST     5       
2188    1
2010-05-14 02:24:45 auth(default): Info: 
prefetch(alex at domain.tld,x.x.x.x): success
2010-05-14 02:24:45 auth(default): Info: master out: USER       5       
alex at domain.tld    home=/var/vmail/domain.tld/alex        
mail=maildir:/var/vmail/domain.tld/alex    uid=150 gid=8
2010-05-14 02:24:45 imap-login: Info: Login: user=<alex at domain.tld>, 
method=PLAIN, rip=x.x.x.x, lip=y.y.y.y, TLS
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: Loading modules from 
directory: /usr/lib/dovecot/modules/imap
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: Module loaded: 
/usr/lib/dovecot/modules/imap/lib10_quota_plugin.so
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: Module loaded: 
/usr/lib/dovecot/modules/imap/lib11_imap_quota_plugin.so
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: Effective uid=150, 
gid=8, home=/var/vmail/domain.tld/alex
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: Quota root: 
name=storage=102400 backend=maildir args=
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: maildir: 
data=/var/vmail/domain.tld/alex
2010-05-14 02:24:45 IMAP(alex at domain.tld): Info: maildir++: 
root=/var/vmail/domain.tld/alex, index=, control=, 
inbox=/var/vmail/domain.tld/alex
2010-05-14 02:24:46 auth(default): Info: new auth connection: pid=2192

--- snip ---

i have a working installation from the stable repository with the same 
settings - but i need the newer dovecot for the nfs feature;
i know there was a kernel bug prior 2.6.27 which also causes such a 
problem, but i have now the 2.6.32 running and still having this problem 
- no client connection could be established....

has anyone a idea or a solution for me?

thx,
alex


More information about the dovecot mailing list