[fetchmail]Problem fetching from IMAP server (fetchmail 6.3.0)
Jason White
jasonjgw@internode.on.net
Fri, 16 Dec 2005 11:51:28 +1100
In trying to debug this, I created a test configuration which is reproduced
below. I have also included the debug output sent to syslog. Fortunately, this
server also supports pop3, which does work correctly with Fetchmail (hence I
will be able to read any replies sent to the list).
Any suggestions would be much appreciated. I don't know enough about Fetchmail
and IMAP to recognize the cause of the problem, other than that there is a
protocol issue causing fetchmail to time out.
Configuration:
# global options
set daemon 60
set syslog
# Server options (mail.internode.on.net)
poll "mail.internode.on.net"
protocol imap
timeout 30
# User options (internode.on.net)
username jasonjgw is jason here
password secret
fetchall
>From syslog:
Dec 16 11:10:39 jdc fetchmail[5210]: 6.3.0 querying mail.internode.on.net (protocol IMAP) at Fri Dec 16 11:10:39 2005: poll started
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP< * OK internode.on.net bld-mail06 Ready
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP> A0001 CAPABILITY
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP< * CAPABILITY IMAP4 IMAP4REV1 NAMESPACE QUOTA UIDPLUS IDLE XFLDDATA SURGEMAIL
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP< A0001 OK CAPABILITY completed
Dec 16 11:10:39 jdc fetchmail[5210]: Protocol identified as IMAP4 rev 1
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP> A0002 LOGIN "jasonjgw" *
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP< A0002 OK LOGIN completed
Dec 16 11:10:39 jdc fetchmail[5210]: selecting or re-polling default folder
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP> A0003 SELECT "INBOX"
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP< * 1 EXISTS
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP< * 0 RECENT
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP< * OK [UIDVALIDITY 1134522857] UIDs valid
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP< * FLAGS (\Answered \Flagged \Deleted \Draft \Seen)
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP< * OK [PERMANENTFLAGS (\Answered \Flagged \Deleted \Draft \Seen)] Limited
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP< A0003 OK [READ-WRITE] SELECT completed
Dec 16 11:10:39 jdc fetchmail[5210]: 1 message waiting after first poll
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP> A0004 EXPUNGE
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP< A0004 OK EXPUNGE completed
Dec 16 11:10:39 jdc fetchmail[5210]: 1 message waiting after expunge
Dec 16 11:10:39 jdc fetchmail[5210]: 1 message for jasonjgw at mail.internode.on.net.
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP> A0005 FETCH 1 RFC822.SIZE
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP< * 1 FETCH (UID 14 RFC822.SIZE 1451)
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP< A0005 OK FETCH completed
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP> A0006 FETCH 1 RFC822.HEADER
Dec 16 11:10:39 jdc fetchmail[5210]: IMAP< * 1 FETCH (UID 14 RFC822.HEADER {1326}
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< Received: from beatrice.nipl.net (unverified [62.94.93.142])
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< ^Iby mail.internode.on.net (SurgeMail 3.2f) with ESMTP id 191498830
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< ^Ifor <jasonjgw@internode.on.net>; Fri, 16 Dec 2005 10:35:44 +1030 (CDT)
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< Return-Path: <jason@nipl.net>
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< Received: from localhost (localhost.localdomain [127.0.0.1])
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< ^Iby beatrice.nipl.net (Postfix) with ESMTP id 1C0CCE8624
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< ^Ifor <jasonjgw@internode.on.net>; Fri, 16 Dec 2005 00:05:40 +0000 (UTC)
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< Received: from beatrice.nipl.net ([127.0.0.1])
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< ^Iby localhost (beatrice.nipl.net [127.0.0.1]) (amavisd-new, port 10024)
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< ^Iwith ESMTP id 20091-12 for <jasonjgw@internode.on.net>;
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< ^IFri, 16 Dec 2005 00:05:33 +0000 (UTC)
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< Received: by beatrice.nipl.net (Postfix, from userid 1010)
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< ^Iid 7B629E8644; Fri, 16 Dec 2005 00:05:32 +0000 (UTC)
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< Date: Fri, 16 Dec 2005 11:05:31 +1100
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< From: Jason White <jason@nipl.net>
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< To: jasonjgw@internode.on.net
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< Subject: Test message
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< Message-ID: <20051216000531.GA21451@nipl.net>
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< Mime-Version: 1.0
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< Content-Type: text/plain; charset=us-ascii
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< Content-Disposition: inline
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< User-Agent: Mutt/1.5.9i
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< X-Virus-Scanned: by amavisd-new-20030616-p10 (Debian) at nipl.net
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< X-Rcpt-To: <jasonjgw@internode.on.net>
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< X-Vpipe: Scanner said clean (/usr/local/clamav/sbin/vscand-clamav)
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< X-NotAscii: charset=us-ascii
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< X-IP-stats: No info recorded yet
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< X-External-IP: 62.94.93.142
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP<
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< )
Dec 16 11:10:40 jdc fetchmail[5210]: IMAP< A0006 OK FETCH completed
Dec 16 11:11:10 jdc fetchmail[5210]: timeout after 30 seconds waiting for server mail.internode.on.net.
Dec 16 11:11:10 jdc fetchmail[5210]: socket error while fetching from jasonjgw@mail.internode.on.net
Dec 16 11:11:10 jdc fetchmail[5210]: 6.3.0 querying mail.internode.on.net (protocol IMAP) at Fri Dec 16 11:11:10 2005: poll completed
Dec 16 11:11:10 jdc fetchmail[5210]: Query status=2 (SOCKET)
Dec 16 11:11:10 jdc fetchmail[5210]: Deleting fetchids file.
Dec 16 11:11:10 jdc fetchmail[5210]: sleeping at Fri Dec 16 11:11:10 2005