Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.x/323/
2 tests failed.
FAILED:
org.apache.solr.cloud.autoscaling.NodeLostTriggerTest.testListenerAcceptance
Error Message:
expected:<1> but was:<0>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<0>
at
__randomizedtesting.SeedInfo.seed([9DD5E15780543BAE:8C61BBB039DD2F58]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.cloud.autoscaling.NodeLostTriggerTest.testListenerAcceptance(NodeLostTriggerTest.java:253)
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.client.solrj.io.stream.StreamExpressionTest.testDistributions
Error Message:
Stack Trace:
java.lang.AssertionError
at
__randomizedtesting.SeedInfo.seed([858D41DF7385970:B7A795B729C2B9EC]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertTrue(Assert.java:54)
at
org.apache.solr.client.solrj.io.stream.StreamExpressionTest.testDistributions(StreamExpressionTest.java:6637)
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 13638 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.NodeLostTriggerTest
[junit4] 2> Creating dataDir:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.NodeLostTriggerTest_9DD5E15780543BAE-001/init-core-data-001
[junit4] 2> 3659186 WARN
(SUITE-NodeLostTriggerTest-seed#[9DD5E15780543BAE]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=24 numCloses=24
[junit4] 2> 3659186 INFO
(SUITE-NodeLostTriggerTest-seed#[9DD5E15780543BAE]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 3659187 INFO
(SUITE-NodeLostTriggerTest-seed#[9DD5E15780543BAE]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 3659188 INFO
(SUITE-NodeLostTriggerTest-seed#[9DD5E15780543BAE]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 3659188 INFO
(SUITE-NodeLostTriggerTest-seed#[9DD5E15780543BAE]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 5 servers in
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.NodeLostTriggerTest_9DD5E15780543BAE-001/tempDir-001
[junit4] 2> 3659188 INFO
(SUITE-NodeLostTriggerTest-seed#[9DD5E15780543BAE]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 3659189 INFO (Thread-4254) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 3659189 INFO (Thread-4254) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 3659190 ERROR (Thread-4254) [ ] 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> 3659289 INFO
(SUITE-NodeLostTriggerTest-seed#[9DD5E15780543BAE]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:35496
[junit4] 2> 3659290 INFO (zkConnectionManagerCallback-7134-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3659293 INFO (jetty-launcher-7131-thread-1) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 3659293 INFO (jetty-launcher-7131-thread-2) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 3659294 INFO (jetty-launcher-7131-thread-3) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 3659294 INFO (jetty-launcher-7131-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 3659294 INFO (jetty-launcher-7131-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 3659294 INFO (jetty-launcher-7131-thread-1) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 3659294 INFO (jetty-launcher-7131-thread-4) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 3659294 INFO (jetty-launcher-7131-thread-5) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 3659294 INFO (jetty-launcher-7131-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 3659294 INFO (jetty-launcher-7131-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 3659294 INFO (jetty-launcher-7131-thread-2) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 3659294 INFO (jetty-launcher-7131-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@24b1f9ae{/solr,null,AVAILABLE}
[junit4] 2> 3659294 INFO (jetty-launcher-7131-thread-3) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 3659294 INFO (jetty-launcher-7131-thread-3) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 3659295 INFO (jetty-launcher-7131-thread-3) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 3659295 INFO (jetty-launcher-7131-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@25385ae1{/solr,null,AVAILABLE}
[junit4] 2> 3659295 INFO (jetty-launcher-7131-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@6d8c087f{SSL,[ssl,
http/1.1]}{127.0.0.1:38366}
[junit4] 2> 3659295 INFO (jetty-launcher-7131-thread-1) [ ]
o.e.j.s.Server Started @3668948ms
[junit4] 2> 3659295 INFO (jetty-launcher-7131-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=38366}
[junit4] 2> 3659295 INFO (jetty-launcher-7131-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@4576f23c{SSL,[ssl,
http/1.1]}{127.0.0.1:36402}
[junit4] 2> 3659295 ERROR (jetty-launcher-7131-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3659295 INFO (jetty-launcher-7131-thread-3) [ ]
o.e.j.s.Server Started @3668948ms
[junit4] 2> 3659295 INFO (jetty-launcher-7131-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.3.0
[junit4] 2> 3659295 INFO (jetty-launcher-7131-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=36402}
[junit4] 2> 3659295 INFO (jetty-launcher-7131-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3659295 INFO (jetty-launcher-7131-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3659295 ERROR (jetty-launcher-7131-thread-3) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3659295 INFO (jetty-launcher-7131-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-20T20:07:40.201Z
[junit4] 2> 3659296 INFO (jetty-launcher-7131-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.3.0
[junit4] 2> 3659296 INFO (jetty-launcher-7131-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3659296 INFO (jetty-launcher-7131-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3659296 INFO (jetty-launcher-7131-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-20T20:07:40.202Z
[junit4] 2> 3659296 INFO (jetty-launcher-7131-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@77af8ba3{/solr,null,AVAILABLE}
[junit4] 2> 3659297 INFO (jetty-launcher-7131-thread-5) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 3659297 INFO (jetty-launcher-7131-thread-5) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 3659297 INFO (jetty-launcher-7131-thread-5) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 3659297 INFO (jetty-launcher-7131-thread-5) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7134da09{/solr,null,AVAILABLE}
[junit4] 2> 3659297 INFO (jetty-launcher-7131-thread-5) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@248bba31{SSL,[ssl,
http/1.1]}{127.0.0.1:42464}
[junit4] 2> 3659297 INFO (jetty-launcher-7131-thread-5) [ ]
o.e.j.s.Server Started @3668950ms
[junit4] 2> 3659297 INFO (jetty-launcher-7131-thread-5) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=42464}
[junit4] 2> 3659297 ERROR (jetty-launcher-7131-thread-5) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3659298 INFO (jetty-launcher-7131-thread-5) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.3.0
[junit4] 2> 3659298 INFO (jetty-launcher-7131-thread-5) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3659298 INFO (jetty-launcher-7131-thread-5) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3659298 INFO (jetty-launcher-7131-thread-5) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-20T20:07:40.204Z
[junit4] 2> 3659306 INFO (zkConnectionManagerCallback-7140-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3659306 INFO (jetty-launcher-7131-thread-5) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3659367 INFO (jetty-launcher-7131-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@25c8b0aa{SSL,[ssl,
http/1.1]}{127.0.0.1:44384}
[junit4] 2> 3659367 INFO (jetty-launcher-7131-thread-2) [ ]
o.e.j.s.Server Started @3669020ms
[junit4] 2> 3659367 INFO (jetty-launcher-7131-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=44384}
[junit4] 2> 3659367 ERROR (jetty-launcher-7131-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3659368 INFO (jetty-launcher-7131-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.3.0
[junit4] 2> 3659368 INFO (jetty-launcher-7131-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3659368 INFO (zkConnectionManagerCallback-7138-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3659368 INFO (jetty-launcher-7131-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3659368 INFO (jetty-launcher-7131-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-20T20:07:40.274Z
[junit4] 2> 3659368 INFO (jetty-launcher-7131-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3659368 INFO (jetty-launcher-7131-thread-4) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 3659369 INFO (jetty-launcher-7131-thread-4) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 3659369 INFO (jetty-launcher-7131-thread-4) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 3659369 INFO (jetty-launcher-7131-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@78825b0c{/solr,null,AVAILABLE}
[junit4] 2> 3659369 INFO (jetty-launcher-7131-thread-4) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@118af13b{SSL,[ssl,
http/1.1]}{127.0.0.1:36112}
[junit4] 2> 3659370 INFO (jetty-launcher-7131-thread-4) [ ]
o.e.j.s.Server Started @3669023ms
[junit4] 2> 3659370 INFO (jetty-launcher-7131-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=36112}
[junit4] 2> 3659370 ERROR (jetty-launcher-7131-thread-4) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3659370 INFO (jetty-launcher-7131-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.3.0
[junit4] 2> 3659370 INFO (jetty-launcher-7131-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3659370 INFO (jetty-launcher-7131-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3659370 INFO (jetty-launcher-7131-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-20T20:07:40.276Z
[junit4] 2> 3659371 INFO (zkConnectionManagerCallback-7142-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3659377 INFO (zkConnectionManagerCallback-7136-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3659377 INFO (jetty-launcher-7131-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3659383 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x161152f0b3f0002, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 3659383 INFO (jetty-launcher-7131-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3659400 INFO (jetty-launcher-7131-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35496/solr
[junit4] 2> 3659402 INFO (zkConnectionManagerCallback-7148-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3659403 INFO (zkConnectionManagerCallback-7144-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3659403 INFO (jetty-launcher-7131-thread-5) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35496/solr
[junit4] 2> 3659404 INFO (jetty-launcher-7131-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35496/solr
[junit4] 2> 3659405 INFO (jetty-launcher-7131-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3659406 INFO (zkConnectionManagerCallback-7153-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3659419 INFO (jetty-launcher-7131-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35496/solr
[junit4] 2> 3659420 INFO (zkConnectionManagerCallback-7156-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3659421 INFO (jetty-launcher-7131-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35496/solr
[junit4] 2> 3659431 INFO
(zkConnectionManagerCallback-7162-thread-1-processing-n:127.0.0.1:36402_solr)
[n:127.0.0.1:36402_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3659448 INFO (zkConnectionManagerCallback-7160-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3659452 INFO
(zkConnectionManagerCallback-7166-thread-1-processing-n:127.0.0.1:42464_solr)
[n:127.0.0.1:42464_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3659452 INFO (zkConnectionManagerCallback-7168-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3659452 INFO
(zkConnectionManagerCallback-7171-thread-1-processing-n:127.0.0.1:44384_solr)
[n:127.0.0.1:44384_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3659453 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x161152f0b3f000c, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 3659453 INFO
(zkConnectionManagerCallback-7173-thread-1-processing-n:127.0.0.1:38366_solr)
[n:127.0.0.1:38366_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3659454 INFO
(zkConnectionManagerCallback-7175-thread-1-processing-n:127.0.0.1:36112_solr)
[n:127.0.0.1:36112_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3659485 INFO (jetty-launcher-7131-thread-5)
[n:127.0.0.1:42464_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 3659486 INFO (jetty-launcher-7131-thread-5)
[n:127.0.0.1:42464_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:42464_solr
[junit4] 2> 3659486 INFO (jetty-launcher-7131-thread-5)
[n:127.0.0.1:42464_solr ] o.a.s.c.Overseer Overseer
(id=99383958575185931-127.0.0.1:42464_solr-n_0000000000) starting
[junit4] 2> 3659497 INFO (jetty-launcher-7131-thread-2)
[n:127.0.0.1:44384_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 3659498 INFO (jetty-launcher-7131-thread-2)
[n:127.0.0.1:44384_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:44384_solr
[junit4] 2> 3659499 INFO
(zkCallback-7172-thread-1-processing-n:127.0.0.1:38366_solr)
[n:127.0.0.1:38366_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 3659499 INFO
(zkCallback-7165-thread-1-processing-n:127.0.0.1:42464_solr)
[n:127.0.0.1:42464_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 3659500 INFO (jetty-launcher-7131-thread-1)
[n:127.0.0.1:38366_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 3659529 INFO
(zkCallback-7170-thread-1-processing-n:127.0.0.1:44384_solr)
[n:127.0.0.1:44384_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 3659545 INFO (jetty-launcher-7131-thread-1)
[n:127.0.0.1:38366_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:38366_solr
[junit4] 2> 3659554 INFO (jetty-launcher-7131-thread-5)
[n:127.0.0.1:42464_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:42464_solr
[junit4] 2> 3659557 INFO (jetty-launcher-7131-thread-4)
[n:127.0.0.1:36112_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 3659557 INFO
(zkCallback-7170-thread-1-processing-n:127.0.0.1:44384_solr)
[n:127.0.0.1:44384_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (3)
[junit4] 2> 3659557 INFO
(zkCallback-7165-thread-1-processing-n:127.0.0.1:42464_solr)
[n:127.0.0.1:42464_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (3)
[junit4] 2> 3659558 INFO
(zkCallback-7172-thread-1-processing-n:127.0.0.1:38366_solr)
[n:127.0.0.1:38366_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (3)
[junit4] 2> 3659558 INFO (jetty-launcher-7131-thread-4)
[n:127.0.0.1:36112_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:36112_solr
[junit4] 2> 3659577 INFO
(zkCallback-7165-thread-1-processing-n:127.0.0.1:42464_solr)
[n:127.0.0.1:42464_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 3659589 INFO
(zkCallback-7172-thread-1-processing-n:127.0.0.1:38366_solr)
[n:127.0.0.1:38366_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 3659589 INFO
(zkCallback-7170-thread-1-processing-n:127.0.0.1:44384_solr)
[n:127.0.0.1:44384_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 3659630 INFO
(zkCallback-7174-thread-1-processing-n:127.0.0.1:36112_solr)
[n:127.0.0.1:36112_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 3659661 INFO (jetty-launcher-7131-thread-2)
[n:127.0.0.1:44384_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_44384.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3659696 INFO (jetty-launcher-7131-thread-2)
[n:127.0.0.1:44384_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_44384.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3659696 INFO (jetty-launcher-7131-thread-2)
[n:127.0.0.1:44384_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_44384.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3659697 INFO (jetty-launcher-7131-thread-2)
[n:127.0.0.1:44384_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.NodeLostTriggerTest_9DD5E15780543BAE-001/tempDir-001/node2/.
[junit4] 2> 3659808 INFO (jetty-launcher-7131-thread-1)
[n:127.0.0.1:38366_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_38366.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3659809 INFO (jetty-launcher-7131-thread-5)
[n:127.0.0.1:42464_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_42464.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3659828 INFO (jetty-launcher-7131-thread-4)
[n:127.0.0.1:36112_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36112.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3659865 INFO (jetty-launcher-7131-thread-1)
[n:127.0.0.1:38366_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_38366.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3659865 INFO (jetty-launcher-7131-thread-1)
[n:127.0.0.1:38366_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_38366.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3659866 INFO (jetty-launcher-7131-thread-5)
[n:127.0.0.1:42464_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_42464.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3659866 INFO (jetty-launcher-7131-thread-5)
[n:127.0.0.1:42464_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_42464.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3659903 INFO (jetty-launcher-7131-thread-1)
[n:127.0.0.1:38366_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.NodeLostTriggerTest_9DD5E15780543BAE-001/tempDir-001/node1/.
[junit4] 2> 3659904 INFO (jetty-launcher-7131-thread-5)
[n:127.0.0.1:42464_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.NodeLostTriggerTest_9DD5E15780543BAE-001/tempDir-001/node5/.
[junit4] 2> 3659907 INFO (jetty-launcher-7131-thread-4)
[n:127.0.0.1:36112_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36112.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3659907 INFO (jetty-launcher-7131-thread-4)
[n:127.0.0.1:36112_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36112.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3659907 INFO (jetty-launcher-7131-thread-4)
[n:127.0.0.1:36112_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.NodeLostTriggerTest_9DD5E15780543BAE-001/tempDir-001/node4/.
[junit4] 2> 3659942 INFO (jetty-launcher-7131-thread-3)
[n:127.0.0.1:36402_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 3659943 INFO (jetty-launcher-7131-thread-3)
[n:127.0.0.1:36402_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 3659944 INFO (jetty-launcher-7131-thread-3)
[n:127.0.0.1:36402_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:36402_solr
[junit4] 2> 3659945 INFO
(zkCallback-7172-thread-1-processing-n:127.0.0.1:38366_solr)
[n:127.0.0.1:38366_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 3659945 INFO
(zkCallback-7165-thread-1-processing-n:127.0.0.1:42464_solr)
[n:127.0.0.1:42464_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 3659955 INFO
(zkCallback-7170-thread-1-processing-n:127.0.0.1:44384_solr)
[n:127.0.0.1:44384_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 3659955 INFO
(zkCallback-7161-thread-1-processing-n:127.0.0.1:36402_solr)
[n:127.0.0.1:36402_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 3659958 INFO
(zkCallback-7174-thread-1-processing-n:127.0.0.1:36112_solr)
[n:127.0.0.1:36112_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 3660039 INFO (jetty-launcher-7131-thread-3)
[n:127.0.0.1:36402_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36402.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3660062 INFO (jetty-launcher-7131-thread-3)
[n:127.0.0.1:36402_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36402.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3660062 INFO (jetty-launcher-7131-thread-3)
[n:127.0.0.1:36402_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36402.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3660075 INFO (jetty-launcher-7131-thread-3)
[n:127.0.0.1:36402_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.NodeLostTriggerTest_9DD5E15780543BAE-001/tempDir-001/node3/.
[junit4] 2> 3660210 INFO (zkConnectionManagerCallback-7186-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3660211 INFO (zkConnectionManagerCallback-7190-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3660212 INFO
(SUITE-NodeLostTriggerTest-seed#[9DD5E15780543BAE]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 3660212 INFO
(SUITE-NodeLostTriggerTest-seed#[9DD5E15780543BAE]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:35496/solr ready
[junit4] 2> 3660304 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testRestoreState
[junit4] 2> 3660305 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 3660305 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 3660306 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 3660306 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 3660306 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@56fe1649{/solr,null,AVAILABLE}
[junit4] 2> 3660314 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@3b9d4025{SSL,[ssl,
http/1.1]}{127.0.0.1:41797}
[junit4] 2> 3660314 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.Server Started @3669967ms
[junit4] 2> 3660314 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=41797}
[junit4] 2> 3660315 ERROR
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3660315 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.3.0
[junit4] 2> 3660315 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3660315 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3660315 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-20T20:07:41.221Z
[junit4] 2> 3660316 INFO (zkConnectionManagerCallback-7192-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3660316 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3660331 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35496/solr
[junit4] 2> 3660331 INFO (zkConnectionManagerCallback-7196-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3660333 INFO
(zkConnectionManagerCallback-7198-thread-1-processing-n:127.0.0.1:41797_solr)
[n:127.0.0.1:41797_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3660336 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE])
[n:127.0.0.1:41797_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (5)
[junit4] 2> 3660337 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE])
[n:127.0.0.1:41797_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 3660339 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE])
[n:127.0.0.1:41797_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:41797_solr
[junit4] 2> 3660339 INFO
(zkCallback-7174-thread-1-processing-n:127.0.0.1:36112_solr)
[n:127.0.0.1:36112_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (6)
[junit4] 2> 3660339 INFO
(zkCallback-7170-thread-1-processing-n:127.0.0.1:44384_solr)
[n:127.0.0.1:44384_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (6)
[junit4] 2> 3660339 INFO
(zkCallback-7172-thread-1-processing-n:127.0.0.1:38366_solr)
[n:127.0.0.1:38366_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (6)
[junit4] 2> 3660340 INFO
(zkCallback-7165-thread-1-processing-n:127.0.0.1:42464_solr)
[n:127.0.0.1:42464_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (6)
[junit4] 2> 3660340 INFO
(zkCallback-7161-thread-1-processing-n:127.0.0.1:36402_solr)
[n:127.0.0.1:36402_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (6)
[junit4] 2> 3660340 INFO (zkCallback-7189-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 3660353 INFO
(zkCallback-7197-thread-1-processing-n:127.0.0.1:41797_solr)
[n:127.0.0.1:41797_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (6)
[junit4] 2> 3660437 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE])
[n:127.0.0.1:41797_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41797.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3660454 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE])
[n:127.0.0.1:41797_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41797.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3660454 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE])
[n:127.0.0.1:41797_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41797.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3660455 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE])
[n:127.0.0.1:41797_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.NodeLostTriggerTest_9DD5E15780543BAE-001/tempDir-001/node6/.
[junit4] 2> 3660527 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@3b9d4025{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 3660527 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1520097024
[junit4] 2> 3660528 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 3660528 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@2bb1f501: rootName =
solr_41797, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@14d9e5c8
[junit4] 2> 3660533 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 3660533 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@53cc7de9: rootName =
solr_41797, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@1b7b93b7
[junit4] 2> 3660537 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 3660537 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6e70aec5: rootName =
solr_41797, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@1de62806
[junit4] 2> 3660538 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:41797_solr
[junit4] 2> 3660539 INFO
(zkCallback-7174-thread-1-processing-n:127.0.0.1:36112_solr)
[n:127.0.0.1:36112_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (6) -> (5)
[junit4] 2> 3660539 INFO
(zkCallback-7170-thread-1-processing-n:127.0.0.1:44384_solr)
[n:127.0.0.1:44384_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (6) -> (5)
[junit4] 2> 3660539 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 3660539 INFO
(zkCallback-7165-thread-1-processing-n:127.0.0.1:42464_solr)
[n:127.0.0.1:42464_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (6) -> (5)
[junit4] 2> 3660539 INFO
(zkCallback-7197-thread-1-processing-n:127.0.0.1:41797_solr)
[n:127.0.0.1:41797_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (6) -> (5)
[junit4] 2> 3660539 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 3660539 INFO
(zkCallback-7161-thread-1-processing-n:127.0.0.1:36402_solr)
[n:127.0.0.1:36402_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (6) -> (5)
[junit4] 2> 3660539 INFO (zkCallback-7189-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 3660539 INFO
(zkCallback-7172-thread-1-processing-n:127.0.0.1:38366_solr)
[n:127.0.0.1:38366_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (6) -> (5)
[junit4] 2> 3660540 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@56fe1649{/solr,null,UNAVAILABLE}
[junit4] 2> 3660540 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 3665551 INFO
(TEST-NodeLostTriggerTest.testRestoreState-seed#[9DD5E15780543BAE]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testRestoreState
[junit4] 2> 3665697 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.SolrTestCaseJ4 ###Starting testListenerAcceptance
[junit4] 2> 3665699 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 3665699 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 3665699 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 3665699 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 3665700 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7f0a9142{/solr,null,AVAILABLE}
[junit4] 2> 3665700 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.e.j.s.AbstractConnector Started ServerConnector@3040a4a9{SSL,[ssl,
http/1.1]}{127.0.0.1:39250}
[junit4] 2> 3665700 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.e.j.s.Server Started @3675353ms
[junit4] 2> 3665700 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=39250}
[junit4] 2> 3665700 ERROR
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3665700 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.3.0
[junit4] 2> 3665700 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port
null
[junit4] 2> 3665701 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3665701 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-20T20:07:46.607Z
[junit4] 2> 3665702 INFO (zkConnectionManagerCallback-7202-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3665702 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3665771 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35496/solr
[junit4] 2> 3665772 INFO (zkConnectionManagerCallback-7206-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3665795 INFO
(zkConnectionManagerCallback-7208-thread-1-processing-n:127.0.0.1:39250_solr)
[n:127.0.0.1:39250_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3665816 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE])
[n:127.0.0.1:39250_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (5)
[junit4] 2> 3665818 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE])
[n:127.0.0.1:39250_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 3665827 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE])
[n:127.0.0.1:39250_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:39250_solr
[junit4] 2> 3665828 INFO
(zkCallback-7161-thread-1-processing-n:127.0.0.1:36402_solr)
[n:127.0.0.1:36402_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (6)
[junit4] 2> 3665828 INFO (zkCallback-7189-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 3665829 INFO
(zkCallback-7165-thread-1-processing-n:127.0.0.1:42464_solr)
[n:127.0.0.1:42464_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (6)
[junit4] 2> 3665829 INFO
(zkCallback-7172-thread-1-processing-n:127.0.0.1:38366_solr)
[n:127.0.0.1:38366_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (6)
[junit4] 2> 3665829 INFO
(zkCallback-7174-thread-1-processing-n:127.0.0.1:36112_solr)
[n:127.0.0.1:36112_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (6)
[junit4] 2> 3665829 INFO
(zkCallback-7170-thread-1-processing-n:127.0.0.1:44384_solr)
[n:127.0.0.1:44384_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (6)
[junit4] 2> 3665847 INFO
(zkCallback-7207-thread-1-processing-n:127.0.0.1:39250_solr)
[n:127.0.0.1:39250_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (6)
[junit4] 2> 3666006 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE])
[n:127.0.0.1:39250_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39250.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3666043 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE])
[n:127.0.0.1:39250_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39250.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3666043 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE])
[n:127.0.0.1:39250_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39250.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3666045 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE])
[n:127.0.0.1:39250_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.NodeLostTriggerTest_9DD5E15780543BAE-001/tempDir-001/node7/.
[junit4] 2> 3666301 INFO (zkConnectionManagerCallback-7212-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3666302 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.e.j.s.AbstractConnector Stopped ServerConnector@3040a4a9{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 3666302 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1169408518
[junit4] 2> 3666302 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 3666302 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5300a059: rootName =
solr_39250, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@7f61cba5
[junit4] 2> 3666320 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 3666320 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@35e0fd69: rootName =
solr_39250, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@1b7b93b7
[junit4] 2> 3666336 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 3666336 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@444b20ee: rootName =
solr_39250, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@1de62806
[junit4] 2> 3666337 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:39250_solr
[junit4] 2> 3666338 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 3666338 INFO
(zkCallback-7207-thread-1-processing-n:127.0.0.1:39250_solr)
[n:127.0.0.1:39250_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (6) -> (5)
[junit4] 2> 3666338 INFO
(zkCallback-7174-thread-1-processing-n:127.0.0.1:36112_solr)
[n:127.0.0.1:36112_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (6) -> (5)
[junit4] 2> 3666338 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 3666338 INFO
(zkCallback-7165-thread-1-processing-n:127.0.0.1:42464_solr)
[n:127.0.0.1:42464_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (6) -> (5)
[junit4] 2> 3666339 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@7f0a9142{/solr,null,UNAVAILABLE}
[junit4] 2> 3666339 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.e.j.s.session Stopped scavenging
[junit4] 2> 3666340 INFO (zkConnectionManagerCallback-7214-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3666341 INFO
(TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[9DD5E15780543BAE]) [
] o.a.s.SolrTestCaseJ4 ###Ending testListenerAcceptance
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=NodeLostTriggerTest
-Dtests.method=testListenerAcceptance -Dtests.seed=9DD5E15780543BAE
-Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=ms -Dtests.timezone=Libya
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 0.79s J1 | NodeLostTriggerTest.testListenerAcceptance <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<1> but
was:<0>
[junit4] > at
__randomizedtesting.SeedInfo.seed([9DD5E15780543BAE:8C61BBB039DD2F58]:0)
[junit4] > at
org.apache.solr.cloud.autoscaling.NodeLostTriggerTest.testListenerAcceptance(NodeLostTriggerTest.java:253)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 3666359 INFO
(zkCallback-7170-thread-1-processing-n:127.0.0.1:44384_solr)
[n:127.0.0.1:44384_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (6) -> (5)
[junit4] 2> 3666359 INFO
(zkCallback-7161-thread-1-processing-n:127.0.0.1:36402_solr)
[n:127.0.0.1:36402_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (6) -> (5)
[junit4] 2> 3666359 INFO (zkCallback-7189-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 3666359 INFO
(zkCallback-7172-thread-1-processing-n:127.0.0.1:38366_solr)
[n:127.0.0.1:38366_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (6) -> (5)
[junit4] 2> 3666444 INFO
(TEST-NodeLostTriggerTest.testActionLifecycle-seed#[9DD5E15780543BAE]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testActionLifecycle
[junit4] 2> 3666445 INFO
(TEST-NodeLostTriggerTest.testActionLifecycle-seed#[9DD5E15780543BAE]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testActionLifecycle
[junit4] 2> 3666526 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testTrigger
[junit4] 2> 3666527 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@118af13b{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 3666527 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=78428045
[junit4] 2> 3666527 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 3666527 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@b05745: rootName =
solr_36112, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@52697f5b
[junit4] 2> 3666541 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 3666541 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@60ca0389: rootName =
solr_36112, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@1b7b93b7
[junit4] 2> 3666545 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 3666545 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@557c3af7: rootName =
solr_36112, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@1de62806
[junit4] 2> 3666546 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:36112_solr
[junit4] 2> 3666547 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 3666547 INFO
(zkCallback-7174-thread-1-processing-n:127.0.0.1:36112_solr)
[n:127.0.0.1:36112_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (4)
[junit4] 2> 3666547 INFO
(zkCallback-7170-thread-1-processing-n:127.0.0.1:44384_solr)
[n:127.0.0.1:44384_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (4)
[junit4] 2> 3666547 INFO
(zkCallback-7161-thread-1-processing-n:127.0.0.1:36402_solr)
[n:127.0.0.1:36402_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (4)
[junit4] 2> 3666547 INFO
(zkCallback-7172-thread-1-processing-n:127.0.0.1:38366_solr)
[n:127.0.0.1:38366_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (4)
[junit4] 2> 3666547 INFO (zkCallback-7189-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 3666547 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 3666547 INFO
(zkCallback-7165-thread-1-processing-n:127.0.0.1:42464_solr)
[n:127.0.0.1:42464_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (4)
[junit4] 2> 3666548 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@78825b0c{/solr,null,UNAVAILABLE}
[junit4] 2> 3666548 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 3666553 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@248bba31{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 3666554 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=390489604
[junit4] 2> 3666554 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 3666554 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5b3bbca2: rootName =
solr_42464, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@22fa1df9
[junit4] 2> 3666563 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 3666563 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5355a88e: rootName =
solr_42464, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@1b7b93b7
[junit4] 2> 3666567 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 3666567 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@58c7efd: rootName =
solr_42464, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@1de62806
[junit4] 2> 3666580 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:42464_solr
[junit4] 2> 3666581 INFO
(zkCallback-7172-thread-1-processing-n:127.0.0.1:38366_solr)
[n:127.0.0.1:38366_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 3666581 INFO
(zkCallback-7161-thread-1-processing-n:127.0.0.1:36402_solr)
[n:127.0.0.1:36402_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 3666581 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 3666581 INFO
(zkCallback-7165-thread-1-processing-n:127.0.0.1:42464_solr)
[n:127.0.0.1:42464_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 3666582 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 3666582 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.c.Overseer Overseer
(id=99383958575185931-127.0.0.1:42464_solr-n_0000000000) closing
[junit4] 2> 3666582 INFO
(OverseerStateUpdate-99383958575185931-127.0.0.1:42464_solr-n_0000000000)
[n:127.0.0.1:42464_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:42464_solr
[junit4] 2> 3666582 WARN
(OverseerAutoScalingTriggerThread-99383958575185931-127.0.0.1:42464_solr-n_0000000000)
[n:127.0.0.1:42464_solr ] o.a.s.c.a.OverseerTriggerThread
OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 3666585 INFO
(zkCallback-7170-thread-1-processing-n:127.0.0.1:44384_solr)
[n:127.0.0.1:44384_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 3666586 INFO (zkCallback-7189-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 3666586 INFO
(zkCallback-7170-thread-2-processing-n:127.0.0.1:44384_solr)
[n:127.0.0.1:44384_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:44384_solr
[junit4] 2> 3666587 INFO
(zkCallback-7170-thread-2-processing-n:127.0.0.1:44384_solr)
[n:127.0.0.1:44384_solr ] o.a.s.c.Overseer Overseer
(id=99383958575185933-127.0.0.1:44384_solr-n_0000000001) starting
[junit4] 2> 3668086 WARN
(zkCallback-7165-thread-1-processing-n:127.0.0.1:42464_solr)
[n:127.0.0.1:42464_solr ] o.a.s.c.ZkController Unable to register nodeLost
path for 127.0.0.1:42464_solr
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException:
KeeperErrorCode = Session expired for /autoscaling/nodeLost/127.0.0.1:42464_solr
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:783)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.lambda$create$7(SolrZkClient.java:364)
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:364)
[junit4] 2> at
org.apache.solr.cloud.ZkController.lambda$registerLiveNodesListener$2(ZkController.java:879)
[junit4] 2> at
org.apache.solr.common.cloud.ZkStateReader.lambda$refreshLiveNodes$1(ZkStateReader.java:704)
[junit4] 2> at
java.util.concurrent.ConcurrentHashMap$KeySetView.forEach(ConcurrentHashMap.java:4649)
[junit4] 2> at
org.apache.solr.common.cloud.ZkStateReader.refreshLiveNodes(ZkStateReader.java:703)
[junit4] 2> at
org.apache.solr.common.cloud.ZkStateReader.access$900(ZkStateReader.java:72)
[junit4] 2> at
org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.refreshAndWatch(ZkStateReader.java:1090)
[junit4] 2> at
org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.process(ZkStateReader.java:1085)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$1.lambda$process$1(SolrZkClient.java:268)
[junit4] 2> at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at
java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 3668090 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@7134da09{/solr,null,UNAVAILABLE}
[junit4] 2> 3668090 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 3673117 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@6d8c087f{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 3673118 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1338798192
[junit4] 2> 3673118 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 3673118 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@3c54d05f: rootName =
solr_38366, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@1b592dc3
[junit4] 2> 3673123 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 3673123 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@44e52b5e: rootName =
solr_38366, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@1b7b93b7
[junit4] 2> 3673176 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 3673176 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@618028b9: rootName =
solr_38366, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@1de62806
[junit4] 2> 3673177 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:38366_solr
[junit4] 2> 3673177 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 3673177 INFO
(zkCallback-7161-thread-1-processing-n:127.0.0.1:36402_solr)
[n:127.0.0.1:36402_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 3673177 INFO (zkCallback-7189-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 3673177 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 3673178 INFO
(zkCallback-7170-thread-2-processing-n:127.0.0.1:44384_solr)
[n:127.0.0.1:44384_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 3673178 INFO
(zkCallback-7172-thread-1-processing-n:127.0.0.1:38366_solr)
[n:127.0.0.1:38366_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 3673178 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@24b1f9ae{/solr,null,UNAVAILABLE}
[junit4] 2> 3673179 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 3673180 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 3673181 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 3673181 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 3673181 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 3673181 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@532c59df{/solr,null,AVAILABLE}
[junit4] 2> 3673182 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@104ea67{SSL,[ssl,
http/1.1]}{127.0.0.1:38366}
[junit4] 2> 3673182 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.e.j.s.Server Started @3682835ms
[junit4] 2> 3673182 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=38366}
[junit4] 2> 3673182 ERROR
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3673182 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.3.0
[junit4] 2> 3673182 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3673182 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3673182 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-20T20:07:54.088Z
[junit4] 2> 3673183 INFO (zkConnectionManagerCallback-7216-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3673184 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3673194 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35496/solr
[junit4] 2> 3673217 INFO (zkConnectionManagerCallback-7220-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3673219 INFO
(zkConnectionManagerCallback-7222-thread-1-processing-n:127.0.0.1:38366_solr)
[n:127.0.0.1:38366_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3673222 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE])
[n:127.0.0.1:38366_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 3673223 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE])
[n:127.0.0.1:38366_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 3673224 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE])
[n:127.0.0.1:38366_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:38366_solr
[junit4] 2> 3673225 INFO
(zkCallback-7161-thread-1-processing-n:127.0.0.1:36402_solr)
[n:127.0.0.1:36402_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 3673225 INFO
(zkCallback-7170-thread-2-processing-n:127.0.0.1:44384_solr)
[n:127.0.0.1:44384_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 3673225 INFO (zkCallback-7189-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 3673225 INFO
(zkCallback-7221-thread-1-processing-n:127.0.0.1:38366_solr)
[n:127.0.0.1:38366_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 3673291 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE])
[n:127.0.0.1:38366_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_38366.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3673300 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE])
[n:127.0.0.1:38366_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_38366.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3673300 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE])
[n:127.0.0.1:38366_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_38366.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7a46acea
[junit4] 2> 3673301 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE])
[n:127.0.0.1:38366_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.NodeLostTriggerTest_9DD5E15780543BAE-001/tempDir-001/node1/.
[junit4] 2> 3678340 INFO
(TEST-NodeLostTriggerTest.testTrigger-seed#[9DD5E15780543BAE]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testTrigger
[junit4] 2> 3678343 INFO (jetty-closer-7132-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@104ea67{SSL,[ssl,
http/1.1]}{127.0.0.1:38366}
[junit4] 2> 3678343 INFO (jetty-closer-7132-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@25c8b0aa{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 3678343 INFO (jetty-closer-7132-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@4576f23c{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 3678344 INFO (jetty-closer-7132-thread-1) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=746668030
[junit4] 2> 3678350 INFO (jetty-closer-7132-thread-3) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=2102868912
[junit4] 2> 3678343 INFO (jetty-closer-7132-thread-2) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=984763327
[junit4] 2> 3678350 INFO (jetty-closer-7132-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 3678350 INFO (jetty-closer-7132-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 3678350 INFO (jetty-closer-7132-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@716fb70e: rootName =
solr_44384, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@5a9d44ef
[junit4] 2> 3678350 INFO (jetty-closer-7132-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@3308d4c: rootName =
solr_38366, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@382275a0
[junit4] 2> 3678354 INFO (jetty-closer-7132-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 3678354 INFO (jetty-closer-7132-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@58e3361f: rootName =
solr_44384, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@1b7b93b7
[junit4] 2> 3678370 INFO (jetty-closer-7132-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 3678370 INFO (jetty-closer-7132-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@784a04fd: rootName =
solr_38366, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@1b7b93b7
[junit4] 2> 3678373 INFO (jetty-closer-7132-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 3678373 INFO (jetty-closer-7132-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5046a165: rootName =
solr_44384, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@1de62806
[junit4] 2> 3678375 INFO (jetty-closer-7132-thread-1) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:44384_solr
[junit4] 2> 3678375 INFO (jetty-closer-7132-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 3678376 INFO (jetty-closer-7132-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 3678376 INFO (jetty-closer-7132-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@335723af: rootName =
solr_36402, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@62bce920
[junit4] 2> 3678392 INFO (jetty-closer-7132-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 3678393 INFO (jetty-closer-7132-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@23c5daee: rootName =
solr_36402, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@1b7b93b7
[junit4] 2> 3678393 INFO (jetty-closer-7132-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 3678393 INFO (jetty-closer-7132-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=99383958575185933-127.0.0.1:44384_solr-n_0000000001) closing
[junit4] 2> 3678393 INFO
(OverseerStateUpdate-99383958575185933-127.0.0.1:44384_solr-n_0000000001)
[n:127.0.0.1:44384_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:44384_solr
[junit4] 2> 3678393 WARN
(OverseerAutoScalingTriggerThread-99383958575185933-127.0.0.1:44384_solr-n_0000000001)
[n:127.0.0.1:44384_solr ] o.a.s.c.a.OverseerTriggerThread
OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 3678405 INFO
(zkCallback-7170-thread-1-processing-n:127.0.0.1:44384_solr)
[n:127.0.0.1:44384_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 3678405 INFO
(zkCallback-7221-thread-1-processing-n:127.0.0.1:38366_solr)
[n:127.0.0.1:38366_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 3678406 INFO
(zkCallback-7161-thread-1-processing-n:127.0.0.1:36402_solr)
[n:127.0.0.1:36402_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 3678407 INFO (jetty-closer-7132-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 3678407 INFO (jetty-closer-7132-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@42180e6e: rootName =
solr_38366, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@1de62806
[junit4] 2> 3678408 INFO (jetty-closer-7132-thread-2) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:38366_solr
[junit4] 2> 3678408 INFO (jetty-closer-7132-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 3678408 INFO (jetty-closer-7132-thread-2) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 3678410 INFO (jetty-closer-7132-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 3678410 INFO (jetty-closer-7132-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5e41d2e8: rootName =
solr_36402, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@1de62806
[junit4] 2> 3678430 INFO (jetty-closer-7132-thread-3) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:36402_solr
[junit4] 2> 3678430 INFO (jetty-closer-7132-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 3678430 INFO (jetty-closer-7132-thread-3) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 3678453 INFO
(zkCallback-7161-thread-1-processing-n:127.0.0.1:36402_solr)
[n:127.0.0.1:36402_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (1)
[junit4] 2> 3678453 INFO (jetty-closer-7132-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@77af8ba3{/solr,null,UNAVAILABLE}
[junit4] 2> 3678465 INFO
(zkCallback-7161-thread-2-processing-n:127.0.0.1:36402_solr)
[n:127.0.0.1:36402_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:36402_solr
[junit4] 2> 3678466 INFO (jetty-closer-7132-thread-1) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 3678466 INFO (jetty-closer-7132-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@25385ae1{/solr,null,UNAVAILABLE}
[junit4] 2> 3678467 INFO (jetty-closer-7132-thread-3) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 3679929 WARN
(zkCallback-7221-thread-1-processing-n:127.0.0.1:38366_solr)
[n:127.0.0.1:38366_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 3679930 INFO (jetty-closer-7132-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@532c59df{/solr,null,UNAVAILABLE}
[junit4] 2> 3679930 INFO (jetty-closer-7132-thread-2) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 3679930 ERROR
(SUITE-NodeLostTriggerTest-seed#[9DD5E15780543BAE]-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> 3679931 INFO
(SUITE-NodeLostTriggerTest-seed#[9DD5E15780543BAE]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:35496 35496
[junit4] 2> 3679984 INFO (Thread-4254) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:35496 35496
[junit4] 2> 3679984 WARN (Thread-4254) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 9 /solr/aliases.json
[...truncated too long message...]
ry solr.core.collection1.shard1.replica_n1 /
com.codahale.metrics.MetricRegistry@50f887c
[junit4] 2> 492952 INFO (coreCloseExecutor-849-thread-1)
[n:127.0.0.1:35379_solr c:collection1 s:shard1 r:core_node3
x:collection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.collection1.shard1.leader, tag=1576205090
[junit4] 2> 492968 INFO (coreCloseExecutor-850-thread-1)
[n:127.0.0.1:34587_solr c:collection1 s:shard2 r:core_node4
x:collection1_shard2_replica_n2] o.a.s.c.SolrCore
[collection1_shard2_replica_n2] CLOSING SolrCore
org.apache.solr.core.SolrCore@572058ac
[junit4] 2> 492969 INFO (coreCloseExecutor-850-thread-1)
[n:127.0.0.1:34587_solr c:collection1 s:shard2 r:core_node4
x:collection1_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.collection1.shard2.replica_n2, tag=1461737644
[junit4] 2> 492969 INFO (coreCloseExecutor-850-thread-1)
[n:127.0.0.1:34587_solr c:collection1 s:shard2 r:core_node4
x:collection1_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@63491833: rootName =
solr_34587, domain = solr.core.collection1.shard2.replica_n2, service url =
null, agent id = null] for registry solr.core.collection1.shard2.replica_n2 /
com.codahale.metrics.MetricRegistry@c49e68c
[junit4] 2> 492969 INFO (jetty-closer-402-thread-4) [ ]
o.a.s.c.Overseer Overseer
(id=99384004033970188-127.0.0.1:35379_solr-n_0000000000) closing
[junit4] 2> 492970 INFO
(OverseerStateUpdate-99384004033970188-127.0.0.1:35379_solr-n_0000000000)
[n:127.0.0.1:35379_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:35379_solr
[junit4] 2> 492970 WARN
(OverseerAutoScalingTriggerThread-99384004033970188-127.0.0.1:35379_solr-n_0000000000)
[n:127.0.0.1:35379_solr ] o.a.s.c.a.OverseerTriggerThread
OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 492980 INFO
(zkCallback-431-thread-3-processing-n:127.0.0.1:34587_solr)
[n:127.0.0.1:34587_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:34587_solr
[junit4] 2> 492988 INFO (coreCloseExecutor-850-thread-1)
[n:127.0.0.1:34587_solr c:collection1 s:shard2 r:core_node4
x:collection1_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.collection1.shard2.leader, tag=1461737644
[junit4] 2> 492989 INFO (jetty-closer-402-thread-4) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@1433a77d{/solr,null,UNAVAILABLE}
[junit4] 2> 492992 INFO (jetty-closer-402-thread-4) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 493005 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1611539a0cd000a, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 493005 INFO (jetty-closer-402-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@19d8d92b{/solr,null,UNAVAILABLE}
[junit4] 2> 493005 INFO (jetty-closer-402-thread-3) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 493006 ERROR
(SUITE-StreamExpressionTest-seed#[858D41DF7385970]-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> 493006 INFO
(SUITE-StreamExpressionTest-seed#[858D41DF7385970]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:35631 35631
[junit4] 2> 493248 INFO (Thread-488) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:35631 35631
[junit4] 2> 493249 WARN (Thread-488) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 99 /solr/aliases.json
[junit4] 2> 11 /solr/configs/conf
[junit4] 2> 8 /solr/configs/ml
[junit4] 2> 4 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 99 /solr/clusterprops.json
[junit4] 2> 99 /solr/clusterstate.json
[junit4] 2> 42
/solr/collections/destinationCollection/state.json
[junit4] 2> 28
/solr/collections/parallelDestinationCollection1/state.json
[junit4] 2> 22
/solr/collections/parallelDestinationCollection/state.json
[junit4] 2> 14 /solr/collections/collection1/state.json
[junit4] 2> 12 /solr/collections/workQueue1/state.json
[junit4] 2> 10 /solr/collections/mainCorpus1/state.json
[junit4] 2> 10 /solr/collections/destination/state.json
[junit4] 2> 10 /solr/collections/destination1/state.json
[junit4] 2> 10 /solr/collections/workQueue/state.json
[junit4] 2> 10 /solr/collections/uknownCollection/state.json
[junit4] 2> 10 /solr/collections/modelCollection/state.json
[junit4] 2> 10
/solr/collections/checkpointCollection/state.json
[junit4] 2> 10 /solr/collections/mainCorpus/state.json
[junit4] 2> 2
/solr/overseer_elect/election/99384004033970187-127.0.0.1:40422_solr-n_0000000001
[junit4] 2> 2
/solr/overseer_elect/election/99384004033970188-127.0.0.1:35379_solr-n_0000000000
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 99 /solr/live_nodes
[junit4] 2> 99 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.StreamExpressionTest_858D41DF7385970-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{expr_s=PostingsFormat(name=Asserting),
name_s=PostingsFormat(name=LuceneFixedGap),
terms_ss=PostingsFormat(name=MockRandom),
join2_s=PostingsFormat(name=MockRandom), field_s=PostingsFormat(name=Memory),
multiDefault=PostingsFormat(name=MockRandom),
subject=PostingsFormat(name=MockRandom), a1_s=PostingsFormat(name=MockRandom),
a2_s=PostingsFormat(name=LuceneFixedGap),
level1_s=PostingsFormat(name=Asserting),
body_t=PostingsFormat(name=LuceneFixedGap),
s_multi=PostingsFormat(name=LuceneFixedGap), a_ss=PostingsFormat(name=Memory),
level2_s=PostingsFormat(name=Memory), col_s=PostingsFormat(name=MockRandom),
a_s=PostingsFormat(name=LuceneFixedGap), tv_text=PostingsFormat(name=Memory),
term_s=PostingsFormat(name=MockRandom), a_t=PostingsFormat(name=Memory),
text_s=PostingsFormat(name=Asserting), id=PostingsFormat(name=Asserting),
text=PostingsFormat(name=LuceneFixedGap),
featureSet_s=PostingsFormat(name=MockRandom),
checkpoint_ss=PostingsFormat(name=LuceneFixedGap),
test_t=PostingsFormat(name=LuceneFixedGap),
ident_s=PostingsFormat(name=MockRandom),
whitetok=PostingsFormat(name=LuceneFixedGap),
side_s=PostingsFormat(name=LuceneFixedGap)},
docValues:{expr_s=DocValuesFormat(name=Lucene70),
name_s=DocValuesFormat(name=Lucene70),
iteration_i=DocValuesFormat(name=Lucene70),
terms_ss=DocValuesFormat(name=Direct), join2_s=DocValuesFormat(name=Direct),
field_s=DocValuesFormat(name=Memory),
multiDefault=DocValuesFormat(name=Direct),
price_f=DocValuesFormat(name=Direct), a1_s=DocValuesFormat(name=Direct),
intDefault=DocValuesFormat(name=Memory), a_f=DocValuesFormat(name=Direct),
join1_i=DocValuesFormat(name=Lucene70), a2_s=DocValuesFormat(name=Lucene70),
falseNegative_i=DocValuesFormat(name=Memory),
a_i=DocValuesFormat(name=Lucene70), join3_i=DocValuesFormat(name=Lucene70),
test_i=DocValuesFormat(name=Direct),
falsePositive_i=DocValuesFormat(name=Memory),
field_i=DocValuesFormat(name=Direct), level1_s=DocValuesFormat(name=Lucene70),
s_multi=DocValuesFormat(name=Lucene70), a_ss=DocValuesFormat(name=Memory),
level2_s=DocValuesFormat(name=Memory), col_s=DocValuesFormat(name=Direct),
a_s=DocValuesFormat(name=Lucene70), score_f=DocValuesFormat(name=Lucene70),
term_s=DocValuesFormat(name=Direct), text_s=DocValuesFormat(name=Lucene70),
id=DocValuesFormat(name=Lucene70), timestamp=DocValuesFormat(name=Memory),
i_multi=DocValuesFormat(name=Lucene70),
featureSet_s=DocValuesFormat(name=Direct),
trueNegative_i=DocValuesFormat(name=Lucene70),
index_i=DocValuesFormat(name=Direct), b_ls=DocValuesFormat(name=Direct),
test_dt=DocValuesFormat(name=Lucene70), out_i=DocValuesFormat(name=Direct),
checkpoint_ss=DocValuesFormat(name=Lucene70),
ident_s=DocValuesFormat(name=Direct), order_i=DocValuesFormat(name=Direct),
_version_=DocValuesFormat(name=Memory), side_s=DocValuesFormat(name=Lucene70),
truePositive_i=DocValuesFormat(name=Lucene70),
miles_i=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=509,
maxMBSortInHeap=7.714132312339974, sim=RandomSimilarity(queryNorm=false): {},
locale=en-US, timezone=Australia/Adelaide
[junit4] 2> NOTE: Linux 4.4.0-104-generic amd64/Oracle Corporation
1.8.0_152 (64-bit)/cpus=4,threads=1,free=212349512,total=457179136
[junit4] 2> NOTE: All tests run in this JVM: [NaturalLogEvaluatorTest,
FieldValueEvaluatorTest, UsingSolrJRefGuideExamplesTest, TestPathTrie,
RawValueEvaluatorTest, TestXMLEscaping, ReverseEvaluatorTest,
TestClusteringResponse, CubedRootEvaluatorTest, FieldAnalysisResponseTest,
LessThanEvaluatorTest, TestEmbeddedSolrServer, SolrExampleStreamingTest,
LargeVolumeEmbeddedTest, GreaterThanEvaluatorTest, ContentStreamTest,
GraphExpressionTest, SchemaTest, TestToleratedUpdateError,
ConcurrentUpdateSolrClientBuilderTest, AscEvaluatorTest,
SolrSchemalessExampleTest, GraphTest, JDBCStreamTest, StreamExpressionTest]
[junit4] Completed [146/146 (1!)] on J0 in 227.52s, 151 tests, 1 failure <<<
FAILURES!
[...truncated 47225 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
