Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/20902/
Java: 64bit/jdk-10-ea+29 -XX:+UseCompressedOops -XX:+UseParallelGC

1 tests failed.
FAILED:  
org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigReplication

Error Message:
Index 0 out-of-bounds for length 0

Stack Trace:
java.lang.IndexOutOfBoundsException: Index 0 out-of-bounds for length 0
        at 
__randomizedtesting.SeedInfo.seed([64097E0A2606BCB3:7041255F050101AD]:0)
        at 
java.base/jdk.internal.util.Preconditions.outOfBounds(Preconditions.java:64)
        at 
java.base/jdk.internal.util.Preconditions.outOfBoundsCheckIndex(Preconditions.java:70)
        at 
java.base/jdk.internal.util.Preconditions.checkIndex(Preconditions.java:248)
        at java.base/java.util.Objects.checkIndex(Objects.java:372)
        at java.base/java.util.ArrayList.get(ArrayList.java:440)
        at 
org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigReplication(TestReplicationHandler.java:561)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:844)




Build Log:
[...truncated 12894 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> 1550074 INFO  
(SUITE-TestReplicationHandler-seed#[64097E0A2606BCB3]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/init-core-data-001
   [junit4]   2> 1550075 WARN  
(SUITE-TestReplicationHandler-seed#[64097E0A2606BCB3]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=120 numCloses=120
   [junit4]   2> 1550075 INFO  
(SUITE-TestReplicationHandler-seed#[64097E0A2606BCB3]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1550075 INFO  
(SUITE-TestReplicationHandler-seed#[64097E0A2606BCB3]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl="None")
   [junit4]   2> 1550076 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testEmptyCommits
   [junit4]   2> 1550076 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-001/collection1
   [junit4]   2> 1550077 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1550078 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@176d92e8{/solr,null,AVAILABLE}
   [junit4]   2> 1550078 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@75650aa3{HTTP/1.1,[http/1.1]}{127.0.0.1:39797}
   [junit4]   2> 1550078 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.e.j.s.Server Started @1551535ms
   [junit4]   2> 1550078 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-001/collection1/data,
 hostPort=39797}
   [junit4]   2> 1550079 ERROR 
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1550079 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1550079 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1550079 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1550079 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-13T10:14:24.923218Z
   [junit4]   2> 1550079 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-001/solr.xml
   [junit4]   2> 1550080 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1550080 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1550081 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@165d3b96, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1550106 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@165d3b96
   [junit4]   2> 1550116 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@165d3b96
   [junit4]   2> 1550116 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@165d3b96
   [junit4]   2> 1550118 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-001/.
   [junit4]   2> 1550118 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1550118 INFO  (coreLoadExecutor-5246-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1550121 INFO  (coreLoadExecutor-5246-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1550125 INFO  (coreLoadExecutor-5246-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1550125 INFO  (coreLoadExecutor-5246-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1550125 INFO  (coreLoadExecutor-5246-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-001/./collection1,
 trusted=true
   [junit4]   2> 1550126 INFO  (coreLoadExecutor-5246-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 
'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@165d3b96
   [junit4]   2> 1550126 INFO  (coreLoadExecutor-5246-thread-1) [    ] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1550126 INFO  (coreLoadExecutor-5246-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-001/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 1550127 INFO  (coreLoadExecutor-5246-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=25, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=47.9287109375, 
floorSegmentMB=0.537109375, forceMergeDeletesPctAllowed=26.109063284086137, 
segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1550147 INFO  (coreLoadExecutor-5246-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1550147 INFO  (coreLoadExecutor-5246-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1550148 INFO  (coreLoadExecutor-5246-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=34, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=15.0166015625, 
floorSegmentMB=2.15234375, forceMergeDeletesPctAllowed=24.896282497822362, 
segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.10401525682292166
   [junit4]   2> 1550148 INFO  (coreLoadExecutor-5246-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@6c037003[collection1] main]
   [junit4]   2> 1550148 INFO  (coreLoadExecutor-5246-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-001/collection1/conf
   [junit4]   2> 1550149 INFO  (coreLoadExecutor-5246-thread-1) [    ] 
o.a.s.h.ReplicationHandler Replication enabled for following config files: 
schema.xml,xslt/dummy.xsl
   [junit4]   2> 1550149 INFO  (coreLoadExecutor-5246-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1550154 INFO  (searcherExecutor-5247-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6c037003[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1550154 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-002/collection1
   [junit4]   2> 1550155 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1550157 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7fb8c53b{/solr,null,AVAILABLE}
   [junit4]   2> 1550158 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@7ad3e645{HTTP/1.1,[http/1.1]}{127.0.0.1:40379}
   [junit4]   2> 1550158 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.e.j.s.Server Started @1551614ms
   [junit4]   2> 1550158 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-002/collection1/data,
 hostPort=40379}
   [junit4]   2> 1550158 ERROR 
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1550158 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1550158 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1550158 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1550158 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-13T10:14:25.002740Z
   [junit4]   2> 1550158 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-002/solr.xml
   [junit4]   2> 1550160 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1550160 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1550160 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@165d3b96, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1550182 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@165d3b96
   [junit4]   2> 1550189 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@165d3b96
   [junit4]   2> 1550189 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@165d3b96
   [junit4]   2> 1550190 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-002/.
   [junit4]   2> 1550191 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1550191 INFO  (coreLoadExecutor-5256-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1550195 INFO  (coreLoadExecutor-5256-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1550198 INFO  (coreLoadExecutor-5256-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1550199 INFO  (coreLoadExecutor-5256-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1550199 INFO  (coreLoadExecutor-5256-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-002/./collection1,
 trusted=true
   [junit4]   2> 1550199 INFO  (coreLoadExecutor-5256-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 
'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@165d3b96
   [junit4]   2> 1550199 INFO  (coreLoadExecutor-5256-thread-1) [    ] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1550199 INFO  (coreLoadExecutor-5256-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-002/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 1550201 INFO  (coreLoadExecutor-5256-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=25, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=47.9287109375, 
floorSegmentMB=0.537109375, forceMergeDeletesPctAllowed=26.109063284086137, 
segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1550221 INFO  (coreLoadExecutor-5256-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1550221 INFO  (coreLoadExecutor-5256-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1550221 INFO  (coreLoadExecutor-5256-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=34, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=15.0166015625, 
floorSegmentMB=2.15234375, forceMergeDeletesPctAllowed=24.896282497822362, 
segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.10401525682292166
   [junit4]   2> 1550221 INFO  (coreLoadExecutor-5256-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2cb2b619[collection1] main]
   [junit4]   2> 1550221 INFO  (coreLoadExecutor-5256-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-002/collection1/conf
   [junit4]   2> 1550222 INFO  (coreLoadExecutor-5256-thread-1) [    ] 
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
   [junit4]   2> 1550222 INFO  (coreLoadExecutor-5256-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1550223 INFO  (searcherExecutor-5257-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2cb2b619[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1550224 INFO  (qtp2048955869-17641) [    ] 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> 1550225 INFO  (qtp2048955869-17642) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[1]} 0 0
   [junit4]   2> 1550225 INFO  (qtp2048955869-17643) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1550225 INFO  (qtp2048955869-17643) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@491e734c commitCommandVersion:0
   [junit4]   2> 1550227 INFO  (qtp2048955869-17643) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1a768377[collection1] main]
   [junit4]   2> 1550227 INFO  (qtp2048955869-17643) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1550228 INFO  (searcherExecutor-5247-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1a768377[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)))}
   [junit4]   2> 1550228 INFO  (qtp2048955869-17643) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={commit=true&wt=javabin&version=2}{commit=} 0 2
   [junit4]   2> 1550229 WARN  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 1550230 INFO  (qtp2048955869-17641) [    ] 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> 1550230 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 1550230 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Master's version: 1510568065069
   [junit4]   2> 1550230 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 1550230 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Slave's version: 0
   [junit4]   2> 1550230 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 1550231 INFO  (qtp2048955869-17642) [    ] 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=0
   [junit4]   2> 1550231 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 10
   [junit4]   2> 1550232 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=23, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1550232 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1550232 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@711a9a58 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@460b0d4d)
   [junit4]   2> 1550232 INFO  (qtp2048955869-17643) [    ] 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> 1550232 INFO  (qtp2048955869-17637) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Direct_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1550233 INFO  (qtp2048955869-17641) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Direct_0.tim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1550233 INFO  (qtp2048955869-17642) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Direct_0.tip&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1550234 INFO  (qtp2048955869-17643) [    ] 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> 1550234 INFO  (qtp2048955869-17637) [    ] 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> 1550234 INFO  (qtp2048955869-17641) [    ] 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> 1550235 INFO  (qtp2048955869-17642) [    ] 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> 1550235 INFO  (qtp2048955869-17643) [    ] 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> 1550235 INFO  (qtp2048955869-17637) [    ] 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> 1550236 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=1652) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@711a9a58 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@460b0d4d)
   [junit4]   2> 1550236 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=31, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8461012880588897]
   [junit4]   2> 1550236 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1550237 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@73eb41f5[collection1] main]
   [junit4]   2> 1550237 INFO  (searcherExecutor-5257-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@73eb41f5[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)))}
   [junit4]   2> 1550238 INFO  (qtp1001735406-17658) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:39797/solr/collection1/replication&command=fetchindex}
 status=0 QTime=9
   [junit4]   2> 1550239 INFO  (qtp1001735406-17660) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/select 
params={q=name:empty1&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 1550239 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
   [junit4]   2> 1550239 INFO  (qtp2048955869-17636) [    ] 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=0
   [junit4]   2> 1550239 INFO  (qtp2048955869-17642) [    ] 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=0
   [junit4]   2> 1550240 INFO  (qtp2048955869-17641) [    ] 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> 1550240 INFO  (qtp1001735406-17653) [    ] 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=0
   [junit4]   2> 1550240 INFO  (qtp2048955869-17643) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={_trace=assertVersions&qt=/replication&wt=javabin&version=2&command=indexversion}
 status=0 QTime=0
   [junit4]   2> 1550240 INFO  (qtp1001735406-17658) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={_trace=assertVersions&qt=/replication&wt=javabin&version=2&command=indexversion}
 status=0 QTime=0
   [junit4]   2> 1550240 INFO  (qtp2048955869-17636) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1550240 INFO  (qtp2048955869-17636) [    ] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 1550240 INFO  (qtp2048955869-17636) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1550240 INFO  (qtp2048955869-17636) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={commit=true&wt=javabin&version=2}{commit=} 0 0
   [junit4]   2> 1550241 WARN  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 1550242 INFO  (qtp2048955869-17637) [    ] 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> 1550242 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 1550242 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Master's version: 1510568065069
   [junit4]   2> 1550242 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Slave's generation: 2
   [junit4]   2> 1550242 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Slave's version: 1510568065069
   [junit4]   2> 1550242 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Slave in sync with master.
   [junit4]   2> 1550242 INFO  (qtp1001735406-17659) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:39797/solr/collection1/replication&command=fetchindex}
 status=0 QTime=0
   [junit4]   2> 1550242 INFO  (qtp2048955869-17642) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[2]} 0 0
   [junit4]   2> 1550242 INFO  (qtp2048955869-17643) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1550242 INFO  (qtp2048955869-17643) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@491e734c commitCommandVersion:0
   [junit4]   2> 1550243 INFO  (qtp2048955869-17643) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@5c51140c[collection1] main]
   [junit4]   2> 1550243 INFO  (qtp2048955869-17643) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1550244 INFO  (searcherExecutor-5247-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@5c51140c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)
 Uninverting(_1(8.0.0):C1)))}
   [junit4]   2> 1550244 INFO  (qtp2048955869-17643) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={commit=true&wt=javabin&version=2}{commit=} 0 1
   [junit4]   2> 1550244 WARN  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 1550245 INFO  (qtp2048955869-17641) [    ] 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> 1550245 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Master's generation: 3
   [junit4]   2> 1550245 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Master's version: 1510568065086
   [junit4]   2> 1550245 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Slave's generation: 2
   [junit4]   2> 1550245 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Slave's version: 1510568065069
   [junit4]   2> 1550245 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 1550246 INFO  (qtp2048955869-17637) [    ] 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=0
   [junit4]   2> 1550246 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 19
   [junit4]   2> 1550246 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=23, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1550246 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1550246 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@61ea9eaf 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6115e41a)
   [junit4]   2> 1550246 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 1550246 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0_Direct_0.doc because it already 
exists
   [junit4]   2> 1550246 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0_Direct_0.tim because it already 
exists
   [junit4]   2> 1550246 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0_Direct_0.tip because it already 
exists
   [junit4]   2> 1550246 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
   [junit4]   2> 1550246 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
   [junit4]   2> 1550246 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
   [junit4]   2> 1550246 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
   [junit4]   2> 1550246 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
   [junit4]   2> 1550247 INFO  (qtp2048955869-17642) [    ] 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> 1550247 INFO  (qtp2048955869-17643) [    ] 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> 1550247 INFO  (qtp2048955869-17641) [    ] 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> 1550248 INFO  (qtp2048955869-17637) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1_Direct_0.tip&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1550248 INFO  (qtp2048955869-17642) [    ] 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> 1550248 INFO  (qtp2048955869-17643) [    ] 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> 1550249 INFO  (qtp2048955869-17641) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1_Direct_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1550249 INFO  (qtp2048955869-17637) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1_Direct_0.tim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1550250 INFO  (qtp2048955869-17642) [    ] 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> 1550250 INFO  (qtp2048955869-17643) [    ] 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> 1550250 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=1714) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@61ea9eaf 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6115e41a)
   [junit4]   2> 1550250 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=31, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8461012880588897]
   [junit4]   2> 1550251 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1550251 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@efc8db6[collection1] main]
   [junit4]   2> 1550252 INFO  (searcherExecutor-5257-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@efc8db6[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)
 Uninverting(_1(8.0.0):C1)))}
   [junit4]   2> 1550252 INFO  (qtp1001735406-17660) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:39797/solr/collection1/replication&command=fetchindex}
 status=0 QTime=7
   [junit4]   2> 1550252 INFO  (qtp1001735406-17654) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/select 
params={q=name:empty2&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 1550253 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
   [junit4]   2> 1550253 INFO  (qtp2048955869-17636) [    ] 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=0
   [junit4]   2> 1550253 INFO  (qtp2048955869-17637) [    ] 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=0
   [junit4]   2> 1550253 INFO  (qtp2048955869-17641) [    ] 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> 1550254 INFO  (qtp1001735406-17658) [    ] 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=0
   [junit4]   2> 1550254 INFO  (qtp2048955869-17642) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={_trace=assertVersions&qt=/replication&wt=javabin&version=2&command=indexversion}
 status=0 QTime=0
   [junit4]   2> 1550254 INFO  (qtp1001735406-17659) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={_trace=assertVersions&qt=/replication&wt=javabin&version=2&command=indexversion}
 status=0 QTime=0
   [junit4]   2> 1550254 INFO  (qtp2048955869-17636) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[3]} 0 0
   [junit4]   2> 1550254 INFO  (qtp2048955869-17637) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1550254 INFO  (qtp2048955869-17637) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@491e734c commitCommandVersion:0
   [junit4]   2> 1550255 INFO  (qtp2048955869-17637) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@102dc501[collection1] realtime]
   [junit4]   2> 1550255 INFO  (qtp2048955869-17637) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1550255 INFO  (qtp2048955869-17637) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={openSearcher=false&commit=true&wt=javabin&version=2}{commit=} 0 0
   [junit4]   2> 1550256 WARN  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 1550256 INFO  (qtp2048955869-17643) [    ] 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> 1550256 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Master's generation: 4
   [junit4]   2> 1550256 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Master's version: 1510568065098
   [junit4]   2> 1550256 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Slave's generation: 3
   [junit4]   2> 1550256 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Slave's version: 1510568065086
   [junit4]   2> 1550256 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 1550257 INFO  (qtp2048955869-17642) [    ] 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=0
   [junit4]   2> 1550257 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 28
   [junit4]   2> 1550257 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=23, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1550258 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1550258 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1550258 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1551258 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1551258 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1552258 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1552258 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1553259 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1553259 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1554259 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1554259 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1555259 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1555259 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1556259 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1556259 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1557260 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1557260 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1558260 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1558260 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1559260 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1559260 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1560261 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1560261 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1561261 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher IndexFetcher slept for 11000ms for unused lucene index 
files to be delete-able
   [junit4]   2> 1561261 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@3cdb1e14 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6ced7152)
   [junit4]   2> 1561261 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 1561261 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0_Direct_0.doc because it already 
exists
   [junit4]   2> 1561262 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0_Direct_0.tim because it already 
exists
   [junit4]   2> 1561262 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0_Direct_0.tip because it already 
exists
   [junit4]   2> 1561262 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
   [junit4]   2> 1561262 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
   [junit4]   2> 1561262 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
   [junit4]   2> 1561262 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
   [junit4]   2> 1561262 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
   [junit4]   2> 1561262 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _1.si because it already exists
   [junit4]   2> 1561262 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _1.nvd because it already exists
   [junit4]   2> 1561262 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _1.fdx because it already exists
   [junit4]   2> 1561262 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _1_Direct_0.tip because it already 
exists
   [junit4]   2> 1561262 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _1.fnm because it already exists
   [junit4]   2> 1561262 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _1.nvm because it already exists
   [junit4]   2> 1561262 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _1_Direct_0.doc because it already 
exists
   [junit4]   2> 1561262 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _1_Direct_0.tim because it already 
exists
   [junit4]   2> 1561262 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _1.fdt because it already exists
   [junit4]   2> 1561264 INFO  (qtp2048955869-17636) [    ] 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> 1561274 INFO  (qtp2048955869-17637) [    ] 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> 1561275 INFO  (qtp2048955869-17643) [    ] 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> 1561276 INFO  (qtp2048955869-17642) [    ] 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> 1561276 INFO  (qtp2048955869-17636) [    ] 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> 1561277 INFO  (qtp2048955869-17637) [    ] 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> 1561278 INFO  (qtp2048955869-17643) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_2_Direct_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1561279 INFO  (qtp2048955869-17642) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_2_Direct_0.tim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1561280 INFO  (qtp2048955869-17636) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_2_Direct_0.tip&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1561280 INFO  (qtp2048955869-17637) [    ] 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> 1561281 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=1776) : 11 secs (161 bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@3cdb1e14 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6ced7152)
   [junit4]   2> 1561282 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=31, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8461012880588897]
   [junit4]   2> 1561282 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1561283 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@388e8a0a[collection1] main]
   [junit4]   2> 1561285 INFO  (searcherExecutor-5257-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@388e8a0a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)
 Uninverting(_1(8.0.0):C1) Uninverting(_2(8.0.0):C1)))}
   [junit4]   2> 1561285 INFO  (qtp1001735406-17653) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:39797/solr/collection1/replication&command=fetchindex}
 status=0 QTime=11029
   [junit4]   2> 1561287 INFO  (qtp2048955869-17641) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/select 
