[26881] in Athena Bugs

home help back first fref pref prev next nref lref last post

Re: sun4 9.4.27: mitmailscan \* is unreliable

daemon@ATHENA.MIT.EDU (Mitchell E Berger)
Wed Jul 5 18:20:09 2006

Message-Id: <200607052219.k65MJqBH010753@byte-me.mit.edu>
To: John Hawkinson <jhawk@mit.edu>
In-Reply-To: Your message of "Wed, 05 Jul 2006 17:58:57 EDT."
	<200607052158.k65LwvVI001784@bart-savagewood.mit.edu> 
Date: Wed, 05 Jul 2006 18:19:52 -0400
From: Mitchell E Berger <mitchb@mit.edu>
X-Spam-Score: 3.548
X-Spam-Level: *** (3.548)
X-Spam-Flag: NO
Cc: bugs@mit.edu
Errors-To: bugs-bounces@mit.edu

I've managed to reproduce part of jhawk's results (about 2/3 of the time,
it shows me my last message, and about 1/3 of the time, it gives me no
messages).  Watching zephyr while doing this indicates that it doesn't appear
to be an interaction with delivery of mail while scanning (I got no zephyrs
for either my INBOX or INBOX.Spamscreen while doing this).  Here is the debug
output for a successful and errant run of 'mitmailscan \*':

athena% mitmailscan --debug \*
Send(EXAMINE %s, INBOX) ...
In number callback: keyword EXISTS, number 2
Response: status OK, text [READ-ONLY] Completed
Send(UID SEARCH %a, ALL *) ...
In SEARCH callback: text 148266
Response: status OK, text Completed (1 msgs in 0.000 secs)
Send(UID FETCH %a (%a), 148266, FLAGS BODY.PEEK[HEADER.FIELDS (FROM SUBJECT DATE)]) ...
In FETCH callback: msgno 2 text (FLAGS (\Recent) UID 148266 BODY[HEADER.FIELDS (FROM SUBJECT DATE)] {131}
Subject: sun4 9.4.27: mitmailscan \* is unreliable
Date: Wed, 05 Jul 2006 17:58:57 -0400
From: John Hawkinson <jhawk@MIT.EDU>

)
Response: status OK, text Completed
2U  07/05  John Hawkinson <jhaw  sun4 9.4.27: mitmailscan \* is unreliable
athena% mitmailscan --debug \*
Send(EXAMINE %s, INBOX) ...
In number callback: keyword EXISTS, number 2
Response: status OK, text [READ-ONLY] Completed
Send(UID SEARCH %a, ALL *) ...
In SEARCH callback: text
Response: status OK, text Completed (0 msgs in 0.000 secs)

Mitch



> Five runs of "mitmailscan \*" in rapid succession,
> producing differing output. All suggest the same last message:
> 
>    126  17:55:21        mitmailscan \*
>    127  17:55:22        mitmailscan \*
>    128  17:55:23        mitmailscan \*
>    129  17:55:24        mitmailscan \*
>    130  17:55:25        mitmailscan \*
> 
> 
> [bart-savagewood!jhawk] ~> mitmailscan \*
> 1831U  07/05  Jason R Thorpe <thor  CVS commit: src/doc                      
>   
> [bart-savagewood!jhawk] ~> mitmailscan \*
> 1831U  07/05  Jason R Thorpe <thor  CVS commit: src/doc                      
>   
> [bart-savagewood!jhawk] ~> mitmailscan \*
> [bart-savagewood!jhawk] ~> mitmailscan \*
> 1831U  07/05  Jason R Thorpe <thor  CVS commit: src/doc                      
>   
> [bart-savagewood!jhawk] ~> mitmailscan \*
>    8U  09/11  Richard Tibbetts <ti  SIPB documents                           
>   
> 1831U  07/05  Jason R Thorpe <thor  CVS commit: src/doc                      
>   
> [bart-savagewood!jhawk] ~>
> 
> The 3rd and 5th invokations are the particularly special ones.  I had
> at first suspected a race condition relating to incoming mail
> delivery, but since the last message hasn't changed, that seems
> unlikely.
> 
> And I have no explanation for why it would randomly show me a message
> from 9/11/2001.
> 
> --jhawk
> 

home help back first fref pref prev next nref lref last post