Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/656/
Java: 64bit/jdk-10 -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([980E37160FB7CE65:C65E2A4381785EEC]: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 15084 lines...]
[junit4] Suite: org.apache.solr.search.TestRecovery
[junit4] 2> Creating dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001
[junit4] 2> 2747771 INFO
(SUITE-TestRecovery-seed#[980E37160FB7CE65]-worker) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib,
/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2747790 INFO
(SUITE-TestRecovery-seed#[980E37160FB7CE65]-worker) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 7.5.0
[junit4] 2> 2747802 INFO
(SUITE-TestRecovery-seed#[980E37160FB7CE65]-worker) [ ] o.a.s.s.IndexSchema
[null] Schema name=test
[junit4] 2> 2747843 INFO
(SUITE-TestRecovery-seed#[980E37160FB7CE65]-worker) [ ] o.a.s.s.IndexSchema
Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 2748138 INFO
(SUITE-TestRecovery-seed#[980E37160FB7CE65]-worker) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2748138 INFO
(SUITE-TestRecovery-seed#[980E37160FB7CE65]-worker) [ ]
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history
in memory.
[junit4] 2> 2748149 INFO
(SUITE-TestRecovery-seed#[980E37160FB7CE65]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@363d7013
[junit4] 2> 2748155 INFO
(SUITE-TestRecovery-seed#[980E37160FB7CE65]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@363d7013
[junit4] 2> 2748155 INFO
(SUITE-TestRecovery-seed#[980E37160FB7CE65]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@363d7013
[junit4] 2> 2748158 INFO (coreLoadExecutor-16638-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib,
/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2748178 INFO (coreLoadExecutor-16638-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 2748191 INFO (coreLoadExecutor-16638-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2748233 INFO (coreLoadExecutor-16638-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 2748242 INFO (coreLoadExecutor-16638-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1,
trusted=true
[junit4] 2> 2748242 INFO (coreLoadExecutor-16638-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@363d7013
[junit4] 2> 2748242 INFO (coreLoadExecutor-16638-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2748242 INFO (coreLoadExecutor-16638-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\]
[junit4] 2> 2748247 INFO (coreLoadExecutor-16638-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=543637766,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 2748286 WARN (coreLoadExecutor-16638-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> 2748337 INFO (coreLoadExecutor-16638-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 2748337 INFO (coreLoadExecutor-16638-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 2748339 INFO (coreLoadExecutor-16638-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2748339 INFO (coreLoadExecutor-16638-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2748340 INFO (coreLoadExecutor-16638-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=46, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.3732043509170748]
[junit4] 2> 2748345 INFO (coreLoadExecutor-16638-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@2b75ff65[collection1] main]
[junit4] 2> 2748345 WARN (coreLoadExecutor-16638-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf;
switching to use InMemory storage instead.
[junit4] 2> 2748346 INFO (coreLoadExecutor-16638-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2748346 INFO
(searcherExecutor-16639-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@2b75ff65[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2748346 INFO (coreLoadExecutor-16638-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1604363173308137472
[junit4] 2> 2748353 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[reload1 (1604363173313380352)]}
0 1
[junit4] 2> 2748353 ERROR
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ ]
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\core.properties:java.nio.file.NoSuchFileException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\core.properties
[junit4] 2> 2748354 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib,
/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2748374 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 2748387 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2748431 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 2748440 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ ]
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from
instancedir
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1
[junit4] 2> 2748459 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ 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@363d7013
[junit4] 2> 2748459 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\]
[junit4] 2> 2748462 WARN
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ 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> 2748513 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2748513 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2748524 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@5f47e58[collection1] main]
[junit4] 2> 2748525 WARN
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.r.ManagedResourceStorage Cannot write to config directory
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf;
switching to use InMemory storage instead.
[junit4] 2> 2748525 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2748527 INFO
(searcherExecutor-16644-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@5f47e58[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.5.0):C1)))}
[junit4] 2> 2748635 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=17, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6763294677115692]
[junit4] 2> 2748637 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 2748638 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@81c119e[collection1] main]
[junit4] 2> 2748639 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@2364d123
[junit4] 2> 2748639 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=2364d123
[junit4] 2> 2748639 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@38553429: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@732c37f3
[junit4] 2> 2748640 INFO
(searcherExecutor-16644-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@81c119e[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.5.0):C1)))}
[junit4] 2> 2748648 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[reload1 (1604363173623758848)]}
0 0
[junit4] 2> 2748648 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1604363173624807424,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2748648 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@5a267c02
commitCommandVersion:1604363173624807424
[junit4] 2> 2748681 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@5cd4c0ae[collection1] main]
[junit4] 2> 2748682 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2748682 INFO
(searcherExecutor-16644-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@5cd4c0ae[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.5.0):C1)))}
[junit4] 2> 2748685 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 36
[junit4] 2> 2748687 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[reload1 (1604363173664653312)]}
0 1
[junit4] 2> 2748693 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@448c54fa[collection1] realtime]
[junit4] 2> 2748694 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{deleteByQuery=foo_t:hownowbrowncow
(-1604363173665701888)} 0 7
[junit4] 2> 2748695 INFO
(TEST-TestRecovery.testReload-seed#[980E37160FB7CE65]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[reload1 (1604363173673041920)]}
0 0
[junit4] 2> 2748699 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL
DOCUMENTS FROM INDEX
[junit4] 2> 2748699 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@ee9118[collection1]
realtime]
[junit4] 2> 2748701 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] 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 2
[junit4] 2> 2748701 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1604363173680381952,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2748701 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@5a267c02
commitCommandVersion:1604363173680381952
[junit4] 2> 2748708 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@1cc7eeac[collection1] main]
[junit4] 2> 2748708 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2748709 INFO
(searcherExecutor-16644-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1cc7eeac[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2748711 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 9
[junit4] 2> 2748711 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.UpdateLog Starting to buffer updates.
FSUpdateLog{state=ACTIVE, tlog=null}
[junit4] 2> 2748712 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.UpdateLog Starting to buffer updates.
FSUpdateLog{state=ACTIVE, tlog=null}
[junit4] 2> 2748713 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[C1]} 0 1
[junit4] 2> 2748713 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[C2 (1)]}
0 0
[junit4] 2> 2748713 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[C3 (2)]}
0 0
[junit4] 2> 2748713 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.UpdateLog Dropping buffered updates
FSUpdateLog{state=BUFFERING,
tlog=tlog{file=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\tlog\tlog.0000000000000000002.0
refcount=1}}
[junit4] 2> 2748713 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.UpdateLog Starting to buffer updates.
FSUpdateLog{state=ACTIVE,
tlog=tlog{file=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\tlog\tlog.0000000000000000002.0
refcount=1}}
[junit4] 2> 2748714 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[C4 (3)]}
0 0
[junit4] 2> 2748714 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[C5 (4)]}
0 0
[junit4] 2> 2748714 WARN
(recoveryExecutor-16641-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Starting log replay
tlog{file=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\tlog\buffer.tlog.0001128362020712400
refcount=2} active=true starting pos=0 inSortedOrder=false
[junit4] 2> 2749215 INFO
(recoveryExecutor-16641-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> 2749215 INFO
(recoveryExecutor-16641-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@5a267c02 commitCommandVersion:0
[junit4] 2> 2749256 INFO
(recoveryExecutor-16641-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1857b05b[collection1] main]
[junit4] 2> 2749257 INFO
(recoveryExecutor-16641-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2749258 INFO
(searcherExecutor-16644-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1857b05b[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.5.0):C2)))}
[junit4] 2> 2749258 INFO
(recoveryExecutor-16641-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[C4 (3), C5 (4)]} 0 543
[junit4] 2> 2749258 INFO
(recoveryExecutor-16641-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Re-computing max version from index after log re-play.
[junit4] 2> 2749259 WARN
(recoveryExecutor-16641-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=2
deletes=0 deleteByQuery=0 errors=0 positionOfStart=0}
[junit4] 2> 2749260 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=2&wt=xml} status=0 QTime=0
[junit4] 2> 2749262 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[C100
(5)]} 0 1
[junit4] 2> 2749262 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[C101
(6)]} 0 0
[junit4] 2> 2749263 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.UpdateLog Starting to buffer updates.
FSUpdateLog{state=ACTIVE,
tlog=tlog{file=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\tlog\tlog.0000000000000000003.5
refcount=1}}
[junit4] 2> 2749263 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[C103
(7)]} 0 0
[junit4] 2> 2749263 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[C104
(8)]} 0 0
[junit4] 2> 2749263 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.UpdateLog Dropping buffered updates
FSUpdateLog{state=BUFFERING,
tlog=tlog{file=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\tlog\tlog.0000000000000000003.5
refcount=1}}
[junit4] 2> 2749264 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.UpdateLog Starting to buffer updates.
FSUpdateLog{state=ACTIVE,
tlog=tlog{file=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\tlog\tlog.0000000000000000003.5
refcount=1}}
[junit4] 2> 2749264 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[C105
(9)]} 0 0
[junit4] 2> 2749264 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[C106
(10)]} 0 0
[junit4] 2> 2749264 WARN
(recoveryExecutor-16641-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Starting log replay
tlog{file=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\tlog\buffer.tlog.0001128362571240300
refcount=2} active=true starting pos=0 inSortedOrder=false
[junit4] 2> 2749765 INFO
(recoveryExecutor-16641-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> 2749765 INFO
(recoveryExecutor-16641-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@5a267c02 commitCommandVersion:0
[junit4] 2> 2749857 INFO
(recoveryExecutor-16641-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@4057d7df[collection1] main]
[junit4] 2> 2749859 INFO
(recoveryExecutor-16641-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2749860 INFO
(searcherExecutor-16644-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@4057d7df[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.5.0):C2)
Uninverting(_5(7.5.0):C4)))}
[junit4] 2> 2749860 INFO
(recoveryExecutor-16641-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[C105 (9), C106 (10)]} 0
595
[junit4] 2> 2749860 INFO
(recoveryExecutor-16641-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Re-computing max version from index after log re-play.
[junit4] 2> 2749862 WARN
(recoveryExecutor-16641-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=2
deletes=0 deleteByQuery=0 errors=0 positionOfStart=0}
[junit4] 2> 2749862 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&fl=id,_version_&sort=_version_+asc&wt=xml} hits=6 status=0 QTime=0
[junit4] 2> 2749864 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=6&wt=xml} status=0 QTime=1
[junit4] 2> 2749864 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.UpdateLog Starting to buffer updates.
FSUpdateLog{state=ACTIVE, tlog=null}
[junit4] 2> 2749865 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[C301
(13)]} 0 1
[junit4] 2> 2749866 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[C302
(14)]} 0 0
[junit4] 2> 2749866 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.UpdateLog Dropping buffered updates
FSUpdateLog{state=BUFFERING,
tlog=tlog{file=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\tlog\tlog.0000000000000000004.13
refcount=1}}
[junit4] 2> 2749867 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[C301
(11)]} 0 0
[junit4] 2> 2749867 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[C302
(12)]} 0 0
[junit4] 2> 2749867 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1604363174903021568,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2749867 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@5a267c02
commitCommandVersion:1604363174903021568
[junit4] 2> 2749991 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@27f1ee77[collection1] main]
[junit4] 2> 2749993 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2749993 INFO
(searcherExecutor-16644-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@27f1ee77[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.5.0):C2)
Uninverting(_5(7.5.0):C4) Uninverting(_6(7.5.0):C2)))}
[junit4] 2> 2749993 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 125
[junit4] 2> 2749994 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=2&wt=xml} status=0 QTime=0
[junit4] 2> 2749994 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&fl=id,_version_&sort=_version_+desc&rows=2&wt=xml} hits=8
status=0 QTime=0
[junit4] 2> 2749996 INFO
(TEST-TestRecovery.testDropBuffered-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[C2 (12)]}
0 1
[junit4] 2> 2749999 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL
DOCUMENTS FROM INDEX
[junit4] 2> 2750000 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@13eff87b[collection1] realtime]
[junit4] 2> 2750000 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] 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> 2750000 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1604363175042482176,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2750000 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@5a267c02
commitCommandVersion:1604363175042482176
[junit4] 2> 2750010 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@3843b777[collection1] main]
[junit4] 2> 2750012 INFO
(searcherExecutor-16644-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@3843b777[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2750012 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2750026 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]
webapp=null path=null params={}{commit=} 0 25
[junit4] 2> 2750028 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]
webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ2_1 (15)]} 0 1
[junit4] 2> 2750028 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]
webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ2_2 (18)]} 0 0
[junit4] 2> 2750041 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@4e02e6d9[collection1] realtime]
[junit4] 2> 2750042 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@71b3930f[collection1] realtime]
[junit4] 2> 2750043 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]
webapp=null path=null
params={update.distrib=FROMLEADER&_version_=-17&wt=json&indent=true}{deleteByQuery=_root_:RDBQ2_1
_root_:RDBQ2_2 id:RDBQ2_3 _root_:RDBQ2_4 (-17)} 0 15
[junit4] 2> 2750043 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.
Update=add{_version_=16,id=RDBQ2_3} DBQs=[DBQ{version=17,q=_root_:RDBQ2_1
_root_:RDBQ2_2 id:RDBQ2_3 _root_:RDBQ2_4}]
[junit4] 2> 2750052 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@65bab522[collection1] realtime]
[junit4] 2> 2750052 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]
webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ2_3 (16)]} 0 9
[junit4] 2> 2750053 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]
webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ2_4 (19)]} 0 0
[junit4] 2> 2750053 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 2750054 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.c.CoreContainer Shutting down CoreContainer
instance=1989342533
[junit4] 2> 2750054 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.node, tag=null
[junit4] 2> 2750054 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@562af59: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@758b23ac
[junit4] 2> 2750058 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jvm, tag=null
[junit4] 2> 2750058 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@3f16eaed: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@50663eba
[junit4] 2> 2750060 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jetty, tag=null
[junit4] 2> 2750060 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@24ac34e1: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@27a580bc
[junit4] 2> 2750061 INFO
(coreCloseExecutor-16648-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@14c3f541
[junit4] 2> 2750061 INFO
(coreCloseExecutor-16648-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=14c3f541
[junit4] 2> 2750061 INFO
(coreCloseExecutor-16648-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@de40f1a: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@732c37f3
[junit4] 2> 2750085 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to
classloader, from paths:
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib,
/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2750104 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 2750112 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 2750163 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid
field id
[junit4] 2> 2750511 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient
cache for 2147483647 transient cores
[junit4] 2> 2750511 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.h.a.MetricsHistoryHandler No .system collection,
keeping metrics history in memory.
[junit4] 2> 2750523 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node'
(registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@363d7013
[junit4] 2> 2750530 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm'
(registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@363d7013
[junit4] 2> 2750530 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty'
(registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@363d7013
[junit4] 2> 2750532 INFO
(coreLoadExecutor-16658-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib,
/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2750550 INFO
(coreLoadExecutor-16658-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 2750560 INFO
(coreLoadExecutor-16658-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2750613 INFO
(coreLoadExecutor-16658-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 2750621 INFO
(coreLoadExecutor-16658-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1,
trusted=true
[junit4] 2> 2750622 INFO
(coreLoadExecutor-16658-thread-1-processing-x:collection1) [ 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@363d7013
[junit4] 2> 2750622 INFO
(coreLoadExecutor-16658-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2750622 INFO
(coreLoadExecutor-16658-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\]
[junit4] 2> 2750625 WARN
(coreLoadExecutor-16658-thread-1-processing-x:collection1) [ 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> 2750673 INFO
(coreLoadExecutor-16658-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 2750673 INFO
(coreLoadExecutor-16658-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2750679 INFO
(coreLoadExecutor-16658-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2750679 INFO
(coreLoadExecutor-16658-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2750679 INFO
(coreLoadExecutor-16658-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=543637766,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 2750682 INFO
(coreLoadExecutor-16658-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1489e937[collection1] main]
[junit4] 2> 2750682 WARN
(coreLoadExecutor-16658-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.r.ManagedResourceStorage Cannot write to config directory
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf;
switching to use InMemory storage instead.
[junit4] 2> 2750683 INFO
(coreLoadExecutor-16658-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2750683 INFO
(searcherExecutor-16659-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1489e937[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2750685 WARN
(recoveryExecutor-16661-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Starting log replay
tlog{file=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\tlog\tlog.0000000000000000006.15
refcount=1} active=false starting pos=0 inSortedOrder=false
[junit4] 2> 2750686 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 2751195 INFO
(recoveryExecutor-16661-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@7acf8cac[collection1] realtime]
[junit4] 2> 2751196 INFO
(recoveryExecutor-16661-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@68cf44ff[collection1] realtime]
[junit4] 2> 2751197 INFO
(replayUpdatesExecutor-16652-thread-1-processing-x:collection1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.
Update=add{flags=a,_version_=16,id=RDBQ2_3}
DBQs=[DBQ{version=17,q=_root_:RDBQ2_1 _root_:RDBQ2_2 id:RDBQ2_3 _root_:RDBQ2_4}]
[junit4] 2> 2751204 INFO
(replayUpdatesExecutor-16652-thread-1-processing-x:collection1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@15340530[collection1] realtime]
[junit4] 2> 2751697 INFO
(recoveryExecutor-16661-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> 2751697 INFO
(recoveryExecutor-16661-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@7b08bb21 commitCommandVersion:0
[junit4] 2> 2751914 INFO
(recoveryExecutor-16661-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@670d79c0[collection1] main]
[junit4] 2> 2751914 INFO
(recoveryExecutor-16661-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2751915 INFO
(searcherExecutor-16659-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@670d79c0[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_9(7.5.0):C6/3:delGen=1)
Uninverting(_b(7.5.0):C3)))}
[junit4] 2> 2751916 INFO
(recoveryExecutor-16661-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[RDBQ2_1 (15), RDBQ2_2
(18), RDBQ2_3 (16), RDBQ2_4 (19)],deleteByQuery=_root_:RDBQ2_1 _root_:RDBQ2_2
id:RDBQ2_3 _root_:RDBQ2_4 (-17)} 0 1229
[junit4] 2> 2751916 WARN
(recoveryExecutor-16661-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=4
deletes=0 deleteByQuery=1 errors=0 positionOfStart=0}
[junit4] 2> 2751916 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[980E37160FB7CE65])
[ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&wt=xml} hits=6 status=0 QTime=0
[junit4] 2> 2751920 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL
DOCUMENTS FROM INDEX
[junit4] 2> 2751926 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@21c9c2bd[collection1] realtime]
[junit4] 2> 2751927 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] 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 7
[junit4] 2> 2751927 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1604363177063088128,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2751927 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@7b08bb21
commitCommandVersion:1604363177063088128
[junit4] 2> 2751934 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@469e4f15[collection1] main]
[junit4] 2> 2751934 INFO
(searcherExecutor-16659-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@469e4f15[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2751934 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2751938 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 11
[junit4] 2> 2751944 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ1_1
(20)]} 0 5
[junit4] 2> 2751949 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@3229cb1e[collection1] realtime]
[junit4] 2> 2751950 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null
params={update.distrib=FROMLEADER&_version_=-22&wt=json&indent=true}{deleteByQuery=id:RDBQ1_2
(-22)} 0 5
[junit4] 2> 2751950 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.
Update=add{_version_=21,id=RDBQ1_2} DBQs=[DBQ{version=22,q=id:RDBQ1_2}]
[junit4] 2> 2751956 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@3267f4d8[collection1] realtime]
[junit4] 2> 2751957 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ1_2
(21)]} 0 6
[junit4] 2> 2751958 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ1_3
(23)]} 0 0
[junit4] 2> 2751958 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 2751958 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.CoreContainer Shutting down CoreContainer
instance=727963080
[junit4] 2> 2751958 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.node, tag=null
[junit4] 2> 2751958 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@2cbcf65a: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@6bdab840
[junit4] 2> 2751962 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jvm, tag=null
[junit4] 2> 2751962 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@616607d0: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@50663eba
[junit4] 2> 2751964 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jetty, tag=null
[junit4] 2> 2751964 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1e0a42fc: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@27a580bc
[junit4] 2> 2751965 INFO
(coreCloseExecutor-16664-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@f634242
[junit4] 2> 2751965 INFO
(coreCloseExecutor-16664-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=f634242
[junit4] 2> 2751965 INFO
(coreCloseExecutor-16664-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@395453bc: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@166043ff
[junit4] 2> 2751978 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib,
/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2751995 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 2752004 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 2752052 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 2752269 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache
for 2147483647 transient cores
[junit4] 2> 2752269 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping
metrics history in memory.
[junit4] 2> 2752284 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node'
(registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@363d7013
[junit4] 2> 2752290 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm'
(registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@363d7013
[junit4] 2> 2752290 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty'
(registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@363d7013
[junit4] 2> 2752293 INFO
(coreLoadExecutor-16674-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib,
/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2752314 INFO
(coreLoadExecutor-16674-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 2752323 INFO
(coreLoadExecutor-16674-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2752375 INFO
(coreLoadExecutor-16674-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 2752384 INFO
(coreLoadExecutor-16674-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1,
trusted=true
[junit4] 2> 2752385 INFO
(coreLoadExecutor-16674-thread-1-processing-x:collection1) [ 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@363d7013
[junit4] 2> 2752385 INFO
(coreLoadExecutor-16674-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2752385 INFO
(coreLoadExecutor-16674-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\]
[junit4] 2> 2752404 WARN
(coreLoadExecutor-16674-thread-1-processing-x:collection1) [ 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> 2752501 INFO
(coreLoadExecutor-16674-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 2752502 INFO
(coreLoadExecutor-16674-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2752507 INFO
(coreLoadExecutor-16674-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2752507 INFO
(coreLoadExecutor-16674-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2752510 INFO
(coreLoadExecutor-16674-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=543637766,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 2752512 INFO
(coreLoadExecutor-16674-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@35af3143[collection1] main]
[junit4] 2> 2752512 WARN
(coreLoadExecutor-16674-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.r.ManagedResourceStorage Cannot write to config directory
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf;
switching to use InMemory storage instead.
[junit4] 2> 2752512 INFO
(coreLoadExecutor-16674-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2752514 INFO
(searcherExecutor-16675-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@35af3143[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2752516 WARN
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Starting log replay
tlog{file=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\tlog\tlog.0000000000000000009.20
refcount=1} active=false starting pos=0 inSortedOrder=false
[junit4] 2> 2752517 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 2753049 INFO
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@5299b6a4[collection1] realtime]
[junit4] 2> 2753050 INFO
(replayUpdatesExecutor-16668-thread-1-processing-x:collection1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.
Update=add{flags=a,_version_=21,id=RDBQ1_2} DBQs=[DBQ{version=22,q=id:RDBQ1_2}]
[junit4] 2> 2753056 INFO
(replayUpdatesExecutor-16668-thread-1-processing-x:collection1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5f1d7ef[collection1]
realtime]
[junit4] 2> 2753657 INFO
(recoveryExecutor-16677-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> 2753657 INFO
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@6f816b79 commitCommandVersion:0
[junit4] 2> 2754563 INFO
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@348fd492[collection1] main]
[junit4] 2> 2754564 INFO
(searcherExecutor-16675-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@348fd492[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_d(7.5.0):C1)
Uninverting(_f(7.5.0):C1)))}
[junit4] 2> 2754564 INFO
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2754564 INFO
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[RDBQ1_1 (20), RDBQ1_2
(21), RDBQ1_3 (23)],deleteByQuery=id:RDBQ1_2 (-22)} 0 2048
[junit4] 2> 2754564 WARN
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=3
deletes=0 deleteByQuery=1 errors=0 positionOfStart=0}
[junit4] 2> 2754565 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&wt=xml} hits=2 status=0 QTime=0
[junit4] 2> 2754568 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL
DOCUMENTS FROM INDEX
[junit4] 2> 2754568 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@58b03735[collection1] realtime]
[junit4] 2> 2754568 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
(-9223372036854775807)} 0 0
[junit4] 2> 2754568 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1604363179832377344,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2754568 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@6f816b79
commitCommandVersion:1604363179832377344
[junit4] 2> 2754576 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@1e976cd7[collection1] main]
[junit4] 2> 2754577 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2754578 INFO
(searcherExecutor-16675-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1e976cd7[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2754581 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 12
[junit4] 2> 2754581 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.UpdateLog Starting to buffer updates.
FSUpdateLog{state=ACTIVE, tlog=null}
[junit4] 2> 2754582 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[c1 (24)]}
0 1
[junit4] 2> 2754583 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[c2 (25)]}
0 0
[junit4] 2> 2754583 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[c3 (26)]}
0 0
[junit4] 2> 2754583 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.UpdateLog Starting to buffer updates.
FSUpdateLog{state=BUFFERING,
tlog=tlog{file=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\tlog\tlog.0000000000000000012.24
refcount=1}}
[junit4] 2> 2754584 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[c4 (27)]}
0 0
[junit4] 2> 2754584 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[c5 (28)]}
0 0
[junit4] 2> 2754584 WARN
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Starting log replay
tlog{file=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\tlog\buffer.tlog.0001128367890883300
refcount=2} active=true starting pos=0 inSortedOrder=false
[junit4] 2> 2755109 INFO
(recoveryExecutor-16677-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> 2755109 INFO
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@6f816b79 commitCommandVersion:0
[junit4] 2> 2755173 INFO
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@749c9466[collection1] main]
[junit4] 2> 2755173 INFO
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2755175 INFO
(searcherExecutor-16675-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@749c9466[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_g(7.5.0):C2)))}
[junit4] 2> 2755175 INFO
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[c4 (27), c5 (28)]} 0 590
[junit4] 2> 2755175 INFO
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Re-computing max version from index after log re-play.
[junit4] 2> 2755177 WARN
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=2
deletes=0 deleteByQuery=0 errors=0 positionOfStart=0}
[junit4] 2> 2755179 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=2&wt=xml} status=0 QTime=1
[junit4] 2> 2755181 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[c100
(29)]} 0 1
[junit4] 2> 2755181 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[c101
(30)]} 0 0
[junit4] 2> 2755182 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.UpdateLog Starting to buffer updates.
FSUpdateLog{state=ACTIVE,
tlog=tlog{file=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\tlog\tlog.0000000000000000013.29
refcount=1}}
[junit4] 2> 2755182 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[c103
(31)]} 0 0
[junit4] 2> 2755182 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[c104
(32)]} 0 0
[junit4] 2> 2755182 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.UpdateLog Starting to buffer updates.
FSUpdateLog{state=BUFFERING,
tlog=tlog{file=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\tlog\tlog.0000000000000000013.29
refcount=1}}
[junit4] 2> 2755183 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[c105
(33)]} 0 0
[junit4] 2> 2755183 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[c106
(34)]} 0 0
[junit4] 2> 2755183 WARN
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Starting log replay
tlog{file=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestRecovery_980E37160FB7CE65-001\init-core-data-001\tlog\buffer.tlog.0001128368490189900
refcount=2} active=true starting pos=0 inSortedOrder=false
[junit4] 2> 2755704 INFO
(recoveryExecutor-16677-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> 2755704 INFO
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@6f816b79 commitCommandVersion:0
[junit4] 2> 2756676 INFO
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@7db7635a[collection1] main]
[junit4] 2> 2756678 INFO
(searcherExecutor-16675-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@7db7635a[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_g(7.5.0):C2)
Uninverting(_h(7.5.0):C4)))}
[junit4] 2> 2756678 INFO
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2756678 INFO
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[c105 (33), c106 (34)]}
0 1494
[junit4] 2> 2756678 INFO
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Re-computing max version from index after log re-play.
[junit4] 2> 2756680 WARN
(recoveryExecutor-16677-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=2
deletes=0 deleteByQuery=0 errors=0 positionOfStart=0}
[junit4] 2> 2756680 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&fl=id,_version_&sort=_version_+asc&wt=xml} hits=6 status=0 QTime=0
[junit4] 2> 2756682 INFO
(TEST-TestRecovery.testBufferedMultipleCalls-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=6&wt=xml} status=0 QTime=1
[junit4] 2> 2756685 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL
DOCUMENTS FROM INDEX
[junit4] 2> 2756685 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@1673e3f8[collection1] realtime]
[junit4] 2> 2756686 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
(-9223372036854775807)} 0 0
[junit4] 2> 2756686 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1604363182053261312,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2756686 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@6f816b79
commitCommandVersion:1604363182053261312
[junit4] 2> 2756696 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@729611a4[collection1] main]
[junit4] 2> 2756697 INFO
(searcherExecutor-16675-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@729611a4[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2756697 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2756805 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 119
[junit4] 2> 2756805 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.CoreContainer Shutting down CoreContainer
instance=459988660
[junit4] 2> 2756806 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.node, tag=null
[junit4] 2> 2756806 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@2c2e4897: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@3d8cd4df
[junit4] 2> 2756810 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jvm, tag=null
[junit4] 2> 2756810 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@e6daa20: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@50663eba
[junit4] 2> 2756813 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jetty, tag=null
[junit4] 2> 2756813 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6432fc98: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@27a580bc
[junit4] 2> 2756814 INFO
(coreCloseExecutor-16680-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@408f953f
[junit4] 2> 2756814 INFO
(coreCloseExecutor-16680-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=408f953f
[junit4] 2> 2756814 INFO
(coreCloseExecutor-16680-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@27ab3a56: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@1861d930
[junit4] 2> 2756825 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib,
/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2756843 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 2756851 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 2756898 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 2756961 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache
for 2147483647 transient cores
[junit4] 2> 2756961 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping
metrics history in memory.
[junit4] 2> 2756973 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node'
(registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@363d7013
[junit4] 2> 2756978 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm'
(registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@363d7013
[junit4] 2> 2756980 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[980E37160FB7CE65]) [
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty'
(registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@363d7013
[junit4] 2> 2756984 INFO
(coreLoadExecutor-16690-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/c
[...truncated too long message...]
dexFingerprintCachingTest, DataDrivenBlockJoinTest,
TestReplicationHandlerBackup, HttpTriggerListenerTest, TestRebalanceLeaders,
TestSlowCompositeReaderWrapper, SignatureUpdateProcessorFactoryTest,
OpenCloseCoreStressTest, TestEmbeddedSolrServerConstructors,
TestComponentsName, HdfsLockFactoryTest, WrapperMergePolicyFactoryTest,
TimeRoutedAliasUpdateProcessorTest, TestSortableTextField,
TestSweetSpotSimilarityFactory, TestJettySolrRunner,
TestMultiValuedNumericRangeQuery, TestShardHandlerFactory,
SolrCloudReportersTest, TestQuerySenderNoQuery, TestFieldCacheReopen,
BlobRepositoryCloudTest, TestAtomicUpdateErrorCases,
CollectionStateFormat2Test, DistributedFacetPivotWhiteBoxTest,
MissingSegmentRecoveryTest, TestBM25SimilarityFactory,
TestManagedSynonymFilterFactory, TestDynamicFieldResource,
TestImplicitCoreProperties, TestClusterProperties, QueryResultKeyTest,
SuggestComponentTest, HdfsChaosMonkeySafeLeaderTest,
DocumentAnalysisRequestHandlerTest, TestGroupingSearch, OverseerTest,
FullHLLTest, TestMissingGroups, TestQueryUtils, MetricsHistoryIntegrationTest,
TestBadConfig, TestCustomStream, TestTolerantUpdateProcessorCloud,
ExternalFileFieldSortTest, TestPerFieldSimilarity,
SharedFSAutoReplicaFailoverTest, TestConfig,
StatelessScriptUpdateProcessorFactoryTest, TestNestedDocsSort,
TestNamedUpdateProcessors, DistribDocExpirationUpdateProcessorTest,
CoreAdminHandlerTest, BasicAuthStandaloneTest, CollectionTooManyReplicasTest,
MultiSolrCloudTestCaseTest, SegmentsInfoRequestHandlerTest, UtilsToolTest,
BinaryUpdateRequestHandlerTest, TestStandardQParsers, TestFieldSortValues,
SpatialRPTFieldTypeTest, TestCoreDiscovery, NumericFieldsTest,
CdcrReplicationDistributedZkTest, TestUtilizeNode, TestStressRecovery,
TestGraphMLResponseWriter, TestExtendedDismaxParser, URLClassifyProcessorTest,
TestLFUCache, ZkCLITest, TestReloadDeadlock, ShardSplitTest,
TestCloudManagedSchema, TestBlobHandler, DeleteStatusTest, NodeMutatorTest,
TestFiltering, TestDefaultStatsCache, TestAuthenticationFramework,
HighlighterMaxOffsetTest, TestLuceneMatchVersion, SpellCheckCollatorTest,
ParsingFieldUpdateProcessorsTest, TestDynamicLoading,
ChaosMonkeySafeLeaderTest, TestXmlQParserPlugin, TestCrossCoreJoin,
SSLMigrationTest, TestTrie, NodeMarkersRegistrationTest, TestDistributedSearch,
LukeRequestHandlerTest, SpatialHeatmapFacetsTest,
AutoAddReplicasIntegrationTest, TestFastOutputStream, ReplaceNodeTest,
CircularListTest, ShufflingReplicaListTransformerTest, TestFieldResource,
QueryEqualityTest, TestSolrCloudWithKerberosAlt, TermVectorComponentTest,
TestLRUStatsCache, TestTrackingShardHandlerFactory, DocValuesNotIndexedTest,
TestCSVResponseWriter, PingRequestHandlerTest, DisMaxRequestHandlerTest,
TestPHPSerializedResponseWriter, HdfsRestartWhileUpdatingTest,
OrderedExecutorTest, TestFieldCacheWithThreads, SolrMetricManagerTest,
BigEndianAscendingWordDeserializerTest, TestCollectionAPI,
TestRetrieveFieldsOptimizer, HdfsRecoverLeaseTest, InfoHandlerTest,
AnalysisAfterCoreReloadTest, TestConfigReload, PeerSyncTest,
TestTriggerIntegration, ClassificationUpdateProcessorIntegrationTest,
BooleanFieldTest, TestApiFramework, TestClusterStateProvider, BadCopyFieldTest,
MetricsHandlerTest, HdfsUnloadDistributedZkTest, OverseerModifyCollectionTest,
TestWordDelimiterFilterFactory, PropertiesRequestHandlerTest,
BlockJoinFacetRandomTest, CdcrBidirectionalTest, AutoscalingHistoryHandlerTest,
IndexSchemaTest, TestJoin, TransactionLogTest, TestNumericTerms32,
JsonLoaderTest, TestSolrCloudWithHadoopAuthPlugin, UpdateParamsTest,
AutoScalingHandlerTest, TestAddFieldRealTimeGet, TestRestoreCore,
TestUninvertingReader, TestInitParams, XmlUpdateRequestHandlerTest,
BlockCacheTest, SuggesterFSTTest, TestLegacyField, TestSmileRequest,
TestCloudDeleteByQuery, TestUniqueKeyFieldResource, TestSolrDeletionPolicy2,
EmbeddedSolrNoSerializeTest, TestNodeAddedTrigger, TestIBSimilarityFactory,
FileBasedSpellCheckerTest, TestRecoveryHdfs, BJQParserTest,
SolrRrdBackendFactoryTest, TestScoreJoinQPScore,
DeleteLastCustomShardedReplicaTest, TestLazyCores,
TestPayloadCheckQParserPlugin, TestExactSharedStatsCache,
ExecutePlanActionTest, TestRandomFlRTGCloud, TestStreamBody, DeleteReplicaTest,
TestSurroundQueryParser, UnloadDistributedZkTest, TestSQLHandlerNonCloud,
HttpSolrCallGetCoreTest, TestRawResponseWriter, TestConfigSetImmutable,
TestLegacyNumericRangeQueryBuilder, TestRuleBasedAuthorizationPlugin,
TestIndexSearcher, TestDFISimilarityFactory, ResponseHeaderTest, AssignTest,
TestShortCircuitedRequests, LeaderVoteWaitTimeoutTest,
TestSchemaVersionResource, HLLUtilTest, BasicFunctionalityTest,
ConvertedLegacyTest, CursorPagingTest, EchoParamsTest, OutputWriterTest,
SampleTest, SolrInfoBeanTest, SolrTestCaseJ4Test,
TestCursorMarkWithoutUniqueKey, TestDistributedGrouping,
TestHighlightDedupGrouping, TestRandomFaceting, TestSimpleTrackingShardHandler,
TestSolrCoreProperties, TestTolerantSearch, PathHierarchyTokenizerFactoryTest,
TestLuceneIndexBackCompat, AsyncCallRequestStatusResponseTest,
BasicDistributedZkTest, ChaosMonkeyNothingIsSafeTest,
ChaosMonkeyNothingIsSafeWithPullReplicasTest, ClusterStateUpdateTest,
ConcurrentCreateRoutedAliasTest, ConnectionManagerTest, CreateRoutedAliasTest,
DeleteInactiveReplicaTest, DeleteNodeTest, DeleteShardTest,
DistributedQueueTest, FullSolrCloudDistribCmdsTest,
LeaderElectionContextKeyTest, LeaderElectionIntegrationTest,
LeaderFailoverAfterPartitionTest, LeaderFailureAfterFreshStartTest,
LegacyCloudClusterPropTest, MoveReplicaHDFSFailoverTest, MoveReplicaHDFSTest,
MoveReplicaTest, PeerSyncReplicationTest, RecoveryAfterSoftCommitTest,
TestCloudConsistency, TestCloudJSONFacetJoinDomain, TestCloudJSONFacetSKG,
TestCloudPseudoReturnFields, TestCloudRecovery, TestConfigSetsAPIExclusivity,
TestCryptoKeys, TestDistribDocBasedVersion, TestLeaderElectionZkExpiry,
TestLockTree, TestMiniSolrCloudClusterSSL, TestPullReplica,
TestSSLRandomization, TestSolrCloudWithDelegationTokens,
TestStressCloudBlindAtomicUpdates, TestStressInPlaceUpdates,
TestStressLiveNodes, TestZkChroot, TlogReplayBufferedWhileIndexingTest,
ZkControllerTest, ZkFailoverTest, ZkShardTermsTest, CollectionReloadTest,
CollectionsAPIAsyncDistributedZkTest, CustomCollectionTest,
HdfsCollectionsAPIDistributedZkTest, TestHdfsCloudBackupRestore,
TestLocalFSCloudBackupRestore, TestReplicaProperties,
AutoAddReplicasPlanActionTest, MetricTriggerIntegrationTest,
NodeAddedTriggerIntegrationTest, NodeLostTriggerIntegrationTest,
RestoreTriggerStateTest, TestPolicyCloud, TestComputePlanAction,
TestDistribStateManager, TestExecutePlanAction, TestNodeLostTrigger,
TestPolicyCloud, TestSimDistributedQueue, BaseCdcrDistributedZkTest,
CdcrBootstrapTest, HdfsBasicDistributedZk2Test, HdfsBasicDistributedZkTest,
HdfsRecoveryZkTest, HdfsThreadLeakTest, HdfsWriteToMultipleCollectionsTest,
ZkStateReaderTest, AlternateDirectoryTest, CachingDirectoryFactoryTest,
CoreSorterTest, ExitableDirectoryReaderTest, HdfsDirectoryFactoryTest,
RAMDirectoryFactoryTest, RequestHandlersTest, ResourceLoaderTest,
SolrCoreCheckLockOnStartupTest, TestBackupRepositoryFactory, TestConfigOverlay,
TestConfigSetProperties, TestConfigSets, TestDirectoryFactory, TestDynamicURP,
TestInfoStreamLogging, TestNRTOpen, TestSimpleTextCodec, TestSolrConfigHandler,
ResponseBuilderTest, SearchHandlerTest, TestCSVLoader, TestCoreBackup,
TestHdfsBackupRestoreCore, TestReqParamsAPI, TestSolrConfigHandlerConcurrent,
TestSystemCollAutoCreate, CoreMergeIndexesAdminHandlerTest, LoggingHandlerTest,
StatsReloadRaceTest, DebugComponentTest, DistributedFacetExistsSmallTest,
DistributedFacetPivotLongTailTest, DistributedMLTComponentTest,
DistributedQueryComponentOptimizationTest, DistributedSpellCheckComponentTest,
FacetPivotSmallTest, InfixSuggestersTest, QueryElevationComponentTest,
StatsComponentTest, TestExpandComponent, TestHttpShardHandlerFactory,
Tagger2Test, TaggingAttributeTest, XmlInterpolationTest,
FastVectorHighlighterTest, HighlighterConfigTest, HighlighterTest,
TestPostingsSolrHighlighter, UninvertDocValuesMergePolicyTest,
TestNumericRangeQuery32, TestNumericTokenStream, MetricsConfigTest,
SolrMetricReporterTest, SolrMetricsIntegrationTest, SolrJmxReporterTest,
SimpleFacetsTest, TestIntervalFaceting, TestExportWriter,
TestSolrQueryResponse, TestSubQueryTransformerCrossCore, TestManagedResource,
TestRestManager, TestFieldTypeCollectionResource, TestFieldTypeResource,
TestSchemaResource, TestSerializedLuceneMatchVersion,
TestManagedSynonymGraphFilterFactory, CopyFieldTest, CurrencyFieldTypeTest,
DateFieldTest, DateRangeFieldTest, DocValuesMissingTest,
IndexSchemaRuntimeFieldTest, ManagedSchemaRoundRobinCloudTest,
PrimitiveFieldTypeTest, RequiredFieldsTest, SynonymTokenizerTest,
TestBinaryField, TestBulkSchemaConcurrent, TestCollationField,
TestHalfAndHalfDocValues, TestManagedSchema, TestManagedSchemaAPI,
TestSchemaManager, TestSchemalessBufferedUpdates, TestUseDocValuesAsStored2,
AnalyticsMergeStrategyTest, TestReRankQParserPlugin, TestRealTimeGet,
TestRecovery]
[junit4] Completed [729/819 (1!)] on J0 in 52.80s, 20 tests, 1 failure <<<
FAILURES!
[...truncated 44202 lines...]
[repro] Jenkins log URL:
https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/656/consoleText
[repro] Revision: 17d253262cfc1ca24a13618aa1811b21342be267
[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC"
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr\core
[repro] TestRecovery
[repro] ant compile-test
[...truncated 3344 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5
-Dtests.class="*.TestRecovery" -Dtests.showOutput=onerror
"-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC" -Dtests.seed=980E37160FB7CE65
-Dtests.slow=true -Dtests.locale=es-MX -Dtests.timezone=Africa/Bangui
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[...truncated 169 lines...]
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.search.TestRecovery
[repro] Exiting with code 0
[...truncated 75 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