params={q=name:empty3&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 1561287 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.h.TestReplicationHandler Waited for 0ms and found 0 docs
   [junit4]   2> 1561289 INFO  (qtp1001735406-17660) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/select 
params={q=name:empty3&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 1561289 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
   [junit4]   2> 1561290 INFO  (qtp2048955869-17642) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[4]} 0 0
   [junit4]   2> 1561290 INFO  (qtp2048955869-17636) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1561290 INFO  (qtp2048955869-17636) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@491e734c commitCommandVersion:0
   [junit4]   2> 1561292 INFO  (qtp2048955869-17636) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@54bf276d[collection1] main]
   [junit4]   2> 1561292 INFO  (qtp2048955869-17636) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1561293 INFO  (searcherExecutor-5247-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@54bf276d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)
 Uninverting(_1(8.0.0):C1) Uninverting(_2(8.0.0):C1) 
Uninverting(_3(8.0.0):C1)))}
   [junit4]   2> 1561293 INFO  (qtp2048955869-17636) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={commit=true&wt=javabin&version=2}{commit=} 0 3
   [junit4]   2> 1561294 WARN  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 1561295 INFO  (qtp2048955869-17643) [    ] 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> 1561296 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Master's generation: 5
   [junit4]   2> 1561296 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Master's version: 1510568076134
   [junit4]   2> 1561296 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Slave's generation: 4
   [junit4]   2> 1561296 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Slave's version: 1510568065098
   [junit4]   2> 1561296 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 1561297 INFO  (qtp2048955869-17641) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=5&qt=/replication&tlogFiles=false&wt=javabin&version=2&command=filelist}
 status=0 QTime=0
   [junit4]   2> 1561297 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 37
   [junit4]   2> 1561298 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=23, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1561299 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1561299 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@e5f1727 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@50effe18)
   [junit4]   2> 1561299 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 1561299 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0_Direct_0.doc because it already 
