* Ошибка PopFile - [Eserv Forum]

В SPOOL зависло письмо, которое никому не дошло, хотя по журналу 2010-11-19-log.txt вроде бы обработалось нормально, за исключением ошибки PopFile.
201011delivery.txt:

2010-11-19 12:02:34;194.186.47.92;@;26057;4032;aori@co.ru;*@*.*.ru;ExDelivery:Local;47141;<redirect-364351714@backend1.cgp.gldn.net>;popfile_error

acFilter.log :

19.11.2010;12:00:14;1576;0;1;200;POST;302;IFORTH-SCRIPT;/RPC2;c:\Program Files\E4\CommonPlugins\acFilter\apps\index.e;text/xml c:\Program Files\E4\DATA\mail\spool\aori@co.ru!26057!3119616125!1.eml @D1=2 c:\Program Files\E4\DATA\mail\spool\aori@co.ru!26057!3119616125!1.eml drweb:PF:iup=10060 iup2=10060 <Error 10060> c:\Program Files\E4\DATA\mail\spool\aori@co.ru!26057!3119616125!1.eml 1 10000 10000 PF=popfile_error

acSMTP.log:

Signature domain don't match. Can't add message into index. ERR=2 ..\DATA\mail\arc4\201011\2010-11-19\popfile_error\co.ru\aori@co.ru!26057!3119616125!1.eml Can't add message into index. ERR=2 ..\DATA\mail\arc4\201011\2010-11-19\popfile_error\co.ru\aori@co.ru!26057!3119616125!1.eml Signature domain don't match.

Такой папки .\DATA\mail\arc4\201011\2010-11-19\popfile_error\ — не существует

2010-11-19 11:59:42;194.186.47.92;@;26057;4032;IN;MAIL FROM:<aori@co.ru> SIZE=48267 2010-11-19 11:59:43;194.186.47.92;@;26057;4032;OUT;250 aori@co.ru OK 2010-11-19 11:59:43;194.186.47.92;@;26057;4032;IN;RCPT TO:<*@*.*.ru> 2010-11-19 12:00:15;194.186.47.92;@;26057;4032;OUT;250 *@*.*.ru OK, ExDelivery:Local, a=L 2010-11-19 12:00:15;194.186.47.92;@;26057;4032;IN;DATA 2010-11-19 12:00:15;194.186.47.92;@;26057;4032;SPOOL;..\DATA\mail\spool\aori@co.ru!26057!3119616125!1.eml 2010-11-19 12:00:15;194.186.47.92;@;26057;4032;OUT;354 send the mail data, end with . 2010-11-19 12:02:34;194.186.47.92;@;26057;4032;OUT;250 OK message accepted for delivery (ExDelivery:Local) 2010-11-19 12:02:34;194.186.47.92;@;26057;4032;ARCHIVE;aori@co.ru;**@*.*.ru;ExDelivery:Archive 2010-11-19 12:02:34;194.186.47.92;@;26057;4032;DELIVERY;*@*.*.ru;ExDelivery:Local 2010-11-19 12:02:34;194.186.47.92;@;26057;4032;IN;QUIT 2010-11-19 12:02:35;194.186.47.92;@;26057;4032;OUT;221 Goodbye.

Мне не понравилось, что не было никаких извещений об ошибке. Письмо обнаружила только потому, что теперь регулярно просматриваю все эти папки (SPOOL, OUT, Retry...) на предмет проблем.

Автор

Дата

Текст

tags

matveeva

22.11.2010 11:23

Вот сегодня еще одна ошибка popFile, но письмо доставилось нормально.
Появилась папка \DATA\mail\arc4\201011\2010-11-22\popfile_error\, а в журнале PopFile вот такие записи

2010/11/22 10:17:05 2592: Perl warning: binmode() on closed filehandle MSG at /Progra~1/POPFile/Classifier/MailParse.pm line 1700.[0a] 2010/11/22 10:17:05 2592: Perl warning: readline() on closed filehandle MSG at /Progra~1/POPFile/Classifier/MailParse.pm line 1705.[0a]

Вот 201011popfile_debug.txt

