Timo -
Thanks for helping me out on this!
Timo Sirainen wrote:
On Mon, 2006-01-16 at 16:46 -0700, Mario Nigrovic-rvvk40 wrote:
Dovecot happily makes index files, but then fails to serve some of my subscribed folders!
Do you see them in the mailbox list, or don't you just see mails inside them?
Thunderbird still shows all my folders, but won't show messages for some folders. There does seem to be some correlation with the number of messages in the folders (larger folders don't display contents). It just sits there displaying "opening folder" (or something like that) in the lower left status bar.
Thunderbird is less than helpful in telling me what's going wrong, but dtmail shows that dovecot is reporting "out of sync" and a couple other errors (UID out of sequence), then closing the connection (for those folders). This may happen only after Thunderbird has tried to open the folder that I see these errors with dtmail:
Dovecot ready. [UNSEEN 227] First unseen. [UIDNEXT 341] Predicted next UID
IMAP connection broken (server response) No-op dead stream [CLOSED] No-op dead stream
Doesn't Dovecot's logs say anything? Since this looks like Dovecot closes the connection, and in that case it should have written something to logs..
log_path's log file (/home/mario/dovecot/log) has this, which might be interesting:
dovecot: Jan 23 07:12:04 Warning: imap(rvvk40): Compressing cache file /var/tmp/mario/dovecot/.Freescale.ATIC.SAM/dovecot.index.cache dovecot: Jan 23 07:12:04 Warning: imap(rvvk40): Growing pool 'extensions' with: 512 dovecot: Jan 23 07:12:04 Warning: imap(rvvk40): Growing pool 'extensions' with: 512 dovecot: Jan 23 07:12:04 Error: imap(rvvk40): Sending log messages too fast, throttling.. dovecot: Jan 23 07:12:05 Warning: imap(rvvk40): Growing pool 'extensions' with: 512
(Folder .Freescale.ATIC.SAM is one which hangs on displaying contents.)
info_log_path's log file just has this sort of sequence repeated:
dovecot: Jan 23 07:27:04 Info: imap-login: Login: user=<rvvk40>, method=plain, rip=10.213.160.81, lip=172.16.26.151 dovecot: Jan 23 07:27:04 Info: imap(rvvk40): Effective uid=10019173, gid=21 dovecot: Jan 23 07:27:04 Info: imap(rvvk40): maildir: data=/home/mario/.mail/Maildir:INDEX=/var/tmp/mario/dovecot dovecot: Jan 23 07:27:04 Info: imap(rvvk40): maildir: root=/home/mario/.mail/Maildir, index=/var/tmp/mario/dovecot, control=, inbox=
As a last resort, I've turned indexes off default_mail_env = maildir:%h/.mail/Maildir:INDEX=MEMORY but this makes thunderbird reload all headers every time I open a folder, which takes a very long time.
Thunderbird should be caching the headers locally. If it reloads them completely, it means the message UIDs have changed. That shouldn't be happening.
What about ~/.mail/Maildir/dovecot-uidlist file? It should contain something like:
1 1127056150 5891 31 1059753523.2405.mbox:2,F 32 1059753524.2405.mbox:2,F
The second number in first line (1127056150) is the UIDVALIDITY. Does it keep changing? The rest of the lines contain <UID> <maildir file>. Do their UIDs keep changing?
Hmm. I don't see any such file! Can it be recreated, or maybe restored from backup?
Mario-- I don't need a name; my number's just fine. It's nobody else's -- just mine, all mine.