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

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

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

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=9153, name=WRITER7, state=RUNNABLE, 
group=TGRP-TestStressVersions]
        at 
__randomizedtesting.SeedInfo.seed([541FB31E5FCBB6E2:511BA22112B7B2BE]:0)
Caused by: java.lang.RuntimeException: java.lang.NullPointerException
        at __randomizedtesting.SeedInfo.seed([541FB31E5FCBB6E2]:0)
        at 
org.apache.solr.search.TestStressVersions$1.run(TestStressVersions.java:199)
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.updateDeleteTrackers(DirectUpdateHandler2.java:432)
        at 
org.apache.solr.update.DirectUpdateHandler2.delete(DirectUpdateHandler2.java:465)
        at 
org.apache.solr.update.processor.RunUpdateProcessor.processDelete(RunUpdateProcessorFactory.java:75)
        at 
org.apache.solr.update.processor.UpdateRequestProcessor.processDelete(UpdateRequestProcessor.java:59)
        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalDelete(DistributedUpdateProcessor.java:956)
        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.versionDelete(DistributedUpdateProcessor.java:1844)
        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.doDeleteById(DistributedUpdateProcessor.java:1381)
        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.processDelete(DistributedUpdateProcessor.java:1359)
        at 
org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.processDelete(LogUpdateProcessorFactory.java:124)
        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.handleDeleteMap(JsonLoader.java:394)
        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.handleDeleteCommand(JsonLoader.java:311)
        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.processUpdate(JsonLoader.java:171)
        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.load(JsonLoader.java:121)
        at org.apache.solr.handler.loader.JsonLoader.load(JsonLoader.java:84)
        at 
org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:97)
        at 
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:68)
        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199)
        at org.apache.solr.core.SolrCore.execute(SolrCore.java:2510)
        at 
org.apache.solr.servlet.DirectSolrConnection.request(DirectSolrConnection.java:125)
        at org.apache.solr.SolrTestCaseJ4.updateJ(SolrTestCaseJ4.java:1286)
        at 
org.apache.solr.SolrTestCaseJ4.deleteAndGetVersion(SolrTestCaseJ4.java:1464)
        at 
org.apache.solr.search.TestStressVersions$1.run(TestStressVersions.java:144)




Build Log:
[...truncated 13649 lines...]
   [junit4] Suite: org.apache.solr.search.TestStressVersions
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestStressVersions_541FB31E5FCBB6E2-001/init-core-data-001
   [junit4]   2> 1165240 INFO  
