[Mimedefang] Seeing weird SMFI errors

Philip Prindeville philipp_subx at redfish-solutions.com
Sun Jul 26 20:03:38 EDT 2015


I’m running mimedefang-2.78-2 on Fedora 21, along with sendmail-8.14.9-5.

I’m seeing errors when getting email from vger.kernel.org (I get several kernel hacking mailing lists), and getting sporadic delivery.

It seems to start when vger connects every 20 minutes or so and attempts to deliver a message:

Jul 26 17:43:29 mail mimedefang.pl[26644]: helo: vger.kernel.org (209.132.180.67:36829) said "helo vger.kernel.org"
Jul 26 17:43:29 mail sendmail[27848]: t6QNhOYb027848: from=<netdev-owner at vger.kernel.org>, size=23800, class=-60, nrcpts=1, msgid=<1437586416-14735-1-git-send-email-albeu at free.fr>, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:29 mail sendmail[27848]: t6QNhOYb027848: Milter (mimedefang): timeout before data read, where=eom
Jul 26 17:44:29 mail sendmail[27848]: t6QNhOYb027848: Milter (mimedefang): to error state
Jul 26 17:44:29 mail sendmail[27848]: t6QNhOYb027848: Milter: data, reject=451 4.3.2 Please try again later
Jul 26 17:44:29 mail sendmail[27848]: t6QNhOYb027848: to=<philipp_subx at redfish-solutions.com>, delay=00:01:00, pri=161800, stat=Please try again later
Jul 26 17:44:29 mail sendmail[27848]: t6QNhOYd027848: Milter: from=<netdev-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:29 mail sendmail[27848]: t6QNhOYd027848: from=<netdev-owner at vger.kernel.org>, size=5834, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYe027848: Milter: from=<netdev-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYe027848: from=<netdev-owner at vger.kernel.org>, size=3967, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYf027848: Milter: from=<netdev-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYf027848: from=<netdev-owner at vger.kernel.org>, size=2373, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYg027848: Milter: from=<netdev-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYg027848: from=<netdev-owner at vger.kernel.org>, size=5864, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYh027848: Milter: from=<netdev-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYh027848: from=<netdev-owner at vger.kernel.org>, size=2800, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYi027848: Milter: from=<netdev-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYi027848: from=<netdev-owner at vger.kernel.org>, size=2250, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYj027848: Milter: from=<linux-usb-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYj027848: from=<linux-usb-owner at vger.kernel.org>, size=1976, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYk027848: Milter: from=<netdev-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYk027848: from=<netdev-owner at vger.kernel.org>, size=1961, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYl027848: Milter: from=<linux-wireless-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYl027848: from=<linux-wireless-owner at vger.kernel.org>, size=3672, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYm027848: Milter: from=<netdev-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYm027848: from=<netdev-owner at vger.kernel.org>, size=2246, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYn027848: Milter: from=<netdev-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:30 mail sendmail[27848]: t6QNhOYn027848: from=<netdev-owner at vger.kernel.org>, size=2130, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYo027848: Milter: from=<linux-wireless-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYo027848: from=<linux-wireless-owner at vger.kernel.org>, size=3596, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYp027848: Milter: from=<netdev-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYp027848: from=<netdev-owner at vger.kernel.org>, size=4493, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYq027848: Milter: from=<linux-usb-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYq027848: from=<linux-usb-owner at vger.kernel.org>, size=2828, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYr027848: Milter: from=<netdev-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYr027848: from=<netdev-owner at vger.kernel.org>, size=2016, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYs027848: Milter: from=<netdev-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYs027848: from=<netdev-owner at vger.kernel.org>, size=2479, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYt027848: Milter: from=<netdev-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYt027848: from=<netdev-owner at vger.kernel.org>, size=2266, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYu027848: Milter: from=<linux-usb-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:31 mail mimedefang.pl[27292]: t6QNhOYb027848: MDLOG,t6QNhOYb027848,mail_in,,,<netdev-owner at vger.kernel.org>,<philipp_subx at redfish-solutions.com>,[PATCH] MIPS: Remove most of the custom gpio.h
Jul 26 17:44:31 mail mimedefang[31780]: t6QNhOYb027848: smfi_addheader returned MI_FAILURE
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYu027848: from=<linux-usb-owner at vger.kernel.org>, size=5040, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYv027848: Milter: from=<linux-wireless-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYv027848: from=<linux-wireless-owner at vger.kernel.org>, size=7169, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYw027848: Milter: from=<linux-wireless-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYw027848: from=<linux-wireless-owner at vger.kernel.org>, size=6985, class=0, nrcpts=0, bodytype=8BITMIME, proto=ESMTP, daemon=MTA-v4, relay=vger.kernel.org [209.132.180.67]
Jul 26 17:44:31 mail sendmail[27848]: t6QNhOYx027848: Milter: from=<linux-wireless-owner at vger.kernel.org>, reject=451 4.3.2 Please try again later

…


Not sure exactly what’s going on.  This line seems to be telling:

Jul 26 17:44:31 mail mimedefang[31780]: t6QNhOYb027848: smfi_addheader returned MI_FAILURE

I can’t tell if the timeout is happening because the sender is slow to follow up with the DATA command, or if MdF is hanging somewhere, or what.

How to go about debugging something like this?  I’ve never had such issues so this is a first for me.

Thanks,

-Philip



More information about the MIMEDefang mailing list