E61i IMAP sync - old bug back again?

[matt_b]

Hi all,

I've got an issue whereby my Nokia E61i cannot download messages via IMAP. It can connect and download headers, but when I attempt to view a message it tries to download it but nothing happens - I am left at the same screen looking at the new headers.

Strange thing is, it's similar to a bug (14850) that's reported fixed, and there's an old thread that describes the same problem that ends in a fix.

I'm running the OSS version 5.0.8 on Ubuntu 6.06. I also get exactly the same problem on a Nokia E71 so it's not the phone that's at fault. I've tried appending "/ni" to my username but it makes no difference.

What can I try next?

Thanks
Matt

[matt_b]

The thread is here - I couldn't post it above as it was regarded as spam!

[dkarp]

Well, try turning on IMAP protocol-level tracing and post the trace of a session. The E61/71 bug was definitely fixed, and you're the first who has reported it recurring in 5.0.

[matt_b]

Hi, thanks for the reply. I've enabled IMAP DEBUG logging, and attempted to download a message. The log file is below:

2008-08-10 11:05:45,293 INFO  [ImapSSLServer-3] [] imap - [172.30.0.155] connected
2008-08-10 11:05:45,293 DEBUG [ImapSSLServer-3] [] imap -   S: * OK mail.myserver.co.uk Zimbra IMAP4rev1 service ready
2008-08-10 11:05:46,192 DEBUG [ImapSSLServer-3] [ip=172.30.0.155;] imap - C: 1 CAPABILITY
2008-08-10 11:05:46,192 DEBUG [ImapSSLServer-3] [ip=172.30.0.155;] imap -   S: * CAPABILITY IMAP4rev1 AUTH=PLAIN AUTH=X-ZIMBRA ACL BINARY CATENATE CHILDREN CONDSTORE ENABLE ESEARCH ID IDLE LIST-EXTENDED LITERAL+ LOGIN-REFERRALS MULTIAPPEND NAMESPACE QRESYNC QUOTA RIGHTS=ektx SASL-IR SEARCHRES UIDPLUS UNSELECT WITHIN
2008-08-10 11:05:46,193 DEBUG [ImapSSLServer-3] [ip=172.30.0.155;] imap -   S: 1 OK CAPABILITY completed
2008-08-10 11:05:46,204 DEBUG [ImapSSLServer-3] [ip=172.30.0.155;] imap - C: 2 LOGIN ...
2008-08-10 11:05:46,204 INFO  [ImapSSLServer-3] [name=matt@myserver.co.uk;ip=172.30.0.155;] imap - user matt@myserver.co.uk authenticated, mechanism=LOGIN
2008-08-10 11:05:46,205 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;ip=172.30.0.155;] imap -   S: 2 OK [CAPABILITY IMAP4rev1 ACL BINARY CATENATE CHILDREN CONDSTORE ENABLE ESEARCH ID LIST-EXTENDED LITERAL+ LOGIN-REFERRALS MULTIAPPEND NAMESPACE QRESYNC QUOTA RIGHTS=ektx SASL-IR SEARCHRES UIDPLUS UNSELECT WITHIN] LOGIN completed
2008-08-10 11:05:46,219 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;ip=172.30.0.155;] imap - C: 3 SELECT "INBOX"
2008-08-10 11:05:46,220 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;ip=172.30.0.155;] imap -   ** loading folder: INBOX
2008-08-10 11:05:46,223 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;ip=172.30.0.155;] imap -   ** added:  260 262 264 267 281
2008-08-10 11:05:46,223 INFO  [ImapSSLServer-3] [name=matt@myserver.co.uk;ip=172.30.0.155;] imap - selected folder INBOX
2008-08-10 11:05:46,223 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;ip=172.30.0.155;] imap -   S: * 5 EXISTS
2008-08-10 11:05:46,223 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;ip=172.30.0.155;] imap -   S: * 0 RECENT
2008-08-10 11:05:46,223 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;ip=172.30.0.155;] imap -   S: * OK [UNSEEN 4] mailbox contains unseen messages
2008-08-10 11:05:46,223 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;ip=172.30.0.155;] imap -   S: * OK [UIDVALIDITY 1] UIDs are valid for this mailbox
2008-08-10 11:05:46,224 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;ip=172.30.0.155;] imap -   S: * OK [UIDNEXT 282] next expected UID is 282
2008-08-10 11:05:46,224 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;ip=172.30.0.155;] imap -   S: * FLAGS (\Answered \Deleted \Draft \Flagged \Seen $Forwarded $MDNSent Forwarded $Junk $NotJunk Junk JunkRecorded NonJunk NotJunk)
2008-08-10 11:05:46,224 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;ip=172.30.0.155;] imap -   S: * OK [PERMANENTFLAGS (\Answered \Deleted \Draft \Flagged \Seen $Forwarded $MDNSent Forwarded \*)] junk-related flags are not permanent
2008-08-10 11:05:46,224 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;ip=172.30.0.155;] imap -   S: * OK [HIGHESTMODSEQ 337] modseq tracked on this mailbox
2008-08-10 11:05:46,224 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;ip=172.30.0.155;] imap -   S: 3 OK [READ-WRITE] SELECT completed
2008-08-10 11:05:46,245 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap - C: 4 UID FETCH 1:281 (UID FLAGS)
2008-08-10 11:05:46,246 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: * 1 FETCH (UID 260 FLAGS (\Seen))
2008-08-10 11:05:46,246 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: * 2 FETCH (UID 262 FLAGS (\Seen))
2008-08-10 11:05:46,246 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: * 3 FETCH (UID 264 FLAGS (\Answered \Seen))
2008-08-10 11:05:46,257 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: * 4 FETCH (UID 267 FLAGS ())

