You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2018/09/06 12:12:45 UTC
[JENKINS] Lucene-Solr-master-Linux (64bit/jdk1.8.0_172) - Build #
22810 - Still Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/22810/
Java: 64bit/jdk1.8.0_172 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
3 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.update.TransactionLogTest
Error Message:
1 thread leaked from SUITE scope at org.apache.solr.update.TransactionLogTest: 1) Thread[id=15, name=Log4j2-TF-1-AsyncLoggerConfig--1, state=TIMED_WAITING, group=TGRP-TransactionLogTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) at com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38) at com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56) at com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128) at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.update.TransactionLogTest:
1) Thread[id=15, name=Log4j2-TF-1-AsyncLoggerConfig--1, state=TIMED_WAITING, group=TGRP-TransactionLogTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
at com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
at com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([7657F97F2A7AB2E2]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.update.TransactionLogTest
Error Message:
There are still zombie threads that couldn't be terminated: 1) Thread[id=15, name=Log4j2-TF-1-AsyncLoggerConfig--1, state=TIMED_WAITING, group=TGRP-TransactionLogTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) at com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38) at com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56) at com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128) at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
1) Thread[id=15, name=Log4j2-TF-1-AsyncLoggerConfig--1, state=TIMED_WAITING, group=TGRP-TransactionLogTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
at com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
at com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([7657F97F2A7AB2E2]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.update.TransactionLogTest
Error Message:
The test or suite printed 133952 bytes to stdout and stderr, even though the limit was set to 8192 bytes. Increase the limit with @Limit, ignore it completely with @SuppressSysoutChecks or run with -Dtests.verbose=true
Stack Trace:
java.lang.AssertionError: The test or suite printed 133952 bytes to stdout and stderr, even though the limit was set to 8192 bytes. Increase the limit with @Limit, ignore it completely with @SuppressSysoutChecks or run with -Dtests.verbose=true
at __randomizedtesting.SeedInfo.seed([7657F97F2A7AB2E2]:0)
at org.apache.lucene.util.TestRuleLimitSysouts.afterIfSuccessful(TestRuleLimitSysouts.java:211)
at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterIfSuccessful(TestRuleAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:37)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 13133 lines...]
[junit4] Suite: org.apache.solr.update.TransactionLogTest
[junit4] 2> 580545 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:110&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580545 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:142&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580545 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:120&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580545 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=99&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=117&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=22&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=12&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580545 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=81&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=21&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580545 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=107&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:123&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580545 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=101&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:95&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580545 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:106&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580545 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580545 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=36&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=93&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:99&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580545 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=134&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=73&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:64&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580545 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:50&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580545 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:102&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580545 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:86&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580545 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=120&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=85&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=50&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580545 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=41&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580545 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:83&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580545 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=25&wt=json} status=0 QTime=0
[junit4] 2> 580545 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:134&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580546 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=125&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=140&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=90&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:158&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580546 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=26&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:31&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580546 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=49&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=16&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580546 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=135&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=115&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=133&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:116&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580546 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=111&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=40&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=37&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=149&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:33&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:85&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580546 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=26&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:64&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580546 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580546 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:14&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580546 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=145&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=78&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=136&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=60&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=51&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=90&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:157&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580546 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=100&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580546 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580546 INFO (READER24) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:89&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=41&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=29&wt=json} status=0 QTime=294
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=159&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=17&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=44&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580546 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=148&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=41&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:45&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=88&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=68&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=112&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=27&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:115&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580546 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=27&wt=json} status=0 QTime=0
[junit4] 2> 580546 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=19&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=90&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=50&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=25&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=123&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=28&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=98&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=60&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=157&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:36&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:69&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=96&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=29&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:113&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=100&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=22&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=35&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=59&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:105&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=89&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:98&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=68&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=67&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=159&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=44&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:12&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=16&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=157&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=116&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:61&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=146&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=117&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=51&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=48&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:146&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=82&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=44&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=64&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=69&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:114&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=68&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=95&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=112&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=149&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=29&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=104&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
[junit4] 2> 580547 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:116&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=13&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=90&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=30&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:74&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=112&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:67&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=71&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=124&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=144&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=29&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=28&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:90&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=156&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:24&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=159&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:135&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=139&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=61&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=43&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:150&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=118&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=50&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:32&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=50&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=23&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=124&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=108&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=125&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=32&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=19&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=119&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=48&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=102&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=91&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=125&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:39&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=99&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=22&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=144&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=26&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=131&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=143&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:77&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:88&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=23&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580548 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:91&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:95&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580548 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580548 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:68&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=56&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=48&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:127&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=91&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=107&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=62&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=150&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:90&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=39&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:68&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=113&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:85&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=128&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=59&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=17&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=42&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=88&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=23&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=147&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=133&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=45&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=36&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=132&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=140&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=17&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=155&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=100&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:76&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=39&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=52&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=159&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=110&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=67&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=83&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=144&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=48&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=143&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=132&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=86&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=43&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=61&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:57&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:119&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:94&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=24&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=81&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=61&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=146&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:91&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=135&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=69&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=151&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=23&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=145&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:65&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580549 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580549 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=104&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=22&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=102&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:154&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=69&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=146&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=55&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:59&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=66&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=27&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:155&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=43&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=89&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=102&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=84&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:132&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=94&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=136&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=138&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=32&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=22&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:154&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:134&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=73&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=124&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:7&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=81&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:77&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:135&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=51&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=67&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=129&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=142&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:69&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=38&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=153&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=149&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=94&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=110&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=26&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=128&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=129&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=112&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=87&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=86&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=48&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=145&wt=json} status=0 QTime=0
[junit4] 2> 580550 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=12&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:61&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=113&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=125&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=68&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=19&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=118&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=48&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=130&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:77&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=88&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=144&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:84&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=108&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=83&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=80&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=81&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:80&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=107&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=93&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:120&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=91&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=129&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=139&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=106&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=158&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=79&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=103&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=124&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=107&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=131&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:133&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:85&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:155&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=128&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=125&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=98&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=131&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=142&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:26&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=46&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=140&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=140&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=131&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:106&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=19&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=73&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:100&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
[junit4] 2> 580551 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580551 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:19&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:146&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=119&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:152&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=143&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:135&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=156&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=85&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=14&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:133&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=115&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:94&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:124&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=158&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=117&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:18&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=39&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=67&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=56&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:150&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=54&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:13&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:38&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:77&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:42&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:70&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:82&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=45&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=91&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:87&omitHeader=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=137&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=73&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580552 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580552 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=124&wt=json} status=0 QTime=0
[junit4] 2> 580553 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=71&wt=json} status=0 QTime=0
[junit4] 2> 580553 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=40&wt=json} status=0 QTime=0
[junit4] 2> 580553 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:151&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580553 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=23&wt=json} status=0 QTime=0
[junit4] 2> 580553 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580553 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:86&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580553 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:10&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580553 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580553 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=58&wt=json} status=0 QTime=0
[junit4] 2> 580553 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=39&wt=json} status=0 QTime=0
[junit4] 2> 580553 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580553 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580553 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=85&wt=json} status=0 QTime=0
[junit4] 2> 580553 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580553 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=108&wt=json} status=0 QTime=1
[junit4] 2> 580553 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580553 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=16&wt=json} status=0 QTime=0
[junit4] 2> 580553 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=60&wt=json} status=0 QTime=0
[junit4] 2> 580553 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580553 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:100&omitHeader=true&wt=json} hits=0 status=0 QTime=0
[junit4] 2> 580553 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[junit4] 2> 580553 INFO (READER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=133&wt=json} status=0 QTime=0
[junit4] 2> 580553 INFO (READER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=95&wt=json} status=0 QTime=0
[junit4] 2> 580553 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
[...truncated too long message...]
cLogger error handling event seq=2, value='null':
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2088)
[junit4] 2> at com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] 2> at com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] 2> at com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> AsyncLogger error handling event seq=3, value='null':
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2088)
[junit4] 2> at com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] 2> at com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] 2> at com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> AsyncLogger error handling event seq=4, value='null':
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2088)
[junit4] 2> at com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] 2> at com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] 2> at com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> AsyncLogger error handling event seq=5, value='null':
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2088)
[junit4] 2> at com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] 2> at com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] 2> at com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> Sep 06, 2018 12:06:41 PM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> SEVERE: There are still zombie threads that couldn't be terminated:
[junit4] 2> 1) Thread[id=15, name=Log4j2-TF-1-AsyncLoggerConfig--1, state=TIMED_WAITING, group=TGRP-TransactionLogTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] 2> at com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] 2> at com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] 2> at com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene80): {}, docValues:{}, maxPointsInLeafNode=852, maxMBSortInHeap=5.722418798610454, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@48f32e3f), locale=ca-ES, timezone=Indian/Reunion
[junit4] 2> NOTE: Linux 4.15.0-32-generic amd64/Oracle Corporation 1.8.0_172 (64-bit)/cpus=8,threads=2,free=445814896,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TransactionLogTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TransactionLogTest -Dtests.seed=7657F97F2A7AB2E2 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=ca-ES -Dtests.timezone=Indian/Reunion -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J2 | TransactionLogTest (suite) <<<
[junit4] > Throwable #1: com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.update.TransactionLogTest:
[junit4] > 1) Thread[id=15, name=Log4j2-TF-1-AsyncLoggerConfig--1, state=TIMED_WAITING, group=TGRP-TransactionLogTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] > at com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] > at com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] > at com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > at __randomizedtesting.SeedInfo.seed([7657F97F2A7AB2E2]:0)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
[junit4] > 1) Thread[id=15, name=Log4j2-TF-1-AsyncLoggerConfig--1, state=TIMED_WAITING, group=TGRP-TransactionLogTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] > at com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] > at com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] > at com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > at __randomizedtesting.SeedInfo.seed([7657F97F2A7AB2E2]:0)
[junit4] Completed [3/5 (3!)] on J2 in 24.91s, 1 test, 2 errors <<< FAILURES!
[junit4]
[junit4] Suite: org.apache.solr.update.TransactionLogTest
[junit4] Completed [4/5 (3!)] on J0 in 0.02s, 1 test, 1 skipped
[junit4]
[junit4] Suite: org.apache.solr.update.TransactionLogTest
[junit4] Completed [5/5 (3!)] on J1 in 0.01s, 1 test, 1 skipped
[junit4]
[junit4]
[junit4] Tests with failures [seed: 7657F97F2A7AB2E2]:
[junit4] - org.apache.solr.update.TransactionLogTest (suite)
[junit4] - org.apache.solr.update.TransactionLogTest (suite)
[junit4] - org.apache.solr.update.TransactionLogTest (suite)
[junit4]
[junit4]
[junit4] JVM J0: 0.48 .. 26.65 = 26.16s
[junit4] JVM J1: 0.49 .. 26.66 = 26.17s
[junit4] JVM J2: 0.67 .. 26.47 = 25.79s
[junit4] Execution time total: 26 seconds
[junit4] Tests summary: 5 suites, 5 tests, 6 suite-level errors, 2 ignored
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1567: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1092: There were test failures: 5 suites, 5 tests, 6 suite-level errors, 2 ignored [seed: 7657F97F2A7AB2E2]
Total time: 28 seconds
[repro] Setting last failure code to 256
[repro] Failures:
[repro] 3/5 failed: org.apache.solr.update.TransactionLogTest
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all warnings.
<Git Blamer> GIT_COMMIT=285b743a8bff96e3f436f40bcc86f3529a0d8951, workspace=/var/lib/jenkins/workspace/Lucene-Solr-master-Linux
[WARNINGS] Computing warning deltas based on reference build #22809
Recording test results
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2