Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/846/
Java: 32bit/jdk1.8.0_172 -client -XX:+UseSerialGC

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

Error Message:


Stack Trace:
java.lang.AssertionError
        at 
__randomizedtesting.SeedInfo.seed([B3941D605F5F4EFE:3BC022BAF1A32306]:0)
        at org.junit.Assert.fail(Assert.java:92)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertFalse(Assert.java:68)
        at org.junit.Assert.assertFalse(Assert.java:79)
        at org.apache.solr.cloud.MoveReplicaTest.test(MoveReplicaTest.java:146)
        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:1742)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985)
        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:944)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891)
        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 13198 lines...]
   [junit4] Suite: org.apache.solr.cloud.MoveReplicaTest
   [junit4]   2> 1718510 INFO  
(SUITE-MoveReplicaTest-seed#[B3941D605F5F4EFE]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MoveReplicaTest_B3941D605F5F4EFE-001\init-core-data-001
   [junit4]   2> 1718511 WARN  
(SUITE-MoveReplicaTest-seed#[B3941D605F5F4EFE]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
   [junit4]   2> 1718512 INFO  
(SUITE-MoveReplicaTest-seed#[B3941D605F5F4EFE]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1718517 INFO  
(SUITE-MoveReplicaTest-seed#[B3941D605F5F4EFE]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 1718520 INFO  
(SUITE-MoveReplicaTest-seed#[B3941D605F5F4EFE]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MoveReplicaTest_B3941D605F5F4EFE-001\tempDir-001
   [junit4]   2> 1718520 INFO  
(SUITE-MoveReplicaTest-seed#[B3941D605F5F4EFE]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1718521 INFO  (Thread-2580) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1718521 INFO  (Thread-2580) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1718526 ERROR (Thread-2580) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 1718620 INFO  
(SUITE-MoveReplicaTest-seed#[B3941D605F5F4EFE]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:65511
   [junit4]   2> 1718625 INFO  (zkConnectionManagerCallback-3260-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1718629 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x10041fd4d300000, likely client has closed socket
   [junit4]   2> 1718634 INFO  (jetty-launcher-3257-thread-3) [    ] 
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: 
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
   [junit4]   2> 1718635 INFO  (jetty-launcher-3257-thread-3) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1718635 INFO  (jetty-launcher-3257-thread-3) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1718635 INFO  (jetty-launcher-3257-thread-3) [    ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1718635 INFO  (jetty-launcher-3257-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@e5d83d{/solr,null,AVAILABLE}
   [junit4]   2> 1718637 INFO  (jetty-launcher-3257-thread-3) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@8f339d{SSL,[ssl, 
http/1.1]}{127.0.0.1:65515}
   [junit4]   2> 1718637 INFO  (jetty-launcher-3257-thread-3) [    ] 
o.e.j.s.Server Started @1718670ms
   [junit4]   2> 1718637 INFO  (jetty-launcher-3257-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=65515}
   [junit4]   2> 1718637 ERROR (jetty-launcher-3257-thread-3) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1718637 INFO  (jetty-launcher-3257-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1718637 INFO  (jetty-launcher-3257-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.6.0
   [junit4]   2> 1718637 INFO  (jetty-launcher-3257-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1718640 INFO  (jetty-launcher-3257-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: 
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
   [junit4]   2> 1718640 INFO  (jetty-launcher-3257-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1718640 INFO  (jetty-launcher-3257-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1718640 INFO  (jetty-launcher-3257-thread-1) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1718641 INFO  (jetty-launcher-3257-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@884bf4{/solr,null,AVAILABLE}
   [junit4]   2> 1718637 INFO  (jetty-launcher-3257-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1718641 INFO  (jetty-launcher-3257-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-10-22T15:47:36.227Z
   [junit4]   2> 1718642 INFO  (jetty-launcher-3257-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@1509f49{SSL,[ssl, 
http/1.1]}{127.0.0.1:65518}
   [junit4]   2> 1718642 INFO  (jetty-launcher-3257-thread-1) [    ] 
o.e.j.s.Server Started @1718675ms
   [junit4]   2> 1718642 INFO  (jetty-launcher-3257-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=65518}
   [junit4]   2> 1718642 ERROR (jetty-launcher-3257-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1718642 INFO  (jetty-launcher-3257-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1718643 INFO  (jetty-launcher-3257-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.6.0
   [junit4]   2> 1718643 INFO  (jetty-launcher-3257-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1718643 INFO  (jetty-launcher-3257-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1718643 INFO  (jetty-launcher-3257-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-10-22T15:47:36.229Z
   [junit4]   2> 1718644 INFO  (jetty-launcher-3257-thread-4) [    ] 
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: 
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
   [junit4]   2> 1718645 INFO  (jetty-launcher-3257-thread-4) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1718645 INFO  (jetty-launcher-3257-thread-4) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1718645 INFO  (jetty-launcher-3257-thread-4) [    ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1718645 INFO  (jetty-launcher-3257-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@cbafef{/solr,null,AVAILABLE}
   [junit4]   2> 1718646 INFO  (jetty-launcher-3257-thread-4) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@cbf659{SSL,[ssl, 
http/1.1]}{127.0.0.1:65525}
   [junit4]   2> 1718646 INFO  (jetty-launcher-3257-thread-4) [    ] 
o.e.j.s.Server Started @1718679ms
   [junit4]   2> 1718647 INFO  (jetty-launcher-3257-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=65525}
   [junit4]   2> 1718647 ERROR (jetty-launcher-3257-thread-4) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1718647 INFO  (jetty-launcher-3257-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1718647 INFO  (jetty-launcher-3257-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.6.0
   [junit4]   2> 1718647 INFO  (jetty-launcher-3257-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1718647 INFO  (jetty-launcher-3257-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1718647 INFO  (jetty-launcher-3257-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-10-22T15:47:36.233Z
   [junit4]   2> 1718652 INFO  (jetty-launcher-3257-thread-2) [    ] 
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: 
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
   [junit4]   2> 1718652 INFO  (jetty-launcher-3257-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1718652 INFO  (jetty-launcher-3257-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1718653 INFO  (jetty-launcher-3257-thread-2) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1718653 INFO  (jetty-launcher-3257-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@13aa882{/solr,null,AVAILABLE}
   [junit4]   2> 1718654 INFO  (jetty-launcher-3257-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@3f8902{SSL,[ssl, 
http/1.1]}{127.0.0.1:65531}
   [junit4]   2> 1718654 INFO  (jetty-launcher-3257-thread-2) [    ] 
o.e.j.s.Server Started @1718688ms
   [junit4]   2> 1718654 INFO  (jetty-launcher-3257-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=65531}
   [junit4]   2> 1718654 ERROR (jetty-launcher-3257-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1718654 INFO  (jetty-launcher-3257-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1718655 INFO  (jetty-launcher-3257-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.6.0
   [junit4]   2> 1718655 INFO  (jetty-launcher-3257-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1718655 INFO  (jetty-launcher-3257-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1718655 INFO  (jetty-launcher-3257-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-10-22T15:47:36.241Z
   [junit4]   2> 1718658 INFO  (zkConnectionManagerCallback-3266-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1718673 INFO  (zkConnectionManagerCallback-3264-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1718675 INFO  (zkConnectionManagerCallback-3262-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1718676 INFO  (jetty-launcher-3257-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1718677 INFO  (jetty-launcher-3257-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1718679 INFO  (jetty-launcher-3257-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1719167 INFO  (zkConnectionManagerCallback-3268-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1719194 INFO  (jetty-launcher-3257-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1719927 INFO  (jetty-launcher-3257-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:65511/solr
   [junit4]   2> 1719949 INFO  (jetty-launcher-3257-thread-4) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:65511/solr
   [junit4]   2> 1719957 INFO  (zkConnectionManagerCallback-3272-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1720120 INFO  (zkConnectionManagerCallback-3276-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1720404 INFO  (zkConnectionManagerCallback-3278-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1720420 INFO  (jetty-launcher-3257-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:65511/solr
   [junit4]   2> 1720432 INFO  (zkConnectionManagerCallback-3280-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1720472 INFO  (zkConnectionManagerCallback-3284-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1720505 INFO  (zkConnectionManagerCallback-3290-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1720528 INFO  (jetty-launcher-3257-thread-2) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:65531_solr
   [junit4]   2> 1720529 INFO  (jetty-launcher-3257-thread-2) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer Overseer 
(id=72130150215450634-127.0.0.1:65531_solr-n_0000000000) starting
   [junit4]   2> 1720551 INFO  (zkConnectionManagerCallback-3297-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1720555 INFO  (jetty-launcher-3257-thread-2) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:65511/solr ready
   [junit4]   2> 1720556 INFO  (jetty-launcher-3257-thread-2) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:65531_solr
   [junit4]   2> 1720570 INFO  (jetty-launcher-3257-thread-3) 
[n:127.0.0.1:65515_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1720571 INFO  (jetty-launcher-3257-thread-4) 
[n:127.0.0.1:65525_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1720577 INFO  (jetty-launcher-3257-thread-3) 
[n:127.0.0.1:65515_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1720577 INFO  (jetty-launcher-3257-thread-4) 
[n:127.0.0.1:65525_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1720577 INFO  (jetty-launcher-3257-thread-3) 
[n:127.0.0.1:65515_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:65515_solr
   [junit4]   2> 1720578 INFO  (jetty-launcher-3257-thread-4) 
[n:127.0.0.1:65525_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:65525_solr
   [junit4]   2> 1720637 INFO  (jetty-launcher-3257-thread-2) 
[n:127.0.0.1:65531_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1720707 INFO  (jetty-launcher-3257-thread-2) 
[n:127.0.0.1:65531_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_65531.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1720715 INFO  (jetty-launcher-3257-thread-2) 
[n:127.0.0.1:65531_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_65531.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1720715 INFO  (jetty-launcher-3257-thread-2) 
[n:127.0.0.1:65531_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_65531.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1720718 INFO  (jetty-launcher-3257-thread-2) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MoveReplicaTest_B3941D605F5F4EFE-001\tempDir-001\node4\.
   [junit4]   2> 1720719 INFO  
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:65531_solr
   [junit4]   2> 1720723 INFO  
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 1720726 INFO  (zkCallback-3277-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
   [junit4]   2> 1720727 INFO  (zkConnectionManagerCallback-3303-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1720732 INFO  (zkCallback-3279-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
   [junit4]   2> 1720733 INFO  (zkCallback-3296-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 1720741 INFO  (jetty-launcher-3257-thread-4) 
[n:127.0.0.1:65525_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 1720745 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 0, 
message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:65515_solr"} current state version: 0
   [junit4]   2> 1720745 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 0, 
message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:65525_solr"} current state version: 0
   [junit4]   2> 1720747 INFO  (jetty-launcher-3257-thread-4) 
[n:127.0.0.1:65525_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:65511/solr ready
   [junit4]   2> 1720748 INFO  (jetty-launcher-3257-thread-4) 
[n:127.0.0.1:65525_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1720761 INFO  (zkConnectionManagerCallback-3308-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1720773 INFO  (jetty-launcher-3257-thread-3) 
[n:127.0.0.1:65515_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 1720777 INFO  (jetty-launcher-3257-thread-3) 
[n:127.0.0.1:65515_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:65511/solr ready
   [junit4]   2> 1720777 INFO  (jetty-launcher-3257-thread-3) 
[n:127.0.0.1:65515_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1720783 INFO  (jetty-launcher-3257-thread-4) 
[n:127.0.0.1:65525_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_65525.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1720783 INFO  (jetty-launcher-3257-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:65511/solr
   [junit4]   2> 1720812 INFO  (jetty-launcher-3257-thread-4) 
[n:127.0.0.1:65525_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_65525.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1720812 INFO  (jetty-launcher-3257-thread-4) 
[n:127.0.0.1:65525_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_65525.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1720815 INFO  (jetty-launcher-3257-thread-4) 
[n:127.0.0.1:65525_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MoveReplicaTest_B3941D605F5F4EFE-001\tempDir-001\node3\.
   [junit4]   2> 1720817 INFO  (jetty-launcher-3257-thread-3) 
[n:127.0.0.1:65515_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_65515.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1720828 INFO  (jetty-launcher-3257-thread-3) 
[n:127.0.0.1:65515_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_65515.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1720828 INFO  (jetty-launcher-3257-thread-3) 
[n:127.0.0.1:65515_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_65515.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1720830 INFO  (jetty-launcher-3257-thread-3) 
[n:127.0.0.1:65515_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MoveReplicaTest_B3941D605F5F4EFE-001\tempDir-001\node2\.
   [junit4]   2> 1720833 INFO  (zkConnectionManagerCallback-3314-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1720838 INFO  (zkConnectionManagerCallback-3316-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1720849 INFO  (jetty-launcher-3257-thread-1) 
[n:127.0.0.1:65518_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 1720856 INFO  (jetty-launcher-3257-thread-1) 
[n:127.0.0.1:65518_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1720856 INFO  (jetty-launcher-3257-thread-1) 
[n:127.0.0.1:65518_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:65518_solr
   [junit4]   2> 1720857 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:65518_solr"} current state version: 0
   [junit4]   2> 1720859 INFO  (zkCallback-3279-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1720859 INFO  (zkCallback-3277-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1720859 INFO  (zkCallback-3296-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1720859 INFO  (zkCallback-3289-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1720914 INFO  (zkCallback-3315-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1720916 INFO  (zkCallback-3302-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1720916 INFO  (zkCallback-3307-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1720950 INFO  (zkConnectionManagerCallback-3323-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1720951 INFO  (jetty-launcher-3257-thread-1) 
[n:127.0.0.1:65518_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (4)
   [junit4]   2> 1720953 INFO  (jetty-launcher-3257-thread-1) 
[n:127.0.0.1:65518_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:65511/solr ready
   [junit4]   2> 1720954 INFO  (jetty-launcher-3257-thread-1) 
[n:127.0.0.1:65518_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1720994 INFO  (jetty-launcher-3257-thread-1) 
[n:127.0.0.1:65518_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_65518.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1721007 INFO  (jetty-launcher-3257-thread-1) 
[n:127.0.0.1:65518_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_65518.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1721008 INFO  (jetty-launcher-3257-thread-1) 
[n:127.0.0.1:65518_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_65518.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1721009 INFO  (jetty-launcher-3257-thread-1) 
[n:127.0.0.1:65518_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MoveReplicaTest_B3941D605F5F4EFE-001\tempDir-001\node1\.
   [junit4]   2> 1721096 INFO  (zkConnectionManagerCallback-3326-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1721106 INFO  (zkConnectionManagerCallback-3331-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1721107 INFO  
(SUITE-MoveReplicaTest-seed#[B3941D605F5F4EFE]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 1721108 INFO  
(SUITE-MoveReplicaTest-seed#[B3941D605F5F4EFE]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:65511/solr ready
   [junit4]   2> 1721178 INFO  (qtp27354813-12097) [n:127.0.0.1:65531_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with 
params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 1721193 INFO  (qtp27354813-12097) [n:127.0.0.1:65531_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=13
   [junit4]   2> 1721239 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testFailedMove
   [junit4]   2> 1721240 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 1721324 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) [    ] 
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: 
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
   [junit4]   2> 1721325 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1721325 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1721325 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) [    ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1721326 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@cd1c7c{/solr,null,AVAILABLE}
   [junit4]   2> 1721327 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@117ba41{SSL,[ssl, 
http/1.1]}{127.0.0.1:49205}
   [junit4]   2> 1721327 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) [    ] 
o.e.j.s.Server Started @1721361ms
   [junit4]   2> 1721327 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=49205}
   [junit4]   2> 1721329 ERROR 
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1721329 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1721329 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.6.0
   [junit4]   2> 1721329 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1721329 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1721329 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-10-22T15:47:38.915Z
   [junit4]   2> 1721333 INFO  (zkConnectionManagerCallback-3335-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1721335 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1723125 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:65511/solr
   [junit4]   2> 1723128 INFO  (zkConnectionManagerCallback-3339-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1723134 INFO  (zkConnectionManagerCallback-3341-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1723145 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) 
[n:127.0.0.1:49205_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (4)
   [junit4]   2> 1723152 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) 
[n:127.0.0.1:49205_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1723153 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) 
[n:127.0.0.1:49205_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:49205_solr
   [junit4]   2> 1723153 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:49205_solr"} current state version: 0
   [junit4]   2> 1723156 INFO  (zkCallback-3279-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1723157 INFO  (zkCallback-3302-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1723157 INFO  (zkCallback-3277-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1723158 INFO  (zkCallback-3330-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1723158 INFO  (zkCallback-3296-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1723158 INFO  (zkCallback-3315-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1723158 INFO  (zkCallback-3322-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1723158 INFO  (zkCallback-3330-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1723158 INFO  (zkCallback-3289-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1723158 INFO  (zkCallback-3307-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1723159 INFO  (zkCallback-3340-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1723186 INFO  
(OverseerCollectionConfigSetProcessor-72130150215450634-127.0.0.1:65531_solr-n_0000000000)
 [n:127.0.0.1:65531_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> 1723236 INFO  (zkConnectionManagerCallback-3348-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1723236 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) 
[n:127.0.0.1:49205_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (5)
   [junit4]   2> 1723236 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) 
[n:127.0.0.1:49205_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:65511/solr ready
   [junit4]   2> 1723240 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) 
[n:127.0.0.1:49205_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1723279 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) 
[n:127.0.0.1:49205_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_49205.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1723290 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) 
[n:127.0.0.1:49205_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_49205.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1723290 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) 
[n:127.0.0.1:49205_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_49205.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1723293 INFO  
(TEST-MoveReplicaTest.testFailedMove-seed#[B3941D605F5F4EFE]) 
[n:127.0.0.1:49205_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MoveReplicaTest_B3941D605F5F4EFE-001\tempDir-001\node5\.
   [junit4]   2> 1723389 INFO  (zkConnectionManagerCallback-3351-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1723451 INFO  (qtp9676835-12200) [n:127.0.0.1:49205_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
collection.configName=conf1&autoAddReplicas=false&name=MoveReplicaTest_failed_coll_true&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1723459 INFO  
(OverseerThreadFactory-5646-thread-2-processing-n:127.0.0.1:65531_solr) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
MoveReplicaTest_failed_coll_true
   [junit4]   2> 1723470 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "name":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "fromApi":"true",
   [junit4]   2>   "collection.configName":"conf1",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"2",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "operation":"create"} current state version: 0
   [junit4]   2> 1723586 INFO  (qtp27354813-12097) [n:127.0.0.1:65531_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=4
   [junit4]   2> 1723599 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=3
   [junit4]   2> 1723654 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=3
   [junit4]   2> 1723715 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=5
   [junit4]   2> 1723791 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=4
   [junit4]   2> 1723806 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"MoveReplicaTest_failed_coll_true_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:65518/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 1723806 INFO  
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"MoveReplicaTest_failed_coll_true_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:65518/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1723813 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 2, 
message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"MoveReplicaTest_failed_coll_true_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:65515/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 1723815 INFO  
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"MoveReplicaTest_failed_coll_true_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:65515/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1723820 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 3, 
message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"MoveReplicaTest_failed_coll_true_shard2_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:65525/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 1723820 INFO  
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"MoveReplicaTest_failed_coll_true_shard2_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:65525/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1723823 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 4, 
message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"MoveReplicaTest_failed_coll_true_shard2_replica_n6",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:49205/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 1723823 INFO  
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"MoveReplicaTest_failed_coll_true_shard2_replica_n6",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:49205/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1724051 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr    
x:MoveReplicaTest_failed_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_failed_coll_true_shard1_replica_n1&action=CREATE&numShards=2&collection=MoveReplicaTest_failed_coll_true&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1724058 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr    
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf1&newCollection=true&name=MoveReplicaTest_failed_coll_true_shard1_replica_n2&action=CREATE&numShards=2&collection=MoveReplicaTest_failed_coll_true&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1724061 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr    
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=MoveReplicaTest_failed_coll_true_shard2_replica_n6&action=CREATE&numShards=2&collection=MoveReplicaTest_failed_coll_true&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1724063 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr    
x:MoveReplicaTest_failed_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_failed_coll_true_shard2_replica_n4&action=CREATE&numShards=2&collection=MoveReplicaTest_failed_coll_true&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1724080 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 4, 
message = {
   [junit4]   2>   "core":"MoveReplicaTest_failed_coll_true_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node3",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:65518/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:65518_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1724080 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 4, 
message = {
   [junit4]   2>   "core":"MoveReplicaTest_failed_coll_true_shard1_replica_n2",
   [junit4]   2>   "core_node_name":"core_node5",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:65515/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:65515_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1724080 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 4, 
message = {
   [junit4]   2>   "core":"MoveReplicaTest_failed_coll_true_shard2_replica_n6",
   [junit4]   2>   "core_node_name":"core_node8",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:49205/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:49205_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1724081 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 4, 
message = {
   [junit4]   2>   "core":"MoveReplicaTest_failed_coll_true_shard2_replica_n4",
   [junit4]   2>   "core_node_name":"core_node7",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:65525/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:65525_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1725127 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n1] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.6.0
   [junit4]   2> 1725129 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n4] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.6.0
   [junit4]   2> 1725134 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.6.0
   [junit4]   2> 1725134 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.6.0
   [junit4]   2> 1725153 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n1] o.a.s.s.IndexSchema 
[MoveReplicaTest_failed_coll_true_shard1_replica_n1] Schema name=cloud-dynamic
   [junit4]   2> 1725154 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n4] o.a.s.s.IndexSchema 
[MoveReplicaTest_failed_coll_true_shard2_replica_n4] Schema name=cloud-dynamic
   [junit4]   2> 1725162 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.s.IndexSchema 
[MoveReplicaTest_failed_coll_true_shard2_replica_n6] Schema name=cloud-dynamic
   [junit4]   2> 1725181 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] o.a.s.s.IndexSchema 
[MoveReplicaTest_failed_coll_true_shard1_replica_n2] Schema name=cloud-dynamic
   [junit4]   2> 1725193 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n4] o.a.s.s.IndexSchema 
Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 1725193 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n4] o.a.s.c.CoreContainer 
Creating SolrCore 'MoveReplicaTest_failed_coll_true_shard2_replica_n4' using 
configuration from collection MoveReplicaTest_failed_coll_true, trusted=true
   [junit4]   2> 1725193 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n4] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 
'solr_65525.solr.core.MoveReplicaTest_failed_coll_true.shard2.replica_n4' 
(registry 'solr.core.MoveReplicaTest_failed_coll_true.shard2.replica_n4') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1725193 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n4] o.a.s.c.SolrCore 
[[MoveReplicaTest_failed_coll_true_shard2_replica_n4] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MoveReplicaTest_B3941D605F5F4EFE-001\tempDir-001\node3\MoveReplicaTest_failed_coll_true_shard2_replica_n4],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MoveReplicaTest_B3941D605F5F4EFE-001\tempDir-001\node3\.\MoveReplicaTest_failed_coll_true_shard2_replica_n4\data\]
   [junit4]   2> 1725207 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n1] o.a.s.s.IndexSchema 
Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 1725207 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n1] o.a.s.c.CoreContainer 
Creating SolrCore 'MoveReplicaTest_failed_coll_true_shard1_replica_n1' using 
configuration from collection MoveReplicaTest_failed_coll_true, trusted=true
   [junit4]   2> 1725208 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 
'solr_65518.solr.core.MoveReplicaTest_failed_coll_true.shard1.replica_n1' 
(registry 'solr.core.MoveReplicaTest_failed_coll_true.shard1.replica_n1') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1725208 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n1] o.a.s.c.SolrCore 
[[MoveReplicaTest_failed_coll_true_shard1_replica_n1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MoveReplicaTest_B3941D605F5F4EFE-001\tempDir-001\node1\MoveReplicaTest_failed_coll_true_shard1_replica_n1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MoveReplicaTest_B3941D605F5F4EFE-001\tempDir-001\node1\.\MoveReplicaTest_failed_coll_true_shard1_replica_n1\data\]
   [junit4]   2> 1725220 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.s.IndexSchema 
Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 1725221 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.c.CoreContainer 
Creating SolrCore 'MoveReplicaTest_failed_coll_true_shard2_replica_n6' using 
configuration from collection MoveReplicaTest_failed_coll_true, trusted=true
   [junit4]   2> 1725222 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 
'solr_49205.solr.core.MoveReplicaTest_failed_coll_true.shard2.replica_n6' 
(registry 'solr.core.MoveReplicaTest_failed_coll_true.shard2.replica_n6') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1725222 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.c.SolrCore 
[[MoveReplicaTest_failed_coll_true_shard2_replica_n6] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MoveReplicaTest_B3941D605F5F4EFE-001\tempDir-001\node5\MoveReplicaTest_failed_coll_true_shard2_replica_n6],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MoveReplicaTest_B3941D605F5F4EFE-001\tempDir-001\node5\.\MoveReplicaTest_failed_coll_true_shard2_replica_n6\data\]
   [junit4]   2> 1725225 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] o.a.s.s.IndexSchema 
Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 1725225 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] o.a.s.c.CoreContainer 
Creating SolrCore 'MoveReplicaTest_failed_coll_true_shard1_replica_n2' using 
configuration from collection MoveReplicaTest_failed_coll_true, trusted=true
   [junit4]   2> 1725225 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 
'solr_65515.solr.core.MoveReplicaTest_failed_coll_true.shard1.replica_n2' 
(registry 'solr.core.MoveReplicaTest_failed_coll_true.shard1.replica_n2') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@a7ecca
   [junit4]   2> 1725226 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] o.a.s.c.SolrCore 
[[MoveReplicaTest_failed_coll_true_shard1_replica_n2] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MoveReplicaTest_B3941D605F5F4EFE-001\tempDir-001\node2\MoveReplicaTest_failed_coll_true_shard1_replica_n2],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MoveReplicaTest_B3941D605F5F4EFE-001\tempDir-001\node2\.\MoveReplicaTest_failed_coll_true_shard1_replica_n2\data\]
   [junit4]   2> 1726113 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n1] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1726113 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n4] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1726113 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1726113 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n4] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1726113 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1726115 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1726115 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1726115 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1726118 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n1] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1726118 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n1] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1726118 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n4] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1726119 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n4] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1726119 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1726119 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1726121 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1726121 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1726122 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@1c1c585[MoveReplicaTest_failed_coll_true_shard2_replica_n6] 
main]
   [junit4]   2> 1726122 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n4] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@12bd435[MoveReplicaTest_failed_coll_true_shard2_replica_n4] 
main]
   [junit4]   2> 1726124 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n4] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1726124 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1726124 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n4] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1726124 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1726125 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@d9f148[MoveReplicaTest_failed_coll_true_shard1_replica_n2] 
main]
   [junit4]   2> 1726125 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n4] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1726125 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n4] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1615041148969025536
   [junit4]   2> 1726126 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1726126 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1615041148970074112
   [junit4]   2> 1726127 INFO  
(searcherExecutor-5669-thread-1-processing-n:127.0.0.1:65525_solr 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n4 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7) 
[n:127.0.0.1:65525_solr c:MoveReplicaTest_failed_coll_true s:shard2 
r:core_node7 x:MoveReplicaTest_failed_coll_true_shard2_replica_n4] 
o.a.s.c.SolrCore [MoveReplicaTest_failed_coll_true_shard2_replica_n4] 
Registered new searcher 
Searcher@12bd435[MoveReplicaTest_failed_coll_true_shard2_replica_n4] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1726129 INFO  
(searcherExecutor-5671-thread-1-processing-n:127.0.0.1:49205_solr 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8) 
[n:127.0.0.1:49205_solr c:MoveReplicaTest_failed_coll_true s:shard2 
r:core_node8 x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] 
o.a.s.c.SolrCore [MoveReplicaTest_failed_coll_true_shard2_replica_n6] 
Registered new searcher 
Searcher@1c1c585[MoveReplicaTest_failed_coll_true_shard2_replica_n6] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1726131 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1726132 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1726133 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1726133 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1615041148977414144
   [junit4]   2> 1726135 INFO  
(searcherExecutor-5672-thread-1-processing-n:127.0.0.1:65515_solr 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5) 
[n:127.0.0.1:65515_solr c:MoveReplicaTest_failed_coll_true s:shard1 
r:core_node5 x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] 
o.a.s.c.SolrCore [MoveReplicaTest_failed_coll_true_shard1_replica_n2] 
Registered new searcher 
Searcher@d9f148[MoveReplicaTest_failed_coll_true_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1726136 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n4] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/MoveReplicaTest_failed_coll_true/terms/shard2 to 
Terms{values={core_node7=0}, version=0}
   [junit4]   2> 1726136 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.c.ZkShardTerms 
Failed to save terms, version is not a match, retrying
   [junit4]   2> 1726137 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@1323704[MoveReplicaTest_failed_coll_true_shard1_replica_n1] 
main]
   [junit4]   2> 1726138 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/MoveReplicaTest_failed_coll_true/terms/shard2 to 
Terms{values={core_node7=0, core_node8=0}, version=1}
   [junit4]   2> 1726141 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/MoveReplicaTest_failed_coll_true/terms/shard1 to 
Terms{values={core_node5=0}, version=0}
   [junit4]   2> 1726144 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1726145 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1726145 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1726145 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true"} current 
state version: 0
   [junit4]   2> 1726145 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.c.SyncStrategy Sync 
replicas to 
https://127.0.0.1:49205/solr/MoveReplicaTest_failed_coll_true_shard2_replica_n6/
   [junit4]   2> 1726145 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1726146 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.u.PeerSync 
PeerSync: core=MoveReplicaTest_failed_coll_true_shard2_replica_n6 
url=https://127.0.0.1:49205/solr START 
replicas=[https://127.0.0.1:65525/solr/MoveReplicaTest_failed_coll_true_shard2_replica_n4/]
 nUpdates=100
   [junit4]   2> 1726146 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1726147 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.u.PeerSync 
PeerSync: core=MoveReplicaTest_failed_coll_true_shard2_replica_n6 
url=https://127.0.0.1:49205/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 1726147 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n1] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1615041148992094208
   [junit4]   2> 1726148 INFO  
(searcherExecutor-5670-thread-1-processing-n:127.0.0.1:65518_solr 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n1 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3) 
[n:127.0.0.1:65518_solr c:MoveReplicaTest_failed_coll_true s:shard1 
r:core_node3 x:MoveReplicaTest_failed_coll_true_shard1_replica_n1] 
o.a.s.c.SolrCore [MoveReplicaTest_failed_coll_true_shard1_replica_n1] 
Registered new searcher 
Searcher@1323704[MoveReplicaTest_failed_coll_true_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1726149 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard1: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 1726149 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 2, 
message = {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true"} current 
state version: 0
   [junit4]   2> 1726158 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n1] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/MoveReplicaTest_failed_coll_true/terms/shard1 to 
Terms{values={core_node3=0, core_node5=0}, version=1}
   [junit4]   2> 1726158 INFO  (qtp26544089-12066) [n:127.0.0.1:65525_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n4] o.a.s.c.S.Request 
[MoveReplicaTest_failed_coll_true_shard2_replica_n4]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=1
   [junit4]   2> 1726159 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.c.SyncStrategy 
Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 1726159 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 1726159 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1726164 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:49205/solr/MoveReplicaTest_failed_coll_true_shard2_replica_n6/
 shard2
   [junit4]   2> 1726166 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 3, 
message = {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "base_url":"https://127.0.0.1:49205/solr";,
   [junit4]   2>   "core":"MoveReplicaTest_failed_coll_true_shard2_replica_n6",
   [junit4]   2>   "state":"active"} current state version: 0
   [junit4]   2> 1726269 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] o.a.s.c.ZkController I am 
the leader, no recovery necessary
   [junit4]   2> 1726271 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "core":"MoveReplicaTest_failed_coll_true_shard2_replica_n6",
   [junit4]   2>   "core_node_name":"core_node8",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:49205/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:49205_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1726274 INFO  (qtp9676835-12196) [n:127.0.0.1:49205_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node8 
x:MoveReplicaTest_failed_coll_true_shard2_replica_n6] 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_failed_coll_true_shard2_replica_n6&action=CREATE&numShards=2&collection=MoveReplicaTest_failed_coll_true&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2215
   [junit4]   2> 1726373 INFO  (zkCallback-3340-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MoveReplicaTest_failed_coll_true/state.json] for collection 
[MoveReplicaTest_failed_coll_true] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1726651 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1726651 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1726651 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] o.a.s.c.SyncStrategy Sync 
replicas to 
https://127.0.0.1:65515/solr/MoveReplicaTest_failed_coll_true_shard1_replica_n2/
   [junit4]   2> 1726652 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] o.a.s.u.PeerSync 
PeerSync: core=MoveReplicaTest_failed_coll_true_shard1_replica_n2 
url=https://127.0.0.1:65515/solr START 
replicas=[https://127.0.0.1:65518/solr/MoveReplicaTest_failed_coll_true_shard1_replica_n1/]
 nUpdates=100
   [junit4]   2> 1726653 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] o.a.s.u.PeerSync 
PeerSync: core=MoveReplicaTest_failed_coll_true_shard1_replica_n2 
url=https://127.0.0.1:65515/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 1726662 INFO  (qtp5382242-12057) [n:127.0.0.1:65518_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n1] o.a.s.c.S.Request 
[MoveReplicaTest_failed_coll_true_shard1_replica_n1]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1726663 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] o.a.s.c.SyncStrategy 
Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 1726663 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 1726663 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1726668 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:65515/solr/MoveReplicaTest_failed_coll_true_shard1_replica_n2/
 shard1
   [junit4]   2> 1726669 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "base_url":"https://127.0.0.1:65515/solr";,
   [junit4]   2>   "core":"MoveReplicaTest_failed_coll_true_shard1_replica_n2",
   [junit4]   2>   "state":"active"} current state version: 0
   [junit4]   2> 1726772 INFO  (zkCallback-3340-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MoveReplicaTest_failed_coll_true/state.json] for collection 
[MoveReplicaTest_failed_coll_true] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1726822 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] o.a.s.c.ZkController I am 
the leader, no recovery necessary
   [junit4]   2> 1726824 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "core":"MoveReplicaTest_failed_coll_true_shard1_replica_n2",
   [junit4]   2>   "core_node_name":"core_node5",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:65515/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:65515_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1726826 INFO  (qtp31496497-12053) [n:127.0.0.1:65515_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node5 
x:MoveReplicaTest_failed_coll_true_shard1_replica_n2] 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_failed_coll_true_shard1_replica_n2&action=CREATE&numShards=2&collection=MoveReplicaTest_failed_coll_true&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2768
   [junit4]   2> 1726927 INFO  (zkCallback-3340-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MoveReplicaTest_failed_coll_true/state.json] for collection 
[MoveReplicaTest_failed_coll_true] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1726927 INFO  (zkCallback-3277-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MoveReplicaTest_failed_coll_true/state.json] for collection 
[MoveReplicaTest_failed_coll_true] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1727147 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "core":"MoveReplicaTest_failed_coll_true_shard2_replica_n4",
   [junit4]   2>   "core_node_name":"core_node7",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:65525/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:65525_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1727150 INFO  (qtp26544089-12069) [n:127.0.0.1:65525_solr 
c:MoveReplicaTest_failed_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_failed_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_failed_coll_true_shard2_replica_n4&action=CREATE&numShards=2&collection=MoveReplicaTest_failed_coll_true&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=3086
   [junit4]   2> 1727164 DEBUG 
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer processMessage: queueSize: 2, 
message = {
   [junit4]   2>   "core":"MoveReplicaTest_failed_coll_true_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node3",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:65518/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:65518_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"MoveReplicaTest_failed_coll_true",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1727167 INFO  (qtp5382242-12060) [n:127.0.0.1:65518_solr 
c:MoveReplicaTest_failed_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_failed_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_failed_coll_true_shard1_replica_n1&action=CREATE&numShard

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

, tag=ef916c
   [junit4]   2> 1748717 INFO  (coreCloseExecutor-5721-thread-1) 
[n:127.0.0.1:65531_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 
x:MoveReplicaTest_coll_true_shard1_replica_n1] o.a.s.m.SolrMetricManager 
Closing metric reporters for 
registry=solr.collection.MoveReplicaTest_coll_true.shard1.leader, tag=8edb2a
   [junit4]   2> 1748721 INFO  (coreCloseExecutor-5723-thread-1) 
[n:127.0.0.1:65518_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 
x:MoveReplicaTest_coll_true_shard2_replica_n4] o.a.s.m.SolrMetricManager 
Closing metric reporters for 
registry=solr.collection.MoveReplicaTest_coll_true.shard2.leader, tag=15f370b
   [junit4]   2> 1748723 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x10041fd4d30000d, likely client has closed socket
   [junit4]   2> 1748725 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x10041fd4d300007, likely client has closed socket
   [junit4]   2> 1748726 INFO  (jetty-closer-3258-thread-3) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@e5d83d{/solr,null,UNAVAILABLE}
   [junit4]   2> 1748726 INFO  (jetty-closer-3258-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72130150215450634-127.0.0.1:65531_solr-n_0000000000) closing
   [junit4]   2> 1748727 INFO  (jetty-closer-3258-thread-3) [    ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1748729 INFO  
(OverseerStateUpdate-72130150215450634-127.0.0.1:65531_solr-n_0000000000) 
[n:127.0.0.1:65531_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:65531_solr
   [junit4]   2> 1748731 WARN  
(OverseerAutoScalingTriggerThread-72130150215450634-127.0.0.1:65531_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 1748735 INFO  (jetty-closer-3258-thread-4) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@884bf4{/solr,null,UNAVAILABLE}
   [junit4]   2> 1748736 INFO  (jetty-closer-3258-thread-4) [    ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1748736 INFO  (jetty-closer-3258-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@13aa882{/solr,null,UNAVAILABLE}
   [junit4]   2> 1748737 INFO  (jetty-closer-3258-thread-1) [    ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1748737 ERROR 
(SUITE-MoveReplicaTest-seed#[B3941D605F5F4EFE]-worker) [    ] 
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper 
server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 1748738 INFO  
(SUITE-MoveReplicaTest-seed#[B3941D605F5F4EFE]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:65511 65511
   [junit4]   2> 1748739 INFO  (Thread-2580) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:65511 65511
   [junit4]   2> 1748740 WARN  (Thread-2580) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        15      /solr/aliases.json
   [junit4]   2>        10      
/solr/collections/MoveReplicaTest_failed_coll_true/terms/shard1
   [junit4]   2>        9       
/solr/collections/MoveReplicaTest_failed_coll_true/terms/shard2
   [junit4]   2>        8       
/solr/collections/MoveReplicaTest_coll_true/terms/shard2
   [junit4]   2>        7       /solr/configs/conf1
   [junit4]   2>        6       /solr/security.json
   [junit4]   2>        4       
/solr/collections/MoveReplicaTest_coll_true/terms/shard1
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        15      /solr/clusterprops.json
   [junit4]   2>        15      /solr/clusterstate.json
   [junit4]   2>        4       
/solr/collections/MoveReplicaTest_failed_coll_true/state.json
   [junit4]   2>        4       
/solr/collections/MoveReplicaTest_coll_true/state.json
   [junit4]   2>        3       /solr/aliases.json
   [junit4]   2>        2       
/solr/overseer_elect/election/72130150215450631-127.0.0.1:65515_solr-n_0000000001
   [junit4]   2>        2       
/solr/overseer_elect/election/72130150215450639-127.0.0.1:65518_solr-n_0000000003
   [junit4]   2>        2       
/solr/overseer_elect/election/72130150215450634-127.0.0.1:65531_solr-n_0000000000
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        20      /solr/collections
   [junit4]   2>        19      /solr/live_nodes
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MoveReplicaTest_B3941D605F5F4EFE-001
   [junit4]   2> Oct 22, 2018 3:48:06 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 9 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Lucene70, 
sim=RandomSimilarity(queryNorm=true): {}, locale=pt-BR, timezone=Pacific/Gambier
   [junit4]   2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_172 
(32-bit)/cpus=3,threads=1,free=41224752,total=300007424
   [junit4]   2> NOTE: All tests run in this JVM: [TestSolr4Spatial, 
TestCrossCoreJoin, BlockJoinFacetSimpleTest, TestCustomSort, 
SolrRrdBackendFactoryTest, SchemaVersionSpecificBehaviorTest, 
ReplicaListTransformerTest, RankQueryTest, TestSolrCoreProperties, 
TestShortCircuitedRequests, ZkControllerTest, TestMultiValuedNumericRangeQuery, 
DocValuesNotIndexedTest, TestSimNodeAddedTrigger, TestIntervalFaceting, 
MetricTriggerTest, OverseerRolesTest, TestRequestStatusCollectionAPI, 
RollingRestartTest, MetricsConfigTest, ConcurrentCreateRoutedAliasTest, 
TestRandomFaceting, TestAnalyzedSuggestions, SpellingQueryConverterTest, 
QueryResultKeyTest, HdfsCollectionsAPIDistributedZkTest, TestRebalanceLeaders, 
TestJsonRequest, TestFilteredDocIdSet, PeerSyncWithBufferUpdatesTest, 
MultiThreadedOCPTest, TestCloudManagedSchema, PreAnalyzedFieldTest, 
TestConfigSetImmutable, ScheduledTriggerIntegrationTest, SuggesterTSTTest, 
TestCSVResponseWriter, TestLegacyNumericUtils, TestHashQParserPlugin, 
MaxSizeAutoCommitTest, CdcrVersionReplicationTest, TestStreamBody, 
TestRestoreCore, DocValuesMissingTest, SpatialHeatmapFacetsTest, 
NodeLostTriggerTest, DistributedFacetPivotWhiteBoxTest, TestReload, 
TestPostingsSolrHighlighter, DocValuesTest, TestJsonFacetsWithNestedObjects, 
TestReRankQParserPlugin, TestJettySolrRunner, HttpPartitionTest, TestBadConfig, 
TaggingAttributeTest, TestExpandComponent, RequiredFieldsTest, 
SuggestComponentContextFilterQueryTest, LeaderFailoverAfterPartitionTest, 
SpellCheckCollatorWithCollapseTest, WordBreakSolrSpellCheckerTest, 
HDFSCollectionsAPITest, CollectionStateFormat2Test, SolrInfoBeanTest, 
ConcurrentDeleteAndCreateCollectionTest, TestConfigSetsAPIExclusivity, 
BadComponentTest, TestSimpleQParserPlugin, XmlUpdateRequestHandlerTest, 
MBeansHandlerTest, TestOmitPositions, CollectionsAPIAsyncDistributedZkTest, 
OutOfBoxZkACLAndCredentialsProvidersTest, TestLocalFSCloudBackupRestore, 
CollectionReloadTest, TestTolerantUpdateProcessorCloud, TestManagedResource, 
TestOrdValues, TestBinaryField, DistanceUnitsTest, CopyFieldTest, 
TestFieldResource, DistributedFacetPivotSmallAdvancedTest, ZkSolrClientTest, 
TestLegacyFieldCache, RequestHandlersTest, UpdateParamsTest, 
TestSchemaResource, VMParamsZkACLAndCredentialsProvidersTest, 
TestOverriddenPrefixQueryForCustomFieldType, TolerantUpdateProcessorTest, 
Tagger2Test, DateFieldTest, TestSkipOverseerOperations, 
TestDistributedGrouping, MetricsHistoryHandlerTest, ActionThrottleTest, 
FacetPivotSmallTest, TestStressReorder, TestWordDelimiterFilterFactory, 
HdfsRestartWhileUpdatingTest, TestNonDefinedSimilarityFactory, 
TriggerCooldownIntegrationTest, ProtectedTermFilterFactoryTest, SolrCoreTest, 
MigrateRouteKeyTest, EmbeddedSolrNoSerializeTest, 
UpdateRequestProcessorFactoryTest, TestShardHandlerFactory, ShardRoutingTest, 
StressHdfsTest, TestCustomStream, CdcrUpdateLogTest, 
CachingDirectoryFactoryTest, TestStressLucene, TestConfigSets, TestQueryTypes, 
CoreMergeIndexesAdminHandlerTest, TestHdfsUpdateLog, 
HdfsChaosMonkeySafeLeaderTest, PreAnalyzedUpdateProcessorTest, 
TimeZoneUtilsTest, TestWriterPerf, TestDistribDocBasedVersion, 
TestFieldCacheVsDocValues, HdfsAutoAddReplicasIntegrationTest, 
HdfsDirectoryTest, TestMacros, RulesTest, TestExportWriter, 
TestSolrCloudSnapshots, TestPartialUpdateDeduplication, 
TestPerFieldSimilarityWithDefaultOverride, TestSolrQueryResponse, 
V2ApiIntegrationTest, HighlighterMaxOffsetTest, NumericFieldsTest, 
TestSearchPerf, TestCloudJSONFacetSKG, SolrJmxReporterTest, 
TestChildDocTransformerHierarchy, RestoreTriggerStateTest, 
TestStressCloudBlindAtomicUpdates, AddBlockUpdateTest, 
TestPKIAuthenticationPlugin, ExternalFileFieldSortTest, 
ExitableDirectoryReaderTest, UUIDUpdateProcessorFallbackTest, 
TestSchemaManager, TriggerIntegrationTest, CoreAdminCreateDiscoverTest, 
TestSchemaVersionResource, TestLegacyField, MoveReplicaTest]
   [junit4] Completed [217/834 (1!)] on J0 in 30.77s, 2 tests, 1 failure <<< 
FAILURES!

[...truncated 47203 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/846/consoleText

[repro] Revision: 4332b0aa6e467c1ae18246fa25301ae9410b4d7f

[repro] Ant options: "-Dargs=-client -XX:+UseSerialGC"

[repro] ant clean

[...truncated 6 lines...]
[repro] Test suites by module:
[repro]    solr\core
[repro]       MoveReplicaTest
[repro] ant compile-test

[...truncated 3458 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.MoveReplicaTest" -Dtests.showOutput=onerror "-Dargs=-client 
-XX:+UseSerialGC" -Dtests.seed=B3941D605F5F4EFE -Dtests.slow=true 
-Dtests.locale=pt-BR -Dtests.timezone=Pacific/Gambier -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1

[...truncated 74 lines...]
[repro] Failures:
[repro]   0/5 failed: org.apache.solr.cloud.MoveReplicaTest
[repro] Exiting with code 0

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

Reply via email to