[JENKINS] Lucene-Solr-master-Linux (64bit/jdk-10.0.1) - Build # 22361 - Unstable!

[Policeman Jenkins Server]

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/22361/
Java: 64bit/jdk-10.0.1 -XX:-UseCompressedOops -XX:+UseG1GC

1 tests failed.
FAILED:  org.apache.solr.search.TestRecovery.testExistOldBufferLog

Error Message:


Stack Trace:
java.lang.AssertionError
        at 
__randomizedtesting.SeedInfo.seed([74265E35EF1555CB:2A76436061DAC542]:0)
        at org.junit.Assert.fail(Assert.java:92)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertFalse(Assert.java:68)
        at org.junit.Assert.assertFalse(Assert.java:79)
        at 
org.apache.solr.search.TestRecovery.testExistOldBufferLog(TestRecovery.java:1071)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:844)




Build Log:
[...truncated 15112 lines...]
   [junit4] Suite: org.apache.solr.search.TestRecovery
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestRecovery_74265E35EF1555CB-001/init-core-data-001
   [junit4]   2> 1857273 WARN  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    ] o.a.s.SolrTestCaseJ4 
startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 1857274 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    ] o.a.s.SolrTestCaseJ4 
Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1857275 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    ] o.a.s.SolrTestCaseJ4 
Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 1857276 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    ] o.a.s.SolrTestCaseJ4 
SecureRandom sanity checks: test.solr.allowed.securerandom=null & 
java.security.egd=file:/dev/./urandom
   [junit4]   2> 1857276 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    ] o.a.s.SolrTestCaseJ4 
updateLog impl=solr.CdcrUpdateLog
   [junit4]   2> 1857276 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    ] o.a.s.SolrTestCaseJ4 
####initCore
   [junit4]   2> 1857276 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-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> 1857294 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1857305 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    ] o.a.s.s.IndexSchema 
