[JENKINS] Lucene-Solr-master-Linux (32bit/jdk1.8.0_162) - Build # 21954 - Unstable!

[Policeman Jenkins Server]

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/21954/
Java: 32bit/jdk1.8.0_162 -client -XX:+UseConcMarkSweepGC

1 tests failed.
FAILED:  org.apache.solr.search.TestStressVersions.testStressGetRealtimeVersions

Error Message:
Captured an uncaught exception in thread: Thread[id=13169, name=WRITER16, 
state=RUNNABLE, group=TGRP-TestStressVersions]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=13169, name=WRITER16, state=RUNNABLE, 
group=TGRP-TestStressVersions]
        at 
__randomizedtesting.SeedInfo.seed([6950307486962244:6C54214BCBEA2618]:0)
Caused by: java.lang.RuntimeException: org.apache.solr.common.SolrException: 
Exception writing document id 134 to the index; possible analysis error.
        at __randomizedtesting.SeedInfo.seed([6950307486962244]:0)
        at 
org.apache.solr.search.TestStressVersions$1.run(TestStressVersions.java:199)
Caused by: org.apache.solr.common.SolrException: Exception writing document id 
134 to the index; possible analysis error.
        at 
org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:246)
        at 
org.apache.solr.update.processor.RunUpdateProcessor.processAdd(RunUpdateProcessorFactory.java:67)
        at 
org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalAdd(DistributedUpdateProcessor.java:950)
        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:1163)
        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:633)
        at 
org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.processAdd(LogUpdateProcessorFactory.java:103)
        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.handleAdds(JsonLoader.java:501)
        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.processUpdate(JsonLoader.java:145)
        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.addAndGetVersion(SolrTestCaseJ4.java:1451)
        at 
org.apache.solr.search.TestStressVersions$1.run(TestStressVersions.java:175)
Caused by: java.lang.NullPointerException
        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.addDoc0(DirectUpdateHandler2.java:291)
        at 
org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:234)
        ... 18 more




