Регистрация...

Eserv Forum / E3 / Eserv 3 Mail Server Support / Ошибка в POP3RECV

imported // (v1)
Продукты и услуги Скачать Документация Купить Поддержка Форумы Партнёрам Статьи О компании
Новости
12.10.2009
Переезд завершен
Добрый день !

Установлен EServ 3.30 + PigMail 1.30.
Последние дни при приёме почты из внешнего ящика при помощи POP3RECV регистрируется ошибка.

POP3RECVErr.log
15:14:16 73 Error 87 while polling mailbox mailbox@domain:110


POP3RECV.log
15:14:11 73 Connecting to: 62.85.104.4:110 15:14:15 73 Reply from server: +OK Lotus Notes POP3 server version X2.0 ready. 15:14:15 73 Connected 15:14:15 73 Command to server: USER mailbox 15:14:15 73 Reply from server: +OK mailbox, your papers please. 15:14:15 73 Command to server: PASS password 15:14:15 73 Reply from server: +OK mailbox has 4 messages. 15:14:15 73 Command to server: STAT 15:14:15 73 Reply from server: +OK 4 4096 15:14:15 73 Command to server: LIST 15:14:15 73 Reply from server: +OK 4 messages. 15:14:15 73 Command to server: TOP 4 0 15:14:15 73 Reply from server: +OK 15:14:15 73 Checking sender: <sender@domain> 15:14:15 73 Accepted 15:14:15 73 Checking recipient: <user@mydomain> 15:14:15 73 Local domain user, accepted 15:14:15 73 Command to server: RETR 4 15:14:15 73 Reply from server: +OK 5988 octets 15:14:15 73 Message has been received completely, 5987 bytes size 15:14:16 73 Local user: user@mydomain, copied to archive folder: ..\DATA\mail\archive\2007-05\user\in 15:14:16 73 Delivered to local user: user@mydomain 15:14:16 73 Command to server: DELE 4 15:14:16 73 Reply from server: +OK Message 4 deleted. 15:14:16 73 Command to server: TOP 3 0 15:14:16 73 Reply from server: +OK 15:14:16 73 Checking sender: <sender@domain> 15:14:16 73 Accepted 15:14:16 73 Checking recipient: <user@mydomain> 15:14:16 73 Local domain user, accepted 15:14:16 73 Command to server: RETR 3 15:14:16 73 Reply from server: +OK 3505 octets 15:14:16 73 Receiving aborted at offset 0 with error code 87 15:14:16 73 STAT: 7673:86:168:571:547


Это задание работает без изменений второй год уже. И начались неожиданно ошибки. Перезагрузка сервиса и сервера не помогла.
Сегодня 22 раза была ошибка и только 8 раз удачно принята почта.
 
Комментарии к этой версии (07.05.2007 15:54) [~ND] ee11e5c9
АвторДатаТекстtags
ND08.05.2007 08:42
Сделал для проверки маппинг на почтовый сервер. Приём почты работает нормально.
Значит почтовый сервер, откуда почта забирается работает исправно.
imported
ac08.05.2007 19:23
А pop2smtp (из базового конфига) сработает?
imported
ND10.05.2007 14:17
Попробовал через pop2smtp — принимается всё. Но не получается сделать, чтобы почта принятая из почтового ящика складывалась в определённый локальный ящик — уходит наружу.

С Pop3Recv — проблемы всё те же
imported
ac10.05.2007 15:42
ND пишет: Попробовал через pop2smtp — принимается всё. Но не получается сделать, чтобы почта принятая из почтового ящика складывалась в определённый локальный ящик — уходит наружу.

Нужно в поле SMTPSERVER указывать внешний сетевой интерфейс своего Eserv'а, чтобы почта от pop2smtp считалась не исходящей, а входящей.
imported
ND11.05.2007 14:04
поле SMTPSERVER указывать внешний сетевой интерфейс своего Eserv

Указывал — получателем почты указан несуществующий у нас пользователь username@domain1, а надо чтобы вся эта почта попадала к нашему пользователю username@domain2. И вся почта уходит наружу в домен domain1.

В логах pop2recv :
13:52:52 77 Connecting to: server-IP:110
13:52:52 77 Reply from server: +OK Lotus Notes POP3 server version X2.0 ready.
13:52:52 77 Connected
13:52:52 77 Command to server: USER username
13:52:52 77 Reply from server: +OK username, your papers please.
13:52:52 77 STAT: 98:13:0:0:16

после перезапуска сервиса пару раз нормально запустится, а затем в логах это.
imported
ac11.05.2007 16:20
ND пишет:
поле SMTPSERVER указывать внешний сетевой интерфейс своего Eserv

