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 2019/03/19 21:26:30 UTC

[JENKINS-EA] Lucene-Solr-master-Linux (64bit/jdk-12-ea+shipilev-fastdebug) - Build # 23801 - Unstable!

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/23801/
Java: 64bit/jdk-12-ea+shipilev-fastdebug -XX:-UseCompressedOops -XX:+UseSerialGC

1 tests failed.
FAILED:  org.apache.solr.metrics.rrd.SolrRrdBackendFactoryTest.testBasic

Error Message:
{} expected:<1> but was:<0>

Stack Trace:
java.lang.AssertionError: {} expected:<1> but was:<0>
	at __randomizedtesting.SeedInfo.seed([394CB06F8AB152ED:92B6AD7A556DD4C3]:0)
	at org.junit.Assert.fail(Assert.java:88)
	at org.junit.Assert.failNotEquals(Assert.java:834)
	at org.junit.Assert.assertEquals(Assert.java:645)
	at org.apache.solr.metrics.rrd.SolrRrdBackendFactoryTest.testBasic(SolrRrdBackendFactoryTest.java:92)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:567)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	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.base/java.lang.Thread.run(Thread.java:835)




Build Log:
[...truncated 15055 lines...]
   [junit4] Suite: org.apache.solr.metrics.rrd.SolrRrdBackendFactoryTest
   [junit4]   2> 3375178 INFO  (SUITE-SolrRrdBackendFactoryTest-seed#[394CB06F8AB152ED]-worker) [    ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.metrics.rrd.SolrRrdBackendFactoryTest_394CB06F8AB152ED-001/init-core-data-001
   [junit4]   2> 3375179 WARN  (SUITE-SolrRrdBackendFactoryTest-seed#[394CB06F8AB152ED]-worker) [    ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=8 numCloses=8
   [junit4]   2> 3375179 INFO  (SUITE-SolrRrdBackendFactoryTest-seed#[394CB06F8AB152ED]-worker) [    ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 3375180 INFO  (SUITE-SolrRrdBackendFactoryTest-seed#[394CB06F8AB152ED]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
   [junit4]   2> 3375183 INFO  (TEST-SolrRrdBackendFactoryTest.testBasic-seed#[394CB06F8AB152ED]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testBasic
   [junit4]   2> 3375576 INFO  (TEST-SolrRrdBackendFactoryTest.testBasic-seed#[394CB06F8AB152ED]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testBasic
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=SolrRrdBackendFactoryTest -Dtests.method=testBasic -Dtests.seed=394CB06F8AB152ED -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sr-Latn-XK -Dtests.timezone=America/Argentina/Rio_Gallegos -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] FAILURE 0.44s J0 | SolrRrdBackendFactoryTest.testBasic <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: {} expected:<1> but was:<0>
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([394CB06F8AB152ED:92B6AD7A556DD4C3]:0)
   [junit4]    > 	at org.apache.solr.metrics.rrd.SolrRrdBackendFactoryTest.testBasic(SolrRrdBackendFactoryTest.java:92)
   [junit4]    > 	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    > 	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    > 	at java.base/java.lang.reflect.Method.invoke(Method.java:567)
   [junit4]    > 	at java.base/java.lang.Thread.run(Thread.java:835)
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.metrics.rrd.SolrRrdBackendFactoryTest_394CB06F8AB152ED-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene80): {}, docValues:{}, maxPointsInLeafNode=275, maxMBSortInHeap=5.903220980450477, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@21a046ea), locale=sr-Latn-XK, timezone=America/Argentina/Rio_Gallegos
   [junit4]   2> NOTE: Linux 4.18.0-15-generic amd64/Aleksey Shipilev 12-testing (64-bit)/cpus=8,threads=1,free=91447736,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: [CollectionsAPISolrJTest, TestPerFieldSimilarity, IgnoreLargeDocumentProcessorFactoryTest, SimplePostToolTest, DateFieldTest, ChaosMonkeySafeLeaderTest, CleanupOldIndexTest, FieldAnalysisRequestHandlerTest, TestPayloadCheckQParserPlugin, HdfsUnloadDistributedZkTest, ScheduledTriggerIntegrationTest, TestSimExtremeIndexing, SolrCLIZkUtilsTest, TestNRTOpen, SOLR749Test, TestSolrCloudWithKerberosAlt, HdfsChaosMonkeyNothingIsSafeTest, URLClassifyProcessorTest, TestWordDelimiterFilterFactory, TestBackupRepositoryFactory, TestUpdate, PathHierarchyTokenizerFactoryTest, ReplicationFactorTest, TestOrdValues, TestSSLRandomization, TestTolerantUpdateProcessorCloud, TestChildDocTransformerHierarchy, BasicAuthIntegrationTest, TestRequestStatusCollectionAPI, HdfsSyncSliceTest, TestSolrConfigHandler, ChangedSchemaMergeTest, QueryParsingTest, ConnectionManagerTest, AtomicUpdateProcessorFactoryTest, TestConfigSetProperties, TriggerSetPropertiesIntegrationTest, HLLUtilTest, ExternalFileFieldSortTest, RegexBoostProcessorTest, AutoscalingHistoryHandlerTest, TestDirectoryFactory, TestCloudPseudoReturnFields, TestDelegationWithHadoopAuth, MetricTriggerIntegrationTest, BlockDirectoryTest, SearchRateTriggerTest, TestCloudInspectUtil, BadCopyFieldTest, RegexBytesRefFilterTest, HttpSolrCallGetCoreTest, CoreAdminOperationTest, SSLMigrationTest, NodeMarkersRegistrationTest, TestExportWriter, TestMiniSolrCloudClusterSSL, CustomHighlightComponentTest, TestReloadAndDeleteDocs, CloneFieldUpdateProcessorFactoryTest, TestNumericRangeQuery32, TestFieldCacheSortRandom, TestRealTimeGet, DocExpirationUpdateProcessorFactoryTest, SolrMetricsIntegrationTest, DistributedDebugComponentTest, SuggesterTSTTest, TemplateUpdateProcessorTest, CustomCollectionTest, OverseerModifyCollectionTest, BlockJoinFacetSimpleTest, TestSchemaVersionResource, TestBM25SimilarityFactory, ClassificationUpdateProcessorFactoryTest, TestLMJelinekMercerSimilarityFactory, TestSchemalessBufferedUpdates, CollectionsAPIAsyncDistributedZkTest, ByteBuffersDirectoryFactoryTest, TestHashQParserPlugin, BinaryUpdateRequestHandlerTest, TestHighFrequencyDictionaryFactory, TestFieldCache, ImplicitSnitchTest, TestJsonFacets, JWTAuthPluginTest, PeerSyncWithBufferUpdatesTest, TestStressInPlaceUpdates, TestImplicitCoreProperties, SpatialRPTFieldTypeTest, TestHdfsCloudBackupRestore, ZkNodePropsTest, DistribCursorPagingTest, AsyncCallRequestStatusResponseTest, TestAuthenticationFramework, TestNestedDocsSort, TestPushWriter, DistributedQueryComponentCustomSortTest, FileBasedSpellCheckerTest, SignificantTermsQParserPluginTest, TestDistributedMissingSort, TestLFUCache, HdfsDirectoryFactoryTest, TestHdfsUpdateLog, TestStressVersions, NumberUtilsTest, EchoParamsTest, TestRandomDVFaceting, TriLevelCompositeIdRoutingTest, DocumentBuilderTest, TestLegacyNumericUtils, TestComplexPhraseQParserPlugin, TestSolrCoreProperties, AnalyticsQueryTest, TestRestManager, OpenExchangeRatesOrgProviderTest, DateMathParserTest, RandomizedTaggerTest, SearchHandlerTest, UpdateParamsTest, ForceLeaderTest, TestReqParamsAPI, TestConfigSetsAPIExclusivity, UtilsToolTest, HDFSCollectionsAPITest, SchemaApiFailureTest, TestBulkSchemaConcurrent, BJQParserTest, TestRemoteStreaming, TestQueryTypes, CoreSorterTest, TestJsonRequest, TestSchemaNameResource, HdfsLockFactoryTest, TestWriterPerf, HdfsAutoAddReplicasIntegrationTest, TestSolrFieldCacheBean, SortByFunctionTest, TestRetrieveFieldsOptimizer, TestCursorMarkWithoutUniqueKey, TestDistributedGrouping, TestJoin, ActionThrottleTest, AliasIntegrationTest, BasicZkTest, ChaosMonkeyNothingIsSafeTest, ClusterStateUpdateTest, CollectionPropsTest, DeleteLastCustomShardedReplicaTest, DeleteNodeTest, DeleteShardTest, DeleteStatusTest, DistributedQueueTest, DistributedVersionInfoTest, HealthCheckHandlerTest, HttpPartitionOnCommitTest, HttpPartitionWithTlogReplicasTest, LeaderElectionTest, LeaderFailoverAfterPartitionTest, LeaderTragicEventTest, LeaderVoteWaitTimeoutTest, MigrateRouteKeyTest, MultiSolrCloudTestCaseTest, MultiThreadedOCPTest, NodeMutatorTest, OutOfBoxZkACLAndCredentialsProvidersTest, OverriddenZkACLAndCredentialsProvidersTest, OverseerCollectionConfigSetProcessorTest, OverseerTest, RecoveryZkTest, ReindexCollectionTest, TestConfigSetsAPI, TestLockTree, TestPullReplica, TestPullReplicaErrorHandling, TestRebalanceLeaders, TestSolrCloudWithDelegationTokens, TestWithCollection, AutoScalingHandlerTest, ExecutePlanActionTest, NodeLostTriggerTest, TriggerEventQueueTest, TriggerIntegrationTest, CdcrWithNodesRestartsTest, HdfsRecoverLeaseTest, ResourceLoaderTest, TestConfig, TestCoreDiscovery, TestLazyCores, TestConfigReload, TestReplicationHandlerBackup, TestSolrConfigHandlerCloud, PropertiesRequestHandlerTest, SecurityConfHandlerTest, ShowFileRequestHandlerTest, SystemInfoHandlerTest, TestApiFramework, TestCollectionAPIs, TestConfigsApi, TestCoreAdminApis, ZookeeperStatusHandlerTest, DistributedFacetPivotLargeTest, DistributedMLTComponentTest, DistributedSuggestComponentTest, QueryElevationComponentTest, ShufflingReplicaListTransformerTest, SpellCheckComponentTest, StatsComponentTest, TestHttpShardHandlerFactory, TaggingAttributeTest, XmlInterpolationTest, FastVectorHighlighterTest, HighlighterMaxOffsetTest, TestPostingsSolrHighlighter, TestSlowCompositeReaderWrapper, UninvertDocValuesMergePolicyTest, TestLegacyFieldReuse, JvmMetricsTest, SolrMetricManagerTest, SolrMetricReporterTest, SolrJmxReporterCloudTest, SolrSlf4jReporterTest, SolrCloudReportersTest, SolrRrdBackendFactoryTest]
   [junit4] Completed [682/849 (1!)] on J0 in 0.51s, 1 test, 1 failure <<< FAILURES!

[...truncated 43118 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/23801/consoleText

[repro] Revision: 2a1ed6e4848abc6ab9bce27c170bce28a4c9691c

[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseSerialGC"
[repro] Repro line:  ant test  -Dtestcase=SolrRrdBackendFactoryTest -Dtests.method=testBasic -Dtests.seed=394CB06F8AB152ED -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sr-Latn-XK -Dtests.timezone=America/Argentina/Rio_Gallegos -Dtests.asserts=true -Dtests.file.encoding=US-ASCII

[repro] ant clean

[...truncated 6 lines...]
[repro] Test suites by module:
[repro]    solr/core
[repro]       SolrRrdBackendFactoryTest
[repro] ant compile-test

[...truncated 3570 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.SolrRrdBackendFactoryTest" -Dtests.showOutput=onerror "-Dargs=-XX:-UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=394CB06F8AB152ED -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sr-Latn-XK -Dtests.timezone=America/Argentina/Rio_Gallegos -Dtests.asserts=true -Dtests.file.encoding=US-ASCII

[...truncated 75 lines...]
[repro] Failures:
[repro]   0/5 failed: org.apache.solr.metrics.rrd.SolrRrdBackendFactoryTest
[repro] Exiting with code 0

[...truncated 43 lines...]

[JENKINS-EA] Lucene-Solr-master-Linux (64bit/jdk-13-ea+shipilev-fastdebug) - Build # 23802 - Still Unstable!

Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/23802/
Java: 64bit/jdk-13-ea+shipilev-fastdebug -XX:+UseCompressedOops -XX:+UseSerialGC

2 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.update.TransactionLogTest

Error Message:
The test or suite printed 88675 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 88675 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([EDE8A3070B20CED8]:0)
	at org.apache.lucene.util.TestRuleLimitSysouts.afterIfSuccessful(TestRuleLimitSysouts.java:282)
	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.base/java.lang.Thread.run(Thread.java:835)


FAILED:  junit.framework.TestSuite.org.apache.solr.client.solrj.impl.CloudHttp2SolrClientTest

Error Message:
ObjectTracker found 3 object(s) that were not released!!! [SolrCore, MockDirectoryWrapper, MockDirectoryWrapper] org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore  at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)  at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1063)  at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)  at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)  at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)  at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)  at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)  at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)  at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)  at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)  at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)  at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)  at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)  at java.base/java.lang.Thread.run(Thread.java:835)  org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper  at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)  at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)  at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:517)  at org.apache.solr.core.SolrCore.<init>(SolrCore.java:968)  at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)  at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)  at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)  at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)  at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)  at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)  at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)  at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)  at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)  at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)  at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)  at java.base/java.lang.Thread.run(Thread.java:835)  org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper  at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)  at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)  at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:99)  at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:779)  at org.apache.solr.core.SolrCore.<init>(SolrCore.java:976)  at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)  at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)  at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)  at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)  at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)  at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)  at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)  at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)  at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)  at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)  at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)  at java.base/java.lang.Thread.run(Thread.java:835)   expected null, but was:<ObjectTracker found 3 object(s) that were not released!!! [SolrCore, MockDirectoryWrapper, MockDirectoryWrapper] org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore  at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)  at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1063)  at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)  at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)  at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)  at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)  at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)  at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)  at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)  at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)  at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)  at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)  at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)  at java.base/java.lang.Thread.run(Thread.java:835)  org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper  at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)  at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)  at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:517)  at org.apache.solr.core.SolrCore.<init>(SolrCore.java:968)  at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)  at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)  at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)  at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)  at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)  at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)  at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)  at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)  at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)  at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)  at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)  at java.base/java.lang.Thread.run(Thread.java:835)  org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper  at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)  at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)  at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:99)  at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:779)  at org.apache.solr.core.SolrCore.<init>(SolrCore.java:976)  at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)  at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)  at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)  at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)  at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)  at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)  at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)  at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)  at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)  at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)  at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)  at java.base/java.lang.Thread.run(Thread.java:835)  >