Build Log:
[...truncated 13287 lines...]
   [junit4] Suite: org.apache.solr.search.TestStressVersions
   [junit4]   2> 1273637 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestStressVersions_6950307486962244-001/init-core-data-001
   [junit4]   2> 1273637 WARN  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 1273638 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1273639 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 1273639 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1273639 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1273665 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1273681 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1273755 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1273801 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@519c6b
   [junit4]   2> 1273808 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@519c6b
   [junit4]   2> 1273808 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@519c6b
   [junit4]   2> 1273810 INFO  (coreLoadExecutor-4390-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1273810 INFO  (coreLoadExecutor-4390-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1273847 INFO  (coreLoadExecutor-4390-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1273860 INFO  (coreLoadExecutor-4390-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1273933 INFO  (coreLoadExecutor-4390-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1273942 INFO  (coreLoadExecutor-4390-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 1273942 INFO  (coreLoadExecutor-4390-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@519c6b
   [junit4]   2> 1273942 INFO  (coreLoadExecutor-4390-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1273942 INFO  (coreLoadExecutor-4390-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestStressVersions_6950307486962244-001/init-core-data-001/]
   [junit4]   2> 1273944 INFO  (coreLoadExecutor-4390-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@1726cc9
   [junit4]   2> 1273947 WARN  (coreLoadExecutor-4390-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> 1273995 INFO  (coreLoadExecutor-4390-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1273995 INFO  (coreLoadExecutor-4390-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1273996 INFO  (coreLoadExecutor-4390-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1273996 INFO  (coreLoadExecutor-4390-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1273997 INFO  (coreLoadExecutor-4390-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=50, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1273997 INFO  (coreLoadExecutor-4390-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@32315f[collection1] 
main]
   [junit4]   2> 1273998 WARN  (coreLoadExecutor-4390-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 1273998 INFO  (coreLoadExecutor-4390-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1273999 INFO  
(searcherExecutor-4391-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@32315f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1273999 INFO  (coreLoadExecutor-4390-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1599517764377116672
   [junit4]   2> 1274001 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 1274004 INFO  
(TEST-TestStressVersions.testStressGetRealtimeVersions-seed#[6950307486962244]) 
[    ] o.a.s.SolrTestCaseJ4 ###Starting testStressGetRealtimeVersions
   [junit4]   2> 1274004 INFO  
(TEST-TestStressVersions.testStressGetRealtimeVersions-seed#[6950307486962244]) 
[    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM 
INDEX
   [junit4]   2> 1274005 INFO  
(TEST-TestStressVersions.testStressGetRealtimeVersions-seed#[6950307486962244]) 
[    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@8c6fc1[collection1] realtime]
   [junit4]   2> 1274006 INFO  
(TEST-TestStressVersions.testStressGetRealtimeVersions-seed#[6950307486962244]) 
[    ] 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 1
   [junit4]   2> 1274006 INFO  
(TEST-TestStressVersions.testStressGetRealtimeVersions-seed#[6950307486962244]) 
[    ] o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1599517764384456704,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1274006 INFO  
(TEST-TestStressVersions.testStressGetRealtimeVersions-seed#[6950307486962244]) 
[    ] o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@137f7ee 
commitCommandVersion:1599517764384456704
   [junit4]   2> 1274007 INFO  
(TEST-TestStressVersions.testStressGetRealtimeVersions-seed#[6950307486962244]) 
[    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@e5abbd[collection1] main]
   [junit4]   2> 1274007 INFO  
(TEST-TestStressVersions.testStressGetRealtimeVersions-seed#[6950307486962244]) 
[    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1274009 INFO  (searcherExecutor-4391-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@e5abbd[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1274009 INFO  
(TEST-TestStressVersions.testStressGetRealtimeVersions-seed#[6950307486962244]) 
[    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 2
   [junit4]   2> 1274013 INFO  (WRITER1) [    ] o.a.s.u.DirectUpdateHandler2 
start 
commit{_version_=1599517764391796736,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 1274015 INFO  (WRITER20) [    ] o.a.s.u.DirectUpdateHandler2 
start 
commit{_version_=1599517764393893888,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 1274015 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=46&wt=json} status=0 QTime=0
   [junit4]   2> 1274015 INFO  (READER0) [    ] 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> 1274015 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=120&wt=json} status=0 QTime=0
   [junit4]   2> 1274016 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
   [junit4]   2> 1274016 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=27&wt=json} status=0 QTime=0
   [junit4]   2> 1274016 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=56&wt=json} status=0 QTime=0
   [junit4]   2> 1274016 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=116&wt=json} status=0 QTime=0
   [junit4]   2> 1274016 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=56&wt=json} status=0 QTime=0
   [junit4]   2> 1274016 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:67&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274016 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:56&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274017 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=56&wt=json} status=0 QTime=0
   [junit4]   2> 1274017 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=115&wt=json} status=0 QTime=0
   [junit4]   2> 1274017 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> 1274017 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=117&wt=json} status=0 QTime=0
   [junit4]   2> 1274017 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:60&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274017 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=35&wt=json} status=0 QTime=0
   [junit4]   2> 1274017 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
   [junit4]   2> 1274017 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> 1274017 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
   [junit4]   2> 1274017 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:136&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274018 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=130&wt=json} status=0 QTime=0
   [junit4]   2> 1274018 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=73&wt=json} status=0 QTime=0
   [junit4]   2> 1274018 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=141&wt=json} status=0 QTime=0
   [junit4]   2> 1274018 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> 1274018 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=134&wt=json} status=0 QTime=0
   [junit4]   2> 1274018 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=118&wt=json} status=0 QTime=0
   [junit4]   2> 1274018 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> 1274018 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:117&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274019 INFO  (READER0) [    ] 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> 1274019 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=133&wt=json} status=0 QTime=0
   [junit4]   2> 1274019 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:139&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274019 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=94&wt=json} status=0 QTime=0
   [junit4]   2> 1274019 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> 1274019 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:72&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274020 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:25&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274020 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=102&wt=json} status=0 QTime=0
   [junit4]   2> 1274020 INFO  (READER0) [    ] 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> 1274020 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=77&wt=json} status=0 QTime=0
   [junit4]   2> 1274020 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> 1274020 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=46&wt=json} status=0 QTime=0
   [junit4]   2> 1274020 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=52&wt=json} status=0 QTime=0
   [junit4]   2> 1274020 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> 1274021 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=14&wt=json} status=0 QTime=0
   [junit4]   2> 1274021 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=117&wt=json} status=0 QTime=0
   [junit4]   2> 1274021 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> 1274021 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=47&wt=json} status=0 QTime=0
   [junit4]   2> 1274021 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=36&wt=json} status=0 QTime=0
   [junit4]   2> 1274021 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=30&wt=json} status=0 QTime=0
   [junit4]   2> 1274021 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=19&wt=json} status=0 QTime=0
   [junit4]   2> 1274021 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> 1274021 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=127&wt=json} status=0 QTime=0
   [junit4]   2> 1274021 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=143&wt=json} status=0 QTime=0
   [junit4]   2> 1274021 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=117&wt=json} status=0 QTime=0
   [junit4]   2> 1274021 INFO  (READER0) [    ] 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> 1274021 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=135&wt=json} status=0 QTime=0
   [junit4]   2> 1274022 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> 1274022 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> 1274022 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> 1274022 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:117&omitHeader=true&wt=json} hits=0 
status=0 QTime=5
   [junit4]   2> 1274022 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=116&wt=json} status=0 QTime=0
   [junit4]   2> 1274022 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=51&wt=json} status=0 QTime=0
   [junit4]   2> 1274023 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=83&wt=json} status=0 QTime=0
   [junit4]   2> 1274023 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=121&wt=json} status=0 QTime=0
   [junit4]   2> 1274023 INFO  (READER1) [    ] 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> 1274023 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:127&omitHeader=true&wt=json} hits=0 
status=0 QTime=6
   [junit4]   2> 1274023 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:117&omitHeader=true&wt=json} hits=0 
status=0 QTime=2
   [junit4]   2> 1274023 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:54&omitHeader=true&wt=json} hits=0 status=0 
