Build: https://jenkins.thetaphi.de/job/Lucene-Solr-BadApples-master-Linux/35/
Java: 64bit/jdk-9.0.4 -XX:-UseCompressedOops -XX:+UseParallelGC

2 tests failed.
FAILED:  org.apache.solr.cloud.AddReplicaTest.test

Error Message:
core_node6:{"core":"addreplicatest_coll_shard1_replica_n5","base_url":"https://127.0.0.1:34103/solr","node_name":"127.0.0.1:34103_solr","state":"active","type":"NRT","force_set_state":"false"}

Stack Trace:
java.lang.AssertionError: 
core_node6:{"core":"addreplicatest_coll_shard1_replica_n5","base_url":"https://127.0.0.1:34103/solr","node_name":"127.0.0.1:34103_solr","state":"active","type":"NRT","force_set_state":"false"}
        at 
__randomizedtesting.SeedInfo.seed([EED4732D0B2C8220:66804CF7A5D0EFD8]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.apache.solr.cloud.AddReplicaTest.test(AddReplicaTest.java:85)
        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:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        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:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        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:844)


FAILED:  org.apache.solr.search.TestStressRecovery.testStressRecovery

Error Message:
Captured an uncaught exception in thread: Thread[id=4080, name=WRITER5, 
state=RUNNABLE, group=TGRP-TestStressRecovery]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=4080, name=WRITER5, state=RUNNABLE, 
group=TGRP-TestStressRecovery]
        at 
__randomizedtesting.SeedInfo.seed([EED4732D0B2C8220:54EE1A7094C43D2E]:0)
Caused by: java.lang.RuntimeException: java.lang.NullPointerException
        at __randomizedtesting.SeedInfo.seed([EED4732D0B2C8220]:0)
        at 
org.apache.solr.search.TestStressRecovery$1.run(TestStressRecovery.java:259)
Caused by: java.lang.NullPointerException
        at 
org.apache.solr.update.TransactionLog.getLogSizeFromStream(TransactionLog.java:637)
        at 
org.apache.solr.update.UpdateLog.getCurrentLogSizeFromStream(UpdateLog.java:299)
        at 
org.apache.solr.update.DirectUpdateHandler2.getCurrentTLogSize(DirectUpdateHandler2.java:1007)
        at 
org.apache.solr.update.DirectUpdateHandler2.updateDeleteTrackers(DirectUpdateHandler2.java:432)
        at 
org.apache.solr.update.DirectUpdateHandler2.delete(DirectUpdateHandler2.java:465)
        at 
org.apache.solr.update.processor.RunUpdateProcessor.processDelete(RunUpdateProcessorFactory.java:75)
        at 
org.apache.solr.update.processor.UpdateRequestProcessor.processDelete(UpdateRequestProcessor.java:59)
        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalDelete(DistributedUpdateProcessor.java:956)
        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.versionDelete(DistributedUpdateProcessor.java:1844)
        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.doDeleteById(DistributedUpdateProcessor.java:1381)
        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.processDelete(DistributedUpdateProcessor.java:1359)
        at 
org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.processDelete(LogUpdateProcessorFactory.java:124)
        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.handleDeleteMap(JsonLoader.java:394)
        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.handleDeleteCommand(JsonLoader.java:311)
        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.processUpdate(JsonLoader.java:171)
        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.load(JsonLoader.java:121)
        at org.apache.solr.handler.loader.JsonLoader.load(JsonLoader.java:84)
        at 
org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:97)
        at 
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:68)
        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199)
        at org.apache.solr.core.SolrCore.execute(SolrCore.java:2510)
        at 
org.apache.solr.servlet.DirectSolrConnection.request(DirectSolrConnection.java:125)
        at org.apache.solr.SolrTestCaseJ4.updateJ(SolrTestCaseJ4.java:1286)
        at 
org.apache.solr.SolrTestCaseJ4.deleteAndGetVersion(SolrTestCaseJ4.java:1464)
        at 
org.apache.solr.search.TestStressRecovery$1.run(TestStressRecovery.java:191)




