Very annoying IMAP problem (cyrus + Outlook)

[Denis BUCHER]

Hello everyone,

David Carter a écrit :
> On Fri, 22 Aug 2008, Denis BUCHER wrote:
> 
>> As far as I understand, the cause of the problem is : * "Outlook is 
>> sending either a token or quoted string that is longer than 8K bytes."
> 
> Your problem is a mailbox which contains several thousand messages. 
> Possibly several thousand messages which Outlook hasn't seen previously.
> 
> Outlook tries to construct a single IMAP command of the form:
> 
>  UID FETCH uid,uid,uid,... <some set of fields>
> 
> where the list of UIDs is larger than 8 KBytes in size.

Ok that's what I have :

a) Logs are present
# ls -l /var/lib/imap/log/dbucher
total 2508
-rw------- 1 cyrus mail 355147 Aug 22 14:43 20235
-rw------- 1 cyrus mail   5327 Aug 22 14:43 25058
-rw------- 1 cyrus mail  10654 Aug 22 14:54 25415
-rw------- 1 cyrus mail 355241 Aug 22 15:24 25416
-rw------- 1 cyrus mail 355537 Aug 22 15:03 25417
-rw------- 1 cyrus mail 355147 Aug 22 14:48 25576
-rw------- 1 cyrus mail   5327 Aug 22 14:59 26381
-rw------- 1 cyrus mail   5327 Aug 22 15:04 26763
-rw------- 1 cyrus mail 355443 Aug 22 15:15 26765
-rw------- 1 cyrus mail   5327 Aug 22 15:09 27095
-rw------- 1 cyrus mail   5327 Aug 22 15:14 27752
-rw------- 1 cyrus mail 360146 Aug 22 15:19 28135
-rw------- 1 cyrus mail   5327 Aug 22 15:24 28463
-rw------- 1 cyrus mail   5327 Aug 22 15:29 29125
-rw------- 1 cyrus mail 355147 Aug 22 15:29 29127

b) That's the UID FETCH :
# grep "UID FETCH" *
20235:<1219408982<jbf7 UID FETCH 7136:* (UID FLAGS RFC822.SIZE 
BODY.PEEK[HEADER] INTERNALDATE)
20235:<1219408982<eke2 UID FETCH 1:7135 (UID FLAGS)
25416:<1219411440<kb1u UID FETCH 7136:* (UID FLAGS RFC822.SIZE 
BODY.PEEK[HEADER] INTERNALDATE)
25416:<1219411440<qv47 UID FETCH 1:7135 (UID FLAGS)
25417:<1219409521<1ozq UID FETCH 7136:* (UID FLAGS RFC822.SIZE 
BODY.PEEK[HEADER] INTERNALDATE)
25417:<1219409521<h7ki UID FETCH 1:7135 (UID FLAGS)
25576:<1219409287<ukf6 UID FETCH 7136:* (UID FLAGS RFC822.SIZE 
BODY.PEEK[HEADER] INTERNALDATE)
25576:<1219409287<9vks UID FETCH 1:7135 (UID FLAGS)
26765:<1219410214<y8b2 UID FETCH 7136:* (UID FLAGS RFC822.SIZE 
BODY.PEEK[HEADER] INTERNALDATE)
26765:<1219410214<b685 UID FETCH 1:7135 (UID FLAGS)
28135:<1219411131<7bfi UID FETCH 7136:* (UID FLAGS RFC822.SIZE 
BODY.PEEK[HEADER] INTERNALDATE)
28135:<1219411131<dkkx UID FETCH 1:7135 (UID FLAGS)
29127:<1219411745<4g4y UID FETCH 7136:* (UID FLAGS RFC822.SIZE 
BODY.PEEK[HEADER] INTERNALDATE)
29127:<1219411745<cos6 UID FETCH 1:7135 (UID FLAGS)

c) Most sessions in the logs seem to finish correctly :
...
<1219411787<DONE
ZZZZ LOGOUT
 >1219411787>5mk6 OK Completed
* BYE LOGOUT received
ZZZZ OK Completed

d) But not all :
==> 30887 <==
 >1219413279>91rc OK Completed
<1219413279<6leo IDLE
 >1219413279>+ idling
<1219413343<DONE
 >1219413343>6leo OK Completed
<1219413343<351h UID STORE 7136 +FLAGS (\Deleted \Seen)
 >1219413343>* 7136 FETCH (FLAGS (\Deleted \Seen) UID 7136)
351h OK Completed
<1219413343<dpau IDLE
 >1219413343>+ idling
[end of file]

e) And there are many "Fatal error: word too long" but not with same 
number...
Aug 22 14:43:03 atlantic imaps[25050]: Fatal error: word too long
Aug 22 14:48:08 atlantic imaps[25063]: Fatal error: word too long
Aug 22 14:53:24 atlantic imaps[17518]: Fatal error: word too long
Aug 22 14:58:28 atlantic imaps[26379]: Fatal error: word too long
Aug 22 15:03:34 atlantic imaps[26776]: Fatal error: word too long
Aug 22 15:08:40 atlantic imaps[27118]: Fatal error: word too long
Aug 22 15:13:45 atlantic imaps[27749]: Fatal error: word too long
Aug 22 15:18:51 atlantic imaps[27174]: Fatal error: word too long
Aug 22 15:24:01 atlantic imaps[28464]: Fatal error: word too long
Aug 22 15:29:06 atlantic imaps[29123]: Fatal error: word too long

Normally the watched account having had "Fatal error", I should find a 
fatal error in the transactions logs ? Or is nothing written in case of 
a Fatal error ? (Which I hope not ;-)

Thanks a lot for your help !

Denis