[Mailman-Users] Outgoing qrunner stops working and outgoing mails get stuck
ippaso
ippaso at trashmail.net
Tue Feb 5 16:13:26 CET 2008
SP ha scritto:
> Ok, thanks: I will patch mailman immediately and post here the 'error'
> log as soon as the error appears again.
Here the relevant part of mailman 'error' log (the time of the last sent
message is 22.29 and the time of the first message which gets stuck in
qfiles/out is 22.30):
Feb 03 22:26:03 2008 qrunner(20175): connect: ('localhost', 25)
Feb 03 22:26:03 2008 qrunner(20175): connect: ('localhost', 25)
Feb 03 22:26:03 2008 qrunner(20175): reply: '220 MYDOMAIN ESMTP\r\n'
Feb 03 22:26:03 2008 qrunner(20175): reply: retcode (220); Msg: MYDOMAIN
ESMTP
Feb 03 22:26:03 2008 qrunner(20175): connect: MYDOMAIN ESMTP
Feb 03 22:26:03 2008 qrunner(20175): send: 'ehlo www.MYDOMAIN\r\n'
Feb 03 22:26:03 2008 qrunner(20175): reply: '250-MYDOMAIN\r\n'
Feb 03 22:26:03 2008 qrunner(20175): reply: '250-AUTH LOGIN CRAM-MD5
PLAIN\r\n'
Feb 03 22:26:03 2008 qrunner(20175): reply: '250-AUTH=LOGIN CRAM-MD5
PLAIN\r\n'
Feb 03 22:26:03 2008 qrunner(20175): reply: '250-STARTTLS\r\n'
Feb 03 22:26:03 2008 qrunner(20175): reply: '250-PIPELINING\r\n'
Feb 03 22:26:03 2008 qrunner(20175): reply: '250 8BITMIME\r\n'
Feb 03 22:26:03 2008 qrunner(20175): reply: retcode (250); Msg: MYDOMAIN
AUTH LOGIN CRAM-MD5 PLAIN
AUTH=LOGIN CRAM-MD5 PLAIN
STARTTLS
PIPELINING
8BITMIME
Feb 03 22:26:03 2008 qrunner(20175): send: 'mail
FROM:<test-bounces at MYDOMAIN>\r\n'
Feb 03 22:26:03 2008 qrunner(20175): reply: '250 ok\r\n'
Feb 03 22:26:03 2008 qrunner(20175): reply: retcode (250); Msg: ok
Feb 03 22:26:03 2008 qrunner(20175): send: 'rcpt
TO:<mailman-test at MYDOMAIN>\r\n'
Feb 03 22:26:03 2008 qrunner(20175): reply: '250 ok\r\n'
Feb 03 22:26:03 2008 qrunner(20175): reply: retcode (250); Msg: ok
Feb 03 22:26:03 2008 qrunner(20175): send: 'data\r\n'
Feb 03 22:26:03 2008 qrunner(20175): reply: '354 go ahead\r\n'
Feb 03 22:26:03 2008 qrunner(20175): reply: retcode (354); Msg: go ahead
Feb 03 22:26:03 2008 qrunner(20175): data: (354, 'go ahead')
Feb 03 22:26:03 2008 qrunner(20175): send: 'Return-Path:
<TESTMAIL at MYDOMAIN>\r\nDelivered-To: MYDOMAIN-test at MYDOMAIN\r\nReceived:
(qmail 3364 invoked by uid 511); 3 Feb 2008 22:26:02 +0100\r\nDate: 3
Feb 2008 22:26:02 +0100\r\nMessage-ID:
<20080203212602.3363.qmail at MYDOMAIN>\r\nFrom: TESTMAIL at MYDOMAIN\r\nTo:
test at MYDOMAIN\r\nSubject: [Test] Test Sun Feb 3 22:26:02 CET
2008\r\nX-BeenThere: test at MYDOMAIN\r\nX-Mailman-Version:
2.1.9\r\nPrecedence: list\r\nList-Id:
<test.MYDOMAIN>\r\nList-Unsubscribe:
<http://MYDOMAIN/mailman/listinfo/test>,\r\n\t<mailto:test-request at MYDOMAIN?subject=unsubscribe>\r\nList-Archive:
<http://MYDOMAIN/pipermail/test>\r\nList-Post:
<mailto:test at MYDOMAIN>\r\nList-Help:
<mailto:test-request at MYDOMAIN?subject=help>\r\nList-Subscribe:
<http://MYDOMAIN/mailman/listinfo/test>,\r\n\t<mailto:test-request at MYDOMAIN?subject=subscribe>\r\nMIME-Version:
1.0\r\nContent-Type: text/plain;
charset="iso-8859-1"\r\nContent-Transfer-Encoding:
quoted-printable\r\nSender: test-bounces at MYDOMAIN\r\nErrors-To:
test-bounces at MYDOMAIN\r\n\r\nSun Feb 3 22:26:02 CET
2008\r\n_______________________________________________\r\nTest mailing
list\r\nTest at MYDOMAIN\r\nhttp://MYDOMAIN/mailman/listinfo/test\r\n.\r\n'
Feb 03 22:26:06 2008 qrunner(20175): reply: '250 ok 1202073966 qp
3369\r\n'
Feb 03 22:26:06 2008 qrunner(20175): reply: retcode (250); Msg: ok
1202073966 qp 3369
Feb 03 22:26:06 2008 qrunner(20175): data: (250, 'ok 1202073966 qp 3369')
Feb 03 22:26:06 2008 qrunner(20175): send: 'quit\r\n'
Feb 03 22:26:06 2008 qrunner(20175): reply: '221 MYDOMAIN\r\n'
Feb 03 22:26:06 2008 qrunner(20175): reply: retcode (221); Msg: MYDOMAIN
Feb 03 22:29:40 2008 qrunner(20175): connect: ('localhost', 25)
Feb 03 22:29:40 2008 qrunner(20175): connect: ('localhost', 25)
Feb 03 22:30:18 2008 qrunner(20175): reply: '220 MYDOMAIN ESMTP\r\n'
Feb 03 22:30:18 2008 qrunner(20175): reply: retcode (220); Msg: MYDOMAIN
ESMTP
Feb 03 22:30:18 2008 qrunner(20175): connect: MYDOMAIN ESMTP
Feb 03 22:30:18 2008 qrunner(20175): send: 'ehlo www.MYDOMAIN\r\n'
Feb 03 22:30:18 2008 qrunner(20175): reply: '250-MYDOMAIN\r\n'
Feb 03 22:30:18 2008 qrunner(20175): reply: '250-AUTH LOGIN CRAM-MD5
PLAIN\r\n'
Feb 03 22:30:18 2008 qrunner(20175): reply: '250-AUTH=LOGIN CRAM-MD5
PLAIN\r\n'
Feb 03 22:30:18 2008 qrunner(20175): reply: '250-STARTTLS\r\n'
Feb 03 22:30:18 2008 qrunner(20175): reply: '250-PIPELINING\r\n'
Feb 03 22:30:18 2008 qrunner(20175): reply: '250 8BITMIME\r\n'
Feb 03 22:30:18 2008 qrunner(20175): reply: retcode (250); Msg: MYDOMAIN
AUTH LOGIN CRAM-MD5 PLAIN
AUTH=LOGIN CRAM-MD5 PLAIN
STARTTLS
PIPELINING
8BITMIME
Feb 03 22:30:18 2008 qrunner(20175): send: 'mail
FROM:<test-bounces at MYDOMAIN>\r\n'
Feb 03 22:30:18 2008 qrunner(20175): reply: '250 ok\r\n'
Feb 03 22:30:18 2008 qrunner(20175): reply: retcode (250); Msg: ok
Feb 03 22:30:18 2008 qrunner(20175): send: 'rcpt
TO:<mailman-test at MYDOMAIN>\r\n'
Feb 03 22:30:19 2008 qrunner(20175): reply: '250 ok\r\n'
Feb 03 22:30:19 2008 qrunner(20175): reply: retcode (250); Msg: ok
Feb 03 22:30:19 2008 qrunner(20175): send: 'data\r\n'
Feb 03 22:30:20 2008 qrunner(20175): reply: '354 go ahead\r\n'
Feb 03 22:30:20 2008 qrunner(20175): reply: retcode (354); Msg: go ahead
Feb 03 22:30:20 2008 qrunner(20175): data: (354, 'go ahead')
Feb 03 22:30:20 2008 qrunner(20175): send: 'Return-Path:
<TESTMAIL at MYDOMAIN>\r\nDelivered-To: MYDOMAIN-test at MYDOMAIN\r\nReceived:
(qmail 3747 invoked by uid 511); 3 Feb 2008 22:27:30 +0100\r\nDate: 3
Feb 2008 22:27:30 +0100\r\nMessage-ID:
<20080203212730.3725.qmail at MYDOMAIN>\r\nFrom: TESTMAIL at MYDOMAIN\r\nTo:
test at MYDOMAIN\r\nSubject: [Test] Test Sun Feb 3 22:27:27 CET
2008\r\nX-BeenThere: test at MYDOMAIN\r\nX-Mailman-Version:
2.1.9\r\nPrecedence: list\r\nList-Id:
<test.MYDOMAIN>\r\nList-Unsubscribe:
<http://MYDOMAIN/mailman/listinfo/test>,\r\n\t<mailto:test-request at MYDOMAIN?subject=unsubscribe>\r\nList-Archive:
<http://MYDOMAIN/pipermail/test>\r\nList-Post:
<mailto:test at MYDOMAIN>\r\nList-Help:
<mailto:test-request at MYDOMAIN?subject=help>\r\nList-Subscribe:
<http://MYDOMAIN/mailman/listinfo/test>,\r\n\t<mailto:test-request at MYDOMAIN?subject=subscribe>\r\nMIME-Version:
1.0\r\nContent-Type: text/plain;
charset="iso-8859-1"\r\nContent-Transfer-Encoding:
quoted-printable\r\nSender: test-bounces at MYDOMAIN\r\nErrors-To:
test-bounces at MYDOMAIN\r\n\r\nSun Feb 3 22:27:26 CET
2008\r\n_______________________________________________\r\nTest mailing
list\r\nTest at MYDOMAIN\r\nhttp://MYDOMAIN/mailman/listinfo/test\r\n.\r\n'
Feb 03 22:31:22 2008 qrunner(20175): reply: '250 ok 1202074282 qp
4580\r\n'
Feb 03 22:31:22 2008 qrunner(20175): reply: retcode (250); Msg: ok
1202074282 qp 4580
Feb 03 22:31:22 2008 qrunner(20175): data: (250, 'ok 1202074282 qp 4580')
Feb 03 22:31:22 2008 qrunner(20175): send: 'quit\r\n'
Feb 03 22:31:22 2008 qrunner(20175): reply: '221 MYDOMAIN\r\n'
Feb 03 22:31:22 2008 qrunner(20175): reply: retcode (221); Msg: MYDOMAIN
Feb 03 22:31:22 2008 qrunner(20175): connect: ('localhost', 25)
Feb 03 22:31:22 2008 qrunner(20175): connect: ('localhost', 25)
Feb 03 22:31:50 2008 qrunner(20175): reply: '220 MYDOMAIN ESMTP\r\n'
Feb 03 22:31:50 2008 qrunner(20175): reply: retcode (220); Msg: MYDOMAIN
ESMTP
Feb 03 22:31:50 2008 qrunner(20175): connect: MYDOMAIN ESMTP
Feb 03 22:31:50 2008 qrunner(20175): send: 'ehlo www.MYDOMAIN\r\n'
Feb 03 22:31:50 2008 qrunner(20175): reply: '250-MYDOMAIN\r\n'
Feb 03 22:31:50 2008 qrunner(20175): reply: '250-AUTH LOGIN CRAM-MD5
PLAIN\r\n'
Feb 03 22:31:50 2008 qrunner(20175): reply: '250-AUTH=LOGIN CRAM-MD5
PLAIN\r\n'
Feb 03 22:31:50 2008 qrunner(20175): reply: '250-STARTTLS\r\n'
Feb 03 22:31:50 2008 qrunner(20175): reply: '250-PIPELINING\r\n'
Feb 03 22:31:50 2008 qrunner(20175): reply: '250 8BITMIME\r\n'
Feb 03 22:31:50 2008 qrunner(20175): reply: retcode (250); Msg: MYDOMAIN
AUTH LOGIN CRAM-MD5 PLAIN
AUTH=LOGIN CRAM-MD5 PLAIN
STARTTLS
PIPELINING
8BITMIME
Feb 03 22:31:50 2008 qrunner(20175): send: 'mail
FROM:<test-bounces at MYDOMAIN>\r\n'
Feb 03 22:31:50 2008 qrunner(20175): reply: '250 ok\r\n'
Feb 03 22:31:50 2008 qrunner(20175): reply: retcode (250); Msg: ok
Feb 03 22:31:50 2008 qrunner(20175): send: 'rcpt
TO:<mailman-test at MYDOMAIN>\r\n'
Feb 03 22:31:50 2008 qrunner(20175): reply: '250 ok\r\n'
Feb 03 22:31:50 2008 qrunner(20175): reply: retcode (250); Msg: ok
Feb 03 22:31:50 2008 qrunner(20175): send: 'data\r\n'
Feb 03 22:31:51 2008 qrunner(20175): reply: '354 go ahead\r\n'
Feb 03 22:31:51 2008 qrunner(20175): reply: retcode (354); Msg: go ahead
Feb 03 22:31:51 2008 qrunner(20175): data: (354, 'go ahead')
Feb 03 22:31:51 2008 qrunner(20175): send: 'Return-Path:
<TESTMAIL at MYDOMAIN>\r\nDelivered-To: MYDOMAIN-test at MYDOMAIN\r\nReceived:
(qmail 3907 invoked by uid 511); 3 Feb 2008 22:28:18 +0100\r\nDate: 3
Feb 2008 22:28:07 +0100\r\nMessage-ID:
<20080203212807.3906.qmail at MYDOMAIN>\r\nFrom: TESTMAIL at MYDOMAIN\r\nTo:
test at MYDOMAIN\r\nSubject: [Test] Test Sun Feb 3 22:28:07 CET
2008\r\nX-BeenThere: test at MYDOMAIN\r\nX-Mailman-Version:
2.1.9\r\nPrecedence: list\r\nList-Id:
<test.MYDOMAIN>\r\nList-Unsubscribe:
<http://MYDOMAIN/mailman/listinfo/test>,\r\n\t<mailto:test-request at MYDOMAIN?subject=unsubscribe>\r\nList-Archive:
<http://MYDOMAIN/pipermail/test>\r\nList-Post:
<mailto:test at MYDOMAIN>\r\nList-Help:
<mailto:test-request at MYDOMAIN?subject=help>\r\nList-Subscribe:
<http://MYDOMAIN/mailman/listinfo/test>,\r\n\t<mailto:test-request at MYDOMAIN?subject=subscribe>\r\nMIME-Version:
1.0\r\nContent-Type: text/plain;
charset="iso-8859-1"\r\nContent-Transfer-Encoding:
quoted-printable\r\nSender: test-bounces at MYDOMAIN\r\nErrors-To:
test-bounces at MYDOMAIN\r\n\r\nSun Feb 3 22:28:07 CET
2008\r\n_______________________________________________\r\nTest mailing
list\r\nTest at MYDOMAIN\r\nhttp://MYDOMAIN/mailman/listinfo/test\r\n.\r\n'
Feb 03 22:32:14 2008 qrunner(20175): reply: '250 ok 1202074334 qp
5084\r\n'
Feb 03 22:32:14 2008 qrunner(20175): reply: retcode (250); Msg: ok
1202074334 qp 5084
Feb 03 22:32:14 2008 qrunner(20175): data: (250, 'ok 1202074334 qp 5084')
Feb 03 22:32:14 2008 qrunner(20175): send: 'quit\r\n'
Feb 03 22:32:14 2008 qrunner(20175): reply: '221 MYDOMAIN\r\n'
Feb 03 22:32:14 2008 qrunner(20175): reply: retcode (221); Msg: MYDOMAIN
Feb 03 22:32:14 2008 qrunner(20175): connect: ('localhost', 25)
Feb 03 22:32:14 2008 qrunner(20175): connect: ('localhost', 25)
Feb 03 22:32:55 2008 qrunner(20175): reply: '220 MYDOMAIN ESMTP\r\n'
Feb 03 22:32:55 2008 qrunner(20175): reply: retcode (220); Msg: MYDOMAIN
ESMTP
Feb 03 22:32:55 2008 qrunner(20175): connect: MYDOMAIN ESMTP
Feb 03 22:32:55 2008 qrunner(20175): send: 'ehlo www.MYDOMAIN\r\n'
Feb 03 22:32:55 2008 qrunner(20175): reply: '250-MYDOMAIN\r\n'
Feb 03 22:32:55 2008 qrunner(20175): reply: '250-AUTH LOGIN CRAM-MD5
PLAIN\r\n'
Feb 03 22:32:55 2008 qrunner(20175): reply: '250-AUTH=LOGIN CRAM-MD5
PLAIN\r\n'
Feb 03 22:32:55 2008 qrunner(20175): reply: '250-STARTTLS\r\n'
Feb 03 22:32:55 2008 qrunner(20175): reply: '250-PIPELINING\r\n'
Feb 03 22:32:55 2008 qrunner(20175): reply: '250 8BITMIME\r\n'
Feb 03 22:32:55 2008 qrunner(20175): reply: retcode (250); Msg: MYDOMAIN
AUTH LOGIN CRAM-MD5 PLAIN
AUTH=LOGIN CRAM-MD5 PLAIN
STARTTLS
PIPELINING
8BITMIME
Feb 03 22:32:55 2008 qrunner(20175): send: 'mail
FROM:<test-bounces at MYDOMAIN>\r\n'
Feb 03 22:32:55 2008 qrunner(20175): reply: '250 ok\r\n'
Feb 03 22:32:55 2008 qrunner(20175): reply: retcode (250); Msg: ok
Feb 03 22:32:55 2008 qrunner(20175): send: 'rcpt
TO:<mailman-test at MYDOMAIN>\r\n'
Feb 03 22:32:55 2008 qrunner(20175): reply: '250 ok\r\n'
Feb 03 22:32:55 2008 qrunner(20175): reply: retcode (250); Msg: ok
Feb 03 22:32:55 2008 qrunner(20175): send: 'data\r\n'
Feb 03 22:32:55 2008 qrunner(20175): reply: '354 go ahead\r\n'
Feb 03 22:32:56 2008 qrunner(20175): reply: retcode (354); Msg: go ahead
Feb 03 22:32:56 2008 qrunner(20175): data: (354, 'go ahead')
Feb 03 22:32:56 2008 qrunner(20175): send: 'Return-Path:
<TESTMAIL at MYDOMAIN>\r\nDelivered-To: MYDOMAIN-test at MYDOMAIN\r\nReceived:
(qmail 4288 invoked by uid 511); 3 Feb 2008 22:29:12 +0100\r\nDate: 3
Feb 2008 22:29:12 +0100\r\nMessage-ID:
<20080203212912.4287.qmail at MYDOMAIN>\r\nFrom: TESTMAIL at MYDOMAIN\r\nTo:
test at MYDOMAIN\r\nSubject: [Test] Test Sun Feb 3 22:29:12 CET
2008\r\nX-BeenThere: test at MYDOMAIN\r\nX-Mailman-Version:
2.1.9\r\nPrecedence: list\r\nList-Id:
<test.MYDOMAIN>\r\nList-Unsubscribe:
<http://MYDOMAIN/mailman/listinfo/test>,\r\n\t<mailto:test-request at MYDOMAIN?subject=unsubscribe>\r\nList-Archive:
<http://MYDOMAIN/pipermail/test>\r\nList-Post:
<mailto:test at MYDOMAIN>\r\nList-Help:
<mailto:test-request at MYDOMAIN?subject=help>\r\nList-Subscribe:
<http://MYDOMAIN/mailman/listinfo/test>,\r\n\t<mailto:test-request at MYDOMAIN?subject=subscribe>\r\nMIME-Version:
1.0\r\nContent-Type: text/plain;
charset="iso-8859-1"\r\nContent-Transfer-Encoding:
quoted-printable\r\nSender: test-bounces at MYDOMAIN\r\nErrors-To:
test-bounces at MYDOMAIN\r\n\r\nSun Feb 3 22:29:12 CET
2008\r\n_______________________________________________\r\nTest mailing
list\r\nTest at MYDOMAIN\r\nhttp://MYDOMAIN/mailman/listinfo/test\r\n.\r\n'
Feb 03 22:33:23 2008 qrunner(20175): reply: '250 ok 1202074403 qp
5450\r\n'
Feb 03 22:33:23 2008 qrunner(20175): reply: retcode (250); Msg: ok
1202074403 qp 5450
Feb 03 22:33:23 2008 qrunner(20175): data: (250, 'ok 1202074403 qp 5450')
Feb 03 22:33:23 2008 qrunner(20175): send: 'quit\r\n'
Feb 03 22:33:23 2008 qrunner(20175): reply: '221 MYDOMAIN\r\n'
Feb 03 22:33:23 2008 qrunner(20175): reply: retcode (221); Msg: MYDOMAIN
Feb 03 22:33:23 2008 qrunner(20175): connect: ('localhost', 25)
Feb 03 22:33:23 2008 qrunner(20175): connect: ('localhost', 25)
Again at the moment of the failure the system load was high since there
were about 20 simultaneous connections to the smtp server, and
consequently many spamassassins processes, and from the mailman 'smtp'
log again it took many time to deliver the last few messages:
Feb 03 22:25:10 2008 (20175) <20080203212501.3266.qmail at MYDOMAIN> smtp
to test for 1 recips, completed in 3.815 seconds
Feb 03 22:26:06 2008 (20175) <20080203212602.3363.qmail at MYDOMAIN> smtp
to test for 1 recips, completed in 3.451 seconds
Feb 03 22:31:22 2008 (20175) <20080203212730.3725.qmail at MYDOMAIN> smtp
to test for 1 recips, completed in 102.005 seconds
Feb 03 22:32:14 2008 (20175) <20080203212807.3906.qmail at MYDOMAIN> smtp
to test for 1 recips, completed in 52.107 seconds
Feb 03 22:33:23 2008 (20175) <20080203212912.4287.qmail at MYDOMAIN> smtp
to test for 1 recips, completed in 69.000 seconds
No entries in the smtp-failure log, the last lines are dated the day before:
Feb 01 04:00:03 2008 (2154) Low level smtp error: (4, 'Interrupted
system call'), msgid: <mailman.1319.1201822426.2150.sp at MYDOMAIN>
Feb 02 12:36:08 2008 (2154) Low level smtp error: (110, 'Connection
timed out'), msgid: <mailman.1407.1201951977.2150.sp at MYDOMAIN>
Feb 02 12:36:08 2008 (2154) delivery to ADDRESS at MYDOMAIN failed with
code -1: (110, 'Connection timed out')
bye,
Paso
More information about the Mailman-Users
mailing list