You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2018/05/23 21:49:19 UTC
[JENKINS] Lucene-Solr-master-Linux (32bit/jdk1.8.0_172) - Build #
22088 - Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/22088/
Java: 32bit/jdk1.8.0_172 -server -XX:+UseParallelGC
1 tests failed.
FAILED: org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState
Error Message:
Newly added node was not present in event message
Stack Trace:
java.lang.AssertionError: Newly added node was not present in event message
at __randomizedtesting.SeedInfo.seed([46DAE7F641F56910:88744365B9CC1106]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState(NodeAddedTriggerTest.java:306)
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 14478 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_46DAE7F641F56910-001/init-core-data-001
[junit4] 2> 1832877 INFO (SUITE-NodeAddedTriggerTest-seed#[46DAE7F641F56910]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_46DAE7F641F56910-001/tempDir-001
[junit4] 2> 1832877 INFO (SUITE-NodeAddedTriggerTest-seed#[46DAE7F641F56910]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1832878 INFO (Thread-5689) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1832878 INFO (Thread-5689) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1832880 ERROR (Thread-5689) [ ] 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> 1832978 INFO (SUITE-NodeAddedTriggerTest-seed#[46DAE7F641F56910]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:33317
[junit4] 2> 1832981 INFO (zkConnectionManagerCallback-12856-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1832989 INFO (jetty-launcher-12853-thread-1) [ ] o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git: daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
[junit4] 2> 1832989 INFO (jetty-launcher-12853-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1832989 INFO (jetty-launcher-12853-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1832989 INFO (jetty-launcher-12853-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1832990 INFO (jetty-launcher-12853-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1081b0c{/solr,null,AVAILABLE}
[junit4] 2> 1832990 INFO (jetty-launcher-12853-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1f94a8b{SSL,[ssl, http/1.1]}{127.0.0.1:43139}
[junit4] 2> 1832990 INFO (jetty-launcher-12853-thread-1) [ ] o.e.j.s.Server Started @1833019ms
[junit4] 2> 1832990 INFO (jetty-launcher-12853-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=43139}
[junit4] 2> 1832990 ERROR (jetty-launcher-12853-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1832990 INFO (jetty-launcher-12853-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1832990 INFO (jetty-launcher-12853-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0
[junit4] 2> 1832990 INFO (jetty-launcher-12853-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1832990 INFO (jetty-launcher-12853-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1832990 INFO (jetty-launcher-12853-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-05-23T21:30:15.765Z
[junit4] 2> 1832991 INFO (zkConnectionManagerCallback-12858-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1832991 INFO (jetty-launcher-12853-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1832997 INFO (jetty-launcher-12853-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33317/solr
[junit4] 2> 1832998 INFO (zkConnectionManagerCallback-12862-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1833000 INFO (zkConnectionManagerCallback-12864-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1833027 INFO (jetty-launcher-12853-thread-1) [n:127.0.0.1:43139_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1833027 INFO (jetty-launcher-12853-thread-1) [n:127.0.0.1:43139_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:43139_solr
[junit4] 2> 1833027 INFO (jetty-launcher-12853-thread-1) [n:127.0.0.1:43139_solr ] o.a.s.c.Overseer Overseer (id=72076738895085571-127.0.0.1:43139_solr-n_0000000000) starting
[junit4] 2> 1833031 INFO (zkConnectionManagerCallback-12871-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1833032 INFO (jetty-launcher-12853-thread-1) [n:127.0.0.1:43139_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33317/solr ready
[junit4] 2> 1833032 INFO (jetty-launcher-12853-thread-1) [n:127.0.0.1:43139_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43139_solr
[junit4] 2> 1833032 INFO (zkCallback-12870-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1833033 INFO (zkCallback-12863-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1833744 INFO (jetty-launcher-12853-thread-1) [n:127.0.0.1:43139_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43139.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d56107
[junit4] 2> 1833749 INFO (jetty-launcher-12853-thread-1) [n:127.0.0.1:43139_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43139.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d56107
[junit4] 2> 1833749 INFO (jetty-launcher-12853-thread-1) [n:127.0.0.1:43139_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43139.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d56107
[junit4] 2> 1833750 INFO (jetty-launcher-12853-thread-1) [n:127.0.0.1:43139_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_46DAE7F641F56910-001/tempDir-001/node1/.
[junit4] 2> 1833771 INFO (zkConnectionManagerCallback-12873-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1833774 INFO (zkConnectionManagerCallback-12878-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1833774 INFO (SUITE-NodeAddedTriggerTest-seed#[46DAE7F641F56910]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1833775 INFO (SUITE-NodeAddedTriggerTest-seed#[46DAE7F641F56910]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33317/solr ready
[junit4] 2> 1833828 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git: daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
[junit4] 2> 1833829 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1833829 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1833829 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1833829 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@11c715{/solr,null,AVAILABLE}
[junit4] 2> 1833830 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@ebdab1{SSL,[ssl, http/1.1]}{127.0.0.1:43851}
[junit4] 2> 1833830 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.Server Started @1833859ms
[junit4] 2> 1833830 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=43851}
[junit4] 2> 1833830 ERROR (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1833830 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1833830 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0
[junit4] 2> 1833830 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1833830 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1833830 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-05-23T21:30:16.605Z
[junit4] 2> 1833831 INFO (zkConnectionManagerCallback-12880-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1833831 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1833839 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33317/solr
[junit4] 2> 1833839 INFO (zkConnectionManagerCallback-12884-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1833841 INFO (zkConnectionManagerCallback-12886-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1833844 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:43851_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1833844 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:43851_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1833845 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:43851_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1833845 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:43851_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43851_solr
[junit4] 2> 1833845 INFO (zkCallback-12870-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1833846 INFO (zkCallback-12885-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1833846 INFO (zkCallback-12863-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1833846 INFO (zkCallback-12877-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1834061 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:43851_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43851.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d56107
[junit4] 2> 1834068 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:43851_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43851.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d56107
[junit4] 2> 1834068 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:43851_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43851.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d56107
[junit4] 2> 1834069 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:43851_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_46DAE7F641F56910-001/tempDir-001/node2/.
[junit4] 2> 1834072 INFO (zkConnectionManagerCallback-12893-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1834073 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:43851_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1834073 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:43851_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33317/solr ready
[junit4] 2> 1834092 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git: daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
[junit4] 2> 1834093 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1834093 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1834093 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1834093 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@50881f{/solr,null,AVAILABLE}
[junit4] 2> 1834093 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1dad734{SSL,[ssl, http/1.1]}{127.0.0.1:38415}
[junit4] 2> 1834093 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.Server Started @1834123ms
[junit4] 2> 1834093 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=38415}
[junit4] 2> 1834094 ERROR (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1834094 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1834094 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0
[junit4] 2> 1834094 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1834094 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1834094 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-05-23T21:30:16.869Z
[junit4] 2> 1834095 INFO (zkConnectionManagerCallback-12895-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1834095 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1834102 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33317/solr
[junit4] 2> 1834102 INFO (zkConnectionManagerCallback-12899-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1834104 INFO (zkConnectionManagerCallback-12901-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1834106 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:38415_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1834107 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:38415_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1834107 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:38415_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1834107 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:38415_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38415_solr
[junit4] 2> 1834108 INFO (zkCallback-12870-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1834108 INFO (zkCallback-12877-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1834108 INFO (zkCallback-12885-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1834108 INFO (zkCallback-12892-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1834108 INFO (zkCallback-12900-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1834108 INFO (zkCallback-12863-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1834596 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:38415_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38415.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d56107
[junit4] 2> 1834603 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:38415_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38415.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d56107
[junit4] 2> 1834603 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:38415_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38415.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d56107
[junit4] 2> 1834604 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:38415_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_46DAE7F641F56910-001/tempDir-001/node3/.
[junit4] 2> 1834607 INFO (zkConnectionManagerCallback-12908-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1834608 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:38415_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 1834608 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:38415_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33317/solr ready
[junit4] 2> 1836635 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git: daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
[junit4] 2> 1836636 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1836636 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1836636 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1836636 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@15bd0a2{/solr,null,AVAILABLE}
[junit4] 2> 1836636 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@767331{SSL,[ssl, http/1.1]}{127.0.0.1:41311}
[junit4] 2> 1836636 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.Server Started @1836666ms
[junit4] 2> 1836636 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41311}
[junit4] 2> 1836637 ERROR (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1836637 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1836637 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0
[junit4] 2> 1836637 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1836637 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1836637 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-05-23T21:30:19.412Z
[junit4] 2> 1836638 INFO (zkConnectionManagerCallback-12910-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1836638 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1836646 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33317/solr
[junit4] 2> 1836647 INFO (zkConnectionManagerCallback-12914-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1836649 INFO (zkConnectionManagerCallback-12916-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1836651 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:41311_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 1836652 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:41311_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1836653 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:41311_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1836653 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:41311_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41311_solr
[junit4] 2> 1836654 INFO (zkCallback-12900-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1836654 INFO (zkCallback-12870-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1836654 INFO (zkCallback-12863-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1836654 INFO (zkCallback-12885-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1836654 INFO (zkCallback-12892-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1836654 INFO (zkCallback-12877-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1836654 INFO (zkCallback-12915-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1836654 INFO (zkCallback-12907-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1837107 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:41311_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41311.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d56107
[junit4] 2> 1837114 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:41311_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41311.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d56107
[junit4] 2> 1837115 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:41311_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41311.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d56107
[junit4] 2> 1837116 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:41311_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_46DAE7F641F56910-001/tempDir-001/node4/.
[junit4] 2> 1837118 INFO (zkConnectionManagerCallback-12923-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1837119 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:41311_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1837119 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [n:127.0.0.1:41311_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33317/solr ready
[junit4] 2> 1837151 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@767331{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 1837151 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=13733316
[junit4] 2> 1837151 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1837151 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@14d0340: rootName = solr_41311, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@c3ea44
[junit4] 2> 1837157 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1837157 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@111f5fc: rootName = solr_41311, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1794dec
[junit4] 2> 1837161 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1837161 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@17e7636: rootName = solr_41311, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@c6b4a3
[junit4] 2> 1837162 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:41311_solr
[junit4] 2> 1837163 INFO (zkCallback-12885-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1837163 INFO (zkCallback-12870-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1837163 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1837163 INFO (zkCallback-12907-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1837163 INFO (zkCallback-12877-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1837163 INFO (zkCallback-12915-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1837163 INFO (zkCallback-12892-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1837163 INFO (zkCallback-12863-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1837163 INFO (zkCallback-12900-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1837163 INFO (zkCallback-12922-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1837164 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@15bd0a2{/solr,null,UNAVAILABLE}
[junit4] 2> 1837164 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[46DAE7F641F56910]) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1842389 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [ ] o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git: daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
[junit4] 2> 1842390 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1842390 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1842390 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1842390 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@be05c4{/solr,null,AVAILABLE}
[junit4] 2> 1842390 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1d791d6{SSL,[ssl, http/1.1]}{127.0.0.1:43243}
[junit4] 2> 1842390 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [ ] o.e.j.s.Server Started @1842420ms
[junit4] 2> 1842390 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=43243}
[junit4] 2> 1842391 ERROR (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1842391 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1842391 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0
[junit4] 2> 1842391 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1842391 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1842391 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-05-23T21:30:25.166Z
[junit4] 2> 1842392 INFO (zkConnectionManagerCallback-12925-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1842392 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1842399 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33317/solr
[junit4] 2> 1842400 INFO (zkConnectionManagerCallback-12929-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1842401 INFO (zkConnectionManagerCallback-12931-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1842404 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [n:127.0.0.1:43243_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 1842405 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [n:127.0.0.1:43243_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1842406 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [n:127.0.0.1:43243_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1842406 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [n:127.0.0.1:43243_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43243_solr
[junit4] 2> 1842406 INFO (zkCallback-12870-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1842406 INFO (zkCallback-12892-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1842406 INFO (zkCallback-12885-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1842406 INFO (zkCallback-12877-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1842406 INFO (zkCallback-12900-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1842406 INFO (zkCallback-12863-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1842406 INFO (zkCallback-12907-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1842408 INFO (zkCallback-12930-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1843418 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [n:127.0.0.1:43243_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43243.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d56107
[junit4] 2> 1843425 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [n:127.0.0.1:43243_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43243.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d56107
[junit4] 2> 1843425 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [n:127.0.0.1:43243_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43243.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d56107
[junit4] 2> 1843426 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [n:127.0.0.1:43243_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_46DAE7F641F56910-001/tempDir-001/node5/.
[junit4] 2> 1843429 INFO (zkConnectionManagerCallback-12938-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1843430 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [n:127.0.0.1:43243_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1843430 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[46DAE7F641F56910]) [n:127.0.0.1:43243_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33317/solr ready
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=NodeAddedTriggerTest -Dtests.method=testRestoreState -Dtests.seed=46DAE7F641F56910 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=en-US -Dtests.timezone=Africa/Dakar -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 5.19s J2 | NodeAddedTriggerTest.testRestoreState <<<
[junit4] > Throwable #1: java.lang.AssertionError: Newly added node was not present in event message
[junit4] > at __randomizedtesting.SeedInfo.seed([46DAE7F641F56910:88744365B9CC1106]:0)
[junit4] > at org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState(NodeAddedTriggerTest.java:306)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1847627 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [ ] o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git: daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
[junit4] 2> 1847628 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1847628 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1847628 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1847628 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1b149b9{/solr,null,AVAILABLE}
[junit4] 2> 1847629 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1eb40af{SSL,[ssl, http/1.1]}{127.0.0.1:39667}
[junit4] 2> 1847629 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [ ] o.e.j.s.Server Started @1847658ms
[junit4] 2> 1847629 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=39667}
[junit4] 2> 1847629 ERROR (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1847629 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1847629 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0
[junit4] 2> 1847629 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1847629 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1847629 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-05-23T21:30:30.404Z
[junit4] 2> 1847630 INFO (zkConnectionManagerCallback-12940-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1847630 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1847638 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33317/solr
[junit4] 2> 1847639 INFO (zkConnectionManagerCallback-12944-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1847641 INFO (zkConnectionManagerCallback-12946-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1847644 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [n:127.0.0.1:39667_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1847645 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [n:127.0.0.1:39667_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1847646 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [n:127.0.0.1:39667_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1847646 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [n:127.0.0.1:39667_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39667_solr
[junit4] 2> 1847647 INFO (zkCallback-12885-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1847647 INFO (zkCallback-12877-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1847647 INFO (zkCallback-12870-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1847647 INFO (zkCallback-12900-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1847647 INFO (zkCallback-12892-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1847647 INFO (zkCallback-12930-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1847647 INFO (zkCallback-12863-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1847647 INFO (zkCallback-12937-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1847647 INFO (zkCallback-12945-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1847648 INFO (zkCallback-12907-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1847916 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [n:127.0.0.1:39667_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39667.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d56107
[junit4] 2> 1847923 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [n:127.0.0.1:39667_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39667.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d56107
[junit4] 2> 1847923 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [n:127.0.0.1:39667_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39667.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d56107
[junit4] 2> 1847925 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [n:127.0.0.1:39667_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_46DAE7F641F56910-001/tempDir-001/node6/.
[junit4] 2> 1847927 INFO (zkConnectionManagerCallback-12953-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1847928 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [n:127.0.0.1:39667_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 1847929 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[46DAE7F641F56910]) [n:127.0.0.1:39667_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33317/solr ready
[junit4] 2> 1847970 INFO (jetty-closer-12854-thread-3) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1dad734{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 1847972 INFO (jetty-closer-12854-thread-3) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=16970762
[junit4] 2> 1847972 INFO (jetty-closer-12854-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@ebdab1{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 1847974 INFO (jetty-closer-12854-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1847974 INFO (jetty-closer-12854-thread-2) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2644600
[junit4] 2> 1847974 INFO (jetty-closer-12854-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@11e0a63: rootName = solr_38415, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@1da1f73
[junit4] 2> 1847975 INFO (jetty-closer-12854-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1847975 INFO (jetty-closer-12854-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1f94a8b{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 1847975 INFO (jetty-closer-12854-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1a11fbb: rootName = solr_43851, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@13b5d77
[junit4] 2> 1847977 INFO (jetty-closer-12854-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=18849992
[junit4] 2> 1847978 INFO (jetty-closer-12854-thread-4) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1eb40af{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 1847978 INFO (jetty-closer-12854-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1847981 INFO (jetty-closer-12854-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1117529: rootName = solr_43139, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@16158bf
[junit4] 2> 1847981 INFO (jetty-closer-12854-thread-5) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1d791d6{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 1847983 INFO (jetty-closer-12854-thread-5) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=30535375
[junit4] 2> 1847983 INFO (jetty-closer-12854-thread-4) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2463169
[junit4] 2> 1847983 INFO (jetty-closer-12854-thread-5) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1847983 INFO (jetty-closer-12854-thread-5) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1f151a6: rootName = solr_43243, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@3d9356
[junit4] 2> 1847983 INFO (jetty-closer-12854-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1847983 INFO (jetty-closer-12854-thread-4) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@531036: rootName = solr_39667, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@11cddf6
[junit4] 2> 1847990 INFO (jetty-closer-12854-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1847990 INFO (jetty-closer-12854-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@68af2a: rootName = solr_43139, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1794dec
[junit4] 2> 1847990 INFO (jetty-closer-12854-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1847990 INFO (jetty-closer-12854-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1847990 INFO (jetty-closer-12854-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@df03b3: rootName = solr_38415, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1794dec
[junit4] 2> 1847990 INFO (jetty-closer-12854-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@cd930c: rootName = solr_43851, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1794dec
[junit4] 2> 1847991 INFO (jetty-closer-12854-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1847991 INFO (jetty-closer-12854-thread-4) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@173077a: rootName = solr_39667, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1794dec
[junit4] 2> 1847991 INFO (jetty-closer-12854-thread-5) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1847991 INFO (jetty-closer-12854-thread-5) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1449f39: rootName = solr_43243, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1794dec
[junit4] 2> 1847994 INFO (jetty-closer-12854-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1847994 INFO (jetty-closer-12854-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1e5cce6: rootName = solr_43139, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@c6b4a3
[junit4] 2> 1847994 INFO (jetty-closer-12854-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1847994 INFO (jetty-closer-12854-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@32992c: rootName = solr_43851, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@c6b4a3
[junit4] 2> 1847994 INFO (jetty-closer-12854-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1847994 INFO (jetty-closer-12854-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@133eff8: rootName = solr_38415, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@c6b4a3
[junit4] 2> 1847995 INFO (jetty-closer-12854-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1847995 INFO (jetty-closer-12854-thread-1) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:43139_solr
[junit4] 2> 1847995 INFO (jetty-closer-12854-thread-3) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:38415_solr
[junit4] 2> 1847995 INFO (jetty-closer-12854-thread-4) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4868cc: rootName = solr_39667, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@c6b4a3
[junit4] 2> 1847995 INFO (jetty-closer-12854-thread-5) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1847995 INFO (jetty-closer-12854-thread-5) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@16f8003: rootName = solr_43243, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@c6b4a3
[junit4] 2> 1847995 INFO (zkCallback-12870-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1847995 INFO (zkCallback-12892-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1847995 INFO (zkCallback-12937-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1847996 INFO (zkCallback-12907-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1847996 INFO (zkCallback-12930-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1847996 INFO (zkCallback-12900-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1847996 INFO (zkCallback-12863-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1847996 INFO (jetty-closer-12854-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1847996 INFO (zkCallback-12945-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1847996 INFO (jetty-closer-12854-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1847996 INFO (zkCallback-12952-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1847996 INFO (jetty-closer-12854-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1847996 INFO (zkCallback-12870-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1847996 INFO (zkCallback-12892-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1847996 INFO (jetty-closer-12854-thread-5) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:43243_solr
[junit4] 2> 1847996 INFO (zkCallback-12937-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1847996 INFO (zkCallback-12907-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1847996 INFO (zkCallback-12952-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1847996 INFO (zkCallback-12930-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1847997 INFO (jetty-closer-12854-thread-4) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:39667_solr
[junit4] 2> 1847997 INFO (zkCallback-12863-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1847998 INFO (jetty-closer-12854-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72076738895085571-127.0.0.1:43139_solr-n_0000000000) closing
[junit4] 2> 1847998 INFO (OverseerStateUpdate-72076738895085571-127.0.0.1:43139_solr-n_0000000000) [ ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:43139_solr
[junit4] 2> 1847998 WARN (OverseerAutoScalingTriggerThread-72076738895085571-127.0.0.1:43139_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 1847998 INFO (zkCallback-12900-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1848002 INFO (zkCallback-12885-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (1)
[junit4] 2> 1848002 INFO (jetty-closer-12854-thread-5) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1848002 INFO (zkCallback-12945-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (2)
[junit4] 2> 1848002 INFO (jetty-closer-12854-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1848004 INFO (zkCallback-12870-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
[junit4] 2> 1848004 INFO (zkCallback-12930-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
[junit4] 2> 1848004 INFO (zkCallback-12937-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
[junit4] 2> 1848004 INFO (zkCallback-12945-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 1848005 INFO (zkCallback-12900-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
[junit4] 2> 1848005 INFO (zkCallback-12952-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
[junit4] 2> 1848005 INFO (zkCallback-12863-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
[junit4] 2> 1848005 INFO (jetty-closer-12854-thread-2) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:43851_solr
[junit4] 2> 1848005 INFO (jetty-closer-12854-thread-5) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@be05c4{/solr,null,UNAVAILABLE}
[junit4] 2> 1848005 INFO (jetty-closer-12854-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1081b0c{/solr,null,UNAVAILABLE}
[junit4] 2> 1848005 INFO (zkCallback-12885-thread-2) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:43851_solr
[junit4] 2> 1848007 INFO (jetty-closer-12854-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1848007 INFO (jetty-closer-12854-thread-5) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1848007 INFO (jetty-closer-12854-thread-4) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1b149b9{/solr,null,UNAVAILABLE}
[junit4] 2> 1848008 INFO (jetty-closer-12854-thread-4) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1848008 INFO (jetty-closer-12854-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1848009 INFO (zkCallback-12885-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
[junit4] 2> 1848009 INFO (zkCallback-12900-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
[junit4] 2> 1849501 WARN (zkCallback-12907-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 1849502 INFO (jetty-closer-12854-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@50881f{/solr,null,UNAVAILABLE}
[junit4] 2> 1849504 INFO (jetty-closer-12854-thread-3) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1849513 WARN (zkCallback-12892-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 1849513 INFO (jetty-closer-12854-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@11c715{/solr,null,UNAVAILABLE}
[junit4] 2> 1849515 INFO (jetty-closer-12854-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1849515 ERROR (SUITE-NodeAddedTriggerTest-seed#[46DAE7F641F56910]-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> 1849515 INFO (SUITE-NodeAddedTriggerTest-seed#[46DAE7F641F56910]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:33317 33317
[junit4] 2> 1849552 INFO (Thread-5689) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:33317 33317
[junit4] 2> 1849554 WARN (Thread-5689) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 13 /solr/aliases.json
[junit4] 2> 6 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 13 /solr/clusterstate.json
[junit4] 2> 13 /solr/clusterprops.json
[junit4] 2> 3 /solr/overseer_elect/election/72076738895085581-127.0.0.1:38415_solr-n_0000000002
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 13 /solr/live_nodes
[junit4] 2> 13 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_46DAE7F641F56910-001
[junit4] 2> May 23, 2018 9:30:32 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 2 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70), sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@d87922), locale=en-US, timezone=Africa/Dakar
[junit4] 2> NOTE: Linux 4.13.0-41-generic i386/Oracle Corporation 1.8.0_172 (32-bit)/cpus=8,threads=1,free=189278200,total=522715136
[junit4] 2> NOTE: All tests run in this JVM: [ConnectionManagerTest, DistributedFacetSimpleRefinementLongTailTest, TestClusterStateProvider, ReplaceNodeTest, HdfsAutoAddReplicasIntegrationTest, AnalysisAfterCoreReloadTest, AddBlockUpdateTest, TestCustomStream, HdfsUnloadDistributedZkTest, TestNodeAddedTrigger, TestLeaderElectionWithEmptyReplica, TestBulkSchemaConcurrent, TestSuggestSpellingConverter, TestDelegationWithHadoopAuth, OverseerCollectionConfigSetProcessorTest, HdfsRecoverLeaseTest, CoreAdminOperationTest, CopyFieldTest, TestDistributedMissingSort, IndexSchemaRuntimeFieldTest, CdcrBidirectionalTest, ConfigureRecoveryStrategyTest, SimpleCollectionCreateDeleteTest, DocValuesMultiTest, CloudExitableDirectoryReaderTest, TestLFUCache, SearchRateTriggerTest, InfoHandlerTest, ClusterStateUpdateTest, LargeFieldTest, SimpleMLTQParserTest, TestSchemaVersionResource, TestLockTree, TestCoreAdminApis, MinimalSchemaTest, HDFSCollectionsAPITest, SmileWriterTest, RegexBytesRefFilterTest, SpellPossibilityIteratorTest, TestTrackingShardHandlerFactory, LeaderElectionIntegrationTest, ExitableDirectoryReaderTest, TimeZoneUtilsTest, TestExportWriter, BlockJoinFacetRandomTest, ActionThrottleTest, VMParamsZkACLAndCredentialsProvidersTest, DistanceFunctionTest, CircularListTest, SolrIndexMetricsTest, TestCoreDiscovery, ConjunctionSolrSpellCheckerTest, TestHighFrequencyDictionaryFactory, TestReplicationHandlerBackup, TestRandomFlRTGCloud, TestConfigSetProperties, V2StandaloneTest, TestTrieFacet, DateFieldTest, DistributedFacetPivotWhiteBoxTest, ResponseLogComponentTest, TestSQLHandler, TestBackupRepositoryFactory, TestFieldCacheReopen, RollingRestartTest, TestDistributedMap, TestCloudNestedDocsSort, TestRandomDVFaceting, TestCoreContainer, OverseerStatusTest, LeaderElectionContextKeyTest, TestZkAclsWithHadoopAuth, TestImplicitCoreProperties, TestSolrCloudSnapshots, TestChildDocTransformer, LeaderElectionTest, SortSpecParsingTest, TestDefaultStatsCache, NoCacheHeaderTest, CoreAdminHandlerTest, SolrMetricReporterTest, DateMathParserTest, FileBasedSpellCheckerTest, SolrCmdDistributorTest, MoreLikeThisHandlerTest, DataDrivenBlockJoinTest, TestNonDefinedSimilarityFactory, CollectionsAPISolrJTest, NodeMarkersRegistrationTest, TestDocTermOrds, TestJavabinTupleStreamParser, TestTolerantSearch, MetricUtilsTest, TestRangeQuery, SchemaApiFailureTest, RegexBoostProcessorTest, TestHashQParserPlugin, MoveReplicaTest, HdfsSyncSliceTest, PingRequestHandlerTest, SuggesterTSTTest, SuggestComponentContextFilterQueryTest, BasicAuthStandaloneTest, TestConfigReload, TestSolrFieldCacheBean, TestSortByMinMaxFunction, DisMaxRequestHandlerTest, TestScoreJoinQPScore, TriggerCooldownIntegrationTest, TestIntervalFaceting, TestConfigSetsAPI, TestUpdate, ShowFileRequestHandlerTest, TestCollationFieldDocValues, TestSmileRequest, CdcrReplicationHandlerTest, ReplicaListTransformerTest, DistributedSuggestComponentTest, TestRawTransformer, TestSchemaManager, AnalyticsQueryTest, TestFieldCacheVsDocValues, TestStressCloudBlindAtomicUpdates, DistributedSpellCheckComponentTest, TestCloudDeleteByQuery, UnloadDistributedZkTest, TestBadConfig, TestSimpleTextCodec, TestFieldSortValues, TestSubQueryTransformerDistrib, TestManagedStopFilterFactory, DistributedQueryElevationComponentTest, SolrIndexSplitterTest, SimplePostToolTest, SignatureUpdateProcessorFactoryTest, TestExtendedDismaxParser, SpellCheckCollatorTest, SuggesterFSTTest, DocValuesTest, SuggesterTest, TestTrie, SpatialFilterTest, PolyFieldTest, WordBreakSolrSpellCheckerTest, SolrCoreCheckLockOnStartupTest, TestPseudoReturnFields, TestAtomicUpdateErrorCases, TestWordDelimiterFilterFactory, DirectUpdateHandlerOptimizeTest, DefaultValueUpdateProcessorTest, StatelessScriptUpdateProcessorFactoryTest, SolrInfoBeanTest, XsltUpdateRequestHandlerTest, DebugComponentTest, CacheHeaderTest, IndexBasedSpellCheckerTest, TestSurroundQueryParser, LukeRequestHandlerTest, TestQueryUtils, TestWriterPerf, DirectSolrSpellCheckerTest, TestQueryTypes, TermsComponentTest, RequestHandlersTest, TestValueSourceCache, PathHierarchyTokenizerFactoryTest, TermVectorComponentTest, RequiredFieldsTest, FastVectorHighlighterTest, LoggingHandlerTest, SolrPluginUtilsTest, TestJmxIntegration, ReturnFieldsTest, TestAnalyzedSuggestions, UniqFieldsUpdateProcessorFactoryTest, BinaryUpdateRequestHandlerTest, TestPartialUpdateDeduplication, TestPHPSerializedResponseWriter, SearchHandlerTest, HighlighterConfigTest, TestQuerySenderListener, UpdateParamsTest, SolrIndexConfigTest, BadComponentTest, MultiTermTest, TestDocSet, NumericFieldsTest, TestFuzzyAnalyzedSuggestions, NotRequiredUniqueKeyTest, EchoParamsTest, TestDFRSimilarityFactory, TestLMDirichletSimilarityFactory, TestLMJelinekMercerSimilarityFactory, TestFastOutputStream, URLClassifyProcessorTest, PreAnalyzedFieldTest, SpellingQueryConverterTest, ClusterStateTest, DistributedMLTComponentTest, TestSimpleTrackingShardHandler, TestEmbeddedSolrServerAdminHandler, TestEmbeddedSolrServerSchemaAPI, ConnectionReuseTest, AssignBackwardCompatibilityTest, ConcurrentCreateRoutedAliasTest, ConfigSetsAPITest, DeleteInactiveReplicaTest, DistribCursorPagingTest, DistribJoinFromCollectionTest, DistributedQueueTest, HttpPartitionTest, LIROnShardRestartTest, LeaderFailoverAfterPartitionTest, LeaderFailureAfterFreshStartTest, MissingSegmentRecoveryTest, MoveReplicaHDFSFailoverTest, RestartWhileUpdatingTest, SSLMigrationTest, SaslZkACLProviderTest, TestCloudJSONFacetSKG, TestClusterProperties, TestCryptoKeys, TestLeaderInitiatedRecoveryThread, TestMiniSolrCloudClusterSSL, TestRandomRequestDistribution, TestRequestForwarding, TestSizeLimitedDistributedMap, TestSolrCloudWithDelegationTokens, TestSolrCloudWithKerberosAlt, TestStressLiveNodes, TestTolerantUpdateProcessorRandomCloud, TestUtilizeNode, AssignTest, CollectionReloadTest, CollectionTooManyReplicasTest, CollectionsAPIAsyncDistributedZkTest, CustomCollectionTest, TestHdfsCloudBackupRestore, TestLocalFSCloudBackupRestore, AutoAddReplicasPlanActionTest, AutoScalingHandlerTest, ComputePlanActionTest, NodeAddedTriggerTest]
[junit4] Completed [618/808 (1!)] on J2 in 16.95s, 4 tests, 1 failure <<< FAILURES!
[...truncated 46910 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/22088/consoleText
[repro] Revision: 53a3de3b98a5a06146a33251c176b7e4475270e4
[repro] Ant options: "-Dargs=-server -XX:+UseParallelGC"
[repro] Repro line: ant test -Dtestcase=NodeAddedTriggerTest -Dtests.method=testRestoreState -Dtests.seed=46DAE7F641F56910 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=en-US -Dtests.timezone=Africa/Dakar -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr/core
[repro] NodeAddedTriggerTest
[repro] ant compile-test
[...truncated 3298 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.NodeAddedTriggerTest" -Dtests.showOutput=onerror "-Dargs=-server -XX:+UseParallelGC" -Dtests.seed=46DAE7F641F56910 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=en-US -Dtests.timezone=Africa/Dakar -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[...truncated 86 lines...]
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest
[repro] Exiting with code 0
[...truncated 40 lines...]