[Mailman-Users] Mailman and Sendmail debugging questions

Thu Jun 8 08:04:23 CEST 2006

Daniel, Barry K. wrote:
>  
> /usr/local/mailman/log/smtp
> Jun 07 09:28:34 2006 (2096) <fa3eb4104181.44869c3f at domain.gov> smtp to testlist for 4 recips, completed in 0.088 seconds

Your post was sent to 4 recipients.

> Jun 07 09:28:37 2006 (2096) <mailman.0.1149686915.2092.testlist at domainwcs1.domainpriv.gov> smtp to testlist for 1 recips, completed in 0.105 seconds

Note: in the above and in what follows I have tried to remove (for 
readability) the 
<mailto:mailman.0.1149686915.2092.testlist at leowcs1.leopriv.gov> and 
similar 'mailto:' links added by your MUA.

3 seconds later a single, mailman generated message was sent - maybe a 
notice to the list owner?

> Jun 07 09:28:37 2006 (2096) <mailman.1.1149686915.2092.testlist at domainwcs1.domainpriv.gov> smtp to testlist for 1 recips, completed in 0.068 seconds

and another

> Jun 07 09:28:37 2006 (2096) <mailman.2.1149686915.2092.testlist at domainwcs1.domainpriv.gov> smtp to testlist for 1 recips, completed in 0.086 seconds

and another

> Jun 07 09:28:38 2006 (2096) <mailman.3.1149686916.2092.testlist at domainwcs1.domainpriv.gov> smtp to testlist for 1 recips, completed in 0.084 seconds

and another

> Jun 07 09:28:39 2006 (2096) <mailman.4.1149686918.2092.mailman at domainmta.domainpriv.gov> smtp to mailman for 1 recips, completed in 0.090 seconds

and another

> Jun 07 09:28:39 2006 (2096) <mailman.5.1149686918.2092.mailman at domainmta.domainpriv.gov> smtp to mailman for 1 recips, completed in 0.094 seconds

and another

> Jun 07 09:28:39 2006 (2096) <mailman.6.1149686918.2092.mailman at domainmta.domainpriv.gov> smtp to mailman for 1 recips, completed in 0.097 seconds

and another for a total of 7 Mailman generated messages, each to a 
single recipient?

> /var/mail/maillog
> Jun  7 09:28:33 domainwcs1 sendmail[4490]: [ID 801593 mail.info] k57DSX8Z004490: from=<dud1 at domain.gov>, size=1806, class=0, nrcpts=1, msgid=<fa3eb410418
> 1.44869c3f at domain.gov>, proto=ESMTP, daemon=MTA-v4, relay=domainmta1.domainpriv.gov [10.31.162.9]

The original post is received by the MTA

> Jun  7 09:28:33 domainwcs1 sendmail[4492]: [ID 801593 mail.info] k57DSX8Z004490: to=<testlist at domain.gov>, delay=00:00:00, xdelay=00:00:00, mailer=mailma
> n, pri=121806, relay=domainwcs1.domainpriv.gov, dsn=2.0.0, stat=Sent

and delivered to testlist at domain.gov

> Jun  7 09:28:34 domainwcs1 sendmail[4495]: [ID 801593 mail.info] k57DSY8Z004495: from=<testlist-bounces at domainwcs1.domainpriv.gov>, size=2990, class=-30, nr
> cpts=4, msgid=<fa3eb4104181.44869c3f at domain.gov>, proto=ESMTP, daemon=MTA-v4, relay=localhost [127.0.0.1]

The post is received from Mailman for 4 recipients.

> Jun  7 09:28:35 domainwcs1 sendmail[4499]: [ID 801593 mail.info] k57DSZYg004499: from=root, size=4698, class=0, nrcpts=1, msgid=<200606071328.k57DSZYg
> 004499 at domainps.domainpriv.gov>, relay=root at localhost

Some other message is received by the MTA from root at localhost

> Jun  7 09:28:35 domainwcs1 sendmail[4500]: [ID 801593 mail.info] k57DSZ8Z004500: from=<root at domainps.domainpriv.gov>, size=4915, class=0, nrcpts=1, msgid=<2
> 00606071328.k57DSZYg004499 at domainps.domainpriv.gov>, proto=ESMTP, daemon=MTA-v4, relay=localhost [127.0.0.1]

