Hallo,

I/m trying to use the 3.0-Beta3 with IMAP and JCR configured. It is possible to 
send emails and the server also claims to recieve mails, but nothing is shown 
in the IMAP account. Checking in JackRabbit directly it seems that the mails 
are stored inside Jackrabbit but on reading the INBOX an error occurs and the 
INBOX (or any other box) are shown as empty on the client. 
Can someone confirm this error or is this a problem belong ing to me only?

Situation:
- JackRabbit is initialized correctly no errors are shown in the log. 
- loglevel debug for IMAP and Jackrabbit are enabled
- on a SELECT command (or any other command) from IMAP the following error 
occur: 

Thanks Jan 


DEBUG 18:27:48,755 | james.imapserver | ID=15304902 Got <tag>: 6.2698
DEBUG 18:27:48,755 | james.imapserver | ID=15304902 Got <command>: SELECT
DEBUG 18:27:48,755 | 
org.apache.jackrabbit.core.security.authentication.AbstractLoginModule | 
Initalize LoginModule: 
DEBUG 18:27:48,755 | 
org.apache.jackrabbit.core.security.authentication.AbstractLoginModule | - 
PrincipalProvider -> 
'org.apache.jackrabbit.core.security.simple.SimpleSecurityManager$SimplePrincipalProvider'
DEBUG 18:27:48,756 | 
org.apache.jackrabbit.core.security.simple.SimpleLoginModule | init: 
SimpleLoginModule. Done.
DEBUG 18:27:48,756 | 
org.apache.jackrabbit.core.security.authentication.AbstractLoginModule | - 
Option: anonymousId -> 'anonymous'
DEBUG 18:27:48,756 | 
org.apache.jackrabbit.core.security.authentication.AbstractLoginModule | - 
Option: adminId -> 'admin'
DEBUG 18:27:48,756 | org.apache.jackrabbit.core.state.MLRUItemStateCache | Item 
state cache size: 0% of 4194304 bytes
DEBUG 18:27:48,756 | org.apache.jackrabbit.core.RepositoryImpl | User james 
logged in to workspace james
DEBUG 18:27:48,757 | org.apache.jackrabbit.core.session.SessionState | 
Performing 
node.createQuery(/jcr:root/mailboxes/_x0023_private//element(*,jamesMailbox:mailbox)[@jamesMailbox:mailboxName='INBOX'
 and @jamesMailbox:mailboxNamespace='#private' and 
@jamesMailbox:mailboxUser='[email protected]'], xpath)
DEBUG 18:27:48,758 | org.apache.jackrabbit.core.session.SessionState | 
Performed 
node.createQuery(/jcr:root/mailboxes/_x0023_private//element(*,jamesMailbox:mailbox)[@jamesMailbox:mailboxName='INBOX'
 and @jamesMailbox:mailboxNamespace='#private' and 
@jamesMailbox:mailboxUser='[email protected]'], xpath) in 1ms
DEBUG 18:27:48,758 | org.apache.jackrabbit.core.session.SessionState | 
Performing 
query.execute(/jcr:root/mailboxes/_x0023_private//element(*,jamesMailbox:mailbox)[@jamesMailbox:mailboxName='INBOX'
 and @jamesMailbox:mailboxNamespace='#private' and 
@jamesMailbox:mailboxUser='[email protected]'])
DEBUG 18:27:48,758 | org.apache.jackrabbit.core.query.lucene.QueryImpl | 
Executing query: 
+ Root node
+ Select properties: *
  + PathQueryNode
    + LocationStepQueryNode:  NodeTest={} Descendants=false Index=NONE
    + LocationStepQueryNode:  NodeTest={}mailboxes Descendants=false Index=NONE
    + LocationStepQueryNode:  NodeTest={}#private Descendants=false Index=NONE
    + LocationStepQueryNode:  NodeTest=* Descendants=true Index=NONE
      + NodeTypeQueryNode:  Prop={http://www.jcp.org/jcr/1.0}primaryType 
Value={http://james.apache.org/imap/jcr/}mailbox
      + AndQueryNode
        + AndQueryNode
          + RelationQueryNode: Op: = Prop=[          + PathQueryNode
            + LocationStepQueryNode:  
NodeTest={http://james.apache.org/imap/jcr/}mailboxName Descendants=false 
Index=NONE
] Type=STRING Value=INBOX
          + RelationQueryNode: Op: = Prop=[          + PathQueryNode
            + LocationStepQueryNode:  
NodeTest={http://james.apache.org/imap/jcr/}mailboxNamespace Descendants=false 
Index=NONE
] Type=STRING Value=#private
        + RelationQueryNode: Op: = Prop=[        + PathQueryNode
          + LocationStepQueryNode:  
NodeTest={http://james.apache.org/imap/jcr/}mailboxUser Descendants=false 
Index=NONE
] Type=STRING [email protected]

DEBUG 18:27:48,758 | org.apache.jackrabbit.core.query.lucene.LuceneQueryBuilder 
| Using literal INBOX as is.
DEBUG 18:27:48,758 | org.apache.jackrabbit.core.query.lucene.LuceneQueryBuilder 
| Using literal #private as is.
DEBUG 18:27:48,758 | org.apache.jackrabbit.core.query.lucene.LuceneQueryBuilder 
| Using literal [email protected] as is.
DEBUG 18:27:48,759 | org.apache.jackrabbit.core.query.lucene.QueryResultImpl | 
getResults(2147483647) limit=-1
DEBUG 18:27:48,759 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
EmptyTermDocs(_:PROPERTIES,1570322:mixinTypes[16318755:mailbox)
DEBUG 18:27:48,759 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
CachedTermDocs(_:PROPERTIES,1570322:mixinTypes[16318755:mailbox,1/6)
DEBUG 18:27:48,759 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
CachedTermDocs(_:PROPERTIES,1570322:mixinTypes[16318755:mailbox,1/2)
DEBUG 18:27:48,759 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
EmptyTermDocs(_:PROPERTIES,1570322:mixinTypes[16318755:mailbox)
DEBUG 18:27:48,759 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
EmptyTermDocs(_:PROPERTIES,16318755:mailboxName[INBOX)
DEBUG 18:27:48,759 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
CachedTermDocs(_:PROPERTIES,16318755:mailboxName[INBOX,1/6)
DEBUG 18:27:48,759 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
EmptyTermDocs(_:PROPERTIES,16318755:mailboxName[INBOX)
DEBUG 18:27:48,759 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
EmptyTermDocs(_:PROPERTIES,16318755:mailboxName[INBOX)
DEBUG 18:27:48,759 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
EmptyTermDocs(_:PROPERTIES,16318755:mailboxNamespace[#private)
DEBUG 18:27:48,760 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
CachedTermDocs(_:PROPERTIES,16318755:mailboxNamespace[#private,1/6)
DEBUG 18:27:48,760 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
CachedTermDocs(_:PROPERTIES,16318755:mailboxNamespace[#private,1/2)
DEBUG 18:27:48,760 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
EmptyTermDocs(_:PROPERTIES,16318755:mailboxNamespace[#private)
DEBUG 18:27:48,760 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
EmptyTermDocs(_:PROPERTIES,16318755:mailboxUser[[email protected])
DEBUG 18:27:48,760 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
CachedTermDocs(_:PROPERTIES,16318755:mailboxUser[[email protected],1/6)
DEBUG 18:27:48,760 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
CachedTermDocs(_:PROPERTIES,16318755:mailboxUser[[email protected],1/2)
DEBUG 18:27:48,760 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
EmptyTermDocs(_:PROPERTIES,16318755:mailboxUser[[email protected])
DEBUG 18:27:48,760 | org.apache.jackrabbit.core.query.lucene.QueryResultImpl | 
query executed in 1 ms (0)
DEBUG 18:27:48,760 | org.apache.jackrabbit.core.query.lucene.ChildAxisQuery | 
got NodeState with id cafebabe-cafe-babe-cafe-babecafebabe in 0 ms.
DEBUG 18:27:48,760 | org.apache.jackrabbit.core.query.lucene.ChildAxisQuery | 
got NodeState with id b435e326-568c-423b-a144-0c28e26662a1 in 0 ms.
DEBUG 18:27:48,761 | 
org.apache.jackrabbit.core.query.lucene.DescendantSelfAxisQuery | Collected 1 
context hits in 0 ms for 
DescendantSelfAxisQuery(ChildAxisQuery(ChildAxisQuery(_:PARENT:, {}mailboxes), 
{}#private), +_:PROPERTIES:1570322:mixinTypes[16318755:mailbox 
+(+(+_:PROPERTIES:16318755:mailboxName[INBOX 
+_:PROPERTIES:16318755:mailboxNamespace[#private) 
+_:PROPERTIES:16318755:mailboxUser[[email protected]), 1)
DEBUG 18:27:48,761 | org.apache.jackrabbit.core.query.lucene.QueryResultImpl | 
retrieved ScoreNodes in 1 ms (1)
DEBUG 18:27:48,761 | org.apache.jackrabbit.core.session.SessionState | 
Performed 
query.execute(/jcr:root/mailboxes/_x0023_private//element(*,jamesMailbox:mailbox)[@jamesMailbox:mailboxName='INBOX'
 and @jamesMailbox:mailboxNamespace='#private' and 
@jamesMailbox:mailboxUser='[email protected]']) in 2ms
DEBUG 18:27:48,761 | org.apache.jackrabbit.core.query.QueryImpl | executed in 
0.00 s. 
(/jcr:root/mailboxes/_x0023_private//element(*,jamesMailbox:mailbox)[@jamesMailbox:mailboxName='INBOX'
 and @jamesMailbox:mailboxNamespace='#private' and 
@jamesMailbox:mailboxUser='[email protected]'])
DEBUG 18:27:48,761 | org.apache.jackrabbit.core.session.SessionState | 
Performing 
org.apache.jackrabbit.core.query.lucene.NodeIteratorImpl$FetchNext@a14b94
DEBUG 18:27:48,761 | org.apache.jackrabbit.core.query.lucene.QueryResultImpl | 
getResults(2) limit=-1
DEBUG 18:27:48,761 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
EmptyTermDocs(_:PROPERTIES,1570322:mixinTypes[16318755:mailbox)
DEBUG 18:27:48,761 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
CachedTermDocs(_:PROPERTIES,1570322:mixinTypes[16318755:mailbox,1/6)
DEBUG 18:27:48,761 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
CachedTermDocs(_:PROPERTIES,1570322:mixinTypes[16318755:mailbox,1/2)
DEBUG 18:27:48,761 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
EmptyTermDocs(_:PROPERTIES,1570322:mixinTypes[16318755:mailbox)
DEBUG 18:27:48,761 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
EmptyTermDocs(_:PROPERTIES,16318755:mailboxName[INBOX)
DEBUG 18:27:48,762 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
CachedTermDocs(_:PROPERTIES,16318755:mailboxName[INBOX,1/6)
DEBUG 18:27:48,762 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
EmptyTermDocs(_:PROPERTIES,16318755:mailboxName[INBOX)
DEBUG 18:27:48,762 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
EmptyTermDocs(_:PROPERTIES,16318755:mailboxName[INBOX)
DEBUG 18:27:48,762 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
EmptyTermDocs(_:PROPERTIES,16318755:mailboxNamespace[#private)
DEBUG 18:27:48,762 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
CachedTermDocs(_:PROPERTIES,16318755:mailboxNamespace[#private,1/6)
DEBUG 18:27:48,762 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
CachedTermDocs(_:PROPERTIES,16318755:mailboxNamespace[#private,1/2)
DEBUG 18:27:48,762 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
EmptyTermDocs(_:PROPERTIES,16318755:mailboxNamespace[#private)
DEBUG 18:27:48,762 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
EmptyTermDocs(_:PROPERTIES,16318755:mailboxUser[[email protected])
DEBUG 18:27:48,762 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
CachedTermDocs(_:PROPERTIES,16318755:mailboxUser[[email protected],1/6)
DEBUG 18:27:48,762 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
CachedTermDocs(_:PROPERTIES,16318755:mailboxUser[[email protected],1/2)
DEBUG 18:27:48,762 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | 
EmptyTermDocs(_:PROPERTIES,16318755:mailboxUser[[email protected])
DEBUG 18:27:48,762 | org.apache.jackrabbit.core.query.lucene.QueryResultImpl | 
query executed in 1 ms (0)
DEBUG 18:27:48,762 | org.apache.jackrabbit.core.query.lucene.ChildAxisQuery | 
got NodeState with id cafebabe-cafe-babe-cafe-babecafebabe in 0 ms.
DEBUG 18:27:48,762 | org.apache.jackrabbit.core.query.lucene.ChildAxisQuery | 
got NodeState with id b435e326-568c-423b-a144-0c28e26662a1 in 0 ms.
DEBUG 18:27:48,762 | 
org.apache.jackrabbit.core.query.lucene.DescendantSelfAxisQuery | Collected 1 
context hits in 0 ms for 
DescendantSelfAxisQuery(ChildAxisQuery(ChildAxisQuery(_:PARENT:, {}mailboxes), 
{}#private), +_:PROPERTIES:1570322:mixinTypes[16318755:mailbox 
+(+(+_:PROPERTIES:16318755:mailboxName[INBOX 
+_:PROPERTIES:16318755:mailboxNamespace[#private) 
+_:PROPERTIES:16318755:mailboxUser[[email protected]), 1)
DEBUG 18:27:48,762 | org.apache.jackrabbit.core.query.lucene.QueryResultImpl | 
retrieved ScoreNodes in 0 ms (1)
DEBUG 18:27:48,763 | org.apache.jackrabbit.core.state.MLRUItemStateCache | Item 
state cache size: 0% of 4194304 bytes
DEBUG 18:27:48,763 | org.apache.jackrabbit.core.ItemManager | caching item 
677f73b6-e9c8-44fe-87bf-7ca7da972dc0
DEBUG 18:27:48,763 | org.apache.jackrabbit.core.session.SessionState | 
Performed 
org.apache.jackrabbit.core.query.lucene.NodeIteratorImpl$FetchNext@a14b94 in 1ms
DEBUG 18:27:48,763 | org.apache.jackrabbit.core.session.SessionState | 
Performing 
org.apache.jackrabbit.core.query.lucene.NodeIteratorImpl$FetchNext@16909e0
DEBUG 18:27:48,763 | org.apache.jackrabbit.core.session.SessionState | 
Performed 
org.apache.jackrabbit.core.query.lucene.NodeIteratorImpl$FetchNext@16909e0 in 
1us
DEBUG 18:27:48,763 | james.imapserver | ID=15304902 Loaded mailbox 
#private:[email protected]:INBOX
DEBUG 18:27:48,763 | org.apache.jackrabbit.core.session.SessionState | 
Performing item.getPath()
DEBUG 18:27:48,763 | org.apache.jackrabbit.core.session.SessionState | 
Performed item.getPath() in 460us
DEBUG 18:27:48,763 | org.apache.jackrabbit.core.session.SessionState | 
Performing 
node.createQuery(/jcr:root/mailboxes/_x0023_private/t/tr/try_x0040_moxter.net/INBOX//element(*,jamesMailbox:message)
 order by @jamesMailbox:uid, xpath)
DEBUG 18:27:48,764 | org.apache.jackrabbit.core.session.SessionState | 
Performed 
node.createQuery(/jcr:root/mailboxes/_x0023_private/t/tr/try_x0040_moxter.net/INBOX//element(*,jamesMailbox:message)
 order by @jamesMailbox:uid, xpath) in 872us
DEBUG 18:27:48,764 | org.apache.jackrabbit.core.session.SessionState | 
Performing 
query.execute(/jcr:root/mailboxes/_x0023_private/t/tr/try_x0040_moxter.net/INBOX//element(*,jamesMailbox:message)
 order by @jamesMailbox:uid)
DEBUG 18:27:48,764 | org.apache.jackrabbit.core.query.lucene.QueryImpl | 
Executing query: 
+ Root node
+ Select properties: *
  + PathQueryNode
    + LocationStepQueryNode:  NodeTest={} Descendants=false Index=NONE
    + LocationStepQueryNode:  NodeTest={}mailboxes Descendants=false Index=NONE
    + LocationStepQueryNode:  NodeTest={}#private Descendants=false Index=NONE
    + LocationStepQueryNode:  NodeTest={}t Descendants=false Index=NONE
    + LocationStepQueryNode:  NodeTest={}tr Descendants=false Index=NONE
    + LocationStepQueryNode:  NodeTest={}[email protected] Descendants=false 
Index=NONE
    + LocationStepQueryNode:  NodeTest={}INBOX Descendants=false Index=NONE
    + LocationStepQueryNode:  NodeTest=* Descendants=true Index=NONE
      + NodeTypeQueryNode:  Prop={http://www.jcp.org/jcr/1.0}primaryType 
Value={http://james.apache.org/imap/jcr/}message
  + OrderQueryNode
    {http://james.apache.org/imap/jcr/}uid asc=true

DEBUG 18:27:48,765 | org.apache.jackrabbit.core.query.lucene.QueryResultImpl | 
getResults(2147483647) limit=-1
DEBUG 18:27:48,766 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | #5 
TermDocs(_:PROPERTIES,1570322:mixinTypes[16318755:message)
DEBUG 18:27:48,766 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | #5 
TermDocs(_:PROPERTIES,1570322:mixinTypes[16318755:message)
DEBUG 18:27:48,766 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | #5 
TermDocs(_:PROPERTIES,1570322:mixinTypes[16318755:message)
DEBUG 18:27:48,766 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | #5 
TermDocs(_:PROPERTIES,1570322:mixinTypes[16318755:message)
DEBUG 18:27:48,766 | org.apache.jackrabbit.core.query.lucene.ChildAxisQuery | 
got NodeState with id cafebabe-cafe-babe-cafe-babecafebabe in 0 ms.
DEBUG 18:27:48,766 | org.apache.jackrabbit.core.query.lucene.ChildAxisQuery | 
got NodeState with id b435e326-568c-423b-a144-0c28e26662a1 in 0 ms.
DEBUG 18:27:48,766 | org.apache.jackrabbit.core.query.lucene.ChildAxisQuery | 
got NodeState with id 1746a457-ae82-4adc-867b-1249dc7bcac9 in 0 ms.
DEBUG 18:27:48,766 | org.apache.jackrabbit.core.query.lucene.ChildAxisQuery | 
got NodeState with id 3ee44511-0b1d-48a7-ace0-4ff4df4c407f in 0 ms.
DEBUG 18:27:48,767 | org.apache.jackrabbit.core.query.lucene.ChildAxisQuery | 
got NodeState with id 8e41989d-cf1c-430b-9850-1b5539ebfd55 in 1 ms.
DEBUG 18:27:48,767 | org.apache.jackrabbit.core.query.lucene.ChildAxisQuery | 
got NodeState with id fc233ac3-4f94-42b9-9bbe-2fba32304da1 in 0 ms.
DEBUG 18:27:48,767 | 
org.apache.jackrabbit.core.query.lucene.DescendantSelfAxisQuery | Collected 1 
context hits in 1 ms for 
DescendantSelfAxisQuery(ChildAxisQuery(ChildAxisQuery(ChildAxisQuery(ChildAxisQuery(ChildAxisQuery(ChildAxisQuery(_:PARENT:,
 {}mailboxes), {}#private), {}t), {}tr), {}[email protected]), {}INBOX), 
_:PROPERTIES:1570322:mixinTypes[16318755:message, 1)
DEBUG 18:27:48,767 | 
org.apache.jackrabbit.core.query.lucene.SortedLuceneQueryHits | getHits() 
0/32768
DEBUG 18:27:48,767 | org.apache.jackrabbit.core.query.lucene.QueryResultImpl | 
query executed in 2 ms (1)
DEBUG 18:27:48,767 | org.apache.jackrabbit.core.query.lucene.QueryResultImpl | 
retrieved ScoreNodes in 0 ms (0)
DEBUG 18:27:48,767 | org.apache.jackrabbit.core.session.SessionState | 
Performed 
query.execute(/jcr:root/mailboxes/_x0023_private/t/tr/try_x0040_moxter.net/INBOX//element(*,jamesMailbox:message)
 order by @jamesMailbox:uid) in 2ms
DEBUG 18:27:48,767 | org.apache.jackrabbit.core.query.QueryImpl | executed in 
0.00 s. 
(/jcr:root/mailboxes/_x0023_private/t/tr/try_x0040_moxter.net/INBOX//element(*,jamesMailbox:message)
 order by @jamesMailbox:uid)
DEBUG 18:27:48,767 | org.apache.jackrabbit.core.session.SessionState | 
Performing 
org.apache.jackrabbit.core.query.lucene.NodeIteratorImpl$FetchNext@1b64deb
DEBUG 18:27:48,767 | org.apache.jackrabbit.core.session.SessionState | 
Performed 
org.apache.jackrabbit.core.query.lucene.NodeIteratorImpl$FetchNext@1b64deb in 
2us
DEBUG 18:27:48,767 | org.apache.jackrabbit.core.session.SessionState | 
Performing session.refresh(true)
DEBUG 18:27:48,767 | org.apache.jackrabbit.core.session.SessionState | 
Performed session.refresh(true) in 1us
DEBUG 18:27:48,767 | org.apache.jackrabbit.core.session.SessionState | 
Performing item.getPath()
DEBUG 18:27:48,767 | org.apache.jackrabbit.core.session.SessionState | 
Performed item.getPath() in 29us
DEBUG 18:27:48,767 | org.apache.jackrabbit.core.session.SessionState | 
Performing 
node.createQuery(/jcr:root/mailboxes/_x0023_private/t/tr/try_x0040_moxter.net/INBOX//element(*,jamesMailbox:message)[@jamesMailbox:recent='true']
 order by @jamesMailbox:uid, xpath)
DEBUG 18:27:48,768 | org.apache.jackrabbit.core.session.SessionState | 
Performed 
node.createQuery(/jcr:root/mailboxes/_x0023_private/t/tr/try_x0040_moxter.net/INBOX//element(*,jamesMailbox:message)[@jamesMailbox:recent='true']
 order by @jamesMailbox:uid, xpath) in 770us
DEBUG 18:27:48,768 | org.apache.jackrabbit.core.session.SessionState | 
Performing 
query.execute(/jcr:root/mailboxes/_x0023_private/t/tr/try_x0040_moxter.net/INBOX//element(*,jamesMailbox:message)[@jamesMailbox:recent='true']
 order by @jamesMailbox:uid)
DEBUG 18:27:48,768 | org.apache.jackrabbit.core.query.lucene.QueryImpl | 
Executing query: 
+ Root node
+ Select properties: *
  + PathQueryNode
    + LocationStepQueryNode:  NodeTest={} Descendants=false Index=NONE
    + LocationStepQueryNode:  NodeTest={}mailboxes Descendants=false Index=NONE
    + LocationStepQueryNode:  NodeTest={}#private Descendants=false Index=NONE
    + LocationStepQueryNode:  NodeTest={}t Descendants=false Index=NONE
    + LocationStepQueryNode:  NodeTest={}tr Descendants=false Index=NONE
    + LocationStepQueryNode:  NodeTest={}[email protected] Descendants=false 
Index=NONE
    + LocationStepQueryNode:  NodeTest={}INBOX Descendants=false Index=NONE
    + LocationStepQueryNode:  NodeTest=* Descendants=true Index=NONE
      + NodeTypeQueryNode:  Prop={http://www.jcp.org/jcr/1.0}primaryType 
Value={http://james.apache.org/imap/jcr/}message
      + RelationQueryNode: Op: = Prop=[      + PathQueryNode
        + LocationStepQueryNode:  
NodeTest={http://james.apache.org/imap/jcr/}recent Descendants=false Index=NONE
] Type=STRING Value=true
  + OrderQueryNode
    {http://james.apache.org/imap/jcr/}uid asc=true

DEBUG 18:27:48,769 | org.apache.jackrabbit.core.query.lucene.LuceneQueryBuilder 
| Coerced true into NAME.
DEBUG 18:27:48,769 | org.apache.jackrabbit.core.query.lucene.QueryResultImpl | 
getResults(2147483647) limit=-1
DEBUG 18:27:48,770 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | #6 
TermDocs(_:PROPERTIES,1570322:mixinTypes[16318755:message)
DEBUG 18:27:48,770 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | #6 
TermDocs(_:PROPERTIES,1570322:mixinTypes[16318755:message)
DEBUG 18:27:48,770 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | #6 
TermDocs(_:PROPERTIES,1570322:mixinTypes[16318755:message)
DEBUG 18:27:48,770 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | #6 
TermDocs(_:PROPERTIES,1570322:mixinTypes[16318755:message)
DEBUG 18:27:48,770 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | #3 
TermDocs(_:PROPERTIES,16318755:recent[true)
DEBUG 18:27:48,770 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | #3 
TermDocs(_:PROPERTIES,16318755:recent[true)
DEBUG 18:27:48,771 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | #3 
TermDocs(_:PROPERTIES,16318755:recent[true)
DEBUG 18:27:48,771 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | #3 
TermDocs(_:PROPERTIES,16318755:recent[true)
DEBUG 18:27:48,771 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | #3 
TermDocs(_:PROPERTIES,16318755:recent[0:true)
DEBUG 18:27:48,771 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | #3 
TermDocs(_:PROPERTIES,16318755:recent[0:true)
DEBUG 18:27:48,771 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | #3 
TermDocs(_:PROPERTIES,16318755:recent[0:true)
DEBUG 18:27:48,771 | org.apache.jackrabbit.core.query.lucene.TermDocsCache | #3 
TermDocs(_:PROPERTIES,16318755:recent[0:true)
DEBUG 18:27:48,771 | org.apache.jackrabbit.core.query.lucene.ChildAxisQuery | 
got NodeState with id cafebabe-cafe-babe-cafe-babecafebabe in 0 ms.
DEBUG 18:27:48,771 | org.apache.jackrabbit.core.query.lucene.ChildAxisQuery | 
got NodeState with id b435e326-568c-423b-a144-0c28e26662a1 in 0 ms.
DEBUG 18:27:48,771 | org.apache.jackrabbit.core.query.lucene.ChildAxisQuery | 
got NodeState with id 1746a457-ae82-4adc-867b-1249dc7bcac9 in 0 ms.
DEBUG 18:27:48,771 | org.apache.jackrabbit.core.query.lucene.ChildAxisQuery | 
got NodeState with id 3ee44511-0b1d-48a7-ace0-4ff4df4c407f in 0 ms.
DEBUG 18:27:48,771 | org.apache.jackrabbit.core.query.lucene.ChildAxisQuery | 
got NodeState with id 8e41989d-cf1c-430b-9850-1b5539ebfd55 in 0 ms.
DEBUG 18:27:48,771 | org.apache.jackrabbit.core.query.lucene.ChildAxisQuery | 
got NodeState with id fc233ac3-4f94-42b9-9bbe-2fba32304da1 in 0 ms.
DEBUG 18:27:48,771 | 
org.apache.jackrabbit.core.query.lucene.DescendantSelfAxisQuery | Collected 1 
context hits in 0 ms for 
DescendantSelfAxisQuery(ChildAxisQuery(ChildAxisQuery(ChildAxisQuery(ChildAxisQuery(ChildAxisQuery(ChildAxisQuery(_:PARENT:,
 {}mailboxes), {}#private), {}t), {}tr), {}[email protected]), {}INBOX), 
+_:PROPERTIES:1570322:mixinTypes[16318755:message 
+(_:PROPERTIES:16318755:recent[true _:PROPERTIES:16318755:recent[0:true), 1)
DEBUG 18:27:48,771 | 
org.apache.jackrabbit.core.query.lucene.SortedLuceneQueryHits | getHits() 
0/32768
DEBUG 18:27:48,772 | org.apache.jackrabbit.core.query.lucene.QueryResultImpl | 
query executed in 3 ms (1)
DEBUG 18:27:48,772 | org.apache.jackrabbit.core.query.lucene.QueryResultImpl | 
retrieved ScoreNodes in 0 ms (0)
DEBUG 18:27:48,772 | org.apache.jackrabbit.core.session.SessionState | 
Performed 
query.execute(/jcr:root/mailboxes/_x0023_private/t/tr/try_x0040_moxter.net/INBOX//element(*,jamesMailbox:message)[@jamesMailbox:recent='true']
 order by @jamesMailbox:uid) in 3ms
DEBUG 18:27:48,772 | org.apache.jackrabbit.core.query.QueryImpl | executed in 
0.00 s. 
(/jcr:root/mailboxes/_x0023_private/t/tr/try_x0040_moxter.net/INBOX//element(*,jamesMailbox:message)[@jamesMailbox:recent='true']
 order by @jamesMailbox:uid)
DEBUG 18:27:48,772 | org.apache.jackrabbit.core.session.SessionState | 
Performing 
org.apache.jackrabbit.core.query.lucene.NodeIteratorImpl$FetchNext@10e921d
DEBUG 18:27:48,772 | org.apache.jackrabbit.core.session.SessionState | 
Performed 
org.apache.jackrabbit.core.query.lucene.NodeIteratorImpl$FetchNext@10e921d in 
2us
DEBUG 18:27:48,772 | org.apache.jackrabbit.core.session.SessionState | 
Performing node.getProperty(jamesMailbox:mailboxUidValidity)
DEBUG 18:27:48,772 | org.apache.jackrabbit.core.ItemManager | caching item 
677f73b6-e9c8-44fe-87bf-7ca7da972dc0/{http://james.apache.org/imap/jcr/}mailboxUidValidity
DEBUG 18:27:48,772 | org.apache.jackrabbit.core.session.SessionState | 
Performed node.getProperty(jamesMailbox:mailboxUidValidity) in 375us
DEBUG 18:27:48,774 | james.imapserver | ID=15304902 Error while processing imap 
request
<openjpa-2.1.0-r422266:1071316 nonfatal user error> 
org.apache.openjpa.persistence.InvalidStateException: This operation cannot be 
performed while a Transaction is active.
        at org.apache.openjpa.kernel.BrokerImpl.close(BrokerImpl.java:4304)
        at 
org.apache.openjpa.kernel.DelegatingBroker.close(DelegatingBroker.java:1346)
        at 
org.apache.openjpa.persistence.EntityManagerImpl.close(EntityManagerImpl.java:1284)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:616)
        at 
org.springframework.orm.jpa.ExtendedEntityManagerCreator$ExtendedEntityManagerInvocationHandler.invoke(ExtendedEntityManagerCreator.java:365)
        at $Proxy53.close(Unknown Source)
        at 
org.apache.james.mailbox.jpa.mail.JPAUidProvider.lastUid(JPAUidProvider.java:58)
        at 
org.apache.james.mailbox.store.mail.AbstractMessageMapper.getLastUid(AbstractMessageMapper.java:68)
        at 
org.apache.james.mailbox.store.StoreMessageManager.getMetaData(StoreMessageManager.java:373)
        at 
org.apache.james.imap.processor.AbstractSelectionProcessor.selectMailbox(AbstractSelectionProcessor.java:180)
        at 
org.apache.james.imap.processor.AbstractSelectionProcessor.doProcess(AbstractSelectionProcessor.java:86)
        at 
org.apache.james.imap.processor.AbstractSelectionProcessor.doProcess(AbstractSelectionProcessor.java:53)
        at 
org.apache.james.imap.processor.AbstractMailboxProcessor.doProcess(AbstractMailboxProcessor.java:90)
        at 
org.apache.james.imap.processor.AbstractMailboxProcessor.process(AbstractMailboxProcessor.java:79)
        at 
org.apache.james.imap.processor.AbstractMailboxProcessor.doProcess(AbstractMailboxProcessor.java:73)
        at 
org.apache.james.imap.processor.AbstractMailboxProcessor.doProcess(AbstractMailboxProcessor.java:56)
        at 
org.apache.james.imap.processor.base.AbstractChainedProcessor.process(AbstractChainedProcessor.java:55)
        at 
org.apache.james.imap.processor.base.AbstractChainedProcessor.process(AbstractChainedProcessor.java:57)
        at 
org.apache.james.imap.processor.base.AbstractChainedProcessor.process(AbstractChainedProcessor.java:57)
        at 
org.apache.james.imap.processor.base.AbstractChainedProcessor.process(AbstractChainedProcessor.java:57)
        at 
org.apache.james.imap.processor.base.AbstractChainedProcessor.process(AbstractChainedProcessor.java:57)
        at 
org.apache.james.imap.processor.base.AbstractChainedProcessor.process(AbstractChainedProcessor.java:57)
        at 
org.apache.james.imap.processor.base.AbstractChainedProcessor.process(AbstractChainedProcessor.java:57)
        at 
org.apache.james.imap.processor.base.AbstractChainedProcessor.process(AbstractChainedProcessor.java:57)
        at 
org.apache.james.imapserver.netty.ImapChannelUpstreamHandler.messageReceived(ImapChannelUpstreamHandler.java:175)
        at 
org.jboss.netty.handler.stream.ChunkedWriteHandler.handleUpstream(ChunkedWriteHandler.java:148)
        at 
org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:302)
        at 
org.jboss.netty.handler.codec.frame.FrameDecoder.unfoldAndFireMessageReceived(FrameDecoder.java:317)
        at 
org.jboss.netty.handler.codec.frame.FrameDecoder.callDecode(FrameDecoder.java:299)
        at 
org.jboss.netty.handler.codec.frame.FrameDecoder.messageReceived(FrameDecoder.java:216)
        at 
org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:302)
        at 
org.jboss.netty.handler.codec.frame.FrameDecoder.unfoldAndFireMessageReceived(FrameDecoder.java:317)
        at 
org.jboss.netty.handler.codec.frame.FrameDecoder.callDecode(FrameDecoder.java:299)
        at 
org.jboss.netty.handler.codec.frame.FrameDecoder.messageReceived(FrameDecoder.java:216)
        at 
org.jboss.netty.handler.timeout.IdleStateAwareChannelHandler.handleUpstream(IdleStateAwareChannelHandler.java:48)
        at 
org.jboss.netty.handler.timeout.IdleStateHandler.messageReceived(IdleStateHandler.java:276)
        at 
org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:274)
        at 
org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:261)
        at org.jboss.netty.channel.socket.oio.OioWorker.run(OioWorker.java:90)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
        at java.lang.Thread.run(Thread.java:679)
INFO  18:27:48,775 | james.imapserver | ID=15304902 Connection closed for 
ip-XXXXXXXXXXXXXXXXXXXXXXX)
DEBUG 18:27:53,968 | james.imapserver | ID=9129144 Got <tag>: 5.2697
DEBUG 18:27:53,992 | james.imapserver | ID=9129144 Got <command>: EXAMINE
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to