From: John Madden (no email)
Date: Thu Feb 02 2006 - 16:34:48 EST
> At the moment, I'm actually investigating what another subscriber mentioned --
> loss of sync on the socket as Postfix sends the message. To resolve this, I've
> turned off its lmtp connection cache. I won't know if this is actually a
> sufficient fix for probably another week or so since the problem was so random.
Well it's been a couple of weeks here and the problem has apparently not gone
away. In this case, "odduser" receives mail intended for "recipient" sent from
"sender." Log entries:
Jan 19 14:31:56 postal-b postfix/smtpd[26728]: connect from unknown[168.91.5.15]
Jan 19 14:31:56 postal-b postfix/smtpd[26728]: BB3BD92B9: client=unknown[168.91.5
.15]
Jan 19 14:31:56 postal-b postfix/cleanup[5763]: BB3BD92B9: message-id=<F43351F94C
>
Jan 19 14:31:56 postal-b postfix/qmgr[26568]: BB3BD92B9: from=<sender at ivytech dot e
du>, size=6396, nrcpt=2 (queue active)
Jan 19 14:32:02 postal-b postfix/smtp[4457]: BB3BD92B9: to=<recipient at ivytech dot e
du>, relay=127.0.0.1[127.0.0.1], delay=6, status=sent (250 2.6.0 Ok, id=05631-02,
from MTA([127.0.0.1]:10025): 250 Ok: queued as 3D18992FA)
Jan 19 14:32:02 postal-b amavis[5631]: (05631-02) Passed CLEAN, [168.91.5.15]
<> -> <>,<>>,
Message-ID: <F43351F94CFD274698A8CF7AE51CE00F3E9476 at lafxchng dot laf dot ad dot ivytech dot edu>
, mail_id: OUokavILZ-XV, Hits: -104.249, 5497 ms
Jan 19 14:32:02 postal-b postfix/smtp[4457]: BB3BD92B9:
to=<>, relay=127.0.0.1[127.0.0.1], delay=6,
status=sent (250 2.6.0 Ok, id=056
31-02, from MTA([127.0.0.1]:10025): 250 Ok: queued as 3D18992FA)
Jan 19 14:32:02 postal-b postfix/qmgr[26568]: BB3BD92B9: removed
Jan 19 14:32:02 postal-b postfix/lmtp[30514]: 3D18992FA: to=<recipient at ivytech dot
edu>, relay=/var/imap/socket/lmtp[/var/imap/socket/lmtp], delay=0, status=sent (2
50 2.1.5 Ok)
(The MTA on 127.0.0.1 is amavisd-new.) So gets the message
on LMTP but it ends up in odduser's mailbox:
Return-Path: <>
Received: from postal.ivytech.edu ([unix socket])
by postal-b (Cyrus v2.2.12) with LMTPA;
Thu, 19 Jan 2006 14:32:02 -0500
X-Sieve: CMU Sieve 2.2
Received: from localhost (localhost.localdomain [127.0.0.1])
by postal.ivytech.edu (Postfix) with ESMTP id 3D18992FA;
Thu, 19 Jan 2006 14:32:02 -0500 (EST)
Received: from postal.ivytech.edu ([127.0.0.1])
by localhost (postal.ivytech.edu [127.0.0.1]) (amavisd-new, port 10024)
with ESMTP id 05631-02; Thu, 19 Jan 2006 14:31:56 -0500 (EST)
Received: from frack.centraloffice.ad.ivytech.edu (unknown [168.91.5.15])
by postal.ivytech.edu (Postfix) with SMTP id BB3BD92B9;
Thu, 19 Jan 2006 14:31:56 -0500 (EST)
Received: from lafxchng.laf.ad.ivytech.edu ([172.18.247.233]) by frack.centralof
Thu, 19 Jan 2006 14:31:01 -0500
X-MimeOLE: Produced By Microsoft Exchange V6.5.7226.0
Content-class: urn:content-classes:message
MIME-Version: 1.0
Content-Type: multipart/alternative;
boundary="----_=_NextPart_001_01C61D2E.FF911317"
Subject: CIS 102 Internet Class: NOTICE
Date: Thu, 19 Jan 2006 14:31:51 -0500
Message-ID: <F43351F94CFD274698A8CF7AE51CE00F3E9476 at lafxchng dot laf dot ad dot ivytech dot edu>
X-MS-Has-Attach:
X-MS-TNEF-Correlator:
Thread-Topic: CIS 102 Internet Class: NOTICE
Thread-Index: AcYdLwDZrDpYZYnKTTKWWKwROqLGpg==
From: "Sender" <>
To: <>, <>
X-OriginalArrivalTime: 19 Jan 2006 19:31:01.0272 (UTC) FILETIME=[E1540980:01C61D
X-Virus-Scanned: amavisd-new at postal.ivytech.edu
(We're talking postfix-2.1.5 with "lmtp_cache_connection = no", cyrus 2.2.12) How
can this be? Is there any way to find out what lmtpd's doing with the
transaction?
Thanks,
John
-- John Madden Sr. UNIX Systems Engineer Ivy Tech Community College of Indiana ---- Cyrus Home Page: http://asg.web.cmu.edu/cyrus Cyrus Wiki/FAQ: http://cyruswiki.andrew.cmu.edu List Archives/Info: http://asg.web.cmu.edu/cyrus/mailing-list.html
|
|
|