DigitalOcean Ubuntu16.04+Postfix+Dovecot+MySQL

EXIM, sendmail, postfix, Dovecot и прочие. Решение проблем связанных с работой электронной почты

Модератор: xM

Правила форума
Убедительная просьба юзать теги [code] при оформлении листингов.
Сообщения не оформленные должным образом имеют все шансы быть незамеченными.
hyperstan
проходил мимо
Сообщения: 1
Зарегистрирован: 2016-11-08 11:45:12

DigitalOcean Ubuntu16.04+Postfix+Dovecot+MySQL

Непрочитанное сообщение hyperstan » 2016-11-08 14:25:26

Всем доброго времени суток. Настраиваю почтовый сервер. Вылазили в логи разные ошибки и гугл помог с ними справиться, а с этой ничего поделать не могу. Настраивал по статье http://www.volmed.org.ru/wiki/index.php ... _14.04_LTSЯ новичок. Помогите пож-та. Заранее благодарен.
Юзера создавал так:

Код: Выделить всё

INSERT INTO users (user, email, password) VALUES ('test@test.com.ua', 'test@test.com.ua', ENCRYPT('123'));
Данные пользователя из таблицы users:
user-> test@test.com.ua
email->test@test.com.ua
password->2a3jG2Iz75uPs
содержимое dovecot-sql.conf

Код: Выделить всё

driver = mysql
connect = host=127.0.0.1 dbname=mail user=xxx password=xxx
default_pass_scheme = CRYPT
password_query = SELECT email AS user , password FROM users WHERE (user = '%u') or (email = '%u');
Понимаю, что логи говорят - проблема с паролем, но что не так... в sql запросе явного обращения за паролем нет.
Как бі посмотреть что передается в качестве %u. Если test@test.com.ua то результатом запроса должен получиться:
user-> test@test.com.ua
password->2a3jG2Iz75uPs
И дальше где-то SQL_password должен свериться с полученным от почтового клиента паролем.
содержимое dovecot.conf

Код: Выделить всё

disable_plaintext_auth = no
log_path = /var/log/dovecot.err
log_timestamp = "%Y-%m-%d %H:%M:%S "
ssl = yes
ssl_key =< /etc/dovecot/xxxxxxx.key
ssl_cert =< /etc/dovecot/xxxxxxx.cert
login_greeting = Dovecot ready.
mail_location = maildir:/var/spool/mail/%d/%n
mail_uid = 5000
mail_gid = 5000
mail_privileged_group = mail
valid_chroot_dirs = /var/spool/mail/
auth_verbose = yes
auth_debug = yes
auth_debug_passwords = yes
mail_debug = yes
auth_mechanisms = plain login digest-md5
passdb {
    driver = sql 
    args = /etc/dovecot/dovecot-sql.conf.ext
}
service auth {
               unix_listener auth-master {
               mode = 0660
               user = virtual
               group = virtual
               }
               unix_listener /var/spool/postfix/private/auth {
               mode = 0660
               user = postfix
               group = postfix
               }
}
service imap-login { 
    inet_listener imap { 
	port = 0
    }
    inet_listener imaps { 
	port = 993
	ssl = yes
    }
}
Логи:

Код: Выделить всё