Stack Trace:
java.lang.AssertionError: ObjectTracker found 3 object(s) that were not released!!! [SolrCore, MockDirectoryWrapper, MockDirectoryWrapper]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore
	at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1063)
	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)
	at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)
	at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)
	at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
	at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
	at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
	at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
	at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
	at java.base/java.lang.Thread.run(Thread.java:835)

org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
	at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
	at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
	at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:517)
	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:968)
	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)
	at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)
	at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)
	at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
	at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
	at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
	at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
	at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
	at java.base/java.lang.Thread.run(Thread.java:835)

org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
	at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
	at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
	at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:99)
	at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:779)
	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:976)
	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)
	at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)
	at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)
	at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
	at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
	at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
	at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
	at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
	at java.base/java.lang.Thread.run(Thread.java:835)

 expected null, but was:<ObjectTracker found 3 object(s) that were not released!!! [SolrCore, MockDirectoryWrapper, MockDirectoryWrapper]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore
	at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1063)
	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)
	at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)
	at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)
	at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
	at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
	at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
	at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
	at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
	at java.base/java.lang.Thread.run(Thread.java:835)

org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
	at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
	at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
	at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:517)
	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:968)
	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)
	at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)
	at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)
	at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
	at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
	at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
	at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
	at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
	at java.base/java.lang.Thread.run(Thread.java:835)

