обновил постфикс - теперь стоит 2.2.8, система RH 3.0 Enterprice Server
в логах при отправке писем стали появляться надписи
timed out while sending message body
и письмо попадает в очередь и может там сидет на протяжении нескольких часов
попытка вытолкнуть письма из очереди postsuper -r ALL
приводит к тому, что в логах поялвяется read time out (port 25) и письмо все-равно не уходит
ладно вернул назад на postfix 2.0.16 с первоначальными рабочими конфигами и тот же результат
timed out while sending message body
теперь и для postfix 2.0.16
подскажите как исправить ситуацию?
Приводите полные записи логов. Какие письма и куда не уходят?
>Приводите полные записи логов. Какие письма и куда не уходят?
вот к примеру отправка писем за вчерашний день на mail.ru (заменены только адреса перед @mail.ru)отправка шла с версией 2.2.8
в 18-40 вернулся на версию 2.0.16
письма были с приатаченными файлами, и по-моему поведение письма не зависело особо от размера файла (может быть файлы с меньшим атачем быстрее уходили из очереди), а так письмо отправленное в 10 утра могло покинуть очередь в 17-00. Повторю раньше такого не было.Одновремено с отправкой на два адреса на mail.ru это же письмо уходило на два адреса на yandex.ru, и при этом на yandex.ru письма дошли сразу.
Такое же поведение как с отправкой на mail.ru было и с отправкой на другие (практически все служебные) домены.
Может быть это проявляется только при загруженных серверх/каналах, потому что сейчас с утра на версии 2.0.16 пока все нормально (письма с большими атачами в очередь попадают, но уходят от туда в течение минут 10-20 - а может и это ненормально?)
вот собственно выборка лога:Jan 12 16:37:35 relay postfix/pipe[22257]: 14A12440199: to=<o444@mail.ru>, relay=filter, delay=1, status=sent (dummy)
Jan 12 16:37:35 relay postfix/pipe[22257]: 14A12440199: to=<slon@mail.ru>, relay=filter, delay=1, status=sent (dummy)
Jan 12 16:40:41 relay postfix/smtp[22215]: 2D60344019D: to=<o444@mail.ru>, relay=mxs.mail.ru[194.67.23.20], delay=186, status=deferred (conversation with mxs.mail.ru[194.67.23.20] timed out while sending message body)
Jan 12 16:40:41 relay postfix/smtp[22215]: 2D60344019D: to=<slon@mail.ru>, relay=mxs.mail.ru[194.67.23.20], delay=186, status=deferred (conversation with mxs.mail.ru[194.67.23.20] timed out while sending message body)
Jan 12 16:42:30 relay postfix/smtp[22222]: E98D544019E: to=<o444@mail.ru>, relay=mxs.mail.ru[194.67.23.20], delay=226, status=deferred (lost connection with mxs.mail.ru[194.67.23.20] while sending message body)
Jan 12 16:42:30 relay postfix/smtp[22222]: E98D544019E: to=<slon@mail.ru>, relay=mxs.mail.ru[194.67.23.20], delay=226, status=deferred (lost connection with mxs.mail.ru[194.67.23.20] while sending message body)
Jan 12 17:15:42 relay postfix/smtp[25363]: 2D60344019D: to=<o444@mail.ru>, relay=none, delay=2287, status=deferred (connect to mxs.mail.ru[194.67.23.20]: read timeout)
Jan 12 17:15:42 relay postfix/smtp[25363]: 2D60344019D: to=<slon@mail.ru>, relay=none, delay=2287, status=deferred (connect to mxs.mail.ru[194.67.23.20]: read timeout)
Jan 12 17:15:45 relay postfix/smtp[25338]: E98D544019E: to=<o444@mail.ru>, relay=none, delay=2221, status=deferred (connect to mxs.mail.ru[194.67.23.20]: read timeout)
Jan 12 17:15:45 relay postfix/smtp[25338]: E98D544019E: to=<slon@mail.ru>, relay=none, delay=2221, status=deferred (connect to mxs.mail.ru[194.67.23.20]: read timeout)
Jan 12 17:51:55 relay postfix/smtp[29776]: 6B29E440199: to=<slon@mail.ru>, relay=mxs.mail.ru[194.67.23.20], delay=-114, status=deferred (host mxs.mail.ru[194.67.23.20] said: 421 SMTP command timeout. Closing connection (in reply to RCPT TO command))
Jan 12 17:51:55 relay postfix/smtp[29776]: 6B29E440199: to=<o444@mail.ru>, relay=mxs.mail.ru[194.67.23.20], delay=-114, status=deferred (lost connection with mxs.mail.ru[194.67.23.20] while sending DATA command)
Jan 12 17:57:03 relay postfix/smtp[30247]: BB90F4401A2: to=<o444@mail.ru>, relay=mxs.mail.ru[194.67.23.20], delay=-692, status=deferred (conversation with mxs.mail.ru[194.67.23.20] timed out while sending message body)
Jan 12 17:57:03 relay postfix/smtp[30247]: BB90F4401A2: to=<slon@mail.ru>, relay=mxs.mail.ru[194.67.23.20], delay=-692, status=deferred (conversation with mxs.mail.ru[194.67.23.20] timed out while sending message body)
Jan 12 17:58:52 relay postfix/smtp[30226]: AC0A84401A6: to=<o444@mail.ru>, relay=none, delay=451, status=deferred (connect to mxs.mail.ru[194.67.23.20]: read timeout)
Jan 12 17:58:52 relay postfix/smtp[30226]: AC0A84401A6: to=<slon@mail.ru>, relay=none, delay=451, status=deferred (connect to mxs.mail.ru[194.67.23.20]: read timeout)
Jan 12 18:03:53 relay postfix/smtp[30231]: 6F7A14401A1: to=<o444@mail.ru>, relay=none, delay=601, status=deferred (connect to mxs.mail.ru[194.67.23.20]: read timeout)
Jan 12 18:03:53 relay postfix/smtp[30231]: 6F7A14401A1: to=<slon@mail.ru>, relay=none, delay=601, status=deferred (connect to mxs.mail.ru[194.67.23.20]: read timeout
Jan 12 18:05:47 relay postfix/smtp[30232]: 7D89A44019E: to=<o444@mail.ru>, relay=none, delay=715, status=deferred (connect to mxs.mail.ru[194.67.23.20]: read timeout)
Jan 12 18:05:47 relay postfix/smtp[30232]: 7D89A44019E: to=<slon@mail.ru>, relay=none, delay=715, status=deferred (connect to mxs.mail.ru[194.67.23.20]: read timeout)
Jan 12 18:32:26 relay postfix/smtp[30282]: 6F7A14401A1: to=<o444@mail.ru>, relay=mxs.mail.ru[194.67.23.20], delay=2314, status=sent (250 OK id=1Ex4V9-000EZX-00)
Jan 12 18:32:26 relay postfix/smtp[30282]: 6F7A14401A1: to=<slon@mail.ru>, relay=mxs.mail.ru[194.67.23.20], delay=2314, status=sent (250 OK id=1Ex4V9-000EZX-00)в 18-040 вернулся на версию 2.0.16
Jan 12 18:56:08 relay postfix/smtp[5250]: 7D89A44019E: to=<o444@mail.ru>, relay=mxs.mail.ru[194.67.23.20], delay=3736, status=deferred (conversation with mxs.mail.ru[194.67.23.20] timed out while sending message body)
Jan 12 18:56:08 relay postfix/smtp[5250]: 7D89A44019E: to=<slon@mail.ru>, relay=mxs.mail.ru[194.67.23.20], delay=3736, status=deferred (conversation with mxs.mail.ru[194.67.23.20] timed out while sending message body)
Jan 12 19:21:02 relay postfix/smtp[6616]: 02C594FC1B3: to=<o444@mail.ru>, relay=mxs.mail.ru[194.67.23.20], delay=531, status=deferred (lost connection with mxs.mail.ru[194.67.23.20] while sending message body)
Jan 12 19:54:13 relay postfix/nqmgr[6601]: 02C594FC1B3: from=<user@domain.ru>, size=2819403, nrcpt=1 (queue active)
Jan 12 19:57:50 relay postfix/smtp[10787]: 02C594FC1B3: to=<o444@mail.ru>, relay=mxs.mail.ru[194.67.23.20], delay=2739, status=sent (250 OK id=1Ex5pj-0008Vf-00)
да еще забыл сказать сейчас поменял параметрыecho 0 >/proc/sys/net/ipv4/tcp_ecn ( и так было 0)
echo 1 > /proc/sys/net/ip_no_pmtu_disc (было 0)
как написано в ссылке
http://web.opennet.ru/tips/info/211.shtml
>http://web.opennet.ru/tips/info/211.shtml
Похоже это именно Ваш случай.