exists
   [junit4]   2> 1561299 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0_Direct_0.tim because it already 
exists
   [junit4]   2> 1561299 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0_Direct_0.tip because it already 
exists
   [junit4]   2> 1561299 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
   [junit4]   2> 1561299 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
   [junit4]   2> 1561299 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
   [junit4]   2> 1561299 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
   [junit4]   2> 1561299 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
   [junit4]   2> 1561300 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _1.si because it already exists
   [junit4]   2> 1561300 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _1.nvd because it already exists
   [junit4]   2> 1561300 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _1.fdx because it already exists
   [junit4]   2> 1561300 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _1_Direct_0.tip because it already 
exists
   [junit4]   2> 1561300 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _1.fnm because it already exists
   [junit4]   2> 1561300 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _1.nvm because it already exists
   [junit4]   2> 1561300 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _1_Direct_0.doc because it already 
exists
   [junit4]   2> 1561300 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _1_Direct_0.tim because it already 
exists
   [junit4]   2> 1561300 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _1.fdt because it already exists
   [junit4]   2> 1561300 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _2.nvd because it already exists
   [junit4]   2> 1561300 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _2.si because it already exists
   [junit4]   2> 1561300 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _2.fdt because it already exists
   [junit4]   2> 1561300 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _2.fnm because it already exists
   [junit4]   2> 1561300 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _2.nvm because it already exists
   [junit4]   2> 1561300 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _2.fdx because it already exists
   [junit4]   2> 1561300 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _2_Direct_0.doc because it already 