org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
	at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
	at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
	at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:99)
	at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:779)
	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:976)
	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)
	at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)
	at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)
	at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
	at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
	at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
	at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
	at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
	at java.base/java.lang.Thread.run(Thread.java:835)

>
	at __randomizedtesting.SeedInfo.seed([531029FD13B5251B]:0)
	at org.junit.Assert.fail(Assert.java:88)
	at org.junit.Assert.failNotNull(Assert.java:755)
	at org.junit.Assert.assertNull(Assert.java:737)
	at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:325)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:567)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:901)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	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.base/java.lang.Thread.run(Thread.java:835)




Build Log:
[...truncated 14131 lines...]
   [junit4] Suite: org.apache.solr.update.TransactionLogTest
   [junit4]   2> 1890426 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=28&wt=json} status=0 QTime=0
   [junit4]   2> 1890426 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0
   [junit4]   2> 1890426 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=43&wt=json} status=0 QTime=0
   [junit4]   2> 1890426 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=41&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER23) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=46&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=48&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER23) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=44&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:32&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=52&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER23) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=20&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=18&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=18&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:54&omitHeader=true&wt=json} hits=0 status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER23) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=36&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=32&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER23) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=41&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=52&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER23) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=60&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=51&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER23) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=46&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:43&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=57&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER23) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:50&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890427 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:16&omitHeader=true&wt=json} hits=0 status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER23) [    ] 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> 1890428 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=17&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=12&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER23) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=33&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=40&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=22&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER23) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=40&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=32&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=17&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER23) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:58&omitHeader=true&wt=json} hits=0 status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=54&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=28&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER23) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=26&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER23) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=61&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=58&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=33&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=14&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER23) [    ] 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> 1890428 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=56&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=40&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=31&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=45&wt=json} status=0 QTime=0
   [junit4]   2> 1890428 INFO  (READER12) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=34&wt=json} status=0 QTime=320
   [junit4]   2> 1890429 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=12&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER12) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=42&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER8) [    ] 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> 1890429 INFO  (READER12) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=14&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:20&omitHeader=true&wt=json} hits=0 status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER12) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=55&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER14) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=9
   [junit4]   2> 1890429 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=58&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER12) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=51&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER14) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=58&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER12) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=43&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER14) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=55&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=17&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=16&wt=json} status=0 QTime=307
   [junit4]   2> 1890429 INFO  (READER14) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=53&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=56&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=29&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=60&wt=json} status=0 QTime=308
   [junit4]   2> 1890429 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890429 INFO  (READER24) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=42&wt=json} status=0 QTime=308
   [junit4]   2> 1890429 INFO  (READER1) [    ] 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> 1890429 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:56&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:30&omitHeader=true&wt=json} hits=0 status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=51&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER24) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=45&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=57&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=35&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:8&omitHeader=true&wt=json} hits=0 status=0 QTime=333
   [junit4]   2> 1890430 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=24&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=60&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=27&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=44&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=13&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=47&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=46&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:61&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=21&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=48&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=52&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=54&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=49&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=27&wt=json} status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:43&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890430 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=43&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=41&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=30&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=55&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER27) [    ] 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> 1890431 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:41&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=26&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER11) [    ] 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> 1890431 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:22&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER3) [    ] 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> 1890431 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=54&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:23&omitHeader=true&wt=json} hits=0 status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=27&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=50&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=16&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=21&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:9&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=39&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=13&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:58&omitHeader=true&wt=json} hits=0 status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=45&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=28&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER1) [    ] 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> 1890431 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=43&wt=json} status=0 QTime=0
   [junit4]   2> 1890431 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:42&omitHeader=true&wt=json} hits=0 status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:23&omitHeader=true&wt=json} hits=0 status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:0&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=13&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=46&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:16&omitHeader=true&wt=json} hits=0 status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=57&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=51&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=36&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=39&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=18&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=44&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=18&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:41&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=58&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=16&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:17&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:13&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=39&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=19&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER27) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=41&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER11) [    ] 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> 1890432 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=57&wt=json} status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=8
   [junit4]   2> 1890432 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:61&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890432 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=54&wt=json} status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=19&wt=json} status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER3) [    ] 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> 1890433 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=14&wt=json} status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=38&wt=json} status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=46&wt=json} status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:9&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=18&wt=json} status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=34&wt=json} status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:34&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=34&wt=json} status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=52&wt=json} status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:22&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER22) [    ] 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> 1890433 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:60&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER22) [    ] 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> 1890433 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890433 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=35&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=19&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:50&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:34&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=27&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=34&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER22) [    ] 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> 1890434 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=40&wt=json} status=0 QTime=4
   [junit4]   2> 1890434 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=35&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:25&omitHeader=true&wt=json} hits=0 status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=57&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:5&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER11) [    ] 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> 1890434 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:49&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=40&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:37&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=58&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
   [junit4]   2> 1890434 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=46&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER3) [    ] 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> 1890435 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=50&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=54&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:49&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=58&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=53&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:61&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=20&wt=json} status=0 QTime=314
   [junit4]   2> 1890435 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=26&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER22) [    ] 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> 1890435 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=41&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=33&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=13&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=50&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=12&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:37&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:38&omitHeader=true&wt=json} hits=0 status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=19&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=46&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=56&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=51&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=60&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=41&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=33&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=37&wt=json} status=0 QTime=0
   [junit4]   2> 1890435 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=29&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=31&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=54&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=12&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=58&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=21&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:6&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER15) [    ] 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> 1890436 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=24&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=13&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=36&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=41&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER11) [    ] 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> 1890436 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=60&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=31&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=24&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=12&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=36&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=13&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=52&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=52&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=16&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:12&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=29&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890436 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=27&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=16&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER12) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=7
   [junit4]   2> 1890437 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=12&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:16&omitHeader=true&wt=json} hits=0 status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER12) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=42&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=52&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=57&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=61&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:19&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER12) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=58&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=20&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=31&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=26&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER12) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=30&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=48&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=16&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:20&omitHeader=true&wt=json} hits=0 status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER12) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=34&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:38&omitHeader=true&wt=json} hits=0 status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=13&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER12) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:51&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=14&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=31&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=31&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=53&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER12) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=16&wt=json} status=0 QTime=0
   [junit4]   2> 1890437 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER12) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=49&wt=json} status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=58&wt=json} status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=60&wt=json} status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER12) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=58&wt=json} status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER15) [    ] 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> 1890438 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:48&omitHeader=true&wt=json} hits=0 status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER12) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=46&wt=json} status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER12) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:60&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=46&wt=json} status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER22) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER15) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={qt=/get&ids=29&wt=json} status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:37&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER11) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:50&omitHeader=true&wt=json} hits=1 status=0 QTime=0
   [junit4]   2> 1890438 INFO  (READER22) [    ] o.a

