Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/4656/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseSerialGC
2 tests failed.
FAILED:
org.apache.solr.cloud.LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection
Error Message:
Timeout waiting for new leader null Live Nodes: [127.0.0.1:54576_solr,
127.0.0.1:54582_solr, 127.0.0.1:54588_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":"http://127.0.0.1:54568/solr";,
"node_name":"127.0.0.1:54568_solr", "state":"down",
"type":"NRT", "force_set_state":"false"}, "core_node64":{
"core":"collection1_shard1_replica_n63",
"base_url":"http://127.0.0.1:54576/solr";,
"node_name":"127.0.0.1:54576_solr", "state":"active",
"type":"NRT", "force_set_state":"false"}, "core_node66":{
"core":"collection1_shard1_replica_n65",
"base_url":"http://127.0.0.1:54582/solr";,
"node_name":"127.0.0.1:54582_solr", "state":"active",
"type":"NRT", "force_set_state":"false"}}}},
"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:54576_solr, 127.0.0.1:54582_solr, 127.0.0.1:54588_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":"http://127.0.0.1:54568/solr";,
"node_name":"127.0.0.1:54568_solr",
"state":"down",
"type":"NRT",
"force_set_state":"false"},
"core_node64":{
"core":"collection1_shard1_replica_n63",
"base_url":"http://127.0.0.1:54576/solr";,
"node_name":"127.0.0.1:54576_solr",
"state":"active",
"type":"NRT",
"force_set_state":"false"},
"core_node66":{
"core":"collection1_shard1_replica_n65",
"base_url":"http://127.0.0.1:54582/solr";,
"node_name":"127.0.0.1:54582_solr",
"state":"active",
"type":"NRT",
"force_set_state":"false"}}}},
"router":{"name":"compositeId"},
"maxShardsPerNode":"1",
"autoAddReplicas":"false",
"nrtReplicas":"3",
"tlogReplicas":"0"}
at
__randomizedtesting.SeedInfo.seed([E2917A40304F9AD3:4A8D66FAF20FAEF9]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCase.java:278)
at
org.apache.solr.cloud.LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection(LeaderVoteWaitTimeoutTest.java:187)
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([E2917A40304F9AD3:10656D2274EA97E0]:0)
at
org.apache.solr.client.solrj.embedded.JettySolrRunner.getNodeName(JettySolrRunner.java:347)
at
org.apache.solr.cloud.LeaderVoteWaitTimeoutTest.basicTest(LeaderVoteWaitTimeoutTest.java:93)
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 12302 lines...]
[junit4] Suite: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest
[junit4] 2> 30039 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_E2917A40304F9AD3-001/init-core-data-001
[junit4] 2> 30040 WARN
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4
[junit4] 2> 30040 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 30044 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
w/ MAC_OS_X supressed clientAuth
[junit4] 2> 30054 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_E2917A40304F9AD3-001/tempDir-001
[junit4] 2> 30073 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 30078 INFO (Thread-5) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 30079 INFO (Thread-5) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 30289 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:54539
[junit4] 2> 30410 ERROR (Thread-5) [ ] 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> 30540 INFO (zkConnectionManagerCallback-12-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 31235 INFO (jetty-launcher-9-thread-1) [ ] o.e.j.s.Server
jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git:
daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
[junit4] 2> 31235 INFO (jetty-launcher-9-thread-4) [ ] o.e.j.s.Server
jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git:
daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
[junit4] 2> 31235 INFO (jetty-launcher-9-thread-3) [ ] o.e.j.s.Server
jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git:
daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
[junit4] 2> 31235 INFO (jetty-launcher-9-thread-2) [ ] o.e.j.s.Server
jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git:
daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
[junit4] 2> 31297 INFO (jetty-launcher-9-thread-4) [ ] o.e.j.s.session
DefaultSessionIdManager workerName=node0
[junit4] 2> 31297 INFO (jetty-launcher-9-thread-4) [ ] o.e.j.s.session
No SessionScavenger set, using defaults
[junit4] 2> 31309 INFO (jetty-launcher-9-thread-4) [ ] o.e.j.s.session
node0 Scavenging every 660000ms
[junit4] 2> 31310 INFO (jetty-launcher-9-thread-3) [ ] o.e.j.s.session
DefaultSessionIdManager workerName=node0
[junit4] 2> 31310 INFO (jetty-launcher-9-thread-3) [ ] o.e.j.s.session
No SessionScavenger set, using defaults
[junit4] 2> 31310 INFO (jetty-launcher-9-thread-3) [ ] o.e.j.s.session
node0 Scavenging every 660000ms
[junit4] 2> 31315 INFO (jetty-launcher-9-thread-1) [ ] o.e.j.s.session
DefaultSessionIdManager workerName=node0
[junit4] 2> 31316 INFO (jetty-launcher-9-thread-1) [ ] o.e.j.s.session
No SessionScavenger set, using defaults
[junit4] 2> 31316 INFO (jetty-launcher-9-thread-1) [ ] o.e.j.s.session
node0 Scavenging every 660000ms
[junit4] 2> 31331 INFO (jetty-launcher-9-thread-2) [ ] o.e.j.s.session
DefaultSessionIdManager workerName=node0
[junit4] 2> 31380 INFO (jetty-launcher-9-thread-2) [ ] o.e.j.s.session
No SessionScavenger set, using defaults
[junit4] 2> 31380 INFO (jetty-launcher-9-thread-2) [ ] o.e.j.s.session
node0 Scavenging every 660000ms
[junit4] 2> 31385 INFO (jetty-launcher-9-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@3828b777{/solr,null,AVAILABLE}
[junit4] 2> 31386 INFO (jetty-launcher-9-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1b895281{/solr,null,AVAILABLE}
[junit4] 2> 31392 INFO (jetty-launcher-9-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6bcb7cee{/solr,null,AVAILABLE}
[junit4] 2> 31393 INFO (jetty-launcher-9-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@4ab4a7ec{/solr,null,AVAILABLE}
[junit4] 2> 31440 INFO (jetty-launcher-9-thread-4) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@6c25f2d7{HTTP/1.1,[http/1.1]}{127.0.0.1:54543}
[junit4] 2> 31441 INFO (jetty-launcher-9-thread-4) [ ] o.e.j.s.Server
Started @31523ms
[junit4] 2> 31441 INFO (jetty-launcher-9-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=54543}
[junit4] 2> 31447 INFO (jetty-launcher-9-thread-2) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@719fa609{HTTP/1.1,[http/1.1]}{127.0.0.1:54544}
[junit4] 2> 31447 INFO (jetty-launcher-9-thread-2) [ ] o.e.j.s.Server
Started @31529ms
[junit4] 2> 31447 INFO (jetty-launcher-9-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=54544}
[junit4] 2> 31449 INFO (jetty-launcher-9-thread-1) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@324a31f4{HTTP/1.1,[http/1.1]}{127.0.0.1:54545}
[junit4] 2> 31450 INFO (jetty-launcher-9-thread-1) [ ] o.e.j.s.Server
Started @31532ms
[junit4] 2> 31450 INFO (jetty-launcher-9-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=54545}
[junit4] 2> 31473 INFO (jetty-launcher-9-thread-3) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@477795c4{HTTP/1.1,[http/1.1]}{127.0.0.1:54542}
[junit4] 2> 31474 INFO (jetty-launcher-9-thread-3) [ ] o.e.j.s.Server
Started @31556ms
[junit4] 2> 31474 INFO (jetty-launcher-9-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=54542}
[junit4] 2> 31535 INFO (jetty-launcher-9-thread-4) [ ]
o.a.s.u.c.SSLCredentialProviderFactory Processing SSL Credential Provider
chain: env;sysprop
[junit4] 2> 31553 ERROR (jetty-launcher-9-thread-4) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 31553 INFO (jetty-launcher-9-thread-4) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 31553 INFO (jetty-launcher-9-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 31554 INFO (jetty-launcher-9-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 31554 INFO (jetty-launcher-9-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 31554 INFO (jetty-launcher-9-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-25T02:22:32.974Z
[junit4] 2> 31555 ERROR (jetty-launcher-9-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 31555 INFO (jetty-launcher-9-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 31555 INFO (jetty-launcher-9-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 31555 INFO (jetty-launcher-9-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 31555 INFO (jetty-launcher-9-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 31555 INFO (jetty-launcher-9-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-25T02:22:32.975Z
[junit4] 2> 31556 ERROR (jetty-launcher-9-thread-3) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 31556 INFO (jetty-launcher-9-thread-3) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 31556 ERROR (jetty-launcher-9-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 31556 INFO (jetty-launcher-9-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 31556 INFO (jetty-launcher-9-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 31556 INFO (jetty-launcher-9-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 31556 INFO (jetty-launcher-9-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 31556 INFO (jetty-launcher-9-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-25T02:22:32.976Z
[junit4] 2> 31556 INFO (jetty-launcher-9-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 31556 INFO (jetty-launcher-9-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 31556 INFO (jetty-launcher-9-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 31556 INFO (jetty-launcher-9-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-25T02:22:32.976Z
[junit4] 2> 31564 INFO (zkConnectionManagerCallback-14-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 31564 INFO (zkConnectionManagerCallback-18-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 31564 INFO (zkConnectionManagerCallback-16-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 31581 INFO (jetty-launcher-9-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 31581 INFO (zkConnectionManagerCallback-20-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 31584 INFO (jetty-launcher-9-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 31607 INFO (jetty-launcher-9-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 31619 INFO (jetty-launcher-9-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 31670 INFO (jetty-launcher-9-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54539/solr
[junit4] 2> 31671 INFO (jetty-launcher-9-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54539/solr
[junit4] 2> 31671 INFO (jetty-launcher-9-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54539/solr
[junit4] 2> 31682 INFO (jetty-launcher-9-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54539/solr
[junit4] 2> 31726 INFO (zkConnectionManagerCallback-32-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 31726 INFO (zkConnectionManagerCallback-34-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 31726 INFO (zkConnectionManagerCallback-36-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 31727 INFO (zkConnectionManagerCallback-30-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 31745 INFO (zkConnectionManagerCallback-38-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 31745 INFO (zkConnectionManagerCallback-40-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 31747 INFO (zkConnectionManagerCallback-44-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 31747 INFO (zkConnectionManagerCallback-42-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 32232 INFO (jetty-launcher-9-thread-3)
[n:127.0.0.1:54542_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 32232 INFO (jetty-launcher-9-thread-4)
[n:127.0.0.1:54543_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 32233 INFO (jetty-launcher-9-thread-1)
[n:127.0.0.1:54545_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 32233 INFO (jetty-launcher-9-thread-2)
[n:127.0.0.1:54544_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 32235 INFO (jetty-launcher-9-thread-3)
[n:127.0.0.1:54542_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:54542_solr
[junit4] 2> 32239 INFO (jetty-launcher-9-thread-3)
[n:127.0.0.1:54542_solr ] o.a.s.c.Overseer Overseer
(id=72083277747257354-127.0.0.1:54542_solr-n_0000000000) starting
[junit4] 2> 32240 INFO (jetty-launcher-9-thread-1)
[n:127.0.0.1:54545_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:54545_solr
[junit4] 2> 32240 INFO (jetty-launcher-9-thread-2)
[n:127.0.0.1:54544_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:54544_solr
[junit4] 2> 32240 INFO (jetty-launcher-9-thread-4)
[n:127.0.0.1:54543_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:54543_solr
[junit4] 2> 32298 INFO (zkCallback-39-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 32302 INFO (zkCallback-41-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 32303 INFO (zkCallback-43-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 32303 INFO (zkCallback-37-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 32604 INFO (zkConnectionManagerCallback-57-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 32621 INFO (jetty-launcher-9-thread-3)
[n:127.0.0.1:54542_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 32627 INFO (jetty-launcher-9-thread-3)
[n:127.0.0.1:54542_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:54539/solr ready
[junit4] 2> 33017 INFO (jetty-launcher-9-thread-3)
[n:127.0.0.1:54542_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 33017 INFO (jetty-launcher-9-thread-3)
[n:127.0.0.1:54542_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:54542_solr
[junit4] 2> 33022 INFO (zkCallback-43-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 33022 INFO (zkCallback-37-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 33023 INFO (zkCallback-41-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 33024 INFO (zkCallback-56-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 33025 INFO
(OverseerStateUpdate-72083277747257354-127.0.0.1:54542_solr-n_0000000000) [
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 33492 INFO (jetty-launcher-9-thread-1)
[n:127.0.0.1:54545_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54545.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 33493 INFO (jetty-launcher-9-thread-1)
[n:127.0.0.1:54545_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54545.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 33493 INFO (jetty-launcher-9-thread-1)
[n:127.0.0.1:54545_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54545.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 33499 INFO (jetty-launcher-9-thread-1)
[n:127.0.0.1:54545_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_E2917A40304F9AD3-001/tempDir-001/node1/.
[junit4] 2> 33505 INFO (jetty-launcher-9-thread-2)
[n:127.0.0.1:54544_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54544.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 33518 INFO (jetty-launcher-9-thread-2)
[n:127.0.0.1:54544_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54544.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 33518 INFO (jetty-launcher-9-thread-2)
[n:127.0.0.1:54544_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54544.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 33520 INFO (jetty-launcher-9-thread-2)
[n:127.0.0.1:54544_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_E2917A40304F9AD3-001/tempDir-001/node2/.
[junit4] 2> 33562 INFO (zkConnectionManagerCallback-65-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 33565 INFO (zkConnectionManagerCallback-67-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 33574 INFO (jetty-launcher-9-thread-1)
[n:127.0.0.1:54545_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 33575 INFO (jetty-launcher-9-thread-2)
[n:127.0.0.1:54544_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 33577 INFO (jetty-launcher-9-thread-1)
[n:127.0.0.1:54545_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:54539/solr ready
[junit4] 2> 33579 INFO (jetty-launcher-9-thread-2)
[n:127.0.0.1:54544_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:54539/solr ready
[junit4] 2> 33677 INFO (jetty-launcher-9-thread-4)
[n:127.0.0.1:54543_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54543.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 33681 INFO (jetty-launcher-9-thread-4)
[n:127.0.0.1:54543_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54543.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 33681 INFO (jetty-launcher-9-thread-4)
[n:127.0.0.1:54543_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54543.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 33704 INFO (jetty-launcher-9-thread-3)
[n:127.0.0.1:54542_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54542.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 33708 INFO (jetty-launcher-9-thread-3)
[n:127.0.0.1:54542_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54542.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 33708 INFO (jetty-launcher-9-thread-3)
[n:127.0.0.1:54542_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54542.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 33709 INFO (jetty-launcher-9-thread-4)
[n:127.0.0.1:54543_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_E2917A40304F9AD3-001/tempDir-001/node4/.
[junit4] 2> 33709 INFO (jetty-launcher-9-thread-3)
[n:127.0.0.1:54542_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_E2917A40304F9AD3-001/tempDir-001/node3/.
[junit4] 2> 33742 INFO (zkConnectionManagerCallback-72-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 33746 INFO (jetty-launcher-9-thread-4)
[n:127.0.0.1:54543_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 33748 INFO (jetty-launcher-9-thread-4)
[n:127.0.0.1:54543_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:54539/solr ready
[junit4] 2> 34154 INFO (zkConnectionManagerCallback-74-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 34164 INFO (zkConnectionManagerCallback-79-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 34168 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 34172 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:54539/solr ready
[junit4] 2> 34206 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@6c25f2d7{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 34207 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=887163033
[junit4] 2> 34207 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 34208 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1fafba28: rootName =
solr_54543, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@3b7be84c
[junit4] 2> 34215 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 34215 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6ba5aba2: rootName =
solr_54543, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@2bfee2d9
[junit4] 2> 34227 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 34227 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5b19aeb9: rootName =
solr_54543, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@2225df86
[junit4] 2> 34231 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:54543_solr
[junit4] 2> 34236 INFO (zkCallback-56-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 34236 INFO (zkCallback-41-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 34236 INFO (zkCallback-43-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 34237 INFO (zkCallback-39-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 34236 INFO (zkCallback-37-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 34241 INFO (zkCallback-71-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 34241 INFO (zkCallback-66-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 34241 INFO (zkCallback-78-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 34242 INFO (zkCallback-64-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 34243 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 34243 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 34260 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@1b895281{/solr,null,UNAVAILABLE}
[junit4] 2> 34260 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 34265 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git:
daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
[junit4] 2> 34267 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 34267 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 34267 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 34267 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@c2cf71b{/solr,null,AVAILABLE}
[junit4] 2> 34269 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@58eb41e6{HTTP/1.1,[http/1.1]}{127.0.0.1:54569}
[junit4] 2> 34269 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.Server Started @34351ms
[junit4] 2> 34269 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=54568}
[junit4] 2> 34269 ERROR
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 34269 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 34270 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 34270 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 34270 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 34270 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-25T02:22:35.690Z
[junit4] 2> 34275 INFO (zkConnectionManagerCallback-81-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 34277 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 34299 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54539/solr
[junit4] 2> 34305 INFO (zkConnectionManagerCallback-85-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 34313 INFO (zkConnectionManagerCallback-87-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 34334 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54568_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 34341 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54568_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 34347 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54568_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 34347 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54568_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:54568_solr
[junit4] 2> 34351 INFO (zkCallback-41-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 34351 INFO (zkCallback-64-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 34351 INFO (zkCallback-39-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 34351 INFO (zkCallback-56-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 34351 INFO (zkCallback-37-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 34351 INFO (zkCallback-78-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 34351 INFO (zkCallback-66-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 34352 INFO (zkCallback-86-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 34587 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54568_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54568.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 34649 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54568_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54568.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 34649 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54568_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54568.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 34651 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54568_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_E2917A40304F9AD3-001/tempDir-001/node4/.
[junit4] 2> 34659 INFO (zkConnectionManagerCallback-94-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 34663 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54568_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 34666 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54568_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:54539/solr ready
[junit4] 2> 34781 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.LeaderVoteWaitTimeoutTest Adding proxy for URL:
http://127.0.0.1:54569/solr. Proxy: http://127.0.0.1:54568/solr
[junit4] 2> 34783 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@324a31f4{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 34783 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=50675663
[junit4] 2> 34788 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 34789 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4cce411: rootName =
solr_54545, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@5165cb76
[junit4] 2> 34798 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 34798 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@43039fba: rootName =
solr_54545, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@2bfee2d9
[junit4] 2> 34803 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 34803 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7fc21a8d: rootName =
solr_54545, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@2225df86
[junit4] 2> 34807 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:54545_solr
[junit4] 2> 34811 INFO (zkCallback-37-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 34811 INFO (zkCallback-39-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 34811 INFO (zkCallback-56-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 34811 INFO (zkCallback-41-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 34811 INFO (zkCallback-78-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 34811 INFO (zkCallback-66-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 34811 INFO (zkCallback-86-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 34811 INFO (zkCallback-64-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 34812 INFO (zkCallback-93-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 34814 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 34816 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 34830 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@4ab4a7ec{/solr,null,UNAVAILABLE}
[junit4] 2> 34830 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 34832 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git:
daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
[junit4] 2> 34834 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 34834 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 34834 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 34834 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@59faf4a1{/solr,null,AVAILABLE}
[junit4] 2> 34835 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@1853c2b9{HTTP/1.1,[http/1.1]}{127.0.0.1:54577}
[junit4] 2> 34836 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.Server Started @34918ms
[junit4] 2> 34836 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=54576}
[junit4] 2> 34836 ERROR
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 34836 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 34836 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 34836 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 34837 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 34837 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-25T02:22:36.257Z
[junit4] 2> 34840 INFO (zkConnectionManagerCallback-96-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 34842 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 34863 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54539/solr
[junit4] 2> 34866 INFO (zkConnectionManagerCallback-100-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 34873 INFO (zkConnectionManagerCallback-102-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 34897 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54576_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 34906 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54576_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 34913 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54576_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 34913 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54576_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:54576_solr
[junit4] 2> 34917 INFO (zkCallback-56-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 34917 INFO (zkCallback-66-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 34917 INFO (zkCallback-78-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 34917 INFO (zkCallback-86-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 34918 INFO (zkCallback-37-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 34918 INFO (zkCallback-93-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 34920 INFO (zkCallback-101-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 34921 INFO (zkCallback-39-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 35208 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54576_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54576.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 35221 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54576_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54576.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 35222 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54576_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54576.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 35229 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54576_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_E2917A40304F9AD3-001/tempDir-001/node1/.
[junit4] 2> 35236 INFO (zkConnectionManagerCallback-109-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 35240 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54576_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 35244 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54576_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:54539/solr ready
[junit4] 2> 35340 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.LeaderVoteWaitTimeoutTest Adding proxy for URL:
http://127.0.0.1:54577/solr. Proxy: http://127.0.0.1:54576/solr
[junit4] 2> 35341 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@477795c4{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 35342 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1719358010
[junit4] 2> 35342 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 35343 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@f0b4e49: rootName =
solr_54542, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@2b2628c1
[junit4] 2> 35352 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 35352 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1e206cb5: rootName =
solr_54542, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@2bfee2d9
[junit4] 2> 35358 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 35359 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5fd12d24: rootName =
solr_54542, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@2225df86
[junit4] 2> 35367 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:54542_solr
[junit4] 2> 35372 INFO (zkCallback-66-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 35373 INFO (zkCallback-37-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 35373 INFO (zkCallback-39-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 35373 INFO (zkCallback-93-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 35373 INFO (zkCallback-78-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 35373 INFO (zkCallback-86-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 35373 INFO (zkCallback-56-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 35373 INFO (zkCallback-101-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 35377 INFO (zkCallback-108-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 35388 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 35394 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.Overseer Overseer
(id=72083277747257354-127.0.0.1:54542_solr-n_0000000000) closing
[junit4] 2> 35395 INFO
(OverseerStateUpdate-72083277747257354-127.0.0.1:54542_solr-n_0000000000) [
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:54542_solr
[junit4] 2> 35426 WARN
(OverseerAutoScalingTriggerThread-72083277747257354-127.0.0.1:54542_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we
are closed, exiting.
[junit4] 2> 35434 INFO (zkCallback-37-thread-1) [ ]
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:54544_solr
[junit4] 2> 35435 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@3828b777{/solr,null,UNAVAILABLE}
[junit4] 2> 35435 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 35437 INFO (zkCallback-37-thread-1) [ ] o.a.s.c.Overseer
Overseer (id=72083277747257353-127.0.0.1:54544_solr-n_0000000003) starting
[junit4] 2> 35438 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git:
daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
[junit4] 2> 35440 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 35440 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 35440 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 35441 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@482a1383{/solr,null,AVAILABLE}
[junit4] 2> 35450 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@2ca59ec8{HTTP/1.1,[http/1.1]}{127.0.0.1:54583}
[junit4] 2> 35450 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.Server Started @35533ms
[junit4] 2> 35451 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=54582}
[junit4] 2> 35466 ERROR
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 35538 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 35539 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 35540 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 35540 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 35540 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-25T02:22:36.960Z
[junit4] 2> 35544 INFO (zkConnectionManagerCallback-111-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 35547 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 35564 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54539/solr
[junit4] 2> 35571 INFO (zkConnectionManagerCallback-115-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 35583 INFO (zkConnectionManagerCallback-117-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 35601 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54582_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 35607 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54582_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 35617 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54582_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 35618 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54582_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:54582_solr
[junit4] 2> 35623 INFO (zkCallback-101-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 35624 INFO (zkCallback-108-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 35624 INFO (zkCallback-86-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 35624 INFO (zkCallback-37-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 35624 INFO (zkCallback-93-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 35624 INFO (zkCallback-66-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 35624 INFO (zkCallback-78-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 35625 INFO (zkCallback-116-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 35856 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54582_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54582.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 35870 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54582_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54582.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 35871 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54582_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54582.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 35873 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54582_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_E2917A40304F9AD3-001/tempDir-001/node3/.
[junit4] 2> 35886 INFO (zkConnectionManagerCallback-124-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 35890 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54582_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 35893 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54582_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:54539/solr ready
[junit4] 2> 36028 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.LeaderVoteWaitTimeoutTest Adding proxy for URL:
http://127.0.0.1:54583/solr. Proxy: http://127.0.0.1:54582/solr
[junit4] 2> 36037 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@719fa609{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 36038 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=539750970
[junit4] 2> 36039 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 36039 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@3ef1c96: rootName =
solr_54544, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@3fd33e96
[junit4] 2> 36048 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 36048 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@3c7a42c8: rootName =
solr_54544, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@2bfee2d9
[junit4] 2> 36058 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 36058 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5927816a: rootName =
solr_54544, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@2225df86
[junit4] 2> 36062 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:54544_solr
[junit4] 2> 36066 INFO (zkCallback-108-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 36067 INFO (zkCallback-66-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 36067 INFO (zkCallback-116-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 36067 INFO (zkCallback-93-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 36067 INFO (zkCallback-37-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 36067 INFO (zkCallback-101-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 36067 INFO (zkCallback-86-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 36067 INFO (zkCallback-78-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 36068 INFO (zkCallback-123-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 36070 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 36073 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 36080 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.Overseer Overseer
(id=72083277747257353-127.0.0.1:54544_solr-n_0000000003) closing
[junit4] 2> 36081 INFO
(OverseerStateUpdate-72083277747257353-127.0.0.1:54544_solr-n_0000000003) [
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:54544_solr
[junit4] 2> 36081 WARN
(OverseerAutoScalingTriggerThread-72083277747257353-127.0.0.1:54544_solr-n_0000000003)
[ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we
are closed, exiting.
[junit4] 2> 36090 INFO (zkCallback-86-thread-1) [ ]
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:54568_solr
[junit4] 2> 36093 INFO (zkCallback-86-thread-1) [ ] o.a.s.c.Overseer
Overseer (id=72083277747257365-127.0.0.1:54568_solr-n_0000000004) starting
[junit4] 2> 36094 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@6bcb7cee{/solr,null,UNAVAILABLE}
[junit4] 2> 36095 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 36124 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git:
daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
[junit4] 2> 36144 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 36145 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 36145 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 36150 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1277798b{/solr,null,AVAILABLE}
[junit4] 2> 36154 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@1078d988{HTTP/1.1,[http/1.1]}{127.0.0.1:54589}
[junit4] 2> 36154 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.e.j.s.Server Started @36237ms
[junit4] 2> 36154 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=54588}
[junit4] 2> 36156 ERROR
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 36156 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 36158 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 36158 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 36158 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 36158 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-25T02:22:37.578Z
[junit4] 2> 36163 INFO (zkConnectionManagerCallback-126-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 36165 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 36206 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54539/solr
[junit4] 2> 36240 INFO (zkConnectionManagerCallback-130-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 36251 INFO (zkConnectionManagerCallback-132-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 36296 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54588_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 36302 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54588_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 36312 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54588_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 36312 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54588_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:54588_solr
[junit4] 2> 36320 INFO (zkCallback-123-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 36320 INFO (zkCallback-93-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 36320 INFO (zkCallback-108-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 36320 INFO (zkCallback-101-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 36320 INFO (zkCallback-86-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 36320 INFO (zkCallback-78-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 36321 INFO (zkCallback-116-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 36321 INFO (zkCallback-131-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 36638 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54588_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54588.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 36673 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54588_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54588.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 36673 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54588_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_54588.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@297dba8a
[junit4] 2> 36694 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54588_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_E2917A40304F9AD3-001/tempDir-001/node2/.
[junit4] 2> 36708 INFO (zkConnectionManagerCallback-139-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 36714 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54588_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 36721 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker)
[n:127.0.0.1:54588_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:54539/solr ready
[junit4] 2> 36847 INFO
(SUITE-LeaderVoteWaitTimeoutTest-seed#[E2917A40304F9AD3]-worker) [ ]
o.a.s.c.LeaderVoteWaitTimeoutTest Adding proxy for URL:
http://127.0.0.1:54589/solr. Proxy: http://127.0.0.1:54588/solr
[junit4] 2> 36938 INFO
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[E2917A40304F9AD3])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testMostInSyncReplicasCanWinElection
[junit4] 2> 37447 INFO (SocketProxy-Acceptor-54568) [ ]
o.a.s.c.SocketProxy accepted
Socket[addr=/127.0.0.1,port=54594,localport=54568], receiveBufferSize:408300
[junit4] 2> 37498 INFO (SocketProxy-Acceptor-54568) [ ]
o.a.s.c.SocketProxy proxy connection
Socket[addr=/127.0.0.1,port=54569,localport=54595], receiveBufferSize=408300
[junit4] 2> 38538 INFO (qtp657487167-221) [n:127.0.0.1:54568_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> 38707 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.a.c.CreateCollectionCmd Create collection collection1
[junit4] 2> 38710 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to
/configs/collection1.AUTOCREATED/managed-schema
[junit4] 2> 38716 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to
/configs/collection1.AUTOCREATED/protwords.txt
[junit4] 2> 38721 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to
/configs/collection1.AUTOCREATED/solrconfig.xml
[junit4] 2> 38725 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to
/configs/collection1.AUTOCREATED/synonyms.txt
[junit4] 2> 38729 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to
/configs/collection1.AUTOCREATED/stopwords.txt
[junit4] 2> 38756 INFO (OverseerThreadFactory-120-thread-1) [ ]
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> 38765 INFO (OverseerThreadFactory-120-thread-1) [ ]
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> 38774 INFO (OverseerThreadFactory-120-thread-1) [ ]
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> 38784 INFO (OverseerThreadFactory-120-thread-1) [ ]
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> 38790 INFO (OverseerThreadFactory-120-thread-1) [ ]
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> 38796 INFO (OverseerThreadFactory-120-thread-1) [ ]
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> 38801 INFO (OverseerThreadFactory-120-thread-1) [ ]
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> 38831 INFO (OverseerThreadFactory-120-thread-1) [ ]
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> 38835 INFO (OverseerThreadFactory-120-thread-1) [ ]
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> 38840 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ja.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_ja.txt
[junit4] 2> 38844 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_pt.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_pt.txt
[junit4] 2> 38855 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_hu.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_hu.txt
[junit4] 2> 38860 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_el.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_el.txt
[junit4] 2> 38864 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ru.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_ru.txt
[junit4] 2> 38868 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_tr.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_tr.txt
[junit4] 2> 38873 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ar.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_ar.txt
[junit4] 2> 38877 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/userdict_ja.txt to
/configs/collection1.AUTOCREATED/lang/userdict_ja.txt
[junit4] 2> 38881 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_eu.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_eu.txt
[junit4] 2> 38885 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_it.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_it.txt
[junit4] 2> 38889 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_cz.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_cz.txt
[junit4] 2> 38893 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stoptags_ja.txt to
/configs/collection1.AUTOCREATED/lang/stoptags_ja.txt
[junit4] 2> 38897 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_fr.txt to
/configs/collection1.AUTOCREATED/lang/contractions_fr.txt
[junit4] 2> 38901 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_de.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_de.txt
[junit4] 2> 38905 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_fa.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_fa.txt
[junit4] 2> 38910 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_ga.txt to
/configs/collection1.AUTOCREATED/lang/contractions_ga.txt
[junit4] 2> 38914 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ca.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_ca.txt
[junit4] 2> 38918 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_nl.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_nl.txt
[junit4] 2> 38922 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_bg.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_bg.txt
[junit4] 2> 38926 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_en.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_en.txt
[junit4] 2> 38930 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_es.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_es.txt
[junit4] 2> 38934 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_lv.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_lv.txt
[junit4] 2> 38938 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ro.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_ro.txt
[junit4] 2> 38942 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_th.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_th.txt
[junit4] 2> 38946 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_fr.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_fr.txt
[junit4] 2> 38950 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_sv.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_sv.txt
[junit4] 2> 38956 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_fi.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_fi.txt
[junit4] 2> 38961 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/hyphenations_ga.txt to
/configs/collection1.AUTOCREATED/lang/hyphenations_ga.txt
[junit4] 2> 38965 INFO (OverseerThreadFactory-120-thread-1) [ ]
o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_gl.txt to
/configs/collection1.AUTOCREATED/lang/stopwords_gl.txt
[junit4] 2> 38969 INFO (OverseerThreadFactory-120-thread-1) [ ]
[...truncated too long message...]
s/test
common-solr.compile-test:
compile-test:
BUILD SUCCESSFUL
Total time: 1 minute 54 seconds
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5
-Dtests.class="*.LeaderVoteWaitTimeoutTest" -Dtests.showOutput=onerror
"-Dargs=-XX:-UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=E2917A40304F9AD3
-Dtests.slow=true -Dtests.locale=zh-TW -Dtests.timezone=US/Indiana-Starke
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
Buildfile:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/build.xml
-clover.disable:
ivy-configure:
[ivy:configure] :: Apache Ivy 2.4.0 - 20141213170938 ::
http://ant.apache.org/ivy/ ::
[ivy:configure] :: loading settings :: file =
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/lucene/top-level-ivy-settings.xml
install-junit4-taskdef:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
resolve-groovy:
[ivy:cachepath] :: resolving dependencies ::
org.codehaus.groovy#groovy-all-caller;working
[ivy:cachepath] confs: [default]
[ivy:cachepath] found org.codehaus.groovy#groovy-all;2.4.15 in public
[ivy:cachepath] :: resolution report :: resolve 31ms :: artifacts dl 1ms
---------------------------------------------------------------------
| | modules || artifacts |
| conf | number| search|dwnlded|evicted|| number|dwnlded|
---------------------------------------------------------------------
| default | 1 | 0 | 0 | 0 || 1 | 0 |
---------------------------------------------------------------------
-init-totals:
-test:
[mkdir] Created dir:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test
[junit4:pickseed] Seed property 'tests.seed' already defined: E2917A40304F9AD3
[mkdir] Created dir:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/temp
[junit4] <JUnit4> says ¡Hola! Master seed: E2917A40304F9AD3
[junit4] Executing 5 suites with 2 JVMs.
[junit4]
[junit4] Started J1 PID([email protected]).
[junit4] Started J0 PID([email protected]).
[junit4] Suite: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest
[junit4] OK 40.0s J1 |
LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection
[junit4] OK 12.3s J1 | LeaderVoteWaitTimeoutTest.basicTest
[junit4] Completed [1/5] on J1 in 75.68s, 2 tests
[junit4]
[junit4] Suite: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest
[junit4] OK 40.1s J0 |
LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection
[junit4] OK 14.6s J0 | LeaderVoteWaitTimeoutTest.basicTest
[junit4] Completed [2/5] on J0 in 78.10s, 2 tests
[junit4]
[junit4] Duplicate suite name used with XML reports:
org.apache.solr.cloud.LeaderVoteWaitTimeoutTest. This may confuse tools that
process XML reports. Set 'ignoreDuplicateSuites' to true to skip this message.
[junit4] Suite: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest
[junit4] OK 18.6s J0 |
LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection
[junit4] OK 11.7s J0 | LeaderVoteWaitTimeoutTest.basicTest
[junit4] Completed [3/5] on J0 in 36.23s, 2 tests
[junit4]
[junit4] Suite: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest
[junit4] OK 19.0s J1 |
LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection
[junit4] OK 16.0s J1 | LeaderVoteWaitTimeoutTest.basicTest
[junit4] Completed [4/5] on J1 in 43.21s, 2 tests
[junit4]
[junit4] Suite: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest
[junit4] OK 17.0s J0 |
LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection
[junit4] OK 11.1s J0 | LeaderVoteWaitTimeoutTest.basicTest
[junit4] Completed [5/5] on J0 in 33.78s, 2 tests
[junit4]
[junit4] JVM J0: 1.01 .. 151.62 = 150.62s
[junit4] JVM J1: 1.00 .. 122.78 = 121.77s
[junit4] Execution time total: 2 minutes 31 seconds
[junit4] Tests summary: 5 suites, 10 tests
[junit4] Could not remove temporary path:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1
(java.nio.file.DirectoryNotEmptyException: Remaining files:
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp])
[junit4] Could not remove temporary path:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0
(java.nio.file.DirectoryNotEmptyException: Remaining files:
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp])
[echo] 5 slowest tests:
[junit4:tophints] 177.61s |
org.apache.solr.cloud.autoscaling.SearchRateTriggerIntegrationTest
[junit4:tophints] 143.18s | org.apache.solr.cloud.api.collections.AssignTest
[junit4:tophints] 133.38s |
org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest
[junit4:tophints] 117.48s | org.apache.solr.update.SoftAutoCommitTest
[junit4:tophints] 113.63s | org.apache.solr.cloud.TestTlogReplica
-check-totals:
test-nocompile:
BUILD SUCCESSFUL
Total time: 2 minutes 36 seconds
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest
[repro] Exiting with code 0
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath$34.hasMatch(FilePath.java:2678)
at hudson.FilePath$34.invoke(FilePath.java:2557)
at hudson.FilePath$34.invoke(FilePath.java:2547)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:2918)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to MacOSX VBOX
at
hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1741)
at
hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:357)
at hudson.remoting.Channel.call(Channel.java:955)
at hudson.FilePath.act(FilePath.java:1036)
at hudson.FilePath.act(FilePath.java:1025)
at hudson.FilePath.validateAntFileMask(FilePath.java:2547)
at
hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
at
hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
at
hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at
hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
at
hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at
hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1819)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at
hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:2920)
at hudson.remoting.UserRequest.perform(UserRequest.java:212)
at hudson.remoting.UserRequest.perform(UserRequest.java:54)
at hudson.remoting.Request$2.run(Request.java:369)
at
hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no
matches found within 10000
at hudson.FilePath.act(FilePath.java:1038)
at hudson.FilePath.act(FilePath.java:1025)
at hudson.FilePath.validateAntFileMask(FilePath.java:2547)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
at
hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at
hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
at
hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at
hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1819)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
No artifacts found that match the file pattern
"**/*.events,heapdumps/**,**/*_pid*.log". Configuration error?
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all
warnings.
<Git Blamer> GIT_COMMIT=ad143a1ceceb1e1b40780db2c65bf437e2abc87d,
workspace=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX
[WARNINGS] Computing warning deltas based on reference build #4655
Recording test results
Setting
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