Указывал — получателем почты указан несуществующий у нас пользователь username@domain1, а надо чтобы вся эта почта попадала к нашему пользователю username@domain2. И вся почта уходит наружу в домен domain1.


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

Лог вы привели не от pop2smtp, а от pop3recv, который я без Игоря не берусь обсуждать.
imported
ND24.05.2007 14:41
Вот, и pig появился
Что скажет он про POP3RECV ?
imported
pig24.05.2007 15:02
Пока вот это:
[Pop3Recv]
Debug=1

Перезапустите сервис. Когда появится ошибка, покажите, чем кончается отладочный лог (POP3RECVDbg.log) для соответствующего потока. То есть, прочиталось ли реально что-нибудь из того письма — или ошибка 87 происходит при чтении первой же строки.

Как вариант обхода можно попробовать читать письма из ящика по одному (поставить единицу в поле MAX_MSGNUM списка Boxes). По крайней мере, не будет повторяться чтение успешно принятого.
imported
ND24.05.2007 15:28
В режиме отладки работает с 7 мая.
Вот вчерашний лог, было 8 писем в ящике — 8,7,6 письма принял, и затем вот это:
08:21:03 3 Debug dump: +OK Message 6 deleted. 08:21:03 3 Debug dump: +OK 08:21:03 3 Debug dump: Received: from xxxxxxxxxxxxxx ([xxxxx]) 08:21:03 3 Debug dump: by xxxxx (Lotus Domino Release 6.5.5FP2) 08:21:03 3 Debug dump: with SMTP id 2007052217454499-18985 ; 08:21:03 3 Debug dump: Tue, 22 May 2007 17:45:44 +0300 08:21:03 3 Debug dump: From: xxxxx@xxxxx 08:21:03 3 Debug dump: Message-ID: <1179855944@xxxxxxxxxxxx> 08:21:03 3 Debug dump: Date: Tue, 22 May 2007 17:45:43 +0300 08:21:03 3 Debug dump: Subject: hbank,client 08:21:03 3 Debug dump: To: xxxxx@xxxxxx 08:21:03 3 Debug dump: MIME-Version: 1.0 08:21:03 3 Debug dump: X-MIMETrack: Itemize by SMTP Server on xxxxxxxxxx(Release 6.5.5FP2|October 23, 2006) at 08:21:03 3 Debug dump: 22.05.2007 05:45:45 PM, 08:21:03 3 Debug dump: Serialize by POP3 Server on xxxxxxxxxx(Release 6.5.5FP2|October 23, 2006) at 08:21:03 3 Debug dump: 23.05.2007 08:20:36 AM 08:21:03 3 Debug dump: Content-Transfer-Encoding: 7bit 08:21:03 3 Debug dump: Content-Type: multipart/mixed; boundary="11798559445E00630A==" 08:21:03 3 Debug dump: 08:21:03 3 Debug dump: . 08:21:03 3 Debug dump: +OK 7182 octets 08:50:59 16 Debug dump: +OK Lotus Notes POP3 server version X2.0 ready on xxxxxxxxx. 08:50:59 16 Debug dump: +OK 421305, your papers please. 09:20:56 31 Debug dump: +OK Lotus Notes POP3 server version X2.0 ready on xxxxxxxxx. 09:20:56 31 Debug dump: +OK 421305, your papers please.

И всё, до перезапуска сервиса только так и будут в логах повторяться 2 строчки.
Сейчас перезапустил, в ящике пока ничего нет — свежих логов показать не могу.
imported
ND24.05.2007 15:33
Даже без почты в почтовом ящике:
POP3RECV.log
15:20:48 3 Connecting to: xxxxxx:110 15:20:48 3 Reply from server: +OK Lotus Notes POP3 server version X2.0 ready on xxxxxxxx. 15:20:48 3 Connected 15:20:48 3 Command to server: USER xxxxxx 15:20:48 3 Reply from server: +OK xxxxxx, your papers please. 15:20:48 3 Command to server: PASS xxxxxx 15:20:48 3 Reply from server: +OK xxxxxx has 0 messages. 15:20:48 3 Command to server: STAT 15:20:48 3 Reply from server: +OK 0 0 15:20:48 3 Command to server: QUIT 15:20:48 3 Reply from server: +OK Lotus Notes POP3 server signing off. 15:20:48 3 STAT: 177:44:0:0:78 15:25:48 5 Connecting to: xxxxxx:110 15:25:48 5 Reply from server: +OK Lotus Notes POP3 server version X2.0 ready on xxxxxx. 15:25:48 5 Connected 15:25:48 5 Command to server: USER xxxxxx 15:25:48 5 Reply from server: +OK xxxxxx, your papers please. 15:25:48 5 Command to server: PASS xxxxxx 15:25:48 5 Reply from server: +OK xxxxxx has 0 messages. 15:25:48 5 Command to server: STAT 15:25:48 5 Reply from server: +OK 0 0 15:25:48 5 Command to server: QUIT 15:25:48 5 Reply from server: +OK Lotus Notes POP3 server signing off. 15:25:48 5 STAT: 177:44:0:0:63 15:30:47 10 Connecting to: xxxxxx:110 15:30:47 10 Reply from server: +OK Lotus Notes POP3 server version X2.0 ready on xxxxxx. 15:30:47 10 Connected 15:30:47 10 Command to server: USER xxxxxx 15:30:48 10 Reply from server: +OK xxxxxx, your papers please. 15:30:48 10 STAT: 98:13:0:0:15