[null] Schema name=test
   [junit4]   2> 1857408 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1857721 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1857721 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 1857733 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@609db546
   [junit4]   2> 1857741 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@609db546
   [junit4]   2> 1857741 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@609db546
   [junit4]   2> 1857774 INFO  (coreLoadExecutor-10589-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> 1857791 INFO  (coreLoadExecutor-10589-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1857801 INFO  (coreLoadExecutor-10589-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1857864 INFO  (coreLoadExecutor-10589-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1857871 INFO  (coreLoadExecutor-10589-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> 1857872 INFO  (coreLoadExecutor-10589-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@609db546
   [junit4]   2> 1857872 INFO  (coreLoadExecutor-10589-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1857872 INFO  (coreLoadExecutor-10589-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/J0/temp/solr.search.TestRecovery_74265E35EF1555CB-001/init-core-data-001/]
   [junit4]   2> 1857874 INFO  (coreLoadExecutor-10589-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=38, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1858006 WARN  (coreLoadExecutor-10589-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> 1858251 INFO  (coreLoadExecutor-10589-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.CdcrUpdateLog
   [junit4]   2> 1858252 INFO  (coreLoadExecutor-10589-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1858253 INFO  (coreLoadExecutor-10589-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1858253 INFO  (coreLoadExecutor-10589-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1858255 INFO  (coreLoadExecutor-10589-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@2b11678b
   [junit4]   2> 1858258 INFO  (coreLoadExecutor-10589-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1258d64f[collection1] main]
   [junit4]   2> 1858258 WARN  (coreLoadExecutor-10589-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> 1858258 INFO  (coreLoadExecutor-10589-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1858259 INFO  
(searcherExecutor-10590-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1258d64f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1858259 INFO  (coreLoadExecutor-10589-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1604779643010809856
   [junit4]   2> 1858263 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    ] o.a.s.SolrTestCaseJ4 
####initCore end
   [junit4]   2> 1858265 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testTruncatedLog
   [junit4]   2> 1858266 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1858267 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@5cb19a8c[collection1] realtime]
   [junit4]   2> 1858267 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
 (-9223372036854775807)} 0 1
   [junit4]   2> 1858268 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604779643020247040,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1858268 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@52894b8c 
commitCommandVersion:1604779643020247040
   [junit4]   2> 1858292 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@27c77687[collection1] main]
   [junit4]   2> 1858292 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1858293 INFO  (searcherExecutor-10590-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@27c77687[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1858293 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 25
   [junit4]   2> 1858296 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[F1 (1604779643047510016)]} 0 1
   [junit4]   2> 1858296 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[F2 (1604779643049607168)]} 0 0
   [junit4]   2> 1858296 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[F3 (1604779643049607169)]} 0 0
   [junit4]   2> 1858297 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1254249208
   [junit4]   2> 1858297 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1858297 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@21680f9e: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@78d391c2
   [junit4]   2> 1858302 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1858302 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2c4c3dad: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@6235d05c
   [junit4]   2> 1858304 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1858304 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7ec10146: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@5f5b6972
   [junit4]   2> 1858307 INFO  (coreCloseExecutor-10595-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@54567b2f
   [junit4]   2> 1858315 INFO  (coreCloseExecutor-10595-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=54567b2f
   [junit4]   2> 1858315 INFO  (coreCloseExecutor-10595-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@4167b279: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@dd0b55b
   [junit4]   2> 1858330 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
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> 1858355 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1858367 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1858471 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1858664 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1858664 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 1858732 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@609db546
   [junit4]   2> 1858738 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@609db546
   [junit4]   2> 1858738 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@609db546
   [junit4]   2> 1858751 INFO  (coreLoadExecutor-10605-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> 1858817 INFO  (coreLoadExecutor-10605-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1858825 INFO  (coreLoadExecutor-10605-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1858899 INFO  (coreLoadExecutor-10605-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1858904 INFO  (coreLoadExecutor-10605-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> 1858904 INFO  (coreLoadExecutor-10605-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@609db546
   [junit4]   2> 1858904 INFO  (coreLoadExecutor-10605-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1858904 INFO  (coreLoadExecutor-10605-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/J0/temp/solr.search.TestRecovery_74265E35EF1555CB-001/init-core-data-001/]
   [junit4]   2> 1858906 WARN  (coreLoadExecutor-10605-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> 1858932 INFO  (coreLoadExecutor-10605-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.CdcrUpdateLog
   [junit4]   2> 1858932 INFO  (coreLoadExecutor-10605-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1859002 INFO  (coreLoadExecutor-10605-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1859002 INFO  (coreLoadExecutor-10605-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1859009 INFO  (coreLoadExecutor-10605-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=38, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1859012 INFO  (coreLoadExecutor-10605-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@72731d2a[collection1] main]
   [junit4]   2> 1859013 WARN  (coreLoadExecutor-10605-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> 1859013 INFO  (coreLoadExecutor-10605-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1859014 INFO  
(searcherExecutor-10606-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@72731d2a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1859014 INFO  (coreLoadExecutor-10605-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1604779643802484736
   [junit4]   2> 1859016 WARN  
(recoveryExecutor-10608-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.UpdateLog Starting log replay 
tlog{file=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestRecovery_74265E35EF1555CB-001/init-core-data-001/tlog/tlog.0000000000000000001.1604779643047510016
 refcount=1} active=false starting pos=0 inSortedOrder=false
   [junit4]   2> 1859021 INFO  
(recoveryExecutor-10608-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.UpdateLog Ignoring exception matching OutOfBoundsException
   [junit4]   2> 1859523 INFO  
(recoveryExecutor-10608-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{flags=2,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1859523 INFO  
(recoveryExecutor-10608-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@40f697e0 commitCommandVersion:0
   [junit4]   2> 1859583 INFO  
(recoveryExecutor-10608-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@41d73a2[collection1] main]
   [junit4]   2> 1859583 INFO  
(recoveryExecutor-10608-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1859584 INFO  
(searcherExecutor-10606-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@41d73a2[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c3)))}
   [junit4]   2> 1859585 INFO  
(recoveryExecutor-10608-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[F1 
(1604779643047510016), F2 (1604779643049607168), F3 (1604779643049607169)]} 0 
568
   [junit4]   2> 1859585 WARN  
(recoveryExecutor-10608-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=3 
deletes=0 deleteByQuery=0 errors=0 positionOfStart=0}
   [junit4]   2> 1859585 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=*:*&wt=xml} 
hits=3 status=0 QTime=0
   [junit4]   2> 1859587 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[F4]} 0 1
   [junit4]   2> 1859587 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[F5 (1)]} 0 0
   [junit4]   2> 1859587 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[F6 (2)]} 0 0
   [junit4]   2> 1859588 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=3&wt=xml} status=0 QTime=0
   [junit4]   2> 1859588 INFO  
(TEST-TestRecovery.testTruncatedLog-seed#[74265E35EF1555CB]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testTruncatedLog
   [junit4]   2> 1859590 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testRemoveOldLogs
   [junit4]   2> 1859591 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1859591 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@74d93995[collection1] realtime]
   [junit4]   2> 1859612 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
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 21
   [junit4]   2> 1859612 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604779644429533184,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1859612 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@40f697e0 
commitCommandVersion:1604779644429533184
   [junit4]   2> 1859633 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@76eedb38[collection1] main]
   [junit4]   2> 1859633 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1859635 INFO  (searcherExecutor-10606-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@76eedb38[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1859635 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 23
   [junit4]   2> 1859636 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=2093393963
   [junit4]   2> 1859636 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1859636 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@274e214f: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@660de3e3
   [junit4]   2> 1859642 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1859642 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@39253152: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@6235d05c
   [junit4]   2> 1859645 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1859645 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7f89ba85: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@5f5b6972
   [junit4]   2> 1859669 INFO  (coreCloseExecutor-10611-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@65202403
   [junit4]   2> 1859669 INFO  (coreCloseExecutor-10611-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=65202403
   [junit4]   2> 1859669 INFO  (coreCloseExecutor-10611-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3ae9059f: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@6adae59
   [junit4]   2> 1859681 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
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> 1859695 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1859703 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1859768 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1860114 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1860114 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 1860129 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@609db546
   [junit4]   2> 1860137 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@609db546
   [junit4]   2> 1860138 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@609db546
   [junit4]   2> 1860139 INFO  (coreLoadExecutor-10621-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> 1860200 INFO  (coreLoadExecutor-10621-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1860207 INFO  (coreLoadExecutor-10621-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1860288 INFO  (coreLoadExecutor-10621-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1860293 INFO  (coreLoadExecutor-10621-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> 1860293 INFO  (coreLoadExecutor-10621-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@609db546
   [junit4]   2> 1860293 INFO  (coreLoadExecutor-10621-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1860293 INFO  (coreLoadExecutor-10621-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/J0/temp/solr.search.TestRecovery_74265E35EF1555CB-001/init-core-data-001/]
   [junit4]   2> 1860297 WARN  (coreLoadExecutor-10621-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> 1860355 INFO  (coreLoadExecutor-10621-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.CdcrUpdateLog
   [junit4]   2> 1860355 INFO  (coreLoadExecutor-10621-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1860373 INFO  (coreLoadExecutor-10621-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1860373 INFO  (coreLoadExecutor-10621-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1860374 INFO  (coreLoadExecutor-10621-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=38, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1860374 INFO  (coreLoadExecutor-10621-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@3e15e1c4[collection1] main]
   [junit4]   2> 1860375 WARN  (coreLoadExecutor-10621-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> 1860397 INFO  (coreLoadExecutor-10621-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1860397 INFO  
(searcherExecutor-10622-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3e15e1c4[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1860398 INFO  (coreLoadExecutor-10621-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1604779645253713920
   [junit4]   2> 1860401 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[3 (1604779645255811072)]} 0 1
   [junit4]   2> 1860401 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[3 (1604779645256859648)]} 0 0
   [junit4]   2> 1860402 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[3 (1604779645257908224)]} 0 0
   [junit4]   2> 1860402 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1860402 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604779645257908225,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1860402 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@29ff96d8 
commitCommandVersion:1604779645257908225
   [junit4]   2> 1860576 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@36b3c393[collection1] main]
   [junit4]   2> 1860578 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1860578 INFO  (searcherExecutor-10622-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@36b3c393[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.0.0):c3/2:delGen=1)))}
   [junit4]   2> 1860578 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 176
   [junit4]   2> 1860579 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1860580 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[6 (1604779645443506176)]} 0 1
   [junit4]   2> 1860580 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[6 (1604779645444554752)]} 0 0
   [junit4]   2> 1860581 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[6 (1604779645445603328)]} 0 0
   [junit4]   2> 1860581 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1860581 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604779645445603329,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1860581 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@29ff96d8 
commitCommandVersion:1604779645445603329
   [junit4]   2> 1860707 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@52cf1a89[collection1] main]
   [junit4]   2> 1860711 INFO  (searcherExecutor-10622-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@52cf1a89[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.0.0):c3/2:delGen=1)
 Uninverting(_3(8.0.0):c3/2:delGen=1)))}
   [junit4]   2> 1860711 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1860711 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 130
   [junit4]   2> 1860712 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1860713 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[9 (1604779645582966784)]} 0 0
   [junit4]   2> 1860713 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[9 (1604779645584015360)]} 0 0
   [junit4]   2> 1860713 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[9 (1604779645584015361)]} 0 0
   [junit4]   2> 1860714 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1860714 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604779645585063936,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1860714 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@29ff96d8 
commitCommandVersion:1604779645585063936
   [junit4]   2> 1860794 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@213f06f[collection1] main]
   [junit4]   2> 1860795 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1860796 INFO  (searcherExecutor-10622-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@213f06f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.0.0):c3/2:delGen=1)
 Uninverting(_3(8.0.0):c3/2:delGen=1) Uninverting(_4(8.0.0):c3/2:delGen=1)))}
   [junit4]   2> 1860796 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 82
   [junit4]   2> 1860797 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1860798 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[12 (1604779645672095744)]} 0 1
   [junit4]   2> 1860798 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[12 (1604779645673144320)]} 0 0
   [junit4]   2> 1860799 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[12 (1604779645673144321)]} 0 0
   [junit4]   2> 1860799 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1860799 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604779645674192896,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1860799 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@29ff96d8 
commitCommandVersion:1604779645674192896
   [junit4]   2> 1860894 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3c5850fd[collection1] main]
   [junit4]   2> 1860894 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1860895 INFO  (searcherExecutor-10622-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3c5850fd[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.0.0):c3/2:delGen=1)
 Uninverting(_3(8.0.0):c3/2:delGen=1) Uninverting(_4(8.0.0):c3/2:delGen=1) 
Uninverting(_5(8.0.0):c3/2:delGen=1)))}
   [junit4]   2> 1860895 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 96
   [junit4]   2> 1860896 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1860897 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[15 (1604779645775904768)]} 0 0
   [junit4]   2> 1860897 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[15 (1604779645776953344)]} 0 0
   [junit4]   2> 1860898 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[15 (1604779645778001920)]} 0 0
   [junit4]   2> 1860898 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1860898 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604779645778001921,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1860898 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@29ff96d8 
commitCommandVersion:1604779645778001921
   [junit4]   2> 1860958 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2815f474[collection1] main]
   [junit4]   2> 1860959 INFO  (searcherExecutor-10622-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2815f474[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.0.0):c3/2:delGen=1)
 Uninverting(_3(8.0.0):c3/2:delGen=1) Uninverting(_4(8.0.0):c3/2:delGen=1) 
Uninverting(_5(8.0.0):c3/2:delGen=1) Uninverting(_6(8.0.0):c3/2:delGen=1)))}
   [junit4]   2> 1860960 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1860960 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 61
   [junit4]   2> 1860960 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1860962 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[18 (1604779645844062208)]} 0 1
   [junit4]   2> 1860962 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[18 (1604779645845110784)]} 0 0
   [junit4]   2> 1860962 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[18 (1604779645845110785)]} 0 0
   [junit4]   2> 1860963 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1860963 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604779645846159360,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1860963 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@29ff96d8 
commitCommandVersion:1604779645846159360
   [junit4]   2> 1861030 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@23f443b9[collection1] main]
   [junit4]   2> 1861030 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1861032 INFO  (searcherExecutor-10622-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@23f443b9[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.0.0):c3/2:delGen=1)
 Uninverting(_3(8.0.0):c3/2:delGen=1) Uninverting(_4(8.0.0):c3/2:delGen=1) 
Uninverting(_5(8.0.0):c3/2:delGen=1) Uninverting(_6(8.0.0):c3/2:delGen=1) 
Uninverting(_7(8.0.0):c3/2:delGen=1)))}
   [junit4]   2> 1861032 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 69
   [junit4]   2> 1861033 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1861040 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[21 (1604779645920608256)]} 0 6
   [junit4]   2> 1861040 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[21 (1604779645926899712)]} 0 0
   [junit4]   2> 1861040 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[21 (1604779645926899713)]} 0 0
   [junit4]   2> 1861041 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1861041 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604779645927948288,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1861041 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@29ff96d8 
commitCommandVersion:1604779645927948288
   [junit4]   2> 1861140 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@651598d3[collection1] main]
   [junit4]   2> 1861141 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1861142 INFO  (searcherExecutor-10622-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@651598d3[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.0.0):c3/2:delGen=1)
 Uninverting(_3(8.0.0):c3/2:delGen=1) Uninverting(_4(8.0.0):c3/2:delGen=1) 
Uninverting(_5(8.0.0):c3/2:delGen=1) Uninverting(_6(8.0.0):c3/2:delGen=1) 
Uninverting(_7(8.0.0):c3/2:delGen=1) Uninverting(_8(8.0.0):c3/2:delGen=1)))}
   [junit4]   2> 1861142 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 101
   [junit4]   2> 1861143 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1861144 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[24 (1604779646034903040)]} 0 0
   [junit4]   2> 1861144 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[24 (1604779646035951616)]} 0 0
   [junit4]   2> 1861144 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[24 (1604779646035951617)]} 0 0
   [junit4]   2> 1861144 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1861144 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604779646035951618,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1861144 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@29ff96d8 
commitCommandVersion:1604779646035951618
   [junit4]   2> 1861224 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@20961877[collection1] main]
   [junit4]   2> 1861224 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1861225 INFO  (searcherExecutor-10622-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@20961877[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.0.0):c3/2:delGen=1)
 Uninverting(_3(8.0.0):c3/2:delGen=1) Uninverting(_4(8.0.0):c3/2:delGen=1) 
