Hi,
I've got a problem with cyrus getting slower over time when checking
mail, up to a point where clients start timing out...
I'm using cyrus 2.1.18-1
with Debian Sarge powerpc
on an Apple iMac 400mhz G3.
As clients I use squirrelmail an Apple's Mail.app.
First cyrus works flawlessly, then it starts responding slower to
mailchecking and eventually becomes unusable. (Squirrelmail is no
longer able to show folder contents or update the frame with folders,
Mail times out and takes the mailbox offline)
After some hours, the problem disappears by itself, so it seems
something simply times out after a while, I just can't see what that
might be.
What I find most strange is that restarting cyrus doesn't solve the
problem immediately, only rebooting the server helps.
Below I've placed some snippets from my mail.log. What could be
causing this and where else could I look for more clues?
== Logfiles:==
I've been looking at top and tailing logfiles.
In top I can see cyrus's processes being spawned and sitting idle for
a long time before taking processor time and exiting.
#In mail.log I can see the a normal mailcheck at the start like this:
<snip>
Aug 24 22:36:50 mrgreen cyrus/master[9405]: about to exec /usr/lib/
cyrus/bin/imapd
Aug 24 22:36:50 mrgreen cyrus/imap[9405]: executed
Aug 24 22:36:50 mrgreen cyrus/imapd[9405]: accepted connection
Aug 24 22:36:50 mrgreen cyrus/imapd[9405]: login: oneword.demon.nl
[82.161.85.66] oneman CRAM-MD5 User logged in
Aug 24 22:36:50 mrgreen cyrus/imapd[9405]: seen_db: user oneman
opened /var/lib/cyrus/user/o/oneman.seen
<snip>
#or sometimes it checks all folders like below:
<snip>
Aug 24 22:07:55 mrgreen cyrus/imapd[9345]: open: user oneman opened
INBOX
Aug 24 22:07:55 mrgreen cyrus/imapd[9346]: accepted connection
Aug 24 22:07:55 mrgreen cyrus/imapd[9346]: login: oneword.demon.nl
[82.161.85.66] oneman CRAM-MD5 User logged in
Aug 24 22:07:55 mrgreen cyrus/imapd[9346]: open: user oneman opened
INBOX.Bedrijven
Aug 24 22:07:55 mrgreen cyrus/imapd[9345]: open: user oneman opened
INBOX.Diversen
Aug 24 22:07:55 mrgreen cyrus/imapd[9346]: open: user oneman opened
INBOX.Faculteit Wijsbegeerte
Aug 24 22:07:55 mrgreen cyrus/imapd[9345]: open: user oneman opened
INBOX.Lists
Aug 24 22:07:55 mrgreen cyrus/imapd[9346]: open: user oneman opened
INBOX.logcheck
Aug 24 22:07:55 mrgreen cyrus/imapd[9345]: open: user oneman opened
INBOX.Site &- list registraties
Aug 24 22:07:55 mrgreen cyrus/imapd[9346]: open: user oneman opened
INBOX.Software registraties
Aug 24 22:07:55 mrgreen cyrus/imapd[9345]: open: user oneman opened
INBOX.TidBits
Aug 24 22:07:55 mrgreen cyrus/imapd[9346]: open: user oneman opened
INBOX.Vrienden &- familie
Aug 24 22:07:55 mrgreen cyrus/imapd[9345]: open: user oneman opened
INBOX.Drafts
Aug 24 22:07:55 mrgreen cyrus/imapd[9346]: open: user oneman opened
INBOX.Sent
Aug 24 22:07:55 mrgreen cyrus/imapd[9345]: open: user oneman opened
INBOX.Trash
Aug 24 22:07:55 mrgreen cyrus/imapd[9347]: accepted connection
Aug 24 22:07:55 mrgreen cyrus/imapd[9347]: login: oneword.demon.nl
[82.161.85.66] oneman CRAM-MD5 User logged in
Aug 24 22:07:55 mrgreen cyrus/imapd[9347]: open: user oneman opened
INBOX.Junk
Aug 24 22:07:56 mrgreen cyrus/master[9348]: about to exec /usr/lib/
cyrus/bin/imapd
Aug 24 22:07:56 mrgreen cyrus/imap[9348]: executed
Aug 24 22:07:56 mrgreen cyrus/imapd[9348]: accepted connection
Aug 24 22:07:56 mrgreen cyrus/imapd[9348]: login: oneword.demon.nl
[82.161.85.66] oneman CRAM-MD5 User logged in
Aug 24 22:07:56 mrgreen cyrus/imapd[9348]: seen_db: user oneman
opened /var/lib/cyrus/user/o/oneman.seen
Aug 24 22:07:56 mrgreen cyrus/imapd[9348]: open: user oneman opened
INBOX.Vrienden &- familie.Barbara
Aug 24 22:07:56 mrgreen cyrus/imapd[9347]: open: user oneman opened
INBOX.Vrienden &- familie.Brieven-alg
Aug 24 22:07:56 mrgreen cyrus/imapd[9348]: open: user oneman opened
INBOX.Vrienden &- familie.Frank Lommers
Aug 24 22:07:56 mrgreen cyrus/imapd[9347]: open: user oneman opened
INBOX.Vrienden &- familie.Geert
Aug 24 22:07:56 mrgreen cyrus/imapd[9348]: open: user oneman opened
INBOX.Vrienden &- familie.Jawad
Aug 24 22:07:56 mrgreen cyrus/imapd[9347]: open: user oneman opened
INBOX.Vrienden &- familie.Lau
Aug 24 22:07:56 mrgreen cyrus/imapd[9348]: open: user oneman opened
INBOX.Vrienden &- familie.Monique
Aug 24 22:07:56 mrgreen cyrus/imapd[9347]: open: user oneman opened
INBOX.Vrienden &- familie.Pam
Aug 24 22:07:56 mrgreen cyrus/imapd[9348]: open: user oneman opened
INBOX.Vrienden &- familie.Teun &- Stuff
Aug 24 22:07:56 mrgreen cyrus/imapd[9347]: open: user oneman opened
INBOX.Lists.Cyrus
Aug 24 22:07:56 mrgreen cyrus/imapd[9348]: open: user oneman opened
INBOX.Lists.Debian
Aug 24 22:07:57 mrgreen cyrus/imapd[9347]: open: user oneman opened
INBOX.Lists.Debian.Bewaard
Aug 24 22:07:57 mrgreen cyrus/imapd[9348]: skiplist: checkpointed /
var/lib/cyrus/user/o/oneman.seen (35 records, 2696 bytes)$
Aug 24 22:07:57 mrgreen cyrus/imapd[9348]: open: user oneman opened
INBOX.Diversen.Bestellingen
Aug 24 22:07:57 mrgreen cyrus/imapd[9347]: open: user oneman opened
INBOX.Diversen.Fanmail
Aug 24 22:07:57 mrgreen cyrus/imapd[9348]: open: user oneman opened
INBOX.Bedrijven.Apple
Aug 24 22:07:57 mrgreen cyrus/imapd[9347]: open: user oneman opened
INBOX.Bedrijven.Demon
Aug 24 22:07:57 mrgreen cyrus/imapd[9348]: open: user oneman opened
INBOX.Bedrijven.Domains
Aug 24 22:07:57 mrgreen cyrus/imapd[9347]: open: user oneman opened
INBOX.Bedrijven.KPN
Aug 24 22:07:57 mrgreen cyrus/imapd[9348]: open: user oneman opened
INBOX.Bedrijven.Mijn Postbank
Aug 24 22:07:57 mrgreen cyrus/imapd[9347]: open: user oneman opened
INBOX.Bedrijven.Wirelesscircle
<snip>
#after some time of use (reading and checking mail) is goes like
this, you can see time passing by and all processes exit without
results:
Aug 24 21:15:35 mrgreen cyrus/imapd[8572]: open: user oneman opened
INBOX
Aug 24 21:15:35 mrgreen cyrus/master[8582]: about to exec /usr/lib/
cyrus/bin/imapd
Aug 24 21:15:35 mrgreen cyrus/imap[8582]: executed
Aug 24 21:15:35 mrgreen cyrus/imapd[8582]: accepted connection
Aug 24 21:16:37 mrgreen cyrus/master[1924]: process 8581 exited,
status 0
Aug 24 21:17:35 mrgreen cyrus/master[1924]: process 8572 exited,
status 0
Aug 24 21:17:35 mrgreen cyrus/master[1924]: process 8568 exited,
status 0
Aug 24 21:17:35 mrgreen cyrus/master[1924]: process 8574 exited,
status 0
Aug 24 21:17:35 mrgreen cyrus/master[1924]: process 8582 exited,
status 0
#Or it gets to the first few folders and then stops:
Aug 24 21:18:48 mrgreen cyrus/master[8585]: about to exec /usr/lib/
cyrus/bin/imapd
Aug 24 21:18:48 mrgreen cyrus/imap[8585]: executed
Aug 24 21:18:48 mrgreen cyrus/imapd[8585]: accepted connection
Aug 24 21:19:48 mrgreen cyrus/master[8586]: about to exec /usr/lib/
cyrus/bin/imapd
Aug 24 21:19:48 mrgreen cyrus/imap[8586]: executed
Aug 24 21:19:48 mrgreen cyrus/imapd[8586]: accepted connection
Aug 24 21:20:48 mrgreen cyrus/master[8587]: about to exec /usr/lib/
cyrus/bin/imapd
Aug 24 21:20:48 mrgreen cyrus/imap[8587]: executed
Aug 24 21:20:48 mrgreen cyrus/imapd[8587]: accepted connection
Aug 24 21:21:48 mrgreen cyrus/master[8588]: about to exec /usr/lib/
cyrus/bin/imapd
Aug 24 21:21:48 mrgreen cyrus/imap[8588]: executed
Aug 24 21:21:48 mrgreen cyrus/imapd[8588]: accepted connection
Aug 24 21:21:48 mrgreen cyrus/imapd[8588]: accepted connection
Aug 24 21:22:27 mrgreen cyrus/imapd[8588]: login: oneword.demon.nl
[82.161.85.66] oneman CRAM-MD5 User logged in
Aug 24 21:22:27 mrgreen cyrus/imapd[8588]: seen_db: user oneman
opened /var/lib/cyrus/user/o/oneman.seen
Aug 24 21:22:27 mrgreen cyrus/imapd[8588]: open: user oneman opened
INBOX
Aug 24 21:22:28 mrgreen cyrus/imapd[8587]: accepted connection
Aug 24 21:22:28 mrgreen cyrus/imapd[8587]: login: oneword.demon.nl
[82.161.85.66] oneman CRAM-MD5 User logged in
Aug 24 21:22:28 mrgreen cyrus/imapd[8587]: seen_db: user oneman
opened /var/lib/cyrus/user/o/oneman.seen
Aug 24 21:22:28 mrgreen cyrus/imapd[8587]: open: user oneman opened
INBOX.Junk
Aug 24 21:22:28 mrgreen cyrus/imapd[8587]: open: user oneman opened
INBOX.Bedrijven
Aug 24 21:22:28 mrgreen cyrus/imapd[8586]: accepted connection
Aug 24 21:23:27 mrgreen cyrus/master[1924]: process 8585 exited,
status 0
Aug 24 21:24:28 mrgreen cyrus/master[1924]: process 8587 exited,
status 0
Aug 24 21:24:28 mrgreen cyrus/master[1924]: process 8588 exited,
status 0
I'm at a loss for where to look further.
TIA,
Peter Teunissen
Linux user nr. 389180
-- Never argue with idiots; they'll drag you down to their own level
and beat you on experience.
-----BEGIN GEEK CODE BLOCK-----
Version 3.12
GFA/P/IT$ d+(++) s: a C++$>+++$ UB/L+>++++$ P L++ !E W++
N- o? K? w$>!w !O M+(++) V? PS++ PE- Y+ PGP- t 5?
X- !R !tv b++(+++) DI++++ D+ G>++ e++ h--- r+++ y+++
------END GEEK CODE BLOCK------
----
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