QTime=1
   [junit4]   2> 1274023 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> 1274024 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=69&wt=json} status=0 QTime=0
   [junit4]   2> 1274024 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:140&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274024 INFO  (WRITER13) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[109 (1599517764392845314)]} 0 10
   [junit4]   2> 1274024 INFO  (WRITER5) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[58 (1599517764391796741)]} 0 10
   [junit4]   2> 1274024 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=51&wt=json} status=0 QTime=0
   [junit4]   2> 1274024 INFO  (WRITER2) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[29 (1599517764391796738)]} 0 11
   [junit4]   2> 1274024 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=117&wt=json} status=0 QTime=0
   [junit4]   2> 1274024 INFO  (WRITER19) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[20 (1599517764392845320)]} 0 9
   [junit4]   2> 1274024 INFO  (WRITER15) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[32 (1599517764392845316)]} 0 9
   [junit4]   2> 1274024 INFO  (WRITER24) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[0 (1599517764393893889)]} 0 9
   [junit4]   2> 1274024 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=46&wt=json} status=0 QTime=0
   [junit4]   2> 1274024 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=130&wt=json} status=0 QTime=0
   [junit4]   2> 1274024 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=31&wt=json} status=0 QTime=0
   [junit4]   2> 1274024 INFO  (WRITER9) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[40 (1599517764391796744)]} 0 11
   [junit4]   2> 1274024 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=48&wt=json} status=0 QTime=0
   [junit4]   2> 1274024 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=118&wt=json} status=0 QTime=0
   [junit4]   2> 1274025 INFO  (WRITER10) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[128 (1599517764391796745)]} 0 11
   [junit4]   2> 1274025 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:72&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274025 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=80&wt=json} status=0 QTime=0
   [junit4]   2> 1274025 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=71&wt=json} status=0 QTime=0
   [junit4]   2> 1274025 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=106&wt=json} status=0 QTime=0
   [junit4]   2> 1274025 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=86&wt=json} status=0 QTime=0
   [junit4]   2> 1274025 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=40&wt=json} status=0 QTime=0
   [junit4]   2> 1274025 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=56&wt=json} status=0 QTime=0
   [junit4]   2> 1274025 INFO  (WRITER23) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[128 (1599517764404379649)]} 0 10
   [junit4]   2> 1274025 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> 1274025 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:9&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274025 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=141&wt=json} status=0 QTime=2
   [junit4]   2> 1274025 INFO  (WRITER12) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[62 (1599517764392845312)]} 0 11
   [junit4]   2> 1274025 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=20&wt=json} status=0 QTime=2
   [junit4]   2> 1274025 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=0
   [junit4]   2> 1274025 INFO  (WRITER3) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[101 (1599517764391796737)]} 0 12
   [junit4]   2> 1274026 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> 1274026 INFO  (WRITER0) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[101 (1599517764404379650)]} 0 12
   [junit4]   2> 1274026 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=73&wt=json} status=0 QTime=0
   [junit4]   2> 1274026 INFO  (WRITER11) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[127 (1599517764392845313)]} 0 12
   [junit4]   2> 1274026 INFO  (READER6) [    ] 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> 1274026 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=46&wt=json} status=0 QTime=0
   [junit4]   2> 1274026 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=122&wt=json} status=0 QTime=0
   [junit4]   2> 1274026 INFO  (READER2) [    ] 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> 1274026 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=47&wt=json} status=0 QTime=0
   [junit4]   2> 1274026 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=26&wt=json} status=0 QTime=0
   [junit4]   2> 1274026 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=104&wt=json} status=0 QTime=0
   [junit4]   2> 1274026 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=133&wt=json} status=0 QTime=0
   [junit4]   2> 1274026 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=94&wt=json} status=0 QTime=0
   [junit4]   2> 1274026 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=18&wt=json} status=0 QTime=0
   [junit4]   2> 1274026 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:141&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274026 INFO  (WRITER18) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[105 (1599517764392845319)]} 0 12
   [junit4]   2> 1274026 INFO  (WRITER4) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[64 (1599517764391796742)]} 0 13
   [junit4]   2> 1274026 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=30&wt=json} status=0 QTime=0
   [junit4]   2> 1274026 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=35&wt=json} status=0 QTime=0
   [junit4]   2> 1274027 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:98&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274027 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=140&wt=json} status=0 QTime=3
   [junit4]   2> 1274027 INFO  (WRITER14) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{delete=[126 (-1599517764392845315)]} 
0 12
   [junit4]   2> 1274027 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:51&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274027 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=51&wt=json} status=0 QTime=0
   [junit4]   2> 1274027 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1274027 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=59&wt=json} status=0 QTime=2
   [junit4]   2> 1274027 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=39&wt=json} status=0 QTime=0
   [junit4]   2> 1274027 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> 1274027 INFO  (WRITER8) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[67 (1599517764391796743)]} 0 14
   [junit4]   2> 1274027 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=102&wt=json} status=0 QTime=0
   [junit4]   2> 1274027 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=27&wt=json} status=0 QTime=0
   [junit4]   2> 1274027 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=120&wt=json} status=0 QTime=0
   [junit4]   2> 1274027 INFO  (WRITER7) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[144 (1599517764391796740)]} 0 14
   [junit4]   2> 1274027 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> 1274027 INFO  (WRITER6) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[2 (1599517764391796739)]} 0 14
   [junit4]   2> 1274027 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=136&wt=json} status=0 QTime=0
   [junit4]   2> 1274027 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> 1274027 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=49&wt=json} status=0 QTime=0
   [junit4]   2> 1274027 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=92&wt=json} status=0 QTime=0
   [junit4]   2> 1274027 INFO  (WRITER17) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{delete=[25 (-1599517764392845318)]} 
0 13
   [junit4]   2> 1274028 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=129&wt=json} status=0 QTime=0
   [junit4]   2> 1274028 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=12&wt=json} status=0 QTime=0
   [junit4]   2> 1274028 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:125&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274028 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=123&wt=json} status=0 QTime=0
   [junit4]   2> 1274028 INFO  (WRITER1) [    ] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@5c9ffe[collection1] main]
   [junit4]   2> 1274028 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=127&wt=json} status=0 QTime=0
   [junit4]   2> 1274028 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:66&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274028 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> 1274028 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=64&wt=json} status=0 QTime=0
   [junit4]   2> 1274028 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=127&wt=json} status=0 QTime=0
   [junit4]   2> 1274028 INFO  (WRITER1) [    ] o.a.s.u.DirectUpdateHandler2 
end_commit_flush
   [junit4]   2> 1274028 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=124&wt=json} status=0 QTime=0
   [junit4]   2> 1274028 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=127&wt=json} status=0 QTime=0
   [junit4]   2> 1274026 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> 1274027 INFO  (WRITER16) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[133 (1599517764392845317)]} 0 13
   [junit4]   2> 1274027 INFO  (WRITER21) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[65 (1599517764393893890)]} 0 12
   [junit4]   2> 1274029 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=105&wt=json} status=0 QTime=0
   [junit4]   2> 1274026 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=143&wt=json} status=0 QTime=1
   [junit4]   2> 1274026 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:141&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274029 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274031 INFO  (searcherExecutor-4391-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@5c9ffe[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c1)))}
   [junit4]   2> 1274031 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=137&wt=json} status=0 QTime=2
   [junit4]   2> 1274031 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=112&wt=json} status=0 QTime=2
   [junit4]   2> 1274031 INFO  (WRITER1) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 18
   [junit4]   2> 1274031 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=137&wt=json} status=0 QTime=3
   [junit4]   2> 1274032 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:14&omitHeader=true&wt=json} hits=0 status=0 
QTime=2
   [junit4]   2> 1274031 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=50&wt=json} status=0 QTime=2
   [junit4]   2> 1274032 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:130&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274032 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=50&wt=json} status=0 QTime=3
   [junit4]   2> 1274032 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:51&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274032 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274032 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:65&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274032 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:144&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274032 INFO  (READER5) [    ] 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> 1274032 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=103&wt=json} status=0 QTime=0
   [junit4]   2> 1274032 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:65&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274033 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:52&omitHeader=true&wt=json} hits=0 status=0 
QTime=4
   [junit4]   2> 1274033 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=53&wt=json} status=0 QTime=0
   [junit4]   2> 1274033 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> 1274033 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> 1274033 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> 1274033 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:76&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274033 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:65&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274033 INFO  (READER4) [    ] 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> 1274033 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=110&wt=json} status=0 QTime=0
   [junit4]   2> 1274033 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=103&wt=json} status=0 QTime=0
   [junit4]   2> 1274033 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=132&wt=json} status=0 QTime=0
   [junit4]   2> 1274033 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> 1274033 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
   [junit4]   2> 1274033 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274042 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=94&wt=json} status=0 QTime=8
   [junit4]   2> 1274033 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=53&wt=json} status=0 QTime=0
   [junit4]   2> 1274042 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=88&wt=json} status=0 QTime=8
   [junit4]   2> 1274043 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=28&wt=json} status=0 QTime=0
   [junit4]   2> 1274043 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=12&wt=json} status=0 QTime=0
   [junit4]   2> 1274043 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> 1274043 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:72&omitHeader=true&wt=json} hits=0 status=0 
QTime=9
   [junit4]   2> 1274043 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=37&wt=json} status=0 QTime=0
   [junit4]   2> 1274043 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=88&wt=json} status=0 QTime=0
   [junit4]   2> 1274043 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> 1274043 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=120&wt=json} status=0 QTime=0
   [junit4]   2> 1274043 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> 1274043 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=124&wt=json} status=0 QTime=0
   [junit4]   2> 1274043 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=101&wt=json} status=0 QTime=0
   [junit4]   2> 1274043 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1274043 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=73&wt=json} status=0 QTime=0
   [junit4]   2> 1274043 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> 1274043 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=137&wt=json} status=0 QTime=0
   [junit4]   2> 1274043 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274043 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274043 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=97&wt=json} status=0 QTime=0
   [junit4]   2> 1274043 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:65&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274043 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=120&wt=json} status=0 QTime=0
   [junit4]   2> 1274044 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=95&wt=json} status=0 QTime=0
   [junit4]   2> 1274044 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274044 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=74&wt=json} status=0 QTime=0
   [junit4]   2> 1274044 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=43&wt=json} status=0 QTime=0
   [junit4]   2> 1274044 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=25&wt=json} status=0 QTime=0
   [junit4]   2> 1274044 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=70&wt=json} status=0 QTime=0
   [junit4]   2> 1274044 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=26&wt=json} status=0 QTime=0
   [junit4]   2> 1274044 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=102&wt=json} status=0 QTime=0
   [junit4]   2> 1274044 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=145&wt=json} status=0 QTime=0
   [junit4]   2> 1274044 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=97&wt=json} status=0 QTime=0
   [junit4]   2> 1274044 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> 1274044 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=67&wt=json} status=0 QTime=0
   [junit4]   2> 1274044 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=114&wt=json} status=0 QTime=0
   [junit4]   2> 1274044 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:65&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274044 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:108&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274044 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=86&wt=json} status=0 QTime=0
   [junit4]   2> 1274044 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=124&wt=json} status=0 QTime=0
   [junit4]   2> 1274044 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274044 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> 1274044 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:26&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274044 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:65&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274044 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=81&wt=json} status=0 QTime=0
   [junit4]   2> 1274045 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:66&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274045 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> 1274045 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:120&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274045 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:130&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274045 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274045 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:65&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274045 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=133&wt=json} status=0 QTime=0
   [junit4]   2> 1274045 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274045 INFO  (READER2) [    ] 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> 1274045 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
   [junit4]   2> 1274045 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=57&wt=json} status=0 QTime=0
   [junit4]   2> 1274045 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=32&wt=json} status=0 QTime=0
   [junit4]   2> 1274043 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> 1274045 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:135&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274045 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> 1274045 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=116&wt=json} status=0 QTime=0
   [junit4]   2> 1274043 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=61&wt=json} status=0 QTime=0
   [junit4]   2> 1274045 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=31&wt=json} status=0 QTime=0
   [junit4]   2> 1274045 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=83&wt=json} status=0 QTime=0
   [junit4]   2> 1274045 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> 1274045 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
   [junit4]   2> 1274045 INFO  (READER5) [    ] 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> 1274045 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=32&wt=json} status=0 QTime=0
   [junit4]   2> 1274045 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=73&wt=json} status=0 QTime=0
   [junit4]   2> 1274045 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274046 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=71&wt=json} status=0 QTime=0
   [junit4]   2> 1274046 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=44&wt=json} status=0 QTime=0
   [junit4]   2> 1274046 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> 1274046 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=85&wt=json} status=0 QTime=0
   [junit4]   2> 1274046 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=106&wt=json} status=0 QTime=0
   [junit4]   2> 1274046 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:140&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274046 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=90&wt=json} status=0 QTime=0
   [junit4]   2> 1274046 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
   [junit4]   2> 1274046 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274046 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=113&wt=json} status=0 QTime=0
   [junit4]   2> 1274046 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274046 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=63&wt=json} status=0 QTime=0
   [junit4]   2> 1274046 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:129&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274046 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=120&wt=json} status=0 QTime=0
   [junit4]   2> 1274046 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274046 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=131&wt=json} status=0 QTime=0
   [junit4]   2> 1274046 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274046 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> 1274046 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=56&wt=json} status=0 QTime=0
   [junit4]   2> 1274046 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> 1274046 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=48&wt=json} status=0 QTime=0
   [junit4]   2> 1274047 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=116&wt=json} status=0 QTime=0
   [junit4]   2> 1274047 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=26&wt=json} status=0 QTime=0
   [junit4]   2> 1274047 INFO  (READER3) [    ] 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> 1274047 INFO  (READER0) [    ] 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> 1274047 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274047 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=128&wt=json} status=0 QTime=0
   [junit4]   2> 1274047 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274047 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:65&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274047 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=105&wt=json} status=0 QTime=0
   [junit4]   2> 1274047 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=102&wt=json} status=0 QTime=0
   [junit4]   2> 1274047 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:59&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274047 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=67&wt=json} status=0 QTime=0
   [junit4]   2> 1274047 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=113&wt=json} status=0 QTime=0
   [junit4]   2> 1274047 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=49&wt=json} status=0 QTime=0
   [junit4]   2> 1274047 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274047 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274048 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=53&wt=json} status=0 QTime=0
   [junit4]   2> 1274048 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=30&wt=json} status=0 QTime=0
   [junit4]   2> 1274048 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=130&wt=json} status=0 QTime=0
   [junit4]   2> 1274048 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274048 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=69&wt=json} status=0 QTime=0
   [junit4]   2> 1274048 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=128&wt=json} status=0 QTime=0
   [junit4]   2> 1274048 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=41&wt=json} status=0 QTime=0
   [junit4]   2> 1274048 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=99&wt=json} status=0 QTime=0
   [junit4]   2> 1274048 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274048 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=90&wt=json} status=0 QTime=0
   [junit4]   2> 1274048 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=90&wt=json} status=0 QTime=0
   [junit4]   2> 1274048 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274046 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:50&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274048 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=105&wt=json} status=0 QTime=0
   [junit4]   2> 1274047 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=86&wt=json} status=0 QTime=0
   [junit4]   2> 1274049 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=98&wt=json} status=0 QTime=0
   [junit4]   2> 1274047 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=125&wt=json} status=0 QTime=0
   [junit4]   2> 1274049 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=140&wt=json} status=0 QTime=0
   [junit4]   2> 1274049 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> 1274049 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=94&wt=json} status=0 QTime=0
   [junit4]   2> 1274049 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> 1274049 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
   [junit4]   2> 1274049 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:65&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274049 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274049 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:135&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274049 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:37&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274049 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=120&wt=json} status=0 QTime=0
   [junit4]   2> 1274049 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=116&wt=json} status=0 QTime=0
   [junit4]   2> 1274049 INFO  (READER4) [    ] 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> 1274049 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274049 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:136&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274049 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=60&wt=json} status=0 QTime=0
   [junit4]   2> 1274049 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1274049 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> 1274049 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> 1274049 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=94&wt=json} status=0 QTime=0
   [junit4]   2> 1274049 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=0
   [junit4]   2> 1274049 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=39&wt=json} status=0 QTime=0
   [junit4]   2> 1274049 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:65&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274049 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> 1274049 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=72&wt=json} status=0 QTime=0
   [junit4]   2> 1274049 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> 1274050 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=76&wt=json} status=0 QTime=0
   [junit4]   2> 1274050 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274050 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274050 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> 1274050 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:137&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274050 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=77&wt=json} status=0 QTime=0
   [junit4]   2> 1274050 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> 1274050 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=145&wt=json} status=0 QTime=0
   [junit4]   2> 1274050 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=124&wt=json} status=0 QTime=0
   [junit4]   2> 1274050 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> 1274050 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=91&wt=json} status=0 QTime=0
   [junit4]   2> 1274050 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:65&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274050 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=85&wt=json} status=0 QTime=0
   [junit4]   2> 1274050 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> 1274050 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> 1274050 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
   [junit4]   2> 1274050 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1274050 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=20&wt=json} status=0 QTime=0
   [junit4]   2> 1274050 INFO  (READER1) [    ] 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> 1274050 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274050 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=78&wt=json} status=0 QTime=0
   [junit4]   2> 1274050 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=41&wt=json} status=0 QTime=0
   [junit4]   2> 1274050 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> 1274050 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> 1274050 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=36&wt=json} status=0 QTime=0
   [junit4]   2> 1274050 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=28&wt=json} status=0 QTime=0
   [junit4]   2> 1274050 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274050 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> 1274051 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274051 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274051 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:77&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274051 INFO  (READER5) [    ] 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> 1274051 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> 1274051 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=50&wt=json} status=0 QTime=0
   [junit4]   2> 1274051 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274051 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=95&wt=json} status=0 QTime=0
   [junit4]   2> 1274051 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=79&wt=json} status=0 QTime=0
   [junit4]   2> 1274051 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:100&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274051 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=130&wt=json} status=0 QTime=0
   [junit4]   2> 1274051 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> 1274051 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=79&wt=json} status=0 QTime=0
   [junit4]   2> 1274051 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=140&wt=json} status=0 QTime=0
   [junit4]   2> 1274051 INFO  (READER6) [    ] 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> 1274051 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:65&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274051 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=96&wt=json} status=0 QTime=0
   [junit4]   2> 1274051 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274051 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=130&wt=json} status=0 QTime=0
   [junit4]   2> 1274051 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=43&wt=json} status=0 QTime=0
   [junit4]   2> 1274051 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:65&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274051 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=38&wt=json} status=0 QTime=0
   [junit4]   2> 1274051 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=81&wt=json} status=0 QTime=0
   [junit4]   2> 1274051 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274051 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=54&wt=json} status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:116&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=23&wt=json} status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=91&wt=json} status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=117&wt=json} status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:65&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274051 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:141&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274051 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:23&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274052 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=90&wt=json} status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=77&wt=json} status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:108&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=40&wt=json} status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=111&wt=json} status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=99&wt=json} status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=135&wt=json} status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=66&wt=json} status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=15&wt=json} status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=53&wt=json} status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=16&wt=json} status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:65&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274052 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> 1274052 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:130&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274052 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:97&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274053 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:36&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274053 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274053 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=139&wt=json} status=0 QTime=0
   [junit4]   2> 1274053 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> 1274053 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=67&wt=json} status=0 QTime=0
   [junit4]   2> 1274053 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=48&wt=json} status=0 QTime=0
   [junit4]   2> 1274053 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274053 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:52&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274053 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> 1274053 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=80&wt=json} status=0 QTime=0
   [junit4]   2> 1274053 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:116&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274053 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274053 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> 1274053 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=57&wt=json} status=0 QTime=0
   [junit4]   2> 1274053 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=86&wt=json} status=0 QTime=0
   [junit4]   2> 1274053 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=113&wt=json} status=0 QTime=0
   [junit4]   2> 1274053 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=86&wt=json} status=0 QTime=0
   [junit4]   2> 1274053 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=78&wt=json} status=0 QTime=0
   [junit4]   2> 1274053 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=45&wt=json} status=0 QTime=0
   [junit4]   2> 1274053 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:66&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274053 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=129&wt=json} status=0 QTime=0
   [junit4]   2> 1274053 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1274054 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=141&wt=json} status=0 QTime=0
   [junit4]   2> 1274054 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274054 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=79&wt=json} status=0 QTime=0
   [junit4]   2> 1274054 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=43&wt=json} status=0 QTime=0
   [junit4]   2> 1274054 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274054 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=49&wt=json} status=0 QTime=0
   [junit4]   2> 1274054 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=134&wt=json} status=0 QTime=0
   [junit4]   2> 1274054 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> 1274054 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=89&wt=json} status=0 QTime=0
   [junit4]   2> 1274054 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
   [junit4]   2> 1274054 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274054 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> 1274054 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=127&wt=json} status=0 QTime=0
   [junit4]   2> 1274054 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274054 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274054 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:121&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274054 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=12&wt=json} status=0 QTime=0
   [junit4]   2> 1274054 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=48&wt=json} status=0 QTime=0
   [junit4]   2> 1274054 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274054 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:131&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274055 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274055 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> 1274055 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=129&wt=json} status=0 QTime=0
   [junit4]   2> 1274055 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> 1274055 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=93&wt=json} status=0 QTime=0
   [junit4]   2> 1274055 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:111&omitHeader=true&wt=json} hits=0 
status=0 QTime=0
   [junit4]   2> 1274055 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=79&wt=json} status=0 QTime=0
   [junit4]   2> 1274055 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=84&wt=json} status=0 QTime=0
   [junit4]   2> 1274055 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=29&wt=json} status=0 QTime=0
   [junit4]   2> 1274055 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274055 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=87&wt=json} status=0 QTime=0
   [junit4]   2> 1274055 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=0
   [junit4]   2> 1274055 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=80&wt=json} status=0 QTime=0
   [junit4]   2> 1274055 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=144&wt=json} status=0 QTime=0
   [junit4]   2> 1274056 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274056 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:65&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274056 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:65&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1274056 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=65&wt=json} status=0 QTime=0
   [junit4]   2> 1274056 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=69&wt=json} status=0 QTime=0
   [junit4]   2> 1274056 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> 1274052 INFO  (READER3) [    ] 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> 1274056 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=33&wt=json} status=0 QTime=0
   [junit4]   2> 1274055 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=78&wt=json} status=0 QTime=0
   [junit4]   2> 1274054 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> 1274053 INFO  (READER

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

UpdateProcessor.doLocalAdd(DistributedUpdateProcessor.java:950)
   [junit4]    >        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:1163)
   [junit4]    >        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:633)
   [junit4]    >        at 