Uninverting(_5(8.0.0):c3/2:delGen=1) Uninverting(_6(8.0.0):c3/2:delGen=1) 
Uninverting(_7(8.0.0):c3/2:delGen=1) Uninverting(_8(8.0.0):c3/2:delGen=1) 
Uninverting(_9(8.0.0):c3/2:delGen=1)))}
   [junit4]   2> 1861226 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 81
   [junit4]   2> 1861226 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1861227 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[27 (1604779646122983424)]} 0 0
   [junit4]   2> 1861228 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[27 (1604779646122983425)]} 0 0
   [junit4]   2> 1861228 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[27 (1604779646124032000)]} 0 0
   [junit4]   2> 1861228 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1861228 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604779646124032001,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1861228 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@29ff96d8 
commitCommandVersion:1604779646124032001
   [junit4]   2> 1861307 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@ca185c4[collection1] main]
   [junit4]   2> 1861307 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1861308 INFO  (searcherExecutor-10622-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@ca185c4[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.0.0):c3/2:delGen=1)
 Uninverting(_3(8.0.0):c3/2:delGen=1) Uninverting(_4(8.0.0):c3/2:delGen=1) 
Uninverting(_5(8.0.0):c3/2:delGen=1) Uninverting(_6(8.0.0):c3/2:delGen=1) 
Uninverting(_7(8.0.0):c3/2:delGen=1) Uninverting(_8(8.0.0):c3/2:delGen=1) 
Uninverting(_9(8.0.0):c3/2:delGen=1) Uninverting(_a(8.0.0):c3/2:delGen=1)))}
   [junit4]   2> 1861308 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 80
   [junit4]   2> 1861309 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1861310 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[30 (1604779646208966656)]} 0 0
   [junit4]   2> 1861310 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[30 (1604779646210015232)]} 0 0
   [junit4]   2> 1861311 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[30 (1604779646211063808)]} 0 0
   [junit4]   2> 1861311 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1861311 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604779646211063809,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1861311 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@29ff96d8 
commitCommandVersion:1604779646211063809
   [junit4]   2> 1861406 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1ae9fa9f[collection1] main]
   [junit4]   2> 1861406 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1861408 INFO  (searcherExecutor-10622-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1ae9fa9f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.0.0):c3/2:delGen=1)
 Uninverting(_3(8.0.0):c3/2:delGen=1) Uninverting(_4(8.0.0):c3/2:delGen=1) 
Uninverting(_5(8.0.0):c3/2:delGen=1) Uninverting(_6(8.0.0):c3/2:delGen=1) 
Uninverting(_7(8.0.0):c3/2:delGen=1) Uninverting(_8(8.0.0):c3/2:delGen=1) 
Uninverting(_9(8.0.0):c3/2:delGen=1) Uninverting(_a(8.0.0):c3/2:delGen=1) 
Uninverting(_b(8.0.0):c3/2:delGen=1)))}
   [junit4]   2> 1861408 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 96
   [junit4]   2> 1861409 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1861410 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[33 (1604779646313824256)]} 0 0
   [junit4]   2> 1861410 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[33 (1604779646314872832)]} 0 0
   [junit4]   2> 1861410 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[33 (1604779646314872833)]} 0 0
   [junit4]   2> 1861411 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1861411 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604779646315921408,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1861411 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@29ff96d8 
commitCommandVersion:1604779646315921408
   [junit4]   2> 1861507 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@7a291a95[collection1] main]
   [junit4]   2> 1861517 INFO  (searcherExecutor-10622-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@7a291a95[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.0.0):c3/2:delGen=1)
 Uninverting(_3(8.0.0):c3/2:delGen=1) Uninverting(_4(8.0.0):c3/2:delGen=1) 
Uninverting(_5(8.0.0):c3/2:delGen=1) Uninverting(_6(8.0.0):c3/2:delGen=1) 
Uninverting(_7(8.0.0):c3/2:delGen=1) Uninverting(_8(8.0.0):c3/2:delGen=1) 
Uninverting(_9(8.0.0):c3/2:delGen=1) Uninverting(_a(8.0.0):c3/2:delGen=1) 
Uninverting(_b(8.0.0):c3/2:delGen=1) Uninverting(_c(8.0.0):c3/2:delGen=1)))}
   [junit4]   2> 1861517 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1861517 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 106
   [junit4]   2> 1861518 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1861528 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[36 (1604779646428119040)]} 0 9
   [junit4]   2> 1861528 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[36 (1604779646438604800)]} 0 0
   [junit4]   2> 1861528 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[36 (1604779646438604801)]} 0 0
   [junit4]   2> 1861529 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1861529 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604779646439653376,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1861529 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@29ff96d8 
commitCommandVersion:1604779646439653376
   [junit4]   2> 1861629 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@5529dcf[collection1] main]
   [junit4]   2> 1861629 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1861631 INFO  (searcherExecutor-10622-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@5529dcf[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.0.0):c3/2:delGen=1)
 Uninverting(_3(8.0.0):c3/2:delGen=1) Uninverting(_4(8.0.0):c3/2:delGen=1) 
