Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/331/
Java: 64bit/jdk-12 -XX:+UseCompressedOops -XX:+UseParallelGC
1 tests failed.
FAILED: org.apache.solr.search.TestRecovery.stressLogReplay
Error Message:
mismatch: '72'!='73' @ response/numFound
Stack Trace:
java.lang.RuntimeException: mismatch: '72'!='73' @ response/numFound
at
__randomizedtesting.SeedInfo.seed([26E4275CC210BB7B:E34AC4F51586AC39]:0)
at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:1021)
at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:968)
at
org.apache.solr.search.TestRecovery.stressLogReplay(TestRecovery.java:181)
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:567)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
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:947)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
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:835)
Build Log:
[...truncated 13627 lines...]
[junit4] Suite: org.apache.solr.search.TestRecovery
[junit4] 2> 964311 INFO
(SUITE-TestRecovery-seed#[26E4275CC210BB7B]-worker) [ ] o.a.s.SolrTestCaseJ4
SecureRandom sanity checks: test.solr.allowed.securerandom=null &
java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestRecovery_26E4275CC210BB7B-001/init-core-data-001
[junit4] 2> 964312 WARN
(SUITE-TestRecovery-seed#[26E4275CC210BB7B]-worker) [ ] o.a.s.SolrTestCaseJ4
startTrackingSearchers: numOpens=43 numCloses=43
[junit4] 2> 964312 INFO
(SUITE-TestRecovery-seed#[26E4275CC210BB7B]-worker) [ ] o.a.s.SolrTestCaseJ4
Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 964312 INFO
(SUITE-TestRecovery-seed#[26E4275CC210BB7B]-worker) [ ] o.a.s.SolrTestCaseJ4
Randomized ssl (false) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 964335 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testBuffering
[junit4] 2> 964335 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.SolrTestCaseJ4 updateLog impl=solr.UpdateLog
[junit4] 2> 964335 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 964335 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 964357 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 964373 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 964452 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 964917 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 964920 WARN
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@5b98867b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 964934 WARN
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@2e403be9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 964986 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 964986 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history
in memory.
[junit4] 2> 965006 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb9c5de
[junit4] 2> 965014 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb9c5de
[junit4] 2> 965014 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb9c5de
[junit4] 2> 965018 INFO (coreLoadExecutor-4619-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 965033 INFO (coreLoadExecutor-4619-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 965043 INFO (coreLoadExecutor-4619-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 965107 INFO (coreLoadExecutor-4619-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 965112 INFO (coreLoadExecutor-4619-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 965112 INFO (coreLoadExecutor-4619-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@5bb9c5de
[junit4] 2> 965113 INFO (coreLoadExecutor-4619-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestRecovery_26E4275CC210BB7B-001/init-core-data-001/]
[junit4] 2> 965114 INFO (coreLoadExecutor-4619-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@1606ce89
[junit4] 2> 965236 WARN (coreLoadExecutor-4619-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> 965262 INFO (coreLoadExecutor-4619-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 965262 INFO (coreLoadExecutor-4619-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 965263 INFO (coreLoadExecutor-4619-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 965263 INFO (coreLoadExecutor-4619-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 965269 INFO (coreLoadExecutor-4619-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 965270 INFO (coreLoadExecutor-4619-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@3e353e40[collection1] main]
[junit4] 2> 965270 WARN (coreLoadExecutor-4619-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 965270 INFO (coreLoadExecutor-4619-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 965270 INFO (coreLoadExecutor-4619-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1629535583400361984
[junit4] 2> 965273 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 965273 INFO
(searcherExecutor-4620-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@3e353e40[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 965273 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 965274 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1164318c[collection1] realtime]
[junit4] 2> 965275 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
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> 965275 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1629535583405604864,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 965275 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@44343266
commitCommandVersion:1629535583405604864
[junit4] 2> 965399 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@38089c99[collection1] main]
[junit4] 2> 965399 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 965400 INFO (searcherExecutor-4620-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@38089c99[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 965400 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 125
[junit4] 2> 965401 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.UpdateLog Starting to buffer updates. FSUpdateLog{state=ACTIVE,
tlog=null}
[junit4] 2> 965401 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.UpdateLog Starting to buffer updates. FSUpdateLog{state=ACTIVE,
tlog=null}
[junit4] 2> 965402 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[B1 (3)]} 0 0
[junit4] 2> 965402 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[B11 (4)]} 0 0
[junit4] 2> 965402 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&_version_=-5&wt=json&indent=true}{deleteByQuery=id:B1
id:B11 id:B2 id:B3 (-5)} 0 0
[junit4] 2> 965402 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[B2 (6)]} 0 0
[junit4] 2> 965402 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[B3 (7)]} 0 0
[junit4] 2> 965402 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&_version_=-13&versions=true&wt=json&indent=true}{delete=[B1
(-13)]} 0 0
[junit4] 2> 965402 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=6&wt=xml} status=0 QTime=0
[junit4] 2> 965402 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.DistributedUpdateProcessor Ignoring commit while not ACTIVE - state:
BUFFERING replay: false
[junit4] 2> 965402 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 0
[junit4] 2> 965402 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=6&wt=xml} status=0 QTime=0
[junit4] 2> 965402 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml}
hits=0 status=0 QTime=0
[junit4] 2> 965403 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&id=B3&wt=xml} status=0 QTime=0
[junit4] 2> 965404 WARN (recoveryExecutor-4622-thread-1) [ ]
o.a.s.u.UpdateLog Starting log replay
tlog{file=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestRecovery_26E4275CC210BB7B-001/init-core-data-001/tlog/buffer.tlog.0003620811135886081
refcount=2} active=true starting pos=0 inSortedOrder=false
[junit4] 2> 965661 INFO (recoveryExecutor-4622-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@ba779f0[collection1] realtime]
[junit4] 2> 965662 INFO (recoveryExecutor-4622-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@6913a7d0[collection1] realtime]
[junit4] 2> 965915 INFO (recoveryExecutor-4622-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{flags=2,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 965915 INFO (recoveryExecutor-4622-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@44343266 commitCommandVersion:0
[junit4] 2> 966554 INFO (recoveryExecutor-4622-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@37d00211[collection1] main]
[junit4] 2> 966555 INFO (recoveryExecutor-4622-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 966556 INFO (searcherExecutor-4620-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@37d00211[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(8.1.0):C2:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=12, java.vm.version=12+33,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=12+33, source=flush,
os.version=4.18.0-15-generic,
timestamp=1554046234205}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 966556 INFO (recoveryExecutor-4622-thread-1) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[B1 (3), B11 (4), B2
(6), B3 (7)],deleteByQuery=id:B1 id:B11 id:B2 id:B3 (-5),delete=[B1 (-13)]} 0
1151
[junit4] 2> 966556 INFO (recoveryExecutor-4622-thread-1) [ ]
o.a.s.u.UpdateLog Re-computing max version from index after log re-play.
[junit4] 2> 966558 WARN (recoveryExecutor-4622-thread-1) [ ]
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=4
deletes=1 deleteByQuery=1 errors=0 positionOfStart=0}
[junit4] 2> 966558 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=6&wt=xml} status=0 QTime=0
[junit4] 2> 966558 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml}
hits=2 status=0 QTime=0
[junit4] 2> 966559 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.UpdateLog Starting to buffer updates. FSUpdateLog{state=ACTIVE,
tlog=null}
[junit4] 2> 966559 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&id=B3&wt=xml} status=0 QTime=0
[junit4] 2> 966559 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[B3]} 0 0
[junit4] 2> 966559 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[B4 (8)]} 0 0
[junit4] 2> 966560 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&_version_=-1&versions=true&wt=json&indent=true}{delete=[B4
(-1)]} 0 0
[junit4] 2> 966560 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[B6 (10)]} 0 0
[junit4] 2> 966560 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[B5 (9)]} 0 0
[junit4] 2> 966560 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[B8 (12)]} 0 0
[junit4] 2> 966560 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&_version_=-15&wt=json&indent=true}{deleteByQuery=id:B2
OR id:B8 (-15)} 0 0
[junit4] 2> 966560 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=13&wt=xml} status=0 QTime=0
[junit4] 2> 966566 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[B7 (11)]} 0 6
[junit4] 2> 966567 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&_version_=-2&versions=true&wt=json&indent=true}{delete=[B5
(-2)]} 0 0
[junit4] 2> 966567 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&_version_=-14&versions=true&wt=json&indent=true}{delete=[B6
(-14)]} 0 0
[junit4] 2> 966567 WARN (recoveryExecutor-4622-thread-1) [ ]
o.a.s.u.UpdateLog Starting log replay
tlog{file=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestRecovery_26E4275CC210BB7B-001/init-core-data-001/tlog/buffer.tlog.0003620812293599475
refcount=2} active=true starting pos=0 inSortedOrder=false
[junit4] 2> 966831 INFO (recoveryExecutor-4622-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@5090e294[collection1] realtime]
[junit4] 2> 966831 INFO (recoveryExecutor-4622-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@56bf14b7[collection1] realtime]
[junit4] 2> 967082 INFO (recoveryExecutor-4622-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{flags=2,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 967082 INFO (recoveryExecutor-4622-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@44343266 commitCommandVersion:0
[junit4] 2> 967300 INFO (recoveryExecutor-4622-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@50ce63e4[collection1] main]
[junit4] 2> 967300 INFO (recoveryExecutor-4622-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 967301 INFO (searcherExecutor-4620-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@50ce63e4[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(8.1.0):C2/1:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=12, java.vm.version=12+33,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=12+33, source=flush,
os.version=4.18.0-15-generic,
timestamp=1554046234205}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)
Uninverting(_2(8.1.0):C5/2:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=12, java.vm.version=12+33, lucene.version=8.1.0,
os.arch=amd64, java.runtime.version=12+33, source=flush,
os.version=4.18.0-15-generic,
timestamp=1554046235118}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)))}
[junit4] 2> 967301 INFO (recoveryExecutor-4622-thread-1) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[B3, B4 (8), B6 (10), B5
(9), B8 (12)],delete=[B4 (-1), B5 (-2), B6 (-14)],deleteByQuery=id:B2 OR id:B8
(-15)} 0 734
[junit4] 2> 967301 INFO (recoveryExecutor-4622-thread-1) [ ]
o.a.s.u.UpdateLog Re-computing max version from index after log re-play.
[junit4] 2> 967303 WARN (recoveryExecutor-4622-thread-1) [ ]
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=5
deletes=3 deleteByQuery=1 errors=0 positionOfStart=0}
[junit4] 2> 967303 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&fl=id,_version_&sort=id+asc&wt=xml} hits=4 status=0 QTime=0
[junit4] 2> 967303 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 967304 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=566505479
[junit4] 2> 967304 INFO (coreCloseExecutor-4625-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@44992c22
[junit4] 2> 967304 INFO (coreCloseExecutor-4625-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=44992c22
[junit4] 2> 967304 INFO (coreCloseExecutor-4625-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@62fb3a30: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@20add33f
[junit4] 2> 967386 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 967386 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@44334890: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@28f2b701
[junit4] 2> 967391 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 967391 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@2e989768: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@2253bf9
[junit4] 2> 967394 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 967394 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@3c5316b: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@5a6d0504
[junit4] 2> 967419 INFO
(TEST-TestRecovery.testBuffering-seed#[26E4275CC210BB7B]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testBuffering
[junit4] 2> 967422 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testLogReplay
[junit4] 2> 967422 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.SolrTestCaseJ4 updateLog impl=solr.UpdateLog
[junit4] 2> 967423 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 967423 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 967451 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 967478 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 967600 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 967782 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 967786 WARN
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@18baea84[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 967790 WARN
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@5d321e26[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 967803 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 967803 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history
in memory.
[junit4] 2> 967815 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb9c5de
[junit4] 2> 967824 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb9c5de
[junit4] 2> 967824 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb9c5de
[junit4] 2> 967826 INFO (coreLoadExecutor-4635-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 967839 INFO (coreLoadExecutor-4635-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 967849 INFO (coreLoadExecutor-4635-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 968811 INFO (coreLoadExecutor-4635-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 968817 INFO (coreLoadExecutor-4635-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 968818 INFO (coreLoadExecutor-4635-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@5bb9c5de
[junit4] 2> 968818 INFO (coreLoadExecutor-4635-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestRecovery_26E4275CC210BB7B-001/init-core-data-001/]
[junit4] 2> 968826 INFO (coreLoadExecutor-4635-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@4a01b8ac
[junit4] 2> 968978 WARN (coreLoadExecutor-4635-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> 969008 INFO (coreLoadExecutor-4635-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 969008 INFO (coreLoadExecutor-4635-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 969010 INFO (coreLoadExecutor-4635-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 969010 INFO (coreLoadExecutor-4635-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 969011 INFO (coreLoadExecutor-4635-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 969011 INFO (coreLoadExecutor-4635-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@3d9bd9d4[collection1] main]
[junit4] 2> 969011 WARN (coreLoadExecutor-4635-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 969012 INFO (coreLoadExecutor-4635-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 969012 INFO (coreLoadExecutor-4635-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1629535587324133376
[junit4] 2> 969014 INFO
(searcherExecutor-4636-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@3d9bd9d4[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 969014 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 969015 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 969015 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@a245913[collection1] realtime]
[junit4] 2> 969016 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
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> 969016 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1629535587328327680,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 969016 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@1daa15ba
commitCommandVersion:1629535587328327680
[junit4] 2> 969116 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@3bed8a35[collection1] main]
[junit4] 2> 969116 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 969118 INFO (searcherExecutor-4636-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@3bed8a35[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 969118 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 101
[junit4] 2> 969119 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[A1 (1629535587435282432)]} 0 1
[junit4] 2> 969119 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[A11 (1629535587436331008)]} 0 0
[junit4] 2> 969119 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[A12 (1629535587436331009)]} 0 0
[junit4] 2> 969125 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@29a73a4e[collection1] realtime]
[junit4] 2> 969126 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@638e6299[collection1] realtime]
[junit4] 2> 969127 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{deleteByQuery=id:A11
(-1629535587436331010)} 0 7
[junit4] 2> 969127 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[A13 (1629535587444719616)]} 0 0
[junit4] 2> 969128 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[A12 (1629535587445768192)]} 0 0
[junit4] 2> 969128 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[A12 (1629535587445768193)]} 0 0
[junit4] 2> 969128 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml}
hits=0 status=0 QTime=0
[junit4] 2> 969128 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=7&wt=xml} status=0 QTime=0
[junit4] 2> 969128 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=449818571
[junit4] 2> 969129 INFO (coreCloseExecutor-4641-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@6edcc8c
[junit4] 2> 969129 INFO (coreCloseExecutor-4641-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=6edcc8c
[junit4] 2> 969129 INFO (coreCloseExecutor-4641-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4678879b: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@4bb8cf2b
[junit4] 2> 969139 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 969139 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@79b26794: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@3f50d47
[junit4] 2> 969144 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 969144 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@39c77347: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@2253bf9
[junit4] 2> 969147 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 969147 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@19e1298a: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@5a6d0504
[junit4] 2> 969148 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 969167 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 969174 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 969225 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 969367 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 969372 WARN
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@21eece24[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 969378 WARN
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@669be5bc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 969420 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 969420 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history
in memory.
[junit4] 2> 969432 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb9c5de
[junit4] 2> 969441 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb9c5de
[junit4] 2> 969441 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb9c5de
[junit4] 2> 969443 INFO (coreLoadExecutor-4651-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 969458 INFO (coreLoadExecutor-4651-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 969467 INFO (coreLoadExecutor-4651-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 969538 INFO (coreLoadExecutor-4651-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 969545 INFO (coreLoadExecutor-4651-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 969546 INFO (coreLoadExecutor-4651-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@5bb9c5de
[junit4] 2> 969546 INFO (coreLoadExecutor-4651-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestRecovery_26E4275CC210BB7B-001/init-core-data-001/]
[junit4] 2> 969562 WARN (coreLoadExecutor-4651-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> 969594 INFO (coreLoadExecutor-4651-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 969594 INFO (coreLoadExecutor-4651-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 969596 INFO (coreLoadExecutor-4651-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 969596 INFO (coreLoadExecutor-4651-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 969597 INFO (coreLoadExecutor-4651-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@720a50d7
[junit4] 2> 969616 INFO (coreLoadExecutor-4651-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@50ab693e[collection1] main]
[junit4] 2> 969616 WARN (coreLoadExecutor-4651-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 969616 INFO (coreLoadExecutor-4651-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 969618 INFO
(searcherExecutor-4652-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@50ab693e[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 969620 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml}
hits=0 status=0 QTime=0
[junit4] 2> 969622 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=7&wt=xml} status=0 QTime=2
[junit4] 2> 969623 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=7&wt=xml} status=0 QTime=0
[junit4] 2> 969623 WARN
(recoveryExecutor-4654-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Starting log replay
tlog{file=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestRecovery_26E4275CC210BB7B-001/init-core-data-001/tlog/tlog.0000000000000000001
refcount=2} active=false starting pos=0 inSortedOrder=false
[junit4] 2> 969880 INFO
(recoveryExecutor-4654-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@535c31b7[collection1] realtime]
[junit4] 2> 969880 INFO
(recoveryExecutor-4654-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@34c64dd6[collection1] realtime]
[junit4] 2> 970131 INFO
(recoveryExecutor-4654-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> 970131 INFO
(recoveryExecutor-4654-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@268e7017 commitCommandVersion:0
[junit4] 2> 970902 INFO
(recoveryExecutor-4654-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@606482d3[collection1] main]
[junit4] 2> 970902 INFO
(recoveryExecutor-4654-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 970904 INFO
(searcherExecutor-4652-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@606482d3[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(8.1.0):C3/2:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=12, java.vm.version=12+33,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=12+33, source=flush,
os.version=4.18.0-15-generic,
timestamp=1554046238166}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)
Uninverting(_2(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=12, java.vm.version=12+33, lucene.version=8.1.0,
os.arch=amd64, java.runtime.version=12+33, source=flush,
os.version=4.18.0-15-generic,
timestamp=1554046238422}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:fieldInfosGen=1:dvGen=2)))}
[junit4] 2> 970908 INFO
(recoveryExecutor-4654-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[A1
(1629535587435282432), A11 (1629535587436331008), A12 (1629535587436331009),
A13 (1629535587444719616), A12 (1629535587445768192), A12
(1629535587445768193)],deleteByQuery=id:A11 (-1629535587436331010)} 0 1285
[junit4] 2> 970908 WARN
(recoveryExecutor-4654-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=6
deletes=0 deleteByQuery=1 errors=0 positionOfStart=0}
[junit4] 2> 970909 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=val_i_dvo:2&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 970909 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml}
hits=3 status=0 QTime=0
[junit4] 2> 970909 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=7&wt=xml} status=0 QTime=0
[junit4] 2> 970914 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[A2 (1629535589313282048)]} 0 5
[junit4] 2> 970915 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[A3 (1629535589319573504)]} 0 0
[junit4] 2> 970915 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{delete=[A2 (-1629535589319573505)]} 0 0
[junit4] 2> 970915 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[A4 (1629535589319573506)]} 0 0
[junit4] 2> 970915 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml}
hits=3 status=0 QTime=0
[junit4] 2> 970915 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=val_i_dvo:2&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 970916 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=6846563
[junit4] 2> 970942 INFO (coreCloseExecutor-4657-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@3bcfb1e9
[junit4] 2> 970942 INFO (coreCloseExecutor-4657-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=3bcfb1e9
[junit4] 2> 970942 INFO (coreCloseExecutor-4657-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@440c7e57: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@464b16ef
[junit4] 2> 970986 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 970986 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@54b8daa5: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@11cb3089
[junit4] 2> 970991 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 970991 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5cf7eb51: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@2253bf9
[junit4] 2> 970994 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 970994 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1248c684: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@5a6d0504
[junit4] 2> 971018 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 971033 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 971052 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 971171 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 971278 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 971294 WARN
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@2e5d9f33[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 971326 WARN
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@1417f769[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 971353 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 971354 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history
in memory.
[junit4] 2> 971366 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb9c5de
[junit4] 2> 971374 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb9c5de
[junit4] 2> 971375 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb9c5de
[junit4] 2> 971376 INFO (coreLoadExecutor-4667-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 971390 INFO (coreLoadExecutor-4667-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 971399 INFO (coreLoadExecutor-4667-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 971481 INFO (coreLoadExecutor-4667-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 971487 INFO (coreLoadExecutor-4667-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 971487 INFO (coreLoadExecutor-4667-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@5bb9c5de
[junit4] 2> 971487 INFO (coreLoadExecutor-4667-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestRecovery_26E4275CC210BB7B-001/init-core-data-001/]
[junit4] 2> 971489 WARN (coreLoadExecutor-4667-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> 971509 INFO (coreLoadExecutor-4667-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 971509 INFO (coreLoadExecutor-4667-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 971511 INFO (coreLoadExecutor-4667-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 971511 INFO (coreLoadExecutor-4667-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 971512 INFO (coreLoadExecutor-4667-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@690152cb
[junit4] 2> 971514 INFO (coreLoadExecutor-4667-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@18f83ba[collection1]
main]
[junit4] 2> 971514 WARN (coreLoadExecutor-4667-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 971514 INFO (coreLoadExecutor-4667-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 971516 WARN
(recoveryExecutor-4670-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Starting log replay
tlog{file=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestRecovery_26E4275CC210BB7B-001/init-core-data-001/tlog/tlog.0000000000000000003
refcount=2} active=false starting pos=0 inSortedOrder=false
[junit4] 2> 971516 INFO
(searcherExecutor-4668-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@18f83ba[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(8.1.0):C3/2:[diagnostics={java.runtime.version=12+33,
java.vendor=Oracle Corporation, java.version=12, java.vm.version=12+33,
lucene.version=8.1.0, os=Linux, os.arch=amd64, os.version=4.18.0-15-generic,
source=flush,
timestamp=1554046238166}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)
Uninverting(_2(8.1.0):C2:[diagnostics={java.runtime.version=12+33,
java.vendor=Oracle Corporation, java.version=12, java.vm.version=12+33,
lucene.version=8.1.0, os=Linux, os.arch=amd64, os.version=4.18.0-15-generic,
source=flush,
timestamp=1554046238422}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:fieldInfosGen=1:dvGen=2)))}
[junit4] 2> 971767 INFO
(recoveryExecutor-4670-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> 971767 INFO
(recoveryExecutor-4670-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@534943c7 commitCommandVersion:0
[junit4] 2> 972637 INFO
(recoveryExecutor-4670-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@72416d0d[collection1] main]
[junit4] 2> 972637 INFO
(recoveryExecutor-4670-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 972638 INFO
(searcherExecutor-4668-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@72416d0d[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(8.1.0):C3/2:[diagnostics={java.runtime.version=12+33,
java.vendor=Oracle Corporation, java.version=12, java.vm.version=12+33,
lucene.version=8.1.0, os=Linux, os.arch=amd64, os.version=4.18.0-15-generic,
source=flush,
timestamp=1554046238166}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)
Uninverting(_2(8.1.0):C2:[diagnostics={java.runtime.version=12+33,
java.vendor=Oracle Corporation, java.version=12, java.vm.version=12+33,
lucene.version=8.1.0, os=Linux, os.arch=amd64, os.version=4.18.0-15-generic,
source=flush,
timestamp=1554046238422}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:fieldInfosGen=1:dvGen=2)
Uninverting(_3(8.1.0):C3/1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=12, java.vm.version=12+33, lucene.version=8.1.0,
os.arch=amd64, java.runtime.version=12+33, source=flush,
os.version=4.18.0-15-generic,
timestamp=1554046240057}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)))}
[junit4] 2> 972638 INFO
(recoveryExecutor-4670-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[A2
(1629535589313282048), A3 (1629535589319573504), A4
(1629535589319573506)],delete=[A2 (-1629535589319573505)]} 0 1122
[junit4] 2> 972638 WARN
(recoveryExecutor-4670-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=3
deletes=1 deleteByQuery=0 errors=0 positionOfStart=0}
[junit4] 2> 972638 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml}
hits=5 status=0 QTime=0
[junit4] 2> 972639 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:A2&wt=xml}
hits=0 status=0 QTime=0
[junit4] 2> 972639 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1238549567
[junit4] 2> 972639 INFO (coreCloseExecutor-4673-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@3fab608a
[junit4] 2> 972639 INFO (coreCloseExecutor-4673-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=3fab608a
[junit4] 2> 972639 INFO (coreCloseExecutor-4673-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7516e3d5: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@40f66a13
[junit4] 2> 972657 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 972657 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@75948950: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@103261d3
[junit4] 2> 972662 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 972662 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4f794b45: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@2253bf9
[junit4] 2> 972665 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 972665 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@371395a7: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@5a6d0504
[junit4] 2> 972666 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 972679 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 972688 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 972757 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 972877 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 972882 WARN
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@3588a2dd[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 972887 WARN
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@2f820eab[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 972897 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 972897 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history
in memory.
[junit4] 2> 972909 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb9c5de
[junit4] 2> 972917 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb9c5de
[junit4] 2> 972918 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb9c5de
[junit4] 2> 972919 INFO (coreLoadExecutor-4683-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 972932 INFO (coreLoadExecutor-4683-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 972942 INFO (coreLoadExecutor-4683-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 973007 INFO (coreLoadExecutor-4683-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 973012 INFO (coreLoadExecutor-4683-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 973013 INFO (coreLoadExecutor-4683-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@5bb9c5de
[junit4] 2> 973013 INFO (coreLoadExecutor-4683-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestRecovery_26E4275CC210BB7B-001/init-core-data-001/]
[junit4] 2> 973015 WARN (coreLoadExecutor-4683-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> 973043 INFO (coreLoadExecutor-4683-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 973043 INFO (coreLoadExecutor-4683-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 973045 INFO (coreLoadExecutor-4683-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 973045 INFO (coreLoadExecutor-4683-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 973046 INFO (coreLoadExecutor-4683-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@7e8d3636
[junit4] 2> 973050 INFO (coreLoadExecutor-4683-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@18e71614[collection1] main]
[junit4] 2> 973050 WARN (coreLoadExecutor-4683-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 973050 INFO (coreLoadExecutor-4683-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 973054 INFO
(searcherExecutor-4684-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@18e71614[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(8.1.0):C3/2:[diagnostics={java.runtime.version=12+33,
java.vendor=Oracle Corporation, java.version=12, java.vm.version=12+33,
lucene.version=8.1.0, os=Linux, os.arch=amd64, os.version=4.18.0-15-generic,
source=flush,
timestamp=1554046238166}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)
Uninverting(_2(8.1.0):C2:[diagnostics={java.runtime.version=12+33,
java.vendor=Oracle Corporation, java.version=12, java.vm.version=12+33,
lucene.version=8.1.0, os=Linux, os.arch=amd64, os.version=4.18.0-15-generic,
source=flush,
timestamp=1554046238422}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:fieldInfosGen=1:dvGen=2)
Uninverting(_3(8.1.0):C3/1:[diagnostics={java.runtime.version=12+33,
java.vendor=Oracle Corporation, java.version=12, java.vm.version=12+33,
lucene.version=8.1.0, os=Linux, os.arch=amd64, os.version=4.18.0-15-generic,
source=flush,
timestamp=1554046240057}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)))}
[junit4] 2> 973054 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml}
hits=5 status=0 QTime=1
[junit4] 2> 973054 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=val_i_dvo:2&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 973157 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 973158 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1399424187
[junit4] 2> 973159 INFO (coreCloseExecutor-4689-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@16b90d6
[junit4] 2> 973159 INFO (coreCloseExecutor-4689-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=16b90d6
[junit4] 2> 973159 INFO (coreCloseExecutor-4689-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1582a8c4: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@7be7d031
[junit4] 2> 973214 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 973214 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4c8f871c: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@25795723
[junit4] 2> 973219 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 973219 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@463c7f5f: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@2253bf9
[junit4] 2> 973223 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 973223 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@70b120f1: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@5a6d0504
[junit4] 2> 973247 INFO
(TEST-TestRecovery.testLogReplay-seed#[26E4275CC210BB7B]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testLogReplay
[junit4] 2> 973250 INFO
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testTruncatedLog
[junit4] 2> 973250 INFO
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.a.s.SolrTestCaseJ4 updateLog impl=solr.UpdateLog
[junit4] 2> 973250 INFO
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 973250 INFO
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 973273 INFO
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 973320 INFO
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 973475 INFO
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 973669 INFO
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 973688 WARN
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@596716c6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 973719 WARN
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@5151b1fb[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 973753 INFO
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 973754 INFO
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history
in memory.
[junit4] 2> 973766 INFO
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb9c5de
[junit4] 2> 973777 INFO
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb9c5de
[junit4] 2> 973777 INFO
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb9c5de
[junit4] 2> 973794 INFO (coreLoadExecutor-4699-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 973869 INFO (coreLoadExecutor-4699-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 973879 INFO (coreLoadExecutor-4699-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 973972 INFO (coreLoadExecutor-4699-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 973978 INFO (coreLoadExecutor-4699-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 973978 INFO (coreLoadExecutor-4699-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@5bb9c5de
[junit4] 2> 973978 INFO (coreLoadExecutor-4699-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestRecovery_26E4275CC210BB7B-001/init-core-data-001/]
[junit4] 2> 973981 INFO (coreLoadExecutor-4699-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@afea19f
[junit4] 2> 974105 WARN (coreLoadExecutor-4699-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> 974159 INFO (coreLoadExecutor-4699-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 974159 INFO (coreLoadExecutor-4699-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 974161 INFO (coreLoadExecutor-4699-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 974161 INFO (coreLoadExecutor-4699-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 974162 INFO (coreLoadExecutor-4699-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 974162 INFO (coreLoadExecutor-4699-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@5f80fcbd[collection1] main]
[junit4] 2> 974162 WARN (coreLoadExecutor-4699-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 974163 INFO (coreLoadExecutor-4699-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 974163 INFO (coreLoadExecutor-4699-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1629535592725348352
[junit4] 2> 974165 INFO
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 974165 INFO
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 974170 INFO
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@289727c1[collection1] realtime]
[junit4] 2> 974170 INFO
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
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 4
[junit4] 2> 974170 INFO
(TEST-TestRecovery.testTruncatedLog-seed#[26E4275CC210BB7B]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1629535592732688384,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCom
[...truncated too long message...]
1016217 INFO (recoveryExecutor-5330-thread-1-processing-x:collection1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@47194f5e[collection1] main]
[junit4] 2> 1016217 INFO
(recoveryExecutor-5330-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1016218 INFO
(searcherExecutor-5328-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@47194f5e[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(8.1.0):C6/3:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=12, java.vm.version=12+33,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=12+33, source=flush,
os.version=4.18.0-15-generic,
timestamp=1554046284066}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)
Uninverting(_3(8.1.0):C3:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=12, java.vm.version=12+33, lucene.version=8.1.0,
os.arch=amd64, java.runtime.version=12+33, source=flush,
os.version=4.18.0-15-generic,
timestamp=1554046284320}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 1016218 INFO
(recoveryExecutor-5330-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[RDBQ2_1 (71), RDBQ2_2
(74), RDBQ2_3 (72), RDBQ2_4 (75)],deleteByQuery=_root_:RDBQ2_1 _root_:RDBQ2_2
id:RDBQ2_3 _root_:RDBQ2_4 (-73)} 0 700
[junit4] 2> 1016218 WARN
(recoveryExecutor-5330-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> 1016218 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[26E4275CC210BB7B])
[ 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> 1016218 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[26E4275CC210BB7B])
[ x:collection1] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1016218 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[26E4275CC210BB7B])
[ x:collection1] o.a.s.c.CoreContainer Shutting down CoreContainer
instance=3485015
[junit4] 2> 1016221 INFO
(coreCloseExecutor-5333-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@7d1a825e
[junit4] 2> 1016222 INFO
(coreCloseExecutor-5333-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=7d1a825e
[junit4] 2> 1016222 INFO
(coreCloseExecutor-5333-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6d2c00e4: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@653e8287
[junit4] 2> 1016242 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[26E4275CC210BB7B])
[ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.node, tag=null
[junit4] 2> 1016242 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[26E4275CC210BB7B])
[ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@31712f21: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@408ab63
[junit4] 2> 1016246 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[26E4275CC210BB7B])
[ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jvm, tag=null
[junit4] 2> 1016246 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[26E4275CC210BB7B])
[ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@488a77cb: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@2253bf9
[junit4] 2> 1016250 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[26E4275CC210BB7B])
[ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jetty, tag=null
[junit4] 2> 1016250 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[26E4275CC210BB7B])
[ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@12122121: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@5a6d0504
[junit4] 2> 1016254 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[26E4275CC210BB7B])
[ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending
testLogReplayWithReorderedDBQByAsterixAndChildDocs
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestRecovery_26E4275CC210BB7B-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene80):
{_root_=PostingsFormat(name=LuceneVarGapFixedInterval),
id=Lucene50(blocksize=128)}, docValues:{_version_=DocValuesFormat(name=Direct),
val_i_dvo=DocValuesFormat(name=Lucene80), val_i=DocValuesFormat(name=Lucene80),
_root_=DocValuesFormat(name=Direct), id=DocValuesFormat(name=Lucene80)},
maxPointsInLeafNode=1680, maxMBSortInHeap=6.585535443532822,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@7d864446),
locale=uz-Arab, timezone=America/Costa_Rica
[junit4] 2> NOTE: Linux 4.18.0-15-generic amd64/Oracle Corporation 12
(64-bit)/cpus=8,threads=1,free=199756640,total=510656512
[junit4] 2> NOTE: All tests run in this JVM: [DataDrivenBlockJoinTest,
DistributedQueueTest, ZkCLITest, TestSolrCloudWithKerberosAlt,
BigEndianAscendingWordDeserializerTest, TestDynamicFieldResource,
TestManagedSynonymFilterFactory, FacetPivotSmallTest,
ShowFileRequestHandlerTest, TestSimExtremeIndexing, UUIDFieldTest,
TestStandardQParsers, TestJavabinTupleStreamParser, CursorPagingTest,
AsyncCallRequestStatusResponseTest, TestCloudSearcherWarming,
SolrJmxReporterTest, TestLeaderElectionWithEmptyReplica,
CustomHighlightComponentTest, TestInPlaceUpdatesDistrib,
NotRequiredUniqueKeyTest, BlockJoinFacetDistribTest, HealthCheckHandlerTest,
CopyFieldTest, TestSubQueryTransformer, SynonymTokenizerTest,
TestAuthenticationFramework, TestFunctionQuery, TestFoldingMultitermQuery,
AddReplicaTest, SimplePostToolTest, TestDocBasedVersionConstraints,
CustomCollectionTest, TestFieldTypeCollectionResource,
RecoveryAfterSoftCommitTest, LeaderElectionTest, NodeAddedTriggerTest,
ReplicationFactorTest, TestRandomDVFaceting, TaggingAttributeTest,
TestLegacyBM25SimilarityFactory, TestSolrConfigHandler,
TestIBSimilarityFactory, TestReqParamsAPI, TestRuleBasedAuthorizationPlugin,
TestAtomicUpdateErrorCases, TestPullReplica, TestWordDelimiterFilterFactory,
AlternateDirectoryTest, SearchRateTriggerTest, DistributedFacetPivotLargeTest,
DistributedSpellCheckComponentTest, TestSQLHandlerNonCloud, ZkNodePropsTest,
TestPointFields, TestPostingsSolrHighlighter,
TriggerSetPropertiesIntegrationTest, TestJettySolrRunner,
FieldMutatingUpdateProcessorTest, TestSurroundQueryParser,
HdfsRecoverLeaseTest, TestReloadDeadlock, SolrShardReporterTest,
DefaultValueUpdateProcessorTest, TestDistributedMissingSort,
CollectionsAPISolrJTest, TestJsonFacetsStatsParsing, TestSolrJ, AssignTest,
TestMaxTokenLenTokenizer, TestClassicSimilarityFactory,
HdfsUnloadDistributedZkTest, TestGroupingSearch,
TestSerializedLuceneMatchVersion, TestHdfsCloudBackupRestore,
OverseerTaskQueueTest, TestDocTermOrds, TestIndexSearcher, DocValuesTest,
HdfsDirectoryFactoryTest, IndexSchemaRuntimeFieldTest,
CollectionsAPIAsyncDistributedZkTest, RAMDirectoryFactoryTest,
TestDeprecatedFilters, TestSolr4Spatial2, TestStressReorder, SampleTest,
MetricTriggerIntegrationTest, TestLRUCache, GraphQueryTest,
TestSimTriggerIntegration, TestSimpleQParserPlugin, TestLegacyTerms,
MetricsHistoryIntegrationTest, TestSystemCollAutoCreate,
TestIndexingPerformance, VersionInfoTest, TestSSLRandomization,
TestApiFramework, BufferStoreTest, TestReloadAndDeleteDocs, SimpleFacetsTest,
TestRecovery]
[junit4] Completed [252/846 (1!)] on J0 in 52.10s, 20 tests, 1 error <<<
FAILURES!
[...truncated 44568 lines...]
[repro] Jenkins log URL:
https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/331/consoleText
[repro] Revision: ae95487db69a730ebec7ee5c8f562dccdeb6611f
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseParallelGC"
[repro] Repro line: ant test -Dtestcase=TestRecovery
-Dtests.method=stressLogReplay -Dtests.seed=26E4275CC210BB7B
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=uz-Arab
-Dtests.timezone=America/Costa_Rica -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr/core
[repro] TestRecovery
[repro] ant compile-test
[...truncated 3581 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5
-Dtests.class="*.TestRecovery" -Dtests.showOutput=onerror
"-Dargs=-XX:+UseCompressedOops -XX:+UseParallelGC"
-Dtests.seed=26E4275CC210BB7B -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.locale=uz-Arab -Dtests.timezone=America/Costa_Rica -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[...truncated 170 lines...]
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.search.TestRecovery
[repro] Exiting with code 0
[...truncated 43 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
