[prev in list] [next in list] [prev in thread] [next in thread] 

List:       james-user
Subject:    Meaning of "Got <tag>: ##" in IMapServer log?
From:       Jerry Malcolm <techstuff () malcolms ! com>
Date:       2017-04-27 23:45:48
Message-ID: c63a98e1-166a-79b6-ef12-9db750753bad () malcolms ! com
[Download RAW message or body]

Some of my users are getting timeouts periodically in Thunderbird and 
other mail clients when trying to access their mail folders. I enabled 
DEBUG on IMAP (James R3B5).  I'm seeing sessions lasting several minutes 
with an ongoing "tag" count.   I have a pretty good grasp of the IMAP 
API and have written some standalone apps that interface with IMAP.  But 
I don't really understand what Tbird is doing.    Is this 'tag' just 
some ndx that Tbird keeps incrementing, and does Tbird just keep a 
session open forever? I've got to wait until the hang occurs again on 
Tbird for some client and then determine if the logs differ.  But until 
that time, I'd like a better grasp of what I'm seeing in the log below.  
Can someone explain what is flowing back and forth below? Also, is DEBUG 
the most granular I can go in JAMES log4j?  I'd love to see when each 
command completes and not just when it starts.

DEBUG 18:22:44,249 | james.imapserver | ID=27822739 Got <tag>: 21
DEBUG 18:22:44,249 | james.imapserver | ID=27822739 Got <command>: IDLE
DEBUG 18:22:44,249 | james.imapserver | ID=27822739 Loaded mailbox 
#private:fred@f
DEBUG 18:24:44,359 | james.imapserver | ID=27822739 Got <tag>: 22
DEBUG 18:24:44,359 | james.imapserver | ID=27822739 Got <command>: noop
DEBUG 18:24:44,359 | james.imapserver | ID=27822739 Loaded mailbox 
#private:fred@f
DEBUG 18:24:44,406 | james.imapserver | ID=27822739 Got <tag>: 23
DEBUG 18:24:44,406 | james.imapserver | ID=27822739 Got <command>: UID
DEBUG 18:24:44,406 | james.imapserver | ID=27822739 Loaded mailbox 
#private:fred@f
DEBUG 18:24:44,406 | james.imapserver | ID=27822739 Loaded mailbox 
#private:fred@f
DEBUG 18:24:44,515 | james.imapserver | ID=27822739 Got <tag>: 24
DEBUG 18:24:44,515 | james.imapserver | ID=27822739 Got <command>: IDLE
DEBUG 18:24:44,515 | james.imapserver | ID=27822739 Loaded mailbox 
#private:fred@f
DEBUG 18:25:42,569 | james.imapserver | ID=27822739 Got <tag>: 25
DEBUG 18:25:42,569 | james.imapserver | ID=27822739 Got <command>: check
DEBUG 18:25:42,571 | james.imapserver | ID=27822739 Loaded mailbox 
#private:fred@f
DEBUG 18:25:42,619 | james.imapserver | ID=27822739 Got <tag>: 26
DEBUG 18:25:42,619 | james.imapserver | ID=27822739 Got <command>: UID
DEBUG 18:25:42,621 | james.imapserver | ID=27822739 Loaded mailbox 
#private:fred@f
DEBUG 18:25:42,641 | james.imapserver | ID=27822739 Loaded mailbox 
#private:fred@f
DEBUG 18:25:42,735 | james.imapserver | ID=27822739 Got <tag>: 27
DEBUG 18:25:42,735 | james.imapserver | ID=27822739 Got <command>: IDLE
DEBUG 18:25:42,735 | james.imapserver | ID=27822739 Loaded mailbox 
#private:fred@f
DEBUG 18:27:42,839 | james.imapserver | ID=27822739 Got <tag>: 28
DEBUG 18:27:42,839 | james.imapserver | ID=27822739 Got <command>: noop
DEBUG 18:27:42,841 | james.imapserver | ID=27822739 Loaded mailbox 
#private:fred@f
DEBUG 18:27:42,888 | james.imapserver | ID=27822739 Got <tag>: 29
DEBUG 18:27:42,888 | james.imapserver | ID=27822739 Got <command>: UID
DEBUG 18:27:42,890 | james.imapserver | ID=27822739 Loaded mailbox 
#private:fred@f
DEBUG 18:27:42,896 | james.imapserver | ID=27822739 Loaded mailbox 
#private:fred@f
DEBUG 18:27:43,003 | james.imapserver | ID=27822739 Got <tag>: 30
DEBUG 18:27:43,003 | james.imapserver | ID=27822739 Got <command>: IDLE


---------------------------------------------------------------------
To unsubscribe, e-mail: server-user-unsubscribe@james.apache.org
For additional commands, e-mail: server-user-help@james.apache.org

[prev in list] [next in list] [prev in thread] [next in thread]