Uninverting(_5(8.0.0):c3/2:delGen=1) Uninverting(_6(8.0.0):c3/2:delGen=1) 
Uninverting(_7(8.0.0):c3/2:delGen=1) Uninverting(_8(8.0.0):c3/2:delGen=1) 
Uninverting(_9(8.0.0):c3/2:delGen=1) Uninverting(_a(8.0.0):c3/2:delGen=1) 
Uninverting(_b(8.0.0):c3/2:delGen=1) Uninverting(_c(8.0.0):c3/2:delGen=1) 
Uninverting(_d(8.0.0):c3/2:delGen=1)))}
   [junit4]   2> 1861631 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 102
   [junit4]   2> 1861632 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
   [junit4]   2> 1861633 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646547656704)]} 0 0
   [junit4]   2> 1861633 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646548705280)]} 0 0
   [junit4]   2> 1861633 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646548705281)]} 0 0
   [junit4]   2> 1861633 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646548705282)]} 0 0
   [junit4]   2> 1861633 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646548705283)]} 0 0
   [junit4]   2> 1861633 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646548705284)]} 0 0
   [junit4]   2> 1861633 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646548705285)]} 0 0
   [junit4]   2> 1861634 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646549753856)]} 0 0
   [junit4]   2> 1861634 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646549753857)]} 0 0
   [junit4]   2> 1861634 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646549753858)]} 0 0
   [junit4]   2> 1861634 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646549753859)]} 0 0
   [junit4]   2> 1861634 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646549753860)]} 0 0
   [junit4]   2> 1861634 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646549753861)]} 0 0
   [junit4]   2> 1861634 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646549753862)]} 0 0
   [junit4]   2> 1861634 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646549753863)]} 0 0
   [junit4]   2> 1861634 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646549753864)]} 0 0
   [junit4]   2> 1861634 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646549753865)]} 0 0
   [junit4]   2> 1861634 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646549753866)]} 0 0
   [junit4]   2> 1861634 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646549753867)]} 0 0
   [junit4]   2> 1861634 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646549753868)]} 0 0
   [junit4]   2> 1861634 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646549753869)]} 0 0
   [junit4]   2> 1861634 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646549753870)]} 0 0
   [junit4]   2> 1861635 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646549753871)]} 0 0
   [junit4]   2> 1861635 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646550802432)]} 0 0
   [junit4]   2> 1861635 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646550802433)]} 0 0
   [junit4]   2> 1861635 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646550802434)]} 0 0
   [junit4]   2> 1861635 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646550802435)]} 0 0
   [junit4]   2> 1861635 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646550802436)]} 0 0
   [junit4]   2> 1861635 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646550802437)]} 0 0
   [junit4]   2> 1861635 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646550802438)]} 0 0
   [junit4]   2> 1861635 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646550802439)]} 0 0
   [junit4]   2> 1861635 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646550802440)]} 0 0
   [junit4]   2> 1861635 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646550802441)]} 0 0
   [junit4]   2> 1861635 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646550802442)]} 0 0
   [junit4]   2> 1861635 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646550802443)]} 0 0
   [junit4]   2> 1861635 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646550802444)]} 0 0
   [junit4]   2> 1861636 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646551851008)]} 0 0
   [junit4]   2> 1861636 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646551851009)]} 0 0
   [junit4]   2> 1861636 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646551851010)]} 0 0
   [junit4]   2> 1861636 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646551851011)]} 0 0
   [junit4]   2> 1861636 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646551851012)]} 0 0
   [junit4]   2> 1861636 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646551851013)]} 0 0
   [junit4]   2> 1861636 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646551851014)]} 0 0
   [junit4]   2> 1861636 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646551851015)]} 0 0
   [junit4]   2> 1861636 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646551851016)]} 0 0
   [junit4]   2> 1861636 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646551851017)]} 0 0
   [junit4]   2> 1861636 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646551851018)]} 0 0
   [junit4]   2> 1861636 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646551851019)]} 0 0
   [junit4]   2> 1861636 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646551851020)]} 0 0
   [junit4]   2> 1861636 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646551851021)]} 0 0
   [junit4]   2> 1861636 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646551851022)]} 0 0
   [junit4]   2> 1861637 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646552899584)]} 0 0
   [junit4]   2> 1861637 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646552899585)]} 0 0
   [junit4]   2> 1861637 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646552899586)]} 0 0
   [junit4]   2> 1861637 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646552899587)]} 0 0
   [junit4]   2> 1861637 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646552899588)]} 0 0
   [junit4]   2> 1861637 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646552899589)]} 0 0
   [junit4]   2> 1861637 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646552899590)]} 0 0
   [junit4]   2> 1861637 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646552899591)]} 0 0
   [junit4]   2> 1861637 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646552899592)]} 0 0
   [junit4]   2> 1861637 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646552899593)]} 0 0
   [junit4]   2> 1861637 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646552899594)]} 0 0
   [junit4]   2> 1861637 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646552899595)]} 0 0
   [junit4]   2> 1861638 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646552899596)]} 0 0
   [junit4]   2> 1861638 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646553948160)]} 0 0
   [junit4]   2> 1861638 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646553948161)]} 0 0
   [junit4]   2> 1861638 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646553948162)]} 0 0
   [junit4]   2> 1861638 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646553948163)]} 0 0
   [junit4]   2> 1861638 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646553948164)]} 0 0
   [junit4]   2> 1861638 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646553948165)]} 0 0
   [junit4]   2> 1861638 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646553948166)]} 0 0
   [junit4]   2> 1861638 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646553948167)]} 0 0
   [junit4]   2> 1861638 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646553948168)]} 0 0
   [junit4]   2> 1861638 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646553948169)]} 0 0
   [junit4]   2> 1861638 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646553948170)]} 0 0
   [junit4]   2> 1861638 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646553948171)]} 0 0
   [junit4]   2> 1861638 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646553948172)]} 0 0
   [junit4]   2> 1861638 INFO  