Build Log:
[...truncated 12823 lines...]
   [junit4] Suite: org.apache.solr.search.TestStressRecovery
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestStressRecovery_EED4732D0B2C8220-001/init-core-data-001
   [junit4]   2> 409668 WARN  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=3 numCloses=3
   [junit4]   2> 409668 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 409669 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 409669 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 409669 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.SolrTestCaseJ4 updateLog impl=solr.CdcrUpdateLog
   [junit4]   2> 409669 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 409669 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 409680 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 409690 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 409769 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 409804 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@77b36e1b
   [junit4]   2> 409811 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@77b36e1b
   [junit4]   2> 409812 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@77b36e1b
   [junit4]   2> 409813 INFO  (coreLoadExecutor-936-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 409813 INFO  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 409827 INFO  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 409834 INFO  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 409893 INFO  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 409899 INFO  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 409900 INFO  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@77b36e1b
   [junit4]   2> 409900 INFO  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 409900 INFO  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestStressRecovery_EED4732D0B2C8220-001/init-core-data-001/]
   [junit4]   2> 409901 INFO  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=29, maxMergeAtOnceExplicit=18, maxMergedSegmentMB=1.2236328125, 
floorSegmentMB=1.0830078125, forceMergeDeletesPctAllowed=25.314667465913143, 
segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.45713562105281136
   [junit4]   2> 409902 WARN  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler 
{type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 409938 INFO  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.CdcrUpdateLog
   [junit4]   2> 409938 INFO  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 409939 INFO  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 409939 INFO  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 409940 INFO  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=40, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=84.1064453125, 
floorSegmentMB=1.6484375, forceMergeDeletesPctAllowed=12.481199628807262, 
segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 409940 INFO  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@27534ebf[collection1] main]
   [junit4]   2> 409940 WARN  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 409941 INFO  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 409941 INFO  (coreLoadExecutor-936-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1600227801151045632
   [junit4]   2> 409941 INFO  
(searcherExecutor-937-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@27534ebf[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 409943 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 409944 INFO  
(TEST-TestStressRecovery.testStressRecovery-seed#[EED4732D0B2C8220]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testStressRecovery
   [junit4]   2> 409944 INFO  
(TEST-TestStressRecovery.testStressRecovery-seed#[EED4732D0B2C8220]) [    ] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 409945 INFO  
(TEST-TestStressRecovery.testStressRecovery-seed#[EED4732D0B2C8220]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@ff13b39[collection1] realtime]
   [junit4]   2> 409945 INFO  
(TEST-TestStressRecovery.testStressRecovery-seed#[EED4732D0B2C8220]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
 (-9223372036854775807)} 0 0
   [junit4]   2> 409945 INFO  
(TEST-TestStressRecovery.testStressRecovery-seed#[EED4732D0B2C8220]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1600227801155239936,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 409945 INFO  
(TEST-TestStressRecovery.testStressRecovery-seed#[EED4732D0B2C8220]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1eda21fc 
commitCommandVersion:1600227801155239936
   [junit4]   2> 409946 INFO  
(TEST-TestStressRecovery.testStressRecovery-seed#[EED4732D0B2C8220]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3b235081[collection1] main]
   [junit4]   2> 409946 INFO  
(TEST-TestStressRecovery.testStressRecovery-seed#[EED4732D0B2C8220]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 409947 INFO  (searcherExecutor-937-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3b235081[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 409947 INFO  
(TEST-TestStressRecovery.testStressRecovery-seed#[EED4732D0B2C8220]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 2
   [junit4]   2> 409952 INFO  (WRITER0) [    ] o.a.s.u.DirectUpdateHandler2 
start 
commit{_version_=1600227801162579968,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 409956 INFO  (WRITER2) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-2&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{delete=[126
 (-2)]} 0 4
   [junit4]   2> 409956 INFO  (WRITER1) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-1&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{delete=[168
 (-1)]} 0 4
   [junit4]   2> 409956 INFO  (WRITER7) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-4&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{delete=[126
 (-4)]} 0 0
   [junit4]   2> 409956 INFO  (WRITER3) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-3&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{delete=[126
 (-3)]} 0 4
   [junit4]   2> 409956 INFO  (WRITER1) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-5&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{delete=[126
 (-5)]} 0 0
   [junit4]   2> 409956 INFO  (WRITER0) [    ] o.a.s.u.DirectUpdateHandler2 
end_commit_flush
   [junit4]   2> 409956 INFO  (WRITER0) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 409958 INFO  (WRITER1) [    ] o.a.s.u.DirectUpdateHandler2 
start 
commit{_version_=1600227801168871424,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 409958 INFO  (WRITER1) [    ] o.a.s.u.DirectUpdateHandler2 
end_commit_flush
   [junit4]   2> 409958 INFO  (WRITER1) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 0
   [junit4]   2> 409959 INFO  (WRITER3) [    ] o.a.s.u.DirectUpdateHandler2 
start 
commit{_version_=1600227801169920000,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 409959 INFO  (WRITER3) [    ] o.a.s.u.DirectUpdateHandler2 
end_commit_flush
   [junit4]   2> 409959 INFO  (WRITER3) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 0
   [junit4]   2> 409960 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=34&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409960 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409960 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=70&wt=json} status=0 QTime=1
   [junit4]   2> 409960 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=76&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=39&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=197&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=16&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=21&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=119&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=178&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=104&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=153&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (WRITER7) [    ] o.a.s.u.DirectUpdateHandler2 
start 
commit{_version_=1600227801170968576,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 409960 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=2
   [junit4]   2> 409960 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:160&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409960 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=110&wt=json} status=0 QTime=2
   [junit4]   2> 409960 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=23&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:62&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409960 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (WRITER7) [    ] o.a.s.u.DirectUpdateHandler2 
end_commit_flush
   [junit4]   2> 409960 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=136&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=63&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:47&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409960 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=107&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:86&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409961 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=16&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=45&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=72&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:133&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409961 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409961 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=60&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=181&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:5&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409961 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:181&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409961 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=141&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=177&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:101&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409961 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=37&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=162&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=75&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=58&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=191&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409961 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:180&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409961 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:168&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409961 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=194&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=81&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409961 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=120&wt=json} status=0 QTime=0
   [junit4]   2> 409961 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=96&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=161&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=121&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=146&wt=json} status=0 QTime=3
   [junit4]   2> 409962 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=61&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=187&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:70&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409962 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=173&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:81&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409960 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=3
   [junit4]   2> 409962 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=181&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:142&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409962 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=146&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=176&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=121&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=83&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=170&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=93&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:19&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409962 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=31&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=154&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=176&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:96&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409962 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=55&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=22&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=188&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409962 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409962 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=119&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=192&wt=json} status=0 QTime=0
   [junit4]   2> 409960 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=156&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=111&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=95&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=180&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=134&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=159&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409962 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:61&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409962 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:167&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409963 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409963 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> 409963 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=182&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:112&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409963 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=195&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:143&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409963 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=98&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:174&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409963 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=114&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:166&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409963 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=54&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=131&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=181&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:153&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409963 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=166&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=12&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:109&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409963 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409963 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=17&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409963 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=24&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=38&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=141&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=60&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:64&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409963 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=19&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=107&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER1) [    ] 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> 409963 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=84&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=71&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=84&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=143&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:43&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409963 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=94&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=116&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=74&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409962 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:46&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409962 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=164&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=99&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=60&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=192&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=55&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=56&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=33&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=66&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=14&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:64&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409964 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=67&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=37&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=75&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=141&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=128&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=182&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:191&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409964 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:122&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409963 INFO  (READER1) [    ] 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> 409964 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:119&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409964 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:105&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409964 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=131&wt=json} status=0 QTime=0
   [junit4]   2> 409965 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409965 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=85&wt=json} status=0 QTime=0
   [junit4]   2> 409965 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=59&wt=json} status=0 QTime=0
   [junit4]   2> 409965 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409965 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:103&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409965 INFO  (READER6) [    ] 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> 409965 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409965 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409965 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=175&wt=json} status=0 QTime=0
   [junit4]   2> 409965 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=113&wt=json} status=0 QTime=0
   [junit4]   2> 409965 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409965 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=82&wt=json} status=0 QTime=0
   [junit4]   2> 409965 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:46&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409965 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=165&wt=json} status=0 QTime=0
   [junit4]   2> 409965 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=99&wt=json} status=0 QTime=0
   [junit4]   2> 409965 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=190&wt=json} status=0 QTime=0
   [junit4]   2> 409965 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409965 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:96&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409965 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> 409966 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:99&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409963 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409963 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=34&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:28&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409966 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409966 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=194&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=32&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=68&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=22&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=177&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=62&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=117&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=125&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=55&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=119&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=79&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=64&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=13&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=169&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=138&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:184&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409966 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=60&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=153&wt=json} status=0 QTime=0
   [junit4]   2> 409966 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:78&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409966 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:86&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409966 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=167&wt=json} status=0 QTime=0
   [junit4]   2> 409966 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> 409966 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409966 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=64&wt=json} status=0 QTime=0
   [junit4]   2> 409965 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=48&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=17&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=158&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=80&wt=json} status=0 QTime=0
   [junit4]   2> 409967 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> 409967 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409964 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:55&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409967 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> 409967 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409967 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=138&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:172&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409964 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=75&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409967 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=136&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=24&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=84&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=139&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:143&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409967 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=13&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=143&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:191&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409967 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:191&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409967 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:85&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409967 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:177&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409967 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=75&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:64&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409967 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=87&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=104&wt=json} status=0 QTime=0
   [junit4]   2> 409967 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:172&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409967 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:190&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=42&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=12&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=117&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=175&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=182&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=114&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=162&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=93&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=104&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=183&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=133&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=19&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=53&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:40&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409968 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:71&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=112&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=137&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=196&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=68&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=54&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409968 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:55&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=89&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER5) [    ] 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> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=34&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409968 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:87&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:112&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409968 INFO  (READER5) [    ] 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> 409968 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:186&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=20&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:113&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409969 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=88&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=83&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=195&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=114&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=156&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=97&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409969 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] 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> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=100&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=120&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=137&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=89&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=179&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=155&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:118&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=158&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:75&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=27&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:102&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=46&wt=json} status=0 QTime=0
   [junit4]   2> 409969 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=80&wt=json} status=0 QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:133&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:128&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:8&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=124&wt=json} status=0 QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=184&wt=json} status=0 QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=132&wt=json} status=0 QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=197&wt=json} status=0 QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=83&wt=json} status=0 QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:44&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=96&wt=json} status=0 QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:112&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=151&wt=json} status=0 QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=97&wt=json} status=0 QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=158&wt=json} status=0 QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=169&wt=json} status=0 QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=151&wt=json} status=0 QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:105&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=196&wt=json} status=0 QTime=0
   [junit4]   2> 409970 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=19&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=160&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=82&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=193&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=29&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=88&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=134&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:85&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=72&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=117&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=81&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=128&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=105&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=83&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=174&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=148&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=187&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=77&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=139&wt=json} status=0 QTime=0
   [junit4]   2> 409971 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=154&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (WRITER7) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 11
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=28&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=159&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=101&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=73&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=186&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=78&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=154&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=110&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=96&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:5&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:185&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] 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> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=63&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=64&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409972 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409973 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409973 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:126&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409973 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409973 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409973 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=24&wt=json} status=0 QTime=0
   [junit4]   2> 409973 INFO  (WRITER8) [    ] o.a.s.u.DirectUpdateHandler2 
