You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2016/12/06 21:49:09 UTC

[JENKINS-EA] Lucene-Solr-master-Linux (32bit/jdk-9-ea+140) - Build # 18460 - Unstable!

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/18460/
Java: 32bit/jdk-9-ea+140 -client -XX:+UseConcMarkSweepGC

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

Error Message:
expected:<1> but was:<0>

Stack Trace:
java.lang.AssertionError: expected:<1> but was:<0>
	at __randomizedtesting.SeedInfo.seed([75B1E9D0B0BEB361:82C2078876561C87]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.failNotEquals(Assert.java:647)
	at org.junit.Assert.assertEquals(Assert.java:128)
	at org.junit.Assert.assertEquals(Assert.java:472)
	at org.junit.Assert.assertEquals(Assert.java:456)
	at org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigAliasReplication(TestReplicationHandler.java:1329)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	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:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)




Build Log:
[...truncated 11497 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_75B1E9D0B0BEB361-001/init-core-data-001
   [junit4]   2> 640683 INFO  (SUITE-TestReplicationHandler-seed#[75B1E9D0B0BEB361]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl="None")
   [junit4]   2> 640685 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.SolrTestCaseJ4 ###Starting doTestRepeater
   [junit4]   2> 640685 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] 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_75B1E9D0B0BEB361-001/solr-instance-001/collection1
   [junit4]   2> 640697 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 640698 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@cad828{/solr,null,AVAILABLE}
   [junit4]   2> 640699 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@126f5b1{HTTP/1.1,[http/1.1]}{127.0.0.1:43908}
   [junit4]   2> 640699 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.Server Started @642368ms
   [junit4]   2> 640699 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] 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_75B1E9D0B0BEB361-001/solr-instance-001/collection1/data, hostPort=43908}
   [junit4]   2> 640699 ERROR (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 640699 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 7.0.0
   [junit4]   2> 640699 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 640699 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 640700 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-12-06T21:15:09.832851Z
   [junit4]   2> 640701 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] 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_75B1E9D0B0BEB361-001/solr-instance-001/solr.xml
   [junit4]   2> 640717 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] 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_75B1E9D0B0BEB361-001/solr-instance-001/.
   [junit4]   2> 640717 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 640727 WARN  (coreLoadExecutor-1744-thread-1) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 640728 INFO  (coreLoadExecutor-1744-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 640735 INFO  (coreLoadExecutor-1744-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 640737 INFO  (coreLoadExecutor-1744-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 640737 INFO  (coreLoadExecutor-1744-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_75B1E9D0B0BEB361-001/solr-instance-001/./collection1
   [junit4]   2> 640738 INFO  (coreLoadExecutor-1744-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_75B1E9D0B0BEB361-001/solr-instance-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_75B1E9D0B0BEB361-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 640738 INFO  (coreLoadExecutor-1744-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=13, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 640743 INFO  (coreLoadExecutor-1744-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 640743 INFO  (coreLoadExecutor-1744-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 640743 INFO  (coreLoadExecutor-1744-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=29, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=11.3974609375, floorSegmentMB=0.5986328125, forceMergeDeletesPctAllowed=5.724470375143591, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.29511707564011
   [junit4]   2> 640743 INFO  (coreLoadExecutor-1744-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@109b0d[collection1] main]
   [junit4]   2> 640744 INFO  (coreLoadExecutor-1744-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_75B1E9D0B0BEB361-001/solr-instance-001/collection1/conf
   [junit4]   2> 640744 INFO  (coreLoadExecutor-1744-thread-1) [    ] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 640744 INFO  (coreLoadExecutor-1744-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 640745 INFO  (searcherExecutor-1745-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@109b0d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 641222 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] 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_75B1E9D0B0BEB361-001/solr-instance-002/collection1
   [junit4]   2> 641227 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 641229 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@ccf1d0{/solr,null,AVAILABLE}
   [junit4]   2> 641229 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@b024d1{HTTP/1.1,[http/1.1]}{127.0.0.1:45831}
   [junit4]   2> 641229 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.Server Started @642898ms
   [junit4]   2> 641229 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] 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_75B1E9D0B0BEB361-001/solr-instance-002/collection1/data, hostPort=45831}
   [junit4]   2> 641229 ERROR (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 641230 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 7.0.0
   [junit4]   2> 641230 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 641230 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 641230 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-12-06T21:15:10.363197Z
   [junit4]   2> 641230 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] 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_75B1E9D0B0BEB361-001/solr-instance-002/solr.xml
   [junit4]   2> 641247 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] 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_75B1E9D0B0BEB361-001/solr-instance-002/.
   [junit4]   2> 641247 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 641261 WARN  (coreLoadExecutor-1754-thread-1) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 641261 INFO  (coreLoadExecutor-1754-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 641283 INFO  (coreLoadExecutor-1754-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 641284 INFO  (coreLoadExecutor-1754-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 641286 INFO  (coreLoadExecutor-1754-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_75B1E9D0B0BEB361-001/solr-instance-002/./collection1
   [junit4]   2> 641286 INFO  (coreLoadExecutor-1754-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_75B1E9D0B0BEB361-001/solr-instance-002/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_75B1E9D0B0BEB361-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 641287 INFO  (coreLoadExecutor-1754-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=13, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 641293 INFO  (coreLoadExecutor-1754-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 641293 INFO  (coreLoadExecutor-1754-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 641293 INFO  (coreLoadExecutor-1754-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=29, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=11.3974609375, floorSegmentMB=0.5986328125, forceMergeDeletesPctAllowed=5.724470375143591, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.29511707564011
   [junit4]   2> 641294 INFO  (coreLoadExecutor-1754-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2ca45c[collection1] main]
   [junit4]   2> 641294 INFO  (coreLoadExecutor-1754-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_75B1E9D0B0BEB361-001/solr-instance-002/collection1/conf
   [junit4]   2> 641297 INFO  (coreLoadExecutor-1754-thread-1) [    ] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
   [junit4]   2> 641297 INFO  (searcherExecutor-1755-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2ca45c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 641762 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@b024d1{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 641762 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=30793406
   [junit4]   2> 641762 INFO  (coreCloseExecutor-1760-thread-1) [    ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1aa1573
   [junit4]   2> 641764 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@ccf1d0{/solr,null,UNAVAILABLE}
   [junit4]   2> 641766 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 641767 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@8795f5{/solr,null,AVAILABLE}
   [junit4]   2> 641769 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@180116d{HTTP/1.1,[http/1.1]}{127.0.0.1:35746}
   [junit4]   2> 641769 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.Server Started @643438ms
   [junit4]   2> 641769 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] 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_75B1E9D0B0BEB361-001/solr-instance-002/collection1/data, hostPort=35746}
   [junit4]   2> 641769 ERROR (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 641769 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 7.0.0
   [junit4]   2> 641769 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 641769 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 641769 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-12-06T21:15:10.902864Z
   [junit4]   2> 641770 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] 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_75B1E9D0B0BEB361-001/solr-instance-002/solr.xml
   [junit4]   2> 641796 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] 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_75B1E9D0B0BEB361-001/solr-instance-002/.
   [junit4]   2> 641797 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 641804 WARN  (coreLoadExecutor-1767-thread-1) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 641805 INFO  (coreLoadExecutor-1767-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 641814 INFO  (coreLoadExecutor-1767-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 641816 INFO  (coreLoadExecutor-1767-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 641817 INFO  (coreLoadExecutor-1767-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_75B1E9D0B0BEB361-001/solr-instance-002/./collection1
   [junit4]   2> 641817 INFO  (coreLoadExecutor-1767-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_75B1E9D0B0BEB361-001/solr-instance-002/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_75B1E9D0B0BEB361-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 641818 INFO  (coreLoadExecutor-1767-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=13, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 641823 INFO  (coreLoadExecutor-1767-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 641823 INFO  (coreLoadExecutor-1767-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 641823 INFO  (coreLoadExecutor-1767-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=29, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=11.3974609375, floorSegmentMB=0.5986328125, forceMergeDeletesPctAllowed=5.724470375143591, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.29511707564011
   [junit4]   2> 641823 INFO  (coreLoadExecutor-1767-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1527165[collection1] main]
   [junit4]   2> 641824 INFO  (coreLoadExecutor-1767-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_75B1E9D0B0BEB361-001/solr-instance-002/collection1/conf
   [junit4]   2> 641824 INFO  (coreLoadExecutor-1767-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 641824 INFO  (searcherExecutor-1768-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1527165[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 642301 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] 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_75B1E9D0B0BEB361-001/solr-instance-003/collection1
   [junit4]   2> 642315 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 642315 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@acea0f{/solr,null,AVAILABLE}
   [junit4]   2> 642316 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@38add0{HTTP/1.1,[http/1.1]}{127.0.0.1:38884}
   [junit4]   2> 642317 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.Server Started @643986ms
   [junit4]   2> 642317 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] 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_75B1E9D0B0BEB361-001/solr-instance-003/collection1/data, hostPort=38884}
   [junit4]   2> 642317 ERROR (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 642317 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 7.0.0
   [junit4]   2> 642317 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 642317 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 642317 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-12-06T21:15:11.450805Z
   [junit4]   2> 642318 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] 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_75B1E9D0B0BEB361-001/solr-instance-003/solr.xml
   [junit4]   2> 642345 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] 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_75B1E9D0B0BEB361-001/solr-instance-003/.
   [junit4]   2> 642346 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 642353 WARN  (coreLoadExecutor-1777-thread-1) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 642354 INFO  (coreLoadExecutor-1777-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 642364 INFO  (coreLoadExecutor-1777-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 642368 INFO  (coreLoadExecutor-1777-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 642369 INFO  (coreLoadExecutor-1777-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_75B1E9D0B0BEB361-001/solr-instance-003/./collection1
   [junit4]   2> 642370 INFO  (coreLoadExecutor-1777-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_75B1E9D0B0BEB361-001/solr-instance-003/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_75B1E9D0B0BEB361-001/solr-instance-003/./collection1/data/]
   [junit4]   2> 642371 INFO  (coreLoadExecutor-1777-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=13, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 642377 INFO  (coreLoadExecutor-1777-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 642378 INFO  (coreLoadExecutor-1777-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 642378 INFO  (coreLoadExecutor-1777-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=29, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=11.3974609375, floorSegmentMB=0.5986328125, forceMergeDeletesPctAllowed=5.724470375143591, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.29511707564011
   [junit4]   2> 642378 INFO  (coreLoadExecutor-1777-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@9d3c6a[collection1] main]
   [junit4]   2> 642379 INFO  (coreLoadExecutor-1777-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_75B1E9D0B0BEB361-001/solr-instance-003/collection1/conf
   [junit4]   2> 642380 WARN  (coreLoadExecutor-1777-thread-1) [    ] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
   [junit4]   2> 642382 INFO  (coreLoadExecutor-1777-thread-1) [    ] o.a.s.h.ReplicationHandler  No value set for 'pollInterval'. Timer Task not started.
   [junit4]   2> 642382 INFO  (coreLoadExecutor-1777-thread-1) [    ] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml
   [junit4]   2> 642382 INFO  (coreLoadExecutor-1777-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 642382 INFO  (searcherExecutor-1778-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@9d3c6a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 642853 INFO  (qtp22923776-4026) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[0]} 0 0
   [junit4]   2> 642853 INFO  (qtp22923776-4027) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 0
   [junit4]   2> 642854 INFO  (qtp22923776-4028) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 0
   [junit4]   2> 642854 INFO  (qtp22923776-4028) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 642854 INFO  (qtp22923776-4028) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@be8979
   [junit4]   2> 642857 INFO  (qtp22923776-4028) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@38a8c6[collection1] main]
   [junit4]   2> 642857 INFO  (qtp22923776-4028) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 642857 INFO  (searcherExecutor-1745-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@38a8c6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C3)))}
   [junit4]   2> 642857 INFO  (qtp22923776-4028) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 3
   [junit4]   2> 642874 WARN  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
   [junit4]   2> 642878 INFO  (qtp22923776-4027) [    ] 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> 642878 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 642878 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Master's version: 1481058911987
   [junit4]   2> 642878 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 642878 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 642883 INFO  (qtp22923776-4021) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=2&qt=/replication&wt=javabin&version=2&command=filelist} status=0 QTime=4
   [junit4]   2> 642884 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Number of files in latest index in master: 10
   [junit4]   2> 642887 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=48, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=35.9951171875, floorSegmentMB=0.5888671875, forceMergeDeletesPctAllowed=27.40402128637974, segmentsPerTier=18.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 642887 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 642888 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@b11cb4 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8008f4)
   [junit4]   2> 642888 INFO  (qtp22923776-4028) [    ] 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> 642890 INFO  (qtp22923776-4022) [    ] 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> 642891 INFO  (qtp22923776-4027) [    ] 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> 642895 INFO  (qtp22923776-4021) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_Asserting_0.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 642897 INFO  (qtp22923776-4028) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_Asserting_0.tim&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 642897 INFO  (qtp22923776-4022) [    ] 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> 642898 INFO  (qtp22923776-4027) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_Asserting_0.tip&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 642899 INFO  (qtp22923776-4021) [    ] 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> 642900 INFO  (qtp22923776-4028) [    ] 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> 642901 INFO  (qtp22923776-4022) [    ] 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> 642901 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1731) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@b11cb4 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8008f4)
   [junit4]   2> 642909 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=29, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 642909 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 642910 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1a07992[collection1] main]
   [junit4]   2> 642910 INFO  (searcherExecutor-1778-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1a07992[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C3)))}
   [junit4]   2> 642910 INFO  (qtp32784722-4080) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:43908/solr/collection1/replication&command=fetchindex} status=0 QTime=37
   [junit4]   2> 642921 INFO  (qtp32784722-4082) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=3 status=0 QTime=1
   [junit4]   2> 642921 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 3 docs
   [junit4]   2> 642923 WARN  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
   [junit4]   2> 642926 INFO  (qtp32784722-4080) [    ] 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> 642926 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 642926 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Master's version: 1481058911987
   [junit4]   2> 642926 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 642926 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 642929 INFO  (qtp32784722-4076) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=2&qt=/replication&wt=javabin&version=2&command=filelist} status=0 QTime=2
   [junit4]   2> 642930 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Number of files in latest index in master: 10
   [junit4]   2> 642933 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=48, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=35.9951171875, floorSegmentMB=0.5888671875, forceMergeDeletesPctAllowed=27.40402128637974, segmentsPerTier=18.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 642933 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 642934 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@17e311b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1180f6e)
   [junit4]   2> 642935 INFO  (qtp32784722-4082) [    ] 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> 642936 INFO  (qtp32784722-4077) [    ] 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> 642938 INFO  (qtp32784722-4080) [    ] 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> 642939 INFO  (qtp32784722-4076) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_Asserting_0.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 642940 INFO  (qtp32784722-4082) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_Asserting_0.tim&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 642941 INFO  (qtp32784722-4077) [    ] 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> 642961 INFO  (qtp32784722-4080) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_Asserting_0.tip&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 642961 INFO  (qtp32784722-4076) [    ] 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> 642962 INFO  (qtp32784722-4082) [    ] 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> 642963 INFO  (qtp32784722-4077) [    ] 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> 642963 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1731) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@17e311b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1180f6e)
   [junit4]   2> 642971 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=29, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 642971 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 642976 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1f442fd[collection1] main]
   [junit4]   2> 642976 INFO  (searcherExecutor-1768-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1f442fd[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C3)))}
   [junit4]   2> 642976 INFO  (qtp25169865-4063) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:38884/solr/collection1/replication&command=fetchindex} status=0 QTime=53
   [junit4]   2> 642979 INFO  (qtp25169865-4065) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=3 status=0 QTime=0
   [junit4]   2> 642979 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 3 docs
   [junit4]   2> 642981 INFO  (qtp22923776-4026) [    ] 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> 642982 INFO  (qtp22923776-4021) [    ] 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> 642984 WARN  (qtp32784722-4075) [    ] o.a.s.h.ReplicationHandler Exception while invoking 'details' method for replication on master 
   [junit4]   2> org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:TEST_PORT/solr
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:617)
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:262)
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:251)
   [junit4]   2> 	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
   [junit4]   2> 	at org.apache.solr.handler.IndexFetcher.getDetails(IndexFetcher.java:1726)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.getReplicationDetails(ReplicationHandler.java:938)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.handleRequestBody(ReplicationHandler.java:312)
   [junit4]   2> 	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:152)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.execute(SolrCore.java:2227)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:658)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:464)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:303)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:254)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
   [junit4]   2> 	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:113)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:462)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:534)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
   [junit4]   2> 	at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
   [junit4]   2> 	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]   2> Caused by: org.apache.http.conn.HttpHostConnectException: Connect to 127.0.0.1:80 [/127.0.0.1] failed: Connection refused
   [junit4]   2> 	at org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:151)
   [junit4]   2> 	at org.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:353)
   [junit4]   2> 	at org.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:380)
   [junit4]   2> 	at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:236)
   [junit4]   2> 	at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:184)
   [junit4]   2> 	at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:88)
   [junit4]   2> 	at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
   [junit4]   2> 	at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:184)
   [junit4]   2> 	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
   [junit4]   2> 	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:515)
   [junit4]   2> 	... 36 more
   [junit4]   2> Caused by: java.net.ConnectException: Connection refused
   [junit4]   2> 	at java.net.PlainSocketImpl.socketConnect(java.base@9-ea/Native Method)
   [junit4]   2> 	at java.net.AbstractPlainSocketImpl.doConnect(java.base@9-ea/AbstractPlainSocketImpl.java:400)
   [junit4]   2> 	at java.net.AbstractPlainSocketImpl.connectToAddress(java.base@9-ea/AbstractPlainSocketImpl.java:243)
   [junit4]   2> 	at java.net.AbstractPlainSocketImpl.connect(java.base@9-ea/AbstractPlainSocketImpl.java:225)
   [junit4]   2> 	at java.net.SocksSocketImpl.connect(java.base@9-ea/SocksSocketImpl.java:402)
   [junit4]   2> 	at java.net.Socket.connect(java.base@9-ea/Socket.java:591)
   [junit4]   2> 	at org.apache.http.conn.socket.PlainConnectionSocketFactory.connectSocket(PlainConnectionSocketFactory.java:74)
   [junit4]   2> 	at org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:134)
   [junit4]   2> 	... 46 more
   [junit4]   2> 642986 INFO  (qtp32784722-4075) [    ] 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=3
   [junit4]   2> 642986 INFO  (qtp22923776-4028) [    ] 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> 642987 INFO  (qtp32784722-4076) [    ] 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> 642988 WARN  (qtp32784722-4082) [    ] o.a.s.h.ReplicationHandler Exception while invoking 'details' method for replication on master 
   [junit4]   2> org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:TEST_PORT/solr
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:617)
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:262)
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:251)
   [junit4]   2> 	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
   [junit4]   2> 	at org.apache.solr.handler.IndexFetcher.getDetails(IndexFetcher.java:1726)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.getReplicationDetails(ReplicationHandler.java:938)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.handleRequestBody(ReplicationHandler.java:312)
   [junit4]   2> 	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:152)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.execute(SolrCore.java:2227)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:658)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:464)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:303)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:254)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
   [junit4]   2> 	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:113)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:462)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:534)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
   [junit4]   2> 	at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
   [junit4]   2> 	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]   2> Caused by: org.apache.http.conn.HttpHostConnectException: Connect to 127.0.0.1:80 [/127.0.0.1] failed: Connection refused
   [junit4]   2> 	at org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:151)
   [junit4]   2> 	at org.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:353)
   [junit4]   2> 	at org.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:380)
   [junit4]   2> 	at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:236)
   [junit4]   2> 	at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:184)
   [junit4]   2> 	at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:88)
   [junit4]   2> 	at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
   [junit4]   2> 	at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:184)
   [junit4]   2> 	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
   [junit4]   2> 	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:515)
   [junit4]   2> 	... 36 more
   [junit4]   2> Caused by: java.net.ConnectException: Connection refused
   [junit4]   2> 	at java.net.PlainSocketImpl.socketConnect(java.base@9-ea/Native Method)
   [junit4]   2> 	at java.net.AbstractPlainSocketImpl.doConnect(java.base@9-ea/AbstractPlainSocketImpl.java:400)
   [junit4]   2> 	at java.net.AbstractPlainSocketImpl.connectToAddress(java.base@9-ea/AbstractPlainSocketImpl.java:243)
   [junit4]   2> 	at java.net.AbstractPlainSocketImpl.connect(java.base@9-ea/AbstractPlainSocketImpl.java:225)
   [junit4]   2> 	at java.net.SocksSocketImpl.connect(java.base@9-ea/SocksSocketImpl.java:402)
   [junit4]   2> 	at java.net.Socket.connect(java.base@9-ea/Socket.java:591)
   [junit4]   2> 	at org.apache.http.conn.socket.PlainConnectionSocketFactory.connectSocket(PlainConnectionSocketFactory.java:74)
   [junit4]   2> 	at org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:134)
   [junit4]   2> 	... 46 more
   [junit4]   2> 642990 INFO  (qtp32784722-4082) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=2
   [junit4]   2> 642991 WARN  (qtp32784722-4077) [    ] o.a.s.h.ReplicationHandler Exception while invoking 'details' method for replication on master 
   [junit4]   2> org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:TEST_PORT/solr
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:617)
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:262)
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:251)
   [junit4]   2> 	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
   [junit4]   2> 	at org.apache.solr.handler.IndexFetcher.getDetails(IndexFetcher.java:1726)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.getReplicationDetails(ReplicationHandler.java:938)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.handleRequestBody(ReplicationHandler.java:312)
   [junit4]   2> 	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:152)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.execute(SolrCore.java:2227)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:658)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:464)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:303)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:254)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
   [junit4]   2> 	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:113)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:462)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:534)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
   [junit4]   2> 	at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
   [junit4]   2> 	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]   2> Caused by: org.apache.http.conn.HttpHostConnectException: Connect to 127.0.0.1:80 [/127.0.0.1] failed: Connection refused
   [junit4]   2> 	at org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:151)
   [junit4]   2> 	at org.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:353)
   [junit4]   2> 	at org.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:380)
   [junit4]   2> 	at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:236)
   [junit4]   2> 	at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:184)
   [junit4]   2> 	at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:88)
   [junit4]   2> 	at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
   [junit4]   2> 	at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:184)
   [junit4]   2> 	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
   [junit4]   2> 	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:515)
   [junit4]   2> 	... 36 more
   [junit4]   2> Caused by: java.net.ConnectException: Connection refused
   [junit4]   2> 	at java.net.PlainSocketImpl.socketConnect(java.base@9-ea/Native Method)
   [junit4]   2> 	at java.net.AbstractPlainSocketImpl.doConnect(java.base@9-ea/AbstractPlainSocketImpl.java:400)
   [junit4]   2> 	at java.net.AbstractPlainSocketImpl.connectToAddress(java.base@9-ea/AbstractPlainSocketImpl.java:243)
   [junit4]   2> 	at java.net.AbstractPlainSocketImpl.connect(java.base@9-ea/AbstractPlainSocketImpl.java:225)
   [junit4]   2> 	at java.net.SocksSocketImpl.connect(java.base@9-ea/SocksSocketImpl.java:402)
   [junit4]   2> 	at java.net.Socket.connect(java.base@9-ea/Socket.java:591)
   [junit4]   2> 	at org.apache.http.conn.socket.PlainConnectionSocketFactory.connectSocket(PlainConnectionSocketFactory.java:74)
   [junit4]   2> 	at org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:134)
   [junit4]   2> 	... 46 more
   [junit4]   2> 642993 INFO  (qtp32784722-4077) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=2
   [junit4]   2> 642994 INFO  (qtp32784722-4080) [    ] 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> 642994 INFO  (qtp25169865-4058) [    ] 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=1
   [junit4]   2> 642995 INFO  (qtp32784722-4075) [    ] 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> 642995 INFO  (qtp25169865-4063) [    ] 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> 642996 INFO  (qtp32784722-4082) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[0]} 0 0
   [junit4]   2> 642997 INFO  (qtp32784722-4077) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 0
   [junit4]   2> 642997 INFO  (qtp32784722-4080) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 0
   [junit4]   2> 642997 INFO  (qtp32784722-4075) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[3]} 0 0
   [junit4]   2> 642998 INFO  (qtp32784722-4082) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 642998 INFO  (qtp32784722-4082) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@e44f8
   [junit4]   2> 643000 INFO  (qtp32784722-4082) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1425168[collection1] main]
   [junit4]   2> 643000 INFO  (qtp32784722-4082) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 643000 INFO  (searcherExecutor-1778-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1425168[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):C4)))}
   [junit4]   2> 643000 INFO  (qtp32784722-4082) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 2
   [junit4]   2> 643001 WARN  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
   [junit4]   2> 643003 INFO  (qtp22923776-4027) [    ] 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> 643003 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 643003 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Master's version: 1481058911987
   [junit4]   2> 643003 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Slave's generation: 3
   [junit4]   2> 643004 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 643007 INFO  (qtp22923776-4026) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=2&qt=/replication&wt=javabin&version=2&command=filelist} status=0 QTime=3
   [junit4]   2> 643008 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Number of files in latest index in master: 10
   [junit4]   2> 643008 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Starting download (fullCopy=true) to MockDirectoryWrapper(RAMDirectory@16059c9 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@565de1)
   [junit4]   2> 643009 INFO  (qtp22923776-4021) [    ] 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> 643020 INFO  (qtp22923776-4028) [    ] 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> 643020 INFO  (qtp22923776-4027) [    ] 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> 643021 INFO  (qtp22923776-4026) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_Asserting_0.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 643022 INFO  (qtp22923776-4021) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_Asserting_0.tim&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 643022 INFO  (qtp22923776-4028) [    ] 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> 643023 INFO  (qtp22923776-4027) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_Asserting_0.tip&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 643024 INFO  (qtp22923776-4026) [    ] 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> 643024 INFO  (qtp22923776-4021) [    ] 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> 643029 INFO  (qtp22923776-4028) [    ] 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> 643029 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=true,bytesDownloaded=1731) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@16059c9 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@565de1)
   [junit4]   2> 643030 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher New index installed. Updating index properties... index=index.20161206191512141
   [junit4]   2> 643031 WARN  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Exception while updating statistics
   [junit4]   2> java.io.IOException: file "replication.properties" was already written to
   [junit4]   2> 	at org.apache.lucene.store.MockDirectoryWrapper.createOutput(MockDirectoryWrapper.java:654)
   [junit4]   2> 	at org.apache.solr.handler.IndexFetcher.logReplicationTimeAndConfFiles(IndexFetcher.java:689)
   [junit4]   2> 	at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:501)
   [junit4]   2> 	at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:265)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:397)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.lambda$handleRequestBody$0(ReplicationHandler.java:279)
   [junit4]   2> 	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]   2> 643031 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher removing old index directory MockDirectoryWrapper(RAMDirectory@1fa591b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@163ae88)
   [junit4]   2> 643031 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=48, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=35.9951171875, floorSegmentMB=0.5888671875, forceMergeDeletesPctAllowed=27.40402128637974, segmentsPerTier=18.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 643032 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 643032 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@152793c[collection1] main]
   [junit4]   2> 643032 INFO  (searcherExecutor-1778-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@152793c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C3)))}
   [junit4]   2> 643032 INFO  (qtp32784722-4081) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:43908/solr/collection1/replication&command=fetchindex} status=0 QTime=31
   [junit4]   2> 643033 INFO  (qtp32784722-4077) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=3 status=0 QTime=0
   [junit4]   2> 643034 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 3 docs
   [junit4]   2> 643034 WARN  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
   [junit4]   2> 643036 INFO  (qtp32784722-4076) [    ] 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> 643037 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 643037 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Master's version: 1481058911987
   [junit4]   2> 643037 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Slave's generation: 2
   [junit4]   2> 643037 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Slave in sync with master.
   [junit4]   2> 643037 INFO  (qtp25169865-4064) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:38884/solr/collection1/replication&command=fetchindex} status=0 QTime=2
   [junit4]   2> 643038 INFO  (qtp25169865-4059) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=3 status=0 QTime=0
   [junit4]   2> 643038 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 3 docs
   [junit4]   2> 643040 INFO  (qtp22923776-4022) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[3]} 0 1
   [junit4]   2> 643041 INFO  (qtp22923776-4026) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[4]} 0 0
   [junit4]   2> 643041 INFO  (qtp22923776-4021) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[5]} 0 0
   [junit4]   2> 643041 INFO  (qtp22923776-4028) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 643041 INFO  (qtp22923776-4028) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@be8979
   [junit4]   2> 643043 INFO  (qtp22923776-4028) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@167a45[collection1] main]
   [junit4]   2> 643043 INFO  (qtp22923776-4028) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 643043 INFO  (searcherExecutor-1745-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@167a45[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C3) Uninverting(_1(7.0.0):C3)))}
   [junit4]   2> 643043 INFO  (qtp22923776-4028) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 2
   [junit4]   2> 643044 WARN  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
   [junit4]   2> 643046 INFO  (qtp22923776-4027) [    ] 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> 643046 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Master's generation: 3
   [junit4]   2> 643046 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Master's version: 1481058912174
   [junit4]   2> 643046 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Slave's generation: 2
   [junit4]   2> 643046 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 643048 INFO  (qtp22923776-4026) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=3&qt=/replication&wt=javabin&version=2&command=filelist} status=0 QTime=1
   [junit4]   2> 643049 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Number of files in latest index in master: 19
   [junit4]   2> 643050 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=48, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=35.9951171875, floorSegmentMB=0.5888671875, forceMergeDeletesPctAllowed=27.40402128637974, segmentsPerTier=18.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 643050 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 643050 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@4a1372 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ded8e1)
   [junit4]   2> 643050 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 643050 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
   [junit4]   2> 643050 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
   [junit4]   2> 643050 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Skipping download for _0_Asserting_0.doc because it already exists
   [junit4]   2> 643050 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Skipping download for _0_Asserting_0.tim because it already exists
   [junit4]   2> 643050 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
   [junit4]   2> 643050 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Skipping download for _0_Asserting_0.tip because it already exists
   [junit4]   2> 643050 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
   [junit4]   2> 643050 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
   [junit4]   2> 643051 INFO  (qtp22923776-4021) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1_Asserting_0.tip&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 643052 INFO  (qtp22923776-4028) [    ] 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> 643053 INFO  (qtp22923776-4027) [    ] 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> 643054 INFO  (qtp22923776-4026) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1_Asserting_0.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 643060 INFO  (qtp22923776-4021) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1_Asserting_0.tim&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 643061 INFO  (qtp22923776-4028) [    ] 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> 643062 INFO  (qtp22923776-4027) [    ] 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> 643062 INFO  (qtp22923776-4026) [    ] 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> 643063 INFO  (qtp22923776-4021) [    ] 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> 643064 INFO  (qtp22923776-4028) [    ] 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> 643065 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1794) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@4a1372 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ded8e1)
   [junit4]   2> 643066 WARN  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Exception while updating statistics
   [junit4]   2> java.io.IOException: file "replication.properties" was already written to
   [junit4]   2> 	at org.apache.lucene.store.MockDirectoryWrapper.createOutput(MockDirectoryWrapper.java:654)
   [junit4]   2> 	at org.apache.solr.handler.IndexFetcher.logReplicationTimeAndConfFiles(IndexFetcher.java:689)
   [junit4]   2> 	at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:501)
   [junit4]   2> 	at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:265)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:397)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.lambda$handleRequestBody$0(ReplicationHandler.java:279)
   [junit4]   2> 	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]   2> 643067 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=29, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 643067 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 643068 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1333773[collection1] main]
   [junit4]   2> 643068 INFO  (searcherExecutor-1778-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1333773[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C3) Uninverting(_1(7.0.0):C3)))}
   [junit4]   2> 643068 INFO  (qtp32784722-4080) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:43908/solr/collection1/replication&command=fetchindex} status=0 QTime=23
   [junit4]   2> 643069 INFO  (qtp32784722-4075) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=6 status=0 QTime=0
   [junit4]   2> 643070 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 6 docs
   [junit4]   2> 643070 WARN  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
   [junit4]   2> 643072 INFO  (qtp32784722-4082) [    ] 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> 643073 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Master's generation: 3
   [junit4]   2> 643073 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Master's version: 1481058912174
   [junit4]   2> 643073 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Slave's generation: 2
   [junit4]   2> 643073 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 643104 INFO  (qtp32784722-4076) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=3&qt=/replication&wt=javabin&version=2&command=filelist} status=0 QTime=31
   [junit4]   2> 643104 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Number of files in latest index in master: 19
   [junit4]   2> 643106 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=48, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=35.9951171875, floorSegmentMB=0.5888671875, forceMergeDeletesPctAllowed=27.40402128637974, segmentsPerTier=18.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 643106 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 643106 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@5210ef lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@103dd6)
   [junit4]   2> 643106 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 643106 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
   [junit4]   2> 643106 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
   [junit4]   2> 643106 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Skipping download for _0_Asserting_0.doc because it already exists
   [junit4]   2> 643106 INFO  (explici

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

.store.SingleInstanceLockFactory@1e20c06)
   [junit4]   2> 751852 INFO  (qtp24671078-5066) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 751853 INFO  (qtp24671078-5060) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 751853 INFO  (qtp24671078-5061) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 751854 INFO  (qtp24671078-5062) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0_Asserting_0.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 751860 INFO  (qtp24671078-5066) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0_Asserting_0.tim&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 751861 INFO  (qtp24671078-5060) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 751862 INFO  (qtp24671078-5061) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0_Asserting_0.tip&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 751862 INFO  (qtp24671078-5062) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0.fnm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 751863 INFO  (qtp24671078-5066) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0.nvm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 751863 INFO  (qtp24671078-5060) [    ] 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> 751864 INFO  (indexFetcher-2392-thread-1) [    ] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1703) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@3c517e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e20c06)
   [junit4]   2> 751865 WARN  (indexFetcher-2392-thread-1) [    ] o.a.s.h.IndexFetcher Exception while updating statistics
   [junit4]   2> java.io.IOException: file "replication.properties" was already written to
   [junit4]   2> 	at org.apache.lucene.store.MockDirectoryWrapper.createOutput(MockDirectoryWrapper.java:654)
   [junit4]   2> 	at org.apache.solr.handler.IndexFetcher.logReplicationTimeAndConfFiles(IndexFetcher.java:689)
   [junit4]   2> 	at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:501)
   [junit4]   2> 	at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:265)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:397)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$2(ReplicationHandler.java:1154)
   [junit4]   2> 	at java.util.concurrent.Executors$RunnableAdapter.call(java.base@9-ea/Executors.java:514)
   [junit4]   2> 	at java.util.concurrent.FutureTask.runAndReset(java.base@9-ea/FutureTask.java:305)
   [junit4]   2> 	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(java.base@9-ea/ScheduledThreadPoolExecutor.java:300)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@9-ea/ThreadPoolExecutor.java:1161)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@9-ea/ThreadPoolExecutor.java:635)
   [junit4]   2> 	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]   2> 751865 INFO  (indexFetcher-2392-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=22, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 751866 INFO  (indexFetcher-2392-thread-1) [    ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 751866 INFO  (indexFetcher-2392-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@155b419[collection1] main]
   [junit4]   2> 751866 INFO  (searcherExecutor-2388-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@155b419[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C2)))}
   [junit4]   2> 751933 INFO  (qtp23441574-5085) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=2 status=0 QTime=0
   [junit4]   2> 751934 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.h.TestReplicationHandler Waited for 900ms and found 2 docs
   [junit4]   2> 751934 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.SolrTestCaseJ4 ###Ending doTestReplicateAfterCoreReload
   [junit4]   2> 751934 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@c694a6{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 751934 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2670406
   [junit4]   2> 751935 INFO  (coreCloseExecutor-2399-thread-1) [    ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1b021ad
   [junit4]   2> 751935 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@317ab8{/solr,null,UNAVAILABLE}
   [junit4]   2> 751936 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@1fba559{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 751936 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[75B1E9D0B0BEB361]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=29646857
   [junit4]   2> 751936 INFO  (coreCloseExecutor-2401-thread-1) [    ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1bd88fb
   [junit4]   2> 751937 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[75B1E9D0B0BEB361]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1bc5bf2{/solr,null,UNAVAILABLE}
   [junit4]   2> 751938 INFO  (SUITE-TestReplicationHandler-seed#[75B1E9D0B0BEB361]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [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_75B1E9D0B0BEB361-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70), sim=RandomSimilarity(queryNorm=true): {}, locale=en-RW, timezone=Etc/GMT+2
   [junit4]   2> NOTE: Linux 4.4.0-47-generic i386/Oracle Corporation 9-ea (32-bit)/cpus=12,threads=1,free=59726784,total=307642368
   [junit4]   2> NOTE: All tests run in this JVM: [CacheHeaderTest, TestFieldTypeCollectionResource, TestPseudoReturnFields, TestSolrFieldCacheMBean, TestStressLucene, DisMaxRequestHandlerTest, VMParamsZkACLAndCredentialsProvidersTest, PolyFieldTest, StressHdfsTest, TestDistribIDF, CurrencyFieldOpenExchangeTest, TestObjectReleaseTracker, GraphQueryTest, TestIntervalFaceting, MigrateRouteKeyTest, TestSimpleQParserPlugin, TestSerializedLuceneMatchVersion, TestLFUCache, CollectionTooManyReplicasTest, TestSuggestSpellingConverter, TestClassicSimilarityFactory, DocExpirationUpdateProcessorFactoryTest, TestSubQueryTransformerDistrib, TestDownShardTolerantSearch, TestSolrDynamicMBean, TestLMJelinekMercerSimilarityFactory, TestDFRSimilarityFactory, PKIAuthenticationIntegrationTest, DateMathParserTest, DistributedVersionInfoTest, ZkNodePropsTest, SparseHLLTest, JSONWriterTest, TestCloudInspectUtil, SpellPossibilityIteratorTest, CachingDirectoryFactoryTest, TestHighFrequencyDictionaryFactory, ScriptEngineTest, RequiredFieldsTest, ResponseLogComponentTest, TestRandomFaceting, DistributedSpellCheckComponentTest, TestRTGBase, TestManagedSchemaAPI, RollingRestartTest, TestRandomFlRTGCloud, PreAnalyzedUpdateProcessorTest, DataDrivenBlockJoinTest, XsltUpdateRequestHandlerTest, SolrXmlInZkTest, TestJmxMonitoredMap, QueryEqualityTest, TestAnalyzedSuggestions, FileBasedSpellCheckerTest, HttpPartitionTest, CloudExitableDirectoryReaderTest, TestSolr4Spatial, TestAtomicUpdateErrorCases, TestCustomDocTransformer, UUIDFieldTest, TestJmxIntegration, BlockJoinFacetDistribTest, TestSSLRandomization, TestQuerySenderListener, TestBadConfig, TestDocTermOrds, BadCopyFieldTest, TestPerFieldSimilarityWithDefaultOverride, TestExceedMaxTermLength, DocumentAnalysisRequestHandlerTest, HdfsTlogReplayBufferedWhileIndexingTest, TestFieldCacheSanityChecker, SystemInfoHandlerTest, TestBlendedInfixSuggestions, HdfsRestartWhileUpdatingTest, TestReloadAndDeleteDocs, TestReplicationHandler]
   [junit4] Completed [282/659 (1!)] on J0 in 111.28s, 15 tests, 1 failure, 1 skipped <<< FAILURES!

[...truncated 52685 lines...]