[pkg-fetchmail-maint] Bug#186739: marked as done (SSL-POP3 closes connection when feeding to local SMTP takes too long -> fetchmail dies with signal 13)

Debian Bug Tracking System owner at bugs.debian.org
Sun Jul 31 10:18:06 UTC 2005


Your message dated Sun, 31 Jul 2005 10:43:13 +0200
with message-id <42EC8F21.3040206 at RWTH-Aachen.DE>
and subject line Can't reproduce
has caused the attached Bug report to be marked as done.

This means that you claim that the problem has been dealt with.
If this is not the case it is now your responsibility to reopen the
Bug report if necessary, and/or fix the problem forthwith.

(NB: If you are a system administrator and have no idea what I am
talking about this indicates a serious mail system misconfiguration
somewhere.  Please contact me immediately.)

Debian bug tracking system administrator
(administrator, Debian Bugs database)

--------------------------------------
Received: (at submit) by bugs.debian.org; 29 Mar 2003 14:38:35 +0000
>From rabe at adsl-bergs.rz.rwth-aachen.de Sat Mar 29 08:38:34 2003
Return-path: <rabe at adsl-bergs.rz.rwth-aachen.de>
Received: from adsl-bergs.rz.rwth-aachen.de [137.226.80.218] 
	by master.debian.org with esmtp (Exim 3.12 1 (Debian))
	id 18zHTd-0007ZO-00; Sat, 29 Mar 2003 08:38:33 -0600
Received: from rabe by ADSL-Bergs.RZ.RWTH-Aachen.DE with local (Exim 4.10)
	id 18zHTb-0000jv-00; Sat, 29 Mar 2003 15:38:31 +0100
From: "Ralf G. R. Bergs" <rabe at RWTH-Aachen.DE>
To: Debian Bug Tracking System <submit at bugs.debian.org>
Subject: SSL-POP3 closes connection when feeding to local SMTP takes too long -> fetchmail dies with signal 13
X-Mailer: reportbug 1.50
Date: Sat, 29 Mar 2003 15:38:31 +0100
Message-Id: <E18zHTb-0000jv-00 at ADSL-Bergs.RZ.RWTH-Aachen.DE>
Delivered-To: submit at bugs.debian.org
X-Spam-Status: No, hits=-0.5 required=4.0
	tests=HAS_PACKAGE,SPAM_PHRASE_01_02
	version=2.44
X-Spam-Level: 

Package: fetchmail-ssl
Version: 5.9.11-6.2
Severity: important