and relayed to localhost

> Jun  7 09:28:35 domainwcs1 sendmail[4499]: [ID 801593 mail.info] k57DSZYg004499: to=testlist-bounces at domainwcs1.domainpriv.gov, ctladdr=root (0/1), delay=00
> :00:00, xdelay=00:00:00, mailer=relay, pri=34698, relay=[127.0.0.1] [127.0.0.1], dsn=2.0.0, stat=Sent (k57DSZ8Z004500 Message accepted for delivery
> )

and accepted for delivery to testlist-bounces, so it appears to be a 
bounce (last 3 entries)

> Jun  7 09:28:35 domainwcs1 sendmail[4497]: [ID 801593 mail.info] k57DSY8Z004495: to=<dud3 at domain.gov>, delay=00:00:01, xdelay=00:00:01, mailer=mailman, p
> ri=266990, relay=domainwcs1.domainpriv.gov, dsn=2.0.0, stat=Sent

The original message for 4 recipients (k57DSY8Z004495) is sent to 
dud3 at domain.gov (but this may refer to the bounce)

> Jun  7 09:28:35 domainwcs1 sendmail[4505]: [ID 801593 mail.info] k57DSZUR004505: from=root, size=4698, class=0, nrcpts=1, msgid=<200606071328.k57DSZUR
> 004505 at domainps.domainpriv.gov>, relay=root at localhost
> Jun  7 09:28:35 domainwcs1 sendmail[4506]: [ID 801593 mail.info] k57DSZ8Z004506: from=<root at domainps.domainpriv.gov>, size=4915, class=0, nrcpts=1, msgid=<2
> 00606071328.k57DSZUR004505 at domainps.domainpriv.gov>, proto=ESMTP, daemon=MTA-v4, relay=localhost [127.0.0.1]
> Jun  7 09:28:35 domainwcs1 sendmail[4505]: [ID 801593 mail.info] k57DSZUR004505: to=testlist-bounces at domainwcs1.domainpriv.gov, ctladdr=root (0/1), delay=00
> :00:00, xdelay=00:00:00, mailer=relay, pri=34698, relay=[127.0.0.1] [127.0.0.1], dsn=2.0.0, stat=Sent (k57DSZ8Z004506 Message accepted for delivery
> )

And another bounce relayed and accepted for delivery

> Jun  7 09:28:35 domainwcs1 sendmail[4497]: [ID 801593 mail.info] k57DSY8Z004495: to=<dud2 at domain.gov>, delay=00:00:01, xdelay=00:00:00, mailer=mailman, p
> ri=266990, relay=domainwcs1.domainpriv.gov, dsn=2.0.0, stat=Sent

And another 'Sent' to dud2 at domain.gov

> Jun  7 09:28:35 domainwcs1 sendmail[4511]: [ID 801593 mail.info] k57DSZoI004511: from=root, size=4698, class=0, nrcpts=1, msgid=<200606071328.k57DSZoI
> 004511 at domainps.domainpriv.gov>, relay=root at localhost
> Jun  7 09:28:35 domainwcs1 sendmail[4501]: [ID 801593 mail.info] k57DSZ8Z004500: to="|/usr/local/mailman/mail/mailman bounces testlist", ctladdr=<test
> list-bounces at domainwcs1.domainpriv.gov> (1/0), delay=00:00:00, xdelay=00:00:00, mailer=prog, pri=35136, dsn=2.0.0, stat=Sent
> Jun  7 09:28:35 domainwcs1 sendmail[4512]: [ID 801593 mail.info] k57DSZ8Z004512: from=<root at domainps.domainpriv.gov>, size=4915, class=0, nrcpts=1, msgid=<2
> 00606071328.k57DSZoI004511 at domainps.domainpriv.gov>, proto=ESMTP, daemon=MTA-v4, relay=localhost [127.0.0.1]
> Jun  7 09:28:35 domainwcs1 sendmail[4511]: [ID 801593 mail.info] k57DSZoI004511: to=testlist-bounces at domainwcs1.domainpriv.gov, ctladdr=root (0/1), delay=00
> :00:00, xdelay=00:00:00, mailer=relay, pri=34698, relay=[127.0.0.1] [127.0.0.1], dsn=2.0.0, stat=Sent (k57DSZ8Z004512 Message accepted for delivery
> )
> Jun  7 09:28:35 domainwcs1 sendmail[4497]: [ID 801593 mail.info] k57DSY8Z004495: to=<dud1 at domain.gov>, delay=00:00:01, xdelay=00:00:00, mailer=mailman, p
> ri=266990, relay=domainwcs1.domainpriv.gov, dsn=2.0.0, stat=Sent

