Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/1951/
Java: 32bit/jdk1.8.0_172 -client -XX:+UseConcMarkSweepGC
4 tests failed.
FAILED: org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState
Error Message:
Did not expect the processor to fire on first run! event={
"id":"6fe15b62c6fbTd9tg4a0s2nyqqoj9b2xtxulkb", "source":"node_added_trigger",
"eventTime":123013691524859, "eventType":"NODEADDED", "properties":{
"eventTimes":[123013691524859], "nodeNames":["127.0.0.1:42829_solr"]}}
Stack Trace:
java.lang.AssertionError: Did not expect the processor to fire on first run!
event={
"id":"6fe15b62c6fbTd9tg4a0s2nyqqoj9b2xtxulkb",
"source":"node_added_trigger",
"eventTime":123013691524859,
"eventType":"NODEADDED",
"properties":{
"eventTimes":[123013691524859],
"nodeNames":["127.0.0.1:42829_solr"]}}
at
__randomizedtesting.SeedInfo.seed([A35E7B72FDBA8F06:6DF0DFE10583F710]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.lambda$new$0(NodeAddedTriggerTest.java:49)
at
org.apache.solr.cloud.autoscaling.NodeAddedTrigger.run(NodeAddedTrigger.java:161)
at
org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState(NodeAddedTriggerTest.java:257)
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.autoscaling.NodeAddedTriggerTest.testRestoreState
Error Message:
Did not expect the processor to fire on first run! event={
"id":"6fe5df141471Td9tg4a0s2nyqqoj9b2xtxulkf", "source":"node_added_trigger",
"eventTime":123033080829041, "eventType":"NODEADDED", "properties":{
"eventTimes":[123033080829041], "nodeNames":["127.0.0.1:39205_solr"]}}
Stack Trace:
java.lang.AssertionError: Did not expect the processor to fire on first run!
event={
"id":"6fe5df141471Td9tg4a0s2nyqqoj9b2xtxulkf",
"source":"node_added_trigger",
"eventTime":123033080829041,
"eventType":"NODEADDED",
"properties":{
"eventTimes":[123033080829041],
"nodeNames":["127.0.0.1:39205_solr"]}}
at
__randomizedtesting.SeedInfo.seed([A35E7B72FDBA8F06:6DF0DFE10583F710]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.lambda$new$0(NodeAddedTriggerTest.java:49)
at
org.apache.solr.cloud.autoscaling.NodeAddedTrigger.run(NodeAddedTrigger.java:161)
at
org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState(NodeAddedTriggerTest.java:257)
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.autoscaling.NodeAddedTriggerTest.testRestoreState
Error Message:
Did not expect the processor to fire on first run! event={
"id":"6fe6556d40efTd9tg4a0s2nyqqoj9b2xtxulkf", "source":"node_added_trigger",
"eventTime":123035066384623, "eventType":"NODEADDED", "properties":{
"eventTimes":[123035066384623], "nodeNames":["127.0.0.1:34257_solr"]}}
Stack Trace:
java.lang.AssertionError: Did not expect the processor to fire on first run!
event={
"id":"6fe6556d40efTd9tg4a0s2nyqqoj9b2xtxulkf",
"source":"node_added_trigger",
"eventTime":123035066384623,
"eventType":"NODEADDED",
"properties":{
"eventTimes":[123035066384623],
"nodeNames":["127.0.0.1:34257_solr"]}}
at
__randomizedtesting.SeedInfo.seed([A35E7B72FDBA8F06:6DF0DFE10583F710]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.lambda$new$0(NodeAddedTriggerTest.java:49)
at
org.apache.solr.cloud.autoscaling.NodeAddedTrigger.run(NodeAddedTrigger.java:161)
at
org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState(NodeAddedTriggerTest.java:257)
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.autoscaling.NodeAddedTriggerTest.testRestoreState
Error Message:
Did not expect the processor to fire on first run! event={
"id":"6e9dcf022e7cTd9tg4a0s2nyqqoj9b2xtxus21", "source":"node_added_trigger",
"eventTime":121624061947516, "eventType":"NODEADDED", "properties":{
"eventTimes":[121624061947516], "nodeNames":["127.0.0.1:40347_solr"]}}
Stack Trace:
java.lang.AssertionError: Did not expect the processor to fire on first run!
event={
"id":"6e9dcf022e7cTd9tg4a0s2nyqqoj9b2xtxus21",
"source":"node_added_trigger",
"eventTime":121624061947516,
"eventType":"NODEADDED",
"properties":{
"eventTimes":[121624061947516],
"nodeNames":["127.0.0.1:40347_solr"]}}
at
__randomizedtesting.SeedInfo.seed([A35E7B72FDBA8F06:6DF0DFE10583F710]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.lambda$new$0(NodeAddedTriggerTest.java:49)
at
org.apache.solr.cloud.autoscaling.NodeAddedTrigger.run(NodeAddedTrigger.java:161)
at
org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState(NodeAddedTriggerTest.java:257)
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 14570 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_A35E7B72FDBA8F06-001/init-core-data-001
[junit4] 2> 2185439 INFO
(SUITE-NodeAddedTriggerTest-seed#[A35E7B72FDBA8F06]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_A35E7B72FDBA8F06-001/tempDir-001
[junit4] 2> 2185439 INFO
(SUITE-NodeAddedTriggerTest-seed#[A35E7B72FDBA8F06]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2185440 INFO (Thread-6062) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2185440 INFO (Thread-6062) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 2185442 ERROR (Thread-6062) [ ] 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> 2185540 INFO
(SUITE-NodeAddedTriggerTest-seed#[A35E7B72FDBA8F06]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:46581
[junit4] 2> 2185543 INFO (zkConnectionManagerCallback-4812-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2185548 INFO (jetty-launcher-4809-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> 2185549 INFO (jetty-launcher-4809-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2185549 INFO (jetty-launcher-4809-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2185549 INFO (jetty-launcher-4809-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2185550 INFO (jetty-launcher-4809-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@16be351{/solr,null,AVAILABLE}
[junit4] 2> 2185551 INFO (jetty-launcher-4809-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@1a94a75{SSL,[ssl,
http/1.1]}{127.0.0.1:40347}
[junit4] 2> 2185551 INFO (jetty-launcher-4809-thread-1) [ ]
o.e.j.s.Server Started @2185586ms
[junit4] 2> 2185551 INFO (jetty-launcher-4809-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=40347}
[junit4] 2> 2185551 ERROR (jetty-launcher-4809-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2185551 INFO (jetty-launcher-4809-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2185551 INFO (jetty-launcher-4809-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.4.0
[junit4] 2> 2185551 INFO (jetty-launcher-4809-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2185552 INFO (jetty-launcher-4809-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2185552 INFO (jetty-launcher-4809-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-21T22:08:31.715Z
[junit4] 2> 2185553 INFO (zkConnectionManagerCallback-4814-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2185553 INFO (jetty-launcher-4809-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2185562 INFO (jetty-launcher-4809-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46581/solr
[junit4] 2> 2185563 INFO (zkConnectionManagerCallback-4818-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2185565 INFO (zkConnectionManagerCallback-4820-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2185622 INFO (jetty-launcher-4809-thread-1)
[n:127.0.0.1:40347_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2185622 INFO (jetty-launcher-4809-thread-1)
[n:127.0.0.1:40347_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:40347_solr
[junit4] 2> 2185623 INFO (jetty-launcher-4809-thread-1)
[n:127.0.0.1:40347_solr ] o.a.s.c.Overseer Overseer
(id=72065564741730307-127.0.0.1:40347_solr-n_0000000000) starting
[junit4] 2> 2185629 INFO (zkConnectionManagerCallback-4827-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2185630 INFO (jetty-launcher-4809-thread-1)
[n:127.0.0.1:40347_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:46581/solr ready
[junit4] 2> 2185631 INFO (jetty-launcher-4809-thread-1)
[n:127.0.0.1:40347_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:40347_solr
[junit4] 2> 2185632 INFO (zkCallback-4826-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2185632 INFO (zkCallback-4819-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2186134 INFO (jetty-launcher-4809-thread-1)
[n:127.0.0.1:40347_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40347.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1612157
[junit4] 2> 2186146 INFO (jetty-launcher-4809-thread-1)
[n:127.0.0.1:40347_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40347.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1612157
[junit4] 2> 2186146 INFO (jetty-launcher-4809-thread-1)
[n:127.0.0.1:40347_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40347.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1612157
[junit4] 2> 2186147 INFO (jetty-launcher-4809-thread-1)
[n:127.0.0.1:40347_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_A35E7B72FDBA8F06-001/tempDir-001/node1/.
[junit4] 2> 2186166 INFO (zkConnectionManagerCallback-4829-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2186170 INFO (zkConnectionManagerCallback-4834-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2186171 INFO
(SUITE-NodeAddedTriggerTest-seed#[A35E7B72FDBA8F06]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2186171 INFO
(SUITE-NodeAddedTriggerTest-seed#[A35E7B72FDBA8F06]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46581/solr ready
[junit4] 2> 2186216 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06]) [ ]
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> 2186216 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2186216 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2186216 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2186217 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@8c3cbb{/solr,null,AVAILABLE}
[junit4] 2> 2186217 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@19c4040{SSL,[ssl,
http/1.1]}{127.0.0.1:35653}
[junit4] 2> 2186218 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.Server Started @2186253ms
[junit4] 2> 2186218 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=35653}
[junit4] 2> 2186218 ERROR
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2186218 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2186218 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.4.0
[junit4] 2> 2186218 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2186219 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2186219 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-21T22:08:32.382Z
[junit4] 2> 2186221 INFO (zkConnectionManagerCallback-4836-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2186221 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2186235 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46581/solr
[junit4] 2> 2186237 INFO (zkConnectionManagerCallback-4840-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2186239 INFO (zkConnectionManagerCallback-4842-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2186244 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:35653_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2186245 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:35653_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2186246 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:35653_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 2186247 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:35653_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:35653_solr
[junit4] 2> 2186247 INFO (zkCallback-4826-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2186247 INFO (zkCallback-4819-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2186248 INFO (zkCallback-4841-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2186248 INFO (zkCallback-4833-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2189249 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:35653_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_35653.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1612157
[junit4] 2> 2189259 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:35653_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_35653.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1612157
[junit4] 2> 2189259 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:35653_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_35653.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1612157
[junit4] 2> 2189261 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:35653_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_A35E7B72FDBA8F06-001/tempDir-001/node2/.
[junit4] 2> 2189264 INFO (zkConnectionManagerCallback-4849-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2189266 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:35653_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2189266 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:35653_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:46581/solr ready
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=NodeAddedTriggerTest -Dtests.method=testRestoreState
-Dtests.seed=A35E7B72FDBA8F06 -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.locale=nl -Dtests.timezone=UCT -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[junit4] FAILURE 3.13s J0 | NodeAddedTriggerTest.testRestoreState <<<
[junit4] > Throwable #1: java.lang.AssertionError: Did not expect the
processor to fire on first run! event={
[junit4] > "id":"6e9dcf022e7cTd9tg4a0s2nyqqoj9b2xtxus21",
[junit4] > "source":"node_added_trigger",
[junit4] > "eventTime":121624061947516,
[junit4] > "eventType":"NODEADDED",
[junit4] > "properties":{
[junit4] > "eventTimes":[121624061947516],
[junit4] > "nodeNames":["127.0.0.1:40347_solr"]}}
[junit4] > at
__randomizedtesting.SeedInfo.seed([A35E7B72FDBA8F06:6DF0DFE10583F710]:0)
[junit4] > at
org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.lambda$new$0(NodeAddedTriggerTest.java:49)
[junit4] > at
org.apache.solr.cloud.autoscaling.NodeAddedTrigger.run(NodeAddedTrigger.java:161)
[junit4] > at
org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState(NodeAddedTriggerTest.java:257)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2189348 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06]) [
] 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> 2189349 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06]) [
] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2189349 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06]) [
] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2189349 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06]) [
] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2189350 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1c33db4{/solr,null,AVAILABLE}
[junit4] 2> 2189351 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06]) [
] o.e.j.s.AbstractConnector Started ServerConnector@14af2e{SSL,[ssl,
http/1.1]}{127.0.0.1:34499}
[junit4] 2> 2189351 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06]) [
] o.e.j.s.Server Started @2189386ms
[junit4] 2> 2189351 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=34499}
[junit4] 2> 2189351 ERROR
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06]) [
] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2189351 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06]) [
] o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2189351 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06]) [
] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.4.0
[junit4] 2> 2189351 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06]) [
] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port
null
[junit4] 2> 2189351 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06]) [
] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2189352 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06]) [
] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-21T22:08:35.515Z
[junit4] 2> 2189353 INFO (zkConnectionManagerCallback-4851-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2189354 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06]) [
] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2189368 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46581/solr
[junit4] 2> 2189369 INFO (zkConnectionManagerCallback-4855-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2189371 INFO (zkConnectionManagerCallback-4857-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2189376 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:34499_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2189377 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:34499_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2189379 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:34499_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 2189379 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:34499_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:34499_solr
[junit4] 2> 2189380 INFO (zkCallback-4819-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2189380 INFO (zkCallback-4833-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2189380 INFO (zkCallback-4826-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2189380 INFO (zkCallback-4841-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2189380 INFO (zkCallback-4848-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2189384 INFO (zkCallback-4856-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2190027 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:34499_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34499.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1612157
[junit4] 2> 2190037 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:34499_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34499.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1612157
[junit4] 2> 2190037 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:34499_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34499.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1612157
[junit4] 2> 2190039 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:34499_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_A35E7B72FDBA8F06-001/tempDir-001/node3/.
[junit4] 2> 2190042 INFO (zkConnectionManagerCallback-4864-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2190043 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:34499_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 2190044 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:34499_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:46581/solr ready
[junit4] 2> 2190143 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
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> 2190145 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2190145 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2190145 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2190145 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@222bcf{/solr,null,AVAILABLE}
[junit4] 2> 2190146 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@1402199{SSL,[ssl,
http/1.1]}{127.0.0.1:33481}
[junit4] 2> 2190146 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.Server Started @2190181ms
[junit4] 2> 2190146 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=33481}
[junit4] 2> 2190146 ERROR
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2190146 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2190147 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.4.0
[junit4] 2> 2190147 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2190147 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2190147 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-21T22:08:36.310Z
[junit4] 2> 2190148 INFO (zkConnectionManagerCallback-4866-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2190149 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2190159 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46581/solr
[junit4] 2> 2190160 INFO (zkConnectionManagerCallback-4870-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2190162 INFO (zkConnectionManagerCallback-4872-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2190167 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:33481_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 2190168 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:33481_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2190169 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:33481_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 2190169 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:33481_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:33481_solr
[junit4] 2> 2190170 INFO (zkCallback-4819-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2190170 INFO (zkCallback-4826-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2190170 INFO (zkCallback-4841-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2190170 INFO (zkCallback-4833-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2190170 INFO (zkCallback-4856-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2190170 INFO (zkCallback-4848-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2190171 INFO (zkCallback-4871-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2190171 INFO (zkCallback-4863-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2193444 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:33481_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_33481.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1612157
[junit4] 2> 2193456 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:33481_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_33481.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1612157
[junit4] 2> 2193456 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:33481_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_33481.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1612157
[junit4] 2> 2193458 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:33481_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_A35E7B72FDBA8F06-001/tempDir-001/node4/.
[junit4] 2> 2193462 INFO (zkConnectionManagerCallback-4879-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2193463 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:33481_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 2193464 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:33481_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:46581/solr ready
[junit4] 2> 2193528 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
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> 2193528 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2193528 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2193528 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2193529 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1baf00d{/solr,null,AVAILABLE}
[junit4] 2> 2193530 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@164b917{SSL,[ssl,
http/1.1]}{127.0.0.1:39339}
[junit4] 2> 2193530 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.Server Started @2193565ms
[junit4] 2> 2193530 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=39339}
[junit4] 2> 2193531 ERROR
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2193531 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2193531 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.4.0
[junit4] 2> 2193531 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2193531 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2193531 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-21T22:08:39.694Z
[junit4] 2> 2193533 INFO (zkConnectionManagerCallback-4881-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2193533 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2193546 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46581/solr
[junit4] 2> 2193547 INFO (zkConnectionManagerCallback-4885-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2193550 INFO (zkConnectionManagerCallback-4887-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2193555 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:39339_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 2193556 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:39339_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2193557 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:39339_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 2193557 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:39339_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:39339_solr
[junit4] 2> 2193561 INFO (zkCallback-4833-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2193561 INFO (zkCallback-4856-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2193561 INFO (zkCallback-4863-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2193561 INFO (zkCallback-4848-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2193561 INFO (zkCallback-4841-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2193561 INFO (zkCallback-4871-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2193561 INFO (zkCallback-4819-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2193561 INFO (zkCallback-4878-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2193561 INFO (zkCallback-4826-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2193565 INFO (zkCallback-4886-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2195017 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:39339_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39339.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1612157
[junit4] 2> 2195027 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:39339_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39339.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1612157
[junit4] 2> 2195028 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:39339_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39339.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1612157
[junit4] 2> 2195029 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:39339_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_A35E7B72FDBA8F06-001/tempDir-001/node5/.
[junit4] 2> 2195033 INFO (zkConnectionManagerCallback-4894-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2195034 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:39339_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (5)
[junit4] 2> 2195036 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:39339_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:46581/solr ready
[junit4] 2> 2197089 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
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> 2197090 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2197090 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2197091 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2197091 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@d95392{/solr,null,AVAILABLE}
[junit4] 2> 2197092 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@db6563{SSL,[ssl,
http/1.1]}{127.0.0.1:43551}
[junit4] 2> 2197092 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.Server Started @2197127ms
[junit4] 2> 2197092 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=43551}
[junit4] 2> 2197092 ERROR
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2197092 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2197092 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.4.0
[junit4] 2> 2197092 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2197092 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2197093 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-21T22:08:43.255Z
[junit4] 2> 2197094 INFO (zkConnectionManagerCallback-4896-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2197095 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2197110 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46581/solr
[junit4] 2> 2197111 INFO (zkConnectionManagerCallback-4900-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2197114 INFO (zkConnectionManagerCallback-4902-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2197118 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:43551_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (5)
[junit4] 2> 2197120 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:43551_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2197121 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:43551_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 2197121 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:43551_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:43551_solr
[junit4] 2> 2197122 INFO (zkCallback-4856-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 2197122 INFO (zkCallback-4826-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 2197122 INFO (zkCallback-4833-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 2197122 INFO (zkCallback-4848-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 2197122 INFO (zkCallback-4819-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 2197123 INFO (zkCallback-4841-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 2197123 INFO (zkCallback-4871-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 2197123 INFO (zkCallback-4863-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 2197123 INFO (zkCallback-4878-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 2197123 INFO (zkCallback-4886-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 2197123 INFO (zkCallback-4893-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 2197124 INFO (zkCallback-4901-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 2199594 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:43551_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_43551.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1612157
[junit4] 2> 2199607 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:43551_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_43551.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1612157
[junit4] 2> 2199607 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:43551_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_43551.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1612157
[junit4] 2> 2199609 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:43551_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_A35E7B72FDBA8F06-001/tempDir-001/node6/.
[junit4] 2> 2199613 INFO (zkConnectionManagerCallback-4909-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2199615 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:43551_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (6)
[junit4] 2> 2199616 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06])
[n:127.0.0.1:43551_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:46581/solr ready
[junit4] 2> 2199674 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@db6563{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 2199675 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=6929305
[junit4] 2> 2199675 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2199676 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1a38c4c: rootName =
solr_43551, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@179f994
[junit4] 2> 2199684 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2199684 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@553be0: rootName =
solr_43551, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@14d051a
[junit4] 2> 2199689 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2199689 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@13a7c7: rootName =
solr_43551, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@e1c97c
[junit4] 2> 2199690 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:43551_solr
[junit4] 2> 2199691 INFO (zkCallback-4826-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 2199691 INFO (zkCallback-4856-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 2199692 INFO (zkCallback-4848-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 2199692 INFO (zkCallback-4893-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 2199692 INFO (zkCallback-4833-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 2199692 INFO (zkCallback-4841-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 2199692 INFO (zkCallback-4871-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 2199692 INFO (zkCallback-4886-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 2199692 INFO (zkCallback-4878-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 2199692 INFO (zkCallback-4863-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 2199692 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2199693 INFO (zkCallback-4819-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 2199693 INFO (zkCallback-4908-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 2199693 INFO (zkCallback-4901-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 2199693 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@d95392{/solr,null,UNAVAILABLE}
[junit4] 2> 2199694 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A35E7B72FDBA8F06]) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2204783 INFO (jetty-closer-4810-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@1a94a75{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 2204785 INFO (jetty-closer-4810-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@19c4040{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 2204785 INFO (jetty-closer-4810-thread-1) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1155271
[junit4] 2> 2204786 INFO (jetty-closer-4810-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@14af2e{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 2204786 INFO (jetty-closer-4810-thread-2) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=14875376
[junit4] 2> 2204786 INFO (jetty-closer-4810-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2204786 INFO (jetty-closer-4810-thread-3) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=28821369
[junit4] 2> 2204786 INFO (jetty-closer-4810-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@b69d83: rootName =
solr_40347, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@1cfed29
[junit4] 2> 2204786 INFO (jetty-closer-4810-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2204787 INFO (jetty-closer-4810-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2204787 INFO (jetty-closer-4810-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1642cc5: rootName =
solr_34499, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@19907b4
[junit4] 2> 2204788 INFO (jetty-closer-4810-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@16be8b: rootName =
solr_35653, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@f29c9a
[junit4] 2> 2204788 INFO (jetty-closer-4810-thread-4) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@1402199{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 2204788 INFO (jetty-closer-4810-thread-4) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=4501896
[junit4] 2> 2204788 INFO (jetty-closer-4810-thread-4) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2204788 INFO (jetty-closer-4810-thread-4) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7459e0: rootName =
solr_33481, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@67a713
[junit4] 2> 2204789 INFO (jetty-closer-4810-thread-5) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@164b917{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 2204789 INFO (jetty-closer-4810-thread-5) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=33402085
[junit4] 2> 2204789 INFO (jetty-closer-4810-thread-5) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2204789 INFO (jetty-closer-4810-thread-5) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@f6ffef: rootName =
solr_39339, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@1ad2c57
[junit4] 2> 2204802 INFO (jetty-closer-4810-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2204802 INFO (jetty-closer-4810-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1402bbf: rootName =
solr_40347, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@14d051a
[junit4] 2> 2204802 INFO (jetty-closer-4810-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2204802 INFO (jetty-closer-4810-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@efa9e4: rootName =
solr_34499, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@14d051a
[junit4] 2> 2204802 INFO (jetty-closer-4810-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2204802 INFO (jetty-closer-4810-thread-4) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2204802 INFO (jetty-closer-4810-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@13c2ac5: rootName =
solr_35653, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@14d051a
[junit4] 2> 2204802 INFO (jetty-closer-4810-thread-4) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@b27f89: rootName =
solr_33481, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@14d051a
[junit4] 2> 2204803 INFO (jetty-closer-4810-thread-5) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2204803 INFO (jetty-closer-4810-thread-5) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@41bcc1: rootName =
solr_39339, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@14d051a
[junit4] 2> 2204807 INFO (jetty-closer-4810-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2204807 INFO (jetty-closer-4810-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1e3999f: rootName =
solr_34499, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@e1c97c
[junit4] 2> 2204807 INFO (jetty-closer-4810-thread-4) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2204807 INFO (jetty-closer-4810-thread-4) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4bea8c: rootName =
solr_33481, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@e1c97c
[junit4] 2> 2204808 INFO (jetty-closer-4810-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2204808 INFO (jetty-closer-4810-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1550b3b: rootName =
solr_40347, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@e1c97c
[junit4] 2> 2204808 INFO (jetty-closer-4810-thread-3) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:34499_solr
[junit4] 2> 2204808 INFO (jetty-closer-4810-thread-5) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2204808 INFO (jetty-closer-4810-thread-5) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@c6a8d5: rootName =
solr_39339, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@e1c97c
[junit4] 2> 2204808 INFO (jetty-closer-4810-thread-4) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:33481_solr
[junit4] 2> 2204809 INFO (jetty-closer-4810-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2204809 INFO (jetty-closer-4810-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@15988f0: rootName =
solr_35653, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@e1c97c
[junit4] 2> 2204809 INFO (jetty-closer-4810-thread-1) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:40347_solr
[junit4] 2> 2204809 INFO (jetty-closer-4810-thread-4) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2204809 INFO (zkCallback-4886-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 2204809 INFO (zkCallback-4893-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 2204809 INFO (zkCallback-4878-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 2204810 INFO (zkCallback-4848-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 2204810 INFO (zkCallback-4863-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 2204811 INFO (zkCallback-4841-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 2204811 INFO (zkCallback-4871-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 2204811 INFO (zkCallback-4856-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (3)
[junit4] 2> 2204811 INFO (jetty-closer-4810-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2204811 INFO (zkCallback-4826-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 2204811 INFO (zkCallback-4893-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 2204811 INFO (zkCallback-4863-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 2204811 INFO (zkCallback-4819-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (3)
[junit4] 2> 2204812 INFO (zkCallback-4848-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 2204812 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid
0x100073fd2f80012, likely client has closed socket
[junit4] 2> 2204812 INFO (jetty-closer-4810-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2204812 INFO (jetty-closer-4810-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2204812 INFO (zkCallback-4871-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 2204812 INFO (zkCallback-4841-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 2204812 INFO (zkCallback-4893-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 2204812 INFO (zkCallback-4848-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 2204812 INFO (zkCallback-4826-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (2)
[junit4] 2> 2204812 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid
0x100073fd2f8000e, likely client has closed socket
[junit4] 2> 2204812 INFO (jetty-closer-4810-thread-5) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:39339_solr
[junit4] 2> 2204812 INFO (jetty-closer-4810-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72065564741730307-127.0.0.1:40347_solr-n_0000000000) closing
[junit4] 2> 2204812 INFO
(OverseerStateUpdate-72065564741730307-127.0.0.1:40347_solr-n_0000000000) [
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:40347_solr
[junit4] 2> 2204813 WARN
(OverseerAutoScalingTriggerThread-72065564741730307-127.0.0.1:40347_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we
are closed, exiting.
[junit4] 2> 2204813 INFO (zkCallback-4856-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 2204813 INFO (zkCallback-4886-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (2)
[junit4] 2> 2204814 INFO (zkCallback-4871-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 2204814 INFO (zkCallback-4819-thread-3) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 2204815 INFO (jetty-closer-4810-thread-2) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:35653_solr
[junit4] 2> 2204815 INFO (zkCallback-4841-thread-3) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
[junit4] 2> 2204815 INFO (jetty-closer-4810-thread-5) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2204815 INFO (zkCallback-4893-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 2204815 INFO (zkCallback-4886-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 2204815 INFO (zkCallback-4848-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 2204815 INFO (zkCallback-4856-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 2204815 INFO (zkCallback-4871-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 2204815 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid
0x100073fd2f80004, likely client has closed socket
[junit4] 2> 2204816 INFO (zkCallback-4819-thread-3) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 2204817 INFO (jetty-closer-4810-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2204817 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid
0x100073fd2f80016, likely client has closed socket
[junit4] 2> 2204817 INFO (zkCallback-4841-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
[junit4] 2> 2204817 INFO (zkCallback-4856-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
[junit4] 2> 2204817 INFO (zkCallback-4848-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
[junit4] 2> 2204817 INFO (zkCallback-4871-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
[junit4] 2> 2204817 INFO (zkCallback-4886-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
[junit4] 2> 2204817 INFO (zkCallback-4819-thread-3) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
[junit4] 2> 2204818 INFO (jetty-closer-4810-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@8c3cbb{/solr,null,UNAVAILABLE}
[junit4] 2> 2204819 INFO (jetty-closer-4810-thread-2) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2206311 WARN (zkCallback-4878-thread-1) [ ]
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK:
[KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 2206312 WARN (zkCallback-4863-thread-1) [ ]
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK:
[KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 2206312 INFO (jetty-closer-4810-thread-4) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@222bcf{/solr,null,UNAVAILABLE}
[junit4] 2> 2206312 INFO (jetty-closer-4810-thread-4) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2206313 INFO (jetty-closer-4810-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@1c33db4{/solr,null,UNAVAILABLE}
[junit4] 2> 2206313 INFO (jetty-closer-4810-thread-3) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2206315 WARN (zkCallback-4826-thread-2) [ ]
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK:
[KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 2206316 INFO (zkCallback-4886-thread-2) [ ]
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:39339_solr
[junit4] 2> 2206316 INFO (jetty-closer-4810-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@16be351{/solr,null,UNAVAILABLE}
[junit4] 2> 2206316 INFO (jetty-closer-4810-thread-1) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2206316 WARN (zkCallback-4893-thread-1) [ ]
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK:
[KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 2206317 INFO (jetty-closer-4810-thread-5) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@1baf00d{/solr,null,UNAVAILABLE}
[junit4] 2> 2206317 INFO (jetty-closer-4810-thread-5) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2206318 ERROR
(SUITE-NodeAddedTriggerTest-seed#[A35E7B72FDBA8F06]-worker) [ ]
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper
server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 2206318 INFO
(SUITE-NodeAddedTriggerTest-seed#[A35E7B72FDBA8F06]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:46581 46581
[junit4] 2> 2207121 INFO (Thread-6062) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:46581 46581
[junit4] 2> 2207122 WARN (Thread-6062) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 13 /solr/aliases.json
[junit4] 2> 6 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 13 /solr/clusterstate.json
[junit4] 2> 13 /solr/clusterprops.json
[junit4] 2> 3
/solr/overseer_elect/election/72065564741730307-127.0.0.1:40347_solr-n_0000000000
[junit4] 2> 2
/solr/overseer_elect/election/72065564741730317-127.0.0.1:34499_solr-n_0000000002
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 13 /solr/live_nodes
[junit4] 2> 13 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_A35E7B72FDBA8F06-001
[junit4] 2> May 21, 2018 10:08:53 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=CheapBastard,
sim=RandomSimilarity(queryNorm=false): {}, locale=nl, timezone=UCT
[junit4] 2> NOTE: Linux 4.13.0-41-generic i386/Oracle Corporation
1.8.0_172 (32-bit)/cpus=8,threads=1,free=132943440,total=357847040
[junit4] 2> NOTE: All tests run in this JVM: [TestGroupingSearch,
ReplaceNodeNoTargetTest, SimpleFacetsTest, CollectionTooManyReplicasTest,
TestSimpleQParserPlugin, TestLeaderInitiatedRecoveryThread,
TestQuerySenderNoQuery, TestDistributedSearch, TestFieldTypeResource,
TestEmbeddedSolrServerAdminHandler, PreAnalyzedUpdateProcessorTest,
BinaryUpdateRequestHandlerTest, HdfsBasicDistributedZkTest, OverseerRolesTest,
CollectionPropsTest, ConcurrentDeleteAndCreateCollectionTest,
UUIDUpdateProcessorFallbackTest, TestLegacyField, TestCustomSort,
InfixSuggestersTest, TestUniqueKeyFieldResource, TestDistribStateManager,
TestExclusionRuleCollectionAccess, TestJoin, TestCloudPseudoReturnFields,
TestCloudSchemaless, ClassificationUpdateProcessorTest, TestScoreJoinQPNoScore,
DistributedTermsComponentTest, TestRemoteStreaming, ZkSolrClientTest,
DistributedQueryElevationComponentTest, DefaultValueUpdateProcessorTest,
TestRecoveryHdfs, LeaderFailureAfterFreshStartTest, TestCloudConsistency,
DirectoryFactoryTest, UUIDFieldTest, RestartWhileUpdatingTest,
TestCopyFieldCollectionResource, GraphQueryTest, TestHighlightDedupGrouping,
TestPseudoReturnFields, TestNumericRangeQuery64,
DistribDocExpirationUpdateProcessorTest, AutoAddReplicasPlanActionTest,
TestDistribDocBasedVersion, TestRawResponseWriter, StatsReloadRaceTest,
TestDocumentBuilder, HdfsRestartWhileUpdatingTest, ExecutePlanActionTest,
TestConfigsApi, VersionInfoTest, TestSolrQueryParser, MBeansHandlerTest,
TestHashPartitioner, TestCorePropertiesReload, MigrateRouteKeyTest,
DeleteShardTest, ChaosMonkeyNothingIsSafeTest, SolrRequestParserTest,
TestConfigSetImmutable, TestCSVLoader, TestMultiWordSynonyms,
TestSolrCLIRunExample, TestSolrCoreParser, TestManagedResourceStorage,
PreAnalyzedFieldManagedSchemaCloudTest, TestComponentsName, DistributedVersi
[...truncated too long message...]
d-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) ->
(2)
[junit4] 2> 42421 INFO (jetty-closer-103-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 42421 INFO (jetty-closer-103-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 42422 INFO (zkCallback-119-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 42422 INFO (zkCallback-171-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 42422 INFO (jetty-closer-103-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72065657203916803-127.0.0.1:34257_solr-n_0000000000) closing
[junit4] 2> 42422 INFO
(OverseerStateUpdate-72065657203916803-127.0.0.1:34257_solr-n_0000000000) [
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:34257_solr
[junit4] 2> 42422 WARN
(OverseerAutoScalingTriggerThread-72065657203916803-127.0.0.1:34257_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we
are closed, exiting.
[junit4] 2> 42422 INFO (zkCallback-112-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 42424 INFO (jetty-closer-103-thread-4) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 42424 INFO (zkCallback-164-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (0)
[junit4] 2> 42424 INFO (zkCallback-112-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
[junit4] 2> 42424 INFO (zkCallback-171-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
[junit4] 2> 42426 INFO (jetty-closer-103-thread-4) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@61992b{/solr,null,UNAVAILABLE}
[junit4] 2> 42426 INFO (jetty-closer-103-thread-4) [ ] o.e.j.s.session
node0 Stopped scavenging
[junit4] 2> 43913 WARN (zkCallback-149-thread-1) [ ]
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK:
[KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 43914 INFO (jetty-closer-103-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@199ceb0{/solr,null,UNAVAILABLE}
[junit4] 2> 43914 INFO (jetty-closer-103-thread-3) [ ] o.e.j.s.session
node0 Stopped scavenging
[junit4] 2> 43924 WARN (zkCallback-119-thread-1) [ ]
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK:
[KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 43926 INFO (jetty-closer-103-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@1e1ab48{/solr,null,UNAVAILABLE}
[junit4] 2> 43926 INFO (jetty-closer-103-thread-1) [ ] o.e.j.s.session
node0 Stopped scavenging
[junit4] 2> 43921 WARN (zkCallback-134-thread-2) [ ]
o.a.s.c.ZkController Unable to register nodeLost path for 127.0.0.1:45355_solr
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException:
KeeperErrorCode = Session expired for /autoscaling/nodeLost/127.0.0.1:45355_solr
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:130)
~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:54)
~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:786)
~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.lambda$create$7(SolrZkClient.java:365)
~[java/:?]
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
~[java/:?]
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:365)
~[java/:?]
[junit4] 2> at
org.apache.solr.cloud.ZkController.lambda$registerLiveNodesListener$2(ZkController.java:889)
~[java/:?]
[junit4] 2> at
org.apache.solr.common.cloud.ZkStateReader.lambda$refreshLiveNodes$3(ZkStateReader.java:792)
~[java/:?]
[junit4] 2> at
java.util.concurrent.ConcurrentHashMap$KeySetView.forEach(ConcurrentHashMap.java:4649)
~[?:1.8.0_172]
[junit4] 2> at
org.apache.solr.common.cloud.ZkStateReader.refreshLiveNodes(ZkStateReader.java:791)
~[java/:?]
[junit4] 2> at
org.apache.solr.common.cloud.ZkStateReader.access$1400(ZkStateReader.java:73)
~[java/:?]
[junit4] 2> at
org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.refreshAndWatch(ZkStateReader.java:1284)
~[java/:?]
[junit4] 2> at
org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.process(ZkStateReader.java:1279)
~[java/:?]
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$1.lambda$process$1(SolrZkClient.java:269)
~[java/:?]
[junit4] 2> at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
~[?:1.8.0_172]
[junit4] 2> at
java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_172]
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:192)
~[java/:?]
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[?:1.8.0_172]
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[?:1.8.0_172]
[junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_172]
[junit4] 2> 43933 INFO (jetty-closer-103-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@3d4414{/solr,null,UNAVAILABLE}
[junit4] 2> 43933 INFO (jetty-closer-103-thread-2) [ ] o.e.j.s.session
node0 Stopped scavenging
[junit4] 2> 43934 ERROR
(SUITE-NodeAddedTriggerTest-seed#[A35E7B72FDBA8F06]-worker) [ ]
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper
server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 43934 INFO
(SUITE-NodeAddedTriggerTest-seed#[A35E7B72FDBA8F06]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:46799 46799
[junit4] 2> 44058 INFO (Thread-62) [ ] o.a.s.c.ZkTestServer connecting
to 127.0.0.1:46799 46799
[junit4] 2> 44059 WARN (Thread-62) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 13 /solr/aliases.json
[junit4] 2> 6 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 13 /solr/clusterstate.json
[junit4] 2> 13 /solr/clusterprops.json
[junit4] 2> 2
/solr/overseer_elect/election/72065657203916803-127.0.0.1:34257_solr-n_0000000000
[junit4] 2> 2
/solr/overseer_elect/election/72065657203916809-127.0.0.1:44503_solr-n_0000000001
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 13 /solr/live_nodes
[junit4] 2> 13 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_A35E7B72FDBA8F06-002
[junit4] 2> NOTE: test params are: codec=CheapBastard,
sim=RandomSimilarity(queryNorm=false): {}, locale=nl, timezone=UCT
[junit4] 2> NOTE: Linux 4.13.0-41-generic i386/Oracle Corporation
1.8.0_172 (32-bit)/cpus=8,threads=1,free=4348800,total=35414016
[junit4] 2> NOTE: All tests run in this JVM: [NodeAddedTriggerTest,
NodeAddedTriggerTest]
[junit4] Completed [5/5 (5!)] on J2 in 16.98s, 4 tests, 1 failure <<<
FAILURES!
[...truncated 15 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1568: The
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1092:
There were test failures: 5 suites, 20 tests, 5 failures [seed:
A35E7B72FDBA8F06]
Total time: 46 seconds
[repro] Setting last failure code to 256
[repro] Failures:
[repro] 5/5 failed: org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest
[repro] Exiting with code 256
+ 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=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/var/lib/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=cc2ee2305001a49536886653d2133ee1a3b51b82,
workspace=/var/lib/jenkins/workspace/Lucene-Solr-7.x-Linux
[WARNINGS] Computing warning deltas based on reference build #1950
Recording test results
Setting
ANT_1_8_2_HOME=/var/lib/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=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
