ipop3d and UID N less than M
Hi,
I have a strange problem with the uw-imap ipop3d daemon. Yesterday four
users told me indepently that they've gotten duplicate mails. I asked
them how many mails they've gotten doubled and when that strange
behaviour started.
One of them answered that it started around 17:00. This is about the
same time when I noticed the following log entries:
Oct 25 08:48:41 zuse ipop3d[19125]: Message 4 UID 0 less than 4926
Oct 27 17:02:03 zuse ipop3d[27988]: Message 7 UID 32 less than 14107
Oct 27 17:02:08 zuse ipop3d[28012]: Message 124 UID 32 less than 146
Oct 27 17:02:22 zuse ipop3d[28255]: Message 196 UID 32 less than 3908
Oct 27 17:02:54 zuse ipop3d[28640]: Message 25 UID 32 less than 9984
Oct 27 17:02:54 zuse ipop3d[28578]: Message 425 UID 32 less than 2270
Oct 27 17:04:14 zuse ipop3d[28951]: Message 129 UID 32 less than 9912
Oct 27 17:04:26 zuse ipop3d[29009]: Message 427 UID 32 less than 427
Oct 27 17:06:03 zuse ipop3d[29343]: Message 2695 UID 32 less than 8961
Oct 27 17:06:12 zuse ipop3d[29401]: Message 660 UID 32 less than 3135
Oct 27 17:06:26 zuse ipop3d[29458]: Message 325 UID 32 less than 18611
Oct 27 17:06:49 zuse ipop3d[29485]: Message 523 UID 32 less than 43890
Oct 27 17:23:17 zuse ipop3d[31933]: Message 2084 UID 32 less than 2084
Oct 27 17:23:52 zuse ipop3d[32119]: Message 5 UID 32 less than 4110
Oct 27 17:33:07 zuse ipop3d[898]: Message 4 UID 32 less than 7412
Oct 27 18:05:50 zuse ipop3d[5562]: Message 2 UID 32 less than 5630
Oct 27 18:06:35 zuse ipop3d[5750]: Message 2 UID 32 less than 9098
Oct 27 20:20:38 zuse ipop3d[21608]: Message 12 UID 32 less than 12667
Oct 27 20:26:41 zuse ipop3d[22461]: Message 1586 UID 32 less than 28339
Oct 28 06:39:04 zuse ipop3d[14223]: Message 323 UID 32 less than 29023
Oct 28 06:55:35 zuse ipop3d[15684]: Message 2 UID 32 less than 3362
Oct 28 07:37:09 zuse ipop3d[19740]: Message 3 UID 32 less than 2813
Oct 28 07:42:09 zuse ipop3d[20356]: Message 4 UID 32 less than 3526
Oct 28 07:47:56 zuse ipop3d[21078]: Message 3 UID 32 less than 6210
Oct 28 07:57:20 zuse ipop3d[22515]: Message 331 UID 32 less than 331
Oct 28 09:24:04 zuse ipop3d[3396]: Message 186 UID 32 less than 187
Oct 28 09:30:48 zuse ipop3d[4640]: Message 20 UID 32 less than 5723
Oct 28 09:37:48 zuse ipop3d[5901]: Message 12 UID 32 less than 9318
Oct 28 10:03:01 zuse ipop3d[11465]: Message 2 UID 32 less than 17721
Oct 28 10:29:19 zuse ipop3d[16774]: Message 3 UID 32 less than 13953
Oct 28 10:30:47 zuse ipop3d[17217]: Message 2 UID 32 less than 8010
You can see that they appear cumulatively around 17:00. And there were
never that much of this kind before. The FAQ from uw-imap calls these
log messages harmless
( http://www.washington.edu/imap/IMAP-FAQs/index.html#7.14 ) but I am
not sure if this can still be called harmless.
My question is what circumstances can bring ipopd to suddenly behave
this way? Could it be users popping their mailbox too often? File
system corruption? Has anybody else experienced such a behaviour?
My system is Debian woody, ipopd-ssl version 2001adebian-6.
Kind regards,
Timo
Reply to: