Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/1507/
1 tests failed.
FAILED:
org.apache.solr.handler.TestReplicationHandler.doTestReplicateAfterCoreReload
Error Message:
expected:<[{indexVersion=1521516546070,generation=2,filelist=[_b5.cfe, _b5.cfs,
_b5.si, _ba.fdt, _ba.fdx, _ba.fnm, _ba.nvd, _ba.nvm, _ba.si, _ba_FST50_0.doc,
_ba_FST50_0.tfp, _bb.cfe, _bb.cfs, _bb.si, _bc.fdt, _bc.fdx, _bc.fnm, _bc.nvd,
_bc.nvm, _bc.si, _bc_FST50_0.doc, _bc_FST50_0.tfp, _bd.fdt, _bd.fdx, _bd.fnm,
_bd.nvd, _bd.nvm, _bd.si, _bd_FST50_0.doc, _bd_FST50_0.tfp, _bf.fdt, _bf.fdx,
_bf.fnm, _bf.nvd, _bf.nvm, _bf.si, _bf_FST50_0.doc, _bf_FST50_0.tfp, _bg.fdt,
_bg.fdx, _bg.fnm, _bg.nvd, _bg.nvm, _bg.si, _bg_FST50_0.doc, _bg_FST50_0.tfp,
segments_2]}]> but
was:<[{indexVersion=1521516546070,generation=2,filelist=[_b5.cfe, _b5.cfs,
_b5.si, _ba.fdt, _ba.fdx, _ba.fnm, _ba.nvd, _ba.nvm, _ba.si, _ba_FST50_0.doc,
_ba_FST50_0.tfp, _bb.cfe, _bb.cfs, _bb.si, _bc.fdt, _bc.fdx, _bc.fnm, _bc.nvd,
_bc.nvm, _bc.si, _bc_FST50_0.doc, _bc_FST50_0.tfp, _bd.fdt, _bd.fdx, _bd.fnm,
_bd.nvd, _bd.nvm, _bd.si, _bd_FST50_0.doc, _bd_FST50_0.tfp, _bf.fdt, _bf.fdx,
_bf.fnm, _bf.nvd, _bf.nvm, _bf.si, _bf_FST50_0.doc, _bf_FST50_0.tfp, _bg.fdt,
_bg.fdx, _bg.fnm, _bg.nvd, _bg.nvm, _bg.si, _bg_FST50_0.doc, _bg_FST50_0.tfp,
segments_2]}, {indexVersion=1521516546070,generation=3,filelist=[_be.cfe,
_be.cfs, _be.si, _bf.fdt, _bf.fdx, _bf.fnm, _bf.nvd, _bf.nvm, _bf.si,
_bf_FST50_0.doc, _bf_FST50_0.tfp, _bg.fdt, _bg.fdx, _bg.fnm, _bg.nvd, _bg.nvm,
_bg.si, _bg_FST50_0.doc, _bg_FST50_0.tfp, segments_3]}]>
Stack Trace:
java.lang.AssertionError:
expected:<[{indexVersion=1521516546070,generation=2,filelist=[_b5.cfe, _b5.cfs,
_b5.si, _ba.fdt, _ba.fdx, _ba.fnm, _ba.nvd, _ba.nvm, _ba.si, _ba_FST50_0.doc,
_ba_FST50_0.tfp, _bb.cfe, _bb.cfs, _bb.si, _bc.fdt, _bc.fdx, _bc.fnm, _bc.nvd,
_bc.nvm, _bc.si, _bc_FST50_0.doc, _bc_FST50_0.tfp, _bd.fdt, _bd.fdx, _bd.fnm,
_bd.nvd, _bd.nvm, _bd.si, _bd_FST50_0.doc, _bd_FST50_0.tfp, _bf.fdt, _bf.fdx,
_bf.fnm, _bf.nvd, _bf.nvm, _bf.si, _bf_FST50_0.doc, _bf_FST50_0.tfp, _bg.fdt,
_bg.fdx, _bg.fnm, _bg.nvd, _bg.nvm, _bg.si, _bg_FST50_0.doc, _bg_FST50_0.tfp,
segments_2]}]> but
was:<[{indexVersion=1521516546070,generation=2,filelist=[_b5.cfe, _b5.cfs,
_b5.si, _ba.fdt, _ba.fdx, _ba.fnm, _ba.nvd, _ba.nvm, _ba.si, _ba_FST50_0.doc,
_ba_FST50_0.tfp, _bb.cfe, _bb.cfs, _bb.si, _bc.fdt, _bc.fdx, _bc.fnm, _bc.nvd,
_bc.nvm, _bc.si, _bc_FST50_0.doc, _bc_FST50_0.tfp, _bd.fdt, _bd.fdx, _bd.fnm,
_bd.nvd, _bd.nvm, _bd.si, _bd_FST50_0.doc, _bd_FST50_0.tfp, _bf.fdt, _bf.fdx,
_bf.fnm, _bf.nvd, _bf.nvm, _bf.si, _bf_FST50_0.doc, _bf_FST50_0.tfp, _bg.fdt,
_bg.fdx, _bg.fnm, _bg.nvd, _bg.nvm, _bg.si, _bg_FST50_0.doc, _bg_FST50_0.tfp,
segments_2]}, {indexVersion=1521516546070,generation=3,filelist=[_be.cfe,
_be.cfs, _be.si, _bf.fdt, _bf.fdx, _bf.fnm, _bf.nvd, _bf.nvm, _bf.si,
_bf_FST50_0.doc, _bf_FST50_0.tfp, _bg.fdt, _bg.fdx, _bg.fnm, _bg.nvd, _bg.nvm,
_bg.si, _bg_FST50_0.doc, _bg_FST50_0.tfp, segments_3]}]>
at
__randomizedtesting.SeedInfo.seed([994682F94E7E11:254E5DB289067012]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:147)
at
org.apache.solr.handler.TestReplicationHandler.doTestReplicateAfterCoreReload(TestReplicationHandler.java:1284)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
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.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 1917 lines...]
[junit4] JVM J0: stdout was not empty, see:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/lucene/build/core/test/temp/junit4-J0-20180320_000215_951446106469762539343.sysout
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] codec: DummyCompressingStoredFields, pf: BlockTreeOrds, dvf: Direct
[junit4] <<< JVM J0: EOF ----
[...truncated 10926 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/init-core-data-001
[junit4] 2> 72845 WARN
(SUITE-TestReplicationHandler-seed#[994682F94E7E11]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=7 numCloses=7
[junit4] 2> 72845 INFO
(SUITE-TestReplicationHandler-seed#[994682F94E7E11]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 72850 INFO
(SUITE-TestReplicationHandler-seed#[994682F94E7E11]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
[junit4] 2> 72850 INFO
(SUITE-TestReplicationHandler-seed#[994682F94E7E11]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 72864 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting doTestDetails
[junit4] 2> 72865 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-001/collection1
[junit4] 2> 72870 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 29-11-21T22:27:37+01:00,
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 72877 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 72877 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 72877 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 72878 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@3ebe13fb{/solr,null,AVAILABLE}
[junit4] 2> 72881 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@53653956{HTTP/1.1,[http/1.1]}{127.0.0.1:41047}
[junit4] 2> 72881 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.Server Started @75879ms
[junit4] 2> 72881 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-001/collection1/data,
hostContext=/solr, hostPort=41047}
[junit4] 2> 72882 ERROR
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 72882 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 72882 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on
port null
[junit4] 2> 72882 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 72882 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-03-20T03:24:21.735Z
[junit4] 2> 72883 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-001/solr.xml
[junit4] 2> 72887 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 72887 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 72889 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@3088a30, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 72994 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3088a30
[junit4] 2> 73007 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3088a30
[junit4] 2> 73007 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3088a30
[junit4] 2> 73011 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-001/.
[junit4] 2> 73012 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 73075 INFO (coreLoadExecutor-184-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 73114 INFO (coreLoadExecutor-184-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 73158 INFO (coreLoadExecutor-184-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 73160 INFO (coreLoadExecutor-184-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 73160 INFO (coreLoadExecutor-184-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-001/./collection1,
trusted=true
[junit4] 2> 73161 INFO (coreLoadExecutor-184-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@3088a30
[junit4] 2> 73161 INFO (coreLoadExecutor-184-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 73161 INFO (coreLoadExecutor-184-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-001/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-001/./collection1/data/]
[junit4] 2> 73164 INFO (coreLoadExecutor-184-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=9, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 73297 INFO (coreLoadExecutor-184-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 73297 INFO (coreLoadExecutor-184-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 73298 INFO (coreLoadExecutor-184-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=5, maxMergeAtOnceExplicit=6, maxMergedSegmentMB=76.96484375,
floorSegmentMB=1.7119140625, forceMergeDeletesPctAllowed=26.370069809110724,
segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 73299 INFO (coreLoadExecutor-184-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@3fecaec6[collection1] main]
[junit4] 2> 73300 INFO (coreLoadExecutor-184-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to
use dir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-001/collection1/conf
[junit4] 2> 73301 INFO (coreLoadExecutor-184-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following
config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 73301 INFO (coreLoadExecutor-184-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 73306 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-002/collection1
[junit4] 2> 73307 INFO
(searcherExecutor-185-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@3fecaec6[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 73309 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 29-11-21T22:27:37+01:00,
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 73352 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 73352 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 73352 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 73353 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@8a37ed0{/solr,null,AVAILABLE}
[junit4] 2> 73355 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@d71a32{HTTP/1.1,[http/1.1]}{127.0.0.1:44854}
[junit4] 2> 73355 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.Server Started @76353ms
[junit4] 2> 73355 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-002/collection1/data,
hostContext=/solr, hostPort=44854}
[junit4] 2> 73355 ERROR
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 73355 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 73355 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on
port null
[junit4] 2> 73355 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 73362 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-03-20T03:24:22.215Z
[junit4] 2> 73362 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-002/solr.xml
[junit4] 2> 73369 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 73369 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 73370 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@3088a30, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 73451 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3088a30
[junit4] 2> 73465 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3088a30
[junit4] 2> 73466 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3088a30
[junit4] 2> 73469 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-002/.
[junit4] 2> 73469 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 73470 INFO (coreLoadExecutor-194-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 73522 INFO (coreLoadExecutor-194-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 73531 INFO (coreLoadExecutor-194-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 73534 INFO (coreLoadExecutor-194-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 73534 INFO (coreLoadExecutor-194-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-002/./collection1,
trusted=true
[junit4] 2> 73534 INFO (coreLoadExecutor-194-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@3088a30
[junit4] 2> 73534 INFO (coreLoadExecutor-194-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 73535 INFO (coreLoadExecutor-194-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-002/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-002/./collection1/data/]
[junit4] 2> 73537 INFO (coreLoadExecutor-194-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=9, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 73617 INFO (coreLoadExecutor-194-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 73617 INFO (coreLoadExecutor-194-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 73618 INFO (coreLoadExecutor-194-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=5, maxMergeAtOnceExplicit=6, maxMergedSegmentMB=76.96484375,
floorSegmentMB=1.7119140625, forceMergeDeletesPctAllowed=26.370069809110724,
segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 73619 INFO (coreLoadExecutor-194-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@3f969362[collection1] main]
[junit4] 2> 73619 INFO (coreLoadExecutor-194-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to
use dir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-002/collection1/conf
[junit4] 2> 73626 INFO (coreLoadExecutor-194-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of
1000ms
[junit4] 2> 73626 INFO (coreLoadExecutor-194-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 73630 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@d71a32{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 73630 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=352732885
[junit4] 2> 73630 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 73630 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@15a9174c: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@3aa55de7
[junit4] 2> 73630 INFO
(searcherExecutor-195-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@3f969362[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 73635 INFO (qtp1607989753-527) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
QTime=2
[junit4] 2> 73643 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 73643 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@753af2b7: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@7f0330e8
[junit4] 2> 73646 INFO (indexFetcher-199-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Master's generation: 1
[junit4] 2> 73646 INFO (indexFetcher-199-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Master's version: 0
[junit4] 2> 73646 INFO (indexFetcher-199-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 73646 INFO (indexFetcher-199-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Slave's version: 0
[junit4] 2> 73646 INFO (indexFetcher-199-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher New index in Master. Deleting mine...
[junit4] 2> 73650 INFO (indexFetcher-199-thread-1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 73650 INFO (indexFetcher-199-thread-1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@61058446 commitCommandVersion:0
[junit4] 2> 73652 INFO (indexFetcher-199-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@5c38e1b3[collection1] main]
[junit4] 2> 73655 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 73655 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1d92d01f: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@2a12eea1
[junit4] 2> 73656 INFO (indexFetcher-199-thread-1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 73656 INFO
(searcherExecutor-195-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@5c38e1b3[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 73657 INFO (coreCloseExecutor-200-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@22a1fb25
[junit4] 2> 73657 INFO (coreCloseExecutor-200-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=581040933
[junit4] 2> 73657 INFO (coreCloseExecutor-200-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@436f0002: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@71e58899
[junit4] 2> 73673 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@8a37ed0{/solr,null,UNAVAILABLE}
[junit4] 2> 73673 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 73675 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 29-11-21T22:27:37+01:00,
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 73676 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 73676 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 73676 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 73677 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@456e2ace{/solr,null,AVAILABLE}
[junit4] 2> 73677 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@41c82860{HTTP/1.1,[http/1.1]}{127.0.0.1:45861}
[junit4] 2> 73677 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.Server Started @76675ms
[junit4] 2> 73677 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-002/collection1/data,
hostContext=/solr, hostPort=45861}
[junit4] 2> 73678 ERROR
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 73678 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 73678 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on
port null
[junit4] 2> 73678 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 73678 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-03-20T03:24:22.531Z
[junit4] 2> 73678 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-002/solr.xml
[junit4] 2> 73683 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 73683 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 73684 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@3088a30, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 73734 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3088a30
[junit4] 2> 73759 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3088a30
[junit4] 2> 73760 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3088a30
[junit4] 2> 73763 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-002/.
[junit4] 2> 73763 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 73763 INFO (coreLoadExecutor-207-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 73780 INFO (coreLoadExecutor-207-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 73790 INFO (coreLoadExecutor-207-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 73792 INFO (coreLoadExecutor-207-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 73792 INFO (coreLoadExecutor-207-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-002/./collection1,
trusted=true
[junit4] 2> 73792 INFO (coreLoadExecutor-207-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@3088a30
[junit4] 2> 73792 INFO (coreLoadExecutor-207-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 73792 INFO (coreLoadExecutor-207-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-002/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-002/./collection1/data/]
[junit4] 2> 73795 INFO (coreLoadExecutor-207-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=9, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 73856 INFO (coreLoadExecutor-207-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 73856 INFO (coreLoadExecutor-207-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 73857 INFO (coreLoadExecutor-207-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=5, maxMergeAtOnceExplicit=6, maxMergedSegmentMB=76.96484375,
floorSegmentMB=1.7119140625, forceMergeDeletesPctAllowed=26.370069809110724,
segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 73858 INFO (coreLoadExecutor-207-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@42994720[collection1] main]
[junit4] 2> 73858 INFO (coreLoadExecutor-207-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to
use dir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-002/collection1/conf
[junit4] 2> 73860 INFO (coreLoadExecutor-207-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of
1000ms
[junit4] 2> 73860 INFO (coreLoadExecutor-207-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 73863 INFO
(searcherExecutor-208-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@42994720[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 73872 INFO (qtp1607989753-531) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/select
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 73877 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details}
status=0 QTime=2
[junit4] 2> 73884 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={slave=false&qt=/replication&wt=javabin&version=2&command=details}
status=0 QTime=0
[junit4] 2> 73885 INFO (qtp317331287-566) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details}
status=0 QTime=5
[junit4] 2> 73889 INFO (qtp1607989753-531) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{add=[0]} 0 2
[junit4] 2> 73890 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 73890 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@4d361f42 commitCommandVersion:0
[junit4] 2> 73904 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@2f5cba3e[collection1] main]
[junit4] 2> 73905 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 73906 INFO
(searcherExecutor-185-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@2f5cba3e[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)))}
[junit4] 2> 73907 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 16
[junit4] 2> 73924 WARN (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication
suffix
[junit4] 2> 73930 INFO (qtp1607989753-532) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
QTime=0
[junit4] 2> 73931 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Master's generation: 2
[junit4] 2> 73931 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Master's version: 1521516262743
[junit4] 2> 73931 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 73931 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Slave's version: 0
[junit4] 2> 73931 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 73934 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=2&qt=/replication&tlogFiles=false&wt=javabin&version=2&command=filelist}
status=0 QTime=2
[junit4] 2> 73935 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Number of files in latest index in master: 9
[junit4] 2> 73937 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@361fd7a0
[junit4] 2> 73938 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 73938 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to
MockDirectoryWrapper(RAMDirectory@faf6de0
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@33a03cde)
[junit4] 2> 73940 INFO (qtp1607989753-532) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 73942 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_FST50_0.doc&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 73944 INFO (qtp1607989753-532) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 73946 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 73947 INFO (qtp1607989753-532) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_FST50_0.tfp&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 73949 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 73951 INFO (qtp1607989753-532) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.fnm&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 73953 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.nvm&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 73954 INFO (qtp1607989753-532) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=segments_2&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 73955 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Bytes downloaded: 1524, Bytes skipped downloading: 0
[junit4] 2> 73955 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Total time taken for download
(fullCopy=false,bytesDownloaded=1524) : 0 secs (null bytes/sec) to
MockDirectoryWrapper(RAMDirectory@faf6de0
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@33a03cde)
[junit4] 2> 73957 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=1796754856,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 73958 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 73959 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@716a297b[collection1] main]
[junit4] 2> 73962 INFO
(searcherExecutor-208-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@716a297b[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)))}
[junit4] 2> 73962 INFO (qtp317331287-570) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={wait=true&masterUrl=http://127.0.0.1:41047/solr/collection1/replication&command=fetchindex}
status=0 QTime=38
[junit4] 2> 73973 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={slave=false&qt=/replication&wt=javabin&version=2&command=details}
status=0 QTime=0
[junit4] 2> 73973 INFO (qtp317331287-568) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details}
status=0 QTime=5
[junit4] 2> 73990 INFO (qtp317331287-570) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/select
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=15
[junit4] 2> 73991 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
[junit4] 2> 73993 INFO (qtp1607989753-531) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{add=[1]} 0 0
[junit4] 2> 73994 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 73994 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@4d361f42 commitCommandVersion:0
[junit4] 2> 73999 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@30cf4993[collection1] main]
[junit4] 2> 73999 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 74001 INFO
(searcherExecutor-185-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@30cf4993[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)
Uninverting(_1(8.0.0):C1)))}
[junit4] 2> 74002 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 8
[junit4] 2> 74005 WARN (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication
suffix
[junit4] 2> 74007 INFO (qtp1607989753-532) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
QTime=0
[junit4] 2> 74007 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Master's generation: 3
[junit4] 2> 74007 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Master's version: 1521516262847
[junit4] 2> 74007 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Slave's generation: 2
[junit4] 2> 74007 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Slave's version: 1521516262743
[junit4] 2> 74007 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 74009 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=3&qt=/replication&tlogFiles=false&wt=javabin&version=2&command=filelist}
status=0 QTime=1
[junit4] 2> 74010 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Number of files in latest index in master: 17
[junit4] 2> 74013 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@351392a8
[junit4] 2> 74013 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 74014 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to
MockDirectoryWrapper(RAMDirectory@f854093
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6675126a)
[junit4] 2> 74014 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
[junit4] 2> 74014 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _0_FST50_0.doc because it already
exists
[junit4] 2> 74014 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
[junit4] 2> 74014 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
[junit4] 2> 74015 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _0_FST50_0.tfp because it already
exists
[junit4] 2> 74015 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
[junit4] 2> 74015 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
[junit4] 2> 74015 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
[junit4] 2> 74016 INFO (qtp1607989753-532) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=3&qt=/replication&file=_1.si&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 74018 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=3&qt=/replication&file=_1.nvd&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 74019 INFO (qtp1607989753-532) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=3&qt=/replication&file=_1_FST50_0.tfp&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 74024 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=3&qt=/replication&file=_1.fdx&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 74026 INFO (qtp1607989753-532) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=3&qt=/replication&file=_1.fnm&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 74028 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=3&qt=/replication&file=_1.nvm&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 74030 INFO (qtp1607989753-532) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=3&qt=/replication&file=_1_FST50_0.doc&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 74032 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=3&qt=/replication&file=_1.fdt&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 74033 INFO (qtp1607989753-532) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=3&qt=/replication&file=segments_3&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 74034 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Bytes downloaded: 1586, Bytes skipped downloading: 0
[junit4] 2> 74034 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Total time taken for download
(fullCopy=false,bytesDownloaded=1586) : 0 secs (null bytes/sec) to
MockDirectoryWrapper(RAMDirectory@f854093
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6675126a)
[junit4] 2> 74037 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=1796754856,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 74038 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 74040 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@7306939[collection1] main]
[junit4] 2> 74042 INFO
(searcherExecutor-208-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@7306939[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)
Uninverting(_1(8.0.0):C1)))}
[junit4] 2> 74042 INFO (qtp317331287-571) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={wait=true&masterUrl=http://127.0.0.1:41047/solr/collection1/replication&command=fetchindex}
status=0 QTime=37
[junit4] 2> 74045 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={slave=false&qt=/replication&wt=javabin&version=2&command=details}
status=0 QTime=0
[junit4] 2> 74046 INFO (qtp317331287-568) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details}
status=0 QTime=2
[junit4] 2> 74047 INFO (qtp317331287-571) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/select
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=2 status=0 QTime=0
[junit4] 2> 74048 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.h.TestReplicationHandler Waited for 0ms and found 2 docs
[junit4] 2> 74050 INFO (qtp1607989753-531) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{add=[2]} 0 0
[junit4] 2> 74051 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 74051 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@4d361f42 commitCommandVersion:0
[junit4] 2> 74055 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@3116c259[collection1] main]
[junit4] 2> 74055 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 74057 INFO
(searcherExecutor-185-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@3116c259[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)
Uninverting(_1(8.0.0):C1) Uninverting(_2(8.0.0):C1)))}
[junit4] 2> 74057 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 6
[junit4] 2> 74059 WARN (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication
suffix
[junit4] 2> 74061 INFO (qtp1607989753-532) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
QTime=0
[junit4] 2> 74061 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Master's generation: 4
[junit4] 2> 74061 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Master's version: 1521516262904
[junit4] 2> 74061 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Slave's generation: 3
[junit4] 2> 74062 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Slave's version: 1521516262847
[junit4] 2> 74062 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 74064 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=4&qt=/replication&tlogFiles=false&wt=javabin&version=2&command=filelist}
status=0 QTime=1
[junit4] 2> 74064 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Number of files in latest index in master: 25
[junit4] 2> 74065 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@3ac242cc
[junit4] 2> 74067 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 74067 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to
MockDirectoryWrapper(RAMDirectory@7ba5d3b4
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5bd15903)
[junit4] 2> 74067 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
[junit4] 2> 74067 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _0_FST50_0.doc because it already
exists
[junit4] 2> 74067 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
[junit4] 2> 74067 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
[junit4] 2> 74067 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _0_FST50_0.tfp because it already
exists
[junit4] 2> 74067 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
[junit4] 2> 74067 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
[junit4] 2> 74067 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
[junit4] 2> 74067 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _1.si because it already exists
[junit4] 2> 74067 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _1.nvd because it already exists
[junit4] 2> 74068 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _1_FST50_0.tfp because it already
exists
[junit4] 2> 74068 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _1.fdx because it already exists
[junit4] 2> 74068 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _1.fnm because it already exists
[junit4] 2> 74068 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _1.nvm because it already exists
[junit4] 2> 74068 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _1_FST50_0.doc because it already
exists
[junit4] 2> 74068 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Skipping download for _1.fdt because it already exists
[junit4] 2> 74069 INFO (qtp1607989753-532) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=4&qt=/replication&file=_2.nvd&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 74070 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=4&qt=/replication&file=_2.si&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 74072 INFO (qtp1607989753-532) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=4&qt=/replication&file=_2.fdt&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 74073 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=4&qt=/replication&file=_2_FST50_0.tfp&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 74074 INFO (qtp1607989753-532) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=4&qt=/replication&file=_2.fnm&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 74076 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=4&qt=/replication&file=_2.nvm&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 74078 INFO (qtp1607989753-532) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=4&qt=/replication&file=_2.fdx&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 74086 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=4&qt=/replication&file=_2_FST50_0.doc&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 74087 INFO (qtp1607989753-532) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=4&qt=/replication&file=segments_4&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 74088 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Bytes downloaded: 1648, Bytes skipped downloading: 0
[junit4] 2> 74088 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Total time taken for download
(fullCopy=false,bytesDownloaded=1648) : 0 secs (null bytes/sec) to
MockDirectoryWrapper(RAMDirectory@7ba5d3b4
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5bd15903)
[junit4] 2> 74090 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=1796754856,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 74091 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 74093 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@ce92a24[collection1] main]
[junit4] 2> 74096 INFO
(searcherExecutor-208-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@ce92a24[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)
Uninverting(_1(8.0.0):C1) Uninverting(_2(8.0.0):C1)))}
[junit4] 2> 74096 INFO (qtp317331287-570) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={wait=true&masterUrl=http://127.0.0.1:41047/solr/collection1/replication&command=fetchindex}
status=0 QTime=37
[junit4] 2> 74098 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-003/collection1
[junit4] 2> 74101 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 29-11-21T22:27:37+01:00,
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 74106 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 74106 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 74106 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 74107 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5f81eb1a{/solr,null,AVAILABLE}
[junit4] 2> 74107 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@1157ceaa{HTTP/1.1,[http/1.1]}{127.0.0.1:58731}
[junit4] 2> 74108 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.Server Started @77105ms
[junit4] 2> 74108 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-003/collection1/data,
hostContext=/solr, hostPort=58731}
[junit4] 2> 74108 ERROR
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 74108 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 74108 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on
port null
[junit4] 2> 74108 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 74108 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-03-20T03:24:22.961Z
[junit4] 2> 74109 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-003/solr.xml
[junit4] 2> 74115 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 74115 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 74116 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@3088a30, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 74202 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3088a30
[junit4] 2> 74218 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3088a30
[junit4] 2> 74218 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3088a30
[junit4] 2> 74222 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-003/.
[junit4] 2> 74222 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 74223 INFO (coreLoadExecutor-221-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 74253 INFO (coreLoadExecutor-221-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 74262 INFO (coreLoadExecutor-221-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 74265 INFO (coreLoadExecutor-221-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 74265 INFO (coreLoadExecutor-221-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-003/./collection1,
trusted=true
[junit4] 2> 74265 INFO (coreLoadExecutor-221-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@3088a30
[junit4] 2> 74266 INFO (coreLoadExecutor-221-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 74266 INFO (coreLoadExecutor-221-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-003/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-003/./collection1/data/]
[junit4] 2> 74276 INFO (coreLoadExecutor-221-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=9, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 74359 INFO (coreLoadExecutor-221-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 74359 INFO (coreLoadExecutor-221-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 74360 INFO (coreLoadExecutor-221-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=5, maxMergeAtOnceExplicit=6, maxMergedSegmentMB=76.96484375,
floorSegmentMB=1.7119140625, forceMergeDeletesPctAllowed=26.370069809110724,
segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 74361 INFO (coreLoadExecutor-221-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@40585ed0[collection1] main]
[junit4] 2> 74361 INFO (coreLoadExecutor-221-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to
use dir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-003/collection1/conf
[junit4] 2> 74362 WARN (coreLoadExecutor-221-thread-1) [
x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the
/replication suffix
[junit4] 2> 74363 INFO (coreLoadExecutor-221-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler No value set for 'pollInterval'.
Timer Task not started.
[junit4] 2> 74364 INFO (coreLoadExecutor-221-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following
config files: schema.xml
[junit4] 2> 74364 INFO (coreLoadExecutor-221-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 74366 INFO
(searcherExecutor-222-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@40585ed0[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 74519 INFO (qtp1607989753-529) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
QTime=0
[junit4] 2> 74519 INFO (indexFetcher-212-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Master's generation: 4
[junit4] 2> 74519 INFO (indexFetcher-212-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Master's version: 1521516262904
[junit4] 2> 74519 INFO (indexFetcher-212-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Slave's generation: 4
[junit4] 2> 74519 INFO (indexFetcher-212-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Slave's version: 1521516262904
[junit4] 2> 74519 INFO (indexFetcher-212-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Slave in sync with master.
[junit4] 2> 74877 WARN (qtp958340448-593) [ x:collection1]
o.a.s.h.ReplicationHandler Exception while invoking 'details' method for
replication on master
[junit4] 2>
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:41047/solr: Expected mime type
application/octet-stream but got text/html. <html>
[junit4] 2> <head>
[junit4] 2> <meta http-equiv="Content-Type"
content="text/html;charset=utf-8"/>
[junit4] 2> <title>Error 404 Can not find: /solr/replication</title>
[junit4] 2> </head>
[junit4] 2> <body><h2>HTTP ERROR 404</h2>
[junit4] 2> <p>Problem accessing /solr/replication. Reason:
[junit4] 2> <pre> Can not find: /solr/replication</pre></p><hr><a
href="http://eclipse.org/jetty";>Powered by Jetty:// 9.4.8.v20171121</a><hr/>
[junit4] 2>
[junit4] 2> </body>
[junit4] 2> </html>
[junit4] 2>
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:607)
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
[junit4] 2> at
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
[junit4] 2> at
org.apache.solr.handler.IndexFetcher.getDetails(IndexFetcher.java:1852)
[junit4] 2> at
org.apache.solr.handler.ReplicationHandler.getReplicationDetails(ReplicationHandler.java:928)
[junit4] 2> at
org.apache.solr.handler.ReplicationHandler.handleRequestBody(ReplicationHandler.java:331)
[junit4] 2> at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:195)
[junit4] 2> at
org.apache.solr.core.SolrCore.execute(SolrCore.java:2503)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:711)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:517)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:384)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:330)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1637)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1637)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:533)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:188)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1595)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:188)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1253)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:168)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:473)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1564)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:166)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1155)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:527)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
[junit4] 2> at
org.eclipse.jetty.server.Server.handle(Server.java:530)
[junit4] 2> at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:347)
[junit4] 2> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:256)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:279)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102)
[junit4] 2> at
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:124)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:247)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:140)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 74878 INFO (qtp958340448-593) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details}
status=0 QTime=8
[junit4] 2> 74880 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@1157ceaa{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 74880 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1859787503
[junit4] 2> 74880 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 74880 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@751999bb: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@654a1e35
[junit4] 2> 74891 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 74891 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6cb99600: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@7f0330e8
[junit4] 2> 74897 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 74897 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5e665e87: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@2a12eea1
[junit4] 2> 74898 INFO (coreCloseExecutor-226-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@6e62d124
[junit4] 2> 74898 INFO (coreCloseExecutor-226-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=1851969828
[junit4] 2> 74898 INFO (coreCloseExecutor-226-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@e109f75: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@1c400f10
[junit4] 2> 74918 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@5f81eb1a{/solr,null,UNAVAILABLE}
[junit4] 2> 74918 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 74919 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending doTestDetails
[junit4] 2> 74920 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@53653956{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 74920 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1828433029
[junit4] 2> 74921 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 74921 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@e1f2fa0: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@5077d8fd
[junit4] 2> 74924 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 74924 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4c85e0b5: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@7f0330e8
[junit4] 2> 74925 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 74925 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[994682F94E7E11]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@2ab107e2: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@2a12eea1
[junit4] 2> 7
[...truncated too long message...]
2> 431740 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.h.IndexFetcher Total time taken for download
(fullCopy=false,bytesDownloaded=914319) : 17 secs (53783 bytes/sec) to
NRTCachingDirectory(MMapDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001/solr-instance-030/collection1/data/index.20180320003003148
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4cf9fb40;
maxCacheMB=48.0 maxMergeSizeMB=4.0)
[junit4] 2> 431746 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@2df9691a
[junit4] 2> 431747 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 431749 INFO (explicit-fetchindex-cmd) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@59dfb0a3[collection1] main]
[junit4] 2> 431750 INFO
(searcherExecutor-1025-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@59dfb0a3[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C99)))}
[junit4] 2> 431751 INFO (qtp363854566-2081) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={wait=true&masterUrl=http://127.0.0.1:37335/solr/collection1/replication&command=fetchindex}
status=0 QTime=17464
[junit4] 2> 431782 INFO (qtp1117443685-2067) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{add=[99]} 0 0
[junit4] 2> 431783 INFO (qtp363854566-2085) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/select
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=99 status=0 QTime=5
[junit4] 2> 431784 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 99 docs
[junit4] 2> 431785 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.a.s.h.TestReplicationHandler approximateTimeInSeconds = 0.0
timeTakenInSeconds = 17
[junit4] 2> 431785 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testRateLimitedReplication
[junit4] 2> 431798 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.e.j.s.AbstractConnector Stopped
ServerConnector@64f87fdd{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 431798 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2102603837
[junit4] 2> 431798 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.node, tag=null
[junit4] 2> 431798 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@33c76647: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@5d5c6a68
[junit4] 2> 431803 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jvm, tag=null
[junit4] 2> 431803 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5e9fecc8: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@7f0330e8
[junit4] 2> 431806 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jetty, tag=null
[junit4] 2> 431807 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@70ea296d: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@2a12eea1
[junit4] 2> 431830 INFO (coreCloseExecutor-1030-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@4a5189ba
[junit4] 2> 431830 INFO (coreCloseExecutor-1030-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=1246857658
[junit4] 2> 431830 INFO (coreCloseExecutor-1030-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@144e8ce9: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@4922287a
[junit4] 2> 431882 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@2291ded8{/solr,null,UNAVAILABLE}
[junit4] 2> 431882 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 431894 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.e.j.s.AbstractConnector Stopped
ServerConnector@1269903e{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 431894 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1513789183
[junit4] 2> 431894 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.node, tag=null
[junit4] 2> 431894 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5fdeef93: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@4882a5a5
[junit4] 2> 431901 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jvm, tag=null
[junit4] 2> 431901 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@eeccd9: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@7f0330e8
[junit4] 2> 431906 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jetty, tag=null
[junit4] 2> 431906 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@677e581c: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@2a12eea1
[junit4] 2> 431938 INFO (coreCloseExecutor-1032-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@2945dbc4
[junit4] 2> 431938 INFO (coreCloseExecutor-1032-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=692444100
[junit4] 2> 431938 INFO (coreCloseExecutor-1032-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@367f0847: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@45078e70
[junit4] 2> 431967 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@7b63ae8{/solr,null,UNAVAILABLE}
[junit4] 2> 431967 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[994682F94E7E11])
[ ] o.e.j.s.session Stopped scavenging
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_994682F94E7E11-001
[junit4] 2> Mar 20, 2018 3:30:20 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {name=FST50,
id=FST50, newname=FST50}, docValues:{}, maxPointsInLeafNode=796,
maxMBSortInHeap=5.662425774085755,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@40161a8d),
locale=fr-CA, timezone=America/Goose_Bay
[junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation
1.8.0_144 (64-bit)/cpus=4,threads=1,free=72962528,total=417857536
[junit4] 2> NOTE: All tests run in this JVM: [TestCloudSchemaless,
TestTrie, SuggesterTest, TestReplicationHandler]
[junit4] Completed [79/785 (1!)] on J1 in 359.41s, 16 tests, 1 failure, 2
skipped <<< FAILURES!
[...truncated 51938 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