Debug: Loading modules from directory: /usr/lib/dovecot/modules/auth
Debug: Module loaded: /usr/lib/dovecot/modules/auth/libdriver_mysql.so
Debug: Read auth token secret from /var/run/dovecot/auth-token-secret.dat
Debug: auth client connected (pid=9884)
Debug: client in: AUTH	1	PLAIN	service=imap	secured	session=enYkfsZA7ow+UL/G	lip=ххх.хх.ххх.хх	rip=ххх.хх.ххх.хх	lport=993	rport=36078	resp=AHRlc3RAdG9yeTNkLmNvbS51YQAxMjM= (previous base64 data may contain sensitive data)
auth-worker(9888): Debug: Loading modules from directory: /usr/lib/dovecot/modules/auth
auth-worker(9888): Debug: Module loaded: /usr/lib/dovecot/modules/auth/libdriver_mysql.so
auth-worker(9888): Debug: sql(test@test.com.ua,ххх.хх.ххх.хх): query: SELECT email AS user , password FROM users WHERE (user = 'test@test.com.ua') or (email = 'test@test.com.ua');
auth: Debug: client passdb out: OK	1	user=test@test.com.ua	
 auth: Debug: master in: REQUEST	2239627265	9884	1	f19199e931f68a770bebfc7fe8668892	session_pid=9889	request_auth_token
 auth-worker(9888): Debug: sql(test@test.com.ua,ххх.хх.ххх.хх): lookup
 auth-worker(9888): Info: sql(test@test.com.ua,ххх.хх.ххх.хх): unknown user
 auth: Error: passwd(test@test.com.ua,ххх.хх.ххх.хх,<enYkfsZA7ow+UL/G>): user not found from userdb
 auth: Debug: master userdb out: NOTFOUND	2239627265
 imap: Error: Authenticated user not found from userdb, auth lookup id=2239627265 (client-pid=9884 client-id=1)
 imap-login: Info: Internal login failure (pid=9884 id=1) (internal failure, 1 successful auths): user=<test@test.com.ua>, method=PLAIN, rip=ххх.хх.ххх.хх, lip=ххх.хх.ххх.хх, mpid=9889, TLS, session=<enYkfsZA7ow+UL/G>
 auth: Debug: auth client connected (pid=9890)
 auth: Debug: client in: AUTH	1	PLAIN	service=imap	secured	session=BYkyfsZA8Iw+UL/G	lip=ххх.хх.ххх.хх	rip=ххх.хх.ххх.хх	lport=993	rport=36080	resp=AHRlc3RAdG9yeTNkLmNvbS51YQAxMjM= (previous base64 data may contain sensitive data)
 auth-worker(9888): Debug: sql(test@test.com.ua,ххх.хх.ххх.хх): query: SELECT email AS user , password FROM users WHERE (user = 'test@test.com.ua') or (email = 'test@test.com.ua');
 auth: Debug: client passdb out: OK	1	user=test@test.com.ua	
 auth: Debug: master in: REQUEST	1848508417	9890	1	1225e5b43b808efa336459995c1dc3af	session_pid=9891	request_auth_token
 auth-worker(9888): Debug: sql(test@test.com.ua,ххх.хх.ххх.хх): lookup
 auth-worker(9888): Info: sql(test@test.com.ua,ххх.хх.ххх.хх): unknown user
 auth: Error: passwd(test@test.com.ua,ххх.хх.ххх.хх,<BYkyfsZA8Iw+UL/G>): user not found from userdb
 auth: Debug: master userdb out: NOTFOUND	1848508417
 imap: Error: Authenticated user not found from userdb, auth lookup id=1848508417 (client-pid=9890 client-id=1)
 imap-login: Info: Internal login failure (pid=9890 id=1) (internal failure, 1 successful auths): user=<test@test.com.ua>, method=PLAIN, rip=ххх.хх.ххх.хх, lip=ххх.хх.ххх.хх, mpid=9891, TLS, session=<BYkyfsZA8Iw+UL/G>
 auth: Debug: auth client connected (pid=9892)
 auth: Debug: client in: AUTH	1	PLAIN	service=imap	secured	session=TrSufsZA8ow+UL/G	lip=ххх.хх.ххх.хх	rip=ххх.хх.ххх.хх	lport=993	rport=36082	resp=AHRlc3RAdG9yeTNkLmNvbS51YQAxMjM= (previous base64 data may contain sensitive data)
 auth-worker(9888): Debug: sql(test@test.com.ua,ххх.хх.ххх.хх): query: SELECT email AS user , password FROM users WHERE (user = 'test@test.com.ua') or (email = 'test@test.com.ua');
 auth: Debug: client passdb out: OK	1	user=test@test.com.ua	
 auth: Debug: master in: REQUEST	2092826625	9892	1	501c6d06ac381e5b3688571bbcc7e8c2	session_pid=9893	request_auth_token
 auth-worker(9888): Debug: sql(test@test.com.ua,ххх.хх.ххх.хх): lookup
 auth-worker(9888): Info: sql(test@test.com.ua,ххх.хх.ххх.хх): unknown user
 auth: Error: passwd(test@test.com.ua,ххх.хх.ххх.хх,<TrSufsZA8ow+UL/G>): user not found from userdb
 auth: Debug: master userdb out: NOTFOUND	2092826625
 imap: Error: Authenticated user not found from userdb, auth lookup id=2092826625 (client-pid=9892 client-id=1)
 imap-login: Info: Internal login failure (pid=9892 id=1) (internal failure, 1 successful auths): user=<test@test.com.ua>, method=PLAIN, rip=ххх.хх.ххх.хх, lip=ххх.хх.ххх.хх, mpid=9893, TLS, session=<TrSufsZA8ow+UL/G>
