Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.3/60/
2 tests failed.
FAILED:
org.apache.solr.cloud.LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection
Error Message:
Timeout waiting for new leader null Live Nodes: [127.0.0.1:52694_solr,
127.0.0.1:58961_solr, 127.0.0.1:59993_solr] Last available state:
DocCollection(collection1//collections/collection1/state.json/14)={
"pullReplicas":"0", "replicationFactor":"3", "shards":{"shard1":{
"range":"80000000-7fffffff", "state":"active", "replicas":{
"core_node62":{ "core":"collection1_shard1_replica_n61",
"base_url":"https://127.0.0.1:34744/solr";,
"node_name":"127.0.0.1:34744_solr", "state":"down",
"type":"NRT"}, "core_node64":{
"core":"collection1_shard1_replica_n63",
"base_url":"https://127.0.0.1:58961/solr";,
"node_name":"127.0.0.1:58961_solr", "state":"active",
"type":"NRT"}, "core_node66":{
"core":"collection1_shard1_replica_n65",
"base_url":"https://127.0.0.1:52694/solr";,
"node_name":"127.0.0.1:52694_solr", "state":"active",
"type":"NRT"}}}}, "router":{"name":"compositeId"}, "maxShardsPerNode":"1",
"autoAddReplicas":"false", "nrtReplicas":"3", "tlogReplicas":"0"}
Stack Trace:
java.lang.AssertionError: Timeout waiting for new leader
null
Live Nodes: [127.0.0.1:52694_solr, 127.0.0.1:58961_solr, 127.0.0.1:59993_solr]
Last available state:
DocCollection(collection1//collections/collection1/state.json/14)={
"pullReplicas":"0",
"replicationFactor":"3",
"shards":{"shard1":{
"range":"80000000-7fffffff",
"state":"active",
"replicas":{
"core_node62":{
"core":"collection1_shard1_replica_n61",
"base_url":"https://127.0.0.1:34744/solr";,
"node_name":"127.0.0.1:34744_solr",
"state":"down",
"type":"NRT"},
"core_node64":{
"core":"collection1_shard1_replica_n63",
"base_url":"https://127.0.0.1:58961/solr";,
"node_name":"127.0.0.1:58961_solr",
"state":"active",
"type":"NRT"},
"core_node66":{
"core":"collection1_shard1_replica_n65",
"base_url":"https://127.0.0.1:52694/solr";,
"node_name":"127.0.0.1:52694_solr",
"state":"active",
"type":"NRT"}}}},
"router":{"name":"compositeId"},
"maxShardsPerNode":"1",
"autoAddReplicas":"false",
"nrtReplicas":"3",
"tlogReplicas":"0"}
at
__randomizedtesting.SeedInfo.seed([47275CC5ADF98B96:EF3B407F6FB9BFBC]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCase.java:269)
at
org.apache.solr.cloud.LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection(LeaderVoteWaitTimeoutTest.java:189)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest.basicTest
Error Message:
Stack Trace:
java.lang.NullPointerException
at
__randomizedtesting.SeedInfo.seed([47275CC5ADF98B96:B5D34BA7E95C86A5]:0)
at
org.apache.solr.client.solrj.embedded.JettySolrRunner.getNodeName(JettySolrRunner.java:347)
at
org.apache.solr.cloud.LeaderVoteWaitTimeoutTest.basicTest(LeaderVoteWaitTimeoutTest.java:96)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 13819 lines...]
[junit4] Suite: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest
[junit4] 2> 2288556 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.3/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderVoteWaitTimeoutTest_47275CC5ADF98B96-001/init-core-data-001
[junit4] 2> 2288557 WARN
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=105 numCloses=105
[junit4] 2> 2288557 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 2288559 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 2288560 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.3/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderVoteWaitTimeoutTest_47275CC5ADF98B96-001/tempDir-001
[junit4] 2> 2288561 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2288561 INFO (Thread-5145) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2288561 INFO (Thread-5145) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 2288563 ERROR (Thread-5145) [ ] 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> 2288661 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:44477
[junit4] 2> 2288670 INFO (zkConnectionManagerCallback-5602-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2288682 INFO (jetty-launcher-5599-thread-1) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-22T04:27:37+07:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2288682 INFO (jetty-launcher-5599-thread-2) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-22T04:27:37+07:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2288684 INFO (jetty-launcher-5599-thread-3) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-22T04:27:37+07:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2288684 INFO (jetty-launcher-5599-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2288684 INFO (jetty-launcher-5599-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2288685 INFO (jetty-launcher-5599-thread-1) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 2288693 INFO (jetty-launcher-5599-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@36f00c0e{/solr,null,AVAILABLE}
[junit4] 2> 2288694 INFO (jetty-launcher-5599-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@24236414{SSL,[ssl,
http/1.1]}{127.0.0.1:42238}
[junit4] 2> 2288694 INFO (jetty-launcher-5599-thread-1) [ ]
o.e.j.s.Server Started @2297185ms
[junit4] 2> 2288694 INFO (jetty-launcher-5599-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=42238}
[junit4] 2> 2288694 ERROR (jetty-launcher-5599-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2288695 INFO (jetty-launcher-5599-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.3.1
[junit4] 2> 2288695 INFO (jetty-launcher-5599-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2288695 INFO (jetty-launcher-5599-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2288695 INFO (jetty-launcher-5599-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-03T19:11:39.310Z
[junit4] 2> 2288698 INFO (jetty-launcher-5599-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2288698 INFO (jetty-launcher-5599-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2288698 INFO (jetty-launcher-5599-thread-2) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 2288698 INFO (jetty-launcher-5599-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@77127111{/solr,null,AVAILABLE}
[junit4] 2> 2288699 INFO (jetty-launcher-5599-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@12ae462{SSL,[ssl,
http/1.1]}{127.0.0.1:40376}
[junit4] 2> 2288699 INFO (jetty-launcher-5599-thread-2) [ ]
o.e.j.s.Server Started @2297190ms
[junit4] 2> 2288699 INFO (jetty-launcher-5599-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=40376}
[junit4] 2> 2288699 ERROR (jetty-launcher-5599-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2288699 INFO (jetty-launcher-5599-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.3.1
[junit4] 2> 2288699 INFO (jetty-launcher-5599-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2288699 INFO (jetty-launcher-5599-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2288699 INFO (jetty-launcher-5599-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-03T19:11:39.314Z
[junit4] 2> 2288704 INFO (jetty-launcher-5599-thread-4) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-22T04:27:37+07:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2288708 INFO (zkConnectionManagerCallback-5604-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2288709 INFO (jetty-launcher-5599-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2288709 INFO (zkConnectionManagerCallback-5606-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2288710 INFO (jetty-launcher-5599-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2288719 INFO (jetty-launcher-5599-thread-4) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2288720 INFO (jetty-launcher-5599-thread-4) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2288720 INFO (jetty-launcher-5599-thread-4) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 2288720 INFO (jetty-launcher-5599-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@72bc732f{/solr,null,AVAILABLE}
[junit4] 2> 2288721 INFO (jetty-launcher-5599-thread-4) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@625663c8{SSL,[ssl,
http/1.1]}{127.0.0.1:47353}
[junit4] 2> 2288721 INFO (jetty-launcher-5599-thread-4) [ ]
o.e.j.s.Server Started @2297212ms
[junit4] 2> 2288721 INFO (jetty-launcher-5599-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=47353}
[junit4] 2> 2288721 ERROR (jetty-launcher-5599-thread-4) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2288721 INFO (jetty-launcher-5599-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.3.1
[junit4] 2> 2288721 INFO (jetty-launcher-5599-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2288721 INFO (jetty-launcher-5599-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2288721 INFO (jetty-launcher-5599-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-03T19:11:39.336Z
[junit4] 2> 2288725 INFO (jetty-launcher-5599-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44477/solr
[junit4] 2> 2288728 INFO (jetty-launcher-5599-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44477/solr
[junit4] 2> 2288730 INFO (jetty-launcher-5599-thread-3) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2288730 INFO (jetty-launcher-5599-thread-3) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2288730 INFO (jetty-launcher-5599-thread-3) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 2288731 INFO (jetty-launcher-5599-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@51174190{/solr,null,AVAILABLE}
[junit4] 2> 2288731 INFO (jetty-launcher-5599-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@270d0790{SSL,[ssl,
http/1.1]}{127.0.0.1:43651}
[junit4] 2> 2288731 INFO (jetty-launcher-5599-thread-3) [ ]
o.e.j.s.Server Started @2297223ms
[junit4] 2> 2288731 INFO (jetty-launcher-5599-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=43651}
[junit4] 2> 2288732 ERROR (jetty-launcher-5599-thread-3) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2288732 INFO (jetty-launcher-5599-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.3.1
[junit4] 2> 2288732 INFO (jetty-launcher-5599-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2288732 INFO (jetty-launcher-5599-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2288732 INFO (jetty-launcher-5599-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-03T19:11:39.347Z
[junit4] 2> 2288739 INFO (zkConnectionManagerCallback-5612-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2288740 INFO (zkConnectionManagerCallback-5608-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2288741 INFO (jetty-launcher-5599-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2288746 INFO (zkConnectionManagerCallback-5618-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2288747 INFO (jetty-launcher-5599-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2288755 INFO (zkConnectionManagerCallback-5616-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2288758 INFO (jetty-launcher-5599-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44477/solr
[junit4] 2> 2288761 INFO (zkConnectionManagerCallback-5624-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2288764 INFO (jetty-launcher-5599-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44477/solr
[junit4] 2> 2288766 INFO
(zkConnectionManagerCallback-5620-thread-1-processing-n:127.0.0.1:40376_solr)
[n:127.0.0.1:40376_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2288787 INFO
(zkConnectionManagerCallback-5626-thread-1-processing-n:127.0.0.1:42238_solr)
[n:127.0.0.1:42238_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2288800 INFO (jetty-launcher-5599-thread-1)
[n:127.0.0.1:42238_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2288801 INFO (jetty-launcher-5599-thread-1)
[n:127.0.0.1:42238_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:42238_solr
[junit4] 2> 2288802 INFO (jetty-launcher-5599-thread-1)
[n:127.0.0.1:42238_solr ] o.a.s.c.Overseer Overseer
(id=73737058647670793-127.0.0.1:42238_solr-n_0000000000) starting
[junit4] 2> 2288810 INFO (zkConnectionManagerCallback-5630-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2288811 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
0x105f776d37a000a, likely client has closed socket
[junit4] 2> 2288819 INFO
(zkConnectionManagerCallback-5632-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2288821 INFO
(zkConnectionManagerCallback-5636-thread-1-processing-n:127.0.0.1:43651_solr)
[n:127.0.0.1:43651_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2288847 INFO (jetty-launcher-5599-thread-3)
[n:127.0.0.1:43651_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2288847 INFO (jetty-launcher-5599-thread-4)
[n:127.0.0.1:47353_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2288849 INFO (jetty-launcher-5599-thread-3)
[n:127.0.0.1:43651_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:43651_solr
[junit4] 2> 2288858 INFO (jetty-launcher-5599-thread-4)
[n:127.0.0.1:47353_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:47353_solr
[junit4] 2> 2288937 INFO
(zkCallback-5635-thread-1-processing-n:127.0.0.1:43651_solr)
[n:127.0.0.1:43651_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2288942 INFO
(zkConnectionManagerCallback-5642-thread-1-processing-n:127.0.0.1:42238_solr)
[n:127.0.0.1:42238_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2288943 INFO (jetty-launcher-5599-thread-1)
[n:127.0.0.1:42238_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2288945 INFO (jetty-launcher-5599-thread-1)
[n:127.0.0.1:42238_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:44477/solr ready
[junit4] 2> 2288957 INFO (jetty-launcher-5599-thread-1)
[n:127.0.0.1:42238_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:42238_solr
[junit4] 2> 2288958 INFO
(zkCallback-5635-thread-1-processing-n:127.0.0.1:43651_solr)
[n:127.0.0.1:43651_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2288977 INFO (jetty-launcher-5599-thread-2)
[n:127.0.0.1:40376_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 2288980 INFO
(zkCallback-5625-thread-1-processing-n:127.0.0.1:42238_solr)
[n:127.0.0.1:42238_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2288980 INFO
(zkCallback-5631-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 2288980 INFO
(zkCallback-5641-thread-1-processing-n:127.0.0.1:42238_solr)
[n:127.0.0.1:42238_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2288990 INFO
(OverseerStateUpdate-73737058647670793-127.0.0.1:42238_solr-n_0000000000)
[n:127.0.0.1:42238_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2288991 INFO (jetty-launcher-5599-thread-2)
[n:127.0.0.1:40376_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2288995 INFO (jetty-launcher-5599-thread-2)
[n:127.0.0.1:40376_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:40376_solr
[junit4] 2> 2288996 INFO
(zkCallback-5635-thread-1-processing-n:127.0.0.1:43651_solr)
[n:127.0.0.1:43651_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2288996 INFO
(zkCallback-5625-thread-2-processing-n:127.0.0.1:42238_solr)
[n:127.0.0.1:42238_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2289024 INFO
(zkCallback-5641-thread-1-processing-n:127.0.0.1:42238_solr)
[n:127.0.0.1:42238_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2289039 INFO
(zkCallback-5631-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2289043 INFO
(zkCallback-5619-thread-1-processing-n:127.0.0.1:40376_solr)
[n:127.0.0.1:40376_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2289150 INFO (jetty-launcher-5599-thread-1)
[n:127.0.0.1:42238_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_42238.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2289160 INFO (jetty-launcher-5599-thread-4)
[n:127.0.0.1:47353_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_47353.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2289175 INFO (jetty-launcher-5599-thread-3)
[n:127.0.0.1:43651_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_43651.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2289223 INFO (jetty-launcher-5599-thread-4)
[n:127.0.0.1:47353_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_47353.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2289223 INFO (jetty-launcher-5599-thread-4)
[n:127.0.0.1:47353_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_47353.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2289229 INFO (jetty-launcher-5599-thread-4)
[n:127.0.0.1:47353_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.3/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderVoteWaitTimeoutTest_47275CC5ADF98B96-001/tempDir-001/node4/.
[junit4] 2> 2289231 INFO (jetty-launcher-5599-thread-1)
[n:127.0.0.1:42238_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_42238.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2289231 INFO (jetty-launcher-5599-thread-1)
[n:127.0.0.1:42238_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_42238.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2289232 INFO (jetty-launcher-5599-thread-1)
[n:127.0.0.1:42238_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.3/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderVoteWaitTimeoutTest_47275CC5ADF98B96-001/tempDir-001/node1/.
[junit4] 2> 2289236 INFO (jetty-launcher-5599-thread-3)
[n:127.0.0.1:43651_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_43651.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2289236 INFO (jetty-launcher-5599-thread-3)
[n:127.0.0.1:43651_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_43651.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2289238 INFO (jetty-launcher-5599-thread-3)
[n:127.0.0.1:43651_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.3/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderVoteWaitTimeoutTest_47275CC5ADF98B96-001/tempDir-001/node3/.
[junit4] 2> 2289241 INFO (jetty-launcher-5599-thread-2)
[n:127.0.0.1:40376_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40376.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2289277 INFO (jetty-launcher-5599-thread-2)
[n:127.0.0.1:40376_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40376.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2289278 INFO (jetty-launcher-5599-thread-2)
[n:127.0.0.1:40376_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40376.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2289279 INFO (jetty-launcher-5599-thread-2)
[n:127.0.0.1:40376_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.3/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderVoteWaitTimeoutTest_47275CC5ADF98B96-001/tempDir-001/node2/.
[junit4] 2> 2289297 INFO
(zkConnectionManagerCallback-5646-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2289298 INFO
(zkConnectionManagerCallback-5650-thread-1-processing-n:127.0.0.1:43651_solr)
[n:127.0.0.1:43651_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2289300 INFO (jetty-launcher-5599-thread-3)
[n:127.0.0.1:43651_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 2289301 INFO (jetty-launcher-5599-thread-4)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 2289302 INFO (jetty-launcher-5599-thread-3)
[n:127.0.0.1:43651_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:44477/solr ready
[junit4] 2> 2289304 INFO (jetty-launcher-5599-thread-4)
[n:127.0.0.1:47353_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:44477/solr ready
[junit4] 2> 2289312 INFO
(zkConnectionManagerCallback-5654-thread-1-processing-n:127.0.0.1:40376_solr)
[n:127.0.0.1:40376_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2289313 INFO (jetty-launcher-5599-thread-2)
[n:127.0.0.1:40376_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 2289314 INFO (jetty-launcher-5599-thread-2)
[n:127.0.0.1:40376_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:44477/solr ready
[junit4] 2> 2289550 INFO (zkConnectionManagerCallback-5656-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2289553 INFO (zkConnectionManagerCallback-5660-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2289554 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 2289555 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44477/solr ready
[junit4] 2> 2289565 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@24236414{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 2289565 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=494156193
[junit4] 2> 2289565 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2289565 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7d9d5b35: rootName =
solr_42238, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@2980be04
[junit4] 2> 2289574 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2289574 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@17ea3b5d: rootName =
solr_42238, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@40182055
[junit4] 2> 2289580 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2289580 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@33f8117c: rootName =
solr_42238, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@4427ac8e
[junit4] 2> 2289582 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:42238_solr
[junit4] 2> 2289584 INFO
(zkCallback-5641-thread-1-processing-n:127.0.0.1:42238_solr)
[n:127.0.0.1:42238_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2289584 INFO
(zkCallback-5635-thread-1-processing-n:127.0.0.1:43651_solr)
[n:127.0.0.1:43651_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2289584 INFO
(zkCallback-5631-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2289585 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2289585 INFO
(zkCallback-5625-thread-2-processing-n:127.0.0.1:42238_solr)
[n:127.0.0.1:42238_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2289592 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2289593 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.Overseer Overseer
(id=73737058647670793-127.0.0.1:42238_solr-n_0000000000) closing
[junit4] 2> 2289594 WARN
(OverseerAutoScalingTriggerThread-73737058647670793-127.0.0.1:42238_solr-n_0000000000)
[n:127.0.0.1:42238_solr ] o.a.s.c.a.OverseerTriggerThread
OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 2289609 INFO
(zkCallback-5653-thread-1-processing-n:127.0.0.1:40376_solr)
[n:127.0.0.1:40376_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2289604 INFO
(zkCallback-5619-thread-1-processing-n:127.0.0.1:40376_solr)
[n:127.0.0.1:40376_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2289594 INFO
(OverseerStateUpdate-73737058647670793-127.0.0.1:42238_solr-n_0000000000)
[n:127.0.0.1:42238_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:42238_solr
[junit4] 2> 2289610 INFO
(zkCallback-5649-thread-1-processing-n:127.0.0.1:43651_solr)
[n:127.0.0.1:43651_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2289609 INFO
(zkCallback-5645-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2289615 INFO (zkCallback-5659-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 2289617 INFO
(zkCallback-5635-thread-1-processing-n:127.0.0.1:43651_solr)
[n:127.0.0.1:43651_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:43651_solr
[junit4] 2> 2289618 INFO
(zkCallback-5635-thread-1-processing-n:127.0.0.1:43651_solr)
[n:127.0.0.1:43651_solr ] o.a.s.c.Overseer Overseer
(id=73737058647670796-127.0.0.1:43651_solr-n_0000000001) starting
[junit4] 2> 2289628 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@36f00c0e{/solr,null,UNAVAILABLE}
[junit4] 2> 2289628 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 2289631 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-22T04:27:37+07:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2289636 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2289636 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2289636 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 2289637 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@59b20bad{/solr,null,AVAILABLE}
[junit4] 2> 2289637 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@5af67cf8{SSL,[ssl,
http/1.1]}{127.0.0.1:52914}
[junit4] 2> 2289637 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.Server Started @2298129ms
[junit4] 2> 2289637 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=34744}
[junit4] 2> 2289638 ERROR
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2289638 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.3.1
[junit4] 2> 2289638 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2289638 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2289638 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-03T19:11:40.253Z
[junit4] 2> 2289644 INFO (zkConnectionManagerCallback-5662-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2289645 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2289657 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44477/solr
[junit4] 2> 2289659 INFO (zkConnectionManagerCallback-5666-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2289662 INFO
(zkConnectionManagerCallback-5668-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2289669 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 2289671 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:34744_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2289673 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:34744_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:34744_solr
[junit4] 2> 2289675 INFO
(zkCallback-5631-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2289675 INFO
(zkCallback-5649-thread-1-processing-n:127.0.0.1:43651_solr)
[n:127.0.0.1:43651_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2289675 INFO
(zkCallback-5619-thread-1-processing-n:127.0.0.1:40376_solr)
[n:127.0.0.1:40376_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2289675 INFO
(zkCallback-5635-thread-1-processing-n:127.0.0.1:43651_solr)
[n:127.0.0.1:43651_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2289675 INFO
(zkCallback-5645-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2289676 INFO (zkCallback-5659-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2289676 INFO
(zkCallback-5653-thread-1-processing-n:127.0.0.1:40376_solr)
[n:127.0.0.1:40376_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2289692 INFO
(zkCallback-5667-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2289747 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:34744_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34744.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2289763 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:34744_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34744.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2289763 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:34744_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34744.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2289765 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:34744_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.3/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderVoteWaitTimeoutTest_47275CC5ADF98B96-001/tempDir-001/node1/.
[junit4] 2> 2289769 INFO
(zkConnectionManagerCallback-5673-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2289770 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 2289771 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:34744_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:44477/solr ready
[junit4] 2> 2289896 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.LeaderVoteWaitTimeoutTest Adding proxy for URL:
https://127.0.0.1:52914/solr. Proxy: https://127.0.0.1:34744/solr
[junit4] 2> 2289916 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@12ae462{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 2289920 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=456521785
[junit4] 2> 2289920 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2289920 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@20992c8e: rootName =
solr_40376, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@13e4ac18
[junit4] 2> 2289929 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2289929 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5d19f679: rootName =
solr_40376, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@40182055
[junit4] 2> 2289935 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2289935 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@614a333: rootName =
solr_40376, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@4427ac8e
[junit4] 2> 2289937 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:40376_solr
[junit4] 2> 2289938 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2289939 INFO
(zkCallback-5667-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2289939 INFO
(zkCallback-5649-thread-1-processing-n:127.0.0.1:43651_solr)
[n:127.0.0.1:43651_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2289939 INFO
(zkCallback-5631-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2289939 INFO (zkCallback-5659-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 2289939 INFO
(zkCallback-5645-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2289939 INFO
(zkCallback-5653-thread-1-processing-n:127.0.0.1:40376_solr)
[n:127.0.0.1:40376_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2289940 INFO
(zkCallback-5619-thread-1-processing-n:127.0.0.1:40376_solr)
[n:127.0.0.1:40376_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2289948 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2289949 INFO
(zkCallback-5635-thread-2-processing-n:127.0.0.1:43651_solr)
[n:127.0.0.1:43651_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2289950 INFO
(zkCallback-5672-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2289954 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@77127111{/solr,null,UNAVAILABLE}
[junit4] 2> 2289954 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 2289973 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-22T04:27:37+07:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2289974 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2289974 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2289974 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 2289975 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1e4f65ca{/solr,null,AVAILABLE}
[junit4] 2> 2289975 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@614d249d{SSL,[ssl,
http/1.1]}{127.0.0.1:46336}
[junit4] 2> 2289975 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.Server Started @2298467ms
[junit4] 2> 2289975 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=58961}
[junit4] 2> 2289976 ERROR
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2289976 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.3.1
[junit4] 2> 2289976 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2289976 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2289976 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-03T19:11:40.591Z
[junit4] 2> 2289990 INFO (zkConnectionManagerCallback-5675-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2289990 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2290014 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44477/solr
[junit4] 2> 2290053 INFO (zkConnectionManagerCallback-5679-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2290079 INFO
(zkConnectionManagerCallback-5681-thread-1-processing-n:127.0.0.1:58961_solr)
[n:127.0.0.1:58961_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2290100 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:58961_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 2290102 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:58961_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2290112 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:58961_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:58961_solr
[junit4] 2> 2290114 INFO
(zkCallback-5645-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2290114 INFO
(zkCallback-5672-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2290114 INFO (zkCallback-5659-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2290115 INFO
(zkCallback-5649-thread-1-processing-n:127.0.0.1:43651_solr)
[n:127.0.0.1:43651_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2290115 INFO
(zkCallback-5667-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2290115 INFO
(zkCallback-5635-thread-2-processing-n:127.0.0.1:43651_solr)
[n:127.0.0.1:43651_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2290116 INFO
(zkCallback-5631-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2290138 INFO
(zkCallback-5680-thread-1-processing-n:127.0.0.1:58961_solr)
[n:127.0.0.1:58961_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2290618 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:58961_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_58961.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2290682 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:58961_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_58961.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2290682 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:58961_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_58961.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2290701 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:58961_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.3/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderVoteWaitTimeoutTest_47275CC5ADF98B96-001/tempDir-001/node2/.
[junit4] 2> 2290740 INFO
(zkConnectionManagerCallback-5686-thread-1-processing-n:127.0.0.1:58961_solr)
[n:127.0.0.1:58961_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2290741 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:58961_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 2290742 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:58961_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:44477/solr ready
[junit4] 2> 2290811 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.LeaderVoteWaitTimeoutTest Adding proxy for URL:
https://127.0.0.1:46336/solr. Proxy: https://127.0.0.1:58961/solr
[junit4] 2> 2290821 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@270d0790{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 2290821 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=817229120
[junit4] 2> 2290821 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2290821 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@3d717159: rootName =
solr_43651, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@43d3c5ec
[junit4] 2> 2290918 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2290919 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@19ff6423: rootName =
solr_43651, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@40182055
[junit4] 2> 2290924 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2290925 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6cf05f70: rootName =
solr_43651, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@4427ac8e
[junit4] 2> 2290927 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:43651_solr
[junit4] 2> 2290928 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2290928 INFO
(zkCallback-5680-thread-1-processing-n:127.0.0.1:58961_solr)
[n:127.0.0.1:58961_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2290928 INFO
(zkCallback-5649-thread-1-processing-n:127.0.0.1:43651_solr)
[n:127.0.0.1:43651_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2290929 INFO
(zkCallback-5631-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2290929 INFO
(zkCallback-5667-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2290929 INFO
(zkCallback-5635-thread-1-processing-n:127.0.0.1:43651_solr)
[n:127.0.0.1:43651_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2290929 INFO
(zkCallback-5645-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2290930 INFO (zkCallback-5659-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 2290937 INFO
(zkCallback-5672-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2290942 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2290942 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.Overseer Overseer
(id=73737058647670796-127.0.0.1:43651_solr-n_0000000001) closing
[junit4] 2> 2290942 INFO
(OverseerStateUpdate-73737058647670796-127.0.0.1:43651_solr-n_0000000001)
[n:127.0.0.1:43651_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:43651_solr
[junit4] 2> 2290943 INFO
(zkCallback-5685-thread-1-processing-n:127.0.0.1:58961_solr)
[n:127.0.0.1:58961_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2290945 WARN
(OverseerAutoScalingTriggerThread-73737058647670796-127.0.0.1:43651_solr-n_0000000001)
[n:127.0.0.1:43651_solr ] o.a.s.c.a.OverseerTriggerThread
OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 2290957 INFO
(zkCallback-5631-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:47353_solr
[junit4] 2> 2290959 INFO
(zkCallback-5631-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.Overseer Overseer
(id=73737058647670795-127.0.0.1:47353_solr-n_0000000002) starting
[junit4] 2> 2290960 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@51174190{/solr,null,UNAVAILABLE}
[junit4] 2> 2290961 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 2290966 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-22T04:27:37+07:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2290994 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2290994 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2290994 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 2290998 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@15e60155{/solr,null,AVAILABLE}
[junit4] 2> 2290999 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@7257aa33{SSL,[ssl,
http/1.1]}{127.0.0.1:56691}
[junit4] 2> 2290999 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.Server Started @2299490ms
[junit4] 2> 2290999 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=52694}
[junit4] 2> 2290999 ERROR
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2291011 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.3.1
[junit4] 2> 2291011 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2291011 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2291011 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-03T19:11:41.626Z
[junit4] 2> 2291015 INFO (zkConnectionManagerCallback-5688-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2291016 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2291025 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44477/solr
[junit4] 2> 2291027 INFO (zkConnectionManagerCallback-5692-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2291029 INFO
(zkConnectionManagerCallback-5694-thread-1-processing-n:127.0.0.1:52694_solr)
[n:127.0.0.1:52694_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2291036 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:52694_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 2291038 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:52694_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2291041 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:52694_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:52694_solr
[junit4] 2> 2291042 INFO
(zkCallback-5680-thread-1-processing-n:127.0.0.1:58961_solr)
[n:127.0.0.1:58961_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2291042 INFO
(zkCallback-5631-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2291044 INFO (zkCallback-5659-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2291044 INFO
(zkCallback-5685-thread-1-processing-n:127.0.0.1:58961_solr)
[n:127.0.0.1:58961_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2291045 INFO
(zkCallback-5645-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2291045 INFO
(zkCallback-5672-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2291045 INFO
(zkCallback-5667-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2291063 INFO
(zkCallback-5693-thread-1-processing-n:127.0.0.1:52694_solr)
[n:127.0.0.1:52694_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2291129 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:52694_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_52694.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2291146 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:52694_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_52694.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2291146 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:52694_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_52694.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2291148 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:52694_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.3/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderVoteWaitTimeoutTest_47275CC5ADF98B96-001/tempDir-001/node3/.
[junit4] 2> 2291152 INFO
(zkConnectionManagerCallback-5699-thread-1-processing-n:127.0.0.1:52694_solr)
[n:127.0.0.1:52694_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2291153 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:52694_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 2291154 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:52694_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:44477/solr ready
[junit4] 2> 2291254 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.LeaderVoteWaitTimeoutTest Adding proxy for URL:
https://127.0.0.1:56691/solr. Proxy: https://127.0.0.1:52694/solr
[junit4] 2> 2291262 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@625663c8{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 2291263 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1364413616
[junit4] 2> 2291263 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2291263 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@30da275e: rootName =
solr_47353, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@1b3e644f
[junit4] 2> 2291272 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2291272 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@72ae75c6: rootName =
solr_47353, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@40182055
[junit4] 2> 2291278 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2291278 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@3e3c3627: rootName =
solr_47353, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@4427ac8e
[junit4] 2> 2291280 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:47353_solr
[junit4] 2> 2291283 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2291283 INFO
(zkCallback-5680-thread-1-processing-n:127.0.0.1:58961_solr)
[n:127.0.0.1:58961_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2291283 INFO (zkCallback-5659-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 2291284 INFO
(zkCallback-5685-thread-1-processing-n:127.0.0.1:58961_solr)
[n:127.0.0.1:58961_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2291284 INFO
(zkCallback-5631-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2291284 INFO
(zkCallback-5645-thread-1-processing-n:127.0.0.1:47353_solr)
[n:127.0.0.1:47353_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2291284 INFO
(zkCallback-5672-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2291284 INFO
(zkCallback-5667-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2291290 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2291290 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.Overseer Overseer
(id=73737058647670795-127.0.0.1:47353_solr-n_0000000002) closing
[junit4] 2> 2291291 INFO
(OverseerStateUpdate-73737058647670795-127.0.0.1:47353_solr-n_0000000002)
[n:127.0.0.1:47353_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:47353_solr
[junit4] 2> 2291291 WARN
(OverseerAutoScalingTriggerThread-73737058647670795-127.0.0.1:47353_solr-n_0000000002)
[n:127.0.0.1:47353_solr ] o.a.s.c.a.OverseerTriggerThread
OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 2291293 INFO
(zkCallback-5693-thread-1-processing-n:127.0.0.1:52694_solr)
[n:127.0.0.1:52694_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2291312 INFO
(zkCallback-5698-thread-1-processing-n:127.0.0.1:52694_solr)
[n:127.0.0.1:52694_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2291313 INFO
(zkCallback-5667-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:34744_solr
[junit4] 2> 2291314 INFO
(zkCallback-5667-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.Overseer Overseer
(id=73737058647670805-127.0.0.1:34744_solr-n_0000000004) starting
[junit4] 2> 2291316 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@72bc732f{/solr,null,UNAVAILABLE}
[junit4] 2> 2291316 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 2291318 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-22T04:27:37+07:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2291319 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2291319 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2291319 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 2291320 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7c10a563{/solr,null,AVAILABLE}
[junit4] 2> 2291320 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@3fc207ce{SSL,[ssl,
http/1.1]}{127.0.0.1:45905}
[junit4] 2> 2291321 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.e.j.s.Server Started @2299812ms
[junit4] 2> 2291321 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=59993}
[junit4] 2> 2291321 ERROR
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2291451 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.3.1
[junit4] 2> 2291451 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2291451 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2291451 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-03T19:11:42.066Z
[junit4] 2> 2291463 INFO (zkConnectionManagerCallback-5701-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2291463 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2291473 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44477/solr
[junit4] 2> 2291474 INFO (zkConnectionManagerCallback-5705-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2291477 INFO
(zkConnectionManagerCallback-5707-thread-1-processing-n:127.0.0.1:59993_solr)
[n:127.0.0.1:59993_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2291484 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:59993_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 2291486 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:59993_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2291489 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:59993_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:59993_solr
[junit4] 2> 2291491 INFO (zkCallback-5659-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2291491 INFO
(zkCallback-5698-thread-1-processing-n:127.0.0.1:52694_solr)
[n:127.0.0.1:52694_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2291491 INFO
(zkCallback-5685-thread-1-processing-n:127.0.0.1:58961_solr)
[n:127.0.0.1:58961_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2291491 INFO
(zkCallback-5672-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2291491 INFO
(zkCallback-5680-thread-1-processing-n:127.0.0.1:58961_solr)
[n:127.0.0.1:58961_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2291491 INFO
(zkCallback-5693-thread-1-processing-n:127.0.0.1:52694_solr)
[n:127.0.0.1:52694_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2291491 INFO
(zkCallback-5667-thread-2-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2291503 INFO
(zkCallback-5706-thread-1-processing-n:127.0.0.1:59993_solr)
[n:127.0.0.1:59993_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2291567 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:59993_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_59993.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2291603 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:59993_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_59993.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2291603 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:59993_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_59993.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@587527c
[junit4] 2> 2291605 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:59993_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.3/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderVoteWaitTimeoutTest_47275CC5ADF98B96-001/tempDir-001/node4/.
[junit4] 2> 2291609 INFO
(zkConnectionManagerCallback-5712-thread-1-processing-n:127.0.0.1:59993_solr)
[n:127.0.0.1:59993_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2291610 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:59993_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 2291611 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker)
[n:127.0.0.1:59993_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:44477/solr ready
[junit4] 2> 2291681 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.LeaderVoteWaitTimeoutTest Adding proxy for URL:
https://127.0.0.1:45905/solr. Proxy: https://127.0.0.1:59993/solr
[junit4] 2> 2291714 INFO
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[47275CC5ADF98B96])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testMostInSyncReplicasCanWinElection
[junit4] 2> 2291716 INFO (SocketProxy-Acceptor-34744) [ ]
o.a.s.c.SocketProxy accepted
Socket[addr=/127.0.0.1,port=37767,localport=34744], receiveBufferSize:531000
[junit4] 2> 2291717 INFO (SocketProxy-Acceptor-34744) [ ]
o.a.s.c.SocketProxy proxy connection
Socket[addr=/127.0.0.1,port=52914,localport=43667], receiveBufferSize=530904
[junit4] 2> 2291774 INFO (qtp784271788-18875) [n:127.0.0.1:34744_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
pullReplicas=0&replicationFactor=3&name=collection1&nrtReplicas=3&action=CREATE&numShards=1&tlogReplicas=0&createNodeSet=&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2291776 INFO
(OverseerThreadFactory-5671-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
collection1
[junit4] 2> 2291778 INFO
(OverseerThreadFactory-5671-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/managed-schema to
/configs/collection1.AUTOCREATED/managed-schema
[junit4] 2> 2291781 INFO
(OverseerThreadFactory-5671-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/protwords.txt to
/configs/collection1.AUTOCREATED/protwords.txt
[junit4] 2> 2291783 INFO
(OverseerThreadFactory-5671-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/solrconfig.xml to
/configs/collection1.AUTOCREATED/solrconfig.xml
[junit4] 2> 2291785 INFO
(OverseerThreadFactory-5671-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/synonyms.txt to /configs/collection1.AUTOCREATED/synonyms.txt
[junit4] 2> 2291787 INFO
(OverseerThreadFactory-5671-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/stopwords.txt to
/configs/collection1.AUTOCREATED/stopwords.txt
[junit4] 2> 2291789 INFO
(OverseerThreadFactory-5671-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_it.txt to
/configs/collection1.AUTOCREATED/lang/contractions_it.txt
[junit4] 2> 2291791 INFO
(OverseerThreadFactory-5671-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_ca.txt to
/configs/collection1.AUTOCREATED/lang/contractions_ca.txt
[junit4] 2> 2291793 INFO
(OverseerThreadFactory-5671-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stemdict_nl.txt to
/configs/collection1.AUTOCREATED/lang/stemdict_nl.txt
[junit4] 2> 2291795 INFO
(OverseerThreadFactory-5671-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_no.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_no.txt
[junit4] 2> 2291797 INFO
(OverseerThreadFactory-5671-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_hy.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_hy.txt
[junit4] 2> 2291799 INFO
(OverseerThreadFactory-5671-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_id.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_id.txt
[junit4] 2> 2291801 INFO
(OverseerThreadFactory-5671-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_hi.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_hi.txt
[junit4] 2> 2291803 INFO
(OverseerThreadFactory-5671-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ga.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_ga.txt
[junit4] 2> 2291805 INFO
(OverseerThreadFactory-5671-thread-1-processing-n:127.0.0.1:34744_solr)
[n:127.0.0.1:34744_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_da.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_da.txt
[junit4] 2> 2291806 INFO (OverseerThread
[...truncated too long message...]
: [WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [0])
[junit4] 2> 2299128 INFO
(zkCallback-5693-thread-1-processing-n:127.0.0.1:52694_solr)
[n:127.0.0.1:52694_solr c:collection1 s:shard1 r:core_node66
x:collection1_shard1_replica_n65] o.a.s.c.SolrCore
[collection1_shard1_replica_n65] CLOSING SolrCore
org.apache.solr.core.SolrCore@24d70bd7
[junit4] 2> 2299129 INFO
(zkCallback-5693-thread-1-processing-n:127.0.0.1:52694_solr)
[n:127.0.0.1:52694_solr c:collection1 s:shard1 r:core_node66
x:collection1_shard1_replica_n65] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.collection1.shard1.replica_n65, tag=618073047
[junit4] 2> 2299129 INFO
(zkCallback-5693-thread-1-processing-n:127.0.0.1:52694_solr)
[n:127.0.0.1:52694_solr c:collection1 s:shard1 r:core_node66
x:collection1_shard1_replica_n65] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1c523062: rootName =
solr_52694, domain = solr.core.collection1.shard1.replica_n65, service url =
null, agent id = null] for registry solr.core.collection1.shard1.replica_n65 /
com.codahale.metrics.MetricRegistry@4f8b844c
[junit4] 2> 2299164 INFO
(zkCallback-5693-thread-1-processing-n:127.0.0.1:52694_solr)
[n:127.0.0.1:52694_solr c:collection1 s:shard1 r:core_node66
x:collection1_shard1_replica_n65] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.collection1.shard1.leader, tag=618073047
[junit4] 2> 2303911 ERROR
(recoveryExecutor-5677-thread-1-processing-n:127.0.0.1:58961_solr
x:collection1_shard1_replica_n63 s:shard1 c:collection1 r:core_node64)
[n:127.0.0.1:58961_solr c:collection1 s:shard1 r:core_node64
x:collection1_shard1_replica_n63] o.a.s.c.RecoveryStrategy SolrCore not found -
cannot recover:collection1_shard1_replica_n63
[junit4] 2> 2303912 WARN
(updateExecutor-5676-thread-2-processing-n:127.0.0.1:58961_solr
x:collection1_shard1_replica_n63 s:shard1 c:collection1 r:core_node64)
[n:127.0.0.1:58961_solr c:collection1 s:shard1 r:core_node64
x:collection1_shard1_replica_n63] o.a.s.u.DefaultSolrCoreState Skipping
recovery because Solr is shutdown
[junit4] 2> 2303912 INFO (jetty-closer-5600-thread-2) [ ]
o.a.s.c.Overseer Overseer
(id=73737058647670809-127.0.0.1:58961_solr-n_0000000005) closing
[junit4] 2> 2303913 INFO
(OverseerStateUpdate-73737058647670809-127.0.0.1:58961_solr-n_0000000005)
[n:127.0.0.1:58961_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:58961_solr
[junit4] 2> 2303913 WARN
(OverseerAutoScalingTriggerThread-73737058647670809-127.0.0.1:58961_solr-n_0000000005)
[n:127.0.0.1:58961_solr ] o.a.s.c.a.OverseerTriggerThread
OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 2303922 INFO
(zkCallback-5693-thread-1-processing-n:127.0.0.1:52694_solr)
[n:127.0.0.1:52694_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:52694_solr
[junit4] 2> 2303923 INFO (jetty-closer-5600-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@1e4f65ca{/solr,null,UNAVAILABLE}
[junit4] 2> 2303923 INFO (jetty-closer-5600-thread-2) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 2306250 ERROR
(recoveryExecutor-5690-thread-1-processing-n:127.0.0.1:52694_solr
x:collection1_shard1_replica_n65 s:shard1 c:collection1 r:core_node66)
[n:127.0.0.1:52694_solr c:collection1 s:shard1 r:core_node66
x:collection1_shard1_replica_n65] o.a.s.c.RecoveryStrategy SolrCore not found -
cannot recover:collection1_shard1_replica_n65
[junit4] 2> 2306253 INFO (jetty-closer-5600-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@15e60155{/solr,null,UNAVAILABLE}
[junit4] 2> 2306254 INFO (jetty-closer-5600-thread-1) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 2306255 ERROR
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-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> 2306255 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[47275CC5ADF98B96]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:44477 44477
[junit4] 2> 2306355 INFO (Thread-5145) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:44477 44477
[junit4] 2> 2306356 WARN (Thread-5145) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 30 /solr/collections/collection1/terms/shard1
[junit4] 2> 17 /solr/aliases.json
[junit4] 2> 8 /solr/security.json
[junit4] 2> 3
/solr/configs/collection1.AUTOCREATED/managed-schema
[junit4] 2> 3 /solr/configs/collection1.AUTOCREATED
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 37 /solr/collections/collection1/state.json
[junit4] 2> 17 /solr/clusterprops.json
[junit4] 2> 17 /solr/clusterstate.json
[junit4] 2> 5 /solr/autoscaling.json
[junit4] 2> 2
/solr/overseer_elect/election/73737058647670795-127.0.0.1:47353_solr-n_0000000002
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 17 /solr/live_nodes
[junit4] 2> 17 /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:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.3/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderVoteWaitTimeoutTest_47275CC5ADF98B96-001
[junit4] 2> NOTE: test params are:
codec=FastDecompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST_DECOMPRESSION,
chunkSize=5, maxDocsPerChunk=650, blockSize=42),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION,
chunkSize=5, blockSize=42)), sim=RandomSimilarity(queryNorm=true): {},
locale=fr-FR, timezone=Zulu
[junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation
1.8.0_172 (64-bit)/cpus=4,threads=1,free=182183256,total=527958016
[junit4] 2> NOTE: All tests run in this JVM: [SubstringBytesRefFilterTest,
FacetPivotSmallTest, TestDFRSimilarityFactory, TestClusterStateMutator,
NotRequiredUniqueKeyTest, SolrCmdDistributorTest, TestValueSourceCache,
HdfsChaosMonkeyNothingIsSafeTest, ReturnFieldsTest, SolrXmlInZkTest,
SearchHandlerTest, TestXmlQParserPlugin, AutoAddReplicasIntegrationTest,
HdfsRecoverLeaseTest, DataDrivenBlockJoinTest, TestHttpShardHandlerFactory,
ShufflingReplicaListTransformerTest, TestDistributedMissingSort,
BlockJoinFacetDistribTest, TermVectorComponentTest, ClusterStateTest,
TestJettySolrRunner, LeaderElectionTest, RollingRestartTest,
TestFieldCollectionResource, FileBasedSpellCheckerTest, TestStreamBody,
RegexBoostProcessorTest, TestStressReorder, TestCodecSupport,
DistanceFunctionTest, HttpPartitionOnCommitTest,
DeleteLastCustomShardedReplicaTest, TestLegacyNumericUtils,
CoreAdminRequestStatusTest, TestAuthorizationFramework,
AsyncCallRequestStatusResponseTest, TestLocalFSCloudBackupRestore,
TestSortableTextField, TestFastWriter, TestLMJelinekMercerSimilarityFactory,
TestManagedSchema, TestManagedResourceStorage, BlobRepositoryCloudTest,
TestSQLHandler, DirectSolrSpellCheckerTest, ConvertedLegacyTest,
TestSolrQueryResponse, TestConfigReload, DocValuesMissingTest,
DistributedFacetPivotSmallAdvancedTest, MoveReplicaHDFSTest, TestCollectionAPI,
TestDocBasedVersionConstraints, TestMiniSolrCloudClusterSSL,
TestLegacyNumericRangeQueryBuilder, TestFaceting,
TlogReplayBufferedWhileIndexingTest, ConcurrentCreateRoutedAliasTest,
CacheHeaderTest, TestCustomDocTransformer, ZkFailoverTest,
TestCloudDeleteByQuery, CheckHdfsIndexTest, TestMultiWordSynonyms,
SolrJmxReporterCloudTest, ConfigureRecoveryStrategyTest,
TestCollapseQParserPlugin, UnloadDistributedZkTest, CollectionPropsTest,
TestSizeLimitedDistributedMap, CdcrReplicationHandlerTest, AtomicUpdatesTest,
TestNRTOpen, TestAnalyzedSuggestions, ShowFileRequestHandlerTest,
ClusterStateUpdateTest, TestSubQueryTransformerCrossCore,
TestSimpleQParserPlugin, TestNumericTerms32, TestFiltering, TestJmxIntegration,
BasicAuthIntegrationTest, TestUpdate, DistributedFacetExistsSmallTest,
CollectionsAPIDistributedZkTest, TestRandomRequestDistribution,
DistributedQueryComponentCustomSortTest, TestSolrCloudSnapshots,
DocValuesMultiTest, TestFieldCacheVsDocValues, TestSSLRandomization,
TestStressUserVersions, ReplaceNodeTest, DocValuesTest,
TestClusterStateProvider, TestNumericRangeQuery32, TestUtils,
NoCacheHeaderTest, TestFieldTypeResource, TestPullReplica,
TestImplicitCoreProperties, TestRawResponseWriter, TestCloudSearcherWarming,
IndexSchemaRuntimeFieldTest, TestFieldCacheReopen, TestCustomSort,
TestSimDistributedQueue, BasicDistributedZk2Test, TestPointFields,
TestCopyFieldCollectionResource, TestSolrCoreProperties, TestCustomStream,
HDFSCollectionsAPITest, StatelessScriptUpdateProcessorFactoryTest,
SolrTestCaseJ4Test, MinimalSchemaTest, TimeZoneUtilsTest,
TestQuerySenderListener, NodeLostTriggerTest, CoreAdminHandlerTest,
PreAnalyzedFieldManagedSchemaCloudTest, TestExactSharedStatsCache,
CircularListTest, SolrCoreMetricManagerTest, BinaryUpdateRequestHandlerTest,
CSVRequestHandlerTest, TestLFUCache, ChaosMonkeySafeLeaderWithPullReplicasTest,
CloudExitableDirectoryReaderTest, DeleteInactiveReplicaTest, DeleteShardTest,
DistribCursorPagingTest, DistributedVersionInfoTest, LeaderVoteWaitTimeoutTest]
[junit4] Completed [531/783 (1!)] on J2 in 17.82s, 2 tests, 1 failure, 1
error <<< FAILURES!
[...truncated 50608 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
