Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/21018/
Java: 64bit/jdk1.8.0_144 -XX:+UseCompressedOops -XX:+UseG1GC

2 tests failed.
FAILED:  
org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testNodeAddedTriggerRestoreState

Error Message:
The trigger did not fire at all

Stack Trace:
java.lang.AssertionError: The trigger did not fire at all
        at 
__randomizedtesting.SeedInfo.seed([A4BEF2A25F9A8A2A:2C837BDD655A6B87]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testNodeAddedTriggerRestoreState(TriggerIntegrationTest.java:414)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  
org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigReplication

Error Message:
Index: 0, Size: 0

Stack Trace:
java.lang.IndexOutOfBoundsException: Index: 0, Size: 0
        at 
__randomizedtesting.SeedInfo.seed([A4BEF2A25F9A8A2A:B0F6A9F77C9D3734]:0)
        at java.util.ArrayList.rangeCheck(ArrayList.java:653)
        at java.util.ArrayList.get(ArrayList.java:429)
        at 
org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigReplication(TestReplicationHandler.java:561)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 12878 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/init-core-data-001
   [junit4]   2> 1366527 WARN  
(SUITE-TestReplicationHandler-seed#[A4BEF2A25F9A8A2A]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=43 numCloses=43
   [junit4]   2> 1366527 INFO  
(SUITE-TestReplicationHandler-seed#[A4BEF2A25F9A8A2A]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1366528 INFO  
(SUITE-TestReplicationHandler-seed#[A4BEF2A25F9A8A2A]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
   [junit4]   2> 1366528 INFO  
(SUITE-TestReplicationHandler-seed#[A4BEF2A25F9A8A2A]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1366529 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testEmptyCommits
   [junit4]   2> 1366529 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-001/collection1
   [junit4]   2> 1366531 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1366532 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@be24f4{/solr,null,AVAILABLE}
   [junit4]   2> 1366532 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@3d8ae696{HTTP/1.1,[http/1.1]}{127.0.0.1:36293}
   [junit4]   2> 1366532 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.e.j.s.Server Started @1375218ms
   [junit4]   2> 1366532 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-001/collection1/data,
 hostContext=/solr, hostPort=36293}
   [junit4]   2> 1366532 ERROR 
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1366532 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1366532 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1366532 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1366532 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-12-03T08:19:14.119Z
   [junit4]   2> 1366533 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-001/solr.xml
   [junit4]   2> 1366535 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1366535 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1366536 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1366557 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a
   [junit4]   2> 1366563 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a
   [junit4]   2> 1366564 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a
   [junit4]   2> 1366565 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-001/.
   [junit4]   2> 1366565 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1366565 INFO  (coreLoadExecutor-5046-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1366573 INFO  (coreLoadExecutor-5046-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1366578 INFO  (coreLoadExecutor-5046-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1366579 INFO  (coreLoadExecutor-5046-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1366579 INFO  (coreLoadExecutor-5046-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-001/./collection1,
 trusted=true
   [junit4]   2> 1366579 INFO  (coreLoadExecutor-5046-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a
   [junit4]   2> 1366580 INFO  (coreLoadExecutor-5046-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1366580 INFO  (coreLoadExecutor-5046-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-001/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 1366581 INFO  (coreLoadExecutor-5046-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=28, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.11845946917097275]
   [junit4]   2> 1366600 INFO  (coreLoadExecutor-5046-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1366600 INFO  (coreLoadExecutor-5046-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1366601 INFO  (coreLoadExecutor-5046-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=204349093, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 1366601 INFO  (coreLoadExecutor-5046-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@191951a8[collection1] main]
   [junit4]   2> 1366601 INFO  (coreLoadExecutor-5046-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-001/collection1/conf
   [junit4]   2> 1366601 INFO  (coreLoadExecutor-5046-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 1366601 INFO  (coreLoadExecutor-5046-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1366602 INFO  
(searcherExecutor-5047-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@191951a8[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1366603 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-002/collection1
   [junit4]   2> 1366604 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1366605 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2e212d5c{/solr,null,AVAILABLE}
   [junit4]   2> 1366605 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@67c1cf4c{HTTP/1.1,[http/1.1]}{127.0.0.1:32787}
   [junit4]   2> 1366605 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.e.j.s.Server Started @1375291ms
   [junit4]   2> 1366605 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-002/collection1/data,
 hostContext=/solr, hostPort=32787}
   [junit4]   2> 1366606 ERROR 
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1366606 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1366606 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1366606 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1366606 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-12-03T08:19:14.193Z
   [junit4]   2> 1366606 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-002/solr.xml
   [junit4]   2> 1366608 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1366608 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1366609 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1366629 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a
   [junit4]   2> 1366636 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a
   [junit4]   2> 1366636 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a
   [junit4]   2> 1366637 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-002/.
   [junit4]   2> 1366638 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1366638 INFO  (coreLoadExecutor-5056-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1366644 INFO  (coreLoadExecutor-5056-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1366647 INFO  (coreLoadExecutor-5056-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1366648 INFO  (coreLoadExecutor-5056-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1366648 INFO  (coreLoadExecutor-5056-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-002/./collection1,
 trusted=true
   [junit4]   2> 1366648 INFO  (coreLoadExecutor-5056-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a
   [junit4]   2> 1366648 INFO  (coreLoadExecutor-5056-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1366648 INFO  (coreLoadExecutor-5056-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-002/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 1366661 INFO  (coreLoadExecutor-5056-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=28, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.11845946917097275]
   [junit4]   2> 1366682 INFO  (coreLoadExecutor-5056-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1366682 INFO  (coreLoadExecutor-5056-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1366682 INFO  (coreLoadExecutor-5056-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=204349093, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 1366683 INFO  (coreLoadExecutor-5056-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@19eefa53[collection1] main]
   [junit4]   2> 1366683 INFO  (coreLoadExecutor-5056-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-002/collection1/conf
   [junit4]   2> 1366684 INFO  (coreLoadExecutor-5056-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 
1000ms
   [junit4]   2> 1366684 INFO  (coreLoadExecutor-5056-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1366685 INFO  
(searcherExecutor-5057-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@19eefa53[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1366685 INFO  (qtp199974993-66588) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 1366685 INFO  (qtp199974993-66590) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 1366685 INFO  (indexFetcher-5061-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 1
   [junit4]   2> 1366685 INFO  (indexFetcher-5061-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 0
   [junit4]   2> 1366685 INFO  (indexFetcher-5061-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 1366685 INFO  (indexFetcher-5061-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's version: 0
   [junit4]   2> 1366685 INFO  (indexFetcher-5061-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher New index in Master. Deleting mine...
   [junit4]   2> 1366685 INFO  (indexFetcher-5061-thread-1) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1366685 INFO  (indexFetcher-5061-thread-1) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@4be168ee commitCommandVersion:0
   [junit4]   2> 1366686 INFO  (indexFetcher-5061-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@7b7a6aea[collection1] main]
   [junit4]   2> 1366686 INFO  (qtp199974993-66583) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[1]} 0 0
   [junit4]   2> 1366686 INFO  (indexFetcher-5061-thread-1) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1366686 INFO  (qtp199974993-66584) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1366686 INFO  (qtp199974993-66584) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@2e5b333d commitCommandVersion:0
   [junit4]   2> 1366687 INFO  
(searcherExecutor-5057-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@7b7a6aea[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1366688 INFO  (qtp199974993-66584) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@73cf4b22[collection1] main]
   [junit4]   2> 1366688 INFO  (qtp199974993-66584) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1366689 INFO  
(searcherExecutor-5047-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@73cf4b22[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c1)))}
   [junit4]   2> 1366689 INFO  (qtp199974993-66584) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={commit=true&wt=javabin&version=2}{commit=} 0 2
   [junit4]   2> 1366691 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 1366692 INFO  (qtp199974993-66589) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 1366692 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 1366692 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1512289154273
   [junit4]   2> 1366692 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 2
   [junit4]   2> 1366692 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's version: 1512289154272
   [junit4]   2> 1366692 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 1366694 INFO  (qtp199974993-66590) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&tlogFiles=false&wt=javabin&version=2&command=filelist}
 status=0 QTime=1
   [junit4]   2> 1366694 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 4
   [junit4]   2> 1366694 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=true) to 
MockDirectoryWrapper(RAMDirectory@5a1c2baf 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5db6a9b2)
   [junit4]   2> 1366695 INFO  (qtp199974993-66583) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.cfe&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1366696 INFO  (qtp199974993-66584) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1366697 INFO  (qtp199974993-66589) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.cfs&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1366697 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher File segments_2 did not match. expected checksum is 
3638313304 and actual is checksum 4288546867. expected length is 182 and actual 
length is 117
   [junit4]   2> 1366697 INFO  (qtp199974993-66590) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=segments_2&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1366698 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=true,bytesDownloaded=2081) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@5a1c2baf 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5db6a9b2)
   [junit4]   2> 1366698 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore Updating index properties... index=index.20171203101914281
   [junit4]   2> 1366698 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher removing old index directory 
MockDirectoryWrapper(RAMDirectory@7b2f6d09 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5617559c)
   [junit4]   2> 1366699 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=44, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=42.4208984375, 
floorSegmentMB=2.0234375, forceMergeDeletesPctAllowed=4.866432793447334, 
segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4305311751837777
   [junit4]   2> 1366699 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1366699 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@94ba0a0[collection1] main]
   [junit4]   2> 1366700 INFO  
(searcherExecutor-5057-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@94ba0a0[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c1)))}
   [junit4]   2> 1366701 INFO  (qtp861254588-66605) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:36293/solr/collection1/replication&command=fetchindex}
 status=0 QTime=10
   [junit4]   2> 1366702 INFO  (qtp861254588-66607) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=name:empty1&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 1366702 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
   [junit4]   2> 1366702 INFO  (qtp199974993-66588) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=0
   [junit4]   2> 1366703 INFO  (qtp199974993-66584) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=0
   [junit4]   2> 1366704 INFO  (qtp199974993-66583) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={slave=false&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=0
   [junit4]   2> 1366704 INFO  (qtp861254588-66600) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=1
   [junit4]   2> 1366704 INFO  (qtp199974993-66589) [    x:collection1] 
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> 1366705 INFO  (qtp861254588-66605) [    x:collection1] 
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> 1366705 INFO  (qtp199974993-66588) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1366705 INFO  (qtp199974993-66588) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 1366705 INFO  (qtp199974993-66588) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1366705 INFO  (qtp199974993-66588) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={commit=true&wt=javabin&version=2}{commit=} 0 0
   [junit4]   2> 1366706 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 1366707 INFO  (qtp199974993-66590) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 1366707 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 1366707 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1512289154273
   [junit4]   2> 1366707 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 2
   [junit4]   2> 1366707 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's version: 1512289154273
   [junit4]   2> 1366707 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave in sync with master.
   [junit4]   2> 1366707 INFO  (qtp861254588-66606) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:36293/solr/collection1/replication&command=fetchindex}
 status=0 QTime=1
   [junit4]   2> 1366709 INFO  (qtp199974993-66584) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[2]} 0 0
   [junit4]   2> 1366709 INFO  (qtp199974993-66589) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1366709 INFO  (qtp199974993-66589) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@2e5b333d commitCommandVersion:0
   [junit4]   2> 1366710 INFO  (qtp199974993-66589) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@16e76b9[collection1] main]
   [junit4]   2> 1366711 INFO  (qtp199974993-66589) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1366711 INFO  
(searcherExecutor-5047-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@16e76b9[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c1)
 Uninverting(_1(8.0.0):c1)))}
   [junit4]   2> 1366712 INFO  (qtp199974993-66589) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={commit=true&wt=javabin&version=2}{commit=} 0 2
   [junit4]   2> 1366712 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 1366713 INFO  (qtp199974993-66583) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 1366713 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 3
   [junit4]   2> 1366713 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1512289154296
   [junit4]   2> 1366713 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 2
   [junit4]   2> 1366713 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's version: 1512289154273
   [junit4]   2> 1366713 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 1366714 INFO  (qtp199974993-66583) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&tlogFiles=false&wt=javabin&version=2&command=filelist}
 status=0 QTime=0
   [junit4]   2> 1366714 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 7
   [junit4]   2> 1366715 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=44, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=42.4208984375, 
floorSegmentMB=2.0234375, forceMergeDeletesPctAllowed=4.866432793447334, 
segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4305311751837777
   [junit4]   2> 1366715 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1366716 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@3ab01a30 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@35d67e3f)
   [junit4]   2> 1366716 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.cfe because it already exists
   [junit4]   2> 1366716 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 1366716 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.cfs because it already exists
   [junit4]   2> 1366716 INFO  (qtp199974993-66584) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.cfs&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1366717 INFO  (qtp199974993-66589) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.cfe&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1366717 INFO  (qtp199974993-66590) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1366718 INFO  (qtp199974993-66583) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=segments_3&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1366718 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=2143) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@3ab01a30 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@35d67e3f)
   [junit4]   2> 1366719 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=39, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=35.4677734375, 
floorSegmentMB=1.2607421875, forceMergeDeletesPctAllowed=24.521444327522087, 
segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7064337164634312
   [junit4]   2> 1366719 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1366720 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@35eab6b1[collection1] main]
   [junit4]   2> 1366721 INFO  
(searcherExecutor-5057-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@35eab6b1[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c1)
 Uninverting(_1(8.0.0):c1)))}
   [junit4]   2> 1366721 INFO  (qtp861254588-66607) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:36293/solr/collection1/replication&command=fetchindex}
 status=0 QTime=8
   [junit4]   2> 1366722 INFO  (qtp861254588-66601) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=name:empty2&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 1366722 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
   [junit4]   2> 1366722 INFO  (qtp199974993-66588) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=0
   [junit4]   2> 1366726 INFO  (qtp199974993-66589) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=3
   [junit4]   2> 1366730 INFO  (qtp199974993-66584) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={slave=false&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=0
   [junit4]   2> 1366730 INFO  (qtp861254588-66605) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=2
   [junit4]   2> 1366731 INFO  (qtp199974993-66590) [    x:collection1] 
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> 1366731 INFO  (qtp861254588-66606) [    x:collection1] 
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> 1366732 INFO  (qtp199974993-66590) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[3]} 0 0
   [junit4]   2> 1366732 INFO  (qtp199974993-66589) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1366732 INFO  (qtp199974993-66589) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@2e5b333d commitCommandVersion:0
   [junit4]   2> 1366734 INFO  (qtp199974993-66589) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@5a397174[collection1] realtime]
   [junit4]   2> 1366734 INFO  (qtp199974993-66589) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1366734 INFO  (qtp199974993-66589) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={openSearcher=false&commit=true&wt=javabin&version=2}{commit=} 0 2
   [junit4]   2> 1366735 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 1366736 INFO  (qtp199974993-66583) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 1366736 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 4
   [junit4]   2> 1366736 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1512289154319
   [junit4]   2> 1366736 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 3
   [junit4]   2> 1366736 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's version: 1512289154296
   [junit4]   2> 1366736 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 1366737 INFO  (qtp199974993-66583) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&tlogFiles=false&wt=javabin&version=2&command=filelist}
 status=0 QTime=0
   [junit4]   2> 1366737 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 10
   [junit4]   2> 1366738 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=44, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=42.4208984375, 
floorSegmentMB=2.0234375, forceMergeDeletesPctAllowed=4.866432793447334, 
segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4305311751837777
   [junit4]   2> 1366738 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1366738 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1366738 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1367738 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1367739 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1368739 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1368739 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1369739 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1369739 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1370740 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1370740 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1371740 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1371740 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1372740 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1372740 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1373741 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1373741 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1374741 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1374741 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1375741 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1375741 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1376741 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 1376742 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused lucene index files 
to be delete-able
   [junit4]   2> 1377742 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher IndexFetcher slept for 11000ms for unused lucene index 
files to be delete-able
   [junit4]   2> 1377742 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@339ff2ca 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3859d2c)
   [junit4]   2> 1377742 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.cfe because it already exists
   [junit4]   2> 1377742 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 1377742 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.cfs because it already exists
   [junit4]   2> 1377742 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.cfs because it already exists
   [junit4]   2> 1377742 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.cfe because it already exists
   [junit4]   2> 1377742 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.si because it already exists
   [junit4]   2> 1377744 INFO  (qtp199974993-66590) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_2.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1377752 INFO  (qtp199974993-66589) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_2.cfe&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1377753 INFO  (qtp199974993-66588) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_2.cfs&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1377819 INFO  (qtp199974993-66588) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=segments_4&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1377823 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=2205) : 11 secs (200 bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@339ff2ca 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3859d2c)
   [junit4]   2> 1377823 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=39, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=35.4677734375, 
floorSegmentMB=1.2607421875, forceMergeDeletesPctAllowed=24.521444327522087, 
segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7064337164634312
   [junit4]   2> 1377824 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1377824 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@6b79636e[collection1] main]
   [junit4]   2> 1377826 INFO  
(searcherExecutor-5057-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6b79636e[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c1)
 Uninverting(_1(8.0.0):c1) Uninverting(_2(8.0.0):c1)))}
   [junit4]   2> 1377826 INFO  (qtp861254588-66600) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:36293/solr/collection1/replication&command=fetchindex}
 status=0 QTime=11091
   [junit4]   2> 1377844 INFO  (qtp199974993-66584) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=name:empty3&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 1377844 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.h.TestReplicationHandler Waited for 0ms and found 0 docs
   [junit4]   2> 1377846 INFO  (qtp861254588-66607) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=name:empty3&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 1377846 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
   [junit4]   2> 1377851 INFO  (qtp199974993-66584) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[4]} 0 3
   [junit4]   2> 1377852 INFO  (qtp199974993-66583) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1377852 INFO  (qtp199974993-66583) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@2e5b333d commitCommandVersion:0
   [junit4]   2> 1377854 INFO  (qtp199974993-66583) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@777f0e17[collection1] main]
   [junit4]   2> 1377855 INFO  (qtp199974993-66583) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1377856 INFO  
(searcherExecutor-5047-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@777f0e17[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c1)
 Uninverting(_1(8.0.0):c1) Uninverting(_2(8.0.0):c1) 
Uninverting(_3(8.0.0):c1)))}
   [junit4]   2> 1377856 INFO  (qtp199974993-66583) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={commit=true&wt=javabin&version=2}{commit=} 0 3
   [junit4]   2> 1377862 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 1377863 INFO  (qtp199974993-66590) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 1377864 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 5
   [junit4]   2> 1377864 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1512289165439
   [junit4]   2> 1377864 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 4
   [junit4]   2> 1377864 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's version: 1512289154319
   [junit4]   2> 1377864 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 1377864 INFO  (qtp199974993-66590) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=5&qt=/replication&tlogFiles=false&wt=javabin&version=2&command=filelist}
 status=0 QTime=0
   [junit4]   2> 1377865 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 13
   [junit4]   2> 1377867 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=44, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=42.4208984375, 
floorSegmentMB=2.0234375, forceMergeDeletesPctAllowed=4.866432793447334, 
segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4305311751837777
   [junit4]   2> 1377867 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1377867 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@76d1b1a 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3ff1cbb0)
   [junit4]   2> 1377867 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.cfe because it already exists
   [junit4]   2> 1377867 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 1377867 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.cfs because it already exists
   [junit4]   2> 1377867 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.cfs because it already exists
   [junit4]   2> 1377867 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.cfe because it already exists
   [junit4]   2> 1377867 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.si because it already exists
   [junit4]   2> 1377867 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _2.si because it already exists
   [junit4]   2> 1377868 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _2.cfe because it already exists
   [junit4]   2> 1377868 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _2.cfs because it already exists
   [junit4]   2> 1377868 INFO  (qtp199974993-66584) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=5&qt=/replication&file=_3.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1377875 INFO  (qtp199974993-66583) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=5&qt=/replication&file=_3.cfs&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1377876 INFO  (qtp199974993-66589) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=5&qt=/replication&file=_3.cfe&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1377877 INFO  (qtp199974993-66590) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=5&qt=/replication&file=segments_5&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1377877 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=2267) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@76d1b1a 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3ff1cbb0)
   [junit4]   2> 1377880 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=39, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=35.4677734375, 
floorSegmentMB=1.2607421875, forceMergeDeletesPctAllowed=24.521444327522087, 
segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7064337164634312
   [junit4]   2> 1377881 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1377881 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@5218449b[collection1] main]
   [junit4]   2> 1377883 INFO  
(searcherExecutor-5057-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@5218449b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c1)
 Uninverting(_1(8.0.0):c1) Uninverting(_2(8.0.0):c1) 
Uninverting(_3(8.0.0):c1)))}
   [junit4]   2> 1377883 INFO  (qtp861254588-66601) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:36293/solr/collection1/replication&command=fetchindex}
 status=0 QTime=26
   [junit4]   2> 1377884 INFO  (qtp199974993-66588) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=name:(empty1+empty2+empty3+empty4)&sort=id+desc&wt=javabin&version=2} 