exists
   [junit4]   2> 1561300 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _2_Direct_0.tim because it already 
exists
   [junit4]   2> 1561300 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Skipping download for _2_Direct_0.tip because it already 
exists
   [junit4]   2> 1561301 INFO  (qtp2048955869-17642) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=5&qt=/replication&file=_3.fdx&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1561302 INFO  (qtp2048955869-17636) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=5&qt=/replication&file=_3.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1561303 INFO  (qtp2048955869-17643) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=5&qt=/replication&file=_3.nvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1561304 INFO  (qtp2048955869-17641) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=5&qt=/replication&file=_3_Direct_0.tim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1561304 INFO  (qtp2048955869-17642) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=5&qt=/replication&file=_3_Direct_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1561305 INFO  (qtp2048955869-17636) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=5&qt=/replication&file=_3_Direct_0.tip&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1561306 INFO  (qtp2048955869-17643) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=5&qt=/replication&file=_3.fnm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1561307 INFO  (qtp2048955869-17641) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=5&qt=/replication&file=_3.nvm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1561307 INFO  (qtp2048955869-17642) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=5&qt=/replication&file=_3.fdt&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1561308 INFO  (qtp2048955869-17636) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={generation=5&qt=/replication&file=segments_5&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1561309 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=1838) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@e5f1727 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@50effe18)
   [junit4]   2> 1561310 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=31, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8461012880588897]
   [junit4]   2> 1561310 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1561311 INFO  (explicit-fetchindex-cmd) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@63d484b0[collection1] main]
   [junit4]   2> 1561313 INFO  (searcherExecutor-5257-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@63d484b0[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)
 Uninverting(_1(8.0.0):C1) Uninverting(_2(8.0.0):C1) 
Uninverting(_3(8.0.0):C1)))}
   [junit4]   2> 1561313 INFO  (qtp1001735406-17654) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:39797/solr/collection1/replication&command=fetchindex}
 status=0 QTime=18
   [junit4]   2> 1561314 INFO  (qtp2048955869-17637) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/select 
