помогите с courier-imap pop3 сервером

[scorax]

Я новичок в этом деле... сильно не пинайте плизз!
Первый раз настраиваю сервер Postfix+Courier-IMAP+Cyrus-sasl2
В качестве pop3 сервера использую courier-imap Pop3d.
Фаервол отключен и не используется ( удаленно telnet(ом) могу cоединиться по 21, 22, 80...).
pop3 сервер настроен по статье: http://www.sys-adm.org.ua/mail/mail-howto-p1.php
далее...
обновил порты, установил все апдейты.

но есть проблемы с pop3, почтовым клиентом авторизоваться не могу.
Пытаюсь проверить что с pop3 сервером, для этого удаленно (с другого сервера в этой же сетке) пытаюсь соединиться telnet(ом) по 110, не получается.
К остальным подсоединться получается (например 21, 22, 80)!

Локально пытаюсь (либо на 127.. либо на адрес интерфеса), соединение по порту 110 telnet(ом) устанавливается и
на сколько я понимаю, pop3 сервер работает.

мой конфиг /courier-imap/pop3d
Код:

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

myhost# cat /usr/local/etc/courier-imap/pop3d | grep -v ^# | grep -v ^$
PIDFILE=/var/run/pop3d.pid
MAXDAEMONS=40
MAXPERIP=4
POP3AUTH="PLAIN LOGIN CRAM-MD5"
POP3AUTH_ORIG="PLAIN LOGIN CRAM-MD5"
POP3AUTH_TLS="PLAIN LOGIN CRAM-MD5"
POP3AUTH_TLS_ORIG="PLAIN LOGIN CRAM-MD5"
POP3_PROXY=0
PORT=110
ADDRESS=192.168.1.124
TCPDOPTS="-nodnslookup -noidentlookup"
LOGGEROPTS="-name=courier-imap"
POP3DSTART=YES
MAILDIRPATH=Maildir

Подскажите, как дальше и где искать проблему в pop3 сервере.
Профи пожалуйста, помогите новичку!

