Hi Jan,

there is a bug in the conf/context/james-mailbox-jcr-context.xml

replace:

    <bean id="jcr-sessionMapperFactory"
class="org.apache.james.mailbox.jcr.JCRMailboxSessionMapperFactory">
        <constructor-arg index="0" ref="jcr-sessionJcrRepository"/>
        <constructor-arg index="1" ref="jpa-uidProvider"/>
        <constructor-arg index="2" ref="jpa-modSeqProvider"/>
    </bean>

with:

    <bean id="jcr-sessionMapperFactory"
class="org.apache.james.mailbox.jcr.JCRMailboxSessionMapperFactory">
        <constructor-arg index="0" ref="jcr-sessionJcrRepository"/>
        <constructor-arg index="1" ref="jcr-uidProvider"/>
        <constructor-arg index="2" ref="jcr-modSeqProvider"/>
    </bean>

This should fix it. Please retest and report..

Thanks,
Norman


2011/8/25 Jan Moxter <[email protected]>:
> 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]
>
>

---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to