lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Mikhail Khludnev <m...@apache.org>
Subject Re: [JENKINS] Lucene-Solr-master-Linux (64bit/jdk1.8.0_144) - Build # 21018 - Still Unstable!
Date Sun, 03 Dec 2017 11:45:06 GMT
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)

It seems like https://issues.apache.org/jira/browse/SOLR-11673, you are
welcome for discussion.


On Sun, Dec 3, 2017 at 11:51 AM, Policeman Jenkins Server <
jenkins@thetaphi.de> wrote:

> 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-unsubscribe@lucene.apache.org
> For additional commands, e-mail: dev-help@lucene.apache.org
>



-- 
Sincerely yours
Mikhail Khludnev

Mime
View raw message