You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2020/05/23 17:02:44 UTC

[JENKINS] Lucene-Solr-Tests-8.5 - Build # 238 - Unstable

Build: https://builds.apache.org/job/Lucene-Solr-Tests-8.5/238/

1 tests failed.
FAILED:  org.apache.solr.cloud.MoveReplicaTest.test

Error Message:
expected:<100> but was:<44>

Stack Trace:
java.lang.AssertionError: expected:<100> but was:<44>
	at __randomizedtesting.SeedInfo.seed([63AD0C844B1AF188:EBF9335EE5E69C70]:0)
	at org.junit.Assert.fail(Assert.java:88)
	at org.junit.Assert.failNotEquals(Assert.java:834)
	at org.junit.Assert.assertEquals(Assert.java:645)
	at org.junit.Assert.assertEquals(Assert.java:631)
	at org.apache.solr.cloud.MoveReplicaTest.test(MoveReplicaTest.java:233)
	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:1750)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
	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:947)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
	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 14774 lines...]
   [junit4] Suite: org.apache.solr.cloud.MoveReplicaTest
   [junit4]   2> 2235962 INFO  (SUITE-MoveReplicaTest-seed#[63AD0C844B1AF188]-worker) [     ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 2235962 INFO  (SUITE-MoveReplicaTest-seed#[63AD0C844B1AF188]-worker) [     ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaTest_63AD0C844B1AF188-001/data-dir-171-001
   [junit4]   2> 2235962 WARN  (SUITE-MoveReplicaTest-seed#[63AD0C844B1AF188]-worker) [     ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=6 numCloses=6
   [junit4]   2> 2235962 INFO  (SUITE-MoveReplicaTest-seed#[63AD0C844B1AF188]-worker) [     ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 2235964 INFO  (SUITE-MoveReplicaTest-seed#[63AD0C844B1AF188]-worker) [     ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 2235964 INFO  (SUITE-MoveReplicaTest-seed#[63AD0C844B1AF188]-worker) [     ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 2235967 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 2235968 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaTest_63AD0C844B1AF188-001/tempDir-001
   [junit4]   2> 2235968 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2235968 INFO  (ZkTestServer Run Thread) [     ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2235968 INFO  (ZkTestServer Run Thread) [     ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 2236068 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.ZkTestServer start zk server on port:35807
   [junit4]   2> 2236069 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:35807
   [junit4]   2> 2236069 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:35807
   [junit4]   2> 2236069 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 35807
   [junit4]   2> 2236070 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2236073 INFO  (zkConnectionManagerCallback-7633-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2236073 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2236076 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2236078 INFO  (zkConnectionManagerCallback-7635-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2236078 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2236078 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2236079 INFO  (zkConnectionManagerCallback-7637-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2236080 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2236191 WARN  (jetty-launcher-7638-thread-2) [     ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
   [junit4]   2> 2236191 WARN  (jetty-launcher-7638-thread-1) [     ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
   [junit4]   2> 2236191 INFO  (jetty-launcher-7638-thread-2) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 2236191 INFO  (jetty-launcher-7638-thread-1) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 2236191 INFO  (jetty-launcher-7638-thread-2) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 2236191 INFO  (jetty-launcher-7638-thread-1) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 2236191 INFO  (jetty-launcher-7638-thread-2) [     ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 1.8.0_191-b12
   [junit4]   2> 2236191 INFO  (jetty-launcher-7638-thread-1) [     ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 1.8.0_191-b12
   [junit4]   2> 2236192 WARN  (jetty-launcher-7638-thread-3) [     ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
   [junit4]   2> 2236192 INFO  (jetty-launcher-7638-thread-3) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 2236192 INFO  (jetty-launcher-7638-thread-3) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 2236192 INFO  (jetty-launcher-7638-thread-3) [     ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 1.8.0_191-b12
   [junit4]   2> 2236203 WARN  (jetty-launcher-7638-thread-4) [     ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
   [junit4]   2> 2236203 INFO  (jetty-launcher-7638-thread-4) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 2236203 INFO  (jetty-launcher-7638-thread-4) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 2236203 INFO  (jetty-launcher-7638-thread-4) [     ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 1.8.0_191-b12
   [junit4]   2> 2236203 INFO  (jetty-launcher-7638-thread-1) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2236203 INFO  (jetty-launcher-7638-thread-1) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2236203 INFO  (jetty-launcher-7638-thread-1) [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 2236204 INFO  (jetty-launcher-7638-thread-1) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@a28b536{/solr,null,AVAILABLE}
   [junit4]   2> 2236204 INFO  (jetty-launcher-7638-thread-4) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2236204 INFO  (jetty-launcher-7638-thread-4) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2236204 INFO  (jetty-launcher-7638-thread-4) [     ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 2236205 INFO  (jetty-launcher-7638-thread-2) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2236205 INFO  (jetty-launcher-7638-thread-2) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2236205 INFO  (jetty-launcher-7638-thread-2) [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 2236205 INFO  (jetty-launcher-7638-thread-4) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@fd3fc1f{/solr,null,AVAILABLE}
   [junit4]   2> 2236205 INFO  (jetty-launcher-7638-thread-2) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@451d513e{/solr,null,AVAILABLE}
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-3) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-3) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-3) [     ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-1) [     ] o.e.j.s.AbstractConnector Started ServerConnector@2a1848e9{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:42252}
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-1) [     ] o.e.j.s.Server Started @2236324ms
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-1) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=42252}
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-3) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7724dce9{/solr,null,AVAILABLE}
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-2) [     ] o.e.j.s.AbstractConnector Started ServerConnector@16921aff{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:44049}
   [junit4]   2> 2236206 ERROR (jetty-launcher-7638-thread-1) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-1) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-2) [     ] o.e.j.s.Server Started @2236324ms
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-2) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=44049}
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-4) [     ] o.e.j.s.AbstractConnector Started ServerConnector@5a9102c7{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:35101}
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-4) [     ] o.e.j.s.Server Started @2236324ms
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-1) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.5.2
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-4) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=35101}
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-1) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-1) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-1) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2020-05-23T15:49:39.491Z
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-3) [     ] o.e.j.s.AbstractConnector Started ServerConnector@4aad860{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:33505}
   [junit4]   2> 2236206 ERROR (jetty-launcher-7638-thread-2) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-2) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-3) [     ] o.e.j.s.Server Started @2236324ms
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-3) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=33505}
   [junit4]   2> 2236206 ERROR (jetty-launcher-7638-thread-4) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-4) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-2) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.5.2
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-2) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-4) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.5.2
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-2) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-2) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2020-05-23T15:49:39.491Z
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-4) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-4) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr
   [junit4]   2> 2236206 INFO  (jetty-launcher-7638-thread-4) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2020-05-23T15:49:39.491Z
   [junit4]   2> 2236206 ERROR (jetty-launcher-7638-thread-3) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2236207 INFO  (jetty-launcher-7638-thread-3) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2236207 INFO  (jetty-launcher-7638-thread-3) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.5.2
   [junit4]   2> 2236207 INFO  (jetty-launcher-7638-thread-3) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2236207 INFO  (jetty-launcher-7638-thread-3) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr
   [junit4]   2> 2236207 INFO  (jetty-launcher-7638-thread-3) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2020-05-23T15:49:39.492Z
   [junit4]   2> 2236208 INFO  (jetty-launcher-7638-thread-1) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2236208 INFO  (jetty-launcher-7638-thread-2) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2236208 INFO  (jetty-launcher-7638-thread-3) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2236208 INFO  (jetty-launcher-7638-thread-4) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2236209 INFO  (zkConnectionManagerCallback-7640-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2236209 INFO  (jetty-launcher-7638-thread-1) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2236209 INFO  (zkConnectionManagerCallback-7642-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2236209 INFO  (jetty-launcher-7638-thread-2) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2236209 INFO  (zkConnectionManagerCallback-7646-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2236210 INFO  (jetty-launcher-7638-thread-3) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2236210 INFO  (zkConnectionManagerCallback-7644-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2236210 INFO  (jetty-launcher-7638-thread-4) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2236234 INFO  (jetty-launcher-7638-thread-1) [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2236234 INFO  (jetty-launcher-7638-thread-2) [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2236234 INFO  (jetty-launcher-7638-thread-3) [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2236235 INFO  (jetty-launcher-7638-thread-4) [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2236255 INFO  (jetty-launcher-7638-thread-1) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 2236255 INFO  (jetty-launcher-7638-thread-1) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 2236255 INFO  (jetty-launcher-7638-thread-3) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 2236255 INFO  (jetty-launcher-7638-thread-3) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 2236255 INFO  (jetty-launcher-7638-thread-4) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 2236255 INFO  (jetty-launcher-7638-thread-4) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 2236255 INFO  (jetty-launcher-7638-thread-2) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 2236255 INFO  (jetty-launcher-7638-thread-2) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 2236257 INFO  (jetty-launcher-7638-thread-3) [     ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 2236257 INFO  (jetty-launcher-7638-thread-4) [     ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 2236257 INFO  (jetty-launcher-7638-thread-1) [     ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 2236257 INFO  (jetty-launcher-7638-thread-2) [     ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 2237959 INFO  (jetty-launcher-7638-thread-3) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 2238009 WARN  (jetty-launcher-7638-thread-3) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6d1e420a[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2238009 WARN  (jetty-launcher-7638-thread-3) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6d1e420a[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2238012 WARN  (jetty-launcher-7638-thread-3) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@368ac9fb[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2238012 WARN  (jetty-launcher-7638-thread-3) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@368ac9fb[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2238030 INFO  (jetty-launcher-7638-thread-3) [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35807/solr
   [junit4]   2> 2238031 INFO  (jetty-launcher-7638-thread-3) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2238045 INFO  (zkConnectionManagerCallback-7656-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2238045 INFO  (jetty-launcher-7638-thread-3) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2238163 INFO  (jetty-launcher-7638-thread-3) [n:127.0.0.1:33505_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2238183 INFO  (zkConnectionManagerCallback-7658-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2238183 INFO  (jetty-launcher-7638-thread-3) [n:127.0.0.1:33505_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2238616 INFO  (jetty-launcher-7638-thread-3) [n:127.0.0.1:33505_solr     ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:33505_solr
   [junit4]   2> 2238617 INFO  (jetty-launcher-7638-thread-3) [n:127.0.0.1:33505_solr     ] o.a.s.c.Overseer Overseer (id=72845632642416648-127.0.0.1:33505_solr-n_0000000000) starting
   [junit4]   2> 2238623 INFO  (OverseerStateUpdate-72845632642416648-127.0.0.1:33505_solr-n_0000000000) [n:127.0.0.1:33505_solr     ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:33505_solr
   [junit4]   2> 2238623 INFO  (jetty-launcher-7638-thread-3) [n:127.0.0.1:33505_solr     ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33505_solr
   [junit4]   2> 2238624 INFO  (OverseerStateUpdate-72845632642416648-127.0.0.1:33505_solr-n_0000000000) [n:127.0.0.1:33505_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2238672 INFO  (jetty-launcher-7638-thread-3) [n:127.0.0.1:33505_solr     ] o.a.s.p.PackageLoader /packages.json updated to version -1
   [junit4]   2> 2238673 WARN  (jetty-launcher-7638-thread-3) [n:127.0.0.1:33505_solr     ] o.a.s.c.CoreContainer Not all security plugins configured!  authentication=disabled authorization=disabled.  Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external.  See https://s.apache.org/solrsecurity for more info
   [junit4]   2> 2238761 INFO  (jetty-launcher-7638-thread-3) [n:127.0.0.1:33505_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 2238944 INFO  (jetty-launcher-7638-thread-3) [n:127.0.0.1:33505_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049
   [junit4]   2> 2239005 INFO  (jetty-launcher-7638-thread-3) [n:127.0.0.1:33505_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049
   [junit4]   2> 2239006 INFO  (jetty-launcher-7638-thread-3) [n:127.0.0.1:33505_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049
   [junit4]   2> 2239007 INFO  (jetty-launcher-7638-thread-3) [n:127.0.0.1:33505_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaTest_63AD0C844B1AF188-001/tempDir-001/node3/.
   [junit4]   2> 2240885 INFO  (jetty-launcher-7638-thread-4) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 2240886 WARN  (jetty-launcher-7638-thread-4) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@174d129b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2240886 WARN  (jetty-launcher-7638-thread-4) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@174d129b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2240898 WARN  (jetty-launcher-7638-thread-4) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@29a3104a[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2240898 WARN  (jetty-launcher-7638-thread-4) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@29a3104a[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2240899 INFO  (jetty-launcher-7638-thread-4) [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35807/solr
   [junit4]   2> 2240900 INFO  (jetty-launcher-7638-thread-4) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2240901 INFO  (zkConnectionManagerCallback-7668-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2240901 INFO  (jetty-launcher-7638-thread-4) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2241003 INFO  (jetty-launcher-7638-thread-4) [n:127.0.0.1:35101_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2241004 INFO  (zkConnectionManagerCallback-7670-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2241004 INFO  (jetty-launcher-7638-thread-4) [n:127.0.0.1:35101_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2241023 INFO  (jetty-launcher-7638-thread-4) [n:127.0.0.1:35101_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2241027 INFO  (jetty-launcher-7638-thread-4) [n:127.0.0.1:35101_solr     ] o.a.s.c.ZkController Publish node=127.0.0.1:35101_solr as DOWN
   [junit4]   2> 2241028 INFO  (jetty-launcher-7638-thread-4) [n:127.0.0.1:35101_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
   [junit4]   2> 2241028 INFO  (jetty-launcher-7638-thread-4) [n:127.0.0.1:35101_solr     ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:35101_solr
   [junit4]   2> 2241029 INFO  (zkCallback-7657-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2241029 INFO  (zkCallback-7669-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2241030 INFO  (jetty-launcher-7638-thread-4) [n:127.0.0.1:35101_solr     ] o.a.s.p.PackageLoader /packages.json updated to version -1
   [junit4]   2> 2241031 WARN  (jetty-launcher-7638-thread-4) [n:127.0.0.1:35101_solr     ] o.a.s.c.CoreContainer Not all security plugins configured!  authentication=disabled authorization=disabled.  Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external.  See https://s.apache.org/solrsecurity for more info
   [junit4]   2> 2241087 INFO  (jetty-launcher-7638-thread-4) [n:127.0.0.1:35101_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 2241177 INFO  (jetty-launcher-7638-thread-4) [n:127.0.0.1:35101_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049
   [junit4]   2> 2241227 INFO  (jetty-launcher-7638-thread-4) [n:127.0.0.1:35101_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049
   [junit4]   2> 2241227 INFO  (jetty-launcher-7638-thread-4) [n:127.0.0.1:35101_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049
   [junit4]   2> 2241229 INFO  (jetty-launcher-7638-thread-4) [n:127.0.0.1:35101_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaTest_63AD0C844B1AF188-001/tempDir-001/node4/.
   [junit4]   2> 2241496 INFO  (jetty-launcher-7638-thread-2) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 2241497 WARN  (jetty-launcher-7638-thread-2) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@39fde456[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2241497 WARN  (jetty-launcher-7638-thread-2) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@39fde456[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2241512 WARN  (jetty-launcher-7638-thread-2) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@572bd0f3[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2241512 WARN  (jetty-launcher-7638-thread-2) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@572bd0f3[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2241514 INFO  (jetty-launcher-7638-thread-2) [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35807/solr
   [junit4]   2> 2241515 INFO  (jetty-launcher-7638-thread-2) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2241516 INFO  (zkConnectionManagerCallback-7680-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2241516 INFO  (jetty-launcher-7638-thread-2) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2241633 INFO  (jetty-launcher-7638-thread-2) [n:127.0.0.1:44049_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2241633 INFO  (zkConnectionManagerCallback-7682-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2241633 INFO  (jetty-launcher-7638-thread-2) [n:127.0.0.1:44049_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2241639 INFO  (jetty-launcher-7638-thread-2) [n:127.0.0.1:44049_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2241643 INFO  (jetty-launcher-7638-thread-2) [n:127.0.0.1:44049_solr     ] o.a.s.c.ZkController Publish node=127.0.0.1:44049_solr as DOWN
   [junit4]   2> 2241644 INFO  (jetty-launcher-7638-thread-2) [n:127.0.0.1:44049_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
   [junit4]   2> 2241644 INFO  (jetty-launcher-7638-thread-2) [n:127.0.0.1:44049_solr     ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44049_solr
   [junit4]   2> 2241645 INFO  (zkCallback-7669-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 2241645 INFO  (zkCallback-7657-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 2241645 INFO  (zkCallback-7681-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 2241646 INFO  (jetty-launcher-7638-thread-2) [n:127.0.0.1:44049_solr     ] o.a.s.p.PackageLoader /packages.json updated to version -1
   [junit4]   2> 2241647 WARN  (jetty-launcher-7638-thread-2) [n:127.0.0.1:44049_solr     ] o.a.s.c.CoreContainer Not all security plugins configured!  authentication=disabled authorization=disabled.  Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external.  See https://s.apache.org/solrsecurity for more info
   [junit4]   2> 2241707 INFO  (jetty-launcher-7638-thread-2) [n:127.0.0.1:44049_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 2241793 INFO  (jetty-launcher-7638-thread-2) [n:127.0.0.1:44049_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049
   [junit4]   2> 2241831 INFO  (jetty-launcher-7638-thread-2) [n:127.0.0.1:44049_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049
   [junit4]   2> 2241840 INFO  (jetty-launcher-7638-thread-2) [n:127.0.0.1:44049_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049
   [junit4]   2> 2241842 INFO  (jetty-launcher-7638-thread-2) [n:127.0.0.1:44049_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaTest_63AD0C844B1AF188-001/tempDir-001/node2/.
   [junit4]   2> 2243147 INFO  (jetty-launcher-7638-thread-1) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 2243148 WARN  (jetty-launcher-7638-thread-1) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2e0655a1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2243148 WARN  (jetty-launcher-7638-thread-1) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2e0655a1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2243159 WARN  (jetty-launcher-7638-thread-1) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@37f8f26a[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2243159 WARN  (jetty-launcher-7638-thread-1) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@37f8f26a[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2243161 INFO  (jetty-launcher-7638-thread-1) [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35807/solr
   [junit4]   2> 2243162 INFO  (jetty-launcher-7638-thread-1) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2243163 INFO  (zkConnectionManagerCallback-7692-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2243163 INFO  (jetty-launcher-7638-thread-1) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2243271 INFO  (jetty-launcher-7638-thread-1) [n:127.0.0.1:42252_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2243272 INFO  (zkConnectionManagerCallback-7694-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2243272 INFO  (jetty-launcher-7638-thread-1) [n:127.0.0.1:42252_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2243321 INFO  (jetty-launcher-7638-thread-1) [n:127.0.0.1:42252_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 2243326 INFO  (jetty-launcher-7638-thread-1) [n:127.0.0.1:42252_solr     ] o.a.s.c.ZkController Publish node=127.0.0.1:42252_solr as DOWN
   [junit4]   2> 2243326 INFO  (jetty-launcher-7638-thread-1) [n:127.0.0.1:42252_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
   [junit4]   2> 2243327 INFO  (jetty-launcher-7638-thread-1) [n:127.0.0.1:42252_solr     ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:42252_solr
   [junit4]   2> 2243336 INFO  (zkCallback-7669-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2243336 INFO  (zkCallback-7657-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2243336 INFO  (zkCallback-7681-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2243344 INFO  (zkCallback-7693-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2243345 INFO  (jetty-launcher-7638-thread-1) [n:127.0.0.1:42252_solr     ] o.a.s.p.PackageLoader /packages.json updated to version -1
   [junit4]   2> 2243346 WARN  (jetty-launcher-7638-thread-1) [n:127.0.0.1:42252_solr     ] o.a.s.c.CoreContainer Not all security plugins configured!  authentication=disabled authorization=disabled.  Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external.  See https://s.apache.org/solrsecurity for more info
   [junit4]   2> 2243414 INFO  (jetty-launcher-7638-thread-1) [n:127.0.0.1:42252_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 2243473 INFO  (jetty-launcher-7638-thread-1) [n:127.0.0.1:42252_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049
   [junit4]   2> 2243527 INFO  (jetty-launcher-7638-thread-1) [n:127.0.0.1:42252_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049
   [junit4]   2> 2243527 INFO  (jetty-launcher-7638-thread-1) [n:127.0.0.1:42252_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049
   [junit4]   2> 2243529 INFO  (jetty-launcher-7638-thread-1) [n:127.0.0.1:42252_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaTest_63AD0C844B1AF188-001/tempDir-001/node1/.
   [junit4]   2> 2243679 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=4
   [junit4]   2> 2243680 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2243689 INFO  (zkConnectionManagerCallback-7703-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2243689 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2243691 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 2243692 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:35807/solr ready
   [junit4]   2> 2243699 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr     ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 2243705 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr     ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=5
   [junit4]   2> 2243705 INFO  (TEST-MoveReplicaTest.test-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.MoveReplicaTest total_jettys: 4
   [junit4]   2> 2243706 INFO  (qtp1414981181-24648) [n:127.0.0.1:35101_solr     ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params pullReplicas=1&collection.configName=conf1&maxShardsPerNode=2&autoAddReplicas=false&name=MoveReplicaTest_coll_true&nrtReplicas=1&action=CREATE&numShards=2&tlogReplicas=0&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 2243708 INFO  (OverseerThreadFactory-7299-thread-2-processing-n:127.0.0.1:33505_solr) [n:127.0.0.1:33505_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection MoveReplicaTest_coll_true
   [junit4]   2> 2243709 INFO  (OverseerCollectionConfigSetProcessor-72845632642416648-127.0.0.1:33505_solr-n_0000000000) [n:127.0.0.1:33505_solr     ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may have disconnected from ZooKeeper
   [junit4]   2> 2243816 INFO  (OverseerStateUpdate-72845632642416648-127.0.0.1:33505_solr-n_0000000000) [n:127.0.0.1:33505_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"MoveReplicaTest_coll_true",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"MoveReplicaTest_coll_true_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:44049/solr",
   [junit4]   2>   "node_name":"127.0.0.1:44049_solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2243819 INFO  (OverseerStateUpdate-72845632642416648-127.0.0.1:33505_solr-n_0000000000) [n:127.0.0.1:33505_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"MoveReplicaTest_coll_true",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"MoveReplicaTest_coll_true_shard1_replica_p2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:42252/solr",
   [junit4]   2>   "node_name":"127.0.0.1:42252_solr",
   [junit4]   2>   "type":"PULL",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2243821 INFO  (OverseerStateUpdate-72845632642416648-127.0.0.1:33505_solr-n_0000000000) [n:127.0.0.1:33505_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"MoveReplicaTest_coll_true",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"MoveReplicaTest_coll_true_shard2_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:35101/solr",
   [junit4]   2>   "node_name":"127.0.0.1:35101_solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2243823 INFO  (OverseerStateUpdate-72845632642416648-127.0.0.1:33505_solr-n_0000000000) [n:127.0.0.1:33505_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"MoveReplicaTest_coll_true",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"MoveReplicaTest_coll_true_shard2_replica_p6",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:33505/solr",
   [junit4]   2>   "node_name":"127.0.0.1:33505_solr",
   [junit4]   2>   "type":"PULL",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2244028 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr    x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&newCollection=true&name=MoveReplicaTest_coll_true_shard2_replica_n4&action=CREATE&numShards=2&collection=MoveReplicaTest_coll_true&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2244028 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr    x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true&name=MoveReplicaTest_coll_true_shard1_replica_n1&action=CREATE&numShards=2&collection=MoveReplicaTest_coll_true&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2244028 INFO  (qtp618639874-24633) [n:127.0.0.1:42252_solr    x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf1&newCollection=true&name=MoveReplicaTest_coll_true_shard1_replica_p2&action=CREATE&numShards=2&collection=MoveReplicaTest_coll_true&shard=shard1&wt=javabin&version=2&replicaType=PULL
   [junit4]   2> 2244028 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr    x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=MoveReplicaTest_coll_true_shard2_replica_p6&action=CREATE&numShards=2&collection=MoveReplicaTest_coll_true&shard=shard2&wt=javabin&version=2&replicaType=PULL
   [junit4]   2> 2244029 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr    x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
   [junit4]   2> 2244080 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.5.2
   [junit4]   2> 2244081 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.5.2
   [junit4]   2> 2244082 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.5.2
   [junit4]   2> 2244147 INFO  (qtp618639874-24633) [n:127.0.0.1:42252_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.5.2
   [junit4]   2> 2244160 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.s.IndexSchema [MoveReplicaTest_coll_true_shard2_replica_n4] Schema name=cloud-dynamic
   [junit4]   2> 2244163 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.s.IndexSchema [MoveReplicaTest_coll_true_shard2_replica_p6] Schema name=cloud-dynamic
   [junit4]   2> 2244168 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.s.IndexSchema [MoveReplicaTest_coll_true_shard1_replica_n1] Schema name=cloud-dynamic
   [junit4]   2> 2244179 INFO  (qtp618639874-24633) [n:127.0.0.1:42252_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.s.IndexSchema [MoveReplicaTest_coll_true_shard1_replica_p2] Schema name=cloud-dynamic
   [junit4]   2> 2244300 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2244300 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'MoveReplicaTest_coll_true_shard1_replica_n1' using configuration from configset conf1, trusted=true
   [junit4]   2> 2244301 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.MoveReplicaTest_coll_true.shard1.replica_n1' (registry 'solr.core.MoveReplicaTest_coll_true.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049
   [junit4]   2> 2244301 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.SolrCore [[MoveReplicaTest_coll_true_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaTest_63AD0C844B1AF188-001/tempDir-001/node2/MoveReplicaTest_coll_true_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaTest_63AD0C844B1AF188-001/tempDir-001/node2/./MoveReplicaTest_coll_true_shard1_replica_n1/data/]
   [junit4]   2> 2244303 INFO  (qtp618639874-24633) [n:127.0.0.1:42252_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2244303 INFO  (qtp618639874-24633) [n:127.0.0.1:42252_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.c.CoreContainer Creating SolrCore 'MoveReplicaTest_coll_true_shard1_replica_p2' using configuration from configset conf1, trusted=true
   [junit4]   2> 2244304 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2244304 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.c.CoreContainer Creating SolrCore 'MoveReplicaTest_coll_true_shard2_replica_p6' using configuration from configset conf1, trusted=true
   [junit4]   2> 2244305 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2244305 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.CoreContainer Creating SolrCore 'MoveReplicaTest_coll_true_shard2_replica_n4' using configuration from configset conf1, trusted=true
   [junit4]   2> 2244318 INFO  (qtp618639874-24633) [n:127.0.0.1:42252_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.MoveReplicaTest_coll_true.shard1.replica_p2' (registry 'solr.core.MoveReplicaTest_coll_true.shard1.replica_p2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049
   [junit4]   2> 2244318 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.MoveReplicaTest_coll_true.shard2.replica_n4' (registry 'solr.core.MoveReplicaTest_coll_true.shard2.replica_n4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049
   [junit4]   2> 2244318 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.MoveReplicaTest_coll_true.shard2.replica_p6' (registry 'solr.core.MoveReplicaTest_coll_true.shard2.replica_p6') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30cf9049
   [junit4]   2> 2244319 INFO  (qtp618639874-24633) [n:127.0.0.1:42252_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.c.SolrCore [[MoveReplicaTest_coll_true_shard1_replica_p2] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaTest_63AD0C844B1AF188-001/tempDir-001/node1/MoveReplicaTest_coll_true_shard1_replica_p2], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaTest_63AD0C844B1AF188-001/tempDir-001/node1/./MoveReplicaTest_coll_true_shard1_replica_p2/data/]
   [junit4]   2> 2244319 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.SolrCore [[MoveReplicaTest_coll_true_shard2_replica_n4] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaTest_63AD0C844B1AF188-001/tempDir-001/node4/MoveReplicaTest_coll_true_shard2_replica_n4], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaTest_63AD0C844B1AF188-001/tempDir-001/node4/./MoveReplicaTest_coll_true_shard2_replica_n4/data/]
   [junit4]   2> 2244319 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.c.SolrCore [[MoveReplicaTest_coll_true_shard2_replica_p6] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaTest_63AD0C844B1AF188-001/tempDir-001/node3/MoveReplicaTest_coll_true_shard2_replica_p6], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaTest_63AD0C844B1AF188-001/tempDir-001/node3/./MoveReplicaTest_coll_true_shard2_replica_p6/data/]
   [junit4]   2> 2244706 INFO  (qtp618639874-24633) [n:127.0.0.1:42252_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2244706 INFO  (qtp618639874-24633) [n:127.0.0.1:42252_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2244708 INFO  (qtp618639874-24633) [n:127.0.0.1:42252_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@604a6c80[MoveReplicaTest_coll_true_shard1_replica_p2] main]
   [junit4]   2> 2244722 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2244722 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2244722 INFO  (qtp618639874-24633) [n:127.0.0.1:42252_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 2244722 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2244722 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2244722 INFO  (qtp618639874-24633) [n:127.0.0.1:42252_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2244723 INFO  (qtp618639874-24633) [n:127.0.0.1:42252_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2244723 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2244723 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2244723 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2244723 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2244724 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5bbd2cbd[MoveReplicaTest_coll_true_shard2_replica_p6] main]
   [junit4]   2> 2244724 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2244724 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2244738 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 2244738 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2244739 INFO  (qtp618639874-24633) [n:127.0.0.1:42252_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.c.ZkController MoveReplicaTest_coll_true_shard1_replica_p2 starting background replication from leader
   [junit4]   2> 2244741 INFO  (qtp618639874-24633) [n:127.0.0.1:42252_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.c.ReplicateFromLeader Will start replication from leader with poll interval: 00:00:01
   [junit4]   2> 2244741 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1f87f913[MoveReplicaTest_coll_true_shard2_replica_n4] main]
   [junit4]   2> 2244742 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2244743 INFO  (qtp618639874-24633) [n:127.0.0.1:42252_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
   [junit4]   2> 2244743 INFO  (qtp618639874-24633) [n:127.0.0.1:42252_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2244743 INFO  (searcherExecutor-7326-thread-1-processing-n:127.0.0.1:42252_solr x:MoveReplicaTest_coll_true_shard1_replica_p2 c:MoveReplicaTest_coll_true s:shard1 r:core_node5) [n:127.0.0.1:42252_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.c.SolrCore [MoveReplicaTest_coll_true_shard1_replica_p2] Registered new searcher Searcher@604a6c80[MoveReplicaTest_coll_true_shard1_replica_p2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2244744 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5b41320b[MoveReplicaTest_coll_true_shard1_replica_n1] main]
   [junit4]   2> 2244766 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 2244766 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2244767 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2244767 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1667496922895613952
   [junit4]   2> 2244768 INFO  (searcherExecutor-7327-thread-1-processing-n:127.0.0.1:33505_solr x:MoveReplicaTest_coll_true_shard2_replica_p6 c:MoveReplicaTest_coll_true s:shard2 r:core_node8) [n:127.0.0.1:33505_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.c.SolrCore [MoveReplicaTest_coll_true_shard2_replica_p6] Registered new searcher Searcher@5bbd2cbd[MoveReplicaTest_coll_true_shard2_replica_p6] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2244770 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.c.ZkController MoveReplicaTest_coll_true_shard2_replica_p6 starting background replication from leader
   [junit4]   2> 2244770 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.c.ReplicateFromLeader Will start replication from leader with poll interval: 00:00:01
   [junit4]   2> 2244771 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
   [junit4]   2> 2244771 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2244783 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 2244783 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2244783 INFO  (searcherExecutor-7328-thread-1-processing-n:127.0.0.1:35101_solr x:MoveReplicaTest_coll_true_shard2_replica_n4 c:MoveReplicaTest_coll_true s:shard2 r:core_node7) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.SolrCore [MoveReplicaTest_coll_true_shard2_replica_n4] Registered new searcher Searcher@1f87f913[MoveReplicaTest_coll_true_shard2_replica_n4] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2244784 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2244784 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1667496922913439744
   [junit4]   2> 2244785 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/MoveReplicaTest_coll_true/terms/shard2 to Terms{values={core_node7=0}, version=0}
   [junit4]   2> 2244785 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/MoveReplicaTest_coll_true/leaders/shard2
   [junit4]   2> 2244800 INFO  (searcherExecutor-7325-thread-1-processing-n:127.0.0.1:44049_solr x:MoveReplicaTest_coll_true_shard1_replica_n1 c:MoveReplicaTest_coll_true s:shard1 r:core_node3) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.SolrCore [MoveReplicaTest_coll_true_shard1_replica_n1] Registered new searcher Searcher@5b41320b[MoveReplicaTest_coll_true_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2244802 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/MoveReplicaTest_coll_true/terms/shard1 to Terms{values={core_node3=0}, version=0}
   [junit4]   2> 2244802 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/MoveReplicaTest_coll_true/leaders/shard1
   [junit4]   2> 2244811 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2244811 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2244811 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:35101/solr/MoveReplicaTest_coll_true_shard2_replica_n4/
   [junit4]   2> 2244811 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 2244811 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.SyncStrategy http://127.0.0.1:35101/solr/MoveReplicaTest_coll_true_shard2_replica_n4/ has no replicas
   [junit4]   2> 2244811 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/MoveReplicaTest_coll_true/leaders/shard2/leader after winning as /collections/MoveReplicaTest_coll_true/leader_elect/shard2/election/72845632642416650-core_node7-n_0000000000
   [junit4]   2> 2244813 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:35101/solr/MoveReplicaTest_coll_true_shard2_replica_n4/ shard2
   [junit4]   2> 2244815 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2244815 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2244815 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:44049/solr/MoveReplicaTest_coll_true_shard1_replica_n1/
   [junit4]   2> 2244815 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 2244815 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.SyncStrategy http://127.0.0.1:44049/solr/MoveReplicaTest_coll_true_shard1_replica_n1/ has no replicas
   [junit4]   2> 2244815 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/MoveReplicaTest_coll_true/leaders/shard1/leader after winning as /collections/MoveReplicaTest_coll_true/leader_elect/shard1/election/72845632642416652-core_node3-n_0000000000
   [junit4]   2> 2244817 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:44049/solr/MoveReplicaTest_coll_true_shard1_replica_n1/ shard1
   [junit4]   2> 2244919 INFO  (zkCallback-7657-thread-1) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2244919 INFO  (zkCallback-7681-thread-1) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2244919 INFO  (zkCallback-7669-thread-1) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2244920 INFO  (zkCallback-7657-thread-2) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2244920 INFO  (zkCallback-7669-thread-2) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2244920 INFO  (zkCallback-7681-thread-2) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2244920 INFO  (indexFetcher-7346-thread-1) [     ] o.a.s.h.IndexFetcher Replica core_node7 is leader but it's state is down, skipping replication
   [junit4]   2> 2244920 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 2244922 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 2244924 INFO  (qtp408283013-24653) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true&name=MoveReplicaTest_coll_true_shard1_replica_n1&action=CREATE&numShards=2&collection=MoveReplicaTest_coll_true&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=896
   [junit4]   2> 2244932 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&newCollection=true&name=MoveReplicaTest_coll_true_shard2_replica_n4&action=CREATE&numShards=2&collection=MoveReplicaTest_coll_true&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=896
   [junit4]   2> 2245025 INFO  (zkCallback-7669-thread-1) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2245025 INFO  (zkCallback-7669-thread-2) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2245025 INFO  (zkCallback-7681-thread-1) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2245025 INFO  (zkCallback-7681-thread-2) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2245025 INFO  (zkCallback-7669-thread-3) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2245026 INFO  (zkCallback-7681-thread-3) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2245312 INFO  (indexFetcher-7344-thread-1) [     ] o.a.s.h.IndexFetcher Updated masterUrl to http://127.0.0.1:44049/solr/MoveReplicaTest_coll_true_shard1_replica_n1/
   [junit4]   2> 2245313 INFO  (qtp408283013-24650) [n:127.0.0.1:44049_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.S.Request [MoveReplicaTest_coll_true_shard1_replica_n1]  webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
   [junit4]   2> 2245314 INFO  (indexFetcher-7344-thread-1) [     ] o.a.s.h.IndexFetcher Master's generation: 1
   [junit4]   2> 2245314 INFO  (indexFetcher-7344-thread-1) [     ] o.a.s.h.IndexFetcher Master's version: 0
   [junit4]   2> 2245314 INFO  (indexFetcher-7344-thread-1) [     ] o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 2245314 INFO  (indexFetcher-7344-thread-1) [     ] o.a.s.h.IndexFetcher Slave's version: 0
   [junit4]   2> 2245314 INFO  (indexFetcher-7344-thread-1) [     ] o.a.s.h.IndexFetcher New index in Master. Deleting mine...
   [junit4]   2> 2245315 INFO  (indexFetcher-7344-thread-1) [     ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2245315 INFO  (indexFetcher-7344-thread-1) [     ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@45b746d9 commitCommandVersion:0
   [junit4]   2> 2245331 INFO  (indexFetcher-7344-thread-1) [     ] o.a.s.s.SolrIndexSearcher Opening [Searcher@501693be[MoveReplicaTest_coll_true_shard1_replica_p2] main]
   [junit4]   2> 2245331 INFO  (indexFetcher-7344-thread-1) [     ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2245334 INFO  (searcherExecutor-7326-thread-1) [     ] o.a.s.c.SolrCore [MoveReplicaTest_coll_true_shard1_replica_p2] Registered new searcher Searcher@501693be[MoveReplicaTest_coll_true_shard1_replica_p2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2245773 INFO  (indexFetcher-7346-thread-1) [     ] o.a.s.h.IndexFetcher Last replication failed, so I'll force replication
   [junit4]   2> 2245774 INFO  (indexFetcher-7346-thread-1) [     ] o.a.s.h.IndexFetcher Updated masterUrl to http://127.0.0.1:35101/solr/MoveReplicaTest_coll_true_shard2_replica_n4/
   [junit4]   2> 2245798 INFO  (qtp1414981181-24647) [n:127.0.0.1:35101_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.S.Request [MoveReplicaTest_coll_true_shard2_replica_n4]  webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
   [junit4]   2> 2245798 INFO  (indexFetcher-7346-thread-1) [     ] o.a.s.h.IndexFetcher Master's generation: 1
   [junit4]   2> 2245799 INFO  (indexFetcher-7346-thread-1) [     ] o.a.s.h.IndexFetcher Master's version: 0
   [junit4]   2> 2245799 INFO  (indexFetcher-7346-thread-1) [     ] o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 2245799 INFO  (indexFetcher-7346-thread-1) [     ] o.a.s.h.IndexFetcher Slave's version: 0
   [junit4]   2> 2245799 INFO  (indexFetcher-7346-thread-1) [     ] o.a.s.h.IndexFetcher New index in Master. Deleting mine...
   [junit4]   2> 2245800 INFO  (indexFetcher-7346-thread-1) [     ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2245800 INFO  (indexFetcher-7346-thread-1) [     ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5a57f89c commitCommandVersion:0
   [junit4]   2> 2245802 INFO  (indexFetcher-7346-thread-1) [     ] o.a.s.s.SolrIndexSearcher Opening [Searcher@b027cf5[MoveReplicaTest_coll_true_shard2_replica_p6] main]
   [junit4]   2> 2245802 INFO  (indexFetcher-7346-thread-1) [     ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2245836 INFO  (qtp618639874-24633) [n:127.0.0.1:42252_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_p2 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf1&newCollection=true&name=MoveReplicaTest_coll_true_shard1_replica_p2&action=CREATE&numShards=2&collection=MoveReplicaTest_coll_true&shard=shard1&wt=javabin&version=2&replicaType=PULL} status=0 QTime=1807
   [junit4]   2> 2245837 INFO  (searcherExecutor-7327-thread-1) [     ] o.a.s.c.SolrCore [MoveReplicaTest_coll_true_shard2_replica_p6] Registered new searcher Searcher@b027cf5[MoveReplicaTest_coll_true_shard2_replica_p6] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2245839 INFO  (qtp174929757-24657) [n:127.0.0.1:33505_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_p6 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=MoveReplicaTest_coll_true_shard2_replica_p6&action=CREATE&numShards=2&collection=MoveReplicaTest_coll_true&shard=shard2&wt=javabin&version=2&replicaType=PULL} status=0 QTime=1810
   [junit4]   2> 2245852 INFO  (qtp1414981181-24648) [n:127.0.0.1:35101_solr     ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
   [junit4]   2> 2245941 INFO  (zkCallback-7669-thread-3) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2245941 INFO  (zkCallback-7681-thread-3) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2245941 INFO  (zkCallback-7681-thread-1) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2245941 INFO  (zkCallback-7669-thread-1) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2245941 INFO  (zkCallback-7669-thread-2) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2245941 INFO  (zkCallback-7693-thread-1) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2245941 INFO  (zkCallback-7681-thread-2) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2245941 INFO  (zkCallback-7693-thread-3) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2245941 INFO  (zkCallback-7657-thread-3) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2245941 INFO  (zkCallback-7657-thread-2) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2245941 INFO  (zkCallback-7657-thread-1) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2245941 INFO  (zkCallback-7693-thread-2) [     ] o.a.s.c.c.ZkStateReader A cluster

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

 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
   [junit4]   2> 2272103 INFO  (jetty-closer-7808-thread-3) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@52020961: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@5a099228
   [junit4]   2> 2272103 INFO  (jetty-closer-7808-thread-3) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
   [junit4]   2> 2272110 INFO  (closeThreadPool-7818-thread-1) [     ] o.a.s.c.Overseer Overseer (id=72845634111012872-127.0.0.1:46599_solr-n_0000000000) closing
   [junit4]   2> 2272212 INFO  (jetty-closer-7808-thread-1) [     ] o.a.s.c.Overseer Overseer (id=72845634111012872-127.0.0.1:46599_solr-n_0000000000) closing
   [junit4]   2> 2272213 INFO  (jetty-closer-7808-thread-1) [     ] o.e.j.s.AbstractConnector Stopped ServerConnector@7abd2203{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
   [junit4]   2> 2272213 INFO  (jetty-closer-7808-thread-1) [     ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@10f75554{/solr,null,UNAVAILABLE}
   [junit4]   2> 2272213 INFO  (jetty-closer-7808-thread-1) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 2272313 INFO  (jetty-closer-7808-thread-2) [     ] o.e.j.s.AbstractConnector Stopped ServerConnector@1b1ce2c{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
   [junit4]   2> 2272314 INFO  (jetty-closer-7808-thread-2) [     ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7d0af52c{/solr,null,UNAVAILABLE}
   [junit4]   2> 2272314 INFO  (jetty-closer-7808-thread-2) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 2272413 INFO  (jetty-closer-7808-thread-3) [     ] o.e.j.s.AbstractConnector Stopped ServerConnector@7624cb01{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
   [junit4]   2> 2272414 INFO  (jetty-closer-7808-thread-3) [     ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1c444221{/solr,null,UNAVAILABLE}
   [junit4]   2> 2272414 INFO  (jetty-closer-7808-thread-3) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 2272414 INFO  (TEST-MoveReplicaTest.testFailedMove-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
   [junit4]   2> 2272618 WARN  (ZkTestServer Run Thread) [     ] o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	8	/solr/collections/MoveReplicaTest_failed_coll_true/terms/shard2
   [junit4]   2> 	7	/solr/collections/MoveReplicaTest_failed_coll_true/terms/shard1
   [junit4]   2> 	5	/solr/aliases.json
   [junit4]   2> 	5	/solr/clusterprops.json
   [junit4]   2> 	4	/solr/collections/MoveReplicaTest_failed_coll_true/collectionprops.json
   [junit4]   2> 	4	/solr/packages.json
   [junit4]   2> 	4	/solr/security.json
   [junit4]   2> 	4	/solr/configs/conf1
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2> 	54	/solr/collections/MoveReplicaTest_failed_coll_true/state.json
   [junit4]   2> 	5	/solr/clusterstate.json
   [junit4]   2> 	2	/solr/overseer_elect/election/72845634111012876-127.0.0.1:43954_solr-n_0000000001
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	28	/solr/overseer/queue
   [junit4]   2> 	19	/solr/live_nodes
   [junit4]   2> 	14	/solr/overseer/collection-queue-work
   [junit4]   2> 	10	/solr/collections
   [junit4]   2> 
   [junit4]   2> 2272620 INFO  (TEST-MoveReplicaTest.testFailedMove-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:41132
   [junit4]   2> 2272620 INFO  (TEST-MoveReplicaTest.testFailedMove-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:41132
   [junit4]   2> 2272620 INFO  (TEST-MoveReplicaTest.testFailedMove-seed#[63AD0C844B1AF188]) [     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 41132
   [junit4]   2> 2272620 INFO  (TEST-MoveReplicaTest.testFailedMove-seed#[63AD0C844B1AF188]) [     ] o.a.s.SolrTestCaseJ4 ###Ending testFailedMove
   [junit4]   2> 2272621 INFO  (TEST-MoveReplicaTest.testFailedMove-seed#[63AD0C844B1AF188]) [     ] o.a.s.SolrTestCaseJ4 ###Ending testFailedMove
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaTest_63AD0C844B1AF188-001
   [junit4]   2> May 23, 2020 3:50:16 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene84): {_root_=Lucene84, id=FST50}, docValues:{}, maxPointsInLeafNode=625, maxMBSortInHeap=5.0812082738920425, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@259ab3e), locale=ga, timezone=US/Pacific
   [junit4]   2> NOTE: Linux 4.4.0-170-generic amd64/Oracle Corporation 1.8.0_191 (64-bit)/cpus=8,threads=1,free=90823168,total=527433728
   [junit4]   2> NOTE: All tests run in this JVM: [TestDynamicFieldCollectionResource, TestAtomicUpdateErrorCases, TestSolrConfigHandlerConcurrent, TestCoreDiscovery, QueryParsingTest, OverseerRolesTest, UtilsToolTest, DistributedMLTComponentTest, CdcrOpsAndBoundariesTest, PathHierarchyTokenizerFactoryTest, SolrIndexConfigTest, TestFieldResource, TestConfig, TestOverriddenPrefixQueryForCustomFieldType, TestFieldCacheVsDocValues, ExternalFileFieldSortTest, IndexSizeEstimatorTest, TestLegacyNumericRangeQueryBuilder, SolrSlf4jReporterTest, DistributedFacetExistsSmallTest, MetricUtilsTest, TestInPlaceUpdateWithRouteField, ExplicitHLLTest, HdfsRecoveryZkTest, TestCustomDocTransformer, TestRestManager, BasicFunctionalityTest, ClusterStateUpdateTest, TestDistributedSearch, TestFreeTextSuggestions, HdfsCollectionsAPIDistributedZkTest, TestFaceting, DisMaxRequestHandlerTest, TestLMDirichletSimilarityFactory, TestAddFieldRealTimeGet, HLLUtilTest, TestCoreAdminApis, MetricsHistoryIntegrationTest, CSVRequestHandlerTest, AddReplicaTest, NestedShardedAtomicUpdateTest, TestApiFramework, SSLMigrationTest, TestSimClusterStateProvider, DeleteReplicaTest, HdfsAutoAddReplicasIntegrationTest, TestCursorMarkWithoutUniqueKey, TestStandardQParsers, AutoScalingHandlerTest, ByteBuffersDirectoryFactoryTest, ZkCollectionPropsCachingTest, SpellPossibilityIteratorTest, TestFieldCacheReopen, OverseerStatusTest, PackageManagerCLITest, TestExplainDocTransformer, DimensionalRoutedAliasUpdateProcessorTest, IndexBasedSpellCheckerTest, JavaBinAtomicUpdateMultivalueTest, MetricTriggerTest, TestSolrCloudWithSecureImpersonation, WordBreakSolrSpellCheckerTest, ReplaceNodeNoTargetTest, ClassificationUpdateProcessorTest, MinimalSchemaTest, ShardRoutingTest, SolrLogAuditLoggerPluginTest, CategoryRoutedAliasUpdateProcessorTest, TestWordDelimiterFilterFactory, TestSimDistributedQueue, ScriptEngineTest, ShardsWhitelistTest, BigEndianAscendingWordDeserializerTest, TestGraphTermsQParserPlugin, SolrInfoBeanTest, SystemLogListenerTest, TestMergePolicyConfig, DataDrivenBlockJoinTest, TestMacroExpander, TestCollationField, CoreAdminRequestStatusTest, TestCloudSearcherWarming, TestRequestStatusCollectionAPI, TestSimNodeLostTrigger, TestExportTool, TestStreamBody, TestOmitPositions, FastVectorHighlighterTest, SimplePostToolTest, TestAuthenticationFramework, TestSchemaNameResource, JsonLoaderTest, TriggerEventQueueTest, TestCloudPseudoReturnFields, TestJavabinTupleStreamParser, TestDirectoryFactory, CdcrVersionReplicationTest, RAMDirectoryFactoryTest, TestPhraseSuggestions, TestSolrCLIRunExample, TlogReplayBufferedWhileIndexingTest, CollectionReloadTest, RequestLoggingTest, ChaosMonkeyNothingIsSafeTest, TestJettySolrRunner, TestPseudoReturnFields, ConjunctionSolrSpellCheckerTest, TestSearchPerf, SchemaApiFailureTest, TestBackupRepositoryFactory, HdfsWriteToMultipleCollectionsTest, TestSolrCoreSnapshots, TestOrdValues, TestSimpleTextCodec, FieldMutatingUpdateProcessorTest, TestExtendedDismaxParser, TestReRankQParserPlugin, TestSurroundQueryParser, SimpleMLTQParserTest, BadCopyFieldTest, SOLR749Test, TestXIncludeConfig, NoCacheHeaderTest, TestLockTree, TestMissingGroups, ResponseBuilderTest, DistributedQueueTest, SuggestComponentContextFilterQueryTest, DateFieldTest, TestSchemaVersionResource, TestInitParams, TestSolrJ, ForceLeaderTest, LeaderTragicEventTest, TestRandomFaceting, CoreAdminCreateDiscoverTest, BaseCdcrDistributedZkTest, TestCloudJSONFacetJoinDomain, TestStressReorder, V2ApiIntegrationTest, SortByFunctionTest, PeerSyncWithIndexFingerprintCachingTest, DateMathParserTest, DistribCursorPagingTest, TestHdfsCloudBackupRestore, UUIDFieldTest, RecoveryZkTest, CursorPagingTest, TestCrossCoreJoin, TestGroupingSearch, TestHighlightDedupGrouping, TestJoin, TestRandomDVFaceting, TestSolrCoreProperties, TestSolrTestCaseJ4, TestTolerantSearch, TestTrie, TestCharFilters, TestDeprecatedFilters, TestLuceneMatchVersion, TestLuceneIndexBackCompat, TestEmbeddedSolrServerAdminHandler, TestEmbeddedSolrServerConstructors, ActionThrottleTest, AssignBackwardCompatibilityTest, BasicDistributedZk2Test, BasicZkTest, ChaosMonkeySafeLeaderWithPullReplicasTest, CleanupOldIndexTest, CloudExitableDirectoryReaderTest, ConcurrentCreateRoutedAliasTest, ConfigSetsAPITest, ConnectionManagerTest, CreateCollectionCleanupTest, CreateRoutedAliasTest, DeleteInactiveReplicaTest, DeleteLastCustomShardedReplicaTest, DeleteNodeTest, DocValuesNotIndexedTest, HealthCheckHandlerTest, HttpPartitionOnCommitTest, HttpPartitionWithTlogReplicasTest, LegacyCloudClusterPropTest, MissingSegmentRecoveryTest, MoveReplicaHDFSFailoverTest, MoveReplicaHDFSTest, MoveReplicaTest]
   [junit4] Completed [480/901 (1!)] on J1 in 37.36s, 2 tests, 1 failure <<< FAILURES!

[...truncated 53941 lines...]