start 
commit{_version_=1600227801184600064,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 409973 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 409973 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:101&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409973 INFO  (WRITER8) [    ] o.a.s.u.DirectUpdateHandler2 
end_commit_flush
   [junit4]   2> 409973 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409973 INFO  (WRITER8) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 0
   [junit4]   2> 409973 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> 409973 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:192&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409973 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409973 INFO  (READER4) [    ] 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> 409973 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> 409973 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=61&wt=json} status=0 QTime=0
   [junit4]   2> 409973 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=37&wt=json} status=0 QTime=0
   [junit4]   2> 409973 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={q=id:124&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 409973 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0
   [junit4]   2> 409973 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=175&wt=json} status=0 QTime=0
   [junit4]   2> 409973 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=167&wt=json} status=0 QTime=0
   [junit4]   2> 409973 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> 409973 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=133&wt=json} status=0 QTime=0
   [junit4]   2> 409973 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1]  
webapp=null path=null params={qt=/get&ids=45&wt=json} status=0 QTime=0
   [junit4]   2> 409973 INFO  (READER8) [    ] o.a.s.c.S.Requ

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

dlerBase.handleRequest(RequestHandlerBase.java:199)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.execute(SolrCore.java:2510)
   [junit4]   2>        at 
org.apache.solr.servlet.DirectSolrConnection.request(DirectSolrConnection.java:125)
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.updateJ(SolrTestCaseJ4.java:1286)
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.deleteAndGetVersion(SolrTestCaseJ4.java:1464)
   [junit4]   2>        at 
