Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/1486/ Java: 64bit/jdk-10-ea+43 -XX:-UseCompressedOops -XX:+UseParallelGC
1 tests failed. FAILED: org.apache.solr.cloud.TestCloudConsistency.testOutOfSyncReplicasCannotBecomeLeader Error Message: Doc with id=4 not found in http://127.0.0.1:42381/solr/outOfSyncReplicasCannotBecomeLeader-false due to: Path not found: /id; rsp={doc=null} Stack Trace: java.lang.AssertionError: Doc with id=4 not found in http://127.0.0.1:42381/solr/outOfSyncReplicasCannotBecomeLeader-false due to: Path not found: /id; rsp={doc=null} at __randomizedtesting.SeedInfo.seed([9ABEE8FF6B3AC1A8:E455C8EFA85DCE92]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.cloud.TestCloudConsistency.assertDocExists(TestCloudConsistency.java:250) at org.apache.solr.cloud.TestCloudConsistency.assertDocsExistInAllReplicas(TestCloudConsistency.java:234) at org.apache.solr.cloud.TestCloudConsistency.testOutOfSyncReplicasCannotBecomeLeader(TestCloudConsistency.java:127) at org.apache.solr.cloud.TestCloudConsistency.testOutOfSyncReplicasCannotBecomeLeader(TestCloudConsistency.java:90) 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 13390 lines...] [junit4] Suite: org.apache.solr.cloud.TestCloudConsistency [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/init-core-data-001 [junit4] 2> 930427 WARN (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2 [junit4] 2> 930427 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 930428 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 930428 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 930428 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001 [junit4] 2> 930428 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 930428 INFO (Thread-2256) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 930428 INFO (Thread-2256) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 930432 ERROR (Thread-2256) [ ] 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> 930528 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:37701 [junit4] 2> 930530 INFO (zkConnectionManagerCallback-1670-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930532 INFO (jetty-launcher-1667-thread-1) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T06:27:37+09:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 930532 INFO (jetty-launcher-1667-thread-3) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T06:27:37+09:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 930532 INFO (jetty-launcher-1667-thread-4) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T06:27:37+09:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 930532 INFO (jetty-launcher-1667-thread-2) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T06:27:37+09:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 930533 INFO (jetty-launcher-1667-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 930533 INFO (jetty-launcher-1667-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 930533 INFO (jetty-launcher-1667-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 930533 INFO (jetty-launcher-1667-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 930533 INFO (jetty-launcher-1667-thread-2) [ ] o.e.j.s.session Scavenging every 600000ms [junit4] 2> 930533 INFO (jetty-launcher-1667-thread-4) [ ] o.e.j.s.session Scavenging every 600000ms [junit4] 2> 930533 INFO (jetty-launcher-1667-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7dff2ce4{/solr,null,AVAILABLE} [junit4] 2> 930533 INFO (jetty-launcher-1667-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1f5977a3{/solr,null,AVAILABLE} [junit4] 2> 930533 INFO (jetty-launcher-1667-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 930533 INFO (jetty-launcher-1667-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 930533 INFO (jetty-launcher-1667-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 930533 INFO (jetty-launcher-1667-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 930533 INFO (jetty-launcher-1667-thread-1) [ ] o.e.j.s.session Scavenging every 600000ms [junit4] 2> 930533 INFO (jetty-launcher-1667-thread-3) [ ] o.e.j.s.session Scavenging every 600000ms [junit4] 2> 930533 INFO (jetty-launcher-1667-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7ffc1e6f{/solr,null,AVAILABLE} [junit4] 2> 930533 INFO (jetty-launcher-1667-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@39ea1e6e{/solr,null,AVAILABLE} [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@649d4001{HTTP/1.1,[http/1.1]}{127.0.0.1:46617} [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@59d79b34{HTTP/1.1,[http/1.1]}{127.0.0.1:34097} [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-1) [ ] o.e.j.s.Server Started @932464ms [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-2) [ ] o.e.j.s.Server Started @932464ms [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1b6df8f8{HTTP/1.1,[http/1.1]}{127.0.0.1:46585} [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34097} [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-4) [ ] o.e.j.s.Server Started @932464ms [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6d98fe42{HTTP/1.1,[http/1.1]}{127.0.0.1:45029} [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=46585} [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-3) [ ] o.e.j.s.Server Started @932465ms [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=46617} [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=45029} [junit4] 2> 930535 ERROR (jetty-launcher-1667-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 930535 ERROR (jetty-launcher-1667-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0 [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0 [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 930535 ERROR (jetty-launcher-1667-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-08T07:29:44.761677Z [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0 [junit4] 2> 930535 ERROR (jetty-launcher-1667-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0 [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-08T07:29:44.761918Z [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 930535 INFO (jetty-launcher-1667-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-08T07:29:44.761979Z [junit4] 2> 930536 INFO (jetty-launcher-1667-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-08T07:29:44.762004Z [junit4] 2> 930536 INFO (zkConnectionManagerCallback-1672-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930537 INFO (zkConnectionManagerCallback-1674-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930537 INFO (zkConnectionManagerCallback-1678-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930537 INFO (zkConnectionManagerCallback-1676-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930537 INFO (jetty-launcher-1667-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 930537 INFO (jetty-launcher-1667-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 930537 INFO (jetty-launcher-1667-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 930537 INFO (jetty-launcher-1667-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 930552 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x10025a860860001, likely client has closed socket [junit4] 2> 930553 INFO (jetty-launcher-1667-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37701/solr [junit4] 2> 930553 INFO (jetty-launcher-1667-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37701/solr [junit4] 2> 930554 INFO (zkConnectionManagerCallback-1684-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930554 INFO (zkConnectionManagerCallback-1687-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930555 INFO (jetty-launcher-1667-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37701/solr [junit4] 2> 930555 INFO (jetty-launcher-1667-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37701/solr [junit4] 2> 930555 INFO (zkConnectionManagerCallback-1692-thread-1-processing-n:127.0.0.1:45029_solr) [n:127.0.0.1:45029_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930563 INFO (zkConnectionManagerCallback-1698-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930568 INFO (zkConnectionManagerCallback-1690-thread-1-processing-n:127.0.0.1:34097_solr) [n:127.0.0.1:34097_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930571 INFO (zkConnectionManagerCallback-1696-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930572 INFO (zkConnectionManagerCallback-1701-thread-1-processing-n:127.0.0.1:46585_solr) [n:127.0.0.1:46585_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930574 INFO (jetty-launcher-1667-thread-2) [n:127.0.0.1:34097_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 930575 INFO (jetty-launcher-1667-thread-2) [n:127.0.0.1:34097_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:34097_solr [junit4] 2> 930575 INFO (zkConnectionManagerCallback-1704-thread-1-processing-n:127.0.0.1:46617_solr) [n:127.0.0.1:46617_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930575 INFO (jetty-launcher-1667-thread-2) [n:127.0.0.1:34097_solr ] o.a.s.c.Overseer Overseer (id=72098999142055944-127.0.0.1:34097_solr-n_0000000000) starting [junit4] 2> 930582 INFO (jetty-launcher-1667-thread-1) [n:127.0.0.1:46617_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 930583 INFO (jetty-launcher-1667-thread-1) [n:127.0.0.1:46617_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46617_solr [junit4] 2> 930588 INFO (zkCallback-1703-thread-1-processing-n:127.0.0.1:46617_solr) [n:127.0.0.1:46617_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 930589 INFO (zkCallback-1689-thread-1-processing-n:127.0.0.1:34097_solr) [n:127.0.0.1:34097_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 930593 INFO (jetty-launcher-1667-thread-4) [n:127.0.0.1:46585_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 930594 INFO (jetty-launcher-1667-thread-4) [n:127.0.0.1:46585_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 930598 INFO (jetty-launcher-1667-thread-4) [n:127.0.0.1:46585_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46585_solr [junit4] 2> 930599 INFO (zkCallback-1703-thread-1-processing-n:127.0.0.1:46617_solr) [n:127.0.0.1:46617_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 930613 INFO (zkCallback-1689-thread-1-processing-n:127.0.0.1:34097_solr) [n:127.0.0.1:34097_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 930626 INFO (jetty-launcher-1667-thread-1) [n:127.0.0.1:46617_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46617.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 930628 INFO (jetty-launcher-1667-thread-2) [n:127.0.0.1:34097_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34097_solr [junit4] 2> 930635 INFO (jetty-launcher-1667-thread-1) [n:127.0.0.1:46617_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46617.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 930639 INFO (jetty-launcher-1667-thread-1) [n:127.0.0.1:46617_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46617.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 930640 INFO (zkCallback-1703-thread-1-processing-n:127.0.0.1:46617_solr) [n:127.0.0.1:46617_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 930641 INFO (jetty-launcher-1667-thread-1) [n:127.0.0.1:46617_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node1/. [junit4] 2> 930641 INFO (OverseerStateUpdate-72098999142055944-127.0.0.1:34097_solr-n_0000000000) [n:127.0.0.1:34097_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 930645 INFO (jetty-launcher-1667-thread-3) [n:127.0.0.1:45029_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 930646 INFO (jetty-launcher-1667-thread-3) [n:127.0.0.1:45029_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 930647 INFO (jetty-launcher-1667-thread-3) [n:127.0.0.1:45029_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:45029_solr [junit4] 2> 930648 INFO (zkCallback-1703-thread-1-processing-n:127.0.0.1:46617_solr) [n:127.0.0.1:46617_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 930665 INFO (zkCallback-1700-thread-1-processing-n:127.0.0.1:46585_solr) [n:127.0.0.1:46585_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (4) [junit4] 2> 930665 INFO (zkCallback-1691-thread-1-processing-n:127.0.0.1:45029_solr) [n:127.0.0.1:45029_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 930665 INFO (zkCallback-1689-thread-1-processing-n:127.0.0.1:34097_solr) [n:127.0.0.1:34097_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 930694 INFO (jetty-launcher-1667-thread-2) [n:127.0.0.1:34097_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34097.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 930696 INFO (jetty-launcher-1667-thread-4) [n:127.0.0.1:46585_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46585.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 930702 INFO (jetty-launcher-1667-thread-2) [n:127.0.0.1:34097_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34097.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 930702 INFO (jetty-launcher-1667-thread-2) [n:127.0.0.1:34097_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34097.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 930703 INFO (jetty-launcher-1667-thread-2) [n:127.0.0.1:34097_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node2/. [junit4] 2> 930710 INFO (jetty-launcher-1667-thread-3) [n:127.0.0.1:45029_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45029.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 930711 INFO (jetty-launcher-1667-thread-4) [n:127.0.0.1:46585_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46585.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 930712 INFO (jetty-launcher-1667-thread-4) [n:127.0.0.1:46585_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46585.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 930713 INFO (jetty-launcher-1667-thread-4) [n:127.0.0.1:46585_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node4/. [junit4] 2> 930718 INFO (jetty-launcher-1667-thread-3) [n:127.0.0.1:45029_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45029.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 930718 INFO (jetty-launcher-1667-thread-3) [n:127.0.0.1:45029_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45029.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 930720 INFO (jetty-launcher-1667-thread-3) [n:127.0.0.1:45029_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node3/. [junit4] 2> 930813 INFO (zkConnectionManagerCallback-1712-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930816 INFO (zkConnectionManagerCallback-1716-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930817 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 930817 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:37701/solr ready [junit4] 2> 930819 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@649d4001{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 930819 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=885706967 [junit4] 2> 930819 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 930819 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7fe32cb9: rootName = solr_46617, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@16efe9be [junit4] 2> 930823 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 930823 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@56b7c5fb: rootName = solr_46617, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@4238b1a5 [junit4] 2> 930826 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 930826 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6964bccc: rootName = solr_46617, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@2ad9bdd7 [junit4] 2> 930826 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:46617_solr [junit4] 2> 930827 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 930827 INFO (zkCallback-1691-thread-1-processing-n:127.0.0.1:45029_solr) [n:127.0.0.1:45029_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 930827 INFO (zkCallback-1700-thread-2-processing-n:127.0.0.1:46585_solr) [n:127.0.0.1:46585_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 930827 INFO (zkCallback-1689-thread-1-processing-n:127.0.0.1:34097_solr) [n:127.0.0.1:34097_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 930827 INFO (zkCallback-1703-thread-1-processing-n:127.0.0.1:46617_solr) [n:127.0.0.1:46617_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 930827 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 930827 INFO (zkCallback-1715-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 930828 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7ffc1e6f{/solr,null,UNAVAILABLE} [junit4] 2> 930828 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.session Stopped scavenging [junit4] 2> 930829 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T06:27:37+09:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 930829 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 930829 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 930829 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.session Scavenging every 600000ms [junit4] 2> 930830 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7351de94{/solr,null,AVAILABLE} [junit4] 2> 930830 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@8d1260b{HTTP/1.1,[http/1.1]}{127.0.0.1:41147} [junit4] 2> 930830 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.Server Started @932759ms [junit4] 2> 930830 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=35475} [junit4] 2> 930830 ERROR (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 930830 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0 [junit4] 2> 930830 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 930830 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 930830 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-08T07:29:45.056722Z [junit4] 2> 930831 INFO (zkConnectionManagerCallback-1718-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930831 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 930835 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37701/solr [junit4] 2> 930836 INFO (zkConnectionManagerCallback-1722-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930837 INFO (zkConnectionManagerCallback-1724-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930840 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 930841 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:35475_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 930841 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:35475_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:35475_solr [junit4] 2> 930842 INFO (zkCallback-1689-thread-1-processing-n:127.0.0.1:34097_solr) [n:127.0.0.1:34097_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 930842 INFO (zkCallback-1715-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 930842 INFO (zkCallback-1691-thread-1-processing-n:127.0.0.1:45029_solr) [n:127.0.0.1:45029_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 930842 INFO (zkCallback-1700-thread-2-processing-n:127.0.0.1:46585_solr) [n:127.0.0.1:46585_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 930844 INFO (zkCallback-1723-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 930886 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:35475_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35475.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 930891 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:35475_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35475.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 930891 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:35475_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35475.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 930892 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:35475_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node1/. [junit4] 2> 930933 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.TestCloudConsistency Adding proxy for URL: http://127.0.0.1:41147/solr. Proxy: http://127.0.0.1:35475/solr [junit4] 2> 930934 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@6d98fe42{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 930934 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=788161385 [junit4] 2> 930935 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 930935 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1c4e2235: rootName = solr_45029, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@7ebc71ab [junit4] 2> 930938 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 930938 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5a89bee5: rootName = solr_45029, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@4238b1a5 [junit4] 2> 930941 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 930941 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@366001f8: rootName = solr_45029, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@2ad9bdd7 [junit4] 2> 930941 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:45029_solr [junit4] 2> 930942 INFO (zkCallback-1689-thread-1-processing-n:127.0.0.1:34097_solr) [n:127.0.0.1:34097_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 930942 INFO (zkCallback-1715-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 930942 INFO (zkCallback-1723-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 930942 INFO (zkCallback-1700-thread-2-processing-n:127.0.0.1:46585_solr) [n:127.0.0.1:46585_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 930942 INFO (zkCallback-1691-thread-1-processing-n:127.0.0.1:45029_solr) [n:127.0.0.1:45029_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 930942 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 930942 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 930943 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@39ea1e6e{/solr,null,UNAVAILABLE} [junit4] 2> 930943 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.session Stopped scavenging [junit4] 2> 930944 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T06:27:37+09:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 930945 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 930945 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 930945 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.session Scavenging every 600000ms [junit4] 2> 930945 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@72d57859{/solr,null,AVAILABLE} [junit4] 2> 930945 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5ec114c{HTTP/1.1,[http/1.1]}{127.0.0.1:44533} [junit4] 2> 930945 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.Server Started @932875ms [junit4] 2> 930945 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=42381} [junit4] 2> 930946 ERROR (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 930946 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0 [junit4] 2> 930946 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 930946 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 930946 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-08T07:29:45.172204Z [junit4] 2> 930947 INFO (zkConnectionManagerCallback-1728-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930947 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 930951 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37701/solr [junit4] 2> 930952 INFO (zkConnectionManagerCallback-1732-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930953 INFO (zkConnectionManagerCallback-1734-thread-1-processing-n:127.0.0.1:42381_solr) [n:127.0.0.1:42381_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 930955 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:42381_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 930956 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:42381_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 930957 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:42381_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:42381_solr [junit4] 2> 930957 INFO (zkCallback-1715-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 930957 INFO (zkCallback-1700-thread-2-processing-n:127.0.0.1:46585_solr) [n:127.0.0.1:46585_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 930957 INFO (zkCallback-1723-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 930958 INFO (zkCallback-1733-thread-1-processing-n:127.0.0.1:42381_solr) [n:127.0.0.1:42381_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 930960 INFO (zkCallback-1689-thread-1-processing-n:127.0.0.1:34097_solr) [n:127.0.0.1:34097_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 930986 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:42381_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42381.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 930991 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:42381_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42381.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 930991 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:42381_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42381.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 930992 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:42381_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node3/. [junit4] 2> 931019 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.TestCloudConsistency Adding proxy for URL: http://127.0.0.1:44533/solr. Proxy: http://127.0.0.1:42381/solr [junit4] 2> 931019 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1b6df8f8{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 931019 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=850319672 [junit4] 2> 931019 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 931019 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@396a1f6f: rootName = solr_46585, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@1b2016b3 [junit4] 2> 931023 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 931023 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4f997d17: rootName = solr_46585, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@4238b1a5 [junit4] 2> 931025 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 931025 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4a5e4787: rootName = solr_46585, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@2ad9bdd7 [junit4] 2> 931026 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:46585_solr [junit4] 2> 931026 INFO (zkCallback-1689-thread-1-processing-n:127.0.0.1:34097_solr) [n:127.0.0.1:34097_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 931027 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 931027 INFO (zkCallback-1715-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 931027 INFO (zkCallback-1733-thread-1-processing-n:127.0.0.1:42381_solr) [n:127.0.0.1:42381_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 931027 INFO (zkCallback-1700-thread-2-processing-n:127.0.0.1:46585_solr) [n:127.0.0.1:46585_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 931027 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 931027 INFO (zkCallback-1723-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 931029 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7dff2ce4{/solr,null,UNAVAILABLE} [junit4] 2> 931029 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.session Stopped scavenging [junit4] 2> 931031 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T06:27:37+09:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 931040 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 931040 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 931040 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.session Scavenging every 660000ms [junit4] 2> 931041 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7f102ffd{/solr,null,AVAILABLE} [junit4] 2> 931041 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@34ec14af{HTTP/1.1,[http/1.1]}{127.0.0.1:36979} [junit4] 2> 931041 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.Server Started @932971ms [junit4] 2> 931042 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=40661} [junit4] 2> 931042 ERROR (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 931042 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0 [junit4] 2> 931042 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 931042 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 931042 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-08T07:29:45.268449Z [junit4] 2> 931046 INFO (zkConnectionManagerCallback-1738-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 931046 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 931051 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37701/solr [junit4] 2> 931059 INFO (zkConnectionManagerCallback-1742-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 931062 INFO (zkConnectionManagerCallback-1744-thread-1-processing-n:127.0.0.1:40661_solr) [n:127.0.0.1:40661_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 931064 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:40661_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 931065 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:40661_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 931066 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:40661_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:40661_solr [junit4] 2> 931066 INFO (zkCallback-1733-thread-1-processing-n:127.0.0.1:42381_solr) [n:127.0.0.1:42381_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 931066 INFO (zkCallback-1723-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 931066 INFO (zkCallback-1689-thread-1-processing-n:127.0.0.1:34097_solr) [n:127.0.0.1:34097_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 931066 INFO (zkCallback-1715-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 931075 INFO (zkCallback-1743-thread-1-processing-n:127.0.0.1:40661_solr) [n:127.0.0.1:40661_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 931105 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:40661_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_40661.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 931114 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:40661_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_40661.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 931114 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:40661_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_40661.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 931115 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:40661_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node4/. [junit4] 2> 931153 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.TestCloudConsistency Adding proxy for URL: http://127.0.0.1:36979/solr. Proxy: http://127.0.0.1:40661/solr [junit4] 2> 931153 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@59d79b34{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 931153 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1816295225 [junit4] 2> 931153 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 931153 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@76a2892f: rootName = solr_34097, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@67bcb33d [junit4] 2> 931164 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 931165 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@13650404: rootName = solr_34097, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@4238b1a5 [junit4] 2> 931167 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 931167 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@28f630a: rootName = solr_34097, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@2ad9bdd7 [junit4] 2> 931168 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:34097_solr [junit4] 2> 931168 INFO (zkCallback-1743-thread-1-processing-n:127.0.0.1:40661_solr) [n:127.0.0.1:40661_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 931168 INFO (zkCallback-1723-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 931168 INFO (zkCallback-1689-thread-1-processing-n:127.0.0.1:34097_solr) [n:127.0.0.1:34097_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 931168 INFO (zkCallback-1733-thread-1-processing-n:127.0.0.1:42381_solr) [n:127.0.0.1:42381_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 931168 INFO (zkCallback-1715-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 931168 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 931169 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 931169 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.Overseer Overseer (id=72098999142055944-127.0.0.1:34097_solr-n_0000000000) closing [junit4] 2> 931169 INFO (OverseerStateUpdate-72098999142055944-127.0.0.1:34097_solr-n_0000000000) [n:127.0.0.1:34097_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:34097_solr [junit4] 2> 931170 WARN (OverseerAutoScalingTriggerThread-72098999142055944-127.0.0.1:34097_solr-n_0000000000) [n:127.0.0.1:34097_solr ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 931171 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x10025a860860008, likely client has closed socket [junit4] 2> 931171 INFO (zkCallback-1723-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:35475_solr [junit4] 2> 931171 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1f5977a3{/solr,null,UNAVAILABLE} [junit4] 2> 931171 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.session Stopped scavenging [junit4] 2> 931172 INFO (zkCallback-1723-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.Overseer Overseer (id=72098999142055953-127.0.0.1:35475_solr-n_0000000004) starting [junit4] 2> 931172 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T06:27:37+09:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 931183 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 931183 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 931183 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.session Scavenging every 600000ms [junit4] 2> 931184 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@45744048{/solr,null,AVAILABLE} [junit4] 2> 931184 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@798119a3{HTTP/1.1,[http/1.1]}{127.0.0.1:45809} [junit4] 2> 931184 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.e.j.s.Server Started @933114ms [junit4] 2> 931184 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=45975} [junit4] 2> 931184 ERROR (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 931184 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0 [junit4] 2> 931184 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 931185 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 931185 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-08T07:29:45.411022Z [junit4] 2> 931190 INFO (zkConnectionManagerCallback-1748-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 931190 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 931197 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37701/solr [junit4] 2> 931201 INFO (zkConnectionManagerCallback-1752-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 931203 INFO (zkConnectionManagerCallback-1754-thread-1-processing-n:127.0.0.1:45975_solr) [n:127.0.0.1:45975_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 931206 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:45975_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 931207 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:45975_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 931207 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:45975_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:45975_solr [junit4] 2> 931208 INFO (zkCallback-1715-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 931208 INFO (zkCallback-1733-thread-1-processing-n:127.0.0.1:42381_solr) [n:127.0.0.1:42381_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 931208 INFO (zkCallback-1743-thread-1-processing-n:127.0.0.1:40661_solr) [n:127.0.0.1:40661_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 931208 INFO (zkCallback-1723-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 931212 INFO (zkCallback-1753-thread-1-processing-n:127.0.0.1:45975_solr) [n:127.0.0.1:45975_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 931234 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:45975_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45975.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 931239 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:45975_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45975.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 931239 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:45975_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45975.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ab92199 [junit4] 2> 931240 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [n:127.0.0.1:45975_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node2/. [junit4] 2> 931266 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.TestCloudConsistency Adding proxy for URL: http://127.0.0.1:45809/solr. Proxy: http://127.0.0.1:45975/solr [junit4] 2> 931277 INFO (TEST-TestCloudConsistency.testOutOfSyncReplicasCannotBecomeLeader-seed#[9ABEE8FF6B3AC1A8]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testOutOfSyncReplicasCannotBecomeLeader [junit4] 2> 931277 INFO (SocketProxy-Acceptor-35475) [ ] o.a.s.c.SocketProxy accepted Socket[addr=/127.0.0.1,port=48376,localport=35475], receiveBufferSize:531000 [junit4] 2> 931285 INFO (SocketProxy-Acceptor-35475) [ ] o.a.s.c.SocketProxy proxy connection Socket[addr=/127.0.0.1,port=41147,localport=35240], receiveBufferSize=530904 [junit4] 2> 931287 INFO (qtp2031573940-9411) [n:127.0.0.1:35475_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params pullReplicas=0&replicationFactor=3&name=outOfSyncReplicasCannotBecomeLeader-false&nrtReplicas=3&action=CREATE&numShards=1&tlogReplicas=0&createNodeSet=&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 931296 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection outOfSyncReplicasCannotBecomeLeader-false [junit4] 2> 931297 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/protwords.txt [junit4] 2> 931297 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/managed-schema [junit4] 2> 931298 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/solrconfig.xml [junit4] 2> 931299 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/synonyms.txt [junit4] 2> 931299 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/stopwords.txt [junit4] 2> 931300 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_it.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/contractions_it.txt [junit4] 2> 931301 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stemdict_nl.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stemdict_nl.txt [junit4] 2> 931301 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hy.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_hy.txt [junit4] 2> 931302 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_no.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_no.txt [junit4] 2> 931302 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ca.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/contractions_ca.txt [junit4] 2> 931303 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_id.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_id.txt [junit4] 2> 931303 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ga.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_ga.txt [junit4] 2> 931304 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hi.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_hi.txt [junit4] 2> 931305 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_da.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_da.txt [junit4] 2> 931305 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ja.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_ja.txt [junit4] 2> 931306 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_pt.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_pt.txt [junit4] 2> 931306 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hu.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_hu.txt [junit4] 2> 931307 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_el.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_el.txt [junit4] 2> 931307 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ru.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_ru.txt [junit4] 2> 931308 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_tr.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_tr.txt [junit4] 2> 931309 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ar.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_ar.txt [junit4] 2> 931309 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/userdict_ja.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/userdict_ja.txt [junit4] 2> 931310 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_eu.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_eu.txt [junit4] 2> 931310 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_it.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_it.txt [junit4] 2> 931311 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_cz.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_cz.txt [junit4] 2> 931311 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stoptags_ja.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stoptags_ja.txt [junit4] 2> 931312 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_fr.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/contractions_fr.txt [junit4] 2> 931312 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_de.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_de.txt [junit4] 2> 931313 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fa.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_fa.txt [junit4] 2> 931313 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ga.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/contractions_ga.txt [junit4] 2> 931314 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ca.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_ca.txt [junit4] 2> 931314 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_nl.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_nl.txt [junit4] 2> 931315 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_bg.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_bg.txt [junit4] 2> 931316 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_lv.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_lv.txt [junit4] 2> 931316 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_en.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_en.txt [junit4] 2> 931317 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_es.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_es.txt [junit4] 2> 931317 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_th.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_th.txt [junit4] 2> 931318 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ro.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_ro.txt [junit4] 2> 931319 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fr.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_fr.txt [junit4] 2> 931319 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_sv.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_sv.txt [junit4] 2> 931320 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fi.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_fi.txt [junit4] 2> 931320 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/hyphenations_ga.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/hyphenations_ga.txt [junit4] 2> 931321 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_gl.txt to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/lang/stopwords_gl.txt [junit4] 2> 931322 INFO (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/params.json to /configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/params.json [junit4] 2> 931322 WARN (OverseerThreadFactory-3591-thread-1-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.a.c.CreateCollectionCmd It is unusual to create a collection (outOfSyncReplicasCannotBecomeLeader-false) without cores. [junit4] 2> 931425 INFO (qtp2031573940-9411) [n:127.0.0.1:35475_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> 931425 INFO (qtp2031573940-9411) [n:127.0.0.1:35475_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={pullReplicas=0&replicationFactor=3&name=outOfSyncReplicasCannotBecomeLeader-false&nrtReplicas=3&action=CREATE&numShards=1&tlogReplicas=0&createNodeSet=&wt=javabin&version=2} status=0 QTime=138 [junit4] 2> 931426 INFO (SocketProxy-Acceptor-45975) [ ] o.a.s.c.SocketProxy accepted Socket[addr=/127.0.0.1,port=57016,localport=45975], receiveBufferSize:531000 [junit4] 2> 931426 INFO (SocketProxy-Acceptor-45975) [ ] o.a.s.c.SocketProxy proxy connection Socket[addr=/127.0.0.1,port=45809,localport=33912], receiveBufferSize=530904 [junit4] 2> 931427 INFO (qtp449557847-9490) [n:127.0.0.1:45975_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:35475_solr&action=ADDREPLICA&collection=outOfSyncReplicasCannotBecomeLeader-false&shard=shard1&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 931432 INFO (OverseerCollectionConfigSetProcessor-72098999142055953-127.0.0.1:35475_solr-n_0000000004) [n:127.0.0.1:35475_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> 931432 INFO (OverseerThreadFactory-3591-thread-2-processing-n:127.0.0.1:35475_solr) [n:127.0.0.1:35475_solr ] o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:35475_solr for creating new replica [junit4] 2> 931433 INFO (OverseerStateUpdate-72098999142055953-127.0.0.1:35475_solr-n_0000000004) [n:127.0.0.1:35475_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"addreplica", [junit4] 2> "collection":"outOfSyncReplicasCannotBecomeLeader-false", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:35475/solr";, [junit4] 2> "node_name":"127.0.0.1:35475_solr", [junit4] 2> "type":"NRT"} [junit4] 2> 931635 INFO (SocketProxy-Acceptor-35475) [ ] o.a.s.c.SocketProxy accepted Socket[addr=/127.0.0.1,port=48386,localport=35475], receiveBufferSize:531000 [junit4] 2> 931635 INFO (SocketProxy-Acceptor-35475) [ ] o.a.s.c.SocketProxy proxy connection Socket[addr=/127.0.0.1,port=41147,localport=35250], receiveBufferSize=530904 [junit4] 2> 931636 INFO (qtp2031573940-9417) [n:127.0.0.1:35475_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node62&collection.configName=outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED&name=outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61&action=CREATE&collection=outOfSyncReplicasCannotBecomeLeader-false&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 931636 INFO (qtp2031573940-9417) [n:127.0.0.1:35475_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 931641 INFO (qtp2031573940-9417) [n:127.0.0.1:35475_solr c:outOfSyncReplicasCannotBecomeLeader-false s:shard1 r:core_node62 x:outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61] o.a.s.c.RequestParams conf resource params.json loaded . version : 0 [junit4] 2> 931641 INFO (qtp2031573940-9417) [n:127.0.0.1:35475_solr c:outOfSyncReplicasCannotBecomeLeader-false s:shard1 r:core_node62 x:outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61] o.a.s.c.RequestParams request params refreshed to version 0 [junit4] 2> 931642 WARN (qtp2031573940-9417) [n:127.0.0.1:35475_solr c:outOfSyncReplicasCannotBecomeLeader-false s:shard1 r:core_node62 x:outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node1/outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node1/outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61/../../../../contrib/extraction/lib [junit4] 2> 931642 WARN (qtp2031573940-9417) [n:127.0.0.1:35475_solr c:outOfSyncReplicasCannotBecomeLeader-false s:shard1 r:core_node62 x:outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node1/outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node1/outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61/../../../../dist [junit4] 2> 931642 WARN (qtp2031573940-9417) [n:127.0.0.1:35475_solr c:outOfSyncReplicasCannotBecomeLeader-false s:shard1 r:core_node62 x:outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node1/outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node1/outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61/../../../../contrib/clustering/lib [junit4] 2> 931642 WARN (qtp2031573940-9417) [n:127.0.0.1:35475_solr c:outOfSyncReplicasCannotBecomeLeader-false s:shard1 r:core_node62 x:outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node1/outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node1/outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61/../../../../dist [junit4] 2> 931642 WARN (qtp2031573940-9417) [n:127.0.0.1:35475_solr c:outOfSyncReplicasCannotBecomeLeader-false s:shard1 r:core_node62 x:outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node1/outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node1/outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61/../../../../contrib/langid/lib [junit4] 2> 931642 WARN (qtp2031573940-9417) [n:127.0.0.1:35475_solr c:outOfSyncReplicasCannotBecomeLeader-false s:shard1 r:core_node62 x:outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node1/outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node1/outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61/../../../../dist [junit4] 2> 931642 WARN (qtp2031573940-9417) [n:127.0.0.1:35475_solr c:outOfSyncReplicasCannotBecomeLeader-false s:shard1 r:core_node62 x:outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node1/outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001/tempDir-001/node1/outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61/../../../../contrib/velocity/lib [junit4] 2> 931642 W [...truncated too long message...] s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7017d9ee: rootName = solr_35475, domain = solr.core.outOfSyncReplicasCannotBecomeLeader-false.shard1.replica_n61, service url = null, agent id = null] for registry solr.core.outOfSyncReplicasCannotBecomeLeader-false.shard1.replica_n61 / com.codahale.metrics.MetricRegistry@3a72b075 [junit4] 2> 990342 INFO (coreCloseExecutor-3709-thread-1) [n:127.0.0.1:42381_solr c:outOfSyncReplicasCannotBecomeLeader-false s:shard1 r:core_node64 x:outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n63] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.outOfSyncReplicasCannotBecomeLeader-false.shard1.leader, tag=927511196 [junit4] 2> 990343 INFO (coreCloseExecutor-3708-thread-1) [n:127.0.0.1:40661_solr c:outOfSyncReplicasCannotBecomeLeader-false s:shard1 r:core_node66 x:outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n65] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.outOfSyncReplicasCannotBecomeLeader-false.shard1.leader, tag=1652449871 [junit4] 2> 990345 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x10025a860860023, likely client has closed socket [junit4] 2> 990345 INFO (coreCloseExecutor-3710-thread-1) [n:127.0.0.1:35475_solr c:outOfSyncReplicasCannotBecomeLeader-false s:shard1 r:core_node62 x:outOfSyncReplicasCannotBecomeLeader-false_shard1_replica_n61] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.outOfSyncReplicasCannotBecomeLeader-false.shard1.leader, tag=558628424 [junit4] 2> 990345 INFO (jetty-closer-1668-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4eacfcc0{/solr,null,UNAVAILABLE} [junit4] 2> 990345 INFO (jetty-closer-1668-thread-3) [ ] o.e.j.s.session Stopped scavenging [junit4] 2> 990347 INFO (jetty-closer-1668-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@38b6e996{/solr,null,UNAVAILABLE} [junit4] 2> 990347 INFO (jetty-closer-1668-thread-1) [ ] o.e.j.s.session Stopped scavenging [junit4] 2> 990355 INFO (jetty-closer-1668-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@823b75e{/solr,null,UNAVAILABLE} [junit4] 2> 990356 INFO (jetty-closer-1668-thread-2) [ ] o.e.j.s.session Stopped scavenging [junit4] 2> 990356 ERROR (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-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> 990357 INFO (SUITE-TestCloudConsistency-seed#[9ABEE8FF6B3AC1A8]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37701 37701 [junit4] 2> 990382 INFO (Thread-2256) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37701 37701 [junit4] 2> 990383 WARN (Thread-2256) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 51 /solr/collections/outOfSyncReplicasCannotBecomeLeader-true/terms/shard1 [junit4] 2> 42 /solr/collections/outOfSyncReplicasCannotBecomeLeader-false/terms/shard1 [junit4] 2> 13 /solr/clusterprops.json [junit4] 2> 13 /solr/aliases.json [junit4] 2> 12 /solr/security.json [junit4] 2> 7 /solr/configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED/managed-schema [junit4] 2> 7 /solr/collections/outOfSyncReplicasCannotBecomeLeader-false/collectionprops.json [junit4] 2> 7 /solr/configs/outOfSyncReplicasCannotBecomeLeader-false.AUTOCREATED [junit4] 2> 6 /solr/collections/outOfSyncReplicasCannotBecomeLeader-true/collectionprops.json [junit4] 2> 6 /solr/configs/outOfSyncReplicasCannotBecomeLeader-true.AUTOCREATED [junit4] 2> 6 /solr/configs/outOfSyncReplicasCannotBecomeLeader-true.AUTOCREATED/managed-schema [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 93 /solr/collections/outOfSyncReplicasCannotBecomeLeader-false/state.json [junit4] 2> 81 /solr/collections/outOfSyncReplicasCannotBecomeLeader-true/state.json [junit4] 2> 13 /solr/clusterstate.json [junit4] 2> 5 /solr/autoscaling.json [junit4] 2> 3 /solr/overseer_elect/election/72098999142055944-127.0.0.1:34097_solr-n_0000000000 [junit4] 2> 2 /solr/overseer_elect/election/72098999142055947-127.0.0.1:46585_solr-n_0000000002 [junit4] 2> 2 /solr/overseer_elect/election/72098999142055962-127.0.0.1:45975_solr-n_0000000007 [junit4] 2> 2 /solr/collections/outOfSyncReplicasCannotBecomeLeader-false/leader_elect/shard1/election/72098999142055974-core_node62-n_0000000016 [junit4] 2> 2 /solr/collections/outOfSyncReplicasCannotBecomeLeader-true/leader_elect/shard1/election/72098999142055965-core_node62-n_0000000000 [junit4] 2> 2 /solr/collections/outOfSyncReplicasCannotBecomeLeader-false/leader_elect/shard1/election/72098999142055965-core_node62-n_0000000009 [junit4] 2> 2 /solr/overseer_elect/election/72098999142055968-127.0.0.1:42381_solr-n_0000000009 [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 13 /solr/live_nodes [junit4] 2> 13 /solr/collections [junit4] 2> 5 /solr/overseer/queue [junit4] 2> 5 /solr/autoscaling/events/.auto_add_replicas [junit4] 2> 5 /solr/overseer/collection-queue-work [junit4] 2> 5 /solr/overseer/queue-work [junit4] 2> [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudConsistency_9ABEE8FF6B3AC1A8-001 [junit4] 2> Mar 08, 2018 7:30:44 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 6 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=54, maxMBSortInHeap=6.746994471584564, sim=RandomSimilarity(queryNorm=false): {}, locale=sr-Latn, timezone=SystemV/EST5EDT [junit4] 2> NOTE: Linux 4.13.0-36-generic amd64/Oracle Corporation 10 (64-bit)/cpus=8,threads=1,free=210992800,total=524812288 [junit4] 2> NOTE: All tests run in this JVM: [CollectionStateFormat2Test, TestQueryTypes, SpellPossibilityIteratorTest, WordBreakSolrSpellCheckerTest, TestSha256AuthenticationProvider, SecurityConfHandlerTest, TestBulkSchemaAPI, TestXmlQParser, TestUseDocValuesAsStored2, ConfigSetsAPITest, CoreAdminHandlerTest, UnloadDistributedZkTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, TestSchemaResource, BlockJoinFacetDistribTest, URLClassifyProcessorTest, ShowFileRequestHandlerTest, TestSchemalessBufferedUpdates, TimeRoutedAliasUpdateProcessorTest, MoveReplicaHDFSFailoverTest, AtomicUpdatesTest, TestUpdate, TestDistribStateManager, SolrMetricReporterTest, TestReRankQParserPlugin, BaseCdcrDistributedZkTest, TestDocBasedVersionConstraints, BasicDistributedZk2Test, TestDynamicLoading, TestTestInjection, TestTlogReplica, PingRequestHandlerTest, TestRandomFlRTGCloud, TestSerializedLuceneMatchVersion, DisMaxRequestHandlerTest, TestSubQueryTransformer, TestInitParams, DateFieldTest, HLLUtilTest, RecoveryZkTest, DistribJoinFromCollectionTest, ConnectionReuseTest, TestInitQParser, DistributedExpandComponentTest, TestAnalyzedSuggestions, SimpleCollectionCreateDeleteTest, UniqFieldsUpdateProcessorFactoryTest, TestCryptoKeys, TestMacros, TestBinaryResponseWriter, RulesTest, TestQuerySenderListener, ClusterStateTest, NodeAddedTriggerTest, V2ApiIntegrationTest, RegexBoostProcessorTest, TestDistributedMissingSort, TestFaceting, CachingDirectoryFactoryTest, TestCoreDiscovery, SpellCheckComponentTest, SearchHandlerTest, TestBadConfig, MultiTermTest, RestartWhileUpdatingTest, TestDFISimilarityFactory, TestSolr4Spatial2, HttpPartitionTest, DocValuesMultiTest, MultiThreadedOCPTest, DirectSolrSpellCheckerTest, TestAtomicUpdateErrorCases, DocValuesNotIndexedTest, TestCloudRecovery, QueryResultKeyTest, DeleteNodeTest, HdfsAutoAddReplicasIntegrationTest, FileBasedSpellCheckerTest, TestCodecSupport, TestFieldTypeCollectionResource, TestManagedSchemaThreadSafety, CloudMLTQParserTest, TestInPlaceUpdatesDistrib, TestFieldCacheReopen, TestPrepRecovery, SaslZkACLProviderTest, TestAddFieldRealTimeGet, WrapperMergePolicyFactoryTest, TestJmxIntegration, HdfsBasicDistributedZkTest, TestCloudConsistency] [junit4] Completed [352/780 (1!)] on J2 in 60.47s, 2 tests, 1 failure <<< FAILURES! [...truncated 44174 lines...] [repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/1486/consoleText [repro] Revision: ae97500ec2198280e4dc96bd8b5d64b65034cd5c [repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseParallelGC" [repro] Repro line: ant test -Dtestcase=TestCloudConsistency -Dtests.method=testOutOfSyncReplicasCannotBecomeLeader -Dtests.seed=9ABEE8FF6B3AC1A8 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sr-Latn -Dtests.timezone=SystemV/EST5EDT -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [repro] ant clean [...truncated 6 lines...] [repro] Test suites by module: [repro] solr/core [repro] TestCloudConsistency [repro] ant compile-test [...truncated 3315 lines...] [repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.TestCloudConsistency" -Dtests.showOutput=onerror "-Dargs=-XX:-UseCompressedOops -XX:+UseParallelGC" -Dtests.seed=9ABEE8FF6B3AC1A8 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sr-Latn -Dtests.timezone=SystemV/EST5EDT -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [...truncated 81 lines...] [repro] Failures: [repro] 0/5 failed: org.apache.solr.cloud.TestCloudConsistency [repro] Exiting with code 0 [...truncated 40 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org
