Thanks Sanne. I figured up jconsole and all 3 caches are present under org.infinispan
LuceneIndexesData(repl_sync)
LuceneIndexesLocking(repl_sync)
LuceneIndexesMetadata(repl_sync)So all appear to be fine there. Here is a snippet of the logs with org.infinispan on TRACE. The whole log was too big to post, so let me know if you want me to email to you instead. I hope this gives you want you need.
Code:
2011-04-18 16:08:54,020 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Number of entries in context: 1
2011-04-18 16:08:54,020 [main] TRACE org.infinispan.container.entries.ReadCommittedEntry - Updating entry (key=segments_1|M|com.dummy.demo.Person removed=false valid=true changed=true created=true value=FileMetadata{lastModified=1303157334019, size=32}]
2011-04-18 16:08:54,021 [main] TRACE org.infinispan.interceptors.InvocationContextInterceptor - Invoked with command GetKeyValueCommand {key=*|com.dummy.demo.Person, flags=[SKIP_LOCKING]} and InvocationContext [NonTxInvocationContext{flags=[SKIP_LOCKING]}]
2011-04-18 16:08:54,021 [main] TRACE org.infinispan.container.EntryFactoryImpl - Key *|com.dummy.demo.Person is not in context, fetching from container.
2011-04-18 16:08:54,021 [main] TRACE org.infinispan.interceptors.CallInterceptor - Executing command: GetKeyValueCommand {key=*|com.dummy.demo.Person, flags=[SKIP_LOCKING]}.
2011-04-18 16:08:54,021 [main] TRACE org.infinispan.commands.read.GetKeyValueCommand - Found value []
2011-04-18 16:08:54,021 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Number of entries in context: 1
2011-04-18 16:08:54,021 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Entry for key *|com.dummy.demo.Person is null, not calling commitUpdate
2011-04-18 16:08:54,021 [main] TRACE org.infinispan.interceptors.InvocationContextInterceptor - Invoked with command PutKeyValueCommand{key=*|com.dummy.demo.Person, value=[segments_1], flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1} and InvocationContext [NonTxInvocationContext{flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP]}]
2011-04-18 16:08:54,021 [main] TRACE org.infinispan.container.EntryFactoryImpl - SKIP_LOCKING flag used!
2011-04-18 16:08:54,021 [main] TRACE org.infinispan.container.EntryFactoryImpl - Retrieved from container.
2011-04-18 16:08:54,021 [main] TRACE org.infinispan.interceptors.CallInterceptor - Executing command: PutKeyValueCommand{key=*|com.dummy.demo.Person, value=[segments_1], flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1}.
2011-04-18 16:08:54,021 [main] TRACE org.infinispan.remoting.rpc.RpcManagerImpl - Macintosh-59472 broadcasting call PutKeyValueCommand{key=*|com.dummy.demo.Person, value=[segments_1], flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1} to recipient list null
2011-04-18 16:08:54,021 [main] DEBUG org.infinispan.remoting.rpc.RpcManagerImpl - We're the only member in the cluster; Don't invoke remotely.
2011-04-18 16:08:54,021 [main] TRACE org.infinispan.remoting.rpc.RpcManagerImpl - Response(s) to SingleRpcCommand{cacheName='LuceneIndexesMetadata', command=PutKeyValueCommand{key=*|com.dummy.demo.Person, value=[segments_1], flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1}} is {}
2011-04-18 16:08:54,022 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Number of entries in context: 1
2011-04-18 16:08:54,022 [main] TRACE org.infinispan.container.entries.ReadCommittedEntry - Updating entry (key=*|com.dummy.demo.Person removed=false valid=true changed=true created=false value=[segments_1]]
2011-04-18 16:08:54,022 [main] TRACE org.infinispan.transaction.tm.DummyBaseTransactionManager - Resuming tx DummyTransaction{xid=DummyXid{id=1}, status=0}
2011-04-18 16:08:54,023 [main] TRACE org.infinispan.transaction.xa.TransactionXaAdapter - Sending prepare command through the chain: PrepareCommand {gtx=GlobalTransaction:<Macintosh-59472>:1:local, modifications=[PutKeyValueCommand{key=segments_1|0|com.dummy.demo.Person, value=[B@4a8f5f75, flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1}], onePhaseCommit=false, gtx=GlobalTransaction:<Macintosh-59472>:1:local, cacheName='LuceneIndexesData'}
2011-04-18 16:08:54,023 [main] TRACE org.infinispan.interceptors.InvocationContextInterceptor - Invoked with command PrepareCommand {gtx=GlobalTransaction:<Macintosh-59472>:1:local, modifications=[PutKeyValueCommand{key=segments_1|0|com.dummy.demo.Person, value=[B@4a8f5f75, flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1}], onePhaseCommit=false, gtx=GlobalTransaction:<Macintosh-59472>:1:local, cacheName='LuceneIndexesData'} and InvocationContext [LocalTxInvocationContext{flags=null}]
2011-04-18 16:08:54,024 [main] TRACE org.infinispan.interceptors.CallInterceptor - Suppressing invocation of method handlePrepareCommand.
2011-04-18 16:08:54,024 [main] TRACE org.infinispan.remoting.rpc.RpcManagerImpl - Macintosh-59472 broadcasting call PrepareCommand {gtx=GlobalTransaction:<Macintosh-59472>:1:local, modifications=[PutKeyValueCommand{key=segments_1|0|com.dummy.demo.Person, value=[B@4a8f5f75, flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1}], onePhaseCommit=false, gtx=GlobalTransaction:<Macintosh-59472>:1:local, cacheName='LuceneIndexesData'} to recipient list null
2011-04-18 16:08:54,024 [main] DEBUG org.infinispan.remoting.rpc.RpcManagerImpl - We're the only member in the cluster; Don't invoke remotely.
2011-04-18 16:08:54,024 [main] TRACE org.infinispan.remoting.rpc.RpcManagerImpl - Response(s) to PrepareCommand {gtx=GlobalTransaction:<Macintosh-59472>:1:local, modifications=[PutKeyValueCommand{key=segments_1|0|com.dummy.demo.Person, value=[B@4a8f5f75, flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1}], onePhaseCommit=false, gtx=GlobalTransaction:<Macintosh-59472>:1:local, cacheName='LuceneIndexesData'} is {}
2011-04-18 16:08:54,025 [main] TRACE org.infinispan.transaction.xa.TransactionXaAdapter - Committing transaction GlobalTransaction:<Macintosh-59472>:1:local
2011-04-18 16:08:54,025 [main] TRACE org.infinispan.interceptors.InvocationContextInterceptor - Invoked with command CommitCommand {gtx=GlobalTransaction:<Macintosh-59472>:1:local, cacheName='LuceneIndexesData'} and InvocationContext [LocalTxInvocationContext{flags=null}]
2011-04-18 16:08:54,025 [main] TRACE org.infinispan.remoting.rpc.RpcManagerImpl - Macintosh-59472 broadcasting call CommitCommand {gtx=GlobalTransaction:<Macintosh-59472>:1:local, cacheName='LuceneIndexesData'} to recipient list null
2011-04-18 16:08:54,025 [main] DEBUG org.infinispan.remoting.rpc.RpcManagerImpl - We're the only member in the cluster; Don't invoke remotely.
2011-04-18 16:08:54,025 [main] TRACE org.infinispan.remoting.rpc.RpcManagerImpl - Response(s) to CommitCommand {gtx=GlobalTransaction:<Macintosh-59472>:1:local, cacheName='LuceneIndexesData'} is {}
2011-04-18 16:08:54,025 [main] TRACE org.infinispan.interceptors.CallInterceptor - Suppressing invocation of method handleCommitCommand.
2011-04-18 16:08:54,025 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Number of entries in context: 1
2011-04-18 16:08:54,025 [main] TRACE org.infinispan.container.entries.ReadCommittedEntry - Updating entry (key=segments_1|0|com.dummy.demo.Person removed=false valid=true changed=true created=true value=[B@4a8f5f75]
2011-04-18 16:08:54,025 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Releasing lock on [segments_1|0|com.dummy.demo.Person] for owner GlobalTransaction:<Macintosh-59472>:1:local
2011-04-18 16:08:54,026 [main] TRACE org.infinispan.util.concurrent.locks.LockManagerImpl - Attempting to unlock segments_1|0|com.dummy.demo.Person
2011-04-18 16:08:54,026 [main] TRACE org.infinispan.lucene.InfinispanIndexOutput - Closed IndexOutput for file:segments_1 in index: com.dummy.demo.Person
2011-04-18 16:08:54,026 [main] TRACE org.infinispan.lucene.InfinispanIndexOutput - Opened new IndexOutput for file:segments.gen in index: com.dummy.demo.Person
2011-04-18 16:08:54,026 [main] TRACE org.infinispan.transaction.tm.DummyBaseTransactionManager - Suspending tx DummyTransaction{xid=DummyXid{id=2}, status=0}
2011-04-18 16:08:54,026 [main] TRACE org.infinispan.lucene.InfinispanIndexOutput - Storing segment chunk: segments.gen|0|com.dummy.demo.Person
2011-04-18 16:08:54,026 [main] TRACE org.infinispan.transaction.tm.DummyBaseTransactionManager - Resuming tx DummyTransaction{xid=DummyXid{id=2}, status=0}
2011-04-18 16:08:54,026 [main] TRACE org.infinispan.interceptors.InvocationContextInterceptor - Invoked with command PutKeyValueCommand{key=segments.gen|0|com.dummy.demo.Person, value=[B@15ea9246, flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1} and InvocationContext [LocalTxInvocationContext{flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP]}]
2011-04-18 16:08:54,026 [main] TRACE org.infinispan.transaction.xa.TransactionTable - Created a new GlobalTransaction GlobalTransaction:<Macintosh-59472>:2:local
2011-04-18 16:08:54,026 [main] TRACE org.infinispan.transaction.xa.TransactionXaAdapter - start called on tx GlobalTransaction:<Macintosh-59472>:2:local
2011-04-18 16:08:54,026 [main] TRACE org.infinispan.container.EntryFactoryImpl - SKIP_LOCKING flag used!
2011-04-18 16:08:54,026 [main] TRACE org.infinispan.container.EntryFactoryImpl - Creating new entry.
2011-04-18 16:08:54,026 [main] TRACE org.infinispan.interceptors.CallInterceptor - Executing command: PutKeyValueCommand{key=segments.gen|0|com.dummy.demo.Person, value=[B@15ea9246, flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1}.
2011-04-18 16:08:54,026 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Transactional. Not cleaning up locks till the transaction ends.
2011-04-18 16:08:54,027 [main] TRACE org.infinispan.transaction.xa.LocalTransaction - Adding modification PutKeyValueCommand{key=segments.gen|0|com.dummy.demo.Person, value=[B@15ea9246, flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1}. Mod list is null
2011-04-18 16:08:54,027 [main] TRACE org.infinispan.transaction.tm.DummyBaseTransactionManager - Suspending tx DummyTransaction{xid=DummyXid{id=2}, status=0}
2011-04-18 16:08:54,027 [main] TRACE org.infinispan.interceptors.InvocationContextInterceptor - Invoked with command PutKeyValueCommand{key=segments.gen|M|com.dummy.demo.Person, value=FileMetadata{lastModified=1303157334027, size=20}, flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1} and InvocationContext [NonTxInvocationContext{flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP]}]
2011-04-18 16:08:54,027 [main] TRACE org.infinispan.container.EntryFactoryImpl - SKIP_LOCKING flag used!
2011-04-18 16:08:54,039 [main] TRACE org.infinispan.container.EntryFactoryImpl - Creating new entry.
2011-04-18 16:08:54,039 [main] TRACE org.infinispan.interceptors.CallInterceptor - Executing command: PutKeyValueCommand{key=segments.gen|M|com.dummy.demo.Person, value=FileMetadata{lastModified=1303157334027, size=20}, flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1}.
2011-04-18 16:08:54,040 [main] TRACE org.infinispan.remoting.rpc.RpcManagerImpl - Macintosh-59472 broadcasting call PutKeyValueCommand{key=segments.gen|M|com.dummy.demo.Person, value=FileMetadata{lastModified=1303157334027, size=20}, flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1} to recipient list null
2011-04-18 16:08:54,040 [main] DEBUG org.infinispan.remoting.rpc.RpcManagerImpl - We're the only member in the cluster; Don't invoke remotely.
2011-04-18 16:08:54,040 [main] TRACE org.infinispan.remoting.rpc.RpcManagerImpl - Response(s) to SingleRpcCommand{cacheName='LuceneIndexesMetadata', command=PutKeyValueCommand{key=segments.gen|M|com.dummy.demo.Person, value=FileMetadata{lastModified=1303157334027, size=20}, flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1}} is {}
2011-04-18 16:08:54,040 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Number of entries in context: 1
2011-04-18 16:08:54,040 [main] TRACE org.infinispan.container.entries.ReadCommittedEntry - Updating entry (key=segments.gen|M|com.dummy.demo.Person removed=false valid=true changed=true created=true value=FileMetadata{lastModified=1303157334027, size=20}]
2011-04-18 16:08:54,040 [main] TRACE org.infinispan.interceptors.InvocationContextInterceptor - Invoked with command GetKeyValueCommand {key=*|com.dummy.demo.Person, flags=[SKIP_LOCKING]} and InvocationContext [NonTxInvocationContext{flags=[SKIP_LOCKING]}]
2011-04-18 16:08:54,041 [main] TRACE org.infinispan.container.EntryFactoryImpl - Key *|com.dummy.demo.Person is not in context, fetching from container.
2011-04-18 16:08:54,042 [main] TRACE org.infinispan.interceptors.CallInterceptor - Executing command: GetKeyValueCommand {key=*|com.dummy.demo.Person, flags=[SKIP_LOCKING]}.
2011-04-18 16:08:54,042 [main] TRACE org.infinispan.commands.read.GetKeyValueCommand - Found value [segments_1]
2011-04-18 16:08:54,042 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Number of entries in context: 1
2011-04-18 16:08:54,042 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Entry for key *|com.dummy.demo.Person is null, not calling commitUpdate
2011-04-18 16:08:54,042 [main] TRACE org.infinispan.interceptors.InvocationContextInterceptor - Invoked with command PutKeyValueCommand{key=*|com.dummy.demo.Person, value=[segments_1, segments.gen], flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1} and InvocationContext [NonTxInvocationContext{flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP]}]
2011-04-18 16:08:54,042 [main] TRACE org.infinispan.container.EntryFactoryImpl - SKIP_LOCKING flag used!
2011-04-18 16:08:54,042 [main] TRACE org.infinispan.container.EntryFactoryImpl - Retrieved from container.
2011-04-18 16:08:54,042 [main] TRACE org.infinispan.interceptors.CallInterceptor - Executing command: PutKeyValueCommand{key=*|com.dummy.demo.Person, value=[segments_1, segments.gen], flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1}.
2011-04-18 16:08:54,042 [main] TRACE org.infinispan.remoting.rpc.RpcManagerImpl - Macintosh-59472 broadcasting call PutKeyValueCommand{key=*|com.dummy.demo.Person, value=[segments_1, segments.gen], flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1} to recipient list null
2011-04-18 16:08:54,042 [main] DEBUG org.infinispan.remoting.rpc.RpcManagerImpl - We're the only member in the cluster; Don't invoke remotely.
2011-04-18 16:08:54,042 [main] TRACE org.infinispan.remoting.rpc.RpcManagerImpl - Response(s) to SingleRpcCommand{cacheName='LuceneIndexesMetadata', command=PutKeyValueCommand{key=*|com.dummy.demo.Person, value=[segments_1, segments.gen], flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1}} is {}
2011-04-18 16:08:54,042 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Number of entries in context: 1
2011-04-18 16:08:54,043 [main] TRACE org.infinispan.container.entries.ReadCommittedEntry - Updating entry (key=*|com.dummy.demo.Person removed=false valid=true changed=true created=false value=[segments_1, segments.gen]]
2011-04-18 16:08:54,043 [main] TRACE org.infinispan.transaction.tm.DummyBaseTransactionManager - Resuming tx DummyTransaction{xid=DummyXid{id=2}, status=0}
2011-04-18 16:08:54,043 [main] TRACE org.infinispan.transaction.xa.TransactionXaAdapter - Sending prepare command through the chain: PrepareCommand {gtx=GlobalTransaction:<Macintosh-59472>:2:local, modifications=[PutKeyValueCommand{key=segments.gen|0|com.dummy.demo.Person, value=[B@15ea9246, flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1}], onePhaseCommit=false, gtx=GlobalTransaction:<Macintosh-59472>:2:local, cacheName='LuceneIndexesData'}
2011-04-18 16:08:54,043 [main] TRACE org.infinispan.interceptors.InvocationContextInterceptor - Invoked with command PrepareCommand {gtx=GlobalTransaction:<Macintosh-59472>:2:local, modifications=[PutKeyValueCommand{key=segments.gen|0|com.dummy.demo.Person, value=[B@15ea9246, flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1}], onePhaseCommit=false, gtx=GlobalTransaction:<Macintosh-59472>:2:local, cacheName='LuceneIndexesData'} and InvocationContext [LocalTxInvocationContext{flags=null}]
2011-04-18 16:08:54,043 [main] TRACE org.infinispan.interceptors.CallInterceptor - Suppressing invocation of method handlePrepareCommand.
2011-04-18 16:08:54,043 [main] TRACE org.infinispan.remoting.rpc.RpcManagerImpl - Macintosh-59472 broadcasting call PrepareCommand {gtx=GlobalTransaction:<Macintosh-59472>:2:local, modifications=[PutKeyValueCommand{key=segments.gen|0|com.dummy.demo.Person, value=[B@15ea9246, flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1}], onePhaseCommit=false, gtx=GlobalTransaction:<Macintosh-59472>:2:local, cacheName='LuceneIndexesData'} to recipient list null
2011-04-18 16:08:54,043 [main] DEBUG org.infinispan.remoting.rpc.RpcManagerImpl - We're the only member in the cluster; Don't invoke remotely.
2011-04-18 16:08:54,043 [main] TRACE org.infinispan.remoting.rpc.RpcManagerImpl - Response(s) to PrepareCommand {gtx=GlobalTransaction:<Macintosh-59472>:2:local, modifications=[PutKeyValueCommand{key=segments.gen|0|com.dummy.demo.Person, value=[B@15ea9246, flags=[SKIP_LOCKING, SKIP_CACHE_LOAD, SKIP_REMOTE_LOOKUP], putIfAbsent=false, lifespanMillis=-1, maxIdleTimeMillis=-1}], onePhaseCommit=false, gtx=GlobalTransaction:<Macintosh-59472>:2:local, cacheName='LuceneIndexesData'} is {}
2011-04-18 16:08:54,043 [main] TRACE org.infinispan.transaction.xa.TransactionXaAdapter - Committing transaction GlobalTransaction:<Macintosh-59472>:2:local
2011-04-18 16:08:54,043 [main] TRACE org.infinispan.interceptors.InvocationContextInterceptor - Invoked with command CommitCommand {gtx=GlobalTransaction:<Macintosh-59472>:2:local, cacheName='LuceneIndexesData'} and InvocationContext [LocalTxInvocationContext{flags=null}]
2011-04-18 16:08:54,043 [main] TRACE org.infinispan.remoting.rpc.RpcManagerImpl - Macintosh-59472 broadcasting call CommitCommand {gtx=GlobalTransaction:<Macintosh-59472>:2:local, cacheName='LuceneIndexesData'} to recipient list null
2011-04-18 16:08:54,043 [main] DEBUG org.infinispan.remoting.rpc.RpcManagerImpl - We're the only member in the cluster; Don't invoke remotely.
2011-04-18 16:08:54,044 [main] TRACE org.infinispan.remoting.rpc.RpcManagerImpl - Response(s) to CommitCommand {gtx=GlobalTransaction:<Macintosh-59472>:2:local, cacheName='LuceneIndexesData'} is {}
2011-04-18 16:08:54,044 [main] TRACE org.infinispan.interceptors.CallInterceptor - Suppressing invocation of method handleCommitCommand.
2011-04-18 16:08:54,044 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Number of entries in context: 1
2011-04-18 16:08:54,044 [main] TRACE org.infinispan.container.entries.ReadCommittedEntry - Updating entry (key=segments.gen|0|com.dummy.demo.Person removed=false valid=true changed=true created=true value=[B@15ea9246]
2011-04-18 16:08:54,044 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Releasing lock on [segments.gen|0|com.dummy.demo.Person] for owner GlobalTransaction:<Macintosh-59472>:2:local
2011-04-18 16:08:54,044 [main] TRACE org.infinispan.util.concurrent.locks.LockManagerImpl - Attempting to unlock segments.gen|0|com.dummy.demo.Person
2011-04-18 16:08:54,044 [main] TRACE org.infinispan.lucene.InfinispanIndexOutput - Closed IndexOutput for file:segments.gen in index: com.dummy.demo.Person
2011-04-18 16:08:54,047 [main] TRACE org.infinispan.interceptors.InvocationContextInterceptor - Invoked with command RemoveCommand{key=write.lock|M|com.dummy.demo.Person, value=null, flags=[SKIP_CACHE_STORE]} and InvocationContext [NonTxInvocationContext{flags=[SKIP_CACHE_STORE]}]
2011-04-18 16:08:54,047 [main] TRACE org.infinispan.util.concurrent.locks.LockManagerImpl - Attempting to lock write.lock|M|com.dummy.demo.Person with acquisition timeout of 20000 millis
2011-04-18 16:08:54,047 [main] TRACE org.infinispan.util.concurrent.locks.LockManagerImpl - Successfully acquired lock!
2011-04-18 16:08:54,047 [main] TRACE org.infinispan.container.EntryFactoryImpl - Retrieved from container.
2011-04-18 16:08:54,047 [main] TRACE org.infinispan.interceptors.CallInterceptor - Executing command: RemoveCommand{key=write.lock|M|com.dummy.demo.Person, value=null, flags=[SKIP_CACHE_STORE]}.
2011-04-18 16:08:54,047 [main] TRACE org.infinispan.remoting.rpc.RpcManagerImpl - Macintosh-59472 broadcasting call RemoveCommand{key=write.lock|M|com.dummy.demo.Person, value=null, flags=[SKIP_CACHE_STORE]} to recipient list null
2011-04-18 16:08:54,047 [main] DEBUG org.infinispan.remoting.rpc.RpcManagerImpl - We're the only member in the cluster; Don't invoke remotely.
2011-04-18 16:08:54,047 [main] TRACE org.infinispan.remoting.rpc.RpcManagerImpl - Response(s) to SingleRpcCommand{cacheName='LuceneIndexesLocking', command=RemoveCommand{key=write.lock|M|com.dummy.demo.Person, value=null, flags=[SKIP_CACHE_STORE]}} is {}
2011-04-18 16:08:54,047 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Number of entries in context: 1
2011-04-18 16:08:54,047 [main] TRACE org.infinispan.container.entries.ReadCommittedEntry - Updating entry (key=write.lock|M|com.dummy.demo.Person removed=true valid=false changed=true created=false value=write.lock|M|com.dummy.demo.Person]
2011-04-18 16:08:54,048 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Releasing lock on [write.lock|M|com.dummy.demo.Person] for owner Thread[main,5,main]
2011-04-18 16:08:54,048 [main] TRACE org.infinispan.util.concurrent.locks.LockManagerImpl - Attempting to unlock write.lock|M|com.dummy.demo.Person
2011-04-18 16:08:54,048 [main] TRACE org.infinispan.lucene.locking.BaseLuceneLock - Lock removed for index: com.dummy.demo.Person
2011-04-18 16:08:54,048 [main] DEBUG org.hibernate.search.infinispan.InfinispanDirectoryProvider - Initialized Infinispan index: 'com.dummy.demo.Person'
2011-04-18 16:08:54,129 [main] TRACE org.infinispan.interceptors.InvocationContextInterceptor - Invoked with command GetKeyValueCommand {key=*|com.dummy.demo.Person, flags=[SKIP_LOCKING]} and InvocationContext [NonTxInvocationContext{flags=[SKIP_LOCKING]}]
2011-04-18 16:08:54,129 [main] TRACE org.infinispan.container.EntryFactoryImpl - Key *|com.dummy.demo.Person is not in context, fetching from container.
2011-04-18 16:08:54,130 [main] TRACE org.infinispan.interceptors.CallInterceptor - Executing command: GetKeyValueCommand {key=*|com.dummy.demo.Person, flags=[SKIP_LOCKING]}.
2011-04-18 16:08:54,130 [main] TRACE org.infinispan.commands.read.GetKeyValueCommand - Found value [segments_1, segments.gen]
2011-04-18 16:08:54,130 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Number of entries in context: 1
2011-04-18 16:08:54,130 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Entry for key *|com.dummy.demo.Person is null, not calling commitUpdate
2011-04-18 16:08:54,130 [main] TRACE org.infinispan.interceptors.InvocationContextInterceptor - Invoked with command GetKeyValueCommand {key=segments.gen|M|com.dummy.demo.Person, flags=[SKIP_LOCKING]} and InvocationContext [NonTxInvocationContext{flags=[SKIP_LOCKING]}]
2011-04-18 16:08:54,130 [main] TRACE org.infinispan.container.EntryFactoryImpl - Key segments.gen|M|com.dummy.demo.Person is not in context, fetching from container.
2011-04-18 16:08:54,130 [main] TRACE org.infinispan.interceptors.CallInterceptor - Executing command: GetKeyValueCommand {key=segments.gen|M|com.dummy.demo.Person, flags=[SKIP_LOCKING]}.
2011-04-18 16:08:54,130 [main] TRACE org.infinispan.commands.read.GetKeyValueCommand - Found value FileMetadata{lastModified=1303157334027, size=20}
2011-04-18 16:08:54,130 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Number of entries in context: 1
2011-04-18 16:08:54,130 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Entry for key segments.gen|M|com.dummy.demo.Person is null, not calling commitUpdate
2011-04-18 16:08:54,131 [main] TRACE org.infinispan.interceptors.InvocationContextInterceptor - Invoked with command GetKeyValueCommand {key=segments.gen|0|com.dummy.demo.Person, flags=[SKIP_LOCKING]} and InvocationContext [NonTxInvocationContext{flags=[SKIP_LOCKING]}]
2011-04-18 16:08:54,131 [main] TRACE org.infinispan.container.EntryFactoryImpl - Key segments.gen|0|com.dummy.demo.Person is not in context, fetching from container.
2011-04-18 16:08:54,131 [main] TRACE org.infinispan.interceptors.CallInterceptor - Executing command: GetKeyValueCommand {key=segments.gen|0|com.dummy.demo.Person, flags=[SKIP_LOCKING]}.
2011-04-18 16:08:54,131 [main] TRACE org.infinispan.commands.read.GetKeyValueCommand - Found value [B@15ea9246
2011-04-18 16:08:54,131 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Number of entries in context: 1
2011-04-18 16:08:54,131 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Entry for key segments.gen|0|com.dummy.demo.Person is null, not calling commitUpdate
2011-04-18 16:08:54,132 [main] TRACE org.infinispan.interceptors.InvocationContextInterceptor - Invoked with command GetKeyValueCommand {key=segments_1|M|com.dummy.demo.Person, flags=[SKIP_LOCKING]} and InvocationContext [NonTxInvocationContext{flags=[SKIP_LOCKING]}]
2011-04-18 16:08:54,132 [main] TRACE org.infinispan.container.EntryFactoryImpl - Key segments_1|M|com.dummy.demo.Person is not in context, fetching from container.
2011-04-18 16:08:54,132 [main] TRACE org.infinispan.interceptors.CallInterceptor - Executing command: GetKeyValueCommand {key=segments_1|M|com.dummy.demo.Person, flags=[SKIP_LOCKING]}.
2011-04-18 16:08:54,132 [main] TRACE org.infinispan.commands.read.GetKeyValueCommand - Found value FileMetadata{lastModified=1303157334019, size=32}
2011-04-18 16:08:54,132 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Number of entries in context: 1
2011-04-18 16:08:54,132 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Entry for key segments_1|M|com.dummy.demo.Person is null, not calling commitUpdate
2011-04-18 16:08:54,132 [main] TRACE org.infinispan.interceptors.InvocationContextInterceptor - Invoked with command GetKeyValueCommand {key=segments_1|0|com.dummy.demo.Person, flags=[SKIP_LOCKING]} and InvocationContext [NonTxInvocationContext{flags=[SKIP_LOCKING]}]
2011-04-18 16:08:54,132 [main] TRACE org.infinispan.container.EntryFactoryImpl - Key segments_1|0|com.dummy.demo.Person is not in context, fetching from container.
2011-04-18 16:08:54,132 [main] TRACE org.infinispan.interceptors.CallInterceptor - Executing command: GetKeyValueCommand {key=segments_1|0|com.dummy.demo.Person, flags=[SKIP_LOCKING]}.
2011-04-18 16:08:54,132 [main] TRACE org.infinispan.commands.read.GetKeyValueCommand - Found value [B@4a8f5f75
2011-04-18 16:08:54,132 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Number of entries in context: 1
2011-04-18 16:08:54,132 [main] TRACE org.infinispan.interceptors.LockingInterceptor - Entry for key segments_1|0|com.dummy.demo.Person is null, not calling commitUpdate
2011-04-18 16:08:54,156 [main] DEBUG org.hibernate.search.event.FullTextIndexEventListener - Hibernate Search event listeners activated
2011-04-18 16:08:54,156 [main] DEBUG org.hibernate.search.event.FullTextIndexEventListener - Hibernate Search dirty checks enabled
2011-04-18 16:08:54,156 [main] DEBUG org.hibernate.search.event.FullTextIndexEventListener - Hibernate Search event listeners activated
2011-04-18 16:08:54,156 [main] DEBUG org.hibernate.search.event.FullTextIndexEventListener - Hibernate Search dirty checks enabled
2011-04-18 16:08:54,156 [main] DEBUG org.hibernate.search.event.FullTextIndexEventListener - Hibernate Search event listeners activated
2011-04-18 16:08:54,156 [main] DEBUG org.hibernate.search.event.FullTextIndexEventListener - Hibernate Search dirty checks enabled
2011-04-18 16:08:54,157 [main] DEBUG org.hibernate.search.event.FullTextIndexEventListener - Hibernate Search event listeners activated
2011-04-18 16:08:54,157 [main] DEBUG org.hibernate.search.event.FullTextIndexEventListener - Hibernate Search dirty checks enabled
2011-04-18 16:08:54,157 [main] DEBUG org.hibernate.search.event.FullTextIndexEventListener - Hibernate Search event listeners activated
2011-04-18 16:08:54,157 [main] DEBUG org.hibernate.search.event.FullTextIndexEventListener - Hibernate Search dirty checks enabled
2011-04-18 16:08:54,157 [main] DEBUG org.hibernate.search.event.FullTextIndexEventListener - Hibernate Search event listeners activated
2011-04-18 16:08:54,157 [main] DEBUG org.hibernate.search.event.FullTextIndexEventListener - Hibernate Search dirty checks enabled
2011-04-18 16:08:54,157 [main] DEBUG org.hibernate.search.event.FullTextIndexEventListener - Hibernate Search event listeners activated
2011-04-18 16:08:54,157 [main] DEBUG org.hibernate.search.event.FullTextIndexEventListener - Hibernate Search dirty checks enabled
Apr 18, 2011 4:09:03 PM org.apache.coyote.http11.Http11Protocol start
INFO: Starting Coyote HTTP/1.1 on http-9080
Apr 18, 2011 4:09:03 PM org.apache.jk.common.ChannelSocket init
INFO: JK: ajp13 listening on /0.0.0.0:9009
Apr 18, 2011 4:09:03 PM org.apache.jk.server.JkMain start
INFO: Jk running ID=0 time=0/41 config=null
Apr 18, 2011 4:09:03 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 27209 ms
Connected to server
2011-04-18 16:10:22,929 [RMI TCP Connection(1)-192.168.255.64] DEBUG org.infinispan.jmx.ResourceDMBean - Attribute CacheName has r=true,w=false,is=false and value LuceneIndexesData(repl_sync)
2011-04-18 16:10:22,931 [RMI TCP Connection(1)-192.168.255.64] DEBUG org.infinispan.jmx.ResourceDMBean - Attribute CacheStatus has r=true,w=false,is=false and value RUNNING