[...truncated too long message...]

    > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
   [junit4]    > 	at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
   [junit4]    > 	at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
   [junit4]    > 	at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:99)
   [junit4]    > 	at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:779)
   [junit4]    > 	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:976)
   [junit4]    > 	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)
   [junit4]    > 	at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)
   [junit4]    > 	at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)
   [junit4]    > 	at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
   [junit4]    > 	at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
   [junit4]    > 	at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
   [junit4]    > 	at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
   [junit4]    > 	at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
   [junit4]    > 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
   [junit4]    > 	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
   [junit4]    > 	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
   [junit4]    > 	at java.base/java.lang.Thread.run(Thread.java:835)
   [junit4]    >  expected null, but was:<ObjectTracker found 3 object(s) that were not released!!! [SolrCore, MockDirectoryWrapper, MockDirectoryWrapper]
   [junit4]    > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore
   [junit4]    > 	at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
   [junit4]    > 	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1063)
   [junit4]    > 	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)
   [junit4]    > 	at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)
   [junit4]    > 	at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)
   [junit4]    > 	at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
   [junit4]    > 	at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
   [junit4]    > 	at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
   [junit4]    > 	at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
   [junit4]    > 	at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
   [junit4]    > 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
   [junit4]    > 	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
   [junit4]    > 	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
   [junit4]    > 	at java.base/java.lang.Thread.run(Thread.java:835)
   [junit4]    > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
   [junit4]    > 	at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
   [junit4]    > 	at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
   [junit4]    > 	at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:517)
   [junit4]    > 	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:968)
   [junit4]    > 	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)
   [junit4]    > 	at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)
   [junit4]    > 	at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)
   [junit4]    > 	at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
   [junit4]    > 	at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
   [junit4]    > 	at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
   [junit4]    > 	at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
   [junit4]    > 	at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
   [junit4]    > 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
   [junit4]    > 	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
   [junit4]    > 	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
   [junit4]    > 	at java.base/java.lang.Thread.run(Thread.java:835)
   [junit4]    > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
   [junit4]    > 	at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
   [junit4]    > 	at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
   [junit4]    > 	at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:99)
   [junit4]    > 	at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:779)
   [junit4]    > 	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:976)
   [junit4]    > 	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)
   [junit4]    > 	at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)
   [junit4]    > 	at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)
   [junit4]    > 	at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
   [junit4]    > 	at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
   [junit4]    > 	at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
   [junit4]    > 	at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
   [junit4]    > 	at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
   [junit4]    > 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
   [junit4]    > 	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
   [junit4]    > 	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
   [junit4]    > 	at java.base/java.lang.Thread.run(Thread.java:835)
   [junit4]    > >
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([531029FD13B5251B]:0)
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:325)
   [junit4]    > 	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    > 	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    > 	at java.base/java.lang.reflect.Method.invoke(Method.java:567)
   [junit4]    > 	at java.base/java.lang.Thread.run(Thread.java:835)
   [junit4] Completed [90/192 (1!)] on J2 in 152.93s, 16 tests, 1 failure <<< FAILURES!