(SUITE-TestStressVersions-seed#[541FB31E5FCBB6E2]-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> 1165269 INFO  
(SUITE-TestStressVersions-seed#[541FB31E5FCBB6E2]-worker) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1165283 INFO  
(SUITE-TestStressVersions-seed#[541FB31E5FCBB6E2]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1165346 INFO  
(SUITE-TestStressVersions-seed#[541FB31E5FCBB6E2]-worker) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1165390 INFO  
(SUITE-TestStressVersions-seed#[541FB31E5FCBB6E2]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@10b1a7d
   [junit4]   2> 1165398 INFO  
(SUITE-TestStressVersions-seed#[541FB31E5FCBB6E2]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@10b1a7d
   [junit4]   2> 1165398 INFO  
(SUITE-TestStressVersions-seed#[541FB31E5FCBB6E2]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@10b1a7d
   [junit4]   2> 1165399 INFO  (coreLoadExecutor-3827-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1165400 INFO  (coreLoadExecutor-3827-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> 1165426 INFO  (coreLoadExecutor-3827-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1165440 INFO  (coreLoadExecutor-3827-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1165509 INFO  (coreLoadExecutor-3827-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1165517 INFO  (coreLoadExecutor-3827-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> 1165518 INFO  (coreLoadExecutor-3827-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@10b1a7d
   [junit4]   2> 1165518 INFO  (coreLoadExecutor-3827-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1165518 INFO  (coreLoadExecutor-3827-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_541FB31E5FCBB6E2-001/init-core-data-001/]
   [junit4]   2> 1165519 INFO  (coreLoadExecutor-3827-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=44, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=7.607421875, 
floorSegmentMB=0.9375, forceMergeDeletesPctAllowed=9.321231880172272, 
segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1165522 WARN  (coreLoadExecutor-3827-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> 1165558 INFO  (coreLoadExecutor-3827-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1165558 INFO  (coreLoadExecutor-3827-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1165559 INFO  (coreLoadExecutor-3827-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1165559 INFO  (coreLoadExecutor-3827-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1165560 INFO  (coreLoadExecutor-3827-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1165560 INFO  (coreLoadExecutor-3827-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@60655d[collection1] 
main]
   [junit4]   2> 1165561 WARN  (coreLoadExecutor-3827-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> 1165561 INFO  (coreLoadExecutor-3827-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1165562 INFO  
(searcherExecutor-3828-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@60655d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1165562 INFO  (coreLoadExecutor-3827-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1600468216421810176
   [junit4]   2> 1165568 INFO  
(TEST-TestStressVersions.testStressGetRealtimeVersions-seed#[541FB31E5FCBB6E2]) 
[    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM 
INDEX
   [junit4]   2> 1165568 INFO  
(TEST-TestStressVersions.testStressGetRealtimeVersions-seed#[541FB31E5FCBB6E2]) 
[    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@9cf8aa[collection1] realtime]
   [junit4]   2> 1165569 INFO  
(TEST-TestStressVersions.testStressGetRealtimeVersions-seed#[541FB31E5FCBB6E2]) 
[    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
 (-9223372036854775807)} 0 0
   [junit4]   2> 1165569 INFO  
(TEST-TestStressVersions.testStressGetRealtimeVersions-seed#[541FB31E5FCBB6E2]) 
[    ] o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1600468216429150208,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1165569 INFO  
(TEST-TestStressVersions.testStressGetRealtimeVersions-seed#[541FB31E5FCBB6E2]) 
[    ] o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@8bb575 
commitCommandVersion:1600468216429150208
   [junit4]   2> 1165570 INFO  
(TEST-TestStressVersions.testStressGetRealtimeVersions-seed#[541FB31E5FCBB6E2]) 
[    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@84d537[collection1] main]
   [junit4]   2> 1165570 INFO  
(TEST-TestStressVersions.testStressGetRealtimeVersions-seed#[541FB31E5FCBB6E2]) 
[    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1165572 INFO  (searcherExecutor-3828-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@84d537[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1165572 INFO  
(TEST-TestStressVersions.testStressGetRealtimeVersions-seed#[541FB31E5FCBB6E2]) 
[    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 2
   [junit4]   2> 1165577 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165577 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165577 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 
QTime=0
   [junit4]   2> 1165578 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165578 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> 1165578 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165578 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165578 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:1&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165578 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165578 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165578 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165578 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165578 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165578 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 
QTime=0
   [junit4]   2> 1165578 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165578 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=1
   [junit4]   2> 1165578 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165578 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165578 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=1
   [junit4]   2> 1165578 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165578 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165578 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165578 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 
QTime=0
   [junit4]   2> 1165578 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165578 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165578 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165577 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165577 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165578 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 
QTime=0
   [junit4]   2> 1165578 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165579 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165579 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=1
   [junit4]   2> 1165579 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> 1165579 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165579 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165579 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165579 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165579 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165578 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165578 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:1&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165579 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165579 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165579 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165579 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165579 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165579 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 
QTime=0
   [junit4]   2> 1165579 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165579 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 
QTime=0
   [junit4]   2> 1165579 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165579 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=1
   [junit4]   2> 1165579 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165579 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 
QTime=0
   [junit4]   2> 1165579 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165579 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165579 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:1&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165579 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 
QTime=0
   [junit4]   2> 1165579 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165579 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:0&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165579 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165579 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:1&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165580 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165580 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165580 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165580 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165580 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 
QTime=0
   [junit4]   2> 1165580 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 
QTime=0
   [junit4]   2> 1165580 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165580 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> 1165580 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165580 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:4&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165580 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:1&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165580 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165580 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165580 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165580 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:1&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165580 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 
QTime=0
   [junit4]   2> 1165580 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165580 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165580 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165580 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165580 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165580 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 
QTime=0
   [junit4]   2> 1165579 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165580 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:0&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165579 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165580 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165580 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165580 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:0&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165580 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 
QTime=0
   [junit4]   2> 1165580 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165580 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165581 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165581 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165581 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 
QTime=0
   [junit4]   2> 1165581 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 
QTime=0
   [junit4]   2> 1165581 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165581 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165581 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:1&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165581 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 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> 1165581 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 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> 1165581 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165582 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165582 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165582 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165582 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165582 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165582 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165582 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165582 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165582 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165582 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165582 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165579 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165582 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165582 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> 1165582 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165582 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165582 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165582 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165582 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> 1165582 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165582 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165583 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165583 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165583 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165583 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165583 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=4
   [junit4]   2> 1165583 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165583 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165583 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165583 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165583 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 
QTime=0
   [junit4]   2> 1165583 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165583 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165582 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:1&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165583 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165581 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165583 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 
QTime=0
   [junit4]   2> 1165583 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165583 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165583 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165583 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165583 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165583 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165583 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165583 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165583 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:2&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165583 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 
QTime=0
   [junit4]   2> 1165581 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165583 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165580 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165584 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165584 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165584 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> 1165584 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 
QTime=0
   [junit4]   2> 1165584 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165584 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165584 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:1&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165584 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165584 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165584 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 
QTime=0
   [junit4]   2> 1165584 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> 1165584 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165584 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165584 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:4&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165584 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> 1165584 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165580 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 
QTime=0
   [junit4]   2> 1165584 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165584 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165584 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165584 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165584 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165584 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165585 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165585 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165585 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165585 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165585 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165585 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165585 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165585 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165585 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 
QTime=0
   [junit4]   2> 1165585 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:0&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165585 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165585 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165585 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> 1165584 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165584 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165585 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165583 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165585 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 
QTime=0
   [junit4]   2> 1165585 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165585 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165585 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165585 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165585 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:1&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165585 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 
QTime=0
   [junit4]   2> 1165586 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165586 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> 1165586 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 
QTime=0
   [junit4]   2> 1165586 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 
QTime=0
   [junit4]   2> 1165586 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165586 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 
QTime=0
   [junit4]   2> 1165586 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:0&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165586 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165586 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:0&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165586 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:1&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165586 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165586 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165586 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165586 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165586 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> 1165586 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165586 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165586 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 
QTime=0
   [junit4]   2> 1165586 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 
QTime=0
   [junit4]   2> 1165583 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:0&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165586 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165586 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165582 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165586 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165586 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165587 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165587 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165587 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165587 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165587 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165587 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:1&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165587 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> 1165587 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165587 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165587 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165587 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165587 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165586 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165586 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165587 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165587 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165587 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165587 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165587 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165587 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> 1165587 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165587 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165585 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165587 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165587 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> 1165587 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165588 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165588 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165588 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> 1165588 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165588 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165588 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165588 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> 1165588 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165588 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165588 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165588 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165585 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:2&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165585 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> 1165588 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165588 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165588 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165588 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165588 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:0&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165588 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165588 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165588 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165588 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165588 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165589 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165589 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165589 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165589 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165589 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> 1165589 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165589 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> 1165589 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165589 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165589 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165589 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165589 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165589 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165589 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> 1165589 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165589 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165589 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165589 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165589 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165590 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165590 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165590 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165590 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165590 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165590 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165590 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165590 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165590 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165590 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165590 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165590 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165591 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165591 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165591 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165591 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165591 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> 1165591 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> 1165591 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165591 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> 1165591 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165591 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165591 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165591 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165591 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165592 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165592 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165592 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:0&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165592 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165592 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165592 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165592 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165592 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165592 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165593 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165593 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165593 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165593 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165589 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165589 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:0&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165588 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 
QTime=0
   [junit4]   2> 1165588 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165593 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165593 INFO  (READER0) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165593 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165593 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165593 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165593 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165593 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165593 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165593 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165593 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165594 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165594 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165594 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165594 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165594 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165594 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165594 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165594 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165594 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165594 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165594 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165594 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165594 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165594 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165594 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165594 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:0&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165594 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165595 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165595 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165595 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165595 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165595 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165595 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165595 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165595 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165595 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165595 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165595 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:0&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165595 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165595 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165595 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165595 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165595 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165595 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165588 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165588 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165587 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165596 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165596 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 
QTime=0
   [junit4]   2> 1165596 INFO  (READER3) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165596 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> 1165596 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165596 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165596 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:1&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165596 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165596 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165596 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165596 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 
QTime=0
   [junit4]   2> 1165596 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165596 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165596 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 
QTime=0
   [junit4]   2> 1165596 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165596 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> 1165596 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 
QTime=0
   [junit4]   2> 1165596 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165596 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165596 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165596 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 
QTime=0
   [junit4]   2> 1165596 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165596 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165596 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165596 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165596 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165596 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 
QTime=0
   [junit4]   2> 1165597 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165597 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165597 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165597 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165597 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165587 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165597 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165587 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165597 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165597 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 
QTime=0
   [junit4]   2> 1165597 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165597 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165597 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:4&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165597 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165597 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:0&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165597 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165597 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165597 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 
QTime=0
   [junit4]   2> 1165597 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165598 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165598 INFO  (READER10) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 
QTime=0
   [junit4]   2> 1165598 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165598 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165598 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165598 INFO  (READER14) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:1&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165598 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165598 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165598 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165598 INFO  (READER14) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165598 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> 1165598 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165598 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165598 INFO  (READER14) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 
QTime=0
   [junit4]   2> 1165598 INFO  (READER1) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165598 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165598 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
   [junit4]   2> 1165598 INFO  (READER14) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 
QTime=0
   [junit4]   2> 1165598 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> 1165598 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165598 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165598 INFO  (READER14) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:0&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165598 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165598 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165599 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
   [junit4]   2> 1165599 INFO  (READER14) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:0&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165599 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165599 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165599 INFO  (READER14) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 
QTime=0
   [junit4]   2> 1165599 INFO  (READER7) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165599 INFO  (READER14) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 
QTime=0
   [junit4]   2> 1165599 INFO  (READER2) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165597 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:1&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165597 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 
QTime=0
   [junit4]   2> 1165597 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165599 INFO  (READER14) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165599 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165599 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165599 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:4&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165599 INFO  (READER6) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165599 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 
QTime=0
   [junit4]   2> 1165599 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
   [junit4]   2> 1165599 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165596 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165600 INFO  (WRITER0) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{deleteByQuery=id:4 
(-1600468216436490240)} 0 23
   [junit4]   2> 1165600 INFO  (READER15) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 
QTime=0
   [junit4]   2> 1165600 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165593 INFO  (READER5) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
   [junit4]   2> 1165600 INFO  (READER11) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:1&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165593 INFO  (READER8) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:0&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165600 INFO  (READER15) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165600 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0 
QTime=0
   [junit4]   2> 1165593 INFO  (READER12) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 
QTime=0
   [junit4]   2> 1165600 INFO  (WRITER2) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{delete=[4 (-1600468216461656064)]} 0 
24
   [junit4]   2> 1165599 INFO  (READER9) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
   [junit4]   2> 1165599 INFO  (READER13) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 
QTime=0
   [junit4]   2> 1165600 INFO  (READER15) [    ] o.a.s.c.S.Request 
[collection1]  webapp=null path=null params={q=id:4&omitHeader=true&wt=json} 
hits=0 status=0 QTime=0
   [junit4]   2> 1165600 INFO  (READER4) [    ] o.a.s.c.S.Request [collection1] 
 webapp=null path=null params={qt=/get&ids

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

 [junit4]    >  at 
org.apache.solr.update.UpdateLog.getCurrentLogSizeFromStream(UpdateLog.java:299)
   [junit4]    >        at 
org.apache.solr.update.DirectUpdateHandler2.getCurrentTLogSize(DirectUpdateHandler2.java:1007)
   [junit4]    >        at 
org.apache.solr.update.DirectUpdateHandler2.updateDeleteTrackers(DirectUpdateHandler2.java:432)
   [junit4]    >        at 
org.apache.solr.update.DirectUpdateHandler2.delete(DirectUpdateHandler2.java:465)
   [junit4]    >        at 
org.apache.solr.update.processor.RunUpdateProcessor.processDelete(RunUpdateProcessorFactory.java:75)
   [junit4]    >        at 
org.apache.solr.update.processor.UpdateRequestProcessor.processDelete(UpdateRequestProcessor.java:59)
   [junit4]    >        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalDelete(DistributedUpdateProcessor.java:956)
   [junit4]    >        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.versionDelete(DistributedUpdateProcessor.java:1844)
   [junit4]    >        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.doDeleteById(DistributedUpdateProcessor.java:1381)
   [junit4]    >        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.processDelete(DistributedUpdateProcessor.java:1359)
   [junit4]    >        at 
org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.processDelete(LogUpdateProcessorFactory.java:124)
   [junit4]    >        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.handleDeleteMap(JsonLoader.java:394)
   [junit4]    >        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.handleDeleteCommand(JsonLoader.java:311)
   [junit4]    >        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.processUpdate(JsonLoader.java:171)
   [junit4]    >        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.load(JsonLoader.java:121)
   [junit4]    >        at 
org.apache.solr.handler.loader.JsonLoader.load(JsonLoader.java:84)
   [junit4]    >        at 
org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:97)
   [junit4]    >        at 
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:68)
   [junit4]    >        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199)
   [junit4]    >        at 
org.apache.solr.core.SolrCore.execute(SolrCore.java:2510)
   [junit4]    >        at 
org.apache.solr.servlet.DirectSolrConnection.request(DirectSolrConnection.java:125)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.updateJ(SolrTestCaseJ4.java:1286)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.deleteAndGetVersion(SolrTestCaseJ4.java:1464)
   [junit4]    >        at 
org.apache.solr.search.TestStressVersions$1.run(TestStressVersions.java:144)
   [junit4]   2> 1166668 INFO  
(SUITE-TestStressVersions-seed#[541FB31E5FCBB6E2]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=4517896
   [junit4]   2> 1166668 INFO  
(SUITE-TestStressVersions-seed#[541FB31E5FCBB6E2]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1166668 INFO  
(SUITE-TestStressVersions-seed#[541FB31E5FCBB6E2]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@e6fc0b: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@110d0e4
   [junit4]   2> 1166672 INFO  
(SUITE-TestStressVersions-seed#[541FB31E5FCBB6E2]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1166672 INFO  
(SUITE-TestStressVersions-seed#[541FB31E5FCBB6E2]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1fe2ce: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@a4ed5
   [junit4]   2> 1166674 INFO  
(SUITE-TestStressVersions-seed#[541FB31E5FCBB6E2]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1166674 INFO  
(SUITE-TestStressVersions-seed#[541FB31E5FCBB6E2]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@db9edb: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@1edaeb0
   [junit4]   2> 1166675 INFO  (coreCloseExecutor-3833-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@aaa7da
   [junit4]   2> 1166675 INFO  (coreCloseExecutor-3833-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=aaa7da
   [junit4]   2> 1166675 INFO  (coreCloseExecutor-3833-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1377752: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@150e144
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128)))},
 docValues:{val_l=DocValuesFormat(name=Lucene70), 
_version_=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=208, 
maxMBSortInHeap=6.244480401106971, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@7ff4fa),
 locale=ar-EG, timezone=ACT
   [junit4]   2> NOTE: Linux 4.13.0-39-generic i386/Oracle Corporation 
1.8.0_162 (32-bit)/cpus=8,threads=1,free=109968128,total=350224384
   [junit4]   2> NOTE: All tests run in this JVM: [ShardRoutingCustomTest, 
JavabinLoaderTest, SystemLogListenerTest, TestReversedWildcardFilterFactory, 
DistributedMLTComponentTest, SolrCoreTest, TestPerFieldSimilarity, 
UpdateRequestProcessorFactoryTest, SolrMetricsIntegrationTest, 
TestReloadAndDeleteDocs, SolrXmlInZkTest, TestFunctionQuery, 
DistributedQueryComponentCustomSortTest, AlternateDirectoryTest, 
TestAddFieldRealTimeGet, TestCoreBackup, SuggestComponentTest, 
LoggingHandlerTest, SubstringBytesRefFilterTest, HttpPartitionTest, 
TestRTimerTree, PrimitiveFieldTypeTest, TestSurroundQueryParser, 
TestConfigSets, SolrJmxReporterCloudTest, TestRetrieveFieldsOptimizer, 
DistributedFacetPivotSmallAdvancedTest, TestBM25SimilarityFactory, 
PKIAuthenticationIntegrationTest, TestClassicSimilarityFactory, 
TestReqParamsAPI, BlockJoinFacetSimpleTest, SampleTest, DocumentBuilderTest, 
TestDynamicFieldResource, TestRuleBasedAuthorizationPlugin, TestStreamBody, 
TestImpersonationWithHadoopAuth, TestGenericDistributedQueue, 
TestPostingsSolrHighlighter, SchemaVersionSpecificBehaviorTest, 
TestPullReplica, ScriptEngineTest, TestCloudManagedSchema, TestCollectionAPIs, 
RestoreTriggerStateTest, MaxSizeAutoCommitTest, SortByFunctionTest, 
IndexSchemaTest, TestSearchPerf, AutoAddReplicasIntegrationTest, 
TestNumericTerms64, TestReload, TestFieldCacheSort, TestSystemCollAutoCreate, 
TestRandomRequestDistribution, TestFieldCacheWithThreads, 
SharedFSAutoReplicaFailoverTest, TestUseDocValuesAsStored2, 
ComputePlanActionTest, JsonLoaderTest, TestLuceneIndexBackCompat, 
NumberUtilsTest, NodeLostTriggerIntegrationTest, 
TestManagedSynonymFilterFactory, TestSolrJ, ZkStateReaderTest, 
CollectionReloadTest, TestBinaryResponseWriter, 
CollectionsAPIDistributedZkTest, SolrInfoBeanTest, TestCollectionAPI, 
TermsComponentTest, TestConfigOverlay, TestComplexPhraseQParserPlugin, 
FastVectorHighlighterTest, DistribCursorPagingTest, 
CurrencyRangeFacetCloudTest, BasicZkTest, HighlighterTest, 
FieldMutatingUpdateProcessorTest, HLLUtilTest, 
TestSerializedLuceneMatchVersion, TestLocalFSCloudBackupRestore, 
SoftAutoCommitTest, HdfsBasicDistributedZk2Test, TestTriggerIntegration, 
TestComputePlanAction, TestFieldTypeCollectionResource, OverseerStatusTest, 
OverseerTest, ChaosMonkeySafeLeaderTest, TestQueryUtils, 
TestConfigSetsAPIExclusivity, TestXIncludeConfig, DirectSolrConnectionTest, 
TestSSLRandomization, TlogReplayBufferedWhileIndexingTest, 
SolrCoreMetricManagerTest, TestFoldingMultitermQuery, 
DocExpirationUpdateProcessorFactoryTest, SuggesterTest, TestDistribIDF, 
QueryElevationComponentTest, TestCloudPivotFacet, FacetPivotSmallTest, 
CdcrRequestHandlerTest, TestLegacyNumericUtils, ZkFailoverTest, 
TestInfoStreamLogging, TestManagedResource, AnalysisErrorHandlingTest, 
SpellCheckCollatorWithCollapseTest, CoreSorterTest, ZkControllerTest, 
SystemInfoHandlerTest, HdfsDirectoryTest, TestGeoJSONResponseWriter, 
XsltUpdateRequestHandlerTest, ExplicitHLLTest, TestInitQParser, 
TestStressRecovery, TestStressVersions]
   [junit4] Completed [348/806 (1!)] on J1 in 1.46s, 1 test, 1 error <<< 
FAILURES!

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

[repro] Revision: 02849fb707626cf4312f59324fd894be117787c1

[repro] Ant options: "-Dargs=-client -XX:+UseParallelGC"
[repro] Repro line:  ant test  -Dtestcase=TestStressVersions 
-Dtests.method=testStressGetRealtimeVersions -Dtests.seed=541FB31E5FCBB6E2 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar-EG 
-Dtests.timezone=ACT -Dtests.asserts=true -Dtests.file.encoding=UTF-8

[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:+UseParallelGC" -Dtests.seed=541FB31E5FCBB6E2 -Dtests.multiplier=3 
-Dtests.slow=true -Dtests.locale=ar-EG -Dtests.timezone=ACT 
-Dtests.asserts=true -Dtests.file.encoding=UTF-8

[...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: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to