org.apache.solr.search.TestStressRecovery$1.run(TestStressRecovery.java:191)
   [junit4]   2> 
   [junit4]   2> 21797 INFO  
(TEST-TestStressRecovery.testStressRecovery-seed#[EED4732D0B2C8220]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testStressRecovery
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestStressRecovery 
-Dtests.method=testStressRecovery -Dtests.seed=EED4732D0B2C8220 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.badapples=true 
-Dtests.locale=gv-IM -Dtests.timezone=Etc/GMT+8 -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   16.1s J0 | TestStressRecovery.testStressRecovery <<<
   [junit4]    > Throwable #1: 
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=29, name=WRITER6, state=RUNNABLE, 
group=TGRP-TestStressRecovery]
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([EED4732D0B2C8220:54EE1A7094C43D2E]:0)
   [junit4]    > Caused by: java.lang.RuntimeException: 
java.lang.NullPointerException
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([EED4732D0B2C8220]:0)
   [junit4]    >        at 
org.apache.solr.search.TestStressRecovery$1.run(TestStressRecovery.java:259)
   [junit4]    > Caused by: java.lang.NullPointerException
   [junit4]    >        at 
org.apache.solr.update.TransactionLog.getLogSizeFromStream(TransactionLog.java:637)
   [junit4]    >        at 