org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.processAdd(LogUpdateProcessorFactory.java:103)
   [junit4]    >        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.handleAdds(JsonLoader.java:501)
   [junit4]    >        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.processUpdate(JsonLoader.java:145)
   [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.addAndGetVersion(SolrTestCaseJ4.java:1451)
   [junit4]    >        at 
org.apache.solr.search.TestStressVersions$1.run(TestStressVersions.java:175)
   [junit4]    > Caused by: java.lang.NullPointerException
   [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.addDoc0(DirectUpdateHandler2.java:291)
   [junit4]    >        at 
org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:234)
   [junit4]    >        ... 18 more
   [junit4]   2> 1277265 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 1277265 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=27158174
   [junit4]   2> 1277265 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1277265 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@14e9da3: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@ff84bc
   [junit4]   2> 1277274 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1277274 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@ae5db4: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@2fe44f
   [junit4]   2> 1277278 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1277278 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@941633: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@14c7f0f
   [junit4]   2> 1277279 INFO  (coreCloseExecutor-4396-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1ead4e2
   [junit4]   2> 1277279 INFO  (coreCloseExecutor-4396-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1ead4e2
   [junit4]   2> 1277279 INFO  (coreCloseExecutor-4396-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@42b82d: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@12c8118
   [junit4]   2> 1277287 INFO  (coreCloseExecutor-4396-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
   [junit4]   2> 1277288 INFO  (coreCloseExecutor-4396-thread-1) [    
x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@137f7ee commitCommandVersion:0
   [junit4]   2> 1277291 INFO  
(SUITE-TestStressVersions-seed#[6950307486962244]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ------------------------------------------------------- 
Done waiting for tracked resources to be released
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{id=PostingsFormat(name=Memory)}, 
docValues:{val_l=DocValuesFormat(name=Lucene70), 
_version_=DocValuesFormat(name=Direct), id=DocValuesFormat(name=Lucene70)}, 
maxPointsInLeafNode=1529, maxMBSortInHeap=6.964102817225275, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@139f1f1),
 locale=no-NO, timezone=EAT
   [junit4]   2> NOTE: Linux 4.13.0-39-generic i386/Oracle Corporation 
1.8.0_162 (32-bit)/cpus=8,threads=1,free=130443320,total=227983360
   [junit4]   2> NOTE: All tests run in this JVM: [DistributedQueueTest, 
TestSchemaResource, SearchHandlerTest, SystemInfoHandlerTest, 
TestMiniSolrCloudClusterSSL, TestRuleBasedAuthorizationPlugin, 
DistributedMLTComponentTest, HdfsCollectionsAPIDistributedZkTest, 
CoreAdminRequestStatusTest, SolrCoreTest, SubstringBytesRefFilterTest, 
FastVectorHighlighterTest, HttpTriggerListenerTest, TestCloudDeleteByQuery, 
MissingSegmentRecoveryTest, TestSearchPerf, ReplaceNodeTest, 
CheckHdfsIndexTest, DocExpirationUpdateProcessorFactoryTest, 
MetricsHandlerTest, TestInPlaceUpdatesDistrib, TestDownShardTolerantSearch, 
TestDistribIDF, MetricTriggerTest, UpdateRequestProcessorFactoryTest, 
HttpPartitionTest, TestSolrConfigHandler, DistributedFacetExistsSmallTest, 
TestNodeLostTrigger, CollectionsAPIDistributedZkTest, TestQueryWrapperFilter, 
TestBinaryResponseWriter, TestSerializedLuceneMatchVersion, 
DirectSolrConnectionTest, TolerantUpdateProcessorTest, 
TestElisionMultitermQuery, SchemaVersionSpecificBehaviorTest, 
TestOverriddenPrefixQueryForCustomFieldType, CdcrRequestHandlerTest, 
TestReload, FacetPivotSmallTest, TestGeoJSONResponseWriter, HdfsThreadLeakTest, 
TestAddFieldRealTimeGet, TestCloudPivotFacet, NodeMutatorTest, 
TestSolrCloudWithKerberosAlt, SuggesterFSTTest, SegmentsInfoRequestHandlerTest, 
TestSchemalessBufferedUpdates, CloudExitableDirectoryReaderTest, 
ZkFailoverTest, TestZkChroot, TestSolrCoreSnapshots, TestMacros, 
TestLocalFSCloudBackupRestore, ZkStateReaderTest, SampleTest, 
TestDocTermOrdsUninvertLimit, TriggerIntegrationTest, 
TestManagedSynonymFilterFactory, TestLeaderElectionZkExpiry, 
TestHalfAndHalfDocValues, ShardRoutingCustomTest, TestFuzzyAnalyzedSuggestions, 
CSVRequestHandlerTest, DirectUpdateHandlerOptimizeTest, HLLUtilTest, 
CustomHighlightComponentTest, TestPerFieldSimilarityWithDefaultOverride, 
SolrXmlInZkTest, TestTolerantUpdateProcessorCloud, ChaosMonkeySafeLeaderTest, 
TestDeleteCollectionOnDownNodes, BJQParserTest, MergeStrategyTest, 
SolrCloudReportersTest, TestPartialUpdateDeduplication, TestJsonRequest, 
TestDirectoryFactory, TestSimpleTrackingShardHandler, OverseerTest, 
QueryParsingTest, TestCloudSearcherWarming, CurrencyRangeFacetCloudTest, 
BigEndianAscendingWordDeserializerTest, TestSubQueryTransformer, 
TestReRankQParserPlugin, BasicFunctionalityTest, TestLuceneIndexBackCompat, 
AlternateDirectoryTest, TestDocBasedVersionConstraints, SolrInfoBeanTest, 
JavabinLoaderTest, TestReqParamsAPI, ConnectionManagerTest, 
ManagedSchemaRoundRobinCloudTest, ShufflingReplicaListTransformerTest, 
TestRandomRequestDistribution, TestTrie, SolrCoreMetricManagerTest, 
TestConfigOverlay, ClassificationUpdateProcessorIntegrationTest, 
TestDistributedGrouping, TestClassicSimilarityFactory, 
TestFoldingMultitermQuery, PKIAuthenticationIntegrationTest, TestStressVersions]
   [junit4] Completed [278/806 (1!)] on J1 in 3.67s, 1 test, 1 error <<< 
FAILURES!

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

[repro] Revision: b617489638db4ddca63e5fbc45a58c5695a021d3

[repro] Ant options: "-Dargs=-client -XX:+UseConcMarkSweepGC"
[repro] Repro line:  ant test  -Dtestcase=TestStressVersions 
-Dtests.method=testStressGetRealtimeVersions -Dtests.seed=6950307486962244 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=no-NO 
-Dtests.timezone=EAT -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1

[repro] ant clean

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

[...truncated 3298 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.TestStressVersions" -Dtests.showOutput=onerror "-Dargs=-client 
-XX:+UseConcMarkSweepGC" -Dtests.seed=6950307486962244 -Dtests.multiplier=3 
-Dtests.slow=true -Dtests.locale=no-NO -Dtests.timezone=EAT 
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1

[...truncated 71 lines...]
[repro] Failures:
[repro]   0/5 failed: org.apache.solr.search.TestStressVersions
[repro] Exiting with code 0

[...truncated 40 lines...]

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org