2008-08-10 11:05:46,257 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: * 5 FETCH (UID 281 FLAGS (\Seen))
2008-08-10 11:05:46,257 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: 4 OK UID FETCH completed
2008-08-10 11:05:46,479 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap - C: 5 LIST "" "%"
2008-08-10 11:05:46,480 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: * LIST (\HasNoChildren) "/" "Chats"
2008-08-10 11:05:46,480 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: * LIST (\HasNoChildren) "/" "Contacts"
2008-08-10 11:05:46,480 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: * LIST (\HasNoChildren) "/" "Drafts"
2008-08-10 11:05:46,480 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: * LIST (\HasNoChildren) "/" "Emailed Contacts"
2008-08-10 11:05:46,480 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: * LIST (\HasNoChildren) "/" "INBOX"
2008-08-10 11:05:46,480 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: * LIST (\NoInferiors) "/" "Junk"
2008-08-10 11:05:46,480 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: * LIST (\HasNoChildren) "/" "Sent"
2008-08-10 11:05:46,480 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: * LIST (\HasNoChildren) "/" "Trash"
2008-08-10 11:05:46,480 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   ** iterating (collapseExpunged)
2008-08-10 11:05:46,481 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: 5 OK LIST completed
2008-08-10 11:05:46,502 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap - C: 6 LIST "" "Chats/%"
2008-08-10 11:05:46,502 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   ** iterating (collapseExpunged)
2008-08-10 11:05:46,502 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: 6 OK LIST completed
2008-08-10 11:05:46,521 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap - C: 7 LIST "" "Contacts/%"
2008-08-10 11:05:46,521 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   ** iterating (collapseExpunged)
2008-08-10 11:05:46,521 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: 7 OK LIST completed
2008-08-10 11:05:46,548 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap - C: 8 LIST "" "Drafts/%"
2008-08-10 11:05:46,539 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   ** iterating (collapseExpunged)
2008-08-10 11:05:46,539 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: 8 OK LIST completed
2008-08-10 11:05:46,549 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap - C: 9 LIST "" "Emailed Contacts/%"
2008-08-10 11:05:46,550 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   ** iterating (collapseExpunged)
2008-08-10 11:05:46,550 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: 9 OK LIST completed
2008-08-10 11:05:46,560 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap - C: 10 LIST "" "INBOX/%"
2008-08-10 11:05:46,560 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   ** iterating (collapseExpunged)
2008-08-10 11:05:46,561 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: 10 OK LIST completed
2008-08-10 11:05:46,572 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap - C: 11 LIST "" "Sent/%"
2008-08-10 11:05:46,573 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   ** iterating (collapseExpunged)
2008-08-10 11:05:46,573 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: 11 OK LIST completed
2008-08-10 11:05:46,584 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap - C: 12 LIST "" "Trash/%"
2008-08-10 11:05:46,585 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   ** iterating (collapseExpunged)
2008-08-10 11:05:46,585 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: 12 OK LIST completed
2008-08-10 11:05:46,614 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap - C: 13 IDLE
2008-08-10 11:05:46,615 DEBUG [ImapSSLServer-3] [name=matt@myserver.co.uk;mid=3;ip=172.30.0.155;] imap -   S: 13 BAD parse error: command not implemented
2008-08-10 11:05:46,629 DEBUG [ImapSSLServer-3] [] imap -   S: * BYE mail.myserver.co.uk IMAP4rev1 server terminating connection
2008-08-10 11:05:46,629 INFO  [ImapSSLServer-3] [] ProtocolHandler - Handler exiting normally

From looking at this it appears that my phone is sending the IDLE command and the server is rejecting it - even though my IMAP login name is matt@myserver.co.uk/ni. Have I interpreted/implemented the /ni switch correctly?

[dkarp]

Don't use the /ni switch.

Your client is requesting that IDLE be disabled via the /ni switch, but it's ignoring the CAPABILITY string returned with the LOGIN response that says that IDLE is disabled.

Anyway, now that the bug is fixed there should be no reason for you to use /ni...

[matt_b]

Great, thanks for the pointer - I can now read the emails. Other people have had some odd issues with IMAP IDLE on the E61i so I was trying to disable it via the /ni switch.

Out of interest, how would I completely disable IMAP IDLE on the server? Now I am correctly using IDLE my phone maintains a permanent 3G connection (as you would expect), but it canes the battery and I would like to try it without a permanent connection. I would use the /ni switch to accomplish this, but the E61i doesn't listen to the server

I've also got another problem - reading emails does not mark them as read in the web client, until I receive another new message, then the old message is marked as read.

Thanks
Matt

[dkarp]

To completely disable IMAP for the server, set the server's LDAP attributes zimbraImapDisabledCapability and zimbraImapSSLDisabledCapability to "IDLE".

Which version of ZCS are you running?

[matt_b]

Thanks, I'll give that a try. How do I re-enable IDLE once I've finished testing - do I run the same command(s) again but pass them an empty string instead of "IDLE"?

I'm running the latest version 5.0.8.

Thanks
Matt