Отправлено спустя 1 час 35 минут 13 секунд:
добавил в dovecot.conf

Код: Выделить всё

verbose_ssl=yes
auth_verbose_passwords=sha1
Попробовал получить почту почтовым клиентом (evolution) ввел пароль 123, а в логах нашел
auth-worker(12735): Debug: sql(test@test.com.ua,xxxxxxxxxxxx): CRYPT(2a3jG2Iz75uPs) != '2a3jG2Iz75uPs', try PLAIN scheme instead

Код: Выделить всё

2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x10, ret=1: before/accept initialization [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2001, ret=1: before/accept initialization [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:31 auth: Debug: Loading modules from directory: /usr/lib/dovecot/modules/auth
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2002, ret=-1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2002, ret=-1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:31 auth: Debug: Module loaded: /usr/lib/dovecot/modules/auth/libdriver_mysql.so
2016-11-08 11:12:31 auth: Debug: Read auth token secret from /var/run/dovecot/auth-token-secret.dat
2016-11-08 11:12:31 auth: Debug: auth client connected (pid=12730)
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2002, ret=-1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x20, ret=1: SSL negotiation finished successfully [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL: where=0x2002, ret=1: SSL negotiation finished successfully [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL alert: close notify [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Debug: SSL alert: close notify [xxxxxxxxxxxx]
2016-11-08 11:12:31 imap-login: Info: Disconnected (no auth attempts in 0 secs): user=<>, rip=xxxxxxxxxxxx, lip=xxxxxxxxxxxx, TLS, session=<38p1N8hA5pA+UL/G>
2016-11-08 11:12:50 auth: Debug: auth client connected (pid=12734)
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x10, ret=1: before/accept initialization [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2001, ret=1: before/accept initialization [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2002, ret=-1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2002, ret=-1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2002, ret=-1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2001, ret=1: unknown state [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x20, ret=1: SSL negotiation finished successfully [xxxxxxxxxxxx]
2016-11-08 11:12:50 imap-login: Debug: SSL: where=0x2002, ret=1: SSL negotiation finished successfully [xxxxxxxxxxxx]
2016-11-08 11:12:50 auth: Debug: client in: AUTH	1	PLAIN	service=imap	secured	session=aV6aOMhA6pA+UL/G	lip=xxxxxxxxxxxx	rip=xxxxxxxxxxxx	lport=993	rport=37098	resp=AHRlc3RAdG9yeTNkLmNvbS51YQAyYTNqRzJJejc1dVBz (previous base64 data may contain sensitive data)
2016-11-08 11:12:50 auth-worker(12735): Debug: Loading modules from directory: /usr/lib/dovecot/modules/auth
2016-11-08 11:12:50 auth-worker(12735): Debug: Module loaded: /usr/lib/dovecot/modules/auth/libdriver_mysql.so
2016-11-08 11:12:50 auth-worker(12735): Debug: sql(test@test.com.ua,xxxxxxxxxxxx): query: SELECT email AS user , password FROM users WHERE (user = 'test@test.com.ua') or (email = 'test@test.com.ua');
2016-11-08 11:12:50 auth-worker(12735): Info: sql(test@test.com.ua,xxxxxxxxxxxx): Password mismatch (SHA1 of given password: b815c117752e3737d24e02610985df1f2e34d68d)
2016-11-08 11:12:50 auth-worker(12735): Debug: sql(test@test.com.ua,xxxxxxxxxxxx): CRYPT(2a3jG2Iz75uPs) != '2a3jG2Iz75uPs', try PLAIN scheme instead
2016-11-08 11:12:50 auth-worker(12735): Debug: pam(test@test.com.ua,xxxxxxxxxxxx): lookup service=dovecot
2016-11-08 11:12:50 auth-worker(12735): Debug: pam(test@test.com.ua,xxxxxxxxxxxx): #1/1 style=1 msg=Password: 
2016-11-08 11:12:52 auth-worker(12735): Info: pam(test@test.com.ua,xxxxxxxxxxxx): pam_authenticate() failed: Authentication failure (password mismatch?) (given password: 2a3jG2Iz75uPs)
2016-11-08 11:12:54 auth: Debug: client passdb out: FAIL	1	user=test@test.com.ua
2016-11-08 11:12:59 auth: Debug: client in: AUTH	2	PLAIN	service=imap	secured	session=aV6aOMhA6pA+UL/G	lip=xxxxxxxxxxxx	rip=xxxxxxxxxxxx	lport=993	rport=37098	resp=AHRlc3RAdG9yeTNkLmNvbS51YQAxMjM= (previous base64 data may contain sensitive data)
2016-11-08 11:13:03 auth-worker(12735): Debug: sql(test@test.com.ua,xxxxxxxxxxxx): query: SELECT email AS user , password FROM users WHERE (user = 'test@test.com.ua') or (email = 'test@test.com.ua');
2016-11-08 11:13:03 auth: Debug: client passdb out: OK	2	user=test@test.com.ua	
2016-11-08 11:13:03 auth: Debug: master in: REQUEST	2421686273	12734	2	b500cc492556fe83eef5eaf878f4c8fb	session_pid=12736	request_auth_token
2016-11-08 11:13:03 auth-worker(12735): Debug: sql(test@test.com.ua,xxxxxxxxxxxx): lookup
2016-11-08 11:13:03 auth-worker(12735): Info: sql(test@test.com.ua,xxxxxxxxxxxx): unknown user 
2016-11-08 11:13:03 auth: Error: passwd(test@test.com.ua,xxxxxxxxxxxx,<aV6aOMhA6pA+UL/G>): user not found from userdb
2016-11-08 11:13:03 auth: Debug: master userdb out: NOTFOUND	2421686273
2016-11-08 11:13:03 imap: Error: Authenticated user not found from userdb, auth lookup id=2421686273 (client-pid=12734 client-id=2)
2016-11-08 11:13:03 imap-login: Info: Internal login failure (pid=12734 id=2) (internal failure, 1 successful auths): user=<test@test.com.ua>, method=PLAIN, rip=xxxxxxxxxxxx, lip=xxxxxxxxxxxx, mpid=12736, TLS, session=<aV6aOMhA6pA+UL/G>
2016-11-08 11:13:03 imap-login: Debug: SSL alert: close notify [xxxxxxxxxxxx]


Хостинговая компания Host-Food.ru
Хостинг HostFood.ru
 

Услуги хостинговой компании Host-Food.ru

Хостинг HostFood.ru

Тарифы на хостинг в России, от 12 рублей: https://www.host-food.ru/tariffs/hosting/
Тарифы на виртуальные сервера (VPS/VDS/KVM) в РФ, от 189 руб.: https://www.host-food.ru/tariffs/virtualny-server-vps/
Выделенные сервера, Россия, Москва, от 2000 рублей (HP Proliant G5, Intel Xeon E5430 (2.66GHz, Quad-Core, 12Mb), 8Gb RAM, 2x300Gb SAS HDD, P400i, 512Mb, BBU):
https://www.host-food.ru/tariffs/vydelennyi-server-ds/
Недорогие домены в популярных зонах: https://www.host-food.ru/domains/

Гость
проходил мимо

DigitalOcean Ubuntu16.04+Postfix+Dovecot+MySQL

Непрочитанное сообщение Гость » 2016-11-09 21:02:25

Тему можно закрывать. Почтовик поднял.