params={q=name:(empty1+empty2+empty3+empty4)&sort=id+desc&wt=javabin&version=2} 
hits=4 status=0 QTime=0
   [junit4]   2> 1561315 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.h.TestReplicationHandler Waited for 0ms and found 4 docs
   [junit4]   2> 1561315 INFO  (qtp1001735406-17658) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/select 
params={q=name:(empty1+empty2+empty3+empty4)&sort=id+desc&wt=javabin&version=2} 
hits=4 status=0 QTime=0
   [junit4]   2> 1561316 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.h.TestReplicationHandler Waited for 0ms and found 4 docs
   [junit4]   2> 1561316 INFO  (qtp2048955869-17641) [    ] 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=0
   [junit4]   2> 1561317 INFO  (qtp2048955869-17642) [    ] 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=0
   [junit4]   2> 1561318 INFO  (qtp2048955869-17643) [    ] 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> 1561318 INFO  (qtp1001735406-17653) [    ] 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=0
   [junit4]   2> 1561319 INFO  (qtp2048955869-17636) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={_trace=assertVersions&qt=/replication&wt=javabin&version=2&command=indexversion}
 status=0 QTime=0
   [junit4]   2> 1561319 INFO  (qtp1001735406-17660) [    ] o.a.s.c.S.Request 