[...truncated 41791 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/23802/consoleText

[repro] Revision: 2a1ed6e4848abc6ab9bce27c170bce28a4c9691c

[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC"
[repro] Repro line:  ant test  -Dtestcase=TransactionLogTest -Dtests.seed=EDE8A3070B20CED8 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=lu -Dtests.timezone=NZ -Dtests.asserts=true -Dtests.file.encoding=UTF-8

[repro] Repro line:  ant test  -Dtestcase=CloudHttp2SolrClientTest -Dtests.seed=531029FD13B5251B -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar-TD -Dtests.timezone=Australia/Perth -Dtests.asserts=true -Dtests.file.encoding=UTF-8

[repro] ant clean

[...truncated 6 lines...]
[repro] Test suites by module:
[repro]    solr/solrj
[repro]       CloudHttp2SolrClientTest
[repro]    solr/core
[repro]       TransactionLogTest
[repro] ant compile-test

[...truncated 2708 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.CloudHttp2SolrClientTest" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=531029FD13B5251B -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar-TD -Dtests.timezone=Australia/Perth -Dtests.asserts=true -Dtests.file.encoding=UTF-8

[...truncated 150 lines...]
[repro] ant compile-test

[...truncated 1355 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.TransactionLogTest" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=EDE8A3070B20CED8 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=lu -Dtests.timezone=NZ -Dtests.asserts=true -Dtests.file.encoding=UTF-8

[...truncated 75 lines...]
[repro] Failures:
[repro]   0/5 failed: org.apache.solr.client.solrj.impl.CloudHttp2SolrClientTest
[repro]   0/5 failed: org.apache.solr.update.TransactionLogTest
[repro] Exiting with code 0

[...truncated 43 lines...]