2010-11-22 10:14:05;**@*.ru;***@**.**.ru;0;;81.95.135.2;SMTP;81.95.135.2 2010-11-22 10:14:05;r.**@**.ru;***@**.**.ru;0;;81.95.135.2;SMTP;<?xml version='1.0' encoding='UTF-8'?><methodResponse><params><param><value><string>250</string></value></param></params></methodResponse> 2010-11-22 10:14:17;**@seve***.ru;**@**.co**ru;226845;<94d3819fc8d5844f9ff8e16538f79b50@mail.**.ru>;81.95.135.2;SMTP;c:\Program Files\E4\DATA\mail\spool\**@**.ru!30434!3372457484!1.eml 2010-11-22 10:14:18;;;0;;127.0.0.1;HTTP;c:\Program Files\E4\DATA\mail\spool\**@**.ru!30434!3372457484!1.eml 2010-11-22 10:16:38;;;0;;127.0.0.1;HTTP;<Error 10060> 2010-11-22 10:16:47;**@**.ru;***@**.*.ru;226845;<94d3819fc8d5844f9ff8e16538f79b50@mail.**.ru>;81.95.135.2;SMTP;<?xml version='1.0' encoding='UTF-8'?><methodResponse><params><param><value><string>popfile_error</string></value></param><param><value><string>PF=popfile_error, SPR=10000</string></value></param></params></methodResponse>

wikipost

22.11.2010 22:29

matveeva пишет: ..\DATA\mail\arc4\201011\2010-11-19\popfile_error\co.ru\aori@co.ru!26057!3119616125!1.eml

Этот файл на диске есть? Упомянутая "ошибка 2" — это "нет такого файла". Вероятно последовательность была такой: 1) Dr.WEB заблокировал файл (долго проверял — например, ожидал перезагрузки базы), 2) PopFile не смог обработать заблокированный файл, 3) проверка в acFilter завершилась таймаутом 10060, 4) acSMTP не смог скопировать файл в архив и, соответственно, добавить в индекс.

Поищу, где какой проверки не хватило, чтобы отбой случился раньше, с выдачей 4xx MTA отправителя.

wikipost

matveeva

23.11.2010 10:13

ac пишет: ..\DATA\mail\arc4\201011\2010-11-19\popfile_error\co.ru\aori@co.ru!26057!3119616125!1.eml
Этот файл на диске есть?

Нет, такой папки .\DATA\mail\arc4\201011\2010-11-19\popfile_error\ — вообще не существует. А само письмо aori@co.ru!26057!3119616125!1.eml до сих пор лежит в SPOOL.

wikipost

27.11.2010 08:47
ред: 27.11.2010 08:50

Забыл отчитаться. Виноват в ситуации всё-таки popfile. Точнее, я виноват, что не учел всех вариантов последствий после popfile_error. Т.к. достоверно определить, отдаст ли popfile занятый файл в момент фактической доставки (она производится уже после второго ответа на DATA, т.е. шанса сказать отправляющему MTA о том, что у нас что-то не сработало, больше не будет), невозможно, то остается отвечать отправителю "4xx попробуйте позже" по любому popfile_error. Это и сделано в новой версии конфига (поедет в обновлении). Хотя, если ошибка вызвана не временной перегрузкой машины и прочими преходящими проблемами, а "несовместимостью" popfile с конкретным экземпляром письма (сбой в парсере и т.п.), то такой ответ только усугубит проблему — следующие посылки только еще раз напрягут popfile с тем же печальным результатом. Ну, по крайней мере письмо не будет валяться в спуле, а отправитель рано или поздно получит отлуп от своего MTA — "че-то мне никак не удается доставить письмо на этот хост"... Так что, возможно, стоит выловить то проблемное письмо из спула и погонять его через popfile для выяснения воспроизводимости проблемы "таймаут/popfile_error".

Новый конфиг пока тестируется на нашем сервере. В обновления поедет на той неделе.

wikipost

30.11.2010 10:58

Вчера обновления поехали.

wikipost

Eserv Forum / E4 / Mail / Ошибка PopFile