More info on my MCP problem

Matt Krause krausem at GMAIL.COM
Fri Jul 9 23:26:21 IST 2004 

Forgive me, I would respond to my own post, but I can't figure out why
I am not recieving my own posts.  I have some more log information on
the MCP problem I have been "spamming" the list about for the past
couple of days.

I got a fresh box up with Debian testing/unstable, Postfix 2.1.3,
SpamAssassin 2.63, and MailScanner 4.31.6.  Postfix is a Debian
package and SpamAssassin and MailScanner are form the source.

Everything is working great on the fresh box as it was when I first
installed everything on the broken box. I even have a single instance
of Postfix running on the new box.  Here is the log info for a MCP
email.

I have attached the log information, but basically, the broken box is
never re queuing the message to be sent to the forward account setup
in MailScanner.conf. That is the only difference I see between the two
machine's logs.

Can anyone point me in the right direction of a place to look to see
why the message isn't being re queued according to the log files?

Thanks.

--
Matt Krause
krausem at gmail.com
http://www.mattkrause.net

-------------------------- MailScanner list ----------------------
To leave, send    leave mailscanner    to jiscmail at jiscmail.ac.uk
Before posting, please see the Most Asked Questions at
http://www.mailscanner.biz/maq/     and the archives at
http://www.jiscmail.ac.uk/lists/mailscanner.html
-------------- next part --------------
Jul  9 14:49:47 server1 postfix/smtpd[18010]: 73A5C11E83C: client=out2.smtp.messagingengine.com[66.111.4.26]
Jul  9 14:49:47 server1 postfix/cleanup[8883]: 73A5C11E83C: hold: header Received: from out2.smtp.messagingengine.com (out2.smtp.messagingengine.com [66.111.4.26])??by server1.example.com (Postfix) with ESMTP id 73A5C11E83C??for <user1 at example.com>; Fri,  from out2.smtp.messagingengine.com[66.111.4.26]; from=<me at example2.net> to=<user1 at example.com> proto=ESMTP helo=<out2.smtp.messagingengine.com>
Jul  9 14:49:47 server1 postfix/cleanup[8883]: 73A5C11E83C: hold: header Received: from [192.168.1.217] (server1.example.com [1.1.1.1])??by server1.fastmail.fm (Postfix) with ESMTP id EF8B5C11217??for <user1 at example.com>; Fri,  9 Jul 2004 17:49:44 -0400 ( from out2.smtp.messagingengine.com[66.111.4.26]; from=<me at example2.net> to=<user1 at example.com> proto=ESMTP helo=<out2.smtp.messagingengine.com>
Jul  9 14:49:47 server1 postfix/cleanup[8883]: 73A5C11E83C: message-id=<40EF131E.6040803 at example2.net>
Jul  9 14:49:47 server1 postfix/smtpd[18010]: disconnect from out2.smtp.messagingengine.com[66.111.4.26]
Jul  9 14:49:47 server1 MailScanner[20143]: New Batch: Scanning 1 messages, 1354 bytes
Jul  9 14:49:47 server1 MailScanner[20143]: MCP Checks: Starting
Jul  9 14:49:47 server1 MailScanner[20143]: Message 73A5C11E83C from 66.111.4.26 (me at example2.net) to example.com is MCP, MCP-Checker (score=1, required 1, fuck)
Jul  9 14:49:47 server1 MailScanner[20143]: MCP Actions: message 73A5C11E83C actions are krausem at gmail.com,store,forward,notify
Jul  9 14:49:47 server1 MailScanner[20143]: MCP Actions: Notify user1 at example.com, sarge at example.com
Jul  9 14:49:47 server1 postfix/pickup[8772]: F1D5211E95A: uid=108 from=<postmaster>
Jul  9 14:49:47 server1 postfix/cleanup[19649]: F1D5211E95A: hold: header Received: by server1.example.com (Postfix, from userid 108)??id F1D5211E95A; Fri,  9 Jul 2004 14:49:47 -0700 (PDT) from local; from=<postmaster at server1.example.com>
Jul  9 14:49:47 server1 postfix/cleanup[19649]: F1D5211E95A: message-id=<20040709214947.F1D5211E95A at server1.example.com>
Jul  9 14:49:47 server1 MailScanner[20143]: MCP Checks completed at 1354 bytes per second
Jul  9 14:49:47 server1 MailScanner[20143]: Spam Checks: Starting
Jul  9 14:49:49 server1 MailScanner[20143]: Spam Checks completed at 677 bytes per second
Jul  9 14:49:49 server1 MailScanner[20143]: Virus and Content Scanning: Starting
Jul  9 14:49:49 server1 MailScanner[20143]: Virus Scanning completed at 1354 bytes per second
Jul  9 14:49:49 server1 MailScanner[20143]: Virus Processing completed at 1354 bytes per second
Jul  9 14:49:49 server1 MailScanner[20143]: Disinfection completed at 1354 bytes per second
Jul  9 14:49:49 server1 MailScanner[20143]: Batch completed at 677 bytes per second (1354 / 2)
Jul  9 14:49:49 server1 MailScanner[20143]: New Batch: Scanning 1 messages, 1406 bytes
Jul  9 14:49:49 server1 MailScanner[20143]: MCP Checks: Starting
Jul  9 14:49:49 server1 MailScanner[20143]: MCP Checks completed at 1406 bytes per second
Jul  9 14:49:49 server1 MailScanner[20143]: Spam Checks: Starting
Jul  9 14:49:49 server1 MailScanner[20143]: Message F1D5211E95A from 127.0.0.1 (postmaster at server1.example.com) is whitelisted
Jul  9 14:49:49 server1 MailScanner[20143]: Spam Checks completed at 1406 bytes per second
Jul  9 14:49:49 server1 MailScanner[20143]: Virus and Content Scanning: Starting
Jul  9 14:49:50 server1 MailScanner[20143]: Virus Scanning completed at 1406 bytes per second
Jul  9 14:49:50 server1 MailScanner[20143]: Requeue: F1D5211E95A to B851011E83C
Jul  9 14:49:50 server1 MailScanner[20143]: Uninfected: Delivered 1 messages
Jul  9 14:49:50 server1 MailScanner[20143]: Virus Processing completed at 1406 bytes per second
Jul  9 14:49:50 server1 MailScanner[20143]: Disinfection completed at 1406 bytes per second
Jul  9 14:49:50 server1 MailScanner[20143]: Batch completed at 1406 bytes per second (1406 / 1)
Jul  9 14:49:50 server1 postfix/qmgr[8773]: B851011E83C: from=<postmaster at server1.example.com>, size=1200, nrcpt=2 (queue active)
Jul  9 14:49:50 server1 postfix/local[19749]: B851011E83C: to=<sarge at example.com>, relay=local, delay=3, status=sent (maildir)
Jul  9 14:49:50 server1 postfix/local[19754]: B851011E83C: to=<user1 at example.com>, relay=local, delay=3, status=sent (maildir)

-------------------------- MailScanner list ----------------------
To leave, send    leave mailscanner    to jiscmail at jiscmail.ac.uk
Before posting, please see the Most Asked Questions at
http://www.mailscanner.biz/maq/     and the archives at
http://www.jiscmail.ac.uk/lists/mailscanner.html
-------------- next part --------------
Jul  9 15:02:50 server2 postfix/smtpd[23056]: A20EF30C047: client=server1.example.com[192.168.1.24]
Jul  9 15:02:50 server2 postfix/cleanup[23057]: A20EF30C047: hold: header Received: from server1.example.com (server1.example.com [192.168.1.24])??by server2 (Postfix) with ESMTP id A20EF30C047??for <user at server2.example.com>; Fri,  9 Jul  from server1.example.com[192.168.1.24]; from=<user1 at server1.example.com> to=<user at server2.example.com> proto=ESMTP helo=<server1.example.com>
Jul  9 15:02:50 server2 postfix/cleanup[23057]: A20EF30C047: hold: header Received: from [192.168.1.217] (unknown [192.168.1.217])??(using TLSv1 with cipher DHE-RSA-AES256-SHA (256/256 bits))??(No client certificate requested)??by www.example.com (Postfix) with ES from server1.example.com[192.168.1.24]; from=<user1 at example.com> to=<user1 at server2.example.com> proto=ESMTP helo=<www.example.com>
Jul  9 15:02:50 server2 postfix/cleanup[23057]: A20EF30C047: message-id=<40EF162D.9060901 at example.com>
Jul  9 15:02:50 server2 postfix/smtpd[23056]: disconnect from server1.example.com[192.168.1.24]
Jul  9 15:02:51 server2 MailScanner[23045]: New Batch: Scanning 1 messages, 1701 bytes
Jul  9 15:02:51 server2 MailScanner[23045]: MCP Checks: Starting
Jul  9 15:02:51 server2 MailScanner[23045]: Message A20EF30C047 from 192.168.1.24 (user1 at example.com) to server2.example.com is MCP, MCP-Checker (score=5, required 1, SAMPLE_RULE2)
Jul  9 15:02:51 server2 MailScanner[23045]: MCP Actions: message A20EF30C047 actions are root at server2.example.com,store,forward
Jul  9 15:02:51 server2 MailScanner[23045]: MCP Checks completed at 1701 bytes per second
Jul  9 15:02:51 server2 MailScanner[23045]: Spam Checks: Starting
Jul  9 15:02:52 server2 MailScanner[23045]: Spam Checks completed at 1701 bytes per second
Jul  9 15:02:52 server2 MailScanner[23045]: Virus and Content Scanning: Starting
Jul  9 15:02:52 server2 MailScanner[23045]: Virus Scanning completed at 1701 bytes per second
Jul  9 15:02:52 server2 MailScanner[23045]: Requeue: A20EF30C047 to 9EB2230C048
Jul  9 15:02:52 server2 postfix/qmgr[22966]: 9EB2230C048: from=<user1 at example.com>, size=1519, nrcpt=1 (queue active)
Jul  9 15:02:52 server2 postfix/local[23062]: 9EB2230C048: to=<root at server2.example.com>, relay=local, delay=2, status=sent (delivered to mailbox)

-------------------------- MailScanner list ----------------------
To leave, send    leave mailscanner    to jiscmail at jiscmail.ac.uk
Before posting, please see the Most Asked Questions at
http://www.mailscanner.biz/maq/     and the archives at
http://www.jiscmail.ac.uk/lists/mailscanner.html

More information about the MailScanner mailing list