I'm running SpamAssassin on my local machine. It's invoked using sa-exim
during SMTP time (i.e. before my local Exim has accepted the message
so that it can bounce it during the SMTP phase in case it's spam.)

Since a week or so I have one host that I poll via POP3-over-SSL. Sometimes
(for reasons I can't find out) the SpamAssassin "spamd" process takes
"forever" to complete, so I've written a small cron job that kills Exim
processes that are running since more than 15 minutes wall time. Whenever
this happens while fetchmail is trying to feed a message it has just
fetched from the SSL-POP3 server fetchmail dies with the following
message (longer syslog snippet follows):

============================= 8x ===========================
Mar 29 05:20:11 Server fetchmail[25165]: awakened at Sat Mar 29 05:20:11 2003 
Mar 29 05:20:17 Server fetchmail[25165]: 5.9.11 querying MailServer (protocol POP3) at Sat Mar 29 05:20:17 2003: poll started 
Mar 29 05:20:17 Server fetchmail[25165]: Issuer Organization: <Issuer's Organization> 
Mar 29 05:20:17 Server fetchmail[25165]: Issuer CommonName: <Issuer's CommonName> 
Mar 29 05:20:17 Server fetchmail[25165]: Server CommonName: <Server's CommonName> 
Mar 29 05:20:17 Server fetchmail[25165]: Server CommonName mismatch: my.domain != mailhost.my.domain 
Mar 29 05:20:17 Server fetchmail[25165]: Server key fingerprint: 00:01:02:03:04:05:06:07:08:09:0a:0b:0c:0d:0e:0f 
Mar 29 05:20:17 Server fetchmail[25165]: Warning: server certificate verification: unable to get local issuer certificate 
Mar 29 05:20:17 Server fetchmail[25165]: Issuer Organization: <Issuer's Organization> 
Mar 29 05:20:17 Server fetchmail[25165]: Issuer CommonName: <Issuer's CommonName> 
Mar 29 05:20:17 Server fetchmail[25165]: Server CommonName: <Server's CommonName> 
Mar 29 05:20:17 Server fetchmail[25165]: Server CommonName mismatch: my.domain != mailhost.my.domain 
Mar 29 05:20:17 Server fetchmail[25165]: Warning: server certificate verification: certificate not trusted 
Mar 29 05:20:17 Server fetchmail[25165]: Issuer Organization: <Issuer's Organization> 
Mar 29 05:20:17 Server fetchmail[25165]: Issuer CommonName: <Issuer's CommonName> 
Mar 29 05:20:17 Server fetchmail[25165]: Server CommonName: <Server's CommonName> 
Mar 29 05:20:17 Server fetchmail[25165]: Server CommonName mismatch: my.domain != mailhost.my.domain 
Mar 29 05:20:17 Server fetchmail[25165]: Warning: server certificate verification: unable to verify the first certificate 
Mar 29 05:20:17 Server fetchmail[25165]: POP3< +OK ready <32674.1048911625 at our.pop3.server> 
Mar 29 05:20:17 Server fetchmail[25165]: POP3> CAPA 
Mar 29 05:20:18 Server fetchmail[25165]: POP3< +OK Capability list follows 
Mar 29 05:20:18 Server fetchmail[25165]: POP3< TOP 
Mar 29 05:20:18 Server fetchmail[25165]: POP3< USER 
Mar 29 05:20:18 Server fetchmail[25165]: POP3< LOGIN-DELAY 0 
Mar 29 05:20:18 Server fetchmail[25165]: POP3< EXPIRE 0 
Mar 29 05:20:18 Server fetchmail[25165]: POP3< UIDL 
Mar 29 05:20:18 Server fetchmail[25165]: POP3< RESP-CODES 
Mar 29 05:20:18 Server fetchmail[25165]: POP3< AUTH-RESP-CODE 
Mar 29 05:20:18 Server fetchmail[25165]: POP3< X-MANGLE 
Mar 29 05:20:18 Server fetchmail[25165]: POP3< X-MACRO 
Mar 29 05:20:18 Server fetchmail[25165]: POP3< X-LOCALTIME Sat, 29 Mar 2003 05:20:25 +0100 
Mar 29 05:20:18 Server fetchmail[25165]: POP3< . 
Mar 29 05:20:18 Server fetchmail[25165]: POP3> USER username 
Mar 29 05:20:18 Server fetchmail[25165]: POP3< +OK Password required for username. 
Mar 29 05:20:18 Server fetchmail[25165]: POP3> PASS  
Mar 29 05:20:18 Server fetchmail[25165]: POP3< +OK username has 1 visible message (0 hidden) in 14233 octets. 
Mar 29 05:20:21 Server fetchmail[25165]: POP3> STAT 
Mar 29 05:20:21 Server fetchmail[25165]: POP3< +OK 1 14233 
Mar 29 05:20:21 Server fetchmail[25165]: 1 message for username at our.pop3.server (14233 octets). 
Mar 29 05:20:21 Server fetchmail[25165]: POP3> LIST 
Mar 29 05:20:21 Server fetchmail[25165]: POP3< +OK 1 visible messages (14233 octets) 
Mar 29 05:20:21 Server fetchmail[25165]: POP3< 1 14233 
Mar 29 05:20:21 Server fetchmail[25165]: POP3< . 
Mar 29 05:20:21 Server fetchmail[25165]: POP3> RETR 1 
Mar 29 05:20:21 Server fetchmail[25165]: POP3< +OK 14233 octets 
Mar 29 05:20:21 Server fetchmail[25165]: reading message username at our.pop3.server:1 of 1 (14233 octets)
Mar 29 05:20:21 Server fetchmail[25165]: SMTP< 220 my.own.host ESMTP 
Mar 29 05:20:21 Server fetchmail[25165]: SMTP> EHLO our.pop3.server 
Mar 29 05:20:21 Server fetchmail[25165]: SMTP< 250-my.own.host Hello localhost [127.0.0.1] 
Mar 29 05:20:21 Server fetchmail[25165]: SMTP< 250-SIZE 8388608 
Mar 29 05:20:21 Server fetchmail[25165]: SMTP< 250-PIPELINING 
Mar 29 05:20:21 Server fetchmail[25165]: SMTP< 250 HELP 
Mar 29 05:20:21 Server fetchmail[25165]: SMTP> MAIL FROM:<the at spammer.net> SIZE=14233 
Mar 29 05:20:21 Server fetchmail[25165]: SMTP< 250 OK 
Mar 29 05:20:21 Server fetchmail[25165]: SMTP> RCPT TO:<username at localhost>
[time passes] 
Mar 29 05:40:01 Server fetchmail[25165]: SMTP< 421 my.own.host: Service not available - closing connection 
Mar 29 05:40:01 Server fetchmail[25165]: SMTP error: 421 my.own.host: Service not available - closing connection 
Mar 29 05:40:01 Server fetchmail[25165]: SMTP listener doesn't like recipient address username at localhost'
Mar 29 05:40:01 Server fetchmail[25165]: SMTP< 220 my.own.host ESMTP 
Mar 29 05:40:01 Server fetchmail[25165]: SMTP> HELO localhost 
Mar 29 05:40:01 Server fetchmail[25165]: SMTP< 250 my.own.host Hello localhost [127.0.0.1] 
Mar 29 05:40:02 Server fetchmail[25165]: SMTP> MAIL FROM:<FETCHMAIL-DAEMON at internal.non-public.host.name>
Mar 29 05:40:02 Server fetchmail[25165]: SMTP< 250 OK 
Mar 29 05:40:02 Server fetchmail[25165]: SMTP> RCPT TO:<fetchmail> 
Mar 29 05:40:02 Server fetchmail[25165]: SMTP< 250 Accepted 
Mar 29 05:40:02 Server fetchmail[25165]: SMTP> DATA 
Mar 29 05:40:02 Server fetchmail[25165]: SMTP< 354 Enter message, ending with "." on a line by itself 
Mar 29 05:40:02 Server fetchmail[25165]: SMTP: (bounce-message body) 
Mar 29 05:40:02 Server fetchmail[25165]: SMTP>. (EOM) 
Mar 29 05:40:03 Server fetchmail[25165]: SMTP< 250 OK id=18z88Q-0006Zh-00 
Mar 29 05:40:03 Server fetchmail[25165]: SMTP> QUIT 
Mar 29 05:40:03 Server fetchmail[25165]: SMTP< 221 my.own.host closing connection 
Mar 29 05:40:03 Server fetchmail[25165]: SMTP> RSET 
Mar 29 05:40:03 Server fetchmail[25165]:  not flushed 
Mar 29 05:40:03 Server fetchmail[25165]: POP3> QUIT 
Mar 29 05:40:03 Server fetchmail[25165]: POP3< -ERR POP timeout from our.pop3.server 
Mar 29 05:40:03 Server fetchmail[25165]: POP timeout from our.pop3.server 
Mar 29 05:40:03 Server fetchmail[25165]: 5.9.11 querying MailServer (protocol POP3) at Sat Mar 29 05:40:03 2003: poll completed
Mar 29 05:40:03 Server fetchmail[25165]: Query status=4 (PROTOCOL) 
Mar 29 05:40:03 Server fetchmail[25165]: terminated with signal 13 
============================= 8x ===========================

Note that the SSL connection IS established altho there is a problem
with certificate trust (which I don't bother about since I'm not too
paranoid; I know that all is fine with the server :-)

I'm seeing these crashes ONLY since I started polling the one host
using SSL. Before that I've NEVER seen this, and I'm running fetchmail
since years.


-- System Information
Debian Release: 3.0
Architecture: i386
Kernel: Linux Server 2.4.19-xfs #1 Sat Nov 23 17:19:23 CET 2002 i586
Locale: LANG=C, LC_CTYPE=C

Versions of packages fetchmail-ssl depends on:
ii  fetchmail-common        5.9.11-6.2       POP3, APOP, IMAP mail gatherer/for
ii  libc6                   2.2.5-11.2       GNU C Library: Shared libraries an
ii  libssl0.9.6             0.9.6g-0.woody.1 SSL shared libraries


---------------------------------------
Received: (at 186739-done) by bugs.debian.org; 31 Jul 2005 08:43:17 +0000
>From rabe at rwth-aachen.de Sun Jul 31 01:43:17 2005
Return-path: <rabe at rwth-aachen.de>
Received: from hetzner.ber.gs (Mail.Ber.gs) [213.133.111.72] 
	by spohr.debian.org with esmtp (Exim 3.36 1 (Debian))
	id 1Dz9Ph-00054U-00; Sun, 31 Jul 2005 01:43:17 -0700
Received: from localhost ([127.0.0.1]:53109)
	by Mail.Ber.gs (port 10025) with esmtp (Exim 4.42)
	id 1Dz9Pe-0006Ie-R2
	for 186739-done at bugs.debian.org; Sun, 31 Jul 2005 10:43:14 +0200
Received: from Mail.Ber.gs ([127.0.0.1])
	by localhost (Hetzner.Ber.gs [127.0.0.1]) (amavisd-new, port 10024)
	with ESMTP id 23729-02 for <186739-done at bugs.debian.org>;
	Sun, 31 Jul 2005 10:43:13 +0200 (CEST)
Received: from dsl-213-023-251-163.arcor-ip.net ([213.23.251.163]:59335 helo=[192.168.2.2])
	by Mail.Ber.gs (port 25) with esmtpsa (TLSv1:AES256-SHA:256)
	(Exim 4.42)
	id 1Dz9Pd-0006IW-Q5
	for 186739-done at bugs.debian.org; Sun, 31 Jul 2005 10:43:13 +0200
Message-ID: <42EC8F21.3040206 at RWTH-Aachen.DE>
Date: Sun, 31 Jul 2005 10:43:13 +0200
From: "Ralf G. R. Bergs" <rabe at RWTH-Aachen.DE>
User-Agent: Mozilla Thunderbird 1.0.6 (Windows/20050716)
X-Accept-Language: en-us, en
MIME-Version: 1.0
To: 186739-done at bugs.debian.org
Subject: Can't reproduce
X-Enigmail-Version: 0.92.0.0
Content-Type: text/plain; charset=ISO-8859-15
Content-Transfer-Encoding: 7bit
X-Virus-Scanned: by amavisd-new-20030616-p10 (Debian) at Mail.Ber.gs
Delivered-To: 186739-done at bugs.debian.org
X-Spam-Checker-Version: SpamAssassin 2.60-bugs.debian.org_2005_01_02 
	(1.212-2003-09-23-exp) on spohr.debian.org
X-Spam-Level: 
X-Spam-Status: No, hits=-3.0 required=4.0 tests=BAYES_00 autolearn=no 
	version=2.60-bugs.debian.org_2005_01_02

I'm sorry but I no longer have the means of rebuilding the scenario from
out of my original report -- it's more than 2 years ago since then... :-)




More information about the pkg-fetchmail-maint mailing list