POP3RECVDbg.log
15:20:48 3 Debug dump: +OK Lotus Notes POP3 server version X2.0 ready on xxxxxx. 15:20:48 3 Debug dump: +OK xxxxxx, your papers please. 15:20:48 3 Debug dump: +OK xxxxxx has 0 messages. 15:20:48 3 Debug dump: +OK 0 0 15:20:48 3 Debug dump: +OK Lotus Notes POP3 server signing off. 15:25:48 5 Debug dump: +OK Lotus Notes POP3 server version X2.0 ready on xxxxxx. 15:25:48 5 Debug dump: +OK xxxxxx, your papers please. 15:25:48 5 Debug dump: +OK xxxxxx has 0 messages. 15:25:48 5 Debug dump: +OK 0 0 15:25:48 5 Debug dump: +OK Lotus Notes POP3 server signing off. 15:30:47 10 Debug dump: +OK Lotus Notes POP3 server version X2.0 ready on xxxxxx. 15:30:47 10 Debug dump: +OK xxxxxx, your papers please.

POP3RECVErr.log
15:30:48 10 Error 87 while polling mailbox xxxxxx@xxxxxx:110
imported
pig24.05.2007 19:07
Вот чума! Там же нечему ломаться между USER и PASS. Только если чему-то глубинному — в строковой библиотеке, например...
imported
ND29.05.2007 08:14
Так что делать ?
Уже почти месяц вручную почту разбираю из внешнего ящика
imported
pig29.05.2007 10:09
Я боюсь, что это всё-таки к Андрею. И сам код ошибки загадочный (что за Invalid parameter?), и место: одна команда передана, ответ получен, должна сформироваться строка второй команды, а вместо этого вылезает ошибка
Самое смешное, что код подключения к ящику у меня практически один в один содран из pop2smtp.
imported
ND29.05.2007 12:50
Как раз POP2SMTP с этим почтовым ящиком нормально работает (пробовал недавно), только не могу его заставить расскладывать почту как мне необходимо.
imported
ac29.05.2007 18:54
Попробуйте с этим acSMTP: http://www.eserv.ru/download/acSMTP-no.rar (отключена оптимизация в строчной библиотеке).

POP2SMTP ведь не раскладывает почту. Он только доставляет её по SMTP, как будто она своим ходом пришла. А раскладку нужно делать средствами маршрутизации SMTP, как и для всей остальной (не из pop3-ящиков) почты.
imported
ND30.05.2007 11:19
После замены acSMTP ситуация особенно не изменилась. Всё также при первых запусках принимаются несколько писем. И в дальнейшем:

POP3RECV.Log
09:19:56 10 Connecting to: xxxxxx:110 09:19:56 10 Reply from server: +OK Lotus Notes POP3 server version X2.0 ready. 09:19:56 10 Connected 09:19:56 10 Command to server: USER xxxxxx 09:19:56 10 Reply from server: +OK xxxxxx, your papers please. 09:19:56 10 Command to server: PASS xxxxxx 09:19:56 10 Reply from server: +OK xxxxxx has 2 messages. 09:19:56 10 STAT: 126:32:0:0:172 09:49:51 17 Connecting to: xxxxxx:110 09:49:52 17 Reply from server: +OK Lotus Notes POP3 server version X2.0 ready. 09:49:52 17 Connected 09:49:52 17 Command to server: USER xxxxxx 09:49:52 17 Reply from server: +OK xxxxxx, your papers please. 09:49:52 17 Command to server: PASS xxxxxx 09:49:52 17 Reply from server: +OK xxxxxx has 0 messages. 09:49:52 17 STAT: 126:32:0:0:203 10:19:49 21 Connecting to: xxxxxx:110 10:19:49 21 Reply from server: +OK Lotus Notes POP3 server version X2.0 ready. 10:19:49 21 Connected 10:19:49 21 Command to server: USER xxxxxx 10:19:49 21 Reply from server: +OK xxxxxx, your papers please. 10:19:49 21 Command to server: PASS xxxxxx 10:19:49 21 Reply from server: +OK xxxxxx has 2 messages. 10:19:49 21 STAT: 126:32:0:0:125 10:49:46 25 Connecting to: xxxxxx:110 10:49:46 25 Reply from server: +OK Lotus Notes POP3 server version X2.0 ready. 10:49:46 25 Connected 10:49:46 25 Command to server: USER xxxxxx 10:49:46 25 Reply from server: +OK xxxxxx, your papers please. 10:49:46 25 Command to server: PASS xxxxxx 10:49:47 25 Reply from server: +OK xxxxxx has 0 messages. 10:49:47 25 STAT: 126:32:0:0:172