Another set of 4 culminating in a 'Sent' to dud1 at domain.gov, but here 
there is an additional entry (second of 5) which is actual delivery of 
the first bounce to the mailman wrapper.

> Jun  7 09:28:35 domainwcs1 sendmail[4517]: [ID 801593 mail.info] k57DSZdU004517: from=root, size=4698, class=0, nrcpts=1, msgid=<200606071328.k57DSZdU
> 004517 at domainps.domainpriv.gov>, relay=root at localhost
> Jun  7 09:28:35 domainwcs1 sendmail[4507]: [ID 801593 mail.info] k57DSZ8Z004506: to="|/usr/local/mailman/mail/mailman bounces testlist", ctladdr=<test
> list-bounces at domainwcs1.domainpriv.gov> (1/0), delay=00:00:00, xdelay=00:00:00, mailer=prog, pri=35136, dsn=2.0.0, stat=Sent
> Jun  7 09:28:35 domainwcs1 sendmail[4518]: [ID 801593 mail.info] k57DSZ8Z004518: from=<root at domainps.domainpriv.gov>, size=4915, class=0, nrcpts=1, msgid=<2
> 00606071328.k57DSZdU004517 at domainps.domainpriv.gov>, proto=ESMTP, daemon=MTA-v4, relay=localhost [127.0.0.1]
> Jun  7 09:28:35 domainwcs1 sendmail[4517]: [ID 801593 mail.info] k57DSZdU004517: to=testlist-bounces at domainwcs1.domainpriv.gov, ctladdr=root (0/1), delay=00
> :00:00, xdelay=00:00:00, mailer=relay, pri=34698, relay=[127.0.0.1] [127.0.0.1], dsn=2.0.0, stat=Sent (k57DSZ8Z004518 Message accepted for delivery
> )
> Jun  7 09:28:35 domainwcs1 sendmail[4497]: [ID 801593 mail.info] k57DSY8Z004495: to=<dud4 at domain.gov>, delay=00:00:01, xdelay=00:00:00, mailer=mailman, p
> ri=266990, relay=domainwcs1.domainpriv.gov, dsn=2.0.0, stat=Sent

And another, now familiar set, I think the generation of the bounce of 
dud4 at domain.gov plus the delivery to mailman of the second bounce.

> Jun  7 09:28:35 domainwcs1 sendmail[4513]: [ID 801593 mail.info] k57DSZ8Z004512: to="|/usr/local/mailman/mail/mailman bounces testlist", ctladdr=<test
> list-bounces at domainwcs1.domainpriv.gov> (1/0), delay=00:00:00, xdelay=00:00:00, mailer=prog, pri=35136, dsn=2.0.0, stat=Sent
> Jun  7 09:28:36 domainwcs1 sendmail[4519]: [ID 801593 mail.info] k57DSZ8Z004518: to="|/usr/local/mailman/mail/mailman bounces testlist", ctladdr=<test
> list-bounces at domainwcs1.domainpriv.gov> (1/0), delay=00:00:01, xdelay=00:00:01, mailer=prog, pri=35136, dsn=2.0.0, stat=Sent

and finally, the delivery to Mailman of the last two bounces.

So mailman is sending the post to dud1 at domain.gov, dud2 at domain.gov, 
dud3 at domain.gov and dud4 at domain.gov, the MTA is accepting the post and 
then ultimately bouncing all 4 addresses. This is an MTA configuration 
or other issue. The MTA (Sendmail) either can't deliver to these 
addresses or won't relay to them from localhost. This doesn't appear to 
be a Mailman issue.

-- 
Mark Sapiro <msapiro at value.net>       The highway is for gamblers,
San Francisco Bay Area, California    better use your sense - B. Dylan