[Хостинг 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/

[Alex Keda]

сообщение нормально оформите

[scorax]

оформил.. на сколько хватает знаний.

[hizel]

локально, это

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

telnet 192.168.1.124 110

или

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

telnet 127.0.0.1 110

?

[scorax]

простите неправильно написал
попровил

[hizel]

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

sockstat | grep 110 

дайте пожалуйста

[scorax]

на

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

sockstat | grep 110

выдает:

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

root     couriertcp 937   3  tcp4   *:110                 *:*

[dikens3]

# cat /usr/local/etc/authlib/authdaemonrc | grep -v ^# | grep -v ^$
authmodulelist="authmysql"
authmodulelistorig="authmysql"
daemons=5
authdaemonvar=/var/run/authdaemond
subsystem=mail
DEBUG_LOGIN=2
DEFAULTOPTIONS="wbnodsn=1"
LOGGEROPTS=""

# cat /usr/local/etc/authlib/authmysqlrc | grep -v ^# | grep -v ^$
MYSQL_USERNAME postfix
MYSQL_PASSWORD postfix
MYSQL_SOCKET /tmp/mysql.sock
MYSQL_OPT 0
MYSQL_DATABASE postfix
MYSQL_CHARACTER_SET utf8
MYSQL_USER_TABLE mailbox
MYSQL_CLEAR_PWFIELD password
MYSQL_UID_FIELD '1981'
MYSQL_GID_FIELD '1981'
MYSQL_LOGIN_FIELD username
MYSQL_HOME_FIELD '/var/spool/mail'
MYSQL_NAME_FIELD name
MYSQL_MAILDIR_FIELD maildir
MYSQL_QUOTA_FIELD quota
MYSQL_WHERE_CLAUSE active='1'

Выделенная опция отвечает за логи, что в них?

[scorax]

конфиги authlib такие же, но был еще указан параметр MYSQL_SERVER localhost, его убрал!

/var/log/debug.log:

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

Jul 21 01:26:36 myhost sasldblistusers2: _sasl_plugin_load failed on sasl_auxprop_plug_init for plugin: sql
Jul 21 01:26:47 myhost saslpasswd2: _sasl_plugin_load failed on sasl_auxprop_plug_init for plugin: sql
Jul 21 01:26:47 myhost sasldblistusers2: _sasl_plugin_load failed on sasl_auxprop_plug_init for plugin: sql
Jul 21 01:26:47 myhost saslpasswd2: _sasl_plugin_load failed on sasl_auxprop_plug_init for plugin: sql

такие ошибки вываливались, вчера ночью . Их устранил!


А сейчас в debug.log отображается только удачный локальный вход по telnet(у) на 110 порт

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

Jul 21 10:38:12 myhost courier-imap: Connection, ip=[::ffff:192.168.1.124]
Jul 21 10:38:38 myhost courier-imap: Disconnected, ip=[::ffff:192.168.1.124]
Jul 21 11:10:48 myhost courier-imap: Connection, ip=[::ffff:192.168.1.124]
Jul 21 11:10:56 myhost courier-imap: Disconnected, ip=[::ffff:192.168.1.124]
Jul 22 01:02:17 myhost courier-imap: Connection, ip=[192.168.1.124]
Jul 22 01:02:24 myhost courier-imap: Disconnected, ip=[192.168.1.124]

[hizel]

такое ощуение что вы по IPv6 конектитись

[scorax]

да было дело.. но сейчас поддержку ipv6 убрал (в 2х последних строках debug.log уже нет )

[scorax]

А в maillog есть непонятные вещи, которых я пока непонимаю:

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

Jul 22 09:01:20 myhost postfix/qmgr[1374]: A3E9D5C07C: from=<>, size=4728, nrcpt=1 (queue active)
Jul 22 09:01:20 myhost postfix/qmgr[1374]: 173A75C032: from=<root@mydomain.ru>, size=5204, nrcpt=1 (queue active)
Jul 22 09:01:20 myhost postfix/qmgr[1374]: 402565C034: from=<root@mydomain.ru>, size=1358, nrcpt=1 (queue active)
Jul 22 09:01:20 myhost postfix/qmgr[1374]: 886225C071: from=<>, size=2896, nrcpt=1 (queue active)
Jul 22 09:01:50 myhost postfix/smtp[4206]: connect to postman.mydomain.ru[192.168.1.2]:25: Operation timed out
Jul 22 09:01:50 myhost postfix/smtp[4206]: A3E9D5C07C: to=<root@mydomain.ru>, relay=none, delay=21491, delays=21461/0.06/3
0/0, dsn=4.4.1, status=deferred (connect to postman.mydomain.ru[192.168.1.2]:25: Operation timed out)
Jul 22 09:01:50 myhost postfix/smtp[4207]: connect to postman.mydomain.ru[192.168.1.2]:25: Operation timed out
Jul 22 09:01:50 myhost postfix/smtp[4207]: 173A75C032: to=<root@mydomain.ru>, orig_to=<root>, relay=none, delay=21522, del
ays=21492/0.05/30/0, dsn=4.4.1, status=deferred (connect to postman.mydomain.ru[192.168.1.2]:25: Operation timed out)
Jul 22 09:01:50 myhost postfix/smtp[4208]: connect to postman.mydomain.ru[192.168.1.2]:25: Operation timed out
Jul 22 09:01:50 myhost postfix/smtp[4208]: 402565C034: to=<root@mydomain.ru>, orig_to=<root>, relay=none, delay=21522, del
ays=21492/0.06/30/0, dsn=4.4.1, status=deferred (connect to postman.mydomain.ru[192.168.1.2]:25: Operation timed out)
Jul 22 09:01:50 myhost postfix/smtp[4209]: connect to postman.mydomain.ru[192.168.1.2]:25: Operation timed out
Jul 22 09:01:50 myhost postfix/smtp[4209]: 886225C071: to=<root@mydomain.ru>, relay=none, delay=21491, delays=21461/0.08/3
0/0, dsn=4.4.1, status=deferred (connect to postman.mydomain.ru[192.168.1.2]:25: Operation timed out)
Jul 22 09:25:25 myhost courier-imap: LOGOUT, ip=[127.0.0.1]
myhost#

кто такой postman и где он прописан? зачем туда пытается отправить?
как убрать?

И попрежнему остался вопрос почему с удаленных машин (в той же сетке) не могу telnet(ом) подсоединиться к 110 (еще к 25 немогу), а к 21, 22, 80... могу?

[dikens3]

А сейчас в debug.log отображается только удачный локальный вход по telnet(у) на 110 порт

Если почтовым клиентом аутентифицироваться, тогда что в логах? (не обязательно в debug, ещё в auth и т.п. нужно посмотреть.)

[scorax]

в auth.log только удачные попытки авторизации по ssh2
при попытке забрать почту клиентом в maillog(е) ничего не появляется

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

Jul 22 11:22:50 myhost postfix/qmgr[917]: AEC805C073: removed
Jul 22 11:22:50 myhost postfix/cleanup[1100]: B6ADB5C074: message-id=<20080722072250.B6ADB5C074@myhost.mydomain.ru>
Jul 22 11:22:50 myhost postfix/bounce[1097]: 402565C034: sender non-delivery notification: B6ADB5C074
Jul 22 11:22:50 myhost postfix/qmgr[917]: B6ADB5C074: from=<>, size=3092, nrcpt=1 (queue active)
Jul 22 11:22:50 myhost postfix/qmgr[917]: 402565C034: removed
Jul 22 11:22:50 myhost postfix/virtual[1093]: B6ADB5C074: to=<root@mydomain.ru>, relay=virtual, delay=0.16, delays=0.15/0/
0/0, dsn=5.1.1, status=bounced (unknown user: "root@mydomain.ru")
Jul 22 11:22:50 myhost postfix/qmgr[917]: B6ADB5C074: removed
Jul 22 11:24:17 myhost authdaemond: stopping authdaemond children
Jul 22 11:24:17 myhost authdaemond: modules="authmysql", daemons=5
Jul 22 11:24:17 myhost authdaemond: Installing libauthmysql
Jul 22 11:24:17 myhost authdaemond: Installation complete: authmysql
Jul 22 11:24:17 myhost postfix/postfix-script[1213]: stopping the Postfix mail system
Jul 22 11:24:17 myhost postfix/master[912]: terminating on signal 15
Jul 22 11:24:18 myhost postfix/postfix-script[1268]: starting the Postfix mail system
Jul 22 11:24:18 myhost postfix/master[1269]: daemon started -- version 2.5.1, configuration /usr/local/etc/postfix

какие еще логи посмотреть?

[dikens3]

В выше-приведённом тобой логе нет попыток аутентификации, да и подключения вообще.

вот как выглядит debug

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

Jul 22 11:56:53 newmail pop3d: Connection, ip=[192.168.2.4]
Jul 22 11:56:53 newmail authdaemond: received auth request, service=pop3, authtype=login
Jul 22 11:56:53 newmail authdaemond: authmysql: trying this module
Jul 22 11:56:53 newmail authdaemond: SQL query: SELECT username, "", password, 26, 6, '/mnt/mail/', maildir, `quota-max`, comment, "" FROM users WHERE username = "dik" AND (active = 'Y')
Jul 22 11:56:53 newmail authdaemond: authmysql: sysusername=<null>, sysuserid=26, sysgroupid=6, homedir=/mnt/mail/, address=dik, fullname=Судариков Дмитрий, maildir=mydomain.ru/dik/, quota=200, options=<null>
Jul 22 11:56:53 newmail authdaemond: authmysql: clearpasswd=Мой_Пароль, passwd=<null>

1. Подключение с IP-Адреса 192.168.2.4 к сервису pop3d
2. authdaemond сообщает, что запрошена аутентификация методом login
3. authdaemond пробует аутентифицировать клиента с помощью модуля mysql.
4. Собственно сам запрос к mysql.
5. То что вернул запрос (при нормальной аутентификации. т.е. если пользователь есть в базе).
6. authdaemond показывает под каким паролем произошла аутентификация клиента.

Всё.

[scorax]

с Вами полность согласен. Но у меня мало знаний в этом деле поэтому я обратился за помощью.
Все что у меня есть это статья по каторой я пытаюсь учиться.
Задача реальная создать почтовый сервер для фирмы .
В rc.conf у меня присутствуют следующие строки:

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

courier_authdaemond_enable="YES"
courier_imap_pop3d_enable="YES"
postfix_enable="YES"

в процессах "" слудующие:

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

myhost# ps -aux | grep auth 
root      853  0,0  0,5  2004  1268 con- I    12:06     0:00,01 /usr/local/libexec/courier-authlib/authdaemond
root      859  0,0  0,5  2004  1268 con- I    12:06     0:00,00 /usr/local/libexec/courier-authlib/authdaemond
root      860  0,0  0,5  2004  1268 con- I    12:06     0:00,00 /usr/local/libexec/courier-authlib/authdaemond
root      861  0,0  0,5  2004  1268 con- I    12:06     0:00,00 /usr/local/libexec/courier-authlib/authdaemond
root      862  0,0  0,5  2004  1268 con- I    12:06     0:00,00 /usr/local/libexec/courier-authlib/authdaemond
root      863  0,0  0,5  2004  1268 con- I    12:06     0:00,00 /usr/local/libexec/courier-authlib/authdaemond
root     2095  0,0  0,2   604   484  p1  R+   15:33     0:00,00 grep auth 

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

myhost# ps -aux | grep courier
root      852  0,0  0,3  1272   772 con- I    12:06     0:00,00 /usr/local/sbin/courierlogger -facility=mail -pid=/var/
root      853  0,0  0,5  2004  1268 con- I    12:06     0:00,01 /usr/local/libexec/courier-authlib/authdaemond
root      859  0,0  0,5  2004  1268 con- I    12:06     0:00,00 /usr/local/libexec/courier-authlib/authdaemond
root      860  0,0  0,5  2004  1268 con- I    12:06     0:00,00 /usr/local/libexec/courier-authlib/authdaemond
root      861  0,0  0,5  2004  1268 con- I    12:06     0:00,00 /usr/local/libexec/courier-authlib/authdaemond
root      862  0,0  0,5  2004  1268 con- I    12:06     0:00,00 /usr/local/libexec/courier-authlib/authdaemond
root      863  0,0  0,5  2004  1268 con- I    12:06     0:00,00 /usr/local/libexec/courier-authlib/authdaemond
root      936  0,0  0,3  1268   720 con- I    12:06     0:00,00 [courierlogger]
root      937  0,0  0,3  1324   884 con- I    12:06     0:00,01 /usr/local/libexec/courier-imap/couriertcpd -address=0
root     2110  0,0  0,4  1604  1092  p1  S+   15:35     0:00,00 grep courier

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

myhost# ps -aux | grep postfix
root      912  0,0  0,9  3724  2392  ??  Ss   12:06     0:00,09 /usr/local/libexec/postfix/master
postfix   916  0,0  1,0  3788  2488  ??  S    12:06     0:00,09 qmgr -l -t fifo -u
postfix  2036  0,0  1,0  3740  2600  ??  S    15:26     0:00,02 pickup -l -t fifo -u
root     2117  0,0  0,4  1548   988  p1  R+   15:36     0:00,00 grep postfix

В какой цепи поломка я не знаю, помогите пожалуйста разобраться.

[dikens3]

Процессы у тебя запущены. Поломку искать нужно в логах. Там все ответы.

[scorax]

В каких логах? Вроде все логи выложил, ничего не нашел.

[dikens3]

1. Выставляешь уровень детализации необходимых сервисов на максимум.
2. Запускаешь эти (необходимые) сервисы.
3. Выполняешь то, что якобы не работает.
4. Смотри логи и думаешь.

P.S. Если логи не пишутся, то не пишутся совсем, тогда решаешь сначала проблему с созданием логов вообще. (скорее всего это не твой случай)

auth.log
debug.log
messages
maillog
и т.д.

[scorax]

выходит это мой случай, логи есть, но не от того что нужно, а процессы запущены.
для меня сложно пока понять в чем проблема.

одним словом, где искать проблему , устронив которую можно будет наблюдать в debug.log логи, подобно вашим:

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

Jul 22 11:56:53 newmail pop3d: Connection, ip=[192.168.2.4]
Jul 22 11:56:53 newmail authdaemond: received auth request, service=pop3, authtype=login
Jul 22 11:56:53 newmail authdaemond: authmysql: trying this module
Jul 22 11:56:53 newmail authdaemond: SQL query: SELECT username, "", password, 26, 6, '/mnt/mail/', maildir, `quota-max`, comment, "" FROM users WHERE username = "dik" AND (active = 'Y')
Jul 22 11:56:53 newmail authdaemond: authmysql: sysusername=<null>, sysuserid=26, sysgroupid=6, homedir=/mnt/mail/, address=dik, fullname=Судариков Дмитрий, maildir=mydomain.ru/dik/, quota=200, options=<null>
Jul 22 11:56:53 newmail authdaemond: authmysql: clearpasswd=Мой_Пароль, passwd=<null>

[neyro]

А пакетный фильтр (фаервол) случаем не блокирует коннекты ? Очень похоже, если с локальной машины коннекты проходят...

[scorax]

я написал в верхнем посте:
на 21, 22, 80 и т.д. пускает. (фаервол отключен в rc.conf)
Проблема, как выяснилось в другом, службы запущены, но в логи (например debug.log) никаких ошибок не выводят, другая инфа в логах появляется, но нет pop3, authlibdeamond как в примере в посте выше).
Следовательно, либо проблема с выводом логов (но остальные логи пишутся debug,maillog), либо службы (authlibdeamond, courier-imap), как минимум работают с ошибками.
Сами службы как мог проверил, конфиги еще раз пересмотрел, службы запускаются и активны в списке процессов есть.

На это мои знания ограничеваются подскажите как дальше анализировать , очень нуждаюсь в Вашей помощи друзья!

[scorax]

всем спасибо, а neyro в отдельности , я тупанул
в rc.conf в самом низу был ВТОРОЙ раз прописан ipfw , включен фаервол!

все конец моим мучениям