POP3RECVDbg.Log
09:19:56 10 Debug dump: +OK Lotus Notes POP3 server version X2.0 ready. 09:19:56 10 Debug dump: +OK xxxxxx, your papers please. 09:19:56 10 Debug dump: +OK xxxxxx has 2 messages. 09:49:51 17 Debug dump: +OK Lotus Notes POP3 server version X2.0 ready. 09:49:52 17 Debug dump: +OK xxxxxx, your papers please. 09:49:52 17 Debug dump: +OK xxxxxx has 0 messages. 10:19:49 21 Debug dump: +OK Lotus Notes POP3 server version X2.0 ready. 10:19:49 21 Debug dump: +OK xxxxxx, your papers please. 10:19:49 21 Debug dump: +OK xxxxxx has 2 messages. 10:49:46 25 Debug dump: +OK Lotus Notes POP3 server version X2.0 ready. 10:49:46 25 Debug dump: +OK xxxxxx, your papers please. 10:49:46 25 Debug dump: +OK xxxxxx has 0 messages.

POP3RECVErr.Log
09:19:56 10 Error 87 while polling mailbox xxxxxx@xxxxxx:110 09:49:52 17 Error 87 while polling mailbox xxxxxx@xxxxxx:110 10:19:49 21 Error 87 while polling mailbox xxxxxx@xxxxxx:110 10:49:47 25 Error 87 while polling mailbox xxxxxx@xxxxxx:110
imported
pig30.05.2007 12:03
Значит, не оно. А что сейчас из расширений включено? Антиспам какой?
У меня есть смутное подозрение на сторонние расширения, оформленные в виде DLL. Не исключено, что портится что-то в коде или глобальных данных, поскольку ошибка залипает.
imported
ND30.05.2007 12:38
Из расширений включено:
  • списки рассылки
  • автоответчики
  • волшебные слова
  • PopFile
  • KAV
Вроде всё.
imported
pig30.05.2007 14:43
И вроде всё "родное". А в SMTP-сессиях подобных ошибок не светится?

В конец acSMTP\myconf\OnStartup.rules.txt добавьте строку:
UNUSED . CR

Перезапустите acSMTP и процитируйте число, которое он напишет в acSMTP.log.
imported
ND30.05.2007 14:50
Прописал строчку в нужный файл. Теперь он имеет вид:
GetDNS DROP \ DnsDebug ON \ vDebugRules ON EvalRules: OnStartupPlugins MaxThreads: {SMTP[MaxConnections]} ExternIP: {Server[ExternIP]} Listen: {SMTP[Port]} {SMTP[NetworkInterface]} {SMTP[SslPort]} {SMTP[SslNetworkInterface]} UNUSED . CR


Но в логе acSMTP.log никаких чисел не появилось
imported
ND30.05.2007 14:59
Надо было добавить:
UNUSED . CR


Число -5905
imported
pig30.05.2007 17:47
А вот такая строка что выведет?
IMAGE-SIZE HERE IMAGE-BASE - - . CR
imported
pig30.05.2007 18:20
Всё! Не надо ничего искать. Моя вина
Дооптимизировался... Сейчас будет фикс.

http://www.eserv.ru/download/PigMailPigProxy.1.30.fix.20070530.zip

  • исправлены последствия скороспелой оптимизации, проявлявшиеся в виде Error 87
  • перед обработкой каждого письма сбрасывается счётчик ошибок формата
  • добавлена пропущенная инициализация плагинов в ситуации, когда не удалось определить отправителя и разрешено использование пустого адреса отправителя
imported
ND31.05.2007 08:11
Всё работает
imported
Работает на Eserv/5.05567 (10.02.2020)