[collection1]  webapp=/solr path=/replication 
params={_trace=assertVersions&qt=/replication&wt=javabin&version=2&command=indexversion}
 status=0 QTime=0
   [junit4]   2> 1561319 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testEmptyCommits
   [junit4]   2> 1561320 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@75650aa3{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1561320 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=425497108
   [junit4]   2> 1561321 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1561321 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2129ec42: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@66a2fb63
   [junit4]   2> 1561328 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1561328 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@35ca5a3: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@4f81d748
   [junit4]   2> 1561333 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1561333 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6556ce5a: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@48a43ed4
   [junit4]   2> 1561333 INFO  (coreCloseExecutor-5266-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@2b64ffba
   [junit4]   2> 1561333 INFO  (coreCloseExecutor-5266-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=728039354
   [junit4]   2> 1561333 INFO  (coreCloseExecutor-5266-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6e6664b2: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@6d83e145
   [junit4]   2> 1561342 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@176d92e8{/solr,null,UNAVAILABLE}
   [junit4]   2> 1561342 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@7ad3e645{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1561343 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1032380638
   [junit4]   2> 1561343 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1561343 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@139c9b46: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@28702d27
   [junit4]   2> 1561351 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1561351 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@25eca97: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@4f81d748
   [junit4]   2> 1561357 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1561358 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7b378531: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@48a43ed4
   [junit4]   2> 1561358 INFO  (coreCloseExecutor-5268-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@4dd7b847
   [junit4]   2> 1561358 INFO  (coreCloseExecutor-5268-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1305983047
   [junit4]   2> 1561358 INFO  (coreCloseExecutor-5268-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@8d52f99: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@787173fe
   [junit4]   2> 1561367 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[64097E0A2606BCB3]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@7fb8c53b{/solr,null,UNAVAILABLE}
   [junit4]   2> 1561369 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting doTestIndexFetchWithMasterUrl
   [junit4]   2> 1561369 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-003/collection1
   [junit4]   2> 1561371 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1561372 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7363b66e{/solr,null,AVAILABLE}
   [junit4]   2> 1561372 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@22c27f67{HTTP/1.1,[http/1.1]}{127.0.0.1:33185}
   [junit4]   2> 1561372 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.e.j.s.Server Started @1562829ms
   [junit4]   2> 1561373 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-003/collection1/data,
 hostPort=33185}
   [junit4]   2> 1561373 ERROR 
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1561373 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 8.0.0
   [junit4]   2> 1561373 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 1561373 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1561373 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-13T10:14:36.217759Z
   [junit4]   2> 1561373 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-003/solr.xml
   [junit4]   2> 1561375 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 1561376 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1561376 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@165d3b96, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1561399 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@165d3b96
   [junit4]   2> 1561405 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@165d3b96
   [junit4]   2> 1561405 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@165d3b96
   [junit4]   2> 1561406 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-003/.
   [junit4]   2> 1561406 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1561406 INFO  (coreLoadExecutor-5275-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1561410 INFO  (coreLoadExecutor-5275-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1561414 INFO  (coreLoadExecutor-5275-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1561414 INFO  (coreLoadExecutor-5275-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1561414 INFO  (coreLoadExecutor-5275-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-003/./collection1,
 trusted=true
   [junit4]   2> 1561415 INFO  (coreLoadExecutor-5275-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 
'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@165d3b96
   [junit4]   2> 1561415 INFO  (coreLoadExecutor-5275-thread-1) [    ] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1561415 INFO  (coreLoadExecutor-5275-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-003/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-003/./collection1/data/]
   [junit4]   2> 1561416 INFO  (coreLoadExecutor-5275-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=25, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=47.9287109375, 
floorSegmentMB=0.537109375, forceMergeDeletesPctAllowed=26.109063284086137, 
segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1561438 INFO  (coreLoadExecutor-5275-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1561438 INFO  (coreLoadExecutor-5275-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1561438 INFO  (coreLoadExecutor-5275-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=34, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=15.0166015625, 
floorSegmentMB=2.15234375, forceMergeDeletesPctAllowed=24.896282497822362, 
segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.10401525682292166
   [junit4]   2> 1561439 INFO  (coreLoadExecutor-5275-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@70ea0397[collection1] main]
   [junit4]   2> 1561439 INFO  (coreLoadExecutor-5275-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-003/collection1/conf
   [junit4]   2> 1561439 INFO  (coreLoadExecutor-5275-thread-1) [    ] 
o.a.s.h.ReplicationHandler Replication enabled for following config files: 
schema.xml,xslt/dummy.xsl
   [junit4]   2> 1561439 INFO  (coreLoadExecutor-5275-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1561439 INFO  (searcherExecutor-5276-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@70ea0397[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1561440 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-004/collection1
   [junit4]   2> 1561441 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1561441 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@28f2c910{/solr,null,AVAILABLE}
   [junit4]   2> 1561441 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@f9108f0{HTTP/1.1,[http/1.1]}{127.0.0.1:36693}
   [junit4]   2> 1561441 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.e.j.s.Server Started @1562898ms
   [junit4]   2> 1561441 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-004/collection1/data,
 hostPort=36693}
   [junit4]   2> 1561442 ERROR 
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1561442 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 8.0.0
   [junit4]   2> 1561442 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 1561442 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1561442 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-13T10:14:36.286258Z
   [junit4]   2> 1561442 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001/solr-instance-004/solr.xml
   [junit4]   2> 1561443 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 1561443 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1561443 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@165d3b96, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1561460 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@165d3b96
   [junit4]   2> 1561467 INFO  
(TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[64097E0A2606BCB3])
 [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@165

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

2> 1616647 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending doTestRepeater
   [junit4]   2> 1616647 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@19d4e49{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1616647 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1554791947
   [junit4]   2> 1616647 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1616647 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@45b97da7: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@35f26ddd
   [junit4]   2> 1616648 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1616648 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@191f37ef: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@4f81d748
   [junit4]   2> 1616649 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1616649 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@53aa44fa: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@48a43ed4
   [junit4]   2> 1616649 INFO  (coreCloseExecutor-5924-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@5f7c8d80
   [junit4]   2> 1616649 INFO  (coreCloseExecutor-5924-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1601998208
   [junit4]   2> 1616649 INFO  (coreCloseExecutor-5924-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1a7e080b: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@774439b8
   [junit4]   2> 1616650 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@531a94c0{/solr,null,UNAVAILABLE}
   [junit4]   2> 1616651 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@78da9f42{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1616651 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=942277524
   [junit4]   2> 1616651 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1616651 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5cb0c375: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@4acd4e67
   [junit4]   2> 1616652 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1616652 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@282d30fd: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@4f81d748
   [junit4]   2> 1616652 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1616652 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@73b5df7d: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@48a43ed4
   [junit4]   2> 1616652 INFO  (coreCloseExecutor-5926-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@40eb44bf
   [junit4]   2> 1616653 INFO  (coreCloseExecutor-5926-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1089160383
   [junit4]   2> 1616653 INFO  (coreCloseExecutor-5926-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5e9c2c6: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@848fe3a
   [junit4]   2> 1616654 INFO  
(TEST-TestReplicationHandler.doTestRepeater-seed#[64097E0A2606BCB3]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@3cf64435{/solr,null,UNAVAILABLE}
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_64097E0A2606BCB3-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{name=PostingsFormat(name=Direct), id=PostingsFormat(name=Direct), 
newname=PostingsFormat(name=Direct)}, docValues:{}, maxPointsInLeafNode=1045, 
maxMBSortInHeap=6.749923051795299, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@416b16a7),
 locale=ff-MR, timezone=America/Phoenix
   [junit4]   2> NOTE: Linux 4.10.0-37-generic amd64/Oracle Corporation 10-ea 
(64-bit)/cpus=8,threads=1,free=190412656,total=531103744
   [junit4]   2> NOTE: All tests run in this JVM: [TestGraphTermsQParserPlugin, 
ExplicitHLLTest, TermVectorComponentTest, MinimalSchemaTest, 
CheckHdfsIndexTest, PrimitiveFieldTypeTest, TestEmbeddedSolrServerSchemaAPI, 
TestCollectionsAPIViaSolrCloudCluster, TestSchemaSimilarityResource, 
TestHdfsBackupRestoreCore, TestPullReplica, 
BigEndianAscendingWordDeserializerTest, TestUpdate, CursorMarkTest, 
OverseerCollectionConfigSetProcessorTest, MultiTermTest, 
TestSolrCloudSnapshots, TestRandomCollapseQParserPlugin, 
AnalysisAfterCoreReloadTest, TestSort, TestLegacyFieldCache, 
SystemLogListenerTest, TestCSVLoader, TestPHPSerializedResponseWriter, 
ActionThrottleTest, ForceLeaderTest, TestSkipOverseerOperations, 
TestSchemaManager, SolrMetricsIntegrationTest, CoreAdminCreateDiscoverTest, 
QueryParsingTest, PreAnalyzedFieldManagedSchemaCloudTest, 
ClassificationUpdateProcessorIntegrationTest, MoveReplicaHDFSTest, 
ConnectionManagerTest, TestCopyFieldCollectionResource, 
TestSolrDeletionPolicy1, TestCloudDeleteByQuery, TestSolrCoreParser, 
TestRestoreCore, TestIndexingPerformance, HttpSolrCallGetCoreTest, BasicZkTest, 
TestManagedSynonymGraphFilterFactory, DirectUpdateHandlerOptimizeTest, 
DistributedQueryElevationComponentTest, TestQueryUtils, 
CollectionStateFormat2Test, TestClassicSimilarityFactory, 
TestHttpShardHandlerFactory, TestHdfsCloudBackupRestore, 
CollectionsAPISolrJTest, LeaderElectionIntegrationTest, 
TestCloudSearcherWarming, TestSweetSpotSimilarityFactory, 
TestConfigSetImmutable, ZkControllerTest, CdcrReplicationDistributedZkTest, 
TestLuceneIndexBackCompat, AtomicUpdateProcessorFactoryTest, 
ExecutePlanActionTest, DistribCursorPagingTest, JavabinLoaderTest, 
LeaderInitiatedRecoveryOnCommitTest, SpatialFilterTest, 
TestCorePropertiesReload, TestStressUserVersions, TestCollationFieldDocValues, 
SearchHandlerTest, TestApiFramework, TestRandomFaceting, SolrInfoBeanTest, 
SimpleFacetsTest, TestCodecSupport, HdfsDirectoryTest, TestXmlQParserPlugin, 
TestMiniSolrCloudClusterSSL, PeerSyncTest, TestUseDocValuesAsStored2, 
ResourceLoaderTest, TestStreamBody, UpdateRequestProcessorFactoryTest, 
SolrIndexMetricsTest, TestMergePolicyConfig, TestSubQueryTransformerCrossCore, 
PKIAuthenticationIntegrationTest, TestSolrIndexConfig, BlockCacheTest, 
TestSolrJ, TestObjectReleaseTracker, TestJsonRequest, 
TestLegacyNumericRangeQueryBuilder, ResponseLogComponentTest, 
TestTestInjection, TestFoldingMultitermQuery, JsonLoaderTest, TestJoin, 
DirectoryFactoryTest, SyncSliceTest, TestCoreAdminApis, TestDistribIDF, 
CdcrVersionReplicationTest, LeaderElectionContextKeyTest, 
TestCollapseQParserPlugin, SharedFSAutoReplicaFailoverTest, 
SolrPluginUtilsTest, TestRandomDVFaceting, 
ChaosMonkeyNothingIsSafeWithPullReplicasTest, DocValuesMissingTest, 
BaseCdcrDistributedZkTest, StatelessScriptUpdateProcessorFactoryTest, 
UpdateLogTest, TestSegmentSorting, TestPostingsSolrHighlighter, 
TestHighlightDedupGrouping, V2ApiIntegrationTest, TestUninvertingReader, 
ShufflingReplicaListTransformerTest, VMParamsZkACLAndCredentialsProvidersTest, 
TestNumericRangeQuery32, TestHdfsUpdateLog, CacheHeaderTest, BJQParserTest, 
BasicDistributedZk2Test, OpenCloseCoreStressTest, ShardRoutingTest, 
RecoveryZkTest, FullSolrCloudDistribCmdsTest, TestReplicationHandler]
   [junit4] Completed [382/749 (1!)] on J0 in 66.59s, 16 tests, 1 error, 1 
skipped <<< FAILURES!

[...truncated 41292 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to