URL: https://www.opennet.me/cgi-bin/openforum/vsluhboard.cgi
Форум: vsluhforumID1
Нить номер: 86137
[ Назад ]

Исходное сообщение
"Долгая аутентификация dovecot"

Отправлено Nc , 30-Июл-09 16:40 
Здравствуйте,

Сервер: Linux FС11 2.6.29.6-213.fc11.i586, Dovecot 1.2.0

Клиент: Linux FC11, Почтовик thunderbird 2.0.0.22.

При получении сообщений аутентификация происходит долго (около 3-4 секунд). Когда на серваке стояла FC 5, аутентификация происходила мгновенно. После переустановки конфиги не менялись. Подскажите, пожалуйста, в какую сторону копать, чтобы сократить время аутентификации? Может кто-нибудь сталкивался с этим или знает в чем может быть причина.

========================================================================================
dovecot.log

Jul 30 16:26:37 pop3-login: Info: Login: user=<xxx@yyy.zz>, method=PLAIN, rip=192.168.1.5, lip=192.168.1.2
Jul 30 16:26:37 POP3(xxx@yyy.zz): Info: Disconnected: Logged out top=0/0, retr=2/3096, del=2/2, size=3062
========================================================================================

Проблем с сетью нет:

64 bytes from 192.168.1.2: icmp_seq=1 ttl=64 time=0.198 ms
========================================================================================


Содержание

Сообщения в этом обсуждении
"Долгая аутентификация dovecot"
Отправлено бусик , 30-Июл-09 17:48 
>[оверквотинг удален]
>
>Jul 30 16:26:37 pop3-login: Info: Login: user=<xxx@yyy.zz>, method=PLAIN, rip=192.168.1.5, lip=192.168.1.2
>Jul 30 16:26:37 POP3(xxx@yyy.zz): Info: Disconnected: Logged out top=0/0, retr=2/3096, del=2/2, size=3062
>
>========================================================================================
>
>Проблем с сетью нет:
>
>64 bytes from 192.168.1.2: icmp_seq=1 ttl=64 time=0.198 ms
>========================================================================================

1. попробуйте пройти аутентификацию из консоли (telnet)
2. в приведенном куске лога логин и дисконнект прошёл в течении 1 секунды.


"Долгая аутентификация dovecot"
Отправлено Nc , 30-Июл-09 19:05 
>[оверквотинг удален]
>>========================================================================================
>>
>>Проблем с сетью нет:
>>
>>64 bytes from 192.168.1.2: icmp_seq=1 ttl=64 time=0.198 ms
>>========================================================================================
>
>1. попробуйте пройти аутентификацию из консоли (telnet)
>2. в приведенном куске лога логин и дисконнект прошёл в течении 1
>секунды.

Аутентификация из консоли по telnet проходит мгновенно. Интересно, где тогда причина? В thunderbird? Причем проблема наблюдается на всех почтовых клиентах, которые забирают почту с сервера.


"Долгая аутентификация dovecot"
Отправлено BlackHawk , 30-Июл-09 20:07 
>[оверквотинг удален]
>>>64 bytes from 192.168.1.2: icmp_seq=1 ttl=64 time=0.198 ms
>>>========================================================================================
>>
>>1. попробуйте пройти аутентификацию из консоли (telnet)
>>2. в приведенном куске лога логин и дисконнект прошёл в течении 1
>>секунды.
>
>Аутентификация из консоли по telnet проходит мгновенно. Интересно, где тогда причина? В
>thunderbird? Причем проблема наблюдается на всех почтовых клиентах, которые забирают почту
>с сервера.

backresolv? может dovecot пытается просто сделать reverse запрос на DNS?


"Долгая аутентификация dovecot"
Отправлено Nc , 30-Июл-09 20:18 
>[оверквотинг удален]
>>>
>>>1. попробуйте пройти аутентификацию из консоли (telnet)
>>>2. в приведенном куске лога логин и дисконнект прошёл в течении 1
>>>секунды.
>>
>>Аутентификация из консоли по telnet проходит мгновенно. Интересно, где тогда причина? В
>>thunderbird? Причем проблема наблюдается на всех почтовых клиентах, которые забирают почту
>>с сервера.
>
>backresolv? может dovecot пытается просто сделать reverse запрос на DNS?