org.apache.solr.update.UpdateLog.getCurrentLogSizeFromStream(UpdateLog.java:299)
   [junit4]    >        at 
org.apache.solr.update.DirectUpdateHandler2.getCurrentTLogSize(DirectUpdateHandler2.java:1007)
   [junit4]    >        at 
org.apache.solr.update.DirectUpdateHandler2.updateDeleteTrackers(DirectUpdateHandler2.java:432)
   [junit4]    >        at 
org.apache.solr.update.DirectUpdateHandler2.delete(DirectUpdateHandler2.java:465)
   [junit4]    >        at 
org.apache.solr.update.processor.RunUpdateProcessor.processDelete(RunUpdateProcessorFactory.java:75)
   [junit4]    >        at 
org.apache.solr.update.processor.UpdateRequestProcessor.processDelete(UpdateRequestProcessor.java:59)
   [junit4]    >        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalDelete(DistributedUpdateProcessor.java:956)
   [junit4]    >        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.versionDelete(DistributedUpdateProcessor.java:1844)
   [junit4]    >        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.doDeleteById(DistributedUpdateProcessor.java:1381)
   [junit4]    >        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.processDelete(DistributedUpdateProcessor.java:1359)
   [junit4]    >        at 
org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.processDelete(LogUpdateProcessorFactory.java:124)
   [junit4]    >        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.handleDeleteMap(JsonLoader.java:394)
   [junit4]    >        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.handleDeleteCommand(JsonLoader.java:311)
   [junit4]    >        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.processUpdate(JsonLoader.java:171)
   [junit4]    >        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.load(JsonLoader.java:121)
   [junit4]    >        at 
org.apache.solr.handler.loader.JsonLoader.load(JsonLoader.java:84)
   [junit4]    >        at 
org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:97)
   [junit4]    >        at 
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:68)
   [junit4]    >        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199)
   [junit4]    >        at 
org.apache.solr.core.SolrCore.execute(SolrCore.java:2510)
   [junit4]    >        at 
org.apache.solr.servlet.DirectSolrConnection.request(DirectSolrConnection.java:125)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.updateJ(SolrTestCaseJ4.java:1286)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.deleteAndGetVersion(SolrTestCaseJ4.java:1464)
   [junit4]    >        at 
org.apache.solr.search.TestStressRecovery$1.run(TestStressRecovery.java:191)
   [junit4]   2> 21803 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 21803 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=337245473
   [junit4]   2> 21803 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 21804 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@103b1e90: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@5524f391
   [junit4]   2> 21827 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 21827 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5af24513: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@62076b61
   [junit4]   2> 21827 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 21827 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6c128059: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@9b29cd
   [junit4]   2> 21831 INFO  (coreCloseExecutor-12-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@6cb05f8c
   [junit4]   2> 21832 INFO  (coreCloseExecutor-12-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=6cb05f8c
   [junit4]   2> 21832 INFO  (coreCloseExecutor-12-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6d4fcfd7: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@7e3b7867
   [junit4]   2> 21957 INFO  
(SUITE-TestStressRecovery-seed#[EED4732D0B2C8220]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ------------------------------------------------------- 
Done waiting for tracked resources to be released
   [junit4]   2> May 12, 2018 4:32:51 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Lucene70, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@60d7988e),
 locale=gv-IM, timezone=Etc/GMT+8
   [junit4]   2> NOTE: Linux 4.13.0-39-generic amd64/Oracle Corporation 9.0.4 
(64-bit)/cpus=8,threads=1,free=326643416,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestStressRecovery]
   [junit4] Completed [2/10 (1!)] on J0 in 21.34s, 1 test, 1 error <<< FAILURES!

[...truncated 45 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/lucene/common-build.xml:1568:
 The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/lucene/common-build.xml:1092:
 There were test failures: 10 suites, 10 tests, 1 error [seed: EED4732D0B2C8220]

Total time: 1 minute 31 seconds

[repro] Setting last failure code to 256

[repro] Failures:
[repro]   0/5 failed: org.apache.solr.cloud.AddReplicaTest
[repro]   1/5 failed: org.apache.solr.search.TestStressRecovery
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all 
warnings.
<Git Blamer> GIT_COMMIT=bad0e3f164872c9e96fa366ab2dc1409581d7a34, 
workspace=/var/lib/jenkins/workspace/Lucene-Solr-BadApples-master-Linux
[WARNINGS] Computing warning deltas based on reference build #34
Recording test results
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to