Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/20927/ Java: 64bit/jdk-9.0.1 -XX:+UseCompressedOops -XX:+UseG1GC
3 tests failed. FAILED: junit.framework.TestSuite.org.apache.solr.client.solrj.io.graph.GraphExpressionTest Error Message: Error from server at https://127.0.0.1:35291/solr: create the collection time out:180s Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:35291/solr: create the collection time out:180s at __randomizedtesting.SeedInfo.seed([CE8CD1B9BDD268E1]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1104) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:883) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:816) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211) at org.apache.solr.client.solrj.io.graph.GraphExpressionTest.setupCluster(GraphExpressionTest.java:87) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:874) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at 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.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.cloud.MoveReplicaHDFSFailoverTest.testOldReplicaIsDeleted Error Message: Stack Trace: java.lang.AssertionError at __randomizedtesting.SeedInfo.seed([D9B8AD0C1B4AE93E:962649D11A40A65C]:0) at org.junit.Assert.fail(Assert.java:92) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertTrue(Assert.java:54) at org.apache.solr.cloud.MoveReplicaHDFSFailoverTest.testOldReplicaIsDeleted(MoveReplicaHDFSFailoverTest.java:149) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at 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.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.cloud.MoveReplicaHDFSFailoverTest.testDataDirAndUlogAreMaintained Error Message: Error from server at https://127.0.0.1:32813/solr: Could not fully create collection: movereplicatest_coll2 Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:32813/solr: Could not fully create collection: movereplicatest_coll2 at __randomizedtesting.SeedInfo.seed([D9B8AD0C1B4AE93E:F68B38DFA73A5B1C]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1104) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:883) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:816) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211) at org.apache.solr.cloud.MoveReplicaHDFSFailoverTest.testDataDirAndUlogAreMaintained(MoveReplicaHDFSFailoverTest.java:75) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at 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.base/java.lang.Thread.run(Thread.java:844) Build Log: [...truncated 11929 lines...] [junit4] Suite: org.apache.solr.cloud.MoveReplicaHDFSFailoverTest [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSFailoverTest_D9B8AD0C1B4AE93E-001/init-core-data-001 [junit4] 2> 443411 WARN (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=11974 numCloses=11974 [junit4] 2> 443411 INFO (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 443412 INFO (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 443412 INFO (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 443413 INFO (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSFailoverTest_D9B8AD0C1B4AE93E-001/tempDir-001 [junit4] 2> 443413 INFO (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 443413 INFO (Thread-806) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 443413 INFO (Thread-806) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 443415 ERROR (Thread-806) [ ] 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> 443513 INFO (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:39693 [junit4] 2> 443516 INFO (jetty-launcher-644-thread-1) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 443518 INFO (jetty-launcher-644-thread-2) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 443528 INFO (jetty-launcher-644-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@514c42ec{/solr,null,AVAILABLE} [junit4] 2> 443528 INFO (jetty-launcher-644-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@71077c46{/solr,null,AVAILABLE} [junit4] 2> 443530 INFO (jetty-launcher-644-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@179c287c{SSL,[ssl, http/1.1]}{127.0.0.1:32813} [junit4] 2> 443530 INFO (jetty-launcher-644-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1d7cef29{SSL,[ssl, http/1.1]}{127.0.0.1:39373} [junit4] 2> 443530 INFO (jetty-launcher-644-thread-2) [ ] o.e.j.s.Server Started @446391ms [junit4] 2> 443530 INFO (jetty-launcher-644-thread-1) [ ] o.e.j.s.Server Started @446391ms [junit4] 2> 443530 INFO (jetty-launcher-644-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=39373} [junit4] 2> 443530 INFO (jetty-launcher-644-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=32813} [junit4] 2> 443531 ERROR (jetty-launcher-644-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 443531 ERROR (jetty-launcher-644-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 443531 INFO (jetty-launcher-644-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 443531 INFO (jetty-launcher-644-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 443531 INFO (jetty-launcher-644-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 443531 INFO (jetty-launcher-644-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 443531 INFO (jetty-launcher-644-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 443531 INFO (jetty-launcher-644-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 443531 INFO (jetty-launcher-644-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-16T14:02:18.022176Z [junit4] 2> 443531 INFO (jetty-launcher-644-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-16T14:02:18.022186Z [junit4] 2> 443541 INFO (jetty-launcher-644-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 443547 INFO (jetty-launcher-644-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 443553 INFO (jetty-launcher-644-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39693/solr [junit4] 2> 443554 INFO (jetty-launcher-644-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39693/solr [junit4] 2> 443580 INFO (jetty-launcher-644-thread-1) [n:127.0.0.1:39373_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 443580 INFO (jetty-launcher-644-thread-1) [n:127.0.0.1:39373_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:39373_solr [junit4] 2> 443580 INFO (jetty-launcher-644-thread-1) [n:127.0.0.1:39373_solr ] o.a.s.c.Overseer Overseer (id=99014471706542085-127.0.0.1:39373_solr-n_0000000000) starting [junit4] 2> 443599 INFO (jetty-launcher-644-thread-1) [n:127.0.0.1:39373_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39373_solr [junit4] 2> 443600 INFO (zkCallback-655-thread-1-processing-n:127.0.0.1:39373_solr) [n:127.0.0.1:39373_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 443610 INFO (jetty-launcher-644-thread-2) [n:127.0.0.1:32813_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 443610 INFO (jetty-launcher-644-thread-2) [n:127.0.0.1:32813_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 443611 INFO (jetty-launcher-644-thread-2) [n:127.0.0.1:32813_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:32813_solr [junit4] 2> 443612 INFO (zkCallback-655-thread-1-processing-n:127.0.0.1:39373_solr) [n:127.0.0.1:39373_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 443613 INFO (zkCallback-656-thread-1-processing-n:127.0.0.1:32813_solr) [n:127.0.0.1:32813_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 443652 INFO (jetty-launcher-644-thread-1) [n:127.0.0.1:39373_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39373.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3cd1cdf9 [junit4] 2> 443660 INFO (jetty-launcher-644-thread-1) [n:127.0.0.1:39373_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39373.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3cd1cdf9 [junit4] 2> 443660 INFO (jetty-launcher-644-thread-1) [n:127.0.0.1:39373_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39373.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3cd1cdf9 [junit4] 2> 443661 INFO (jetty-launcher-644-thread-1) [n:127.0.0.1:39373_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSFailoverTest_D9B8AD0C1B4AE93E-001/tempDir-001/node1/. [junit4] 2> 443671 INFO (jetty-launcher-644-thread-2) [n:127.0.0.1:32813_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_32813.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3cd1cdf9 [junit4] 2> 443679 INFO (jetty-launcher-644-thread-2) [n:127.0.0.1:32813_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_32813.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3cd1cdf9 [junit4] 2> 443679 INFO (jetty-launcher-644-thread-2) [n:127.0.0.1:32813_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_32813.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3cd1cdf9 [junit4] 2> 443680 INFO (jetty-launcher-644-thread-2) [n:127.0.0.1:32813_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSFailoverTest_D9B8AD0C1B4AE93E-001/tempDir-001/node2/. [junit4] 2> 443719 INFO (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 443719 INFO (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:39693/solr ready [junit4] 1> Formatting using clusterid: testClusterID [junit4] 2> 443765 WARN (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties [junit4] 2> 443773 WARN (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 443774 INFO (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.m.log jetty-6.1.x [junit4] 2> 443786 INFO (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.m.log Extract jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/hdfs to ./temp/Jetty_localhost_localdomain_35995_hdfs____.tc59df/webapp [junit4] 2> 443866 INFO (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost.localdomain:35995 [junit4] 2> 443940 WARN (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 443941 INFO (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.m.log jetty-6.1.x [junit4] 2> 443944 INFO (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.m.log Extract jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/datanode to ./temp/Jetty_localhost_38331_datanode____.vxde4t/webapp [junit4] 2> 444011 INFO (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:38331 [junit4] 2> 444060 WARN (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 444061 INFO (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.m.log jetty-6.1.x [junit4] 2> 444065 INFO (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.m.log Extract jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/datanode to ./temp/Jetty_localhost_38951_datanode____twv7cn/webapp [junit4] 2> 444143 INFO (SUITE-MoveReplicaHDFSFailoverTest-seed#[D9B8AD0C1B4AE93E]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:38951 [junit4] 2> 444146 ERROR (DataNode: [[[DISK]file:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSFailoverTest_D9B8AD0C1B4AE93E-001/tempDir-002/hdfsBaseDir/data/data1/, [DISK]file:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSFailoverTest_D9B8AD0C1B4AE93E-001/tempDir-002/hdfsBaseDir/data/data2/]] heartbeating to localhost.localdomain/127.0.0.1:46187) [ ] o.a.h.h.s.d.DirectoryScanner dfs.datanode.directoryscan.throttle.limit.ms.per.sec set to value below 1 ms/sec. Assuming default value of 1000 [junit4] 2> 444171 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0x59087919311fa: from storage DS-cf4482d1-06f5-4041-930f-a0625921092f node DatanodeRegistration(127.0.0.1:42817, datanodeUuid=83cc3ce3-f0fa-425c-a3ac-0ed8bf810441, infoPort=40281, infoSecurePort=0, ipcPort=37139, storageInfo=lv=-56;cid=testClusterID;nsid=816151035;c=0), blocks: 0, hasStaleStorage: true, processing time: 1 msecs [junit4] 2> 444172 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0x59087919311fa: from storage DS-03987ad0-166b-40ea-8c52-fa38e3e26131 node DatanodeRegistration(127.0.0.1:42817, datanodeUuid=83cc3ce3-f0fa-425c-a3ac-0ed8bf810441, infoPort=40281, infoSecurePort=0, ipcPort=37139, storageInfo=lv=-56;cid=testClusterID;nsid=816151035;c=0), blocks: 0, hasStaleStorage: false, processing time: 0 msecs [junit4] 2> 444273 ERROR (DataNode: [[[DISK]file:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSFailoverTest_D9B8AD0C1B4AE93E-001/tempDir-002/hdfsBaseDir/data/data3/, [DISK]file:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSFailoverTest_D9B8AD0C1B4AE93E-001/tempDir-002/hdfsBaseDir/data/data4/]] heartbeating to localhost.localdomain/127.0.0.1:46187) [ ] o.a.h.h.s.d.DirectoryScanner dfs.datanode.directoryscan.throttle.limit.ms.per.sec set to value below 1 ms/sec. Assuming default value of 1000 [junit4] 2> 444281 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0x5908798c3c417: from storage DS-50aaeec6-6e0c-4061-9bf8-c08dbca52dae node DatanodeRegistration(127.0.0.1:36201, datanodeUuid=72516d3a-dfd5-4eb0-8fb7-d738fdcd09ff, infoPort=36557, infoSecurePort=0, ipcPort=38349, storageInfo=lv=-56;cid=testClusterID;nsid=816151035;c=0), blocks: 0, hasStaleStorage: true, processing time: 0 msecs [junit4] 2> 444281 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0x5908798c3c417: from storage DS-cd6a2a5f-056b-40c5-8310-2042e8668a7f node DatanodeRegistration(127.0.0.1:36201, datanodeUuid=72516d3a-dfd5-4eb0-8fb7-d738fdcd09ff, infoPort=36557, infoSecurePort=0, ipcPort=38349, storageInfo=lv=-56;cid=testClusterID;nsid=816151035;c=0), blocks: 0, hasStaleStorage: false, processing time: 0 msecs [junit4] 2> 444396 INFO (TEST-MoveReplicaHDFSFailoverTest.testOldReplicaIsDeletedInRaceCondition-seed#[D9B8AD0C1B4AE93E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testOldReplicaIsDeletedInRaceCondition [junit4] 2> 444405 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&collection.configName=conf1&name=movereplicatest_coll4&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:39373_solr&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 444406 INFO (OverseerThreadFactory-1395-thread-1-processing-n:127.0.0.1:39373_solr) [n:127.0.0.1:39373_solr ] o.a.s.c.CreateCollectionCmd Create collection movereplicatest_coll4 [junit4] 2> 444510 INFO (OverseerStateUpdate-99014471706542085-127.0.0.1:39373_solr-n_0000000000) [n:127.0.0.1:39373_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"movereplicatest_coll4", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"movereplicatest_coll4_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:39373/solr";, [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 444714 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf1&newCollection=true&name=movereplicatest_coll4_shard1_replica_n1&action=CREATE&numShards=1&collection=movereplicatest_coll4&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 444714 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 444816 INFO (zkCallback-655-thread-1-processing-n:127.0.0.1:39373_solr) [n:127.0.0.1:39373_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/movereplicatest_coll4/state.json] for collection [movereplicatest_coll4] has occurred - updating... (live nodes size: [2]) [junit4] 2> 444816 INFO (zkCallback-655-thread-2-processing-n:127.0.0.1:39373_solr) [n:127.0.0.1:39373_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/movereplicatest_coll4/state.json] for collection [movereplicatest_coll4] has occurred - updating... (live nodes size: [2]) [junit4] 2> 445720 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 445724 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.s.IndexSchema [movereplicatest_coll4_shard1_replica_n1] Schema name=minimal [junit4] 2> 445725 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 445725 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'movereplicatest_coll4_shard1_replica_n1' using configuration from collection movereplicatest_coll4, trusted=true [junit4] 2> 445726 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39373.solr.core.movereplicatest_coll4.shard1.replica_n1' (registry 'solr.core.movereplicatest_coll4.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3cd1cdf9 [junit4] 2> 445733 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost.localdomain:46187/data [junit4] 2> 445733 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled [junit4] 2> 445734 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 445734 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.SolrCore [[movereplicatest_coll4_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSFailoverTest_D9B8AD0C1B4AE93E-001/tempDir-001/node1/movereplicatest_coll4_shard1_replica_n1], dataDir=[hdfs://localhost.localdomain:46187/data/movereplicatest_coll4/core_node2/data/] [junit4] 2> 445735 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:46187/data/movereplicatest_coll4/core_node2/data/snapshot_metadata [junit4] 2> 445751 WARN (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.s.h.HdfsDirectory The NameNode is in SafeMode - Solr will wait 5 seconds and try again. [junit4] 2> 450763 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:46187/data/movereplicatest_coll4/core_node2/data [junit4] 2> 450781 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:46187/data/movereplicatest_coll4/core_node2/data/index [junit4] 2> 450846 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:36201 is added to blk_1073741825_1001{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-03987ad0-166b-40ea-8c52-fa38e3e26131:NORMAL:127.0.0.1:42817|RBW], ReplicaUC[[DISK]DS-50aaeec6-6e0c-4061-9bf8-c08dbca52dae:NORMAL:127.0.0.1:36201|FINALIZED]]} size 0 [junit4] 2> 450847 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:42817 is added to blk_1073741825_1001 size 69 [junit4] 2> 450920 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.HdfsUpdateLog [junit4] 2> 450920 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 450920 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=3 [junit4] 2> 450933 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 450934 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 450986 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@32991dc7[movereplicatest_coll4_shard1_replica_n1] main] [junit4] 2> 450986 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 450987 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 450989 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 450990 INFO (searcherExecutor-1400-thread-1-processing-n:127.0.0.1:39373_solr x:movereplicatest_coll4_shard1_replica_n1 s:shard1 c:movereplicatest_coll4 r:core_node2) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.SolrCore [movereplicatest_coll4_shard1_replica_n1] Registered new searcher Searcher@32991dc7[movereplicatest_coll4_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 450991 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1584231555249733632 [junit4] 2> 450995 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 450995 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 450995 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:39373/solr/movereplicatest_coll4_shard1_replica_n1/ [junit4] 2> 450995 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 450995 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.SyncStrategy https://127.0.0.1:39373/solr/movereplicatest_coll4_shard1_replica_n1/ has no replicas [junit4] 2> 450995 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 450996 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:39373/solr/movereplicatest_coll4_shard1_replica_n1/ shard1 [junit4] 2> 450997 INFO (zkCallback-655-thread-3-processing-n:127.0.0.1:39373_solr) [n:127.0.0.1:39373_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/movereplicatest_coll4/state.json] for collection [movereplicatest_coll4] has occurred - updating... (live nodes size: [2]) [junit4] 2> 450997 INFO (zkCallback-655-thread-2-processing-n:127.0.0.1:39373_solr) [n:127.0.0.1:39373_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/movereplicatest_coll4/state.json] for collection [movereplicatest_coll4] has occurred - updating... (live nodes size: [2]) [junit4] 2> 451047 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 451056 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf1&newCollection=true&name=movereplicatest_coll4_shard1_replica_n1&action=CREATE&numShards=1&collection=movereplicatest_coll4&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=6341 [junit4] 2> 451057 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 30 seconds. Check all shard replicas [junit4] 2> 451148 INFO (zkCallback-655-thread-3-processing-n:127.0.0.1:39373_solr) [n:127.0.0.1:39373_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/movereplicatest_coll4/state.json] for collection [movereplicatest_coll4] has occurred - updating... (live nodes size: [2]) [junit4] 2> 451148 INFO (zkCallback-655-thread-2-processing-n:127.0.0.1:39373_solr) [n:127.0.0.1:39373_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/movereplicatest_coll4/state.json] for collection [movereplicatest_coll4] has occurred - updating... (live nodes size: [2]) [junit4] 2> 452058 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=1&collection.configName=conf1&name=movereplicatest_coll4&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:39373_solr&wt=javabin&version=2} status=0 QTime=7652 [junit4] 2> 452076 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1 (1584231556369612800)]} 0 17 [junit4] 2> 452078 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[2 (1584231556388487168)]} 0 1 [junit4] 2> 452080 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[3 (1584231556390584320)]} 0 0 [junit4] 2> 452081 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[4 (1584231556391632896)]} 0 0 [junit4] 2> 452082 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[5 (1584231556392681472)]} 0 0 [junit4] 2> 452083 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[6 (1584231556393730048)]} 0 1 [junit4] 2> 452085 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[7 (1584231556395827200)]} 0 0 [junit4] 2> 452086 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[8 (1584231556396875776)]} 0 0 [junit4] 2> 452087 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[9 (1584231556398972928)]} 0 0 [junit4] 2> 452089 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[10 (1584231556400021504)]} 0 0 [junit4] 2> 452090 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[11 (1584231556401070080)]} 0 0 [junit4] 2> 452091 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[12 (1584231556402118656)]} 0 0 [junit4] 2> 452092 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[13 (1584231556403167232)]} 0 1 [junit4] 2> 452094 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[14 (1584231556405264384)]} 0 1 [junit4] 2> 452096 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[15 (1584231556406312960)]} 0 1 [junit4] 2> 452097 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[16 (1584231556408410112)]} 0 0 [junit4] 2> 452099 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[17 (1584231556410507264)]} 0 1 [junit4] 2> 452100 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[18 (1584231556411555840)]} 0 1 [junit4] 2> 452115 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[19 (1584231556413652992)]} 0 14 [junit4] 2> 452117 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[20 (1584231556429381632)]} 0 1 [junit4] 2> 452119 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[21 (1584231556431478784)]} 0 0 [junit4] 2> 452120 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[22 (1584231556432527360)]} 0 1 [junit4] 2> 452122 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[23 (1584231556434624512)]} 0 0 [junit4] 2> 452123 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[24 (1584231556435673088)]} 0 0 [junit4] 2> 452125 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[25 (1584231556436721664)]} 0 1 [junit4] 2> 452126 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[26 (1584231556438818816)]} 0 1 [junit4] 2> 452128 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[27 (1584231556440915968)]} 0 0 [junit4] 2> 452129 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[28 (1584231556441964544)]} 0 0 [junit4] 2> 452130 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[29 (1584231556443013120)]} 0 0 [junit4] 2> 452131 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[30 (1584231556444061696)]} 0 0 [junit4] 2> 452132 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[31 (1584231556445110272)]} 0 0 [junit4] 2> 452133 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[32 (1584231556446158848)]} 0 0 [junit4] 2> 452134 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[33 (1584231556447207424)]} 0 0 [junit4] 2> 452136 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[34 (1584231556448256000)]} 0 1 [junit4] 2> 452137 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[35 (1584231556450353152)]} 0 0 [junit4] 2> 452138 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[36 (1584231556451401728)]} 0 0 [junit4] 2> 452138 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[37 (1584231556452450304)]} 0 0 [junit4] 2> 452139 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[38 (1584231556453498880)]} 0 0 [junit4] 2> 452140 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[39 (1584231556454547456)]} 0 0 [junit4] 2> 452141 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[40 (1584231556455596032)]} 0 0 [junit4] 2> 452142 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[41 (1584231556455596033)]} 0 0 [junit4] 2> 452143 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[42 (1584231556456644608)]} 0 0 [junit4] 2> 452143 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[43 (1584231556457693184)]} 0 0 [junit4] 2> 452144 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[44 (1584231556458741760)]} 0 0 [junit4] 2> 452145 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[45 (1584231556459790336)]} 0 0 [junit4] 2> 452146 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[46 (1584231556460838912)]} 0 0 [junit4] 2> 452147 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[47 (1584231556461887488)]} 0 0 [junit4] 2> 452148 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[48 (1584231556461887489)]} 0 0 [junit4] 2> 452149 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[49 (1584231556462936064)]} 0 0 [junit4] 2> 452150 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[50 (1584231556463984640)]} 0 0 [junit4] 2> 452151 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[51 (1584231556465033216)]} 0 0 [junit4] 2> 452152 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[52 (1584231556466081792)]} 0 0 [junit4] 2> 452152 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[53 (1584231556467130368)]} 0 0 [junit4] 2> 452153 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[54 (1584231556468178944)]} 0 0 [junit4] 2> 452154 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[55 (1584231556469227520)]} 0 0 [junit4] 2> 452155 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[56 (1584231556470276096)]} 0 0 [junit4] 2> 452158 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[57 (1584231556471324672)]} 0 1 [junit4] 2> 452161 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[58 (1584231556474470400)]} 0 1 [junit4] 2> 452162 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[59 (1584231556476567552)]} 0 0 [junit4] 2> 452163 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[60 (1584231556477616128)]} 0 0 [junit4] 2> 452165 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[61 (1584231556479713280)]} 0 0 [junit4] 2> 452166 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[62 (1584231556480761856)]} 0 0 [junit4] 2> 452167 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[63 (1584231556481810432)]} 0 0 [junit4] 2> 452168 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[64 (1584231556482859008)]} 0 0 [junit4] 2> 452169 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[65 (1584231556483907584)]} 0 0 [junit4] 2> 452178 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[66 (1584231556484956160)]} 0 9 [junit4] 2> 452180 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[67 (1584231556495441920)]} 0 0 [junit4] 2> 452181 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[68 (1584231556496490496)]} 0 0 [junit4] 2> 452182 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[69 (1584231556497539072)]} 0 0 [junit4] 2> 452183 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[70 (1584231556498587648)]} 0 0 [junit4] 2> 452184 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[71 (1584231556499636224)]} 0 0 [junit4] 2> 452184 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[72 (1584231556500684800)]} 0 0 [junit4] 2> 452185 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[73 (1584231556501733376)]} 0 0 [junit4] 2> 452186 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[74 (1584231556502781952)]} 0 0 [junit4] 2> 452187 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[75 (1584231556503830528)]} 0 0 [junit4] 2> 452188 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[76 (1584231556504879104)]} 0 0 [junit4] 2> 452190 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[77 (1584231556505927680)]} 0 0 [junit4] 2> 452191 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[78 (1584231556506976256)]} 0 0 [junit4] 2> 452192 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[79 (1584231556508024832)]} 0 0 [junit4] 2> 452193 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[80 (1584231556509073408)]} 0 0 [junit4] 2> 452194 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[81 (1584231556510121984)]} 0 0 [junit4] 2> 452195 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[82 (1584231556511170560)]} 0 0 [junit4] 2> 452195 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[83 (1584231556512219136)]} 0 0 [junit4] 2> 452196 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[84 (1584231556513267712)]} 0 0 [junit4] 2> 452197 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[85 (1584231556513267713)]} 0 0 [junit4] 2> 452198 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[86 (1584231556514316288)]} 0 0 [junit4] 2> 452198 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[87 (1584231556515364864)]} 0 0 [junit4] 2> 452199 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[88 (1584231556516413440)]} 0 0 [junit4] 2> 452202 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[89 (1584231556517462016)]} 0 2 [junit4] 2> 452204 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[90 (1584231556521656320)]} 0 0 [junit4] 2> 452205 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[91 (1584231556522704896)]} 0 0 [junit4] 2> 452206 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[92 (1584231556523753472)]} 0 0 [junit4] 2> 452207 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[93 (1584231556524802048)]} 0 0 [junit4] 2> 452208 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[94 (1584231556524802049)]} 0 0 [junit4] 2> 452209 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[95 (1584231556525850624)]} 0 0 [junit4] 2> 452209 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[96 (1584231556526899200)]} 0 0 [junit4] 2> 452210 INFO (qtp2039642160-3602) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[97 (1584231556527947776)]} 0 0 [junit4] 2> 452211 INFO (qtp2039642160-3606) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[98 (1584231556528996352)]} 0 0 [junit4] 2> 452212 INFO (qtp2039642160-3595) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[99 (1584231556530044928)]} 0 0 [junit4] 2> 452213 INFO (qtp2039642160-3594) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [movereplicatest_coll4_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[100 (1584231556530044929)]} 0 0 [junit4] 2> 452214 INFO (TEST-MoveReplicaHDFSFailoverTest.testOldReplicaIsDeletedInRaceCondition-seed#[D9B8AD0C1B4AE93E]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1d7cef29{SSL,[ssl, http/1.1]}{127.0.0.1:0} [junit4] 2> 452214 INFO (TEST-MoveReplicaHDFSFailoverTest.testOldReplicaIsDeletedInRaceCondition-seed#[D9B8AD0C1B4AE93E]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1592807321 [junit4] 2> 452214 INFO (TEST-MoveReplicaHDFSFailoverTest.testOldReplicaIsDeletedInRaceCondition-seed#[D9B8AD0C1B4AE93E]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 452214 INFO (TEST-MoveReplicaHDFSFailoverTest.testOldReplicaIsDeletedInRaceCondition-seed#[D9B8AD0C1B4AE93E]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6e1fa060: rootName = solr_39373, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@3da6ff93 [junit4] 2> 452219 INFO (TEST-MoveReplicaHDFSFailoverTest.testOldReplicaIsDeletedInRaceCondition-seed#[D9B8AD0C1B4AE93E]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 452219 INFO (TEST-MoveReplicaHDFSFailoverTest.testOldReplicaIsDeletedInRaceCondition-seed#[D9B8AD0C1B4AE93E]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3c17c053: rootName = solr_39373, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@543508d0 [junit4] 2> 452222 INFO (TEST-MoveReplicaHDFSFailoverTest.testOldReplicaIsDeletedInRaceCondition-seed#[D9B8AD0C1B4AE93E]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 452222 INFO (TEST-MoveReplicaHDFSFailoverTest.testOldReplicaIsDeletedInRaceCondition-seed#[D9B8AD0C1B4AE93E]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@238b76c: rootName = solr_39373, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@6ba5aef4 [junit4] 2> 452223 INFO (TEST-MoveReplicaHDFSFailoverTest.testOldReplicaIsDeletedInRaceCondition-seed#[D9B8AD0C1B4AE93E]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:39373_solr [junit4] 2> 452223 INFO (zkCallback-655-thread-2-processing-n:127.0.0.1:39373_solr) [n:127.0.0.1:39373_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1) [junit4] 2> 452223 INFO (zkCallback-656-thread-1-processing-n:127.0.0.1:32813_solr) [n:127.0.0.1:32813_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1) [junit4] 2> 452223 INFO (zkCallback-663-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1) [junit4] 2> 452223 INFO (TEST-MoveReplicaHDFSFailoverTest.testOldReplicaIsDeletedInRaceCondition-seed#[D9B8AD0C1B4AE93E]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 452225 INFO (coreCloseExecutor-1405-thread-1) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.c.SolrCore [movereplicatest_coll4_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@7e25465f [junit4] 2> 452225 INFO (coreCloseExecutor-1405-thread-1) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.movereplicatest_coll4.shard1.replica_n1, tag=2116372063 [junit4] 2> 452225 INFO (coreCloseExecutor-1405-thread-1) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@239cfb96: rootName = solr_39373, domain = solr.core.movereplicatest_coll4.shard1.replica_n1, service url = null, agent id = null] for registry solr.core.movereplicatest_coll4.shard1.replica_n1 / com.codahale.metrics.MetricRegistry@7467da4f [junit4] 2> 452234 INFO (coreCloseExecutor-1405-thread-1) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.movereplicatest_coll4.shard1.leader, tag=2116372063 [junit4] 2> 452234 INFO (coreCloseExecutor-1405-thread-1) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close. [junit4] 2> 452234 INFO (coreCloseExecutor-1405-thread-1) [n:127.0.0.1:39373_solr c:movereplicatest_coll4 s:shard1 r:core_node2 x:movereplicatest_coll4_shard1_replica_n1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@7e9fb13f commitCommandVersion:0 [junit4] 2> 452267 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:36201 is added to blk_1073741827_1003{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-03987ad0-166b-40ea-8c52-fa38e3e26131:NORMAL:127.0.0.1:42817|RBW], ReplicaUC[[DISK]DS-50aaeec6-6e0c-4061-9bf8-c08dbca52dae:NORMAL:127.0.0.1:36201|FINALIZED]]} size 0 [junit4] 2> 452268 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:42817 is added to blk_1073741827_1003 size 185 [junit4] 2> 452287 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:42817 is added to blk_1073741828_1004{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-50aaeec6-6e0c-4061-9bf8-c08dbca52dae:NORMAL:127.0.0.1:36201|RBW], ReplicaUC[[DISK]DS-03987ad0-166b-40ea-8c52-fa38e3e26131:NORMAL:127.0.0.1:42817|RBW]]} size 0 [junit4] 2> 452288 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:36201 is added to blk_1073741828_1004 size 167 [junit4] 2> 452310 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:42817 is added to blk_1073741829_1005{UCState=COMMITTED, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-50aaeec6-6e0c-4061-9bf8-c08dbca52dae:NORMAL:127.0.0.1:36201|RBW], ReplicaUC[[DISK]DS-cf4482d1-06f5-4041-930f-a0625921092f:NORMAL:127.0.0.1:42817|RBW]]} size 70 [junit4] 2> 452311 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:36201 is added to blk_1073741829_1005 size 70 [junit4] 2> 452323 INFO (zkCallback-655-thread-2-processing-n:127.0.0.1:39373_solr) [n:127.0.0.1:39373_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/movereplicatest_coll4/state.json] for collection [movereplicatest_coll4] has occurred - updating... (live nodes size: [1]) [junit4] 2> 452323 INFO (zkCallback-655-thread-3-processing-n:127.0.0.1:39373_solr) [n:127.0.0.1:39373_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/movereplicatest_coll4/state.json] for collection [movereplicatest_coll4] has occurred - updating... (live nodes size: [1]) [junit4] 2> 452408 INFO (OverseerCollectionConfigSetProcessor-99014471706542085-127.0.0.1:39373_solr-n_0000000000) [n:127.0.0.1:39373_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> 452769 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:42817 is added to blk_1073741830_1006{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-50aaeec6-6e0c-4061-9bf8-c08dbca52dae:NORMAL:127.0.0.1:36201|RBW], ReplicaUC[[DISK]DS-03987ad0-166b-40ea-8c52-fa38e3e26131:NORMAL:127.0.0.1:42817|RBW]]} size 0 [junit4] 2> 452769 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:36201 is added to blk_1073741830_1006{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-03987ad0-166b-40ea-8c52-fa38e3e26131:NORMAL:127.0.0.1:42817|RBW], ReplicaUC[[DISK]DS-cd6a2a5f-056b-40c5-8310-2042e8668a7f:NORMAL:127.0.0.1:36201|FINALIZED]]} size 0 [junit4] 2> 452779 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:36201 is added to blk_1073741831_1007{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-03987ad0-166b-40ea-8c52-fa38e3e26131:NORMAL:127.0.0.1:42817|RBW], ReplicaUC[[DISK]DS-50aaeec6-6e0c-4061-9bf8-c08dbca52dae:NORMAL:127.0.0.1:36201|FINALIZED]]} size 0 [junit4] 2> 452780 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:42817 is added to blk_1073741831_1007{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-50aaeec6-6e0c-4061-9bf8-c08dbca52dae:NORMAL:127.0.0.1:36201|FINALIZED], ReplicaUC[[DISK]DS-cf4482d1-06f5-4041-930f-a0625921092f:NORMAL:127.0.0.1:42817|FINALIZED]]} size 0 [junit4] 2> 452792 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:42817 is added to blk_1073741832_1008{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-50aaeec6-6e0c-4061-9bf8-c08dbca52dae:NORMAL:127.0.0.1:36201|RBW], ReplicaUC[[DISK]DS-03987ad0-166b-40ea-8c52-fa38e3e26131:NORMAL:127.0.0.1:42817|FINALIZED]]} size 0 [junit4] 2> 452793 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:36201 is added to blk_1073741832_1008{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-03987ad0-166b-40ea-8c52-fa38e3e26131:NORMAL:127.0.0.1:42817|FINALIZED], ReplicaUC[[DISK]DS-cd6a2a5f-056b-40c5-8310-2042e8668a7f:NORMAL:127.0.0.1:36201|FINALIZED]]} size 0 [junit4] 2> 452804 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:36201 is added to blk_1073741833_1009{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-cf4482d1-06f5-4041-930f-a0625921092f:NORMAL:127.0.0.1:42817|RBW], ReplicaUC[[DISK]DS-50aaeec6-6e0c-4061-9bf8-c08dbca52dae:NORMAL:127.0.0.1:36201|FINALIZED]]} size 0 [junit4] 2> 452804 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:42817 is added to blk_1073741833_1009{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-cf4482d1-06f5-4041-930f-a0625921092f:NORMAL:127.0.0.1:42817|RBW], ReplicaUC[[DISK]DS-50aaeec6-6e0c-4061-9bf8-c08dbca52dae:NORMAL:127.0.0.1:36201|FINALIZED]]} size 0 [junit4] 2> 452812 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:36201 is added to blk_1073741834_1010{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-cf4482d1-06f5-4041-930f-a0625921092f:NORMAL:127.0.0.1:42817|RBW], ReplicaUC[[DISK]DS-cd6a2a5f-056b-40c5-8310-2042e8668a7f:NORMAL:127.0.0.1:36201|FINALIZED]]} size 0 [junit4] 2> 452812 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:42817 is added to blk_1073741834_1010{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-cd6a2a5f-056b-40c5-8310-2042e8668a7f:NORMAL:127.0.0.1:36201|FINALIZED], ReplicaUC[[DISK]DS-03987ad0-166b-40ea-8c52-fa38e3e26131:NORMAL:127.0.0.1:42817|FINALIZED]]} size 0 [junit4] 2> 452822 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:36201 is added to blk_1073741835_1011{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-cf4482d1-06f5-4041-930f-a0625921092f:NORMAL:127.0.0.1:42817|RBW], ReplicaUC[[DISK]DS-50aaeec6-6e0c-4061-9bf8-c08dbca52dae:NORMAL:127.0.0.1:36201|RBW]]} size 0 [junit4] 2> 452822 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:42817 is added to blk_1073741835_1011{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-cf4482d1-06f5-4041-930f-a0625921092f:NORMAL:127.0.0.1:42817|RBW], ReplicaUC[[DISK]DS-50aaeec6-6e0c-4061-9bf8-c08dbca52dae:NORMAL:127.0.0.1:36201|RBW]]} size 0 [junit4] 2> 452835 INFO (Block report processor) [ ] BlockStateChange BL [...truncated too long message...] solr.cloud.ZkController.register(ZkController.java:1014) [junit4] 2> at org.apache.solr.core.ZkContainer.lambda$registerInZk$0(ZkContainer.java:181) [junit4] 2> at org.apache.solr.core.ZkContainer.registerInZk(ZkContainer.java:208) [junit4] 2> at org.apache.solr.core.CoreContainer.registerCore(CoreContainer.java:890) [junit4] 2> at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1051) [junit4] 2> at org.apache.solr.core.CoreContainer.create(CoreContainer.java:952) [junit4] 2> at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:91) [junit4] 2> at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:384) [junit4] 2> at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:389) [junit4] 2> at org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174) [junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:737) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:718) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:499) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759) [junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582) [junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224) [junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512) [junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) [junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) [junit4] 2> at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426) [junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) [junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:534) [junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320) [junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251) [junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283) [junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108) [junit4] 2> at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:251) [junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283) [junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108) [junit4] 2> at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136) [junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671) [junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589) [junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> Caused by: org.apache.solr.common.SolrException: No registered leader was found after waiting for 1220000ms , collection: collection1 slice: shard1 saw state=null with live_nodes=[] [junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.getLeaderRetry(ZkStateReader.java:816) [junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.getLeaderUrl(ZkStateReader.java:781) [junit4] 2> at org.apache.solr.cloud.ZkController.getLeader(ZkController.java:1178) [junit4] 2> ... 44 more [junit4] 2> [junit4] 2> 347388 INFO (qtp888918803-4546) [n:127.0.0.1:35291_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=collection1_shard1_replica_n1&action=CREATE&numShards=2&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=209785 [junit4] 2> 347388 ERROR (SUITE-GraphExpressionTest-seed#[CE8CD1B9BDD268E1]-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> 347389 INFO (SUITE-GraphExpressionTest-seed#[CE8CD1B9BDD268E1]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:40197 40197 [junit4] 2> 352425 INFO (Thread-136) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:40197 40197 [junit4] 2> 352426 WARN (Thread-136) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 3 /solr/aliases.json [junit4] 2> 2 /solr/security.json [junit4] 2> 2 /solr/configs/conf [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 6 /solr/collections/collection1/state.json [junit4] 2> 3 /solr/clusterstate.json [junit4] 2> 3 /solr/clusterprops.json [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 3 /solr/live_nodes [junit4] 2> 3 /solr/collections [junit4] 2> [junit4] 2> 352426 INFO (SUITE-GraphExpressionTest-seed#[CE8CD1B9BDD268E1]-worker) [ ] o.a.s.SolrTestCaseJ4 ------------------------------------------------------- Done waiting for tracked resources to be released [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=115, maxMBSortInHeap=7.8893646060328955, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@41248ac5), locale=zh-Hant-TW, timezone=Pacific/Galapagos [junit4] 2> NOTE: Linux 4.10.0-37-generic amd64/Oracle Corporation 9.0.1 (64-bit)/cpus=8,threads=1,free=184425832,total=536870912 [junit4] 2> NOTE: All tests run in this JVM: [CloudSolrClientCacheTest, TestZkConfigManager, JdbcTest, RawValueEvaluatorTest, LessThanEvaluatorTest, CubedRootEvaluatorTest, HttpSolrClientConPoolTest, AndEvaluatorTest, StreamExpressionTest, ReverseEvaluatorTest, TestXMLEscaping, AscEvaluatorTest, TestSpellCheckResponse, SolrExampleStreamingTest, UsingSolrJRefGuideExamplesTest, HyperbolicTangentEvaluatorTest, GraphExpressionTest] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=GraphExpressionTest -Dtests.seed=CE8CD1B9BDD268E1 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=zh-Hant-TW -Dtests.timezone=Pacific/Galapagos -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] ERROR 0.00s J0 | GraphExpressionTest (suite) <<< [junit4] > Throwable #1: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:35291/solr: create the collection time out:180s [junit4] > at __randomizedtesting.SeedInfo.seed([CE8CD1B9BDD268E1]:0) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1104) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:883) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:816) [junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194) [junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211) [junit4] > at org.apache.solr.client.solrj.io.graph.GraphExpressionTest.setupCluster(GraphExpressionTest.java:87) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:564) [junit4] > at java.base/java.lang.Thread.run(Thread.java:844) [junit4] Completed [140/146 (1!)] on J0 in 215.49s, 0 tests, 1 error <<< FAILURES! [...truncated 39200 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org
