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

[JENKINS] Lucene-Solr-7.2-Linux (64bit/jdk1.8.0_144) - Build # 37 - Still Unstable!

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.2-Linux/37/
Java: 64bit/jdk1.8.0_144 -XX:-UseCompressedOops -XX:+UseParallelGC

2 tests failed.
FAILED:  org.apache.solr.cloud.LegacyCloudClusterPropTest.testCreateCollectionSwitchLegacyCloud

Error Message:


Stack Trace:
java.lang.AssertionError
	at __randomizedtesting.SeedInfo.seed([5416020D95B2758D:8511F08831BDFEBF]:0)
	at org.junit.Assert.fail(Assert.java:92)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.junit.Assert.assertTrue(Assert.java:54)
	at org.apache.solr.cloud.LegacyCloudClusterPropTest.createAndTest(LegacyCloudClusterPropTest.java:87)
	at org.apache.solr.cloud.LegacyCloudClusterPropTest.testCreateCollectionSwitchLegacyCloud(LegacyCloudClusterPropTest.java:69)
	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([5416020D95B2758D:405E5958B6B5C893]: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 11922 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/init-core-data-001
   [junit4]   2> 276801 WARN  (SUITE-TestReplicationHandler-seed#[5416020D95B2758D]-worker) [    ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=300 numCloses=300
   [junit4]   2> 276801 INFO  (SUITE-TestReplicationHandler-seed#[5416020D95B2758D]-worker) [    ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 276802 INFO  (SUITE-TestReplicationHandler-seed#[5416020D95B2758D]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
   [junit4]   2> 276802 INFO  (SUITE-TestReplicationHandler-seed#[5416020D95B2758D]-worker) [    ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 276803 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.SolrTestCaseJ4 ###Starting doTestRepeater
   [junit4]   2> 276804 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-001/collection1
   [junit4]   2> 276807 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 276808 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6e57eddd{/solr,null,AVAILABLE}
   [junit4]   2> 276810 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@3ea0693d{HTTP/1.1,[http/1.1]}{127.0.0.1:44713}
   [junit4]   2> 276810 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.e.j.s.Server Started @278731ms
   [junit4]   2> 276810 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-001/collection1/data, hostContext=/solr, hostPort=44713}
   [junit4]   2> 276810 ERROR (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 276810 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 7.2.0
   [junit4]   2> 276810 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 276810 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 276810 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-12-09T18:45:40.120Z
   [junit4]   2> 276811 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-001/solr.xml
   [junit4]   2> 276814 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 276814 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 276815 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@31d8e10a, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 276839 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31d8e10a
   [junit4]   2> 276845 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31d8e10a
   [junit4]   2> 276845 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31d8e10a
   [junit4]   2> 276847 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-001/.
   [junit4]   2> 276847 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 276847 INFO  (coreLoadExecutor-788-thread-1) [    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
   [junit4]   2> 276854 INFO  (coreLoadExecutor-788-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 276863 INFO  (coreLoadExecutor-788-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 276865 INFO  (coreLoadExecutor-788-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 276865 INFO  (coreLoadExecutor-788-thread-1) [    x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-001/./collection1, trusted=true
   [junit4]   2> 276865 INFO  (coreLoadExecutor-788-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@31d8e10a
   [junit4]   2> 276866 INFO  (coreLoadExecutor-788-thread-1) [    x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 276866 INFO  (coreLoadExecutor-788-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 276870 INFO  (coreLoadExecutor-788-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=20, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4615624230402655]
   [junit4]   2> 276920 INFO  (coreLoadExecutor-788-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 276920 INFO  (coreLoadExecutor-788-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 276921 INFO  (coreLoadExecutor-788-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=32.9677734375, floorSegmentMB=1.0439453125, forceMergeDeletesPctAllowed=12.349924031779867, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2744483160037956
   [junit4]   2> 276922 INFO  (coreLoadExecutor-788-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@8718403[collection1] main]
   [junit4]   2> 276922 INFO  (coreLoadExecutor-788-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-001/collection1/conf
   [junit4]   2> 276922 INFO  (coreLoadExecutor-788-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 276922 INFO  (coreLoadExecutor-788-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 276923 INFO  (searcherExecutor-789-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@8718403[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 276924 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-002/collection1
   [junit4]   2> 276926 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 276937 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@37800b4a{/solr,null,AVAILABLE}
   [junit4]   2> 276937 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@5b06b069{HTTP/1.1,[http/1.1]}{127.0.0.1:45823}
   [junit4]   2> 276940 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.e.j.s.Server Started @278861ms
   [junit4]   2> 276940 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-002/collection1/data, hostContext=/solr, hostPort=45823}
   [junit4]   2> 276940 ERROR (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 276940 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 7.2.0
   [junit4]   2> 276940 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 276940 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 276940 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-12-09T18:45:40.250Z
   [junit4]   2> 276940 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-002/solr.xml
   [junit4]   2> 276943 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 276943 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 276943 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@31d8e10a, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 276964 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31d8e10a
   [junit4]   2> 276970 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31d8e10a
   [junit4]   2> 276970 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31d8e10a
   [junit4]   2> 276971 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-002/.
   [junit4]   2> 276971 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 276974 INFO  (coreLoadExecutor-798-thread-1) [    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
   [junit4]   2> 276986 INFO  (coreLoadExecutor-798-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 276991 INFO  (coreLoadExecutor-798-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 276993 INFO  (coreLoadExecutor-798-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 276993 INFO  (coreLoadExecutor-798-thread-1) [    x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-002/./collection1, trusted=true
   [junit4]   2> 276993 INFO  (coreLoadExecutor-798-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@31d8e10a
   [junit4]   2> 276993 INFO  (coreLoadExecutor-798-thread-1) [    x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 276993 INFO  (coreLoadExecutor-798-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-002/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 276995 INFO  (coreLoadExecutor-798-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=20, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4615624230402655]
   [junit4]   2> 277019 INFO  (coreLoadExecutor-798-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 277019 INFO  (coreLoadExecutor-798-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 277020 INFO  (coreLoadExecutor-798-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=32.9677734375, floorSegmentMB=1.0439453125, forceMergeDeletesPctAllowed=12.349924031779867, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2744483160037956
   [junit4]   2> 277020 INFO  (coreLoadExecutor-798-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@49361238[collection1] main]
   [junit4]   2> 277020 INFO  (coreLoadExecutor-798-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-002/collection1/conf
   [junit4]   2> 277022 INFO  (coreLoadExecutor-798-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
   [junit4]   2> 277022 INFO  (coreLoadExecutor-798-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 277024 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@5b06b069{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 277024 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1021761163
   [junit4]   2> 277026 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
   [junit4]   2> 277026 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@18ac8449: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@27397e78
   [junit4]   2> 277030 INFO  (searcherExecutor-799-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@49361238[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 277032 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
   [junit4]   2> 277032 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@46165db: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@105ffd9
   [junit4]   2> 277037 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
   [junit4]   2> 277037 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1bc79fbe: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@4ebb0da1
   [junit4]   2> 277037 INFO  (coreCloseExecutor-804-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@17ca4894
   [junit4]   2> 277038 INFO  (coreCloseExecutor-804-thread-1) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=399132820
   [junit4]   2> 277038 INFO  (coreCloseExecutor-804-thread-1) [    x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4a99abcb: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@7161355
   [junit4]   2> 277044 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@37800b4a{/solr,null,UNAVAILABLE}
   [junit4]   2> 277045 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 277046 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4b661400{/solr,null,AVAILABLE}
   [junit4]   2> 277046 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@75404ea{HTTP/1.1,[http/1.1]}{127.0.0.1:33451}
   [junit4]   2> 277046 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.e.j.s.Server Started @278968ms
   [junit4]   2> 277046 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-002/collection1/data, hostContext=/solr, hostPort=33451}
   [junit4]   2> 277046 ERROR (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 277046 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 7.2.0
   [junit4]   2> 277047 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 277047 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 277047 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-12-09T18:45:40.357Z
   [junit4]   2> 277047 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-002/solr.xml
   [junit4]   2> 277050 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 277050 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 277050 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@31d8e10a, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 277086 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31d8e10a
   [junit4]   2> 277091 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31d8e10a
   [junit4]   2> 277091 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31d8e10a
   [junit4]   2> 277092 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-002/.
   [junit4]   2> 277092 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 277092 INFO  (coreLoadExecutor-811-thread-1) [    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
   [junit4]   2> 277101 INFO  (coreLoadExecutor-811-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 277106 INFO  (coreLoadExecutor-811-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 277107 INFO  (coreLoadExecutor-811-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 277107 INFO  (coreLoadExecutor-811-thread-1) [    x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-002/./collection1, trusted=true
   [junit4]   2> 277108 INFO  (coreLoadExecutor-811-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@31d8e10a
   [junit4]   2> 277108 INFO  (coreLoadExecutor-811-thread-1) [    x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 277108 INFO  (coreLoadExecutor-811-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-002/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 277109 INFO  (coreLoadExecutor-811-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=20, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4615624230402655]
   [junit4]   2> 277138 INFO  (coreLoadExecutor-811-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 277138 INFO  (coreLoadExecutor-811-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 277139 INFO  (coreLoadExecutor-811-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=32.9677734375, floorSegmentMB=1.0439453125, forceMergeDeletesPctAllowed=12.349924031779867, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2744483160037956
   [junit4]   2> 277139 INFO  (coreLoadExecutor-811-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@237ecba9[collection1] main]
   [junit4]   2> 277139 INFO  (coreLoadExecutor-811-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-002/collection1/conf
   [junit4]   2> 277140 INFO  (coreLoadExecutor-811-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 277141 INFO  (searcherExecutor-812-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@237ecba9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 277141 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-003/collection1
   [junit4]   2> 277143 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 277143 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7ecff6a6{/solr,null,AVAILABLE}
   [junit4]   2> 277144 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@2b54862c{HTTP/1.1,[http/1.1]}{127.0.0.1:39935}
   [junit4]   2> 277144 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.e.j.s.Server Started @279065ms
   [junit4]   2> 277144 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-003/collection1/data, hostContext=/solr, hostPort=39935}
   [junit4]   2> 277144 ERROR (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 277144 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 7.2.0
   [junit4]   2> 277144 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 277144 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 277144 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-12-09T18:45:40.454Z
   [junit4]   2> 277144 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-003/solr.xml
   [junit4]   2> 277147 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 277147 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 277147 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@31d8e10a, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 277165 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31d8e10a
   [junit4]   2> 277171 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31d8e10a
   [junit4]   2> 277171 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31d8e10a
   [junit4]   2> 277172 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-003/.
   [junit4]   2> 277172 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 277172 INFO  (coreLoadExecutor-821-thread-1) [    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
   [junit4]   2> 277181 INFO  (coreLoadExecutor-821-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 277195 INFO  (coreLoadExecutor-821-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 277196 INFO  (coreLoadExecutor-821-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 277196 INFO  (coreLoadExecutor-821-thread-1) [    x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-003/./collection1, trusted=true
   [junit4]   2> 277196 INFO  (coreLoadExecutor-821-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@31d8e10a
   [junit4]   2> 277197 INFO  (coreLoadExecutor-821-thread-1) [    x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 277197 INFO  (coreLoadExecutor-821-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-003/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-003/./collection1/data/]
   [junit4]   2> 277198 INFO  (coreLoadExecutor-821-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=20, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4615624230402655]
   [junit4]   2> 277229 INFO  (coreLoadExecutor-821-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 277229 INFO  (coreLoadExecutor-821-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 277230 INFO  (coreLoadExecutor-821-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=32.9677734375, floorSegmentMB=1.0439453125, forceMergeDeletesPctAllowed=12.349924031779867, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2744483160037956
   [junit4]   2> 277230 INFO  (coreLoadExecutor-821-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@17719580[collection1] main]
   [junit4]   2> 277230 INFO  (coreLoadExecutor-821-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5416020D95B2758D-001/solr-instance-003/collection1/conf
   [junit4]   2> 277266 WARN  (coreLoadExecutor-821-thread-1) [    x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
   [junit4]   2> 277267 INFO  (coreLoadExecutor-821-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler  No value set for 'pollInterval'. Timer Task not started.
   [junit4]   2> 277267 INFO  (coreLoadExecutor-821-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml
   [junit4]   2> 277267 INFO  (coreLoadExecutor-821-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 277268 INFO  (searcherExecutor-822-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@17719580[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 277270 INFO  (qtp2112558300-1836) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[0]} 0 0
   [junit4]   2> 277271 INFO  (qtp2112558300-1837) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 0
   [junit4]   2> 277271 INFO  (qtp2112558300-1838) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 0
   [junit4]   2> 277271 INFO  (qtp2112558300-1831) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 277271 INFO  (qtp2112558300-1831) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@168fac88 commitCommandVersion:0
   [junit4]   2> 277274 INFO  (qtp2112558300-1831) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@13b692fc[collection1] main]
   [junit4]   2> 277274 INFO  (qtp2112558300-1831) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 277275 INFO  (searcherExecutor-789-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@13b692fc[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):c3)))}
   [junit4]   2> 277275 INFO  (qtp2112558300-1831) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 4
   [junit4]   2> 277284 WARN  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
   [junit4]   2> 277286 INFO  (qtp2112558300-1837) [    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> 277286 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 277286 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Master's version: 1512845140581
   [junit4]   2> 277286 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 277286 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Slave's version: 0
   [junit4]   2> 277286 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 277288 INFO  (qtp2112558300-1838) [    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> 277288 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 4
   [junit4]   2> 277289 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=54.9560546875, floorSegmentMB=1.6064453125, forceMergeDeletesPctAllowed=2.3334494943930126, segmentsPerTier=47.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 277289 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 277289 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@6e40c014 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@47ca33ad)
   [junit4]   2> 277290 INFO  (qtp2112558300-1831) [    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> 277291 INFO  (qtp2112558300-1832) [    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> 277292 INFO  (qtp2112558300-1837) [    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> 277292 INFO  (qtp2112558300-1838) [    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> 277293 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1938) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@6e40c014 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@47ca33ad)
   [junit4]   2> 277293 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=36.6982421875, floorSegmentMB=0.8583984375, forceMergeDeletesPctAllowed=12.670592076956202, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 277294 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 277294 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6d9002b0[collection1] main]
   [junit4]   2> 277295 INFO  (searcherExecutor-822-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6d9002b0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):c3)))}
   [junit4]   2> 277295 INFO  (qtp1886749439-1891) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:44713/solr/collection1/replication&command=fetchindex} status=0 QTime=11
   [junit4]   2> 277302 INFO  (qtp1886749439-1893) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=3 status=0 QTime=0
   [junit4]   2> 277302 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 3 docs
   [junit4]   2> 277304 WARN  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
   [junit4]   2> 277305 INFO  (qtp1886749439-1891) [    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> 277305 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 277305 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Master's version: 1512845140581
   [junit4]   2> 277305 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 277305 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Slave's version: 0
   [junit4]   2> 277305 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 277306 INFO  (qtp1886749439-1887) [    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=0
   [junit4]   2> 277306 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 4
   [junit4]   2> 277307 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=54.9560546875, floorSegmentMB=1.6064453125, forceMergeDeletesPctAllowed=2.3334494943930126, segmentsPerTier=47.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 277308 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 277308 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@4673f899 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6dbf3465)
   [junit4]   2> 277308 INFO  (qtp1886749439-1893) [    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> 277309 INFO  (qtp1886749439-1888) [    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> 277310 INFO  (qtp1886749439-1891) [    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> 277311 INFO  (qtp1886749439-1891) [    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> 277311 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1938) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@4673f899 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6dbf3465)
   [junit4]   2> 277312 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=36.6982421875, floorSegmentMB=0.8583984375, forceMergeDeletesPctAllowed=12.670592076956202, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 277313 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 277313 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5fcb3dab[collection1] main]
   [junit4]   2> 277314 INFO  (searcherExecutor-812-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5fcb3dab[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):c3)))}
   [junit4]   2> 277314 INFO  (qtp1696702569-1871) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:39935/solr/collection1/replication&command=fetchindex} status=0 QTime=10
   [junit4]   2> 277317 INFO  (qtp1696702569-1876) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=3 status=0 QTime=0
   [junit4]   2> 277318 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 3 docs
   [junit4]   2> 277318 INFO  (qtp2112558300-1836) [    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> 277319 INFO  (qtp2112558300-1832) [    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> 277322 WARN  (qtp1886749439-1886) [    x:collection1] o.a.s.h.ReplicationHandler Exception while invoking 'details' method for replication on master 
   [junit4]   2> org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:TEST_PORT/solr: Expected mime type application/octet-stream but got text/html. <!DOCTYPE HTML PUBLIC "-//IETF//DTD HTML 2.0//EN">
   [junit4]   2> <html><head>
   [junit4]   2> <title>404 Not Found</title>
   [junit4]   2> </head><body>
   [junit4]   2> <h1>Not Found</h1>
   [junit4]   2> <p>The requested URL /solr/replication was not found on this server.</p>
   [junit4]   2> <hr>
   [junit4]   2> <address>Apache/2.4.18 (Ubuntu) Server at 127.0.0.1 Port 80</address>
   [junit4]   2> </body></html>
   [junit4]   2> 
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:607)
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
   [junit4]   2> 	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
   [junit4]   2> 	at org.apache.solr.handler.IndexFetcher.getDetails(IndexFetcher.java:1830)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.getReplicationDetails(ReplicationHandler.java:928)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.handleRequestBody(ReplicationHandler.java:331)
   [junit4]   2> 	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.execute(SolrCore.java:2503)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:710)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:516)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
   [junit4]   2> 	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:493)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:534)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
   [junit4]   2> 	at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 277323 INFO  (qtp1886749439-1886) [    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> 277323 INFO  (qtp2112558300-1832) [    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> 277324 INFO  (qtp1886749439-1888) [    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> 277325 WARN  (qtp1886749439-1887) [    x:collection1] o.a.s.h.ReplicationHandler Exception while invoking 'details' method for replication on master 
   [junit4]   2> org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:TEST_PORT/solr: Expected mime type application/octet-stream but got text/html. <!DOCTYPE HTML PUBLIC "-//IETF//DTD HTML 2.0//EN">
   [junit4]   2> <html><head>
   [junit4]   2> <title>404 Not Found</title>
   [junit4]   2> </head><body>
   [junit4]   2> <h1>Not Found</h1>
   [junit4]   2> <p>The requested URL /solr/replication was not found on this server.</p>
   [junit4]   2> <hr>
   [junit4]   2> <address>Apache/2.4.18 (Ubuntu) Server at 127.0.0.1 Port 80</address>
   [junit4]   2> </body></html>
   [junit4]   2> 
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:607)
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
   [junit4]   2> 	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
   [junit4]   2> 	at org.apache.solr.handler.IndexFetcher.getDetails(IndexFetcher.java:1830)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.getReplicationDetails(ReplicationHandler.java:928)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.handleRequestBody(ReplicationHandler.java:331)
   [junit4]   2> 	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.execute(SolrCore.java:2503)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:710)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:516)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
   [junit4]   2> 	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:493)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:534)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
   [junit4]   2> 	at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 277326 INFO  (qtp1886749439-1887) [    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> 277327 WARN  (qtp1886749439-1893) [    x:collection1] o.a.s.h.ReplicationHandler Exception while invoking 'details' method for replication on master 
   [junit4]   2> org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:TEST_PORT/solr: Expected mime type application/octet-stream but got text/html. <!DOCTYPE HTML PUBLIC "-//IETF//DTD HTML 2.0//EN">
   [junit4]   2> <html><head>
   [junit4]   2> <title>404 Not Found</title>
   [junit4]   2> </head><body>
   [junit4]   2> <h1>Not Found</h1>
   [junit4]   2> <p>The requested URL /solr/replication was not found on this server.</p>
   [junit4]   2> <hr>
   [junit4]   2> <address>Apache/2.4.18 (Ubuntu) Server at 127.0.0.1 Port 80</address>
   [junit4]   2> </body></html>
   [junit4]   2> 
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:607)
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
   [junit4]   2> 	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
   [junit4]   2> 	at org.apache.solr.handler.IndexFetcher.getDetails(IndexFetcher.java:1830)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.getReplicationDetails(ReplicationHandler.java:928)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.handleRequestBody(ReplicationHandler.java:331)
   [junit4]   2> 	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.execute(SolrCore.java:2503)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:710)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:516)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
   [junit4]   2> 	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:493)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:534)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
   [junit4]   2> 	at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 277328 INFO  (qtp1886749439-1893) [    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> 277330 INFO  (qtp1886749439-1891) [    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> 277330 INFO  (qtp1696702569-1869) [    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> 277331 INFO  (qtp1886749439-1886) [    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> 277331 INFO  (qtp1696702569-1871) [    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> 277332 INFO  (qtp1886749439-1886) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[0]} 0 0
   [junit4]   2> 277333 INFO  (qtp1886749439-1893) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 0
   [junit4]   2> 277334 INFO  (qtp1886749439-1893) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 0
   [junit4]   2> 277334 INFO  (qtp1886749439-1893) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[3]} 0 0
   [junit4]   2> 277335 INFO  (qtp1886749439-1893) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 277335 INFO  (qtp1886749439-1893) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@6175750e commitCommandVersion:0
   [junit4]   2> 277337 INFO  (qtp1886749439-1893) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@116064fa[collection1] main]
   [junit4]   2> 277338 INFO  (qtp1886749439-1893) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 277339 INFO  (searcherExecutor-822-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@116064fa[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.2.0):c4)))}
   [junit4]   2> 277339 INFO  (qtp1886749439-1893) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 4
   [junit4]   2> 277340 WARN  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
   [junit4]   2> 277341 INFO  (qtp2112558300-1831) [    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> 277341 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 277341 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Master's version: 1512845140581
   [junit4]   2> 277341 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Slave's generation: 3
   [junit4]   2> 277341 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Slave's version: 1512845140645
   [junit4]   2> 277341 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 277342 INFO  (qtp2112558300-1836) [    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=0
   [junit4]   2> 277342 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 4
   [junit4]   2> 277343 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=true) to MockDirectoryWrapper(RAMDirectory@3b2c2102 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4bfbea90)
   [junit4]   2> 277343 INFO  (qtp2112558300-1837) [    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> 277346 INFO  (qtp2112558300-1837) [    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> 277347 INFO  (qtp2112558300-1837) [    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> 277348 INFO  (qtp2112558300-1836) [    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> 277353 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=true,bytesDownloaded=1938) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@3b2c2102 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4bfbea90)
   [junit4]   2> 277354 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.c.SolrCore Updating index properties... index=index.20171209184540652
   [junit4]   2> 277354 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher removing old index directory RawDirectoryWrapper(RAMDirectory@6e239245 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@54cba72c)
   [junit4]   2> 277354 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=54.9560546875, floorSegmentMB=1.6064453125, forceMergeDeletesPctAllowed=2.3334494943930126, segmentsPerTier=47.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 277355 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 277355 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@a3ba45[collection1] main]
   [junit4]   2> 277356 INFO  (searcherExecutor-822-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@a3ba45[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):c3)))}
   [junit4]   2> 277356 INFO  (qtp1886749439-1892) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:44713/solr/collection1/replication&command=fetchindex} status=0 QTime=16
   [junit4]   2> 277358 INFO  (qtp1886749439-1888) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=3 status=0 QTime=0
   [junit4]   2> 277359 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 3 docs
   [junit4]   2> 277360 WARN  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
   [junit4]   2> 277361 INFO  (qtp1886749439-1891) [    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> 277361 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 277361 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Master's version: 1512845140581
   [junit4]   2> 277361 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Slave's generation: 2
   [junit4]   2> 277361 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Slave's version: 1512845140581
   [junit4]   2> 277361 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Slave in sync with master.
   [junit4]   2> 277361 INFO  (qtp1696702569-1870) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:39935/solr/collection1/replication&command=fetchindex} status=0 QTime=2
   [junit4]   2> 277362 INFO  (qtp1696702569-1871) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=3 status=0 QTime=0
   [junit4]   2> 277363 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[5416020D95B2758D]) [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 3 docs
   [junit4]   2> 277364 INFO  (qtp2112558300-1838) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[3]} 0 0
   [junit4]   2> 277365 INFO  (qtp2112558300-1831) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[4]} 0 0
   [junit4]   2> 277365 INFO  (qtp2112558300-1837) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[5]} 0 0
   [junit4]   2> 277365 INFO  (qtp2112558300-1832) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 277366 INFO  (qtp2112558300-1832) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@168fac88 commitCommandVersion:0
   [junit4]   2> 277367 INFO  (qtp2112558300-1832) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@227d3f9[collection1] main]
   [junit4]   2> 277367 INFO  (qtp2112558300-1832) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 277368 INFO  (searcherExecutor-789-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@227d3f9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):c3) Uninverting(_1(7.2.0):c3)))}
   [junit4]   2> 277368 INFO  (qtp2112558300-1832) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 3
   [junit4]   2> 277370 WARN  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
   [junit4]   2> 277371 INFO  (qtp2112558300-1836) [    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> 277371 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Master's generation: 3
   [junit4]   2> 277371 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Master's version: 1512845140676
   [junit4]   2> 277371 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Slave's generation: 2
   [junit4]   2> 277371 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Slave's version: 1512845140581
   [junit4]   2> 277371 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 277372 INFO  (qtp2112558300-1831) [    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> 277372 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 7
   [junit4]   2> 277374 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=54.9560546875, floorSegmentMB=1.6064453125, forceMergeDeletesPctAllowed=2.3334494943930126, segmentsPerTier=47.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 277375 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 277375 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@323e1c1c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@49fa6ecb)
   [junit4]   2> 277375 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.cfe because it already exists
   [junit4]   2> 277375 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 277375 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.cfs because it already exists
   [junit4]   2> 277375 INFO  (qtp2112558300-1837) [    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> 277377 INFO  (qtp2112558300-1832) [    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> 277377 INFO  (qtp2112558300-1836) [    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> 277378 INFO  (qtp2112558300-1831) [    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> 277379 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=2000) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@323e1c1c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@49fa6ecb)
   [junit4]   2> 277380 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=43, m

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

licationFactor=1&collection.configName=conf&maxShardsPerNode=1&name=legacyTrue&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2} status=0 QTime=31343
   [junit4]   2> 979002 INFO  (TEST-LegacyCloudClusterPropTest.testCreateCollectionSwitchLegacyCloud-seed#[5416020D95B2758D]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testCreateCollectionSwitchLegacyCloud
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=LegacyCloudClusterPropTest -Dtests.method=testCreateCollectionSwitchLegacyCloud -Dtests.seed=5416020D95B2758D -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=pl-PL -Dtests.timezone=Etc/GMT0 -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] FAILURE  151s J1 | LegacyCloudClusterPropTest.testCreateCollectionSwitchLegacyCloud <<<
   [junit4]    > Throwable #1: java.lang.AssertionError
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([5416020D95B2758D:8511F08831BDFEBF]:0)
   [junit4]    > 	at org.apache.solr.cloud.LegacyCloudClusterPropTest.createAndTest(LegacyCloudClusterPropTest.java:87)
   [junit4]    > 	at org.apache.solr.cloud.LegacyCloudClusterPropTest.testCreateCollectionSwitchLegacyCloud(LegacyCloudClusterPropTest.java:69)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 979005 INFO  (jetty-closer-1498-thread-1) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@2044ed05{SSL,[ssl, http/1.1]}{127.0.0.1:0}
   [junit4]   2> 979006 INFO  (jetty-closer-1498-thread-1) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=495649659
   [junit4]   2> 979006 INFO  (jetty-closer-1498-thread-1) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
   [junit4]   2> 979006 INFO  (jetty-closer-1498-thread-1) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@54e1f91: rootName = solr_44145, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@449938a1
   [junit4]   2> 979011 INFO  (jetty-closer-1498-thread-1) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
   [junit4]   2> 979011 INFO  (jetty-closer-1498-thread-1) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3db05082: rootName = solr_44145, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@314df71c
   [junit4]   2> 979014 INFO  (jetty-closer-1498-thread-1) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
   [junit4]   2> 979014 INFO  (jetty-closer-1498-thread-1) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3a9c075c: rootName = solr_44145, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@43c498e2
   [junit4]   2> 979022 INFO  (jetty-closer-1498-thread-1) [    ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:44145_solr
   [junit4]   2> 979023 INFO  (jetty-closer-1498-thread-1) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
   [junit4]   2> 979025 INFO  (coreCloseExecutor-3399-thread-1) [n:127.0.0.1:44145_solr c:legacyTrue s:shard1 r:core_node2 x:legacyTrue_shard1_replica_n1] o.a.s.c.SolrCore [legacyTrue_shard1_replica_n1]  CLOSING SolrCore org.apache.solr.core.SolrCore@22997c29
   [junit4]   2> 979026 INFO  (coreCloseExecutor-3399-thread-1) [n:127.0.0.1:44145_solr c:legacyTrue s:shard1 r:core_node2 x:legacyTrue_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.legacyTrue.shard1.replica_n1, tag=580484137
   [junit4]   2> 979026 INFO  (zkCallback-1507-thread-3-processing-n:127.0.0.1:44145_solr) [n:127.0.0.1:44145_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 979026 INFO  (coreCloseExecutor-3399-thread-1) [n:127.0.0.1:44145_solr c:legacyTrue s:shard1 r:core_node2 x:legacyTrue_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1cd0b8f2: rootName = solr_44145, domain = solr.core.legacyTrue.shard1.replica_n1, service url = null, agent id = null] for registry solr.core.legacyTrue.shard1.replica_n1 / com.codahale.metrics.MetricRegistry@3e0694bc
   [junit4]   2> 979033 INFO  (coreCloseExecutor-3399-thread-1) [n:127.0.0.1:44145_solr c:legacyTrue s:shard1 r:core_node2 x:legacyTrue_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.legacyTrue.shard1.leader, tag=580484137
   [junit4]   2> 979035 INFO  (jetty-closer-1498-thread-1) [    ] o.a.s.c.Overseer Overseer (id=99145855196332035-127.0.0.1:44145_solr-n_0000000000) closing
   [junit4]   2> 979035 INFO  (OverseerStateUpdate-99145855196332035-127.0.0.1:44145_solr-n_0000000000) [n:127.0.0.1:44145_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:44145_solr
   [junit4]   2> 979035 WARN  (OverseerAutoScalingTriggerThread-99145855196332035-127.0.0.1:44145_solr-n_0000000000) [n:127.0.0.1:44145_solr    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 979039 INFO  (jetty-closer-1498-thread-1) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@26555761{/solr,null,UNAVAILABLE}
   [junit4]   2> 979041 ERROR (SUITE-LegacyCloudClusterPropTest-seed#[5416020D95B2758D]-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> 979041 INFO  (SUITE-LegacyCloudClusterPropTest-seed#[5416020D95B2758D]-worker) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37235 37235
   [junit4]   2> 984185 INFO  (Thread-2493) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37235 37235
   [junit4]   2> 984187 WARN  (Thread-2493) [    ] o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	2	/solr/aliases.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2> 	2	/solr/clusterstate.json
   [junit4]   2> 	2	/solr/clusterprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	2	/solr/live_nodes
   [junit4]   2> 	2	/solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-7.2-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.LegacyCloudClusterPropTest_5416020D95B2758D-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=1367, maxMBSortInHeap=6.385573661614209, sim=RandomSimilarity(queryNorm=false): {}, locale=pl-PL, timezone=Etc/GMT0
   [junit4]   2> NOTE: Linux 4.10.0-40-generic amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=8,threads=1,free=174074112,total=531103744
   [junit4]   2> NOTE: All tests run in this JVM: [TestLegacyNumericRangeQueryBuilder, TestCustomStream, TestStressRecovery, SchemaVersionSpecificBehaviorTest, TestReloadAndDeleteDocs, TestSolrCoreSnapshots, TestRandomFlRTGCloud, MoveReplicaHDFSFailoverTest, ImplicitSnitchTest, V2ApiIntegrationTest, TestFastLRUCache, TestFileDictionaryLookup, RequestHandlersTest, TestManagedSchemaAPI, OverseerRolesTest, UpdateLogTest, HdfsUnloadDistributedZkTest, DistribDocExpirationUpdateProcessorTest, CircularListTest, TlogReplayBufferedWhileIndexingTest, SOLR749Test, TestDeleteCollectionOnDownNodes, TestLegacyFieldCache, HdfsRecoverLeaseTest, PrimUtilsTest, HdfsAutoAddReplicasIntegrationTest, TestTolerantUpdateProcessorCloud, DOMUtilTest, TestMinMaxOnMultiValuedField, TestOmitPositions, CoreAdminCreateDiscoverTest, SynonymTokenizerTest, CollectionsAPIDistributedZkTest, PreAnalyzedUpdateProcessorTest, JavabinLoaderTest, TestLockTree, TestFieldCacheSortRandom, SolrIndexConfigTest, DistributedQueryComponentCustomSortTest, ShardRoutingCustomTest, TestUninvertingReader, SignatureUpdateProcessorFactoryTest, TestJsonRequest, TestPerFieldSimilarityWithDefaultOverride, TestCustomSort, TestFaceting, TestNumericRangeQuery32, CdcrUpdateLogTest, TestSSLRandomization, ChangedSchemaMergeTest, TestManagedSynonymGraphFilterFactory, TestRuleBasedAuthorizationPlugin, TestExclusionRuleCollectionAccess, SolrCmdDistributorTest, DocExpirationUpdateProcessorFactoryTest, BJQParserTest, TestNestedDocsSort, PingRequestHandlerTest, OverriddenZkACLAndCredentialsProvidersTest, TestLazyCores, TestStressReorder, HdfsBasicDistributedZk2Test, NodeLostTriggerTest, SolrJmxReporterCloudTest, TestBulkSchemaConcurrent, SuggesterFSTTest, TestFieldTypeResource, DocumentAnalysisRequestHandlerTest, DistributedFacetPivotSmallAdvancedTest, TestNamedUpdateProcessors, PreAnalyzedFieldManagedSchemaCloudTest, DistributedFacetExistsSmallTest, TestSolrCoreParser, DistributedTermsComponentTest, TestQuerySenderNoQuery, TestConfigSetsAPIExclusivity, TestClusterStateMutator, BinaryUpdateRequestHandlerTest, TestCloudJSONFacetJoinDomain, SuggestComponentTest, TestCloudRecovery, TestFastWriter, TestMaxTokenLenTokenizer, TestClassicSimilarityFactory, TestCollationFieldDocValues, TestSizeLimitedDistributedMap, TestSimpleQParserPlugin, AssignTest, HdfsDirectoryTest, TestBackupRepositoryFactory, BadIndexSchemaTest, TestConfigSetProperties, TestSimpleTrackingShardHandler, SecurityConfHandlerTest, TestStressUserVersions, UUIDUpdateProcessorFallbackTest, BitVectorTest, TestUseDocValuesAsStored2, TestRawResponseWriter, SubstringBytesRefFilterTest, SuggesterTSTTest, TestLegacyNumericUtils, TestHttpShardHandlerFactory, NumericFieldsTest, LegacyCloudClusterPropTest]
   [junit4] Completed [340/751 (2!)] on J1 in 156.92s, 1 test, 1 failure <<< FAILURES!

[...truncated 48669 lines...]