(TEST-TestRecovery.testRemoveOldLogs-seed#[74265E35EF1555CB]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[156 (1604779646553948173)]} 0 0
   [junit4]   2> 1861638 INFO  (TEST-TestRecovery.testRem

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

  [junit4]   2> 1897243 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    x:collection1] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2761c275: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@76563963
   [junit4]   2> 1897245 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1897245 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    x:collection1] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7d26bc5f: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@6235d05c
   [junit4]   2> 1897247 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1897247 INFO  
(SUITE-TestRecovery-seed#[74265E35EF1555CB]-worker) [    x:collection1] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1670289a: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@5f5b6972
   [junit4]   2> 1897247 INFO  
(coreCloseExecutor-10999-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@404df51c
   [junit4]   2> 1897247 INFO  
(coreCloseExecutor-10999-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=404df51c
   [junit4]   2> 1897247 INFO  
(coreCloseExecutor-10999-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@752322f5: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@255a61c5
   [junit4]   2> 1897255 INFO  
(coreCloseExecutor-10999-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
   [junit4]   2> 1897255 INFO  
(coreCloseExecutor-10999-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@296e2b2b commitCommandVersion:0
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestRecovery_74265E35EF1555CB-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{_root_=FST50, id=PostingsFormat(name=LuceneVarGapFixedInterval)}, 
docValues:{_version_=DocValuesFormat(name=Direct), 
val_i_dvo=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=253, 
maxMBSortInHeap=6.543434783740921, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@75281b65),
 locale=nn, timezone=America/Blanc-Sablon
   [junit4]   2> NOTE: Linux 4.13.0-41-generic amd64/Oracle Corporation 10.0.1 
(64-bit)/cpus=8,threads=1,free=277307032,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [BasicDistributedZk2Test, 
TestDynamicFieldResource, MetricUtilsTest, TestCryptoKeys, 
PeerSyncReplicationTest, TestLargeCluster, SolrIndexSplitterTest, 
CopyFieldTest, HighlighterMaxOffsetTest, TestFieldCacheSort, 
CreateCollectionCleanupTest, TestFaceting, FileUtilsTest, 
TestOnReconnectListenerSupport, TestCrossCoreJoin, TestRTGBase, 
VersionInfoTest, TestCodecSupport, SegmentsInfoRequestHandlerTest, 
TestNumericRangeQuery64, TestPullReplicaErrorHandling, 
TestNamedUpdateProcessors, DocExpirationUpdateProcessorFactoryTest, 
TestOmitPositions, BaseCdcrDistributedZkTest, TestSurroundQueryParser, 
SolrJmxReporterTest, DateRangeFieldTest, TestQuerySenderNoQuery, 
SearchHandlerTest, TestExceedMaxTermLength, FullSolrCloudDistribCmdsTest, 
TestMissingGroups, ZkStateWriterTest, TestXIncludeConfig, BadIndexSchemaTest, 
TestIndexSearcher, TestGroupingSearch, SolrCLIZkUtilsTest, 
ScheduledMaintenanceTriggerTest, TestSolrDeletionPolicy2, 
TestDFISimilarityFactory, TestSolrConfigHandlerCloud, DirectSolrConnectionTest, 
TestConfigsApi, TestCollectionsAPIViaSolrCloudCluster, 
LeaderFailoverAfterPartitionTest, XmlInterpolationTest, TestConfigSetImmutable, 
TestLMDirichletSimilarityFactory, AutoAddReplicasPlanActionTest, 
TestEmbeddedSolrServerConstructors, PreAnalyzedFieldTest, TermsComponentTest, 
AtomicUpdatesTest, CollectionPropsTest, TestDistribStateManager, 
TestMacroExpander, CdcrReplicationDistributedZkTest, TestCollationField, 
BlockCacheTest, TestFuzzyAnalyzedSuggestions, CollectionTooManyReplicasTest, 
TestRTimerTree, TestSchemaResource, TestUnifiedSolrHighlighter, 
FieldAnalysisRequestHandlerTest, SuggesterFSTTest, TestCustomDocTransformer, 
SortSpecParsingTest, ZkFailoverTest, HdfsRestartWhileUpdatingTest, 
TestCustomStream, TestSegmentSorting, TestCloudDeleteByQuery, 
ConnectionReuseTest, TestManagedResource, HdfsDirectoryFactoryTest, 
TestConfigSetsAPI, ResourceLoaderTest, SolrCmdDistributorTest, TestPolicyCloud, 
TestManagedSynonymFilterFactory, TestComponentsName, JvmMetricsTest, 
DistributedFacetPivotWhiteBoxTest, HdfsTlogReplayBufferedWhileIndexingTest, 
AnalyticsQueryTest, SpellingQueryConverterTest, TestCloudRecovery, 
SSLMigrationTest, TestXmlQParser, TestSkipOverseerOperations, 
AliasIntegrationTest, TestRandomDVFaceting, TestSolrJ, TestReplicaProperties, 
TestOverriddenPrefixQueryForCustomFieldType, SolrCoreTest, 
TestSolrCloudWithSecureImpersonation, TestElisionMultitermQuery, 
SolrMetricManagerTest, WrapperMergePolicyFactoryTest, BitVectorTest, 
TestManagedSchema, HdfsBasicDistributedZkTest, InfixSuggestersTest, 
RemoteQueryErrorTest, MissingSegmentRecoveryTest, IndexSizeTriggerTest, 
SpatialHeatmapFacetsTest, NodeMutatorTest, NodeAddedTriggerIntegrationTest, 
DOMUtilTest, NodeLostTriggerTest, TestMergePolicyConfig, TestFastOutputStream, 
RulesTest, DistanceFunctionTest, SmileWriterTest, EchoParamsTest, 
TestPolicyCloud, TestSha256AuthenticationProvider, 
ConcurrentCreateRoutedAliasTest, TestJsonFacetsWithNestedObjects, 
TestPushWriter, TriggerSetPropertiesIntegrationTest, TestPerFieldSimilarity, 
TestFoldingMultitermQuery, DocValuesTest, TestBulkSchemaConcurrent, 
PeerSyncTest, HttpPartitionOnCommitTest, HttpPartitionTest, 
LeaderElectionContextKeyTest, LeaderElectionTest, MoveReplicaTest, 
OverseerCollectionConfigSetProcessorTest, OverseerModifyCollectionTest, 
OverseerRolesTest, OverseerStatusTest, RecoveryAfterSoftCommitTest, 
SolrCloudExampleTest, SyncSliceTest, TestCloudPivotFacet, 
TestLeaderInitiatedRecoveryThread, TestLockTree, TestMiniSolrCloudClusterSSL, 
TestZkChroot, TlogReplayBufferedWhileIndexingTest, 
VMParamsZkACLAndCredentialsProvidersTest, ZkNodePropsTest, ZkShardTermsTest, 
CollectionsAPIDistributedZkTest, SystemLogListenerTest, 
CdcrReplicationHandlerTest, CdcrRequestHandlerTest, CdcrVersionReplicationTest, 
HdfsNNFailoverTest, HdfsRecoverLeaseTest, ConfigureRecoveryStrategyTest, 
CoreSorterTest, OpenCloseCoreStressTest, SOLR749Test, TestBadConfig, 
TestCorePropertiesReload, TestDynamicURP, TestSolrCoreSnapshots, 
RequestLoggingTest, ResponseBuilderTest, TestBlobHandler, 
TestReplicationHandler, TestRestoreCore, CoreAdminCreateDiscoverTest, 
CoreAdminHandlerTest, LukeRequestHandlerTest, MetricsHandlerTest, 
MetricsHistoryHandlerTest, ShowFileRequestHandlerTest, StatsReloadRaceTest, 
SystemInfoHandlerTest, TestCoreAdminApis, BadComponentTest, 
CustomHighlightComponentTest, DistributedMLTComponentTest, 
DistributedSuggestComponentTest, SearchHandlerTest, JavabinLoaderTest, 
Tagger2Test, HighlighterTest, TestPostingsSolrHighlighter, 
TestSlowCompositeReaderWrapper, UninvertDocValuesMergePolicyTest, 
TestLegacyField, TestLegacyFieldReuse, TestLegacyNumericUtils, TestLegacyTerms, 
SolrGangliaReporterTest, SolrShardReporterTest, TestRemoteStreaming, 
TestStreamBody, TestBinaryResponseWriter, TestCSVResponseWriter, 
TestExportWriter, TestGeoJSONResponseWriter, TestGraphMLResponseWriter, 
TestJavabinTupleStreamParser, TestRetrieveFieldsOptimizer, 
TestSubQueryTransformer, TestBulkSchemaAPI, DocValuesMissingTest, 
ManagedSchemaRoundRobinCloudTest, TestCloudManagedSchema, QueryEqualityTest, 
QueryParsingTest, RankQueryTest, ReturnFieldsTest, TestCollapseQParserPlugin, 
TestCustomSort, TestFilteredDocIdSet, TestGraphTermsQParserPlugin, 
TestHashQParserPlugin, TestLRUCache, TestPseudoReturnFields, TestQueryTypes, 
TestQueryUtils, TestRecovery]
   [junit4] Completed [750/820 (1!)] on J0 in 40.07s, 20 tests, 1 failure <<< 
FAILURES!

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

[repro] Revision: ea4043b954dd089e3deb27b1f70da868b383152a

[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC"
[repro] Repro line:  ant test  -Dtestcase=TestRecovery 
-Dtests.method=testExistOldBufferLog -Dtests.seed=74265E35EF1555CB 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=nn 
-Dtests.timezone=America/Blanc-Sablon -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII

[repro] ant clean

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

[...truncated 3305 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.TestRecovery" -Dtests.showOutput=onerror 
"-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC" -Dtests.seed=74265E35EF1555CB 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=nn 
-Dtests.timezone=America/Blanc-Sablon -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII

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

[...truncated 40 lines...]

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