DNS настроен верно и работает быстро. Обратная зона прописана.

Вот debug log, надеюсь кто-то увидит в нем причину задержки.

Jul 30 20:12:55 auth(default): Info: client in: AUTH    1    PLAIN    service=pop3    lip=192.168.1.2    rip=192.168.1.5    lport=110    rport=39118    resp=
Jul 30 20:12:55 auth(default): Info: plain(?,192.168.1.5): invalid input
Jul 30 20:12:56 auth(default): Info: new auth connection: pid=23257
Jul 30 20:12:57 auth(default): Info: client out: FAIL    1
Jul 30 20:13:02 auth(default): Info: client in: AUTH    2    PLAIN    service=pop3    lip=192.168.1.2    rip=192.168.1.5    lport=110    rport=39118    resp=AG5jLXBAc3RwZXRlLmxvY2FsAE51T1pxNVl5Tlc=
Jul 30 20:13:02 auth(default): Info: passwd-file(nc-p@stpete.local,192.168.1.5): lookup: user=nc-p@stpete.local file=/etc/dovecot/virt-1-pass
Jul 30 20:13:02 auth(default): Info: client out: OK    2    user=nc-p@stpete.local
Jul 30 20:13:02 auth(default): Info: master in: REQUEST    12    23251    2
Jul 30 20:13:02 auth(default): Info: passwd-file(nc-p@stpete.local,192.168.1.5): lookup: user=nc-p@stpete.local file=/etc/dovecot/v-users
Jul 30 20:13:02 auth(default): Info: master out: USER    12    nc-p@stpete.local    uid=5000    gid=5000    home=/home/virtual/stpete.local/
Jul 30 20:13:02 POP3(nc-p@stpete.local): Info: Effective uid=5000, gid=5000, home=/home/virtual/stpete.local/
Jul 30 20:13:02 POP3(nc-p@stpete.local): Info: mbox: data=/home/virtual/stpete.local/nc-p/mail
Jul 30 20:13:02 POP3(nc-p@stpete.local): Info: mbox: INBOX defaulted to /home/virtual/stpete.local/nc-p/mail/inbox
Jul 30 20:13:02 POP3(nc-p@stpete.local): Info: fs: root=/home/virtual/stpete.local/nc-p/mail, index=, control=, inbox=/home/virtual/stpete.local/nc-p/mail/inbox
Jul 30 20:13:02 POP3(nc-p@stpete.local): Info: Disconnected: Logged out top=0/0, retr=0/0, del=0/0, size=0


"Долгая аутентификация dovecot"
Отправлено Nc , 30-Июл-09 20:24 
>[оверквотинг удален]
>Jul 30 20:13:02 auth(default): Info: master in: REQUEST 12 23251 2
>Jul 30 20:13:02 auth(default): Info: passwd-file(nc-p@stpete.local,192.168.1.5): lookup: user=nc-p@stpete.local file=/etc/dovecot/v-users
>Jul 30 20:13:02 auth(default): Info: master out: USER 12 nc-p@stpete.local uid=5000 gid=5000
>home=/home/virtual/stpete.local/
>Jul 30 20:13:02 POP3(nc-p@stpete.local): Info: Effective uid=5000, gid=5000, home=/home/virtual/stpete.local/
>Jul 30 20:13:02 POP3(nc-p@stpete.local): Info: mbox: data=/home/virtual/stpete.local/nc-p/mail
>Jul 30 20:13:02 POP3(nc-p@stpete.local): Info: mbox: INBOX defaulted to /home/virtual/stpete.local/nc-p/mail/inbox
>Jul 30 20:13:02 POP3(nc-p@stpete.local): Info: fs: root=/home/virtual/stpete.local/nc-p/mail, index=, control=, inbox=/home/virtual/stpete.local/nc-p/mail/inbox
>Jul 30 20:13:02 POP3(nc-p@stpete.local): Info: Disconnected: Logged out top=0/0, retr=0/0, del=0/0, size=0
>

Проблему решил. Поменял в dovecot.conf mechanism на login, а было plain

auth default
mechanism = login (было plain).

Всем спасибо за помощь.