On Mon, Aug 20, 2007 at 05:00:33PM -0500, John Goerzen wrote:
> On Mon August 20 2007 4:03:12 pm you wrote:
> > I'm also seeing this bug, using courier 4.1.1.20060828-6. Very, very
> > annoying.
>
> I'm wondering if any of you will be able to do some more debugging to track
> down exactly what is going on here? I can't replicate the problem myself,
> and am at a loss to explain what may be causing it.
>
> Running offlineimap -1 -d imap -u TTY.TTYUI should produce some significant
> output. If you can track the UID change in there -- what it originally was,
> what it changed to, and what caused that -- this would be great.
Why can't you tee that to a file? I guess it objects to the lack of a
real TTY. I used Noninteractive.Basic instead and it blew up when tee'd:
File "/var/lib/python-support/python2.4/offlineimap/ui/Noninteractive.py",
line 28, in _display
sys.stdout.flush()
IOError: [Errno 11] Resource temporarily unavailable
Eventually I figured out I could try TTY.TTYUI in 'script'.
I attached what is hopefully the right part of the log. offlineimap
sends EXAMINE, which gets a pile of things back including a
UIDVALIDITY. Then I ran offlineimap again, it again sent an EXAMINE
for the same folder, and got back a second UIDVALIDITY.
My presumption is that earlier versions of offlineimap sent something
besides an EXAMINE, which caused courier to create the UID cache.
Or else it did not cache the UID validity until it had done something
more than just EXAMINE the folder.
I verified that sending EXAMINE to courier does not create the
courierimapuiddb cache file, but sending SELECT does create it.
--
Daniel Jacobowitz
CodeSourcery
Folder sync Return[debian-qt-kde]:
Syncing INBOX.debian-qt-kde: IMAP -> Maildir
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.23 > CCJ3 EXAMINE INBOX.debian-qt-kde
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.61 < * FLAGS (\Draft \Answered \Flagged \Deleted \Seen
\Recent)
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.61 matched r'\* (?P<type>[A-Z-]+)( (?P<data>.*))?'
=> ('FLAGS', ' (\\Draft \\Answered \\Flagged \\Deleted \\Seen \\Recent)',
'(\\Draft \\Answered \\Flagged \\Deleted \\Seen \\Recent)')
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.61 untagged_responses[FLAGS] 0 += ["(\Draft \Answered
\Flagged \Deleted \Seen \Recent)"]
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.61 < * OK [PERMANENTFLAGS ()] No permanent flags
permitted
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.61 matched r'\* (?P<type>[A-Z-]+)( (?P<data>.*))?'
=> ('OK', ' [PERMANENTFLAGS ()] No permanent flags permitted', '[PERMANENTFLAGS
()] No permanent flags permitted')
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.61 untagged_responses[OK] 0 += ["[PERMANENTFLAGS ()] No
permanent flags permitted"]
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.61 matched r'\[(?P<type>[A-Z-]+)(
(?P<data>[^\]]*))?\]' => ('PERMANENTFLAGS', ' ()', '()')
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.61 untagged_responses[PERMANENTFLAGS] 0 += ["()"]
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.61 < * 1 EXISTS
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.61 matched r'\* (?P<data>\d+) (?P<type>[A-Z-]+)(
(?P<data2>.*))?' => ('1', 'EXISTS', None, None)
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.62 untagged_responses[EXISTS] 0 += ["1"]
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.62 < * 1 RECENT
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.62 matched r'\* (?P<data>\d+) (?P<type>[A-Z-]+)(
(?P<data2>.*))?' => ('1', 'RECENT', None, None)
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.62 untagged_responses[RECENT] 0 += ["1"]
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.62 < * OK [UIDVALIDITY 1187648350] Ok
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.62 matched r'\* (?P<type>[A-Z-]+)( (?P<data>.*))?'
=> ('OK', ' [UIDVALIDITY 1187648350] Ok', '[UIDVALIDITY 1187648350] Ok')
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.62 untagged_responses[OK] 1 += ["[UIDVALIDITY
1187648350] Ok"]
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.62 matched r'\[(?P<type>[A-Z-]+)(
(?P<data>[^\]]*))?\]' => ('UIDVALIDITY', ' 1187648350', '1187648350')
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.62 untagged_responses[UIDVALIDITY] 0 += ["1187648350"]
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.62 < * OK [MYRIGHTS "acdilrsw"] ACL
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.62 matched r'\* (?P<type>[A-Z-]+)( (?P<data>.*))?'
=> ('OK', ' [MYRIGHTS "acdilrsw"] ACL', '[MYRIGHTS "acdilrsw"] ACL')
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.62 untagged_responses[OK] 2 += ["[MYRIGHTS "acdilrsw"]
ACL"]
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.62 matched r'\[(?P<type>[A-Z-]+)(
(?P<data>[^\]]*))?\]' => ('MYRIGHTS', ' "acdilrsw"', '"acdilrsw"')
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.62 untagged_responses[MYRIGHTS] 0 += [""acdilrsw""]
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.62 < CCJ3 OK [READ-ONLY] Ok
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.62 matched r'(?P<tag>CCJ\d+) (?P<type>[A-Z]+)
(?P<data>.*)' => ('CCJ3', 'OK', '[READ-ONLY] Ok')
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.62 matched r'\[(?P<type>[A-Z-]+)(
(?P<data>[^\]]*))?\]' => ('READ-ONLY', None, None)
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:08.62 untagged_responses[READ-ONLY] 0 += [""]
Folder sync Return[debian-qt-kde]:
WARNING: UID validity problem for folder INBOX.debian-qt-kde (repo Remote)
(saved 1187105276; got 1187648350); skipping it
Account sync Return:
***** Finished processing account Return
]0;[EMAIL PROTECTED]:~[1m[3m%[23m[1m[m
[EMAIL PROTECTED]:~% [KINFO: DISCONNECTED, user=drow, ip=[127.0.0.1],
headers=0, body=0, rcvd=86, sent=13806, time=2
Script done on Mon Aug 20 18:19:17 2007
Folder sync Return[debian-qt-kde]:
Syncing INBOX.debian-qt-kde: IMAP -> Maildir
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.40 > DOOH3 EXAMINE INBOX.debian-qt-kde
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.85 < * FLAGS (\Draft \Answered \Flagged \Deleted \Seen
\Recent)
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.85 matched r'\* (?P<type>[A-Z-]+)( (?P<data>.*))?'
=> ('FLAGS', ' (\\Draft \\Answered \\Flagged \\Deleted \\Seen \\Recent)',
'(\\Draft \\Answered \\Flagged \\Deleted \\Seen \\Recent)')
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.85 untagged_responses[FLAGS] 0 += ["(\Draft \Answered
\Flagged \Deleted \Seen \Recent)"]
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.85 < * OK [PERMANENTFLAGS ()] No permanent flags
permitted
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.85 matched r'\* (?P<type>[A-Z-]+)( (?P<data>.*))?'
=> ('OK', ' [PERMANENTFLAGS ()] No permanent flags permitted', '[PERMANENTFLAGS
()] No permanent flags permitted')
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.86 untagged_responses[OK] 0 += ["[PERMANENTFLAGS ()] No
permanent flags permitted"]
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.86 matched r'\[(?P<type>[A-Z-]+)(
(?P<data>[^\]]*))?\]' => ('PERMANENTFLAGS', ' ()', '()')
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.86 untagged_responses[PERMANENTFLAGS] 0 += ["()"]
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.86 < * 1 EXISTS
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.87 matched r'\* (?P<data>\d+) (?P<type>[A-Z-]+)(
(?P<data2>.*))?' => ('1', 'EXISTS', None, None)
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.87 untagged_responses[EXISTS] 0 += ["1"]
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.88 < * 1 RECENT
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.88 matched r'\* (?P<data>\d+) (?P<type>[A-Z-]+)(
(?P<data2>.*))?' => ('1', 'RECENT', None, None)
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.88 untagged_responses[RECENT] 0 += ["1"]
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.89 < * OK [UIDVALIDITY 1187648380] Ok
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.89 matched r'\* (?P<type>[A-Z-]+)( (?P<data>.*))?'
=> ('OK', ' [UIDVALIDITY 1187648380] Ok', '[UIDVALIDITY 1187648380] Ok')
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.89 untagged_responses[OK] 1 += ["[UIDVALIDITY
1187648380] Ok"]
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.89 matched r'\[(?P<type>[A-Z-]+)(
(?P<data>[^\]]*))?\]' => ('UIDVALIDITY', ' 1187648380', '1187648380')
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.90 untagged_responses[UIDVALIDITY] 0 += ["1187648380"]
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.90 < * OK [MYRIGHTS "acdilrsw"] ACL
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.90 matched r'\* (?P<type>[A-Z-]+)( (?P<data>.*))?'
=> ('OK', ' [MYRIGHTS "acdilrsw"] ACL', '[MYRIGHTS "acdilrsw"] ACL')
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.90 untagged_responses[OK] 2 += ["[MYRIGHTS "acdilrsw"]
ACL"]
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.90 matched r'\[(?P<type>[A-Z-]+)(
(?P<data>[^\]]*))?\]' => ('MYRIGHTS', ' "acdilrsw"', '"acdilrsw"')
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.90 untagged_responses[MYRIGHTS] 0 += [""acdilrsw""]
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.90 < DOOH3 OK [READ-ONLY] Ok
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.90 matched r'(?P<tag>DOOH\d+) (?P<type>[A-Z]+)
(?P<data>.*)' => ('DOOH3', 'OK', '[READ-ONLY] Ok')
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.90 matched r'\[(?P<type>[A-Z-]+)(
(?P<data>[^\]]*))?\]' => ('READ-ONLY', None, None)
Folder sync Return[debian-qt-kde]:
DEBUG[imap]: 19:38.90 untagged_responses[READ-ONLY] 0 += [""]
Folder sync Return[debian-qt-kde]:
WARNING: UID validity problem for folder INBOX.debian-qt-kde (repo Remote)
(saved 1187105276; got 1187648380); skipping it
Account sync Return:
***** Finished processing account Return
]0;[EMAIL PROTECTED]:~[1m[3m%[23m[1m[m
[EMAIL PROTECTED]:~% [KINFO: DISCONNECTED, user=drow, ip=[127.0.0.1],
headers=0, body=0, rcvd=90, sent=13810, time=7
Script done on Mon Aug 20 18:19:40 2007