hits=4 status=0 QTime=0
   [junit4]   2> 1377885 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.h.TestReplicationHandler Waited for 0ms and found 4 docs
   [junit4]   2> 1377886 INFO  (qtp861254588-66605) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=name:(empty1+empty2+empty3+empty4)&sort=id+desc&wt=javabin&version=2} 
hits=4 status=0 QTime=0
   [junit4]   2> 1377886 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.h.TestReplicationHandler Waited for 0ms and found 4 docs
   [junit4]   2> 1377887 INFO  (qtp199974993-66583) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=0
   [junit4]   2> 1377887 INFO  (qtp199974993-66589) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=0
   [junit4]   2> 1377888 INFO  (qtp199974993-66584) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={slave=false&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=0
   [junit4]   2> 1377888 INFO  (qtp861254588-66605) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=0
   [junit4]   2> 1377889 INFO  (qtp199974993-66590) [    x:collection1] 
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> 1377889 INFO  (qtp861254588-66607) [    x:collection1] 
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> 1377889 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testEmptyCommits
   [junit4]   2> 1377894 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@3d8ae696{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1377894 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=45475474
   [junit4]   2> 1377894 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1377894 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@4360c13e: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@320323fb
   [junit4]   2> 1377900 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1377900 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2a5ac840: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@5173f7d4
   [junit4]   2> 1377903 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1377904 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@145a7f42: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@9f568b1
   [junit4]   2> 1378048 INFO  (coreCloseExecutor-5066-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@6fea66dc
   [junit4]   2> 1378049 INFO  (coreCloseExecutor-5066-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1877632732
   [junit4]   2> 1378049 INFO  (coreCloseExecutor-5066-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@4bea619a: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@71c37f6f
   [junit4]   2> 1378058 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@be24f4{/solr,null,UNAVAILABLE}
   [junit4]   2> 1378059 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@67c1cf4c{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1378059 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=340512744
   [junit4]   2> 1378059 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1378059 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5db0eea7: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@d592bc7
   [junit4]   2> 1378064 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1378064 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@4bf5eb5c: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@5173f7d4
   [junit4]   2> 1378067 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1378067 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7f7144cc: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@9f568b1
   [junit4]   2> 1378067 INFO  (coreCloseExecutor-5068-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@131f346a
   [junit4]   2> 1378067 INFO  (coreCloseExecutor-5068-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=320812138
   [junit4]   2> 1378067 INFO  (coreCloseExecutor-5068-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@61d53d87: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@7d8a5b6b
   [junit4]   2> 1378078 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A4BEF2A25F9A8A2A]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@2e212d5c{/solr,null,UNAVAILABLE}
   [junit4]   2> 1378080 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting doTestIndexAndConfigAliasReplication
   [junit4]   2> 1378081 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-003/collection1
   [junit4]   2> 1378083 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1378094 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6a6c4438{/solr,null,AVAILABLE}
   [junit4]   2> 1378095 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@1dc64257{HTTP/1.1,[http/1.1]}{127.0.0.1:37423}
   [junit4]   2> 1378095 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.e.j.s.Server Started @1386781ms
   [junit4]   2> 1378095 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-003/collection1/data,
 hostContext=/solr, hostPort=37423}
   [junit4]   2> 1378095 ERROR 
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1378095 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 8.0.0
   [junit4]   2> 1378095 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 1378095 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1378095 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-12-03T08:19:25.682Z
   [junit4]   2> 1378096 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-003/solr.xml
   [junit4]   2> 1378100 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 1378100 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1378100 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1378137 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a
   [junit4]   2> 1378149 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a
   [junit4]   2> 1378149 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a
   [junit4]   2> 1378151 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-003/.
   [junit4]   2> 1378151 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1378151 INFO  (coreLoadExecutor-5075-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1378171 INFO  (coreLoadExecutor-5075-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1378177 INFO  (coreLoadExecutor-5075-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1378179 INFO  (coreLoadExecutor-5075-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1378180 INFO  (coreLoadExecutor-5075-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-003/./collection1,
 trusted=true
   [junit4]   2> 1378180 INFO  (coreLoadExecutor-5075-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a
   [junit4]   2> 1378180 INFO  (coreLoadExecutor-5075-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1378180 INFO  (coreLoadExecutor-5075-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-003/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-003/./collection1/data/]
   [junit4]   2> 1378182 INFO  (coreLoadExecutor-5075-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=28, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.11845946917097275]
   [junit4]   2> 1378217 INFO  (coreLoadExecutor-5075-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1378217 INFO  (coreLoadExecutor-5075-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1378217 INFO  (coreLoadExecutor-5075-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=204349093, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 1378217 INFO  (coreLoadExecutor-5075-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2a52efd4[collection1] main]
   [junit4]   2> 1378218 INFO  (coreLoadExecutor-5075-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-003/collection1/conf
   [junit4]   2> 1378218 INFO  (coreLoadExecutor-5075-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 1378218 INFO  (coreLoadExecutor-5075-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1378219 INFO  
(searcherExecutor-5076-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2a52efd4[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1378220 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-004/collection1
   [junit4]   2> 1378222 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1378232 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@50db8f8c{/solr,null,AVAILABLE}
   [junit4]   2> 1378233 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@706310b{HTTP/1.1,[http/1.1]}{127.0.0.1:44649}
   [junit4]   2> 1378233 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.e.j.s.Server Started @1386919ms
   [junit4]   2> 1378233 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-004/collection1/data,
 hostContext=/solr, hostPort=44649}
   [junit4]   2> 1378233 ERROR 
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1378233 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 8.0.0
   [junit4]   2> 1378233 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 1378233 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1378233 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-12-03T08:19:25.820Z
   [junit4]   2> 1378234 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-004/solr.xml
   [junit4]   2> 1378237 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 1378237 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1378238 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1378278 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a
   [junit4]   2> 1378286 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a
   [junit4]   2> 1378286 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5d6ace2a
   [junit4]   2> 1378288 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_A4BEF2A25F9A8A2A-001/solr-instance-004/.
   [junit4]   2> 1378288 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[A4BEF2A25F9A8A2A])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1378289 INFO  (coreLoadExecutor-5085-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1378310 INFO  (coreLoadExecutor-5085-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1378317 INFO  (coreLoadExecutor-5085-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1378318 INFO  (coreLoadExecutor-5085-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1378319 INFO  (coreLoadExecutor-5085-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Cre

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

ped o.e.j.s.ServletContextHandler@4f2551e4{/solr,null,UNAVAILABLE}
   [junit4]   2> 2380234 INFO  (jetty-closer-4944-thread-4) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@5e7b056b{/solr,null,UNAVAILABLE}
   [junit4]   2> 2380234 INFO  (jetty-closer-4944-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@69f853c9{/solr,null,UNAVAILABLE}
   [junit4]   2> 2380234 INFO  (jetty-closer-4944-thread-9) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@53ba5074{/solr,null,UNAVAILABLE}
   [junit4]   2> 2380235 INFO  
(zkCallback-5019-thread-2-processing-n:127.0.0.1:41309_solr) 
[n:127.0.0.1:41309_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (6) -> (0)
   [junit4]   2> 2380235 INFO  
(zkCallback-5061-thread-2-processing-n:127.0.0.1:44933_solr) 
[n:127.0.0.1:44933_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:44933_solr
   [junit4]   2> 2380235 INFO  (jetty-closer-4944-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@60d387c0{/solr,null,UNAVAILABLE}
   [junit4]   2> 2380235 INFO  
(zkCallback-5019-thread-1-processing-n:127.0.0.1:41309_solr) 
[n:127.0.0.1:41309_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:41309_solr
   [junit4]   2> 2380237 INFO  (jetty-closer-4944-thread-3) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@638805d3{/solr,null,UNAVAILABLE}
   [junit4]   2> 2380237 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x1601b81d2c90032, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 2380237 INFO  
(zkCallback-5100-thread-2-processing-n:127.0.0.1:35189_solr) 
[n:127.0.0.1:35189_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:35189_solr
   [junit4]   2> 2380240 INFO  (coreCloseExecutor-7195-thread-1) 
[n:127.0.0.1:35189_solr c:collection1 s:shard1 r:core_node4 
x:collection1_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.collection1.shard1.leader, tag=1344600994
   [junit4]   2> 2380242 INFO  (jetty-closer-4944-thread-8) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1747282e{/solr,null,UNAVAILABLE}
   [junit4]   2> 2381737 INFO  (jetty-closer-4944-thread-6) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@8e57431{/solr,null,UNAVAILABLE}
   [junit4]   2> 2381738 ERROR 
(SUITE-TriggerIntegrationTest-seed#[A4BEF2A25F9A8A2A]-worker) [    ] 
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper 
server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 2381738 INFO  
(SUITE-TriggerIntegrationTest-seed#[A4BEF2A25F9A8A2A]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:35179 35179
   [junit4]   2> 2386850 INFO  (Thread-5564) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:35179 35179
   [junit4]   2> 2386851 WARN  (Thread-5564) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        44      /solr/aliases.json
   [junit4]   2>        18      /solr/security.json
   [junit4]   2>        2       /solr/configs/conf
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        44      /solr/clusterprops.json
   [junit4]   2>        44      /solr/clusterstate.json
   [junit4]   2>        16      /solr/collections/collection1/state.json
   [junit4]   2>        6       /solr/autoscaling.json
   [junit4]   2>        3       
/solr/overseer_elect/election/99109436203270179-127.0.0.1:43197_solr-n_0000000008
   [junit4]   2>        3       
/solr/overseer_elect/election/99109436203270194-127.0.0.1:44933_solr-n_0000000011
   [junit4]   2>        2       
/solr/overseer_elect/election/99109436203270210-127.0.0.1:35189_solr-n_0000000014
   [junit4]   2>        2       
/solr/overseer_elect/election/99109436203270176-127.0.0.1:41309_solr-n_0000000007
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        44      /solr/live_nodes
   [junit4]   2>        44      /solr/collections
   [junit4]   2>        6       /solr/overseer/queue-work
   [junit4]   2>        6       /solr/autoscaling/events/.auto_add_replicas
   [junit4]   2>        6       /solr/overseer/queue
   [junit4]   2>        6       /solr/overseer/collection-queue-work
   [junit4]   2>        3       /solr/autoscaling/events/node_added_trigger
   [junit4]   2>        2       /solr/autoscaling/events/node_lost_trigger
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.TriggerIntegrationTest_A4BEF2A25F9A8A2A-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=1825, maxMBSortInHeap=7.895124642589872, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@20d98820),
 locale=ca, timezone=SystemV/PST8
   [junit4]   2> NOTE: Linux 4.10.0-37-generic amd64/Oracle Corporation 
1.8.0_144 (64-bit)/cpus=8,threads=1,free=192364200,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestHighlightDedupGrouping, 
TestReversedWildcardFilterFactory, DateFieldTest, SmileWriterTest, 
MetricsHandlerTest, EnumFieldTest, GraphQueryTest, TestCloudPivotFacet, 
ConnectionManagerTest, TestAuthorizationFramework, TestPullReplica, 
AutoAddReplicasIntegrationTest, TestPostingsSolrHighlighter, 
BasicFunctionalityTest, DirectUpdateHandlerOptimizeTest, 
TestIBSimilarityFactory, SolrMetricManagerTest, ResourceLoaderTest, 
TestCloudSearcherWarming, TestSuggestSpellingConverter, 
TestSolrCloudWithSecureImpersonation, TestCloudManagedSchema, 
TestFieldResource, TestSweetSpotSimilarityFactory, TestFoldingMultitermQuery, 
TestSha256AuthenticationProvider, URLClassifyProcessorTest, 
TestFreeTextSuggestions, TestHdfsCloudBackupRestore, TestExactSharedStatsCache, 
FileUtilsTest, TestSolrXml, TestRestManager, TestMergePolicyConfig, 
TestSQLHandler, TestConfigOverlay, TestLuceneIndexBackCompat, 
TestDFISimilarityFactory, TestIndexingPerformance, ReplicationFactorTest, 
DistributedQueryComponentOptimizationTest, FastVectorHighlighterTest, 
BadCopyFieldTest, VersionInfoTest, UpdateRequestProcessorFactoryTest, 
TestRandomDVFaceting, TestCollectionAPIs, TestSegmentSorting, TestBadConfig, 
PeerSyncTest, AddBlockUpdateTest, TestQueryUtils, 
TestEmbeddedSolrServerSchemaAPI, TestTestInjection, DistribCursorPagingTest, 
TestSolrCloudWithHadoopAuthPlugin, TestPayloadScoreQParserPlugin, 
ChaosMonkeyNothingIsSafeWithPullReplicasTest, TestDocBasedVersionConstraints, 
HdfsBasicDistributedZkTest, DeleteInactiveReplicaTest, 
TestManagedStopFilterFactory, SimpleFacetsTest, MinimalSchemaTest, 
UninvertDocValuesMergePolicyTest, SegmentsInfoRequestHandlerTest, 
TestLeaderInitiatedRecoveryThread, TestScoreJoinQPNoScore, TestRawTransformer, 
TestHashQParserPlugin, SolrJmxReporterTest, SearchRateTriggerTest, 
TermVectorComponentTest, OverseerStatusTest, TestReloadDeadlock, 
ComputePlanActionTest, SpellCheckComponentTest, HdfsThreadLeakTest, 
DistributedQueryElevationComponentTest, SolrInfoBeanTest, 
OverseerCollectionConfigSetProcessorTest, SoftAutoCommitTest, TestSolrJ, 
LargeFieldTest, NoCacheHeaderTest, TestExportWriter, TestSolrDeletionPolicy1, 
TestFieldSortValues, MultiTermTest, SearchHandlerTest, TestCrossCoreJoin, 
SSLMigrationTest, RecoveryAfterSoftCommitTest, ExplicitHLLTest, 
CurrencyFieldTypeTest, TestMiniSolrCloudClusterSSL, CdcrRequestHandlerTest, 
HdfsDirectoryFactoryTest, TestOrdValues, TestConfigSets, TestLegacyField, 
TestInPlaceUpdatesDistrib, PrimitiveFieldTypeTest, CollectionsAPISolrJTest, 
TermsComponentTest, TestLegacyTerms, TestConfigSetsAPIZkFailure, 
AssignBackwardCompatibilityTest, TestComponentsName, TestPhraseSuggestions, 
CollectionStateFormat2Test, BasicDistributedZkTest, TestPivotHelperCode, 
DateMathParserTest, MoveReplicaHDFSTest, TestRequestForwarding, TestUtils, 
HdfsRecoveryZkTest, SortSpecParsingTest, RuleEngineTest, 
DistributedFacetPivotSmallTest, SolrShardReporterTest, 
BasicAuthIntegrationTest, TestSort, TestLazyCores, SpellCheckCollatorTest, 
SuggesterTSTTest, TestStressLucene, TestTrie, TestCSVLoader, 
WordBreakSolrSpellCheckerTest, TestAtomicUpdateErrorCases, QueryEqualityTest, 
SortByFunctionTest, DistanceFunctionTest, XsltUpdateRequestHandlerTest, 
IndexBasedSpellCheckerTest, FileBasedSpellCheckerTest, TestSolrQueryParser, 
IndexSchemaTest, MBeansHandlerTest, PrimUtilsTest, RAMDirectoryFactoryTest, 
ClusterStateTest, TestLRUCache, SliceStateTest, SystemInfoHandlerTest, 
UUIDFieldTest, CircularListTest, DistributedMLTComponentTest, TestRTGBase, 
CursorPagingTest, TestSimpleTrackingShardHandler, ActionThrottleTest, 
AssignTest, CleanupOldIndexTest, DeleteNodeTest, DistributedQueueTest, 
DocValuesNotIndexedTest, HealthCheckHandlerTest, 
LeaderInitiatedRecoveryOnCommitTest, MissingSegmentRecoveryTest, 
MoveReplicaTest, NodeMutatorTest, OutOfBoxZkACLAndCredentialsProvidersTest, 
OverseerModifyCollectionTest, OverseerTaskQueueTest, PeerSyncReplicationTest, 
TestAuthenticationFramework, TestCloudInspectUtil, TestCloudPseudoReturnFields, 
TestClusterProperties, TestCollectionsAPIViaSolrCloudCluster, 
TestConfigSetsAPI, TestPullReplicaErrorHandling, TestSizeLimitedDistributedMap, 
TestSkipOverseerOperations, TestStressCloudBlindAtomicUpdates, 
TestTolerantUpdateProcessorCloud, TriLevelCompositeIdRoutingTest, 
AutoScalingHandlerTest, ExecutePlanActionTest, HttpTriggerListenerTest, 
NodeAddedTriggerTest, TriggerIntegrationTest]
   [junit4] Completed [602/752 (2!)] on J0 in 186.44s, 13 tests, 1 failure <<< 
FAILURES!

[...truncated 47759 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to