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/12/01 03:15:19 UTC

[JENKINS] Lucene-Solr-7.x-Solaris (64bit/jdk1.8.0) - Build # 940 - Unstable!

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Solaris/940/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseSerialGC

2 tests failed.
FAILED:  org.apache.solr.cloud.autoscaling.NodeMarkersRegistrationTest.testNodeMarkersRegistration

Error Message:
Path /autoscaling/nodeLost/127.0.0.1:65068_solr exists

Stack Trace:
java.lang.AssertionError: Path /autoscaling/nodeLost/127.0.0.1:65068_solr exists
	at __randomizedtesting.SeedInfo.seed([9CCB7815F5D34784:8471F019FBE68A6B]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.junit.Assert.assertFalse(Assert.java:68)
	at org.apache.solr.cloud.autoscaling.NodeMarkersRegistrationTest.testNodeMarkersRegistration(NodeMarkersRegistrationTest.java:152)
	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:1742)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985)
	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:944)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at java.lang.Thread.run(Thread.java:748)


FAILED:  org.apache.solr.cloud.autoscaling.NodeMarkersRegistrationTest.testNodeMarkersRegistration

Error Message:
Path /autoscaling/nodeLost/127.0.0.1:40293_solr exists

Stack Trace:
java.lang.AssertionError: Path /autoscaling/nodeLost/127.0.0.1:40293_solr exists
	at __randomizedtesting.SeedInfo.seed([9CCB7815F5D34784:8471F019FBE68A6B]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.junit.Assert.assertFalse(Assert.java:68)
	at org.apache.solr.cloud.autoscaling.NodeMarkersRegistrationTest.testNodeMarkersRegistration(NodeMarkersRegistrationTest.java:152)
	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:1742)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985)
	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:944)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891)
	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 12862 lines...]
   [junit4] Suite: org.apache.solr.cloud.autoscaling.NodeMarkersRegistrationTest
   [junit4]   2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeMarkersRegistrationTest_9CCB7815F5D34784-001/init-core-data-001
   [junit4]   2> 391266 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeMarkersRegistrationTest_9CCB7815F5D34784-001/tempDir-001
   [junit4]   2> 391266 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 391266 INFO  (ZkTestServer Run Thread) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 391266 INFO  (ZkTestServer Run Thread) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 391268 ERROR (ZkTestServer Run Thread) [    ] 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> 391367 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.c.ZkTestServer start zk server on port:50642
   [junit4]   2> 391367 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:50642
   [junit4]   2> 391367 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 50642
   [junit4]   2> 391371 INFO  (zkConnectionManagerCallback-2255-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 391379 INFO  (zkConnectionManagerCallback-2257-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 391381 INFO  (zkConnectionManagerCallback-2259-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 391384 INFO  (jetty-launcher-2252-thread-2) [    ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 391384 INFO  (jetty-launcher-2252-thread-1) [    ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 391384 INFO  (jetty-launcher-2252-thread-2) [    ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 391384 INFO  (jetty-launcher-2252-thread-1) [    ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 391384 INFO  (jetty-launcher-2252-thread-2) [    ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_191-b12
   [junit4]   2> 391384 INFO  (jetty-launcher-2252-thread-1) [    ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_191-b12
   [junit4]   2> 391392 INFO  (jetty-launcher-2252-thread-1) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 391392 INFO  (jetty-launcher-2252-thread-1) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 391392 INFO  (jetty-launcher-2252-thread-1) [    ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 391393 INFO  (jetty-launcher-2252-thread-1) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4eb77ffb{/solr,null,AVAILABLE}
   [junit4]   2> 391393 INFO  (jetty-launcher-2252-thread-2) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 391393 INFO  (jetty-launcher-2252-thread-2) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 391393 INFO  (jetty-launcher-2252-thread-2) [    ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 391393 INFO  (jetty-launcher-2252-thread-2) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@72f1e6ed{/solr,null,AVAILABLE}
   [junit4]   2> 391395 INFO  (jetty-launcher-2252-thread-1) [    ] o.e.j.s.AbstractConnector Started ServerConnector@5924319c{HTTP/1.1,[http/1.1]}{127.0.0.1:40293}
   [junit4]   2> 391395 INFO  (jetty-launcher-2252-thread-1) [    ] o.e.j.s.Server Started @391872ms
   [junit4]   2> 391395 INFO  (jetty-launcher-2252-thread-1) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=40293}
   [junit4]   2> 391395 ERROR (jetty-launcher-2252-thread-1) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 391395 INFO  (jetty-launcher-2252-thread-1) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 391395 INFO  (jetty-launcher-2252-thread-1) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 7.7.0
   [junit4]   2> 391395 INFO  (jetty-launcher-2252-thread-1) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 391395 INFO  (jetty-launcher-2252-thread-1) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 391395 INFO  (jetty-launcher-2252-thread-2) [    ] o.e.j.s.AbstractConnector Started ServerConnector@31e326d4{HTTP/1.1,[http/1.1]}{127.0.0.1:59398}
   [junit4]   2> 391395 INFO  (jetty-launcher-2252-thread-1) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-12-01T02:06:23.410Z
   [junit4]   2> 391395 INFO  (jetty-launcher-2252-thread-2) [    ] o.e.j.s.Server Started @391872ms
   [junit4]   2> 391395 INFO  (jetty-launcher-2252-thread-2) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=59398}
   [junit4]   2> 391395 ERROR (jetty-launcher-2252-thread-2) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 391395 INFO  (jetty-launcher-2252-thread-2) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 391395 INFO  (jetty-launcher-2252-thread-2) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 7.7.0
   [junit4]   2> 391395 INFO  (jetty-launcher-2252-thread-2) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 391395 INFO  (jetty-launcher-2252-thread-2) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 391395 INFO  (jetty-launcher-2252-thread-2) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-12-01T02:06:23.410Z
   [junit4]   2> 391398 INFO  (zkConnectionManagerCallback-2261-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 391398 INFO  (zkConnectionManagerCallback-2263-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 391398 INFO  (jetty-launcher-2252-thread-1) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 391398 INFO  (jetty-launcher-2252-thread-2) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 391660 INFO  (jetty-launcher-2252-thread-1) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50642/solr
   [junit4]   2> 391662 INFO  (zkConnectionManagerCallback-2267-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 391664 INFO  (zkConnectionManagerCallback-2269-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 391723 INFO  (jetty-launcher-2252-thread-1) [n:127.0.0.1:40293_solr    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:40293_solr
   [junit4]   2> 391724 INFO  (jetty-launcher-2252-thread-1) [n:127.0.0.1:40293_solr    ] o.a.s.c.Overseer Overseer (id=72151930287226886-127.0.0.1:40293_solr-n_0000000000) starting
   [junit4]   2> 391729 INFO  (zkConnectionManagerCallback-2276-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 391732 INFO  (jetty-launcher-2252-thread-1) [n:127.0.0.1:40293_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:50642/solr ready
   [junit4]   2> 391733 INFO  (jetty-launcher-2252-thread-1) [n:127.0.0.1:40293_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:40293_solr
   [junit4]   2> 391733 INFO  (OverseerStateUpdate-72151930287226886-127.0.0.1:40293_solr-n_0000000000) [n:127.0.0.1:40293_solr    ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:40293_solr
   [junit4]   2> 391735 INFO  (zkCallback-2268-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 391735 INFO  (zkCallback-2275-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 391738 DEBUG (OverseerAutoScalingTriggerThread-72151930287226886-127.0.0.1:40293_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
   [junit4]   2> 391739 DEBUG (OverseerAutoScalingTriggerThread-72151930287226886-127.0.0.1:40293_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
   [junit4]   2> 391740 DEBUG (OverseerAutoScalingTriggerThread-72151930287226886-127.0.0.1:40293_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion -1
   [junit4]   2> 391740 DEBUG (OverseerAutoScalingTriggerThread-72151930287226886-127.0.0.1:40293_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
   [junit4]   2> 391745 INFO  (OverseerAutoScalingTriggerThread-72151930287226886-127.0.0.1:40293_solr-n_0000000000) [    ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:40293_solr]
   [junit4]   2> 391746 DEBUG (OverseerAutoScalingTriggerThread-72151930287226886-127.0.0.1:40293_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 391746 DEBUG (OverseerAutoScalingTriggerThread-72151930287226886-127.0.0.1:40293_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 391746 INFO  (ScheduledTrigger-2577-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 and last live nodes: 1
   [junit4]   2> 391758 INFO  (jetty-launcher-2252-thread-1) [n:127.0.0.1:40293_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 391777 INFO  (jetty-launcher-2252-thread-1) [n:127.0.0.1:40293_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_40293.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1839ea9b
   [junit4]   2> 391781 INFO  (jetty-launcher-2252-thread-1) [n:127.0.0.1:40293_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_40293.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1839ea9b
   [junit4]   2> 391782 INFO  (jetty-launcher-2252-thread-1) [n:127.0.0.1:40293_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_40293.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1839ea9b
   [junit4]   2> 391782 INFO  (jetty-launcher-2252-thread-1) [n:127.0.0.1:40293_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeMarkersRegistrationTest_9CCB7815F5D34784-001/tempDir-001/node2/.
   [junit4]   2> 392684 INFO  (jetty-launcher-2252-thread-2) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50642/solr
   [junit4]   2> 392686 INFO  (zkConnectionManagerCallback-2281-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 392689 INFO  (zkConnectionManagerCallback-2283-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 392694 INFO  (jetty-launcher-2252-thread-2) [n:127.0.0.1:59398_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 392698 INFO  (jetty-launcher-2252-thread-2) [n:127.0.0.1:59398_solr    ] o.a.s.c.ZkController Publish node=127.0.0.1:59398_solr as DOWN
   [junit4]   2> 392699 INFO  (jetty-launcher-2252-thread-2) [n:127.0.0.1:59398_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 392699 INFO  (jetty-launcher-2252-thread-2) [n:127.0.0.1:59398_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59398_solr
   [junit4]   2> 392701 INFO  (zkCallback-2268-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 392703 INFO  (zkCallback-2275-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 392718 INFO  (zkCallback-2282-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 392719 INFO  (zkConnectionManagerCallback-2290-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 392720 INFO  (jetty-launcher-2252-thread-2) [n:127.0.0.1:59398_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 392722 INFO  (jetty-launcher-2252-thread-2) [n:127.0.0.1:59398_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:50642/solr ready
   [junit4]   2> 392722 INFO  (jetty-launcher-2252-thread-2) [n:127.0.0.1:59398_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 392754 INFO  (ScheduledTrigger-2577-thread-2) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 1
   [junit4]   2> 392756 INFO  (jetty-launcher-2252-thread-2) [n:127.0.0.1:59398_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_59398.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1839ea9b
   [junit4]   2> 392762 INFO  (jetty-launcher-2252-thread-2) [n:127.0.0.1:59398_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_59398.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1839ea9b
   [junit4]   2> 392762 INFO  (jetty-launcher-2252-thread-2) [n:127.0.0.1:59398_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_59398.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1839ea9b
   [junit4]   2> 392767 INFO  (jetty-launcher-2252-thread-2) [n:127.0.0.1:59398_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeMarkersRegistrationTest_9CCB7815F5D34784-001/tempDir-001/node1/.
   [junit4]   2> 392787 INFO  (zkConnectionManagerCallback-2296-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 392789 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 392789 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:50642/solr ready
   [junit4]   2> 392796 INFO  (qtp1847089091-8826) [n:127.0.0.1:40293_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
   [junit4]   2> 392797 INFO  (qtp1847089091-8824) [n:127.0.0.1:40293_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
   [junit4]   2> 392798 INFO  (qtp1847089091-8825) [n:127.0.0.1:40293_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
   [junit4]   2> 392798 INFO  (qtp1847089091-8816) [n:127.0.0.1:40293_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
   [junit4]   2> 392799 INFO  (qtp1847089091-8830) [n:127.0.0.1:40293_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
   [junit4]   2> 392801 INFO  (qtp1520162728-8820) [n:127.0.0.1:59398_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
   [junit4]   2> 392802 INFO  (qtp1520162728-8819) [n:127.0.0.1:59398_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
   [junit4]   2> 392803 INFO  (qtp1520162728-8817) [n:127.0.0.1:59398_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
   [junit4]   2> 392805 INFO  (qtp1520162728-8818) [n:127.0.0.1:59398_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
   [junit4]   2> 392806 INFO  (qtp1520162728-8822) [n:127.0.0.1:59398_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
   [junit4]   2> 392806 DEBUG (qtp1520162728-8823) [n:127.0.0.1:59398_solr    ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 392806 INFO  (qtp1520162728-8823) [n:127.0.0.1:59398_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=12
   [junit4]   2> 392807 DEBUG (zkCallback-2275-thread-1) [    ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 2
   [junit4]   2> 392809 DEBUG (OverseerAutoScalingTriggerThread-72151930287226886-127.0.0.1:40293_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
   [junit4]   2> 392811 DEBUG (OverseerAutoScalingTriggerThread-72151930287226886-127.0.0.1:40293_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 392811 DEBUG (OverseerAutoScalingTriggerThread-72151930287226886-127.0.0.1:40293_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
   [junit4]   2> 392811 INFO  (qtp1847089091-8826) [n:127.0.0.1:40293_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 392817 INFO  (qtp1847089091-8826) [n:127.0.0.1:40293_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=5
   [junit4]   2> 392818 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 392818 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 392818 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_191-b12
   [junit4]   2> 392819 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 392819 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 392819 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 392819 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@58f33714{/solr,null,AVAILABLE}
   [junit4]   2> 392820 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@5fa896d7{HTTP/1.1,[http/1.1]}{127.0.0.1:52518}
   [junit4]   2> 392820 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.e.j.s.Server Started @393297ms
   [junit4]   2> 392820 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=52518}
   [junit4]   2> 392825 ERROR (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 392825 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 392825 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 7.7.0
   [junit4]   2> 392825 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 392825 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 392825 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-12-01T02:06:24.840Z
   [junit4]   2> 392828 INFO  (zkConnectionManagerCallback-2298-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 392828 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 393295 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50642/solr
   [junit4]   2> 393297 INFO  (zkConnectionManagerCallback-2302-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 393300 INFO  (zkConnectionManagerCallback-2304-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 393305 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [n:127.0.0.1:52518_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 393308 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [n:127.0.0.1:52518_solr    ] o.a.s.c.ZkController Publish node=127.0.0.1:52518_solr as DOWN
   [junit4]   2> 393309 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [n:127.0.0.1:52518_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 393309 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [n:127.0.0.1:52518_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52518_solr
   [junit4]   2> 393310 INFO  (zkCallback-2268-thread-2) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 393311 INFO  (zkCallback-2282-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 393311 INFO  (zkCallback-2289-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 393332 INFO  (zkConnectionManagerCallback-2311-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 393333 INFO  (zkCallback-2303-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 393334 INFO  (zkCallback-2275-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 393334 INFO  (zkCallback-2295-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 393335 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [n:127.0.0.1:52518_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 393337 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [n:127.0.0.1:52518_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:50642/solr ready
   [junit4]   2> 393337 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [n:127.0.0.1:52518_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 393353 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [n:127.0.0.1:52518_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52518.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1839ea9b
   [junit4]   2> 393359 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [n:127.0.0.1:52518_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52518.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1839ea9b
   [junit4]   2> 393359 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [n:127.0.0.1:52518_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52518.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1839ea9b
   [junit4]   2> 393361 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [n:127.0.0.1:52518_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeMarkersRegistrationTest_9CCB7815F5D34784-001/tempDir-001/node3/.
   [junit4]   2> 393403 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.c.a.NodeMarkersRegistrationTest ====== KILL OVERSEER 1
   [junit4]   2> 393403 INFO  (Thread-1693) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1617347052
   [junit4]   2> 393403 INFO  (Thread-1693) [    ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:40293_solr
   [junit4]   2> 393404 INFO  (Thread-1693) [    ] o.a.s.c.CoreContainer Publish this node as DOWN...
   [junit4]   2> 393404 INFO  (Thread-1693) [    ] o.a.s.c.ZkController Publish node=127.0.0.1:40293_solr as DOWN
   [junit4]   2> 393405 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@5924319c{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 393406 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4eb77ffb{/solr,null,UNAVAILABLE}
   [junit4]   2> 393406 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 393408 INFO  (Thread-1693) [    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 393409 INFO  (Thread-1693) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
   [junit4]   2> 393409 INFO  (Thread-1693) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4f9efedb: rootName = solr_40293, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@541cbfb2
   [junit4]   2> 393411 INFO  (Thread-1693) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
   [junit4]   2> 393411 INFO  (Thread-1693) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@580b1e46: rootName = solr_40293, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@7602f49a
   [junit4]   2> 393413 INFO  (Thread-1693) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
   [junit4]   2> 393413 INFO  (Thread-1693) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@24c43f80: rootName = solr_40293, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@73f8bc1e
   [junit4]   2> 393413 INFO  (Thread-1693) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
   [junit4]   2> 393414 INFO  (ForkJoinPool-268-worker-9) [    ] o.a.s.c.Overseer Overseer (id=72151930287226886-127.0.0.1:40293_solr-n_0000000000) closing
   [junit4]   2> 393415 INFO  (OverseerStateUpdate-72151930287226886-127.0.0.1:40293_solr-n_0000000000) [n:127.0.0.1:40293_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:40293_solr
   [junit4]   2> 393417 INFO  (zkCallback-2295-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
   [junit4]   2> 393417 INFO  (zkCallback-2275-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
   [junit4]   2> 393417 INFO  (zkCallback-2282-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
   [junit4]   2> 393417 INFO  (zkCallback-2282-thread-2) [    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:59398_solr
   [junit4]   2> 393417 INFO  (zkCallback-2289-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
   [junit4]   2> 393430 INFO  (OverseerAutoScalingTriggerThread-72151930287226886-127.0.0.1:40293_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 393430 DEBUG (ForkJoinPool-268-worker-9) [    ] o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool executor now
   [junit4]   2> 393431 INFO  (zkCallback-2310-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
   [junit4]   2> 393432 DEBUG (ForkJoinPool-268-worker-9) [    ] o.a.s.c.a.ScheduledTriggers Shutting down action executor now
   [junit4]   2> 393432 INFO  (zkCallback-2303-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
   [junit4]   2> 393432 INFO  (zkCallback-2282-thread-2) [n:127.0.0.1:59398_solr    ] o.a.s.c.Overseer Overseer (id=72151930287226889-127.0.0.1:59398_solr-n_0000000001) starting
   [junit4]   2> 393432 DEBUG (ForkJoinPool-268-worker-9) [    ] o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor
   [junit4]   2> 393433 DEBUG (ForkJoinPool-268-worker-9) [    ] o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread pool executor
   [junit4]   2> 393433 DEBUG (ForkJoinPool-268-worker-9) [    ] o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
   [junit4]   2> 393433 DEBUG (ForkJoinPool-268-worker-9) [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 393433 INFO  (Thread-1693) [    ] o.a.s.c.Overseer Overseer (id=72151930287226886-127.0.0.1:40293_solr-n_0000000000) closing
   [junit4]   2> 393433 INFO  (ForkJoinPool-268-worker-2) [    ] o.a.s.c.Overseer Overseer (id=72151930287226886-127.0.0.1:40293_solr-n_0000000000) closing
   [junit4]   2> 393436 INFO  (OverseerStateUpdate-72151930287226889-127.0.0.1:59398_solr-n_0000000001) [n:127.0.0.1:59398_solr    ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:59398_solr
   [junit4]   2> 393437 DEBUG (OverseerAutoScalingTriggerThread-72151930287226889-127.0.0.1:59398_solr-n_0000000001) [    ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 2
   [junit4]   2> 393438 DEBUG (OverseerAutoScalingTriggerThread-72151930287226889-127.0.0.1:59398_solr-n_0000000001) [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion -1
   [junit4]   2> 393438 DEBUG (OverseerAutoScalingTriggerThread-72151930287226889-127.0.0.1:59398_solr-n_0000000001) [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
   [junit4]   2> 393439 INFO  (OverseerAutoScalingTriggerThread-72151930287226889-127.0.0.1:59398_solr-n_0000000001) [    ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:52518_solr, 127.0.0.1:59398_solr]
   [junit4]   2> 393439 DEBUG (OverseerAutoScalingTriggerThread-72151930287226889-127.0.0.1:59398_solr-n_0000000001) [    ] o.a.s.c.a.NodeLostTrigger Adding lost node from marker path: 127.0.0.1:40293_solr
   [junit4]   2> 393440 DEBUG (OverseerAutoScalingTriggerThread-72151930287226889-127.0.0.1:59398_solr-n_0000000001) [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 393440 DEBUG (OverseerAutoScalingTriggerThread-72151930287226889-127.0.0.1:59398_solr-n_0000000001) [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
   [junit4]   2> 393441 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 393441 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Tracking lost node: 127.0.0.1:40293_solr
   [junit4]   2> 394443 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 395445 INFO  (ScheduledTrigger-2602-thread-2) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 396446 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 397447 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 398448 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 399448 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 400449 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 401449 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 402451 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 403452 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 404452 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 405453 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 406455 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 407456 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 408456 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 409459 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 410460 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 411465 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 412467 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 413467 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 414477 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 415483 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 416485 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 417485 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 418486 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 419487 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 420488 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 421488 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 422489 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 423490 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 424491 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 425492 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 426492 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 427495 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 428495 INFO  (ScheduledTrigger-2602-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 428677 INFO  (Thread-1694) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=631722729
   [junit4]   2> 428677 INFO  (Thread-1694) [    ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:59398_solr
   [junit4]   2> 428678 INFO  (jetty-closer-2253-thread-2) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@5fa896d7{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 428678 INFO  (jetty-closer-2253-thread-2) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@58f33714{/solr,null,UNAVAILABLE}
   [junit4]   2> 428679 INFO  (jetty-closer-2253-thread-2) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 428679 INFO  (Thread-1695) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1643539580
   [junit4]   2> 428679 INFO  (Thread-1695) [    ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:52518_solr
   [junit4]   2> 428679 INFO  (Thread-1694) [    ] o.a.s.c.CoreContainer Publish this node as DOWN...
   [junit4]   2> 428679 INFO  (Thread-1694) [    ] o.a.s.c.ZkController Publish node=127.0.0.1:59398_solr as DOWN
   [junit4]   2> 428679 INFO  (jetty-closer-2253-thread-1) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@31e326d4{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 428680 INFO  (jetty-closer-2253-thread-1) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@72f1e6ed{/solr,null,UNAVAILABLE}
   [junit4]   2> 428681 INFO  (jetty-closer-2253-thread-1) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 428682 INFO  (Thread-1695) [    ] o.a.s.c.CoreContainer Publish this node as DOWN...
   [junit4]   2> 428682 INFO  (Thread-1695) [    ] o.a.s.c.ZkController Publish node=127.0.0.1:52518_solr as DOWN
   [junit4]   2> 428687 INFO  (Thread-1694) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
   [junit4]   2> 428687 INFO  (Thread-1694) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@a9047fd: rootName = solr_59398, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@4aa83ebd
   [junit4]   2> 428690 INFO  (Thread-1695) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
   [junit4]   2> 428690 INFO  (Thread-1695) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6704c62: rootName = solr_52518, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@7eee7062
   [junit4]   2> 428694 INFO  (Thread-1694) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
   [junit4]   2> 428694 INFO  (Thread-1694) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@210ff668: rootName = solr_59398, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@7602f49a
   [junit4]   2> 428712 INFO  (Thread-1695) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
   [junit4]   2> 428712 INFO  (Thread-1695) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@525dfa24: rootName = solr_52518, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@7602f49a
   [junit4]   2> 428712 INFO  (Thread-1694) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
   [junit4]   2> 428712 INFO  (Thread-1694) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1ae9c0dc: rootName = solr_59398, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@73f8bc1e
   [junit4]   2> 428713 INFO  (Thread-1694) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
   [junit4]   2> 428714 INFO  (ForkJoinPool-271-worker-11) [    ] o.a.s.c.Overseer Overseer (id=72151930287226889-127.0.0.1:59398_solr-n_0000000001) closing
   [junit4]   2> 428714 INFO  (Thread-1695) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
   [junit4]   2> 428714 INFO  (Thread-1695) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6409d597: rootName = solr_52518, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@73f8bc1e
   [junit4]   2> 428714 INFO  (Thread-1695) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
   [junit4]   2> 428715 INFO  (OverseerStateUpdate-72151930287226889-127.0.0.1:59398_solr-n_0000000001) [n:127.0.0.1:59398_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:59398_solr
   [junit4]   2> 428716 INFO  (OverseerAutoScalingTriggerThread-72151930287226889-127.0.0.1:59398_solr-n_0000000001) [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 428718 DEBUG (ForkJoinPool-271-worker-11) [    ] o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool executor now
   [junit4]   2> 428718 DEBUG (ForkJoinPool-271-worker-11) [    ] o.a.s.c.a.ScheduledTriggers Shutting down action executor now
   [junit4]   2> 428718 DEBUG (ForkJoinPool-271-worker-11) [    ] o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor
   [junit4]   2> 428718 DEBUG (ForkJoinPool-271-worker-11) [    ] o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread pool executor
   [junit4]   2> 428718 DEBUG (ForkJoinPool-271-worker-11) [    ] o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
   [junit4]   2> 428718 DEBUG (ForkJoinPool-271-worker-11) [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 428718 INFO  (ForkJoinPool-271-worker-2) [    ] o.a.s.c.Overseer Overseer (id=72151930287226889-127.0.0.1:59398_solr-n_0000000001) closing
   [junit4]   2> 428718 INFO  (Thread-1694) [    ] o.a.s.c.Overseer Overseer (id=72151930287226889-127.0.0.1:59398_solr-n_0000000001) closing
   [junit4]   2> 428720 INFO  (zkCallback-2310-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 428726 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
   [junit4]   2> 428729 WARN  (ZkTestServer Run Thread) [    ] o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	7	/solr/aliases.json
   [junit4]   2> 	7	/solr/clusterprops.json
   [junit4]   2> 	3	/solr/security.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2> 	7	/solr/clusterstate.json
   [junit4]   2> 	2	/solr/autoscaling.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	7	/solr/live_nodes
   [junit4]   2> 	7	/solr/collections
   [junit4]   2> 	2	/solr/overseer/queue
   [junit4]   2> 	2	/solr/autoscaling/events/.auto_add_replicas
   [junit4]   2> 	2	/solr/overseer/collection-queue-work
   [junit4]   2> 	2	/solr/overseer/queue-work
   [junit4]   2> 
   [junit4]   2> 428730 ERROR (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] 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> 428733 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:50642
   [junit4]   2> 428733 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 50642
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=NodeMarkersRegistrationTest -Dtests.method=testNodeMarkersRegistration -Dtests.seed=9CCB7815F5D34784 -Dtests.slow=true -Dtests.locale=lv-LV -Dtests.timezone=Africa/Juba -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] FAILURE 37.5s J0 | NodeMarkersRegistrationTest.testNodeMarkersRegistration <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Path /autoscaling/nodeLost/127.0.0.1:40293_solr exists
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([9CCB7815F5D34784:8471F019FBE68A6B]:0)
   [junit4]    > 	at org.apache.solr.cloud.autoscaling.NodeMarkersRegistrationTest.testNodeMarkersRegistration(NodeMarkersRegistrationTest.java:152)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> NOTE: leaving temporary files on disk at: /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeMarkersRegistrationTest_9CCB7815F5D34784-001
   [junit4]   2> Dec 01, 2018 2:07:00 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 8 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=875, maxMBSortInHeap=7.983155544561405, sim=RandomSimilarity(queryNorm=true): {}, locale=lv-LV, timezone=Africa/Juba
   [junit4]   2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_191 (64-bit)/cpus=3,threads=1,free=39716304,total=235864064
   [junit4]   2> NOTE: All tests run in this JVM: [ExitableDirectoryReaderTest, AnalysisAfterCoreReloadTest, ExecutePlanActionTest, CollectionTooManyReplicasTest, TestNumericRangeQuery64, ProtectedTermFilterFactoryTest, FieldMutatingUpdateProcessorTest, DistributedExpandComponentTest, HdfsChaosMonkeyNothingIsSafeTest, SolrCoreTest, DistributedQueueTest, TestConfigSetImmutable, AliasIntegrationTest, ScheduledTriggerTest, CurrencyRangeFacetCloudTest, OutputWriterTest, DistributedQueryElevationComponentTest, TestInitQParser, TestRequestForwarding, DistributedQueryComponentCustomSortTest, TestSolrXml, TestDocBasedVersionConstraints, TestLuceneMatchVersion, HdfsSyncSliceTest, DeleteReplicaTest, RecoveryZkTest, SpellCheckComponentTest, TestReplicationHandlerBackup, TestCloudNestedDocsSort, TestZkAclsWithHadoopAuth, OverseerRolesTest, TestExpandComponent, NodeLostTriggerIntegrationTest, MultiTermTest, DisMaxRequestHandlerTest, DocumentAnalysisRequestHandlerTest, TestCollationField, TestTolerantUpdateProcessorRandomCloud, TestPayloadScoreQParserPlugin, NumberUtilsTest, UnloadDistributedZkTest, AlternateDirectoryTest, TestClassicSimilarityFactory, TestCloudManagedSchema, CloudExitableDirectoryReaderTest, LoggingHandlerTest, TestPKIAuthenticationPlugin, TestSolrQueryResponse, TestSlowCompositeReaderWrapper, TestJoin, MetricsConfigTest, DirectUpdateHandlerTest, NoCacheHeaderTest, AddBlockUpdateTest, TestConfigSetsAPIZkFailure, ReplicationFactorTest, CollectionStateFormat2Test, TestRandomRequestDistribution, TestFastLRUCache, TestSQLHandlerNonCloud, TestSimDistributedQueue, TestFacetMethods, NodeMarkersRegistrationTest]
   [junit4] Completed [123/836 (1!)] on J0 in 38.25s, 1 test, 1 failure <<< FAILURES!

[...truncated 51698 lines...]
[asciidoctor:convert] asciidoctor: ERROR: about-this-guide.adoc: line 1: invalid part, must have at least one section (e.g., chapter, appendix, etc.)
[asciidoctor:convert] asciidoctor: ERROR: solr-glossary.adoc: line 1: invalid part, must have at least one section (e.g., chapter, appendix, etc.)
     [java] Processed 2447 links (1998 relative) to 3214 anchors in 247 files
     [echo] Validated Links & Anchors via: /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-ref-guide/bare-bones-html/

-documentation-lint:
    [jtidy] Checking for broken html (such as invalid tags)...
   [delete] Deleting directory /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/jtidy_tmp
     [echo] Checking for broken links...
     [exec] 
     [exec] Crawl/parse...
     [exec] 
     [exec] Verify...
     [echo] Checking for malformed docs...

jar-checksums:

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

common.resolve:

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

jar-checksums:
    [mkdir] Created dir: /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/null1475213733
     [copy] Copying 35 files to /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/null1475213733
   [delete] Deleting directory /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/null1475213733

resolve-example:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

resolve-server:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

jar-checksums:
    [mkdir] Created dir: /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/null996705648
     [copy] Copying 241 files to /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/null996705648
   [delete] Deleting directory /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/null996705648

check-working-copy:
[ivy:cachepath] :: resolving dependencies :: org.eclipse.jgit#org.eclipse.jgit-caller;working
[ivy:cachepath] 	confs: [default]
[ivy:cachepath] 	found org.eclipse.jgit#org.eclipse.jgit;4.6.0.201612231935-r in public
[ivy:cachepath] 	found com.jcraft#jsch;0.1.53 in public
[ivy:cachepath] 	found com.googlecode.javaewah#JavaEWAH;1.1.6 in public
[ivy:cachepath] 	found org.apache.httpcomponents#httpclient;4.3.6 in public
[ivy:cachepath] 	found org.apache.httpcomponents#httpcore;4.3.3 in public
[ivy:cachepath] 	found commons-logging#commons-logging;1.1.3 in public
[ivy:cachepath] 	found commons-codec#commons-codec;1.6 in public
[ivy:cachepath] 	found org.slf4j#slf4j-api;1.7.2 in public
[ivy:cachepath] :: resolution report :: resolve 32ms :: artifacts dl 3ms
	---------------------------------------------------------------------
	|                  |            modules            ||   artifacts   |
	|       conf       | number| search|dwnlded|evicted|| number|dwnlded|
	---------------------------------------------------------------------
	|      default     |   8   |   0   |   0   |   0   ||   8   |   0   |
	---------------------------------------------------------------------
[wc-checker] Initializing working copy...
[wc-checker] SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
[wc-checker] SLF4J: Defaulting to no-operation (NOP) logger implementation
[wc-checker] SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
[wc-checker] Checking working copy status...

-jenkins-base:

BUILD SUCCESSFUL
Total time: 86 minutes 59 seconds
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[Lucene-Solr-7.x-Solaris] $ /bin/sh -xe /var/tmp/jenkins4466455138000235952.sh
+ mv lucene/build lucene/build.orig
+ mv solr/build solr/build.orig
+ ANT_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
+ export ANT_HOME
+ PATH=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/bin:/export/home/jenkins/tools/java/64bit/jdk1.8.0/bin:/usr/bin:/usr/sbin
+ export PATH
+ python3.4 -u dev-tools/scripts/reproduceJenkinsFailures.py --no-git https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Solaris/940/consoleText
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Solaris/940/consoleText

[repro] Revision: 2f6bdb5940ba34386b60ab5868df98eb8cf94b2a

[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC"
[repro] Repro line:  ant test  -Dtestcase=NodeMarkersRegistrationTest -Dtests.method=testNodeMarkersRegistration -Dtests.seed=9CCB7815F5D34784 -Dtests.slow=true -Dtests.locale=lv-LV -Dtests.timezone=Africa/Juba -Dtests.asserts=true -Dtests.file.encoding=US-ASCII

[repro] ant clean
Buildfile: /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/build.xml

clean:

clean:

clean:

BUILD SUCCESSFUL
Total time: 0 seconds
[repro] Test suites by module:
[repro]    solr/core
[repro]       NodeMarkersRegistrationTest
[repro] ant compile-test
Buildfile: /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/build.xml

check-analyzers-icu-uptodate:

jar-analyzers-icu:

-mrjar-classes-uptodate:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: Apache Ivy 2.4.0 - 20141213170938 :: http://ant.apache.org/ivy/ ::
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve-groovy:
[ivy:cachepath] :: resolving dependencies :: org.codehaus.groovy#groovy-all-caller;working
[ivy:cachepath] 	confs: [default]
[ivy:cachepath] 	found org.codehaus.groovy#groovy-all;2.4.15 in public
[ivy:cachepath] :: resolution report :: resolve 122ms :: artifacts dl 2ms
	---------------------------------------------------------------------
	|                  |            modules            ||   artifacts   |
	|       conf       | number| search|dwnlded|evicted|| number|dwnlded|
	---------------------------------------------------------------------
	|      default     |   1   |   0   |   0   |   0   ||   1   |   0   |
	---------------------------------------------------------------------

check-analyzers-common-uptodate:

jar-analyzers-common:

-mrjar-classes-uptodate:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve-groovy:

-check-git-state:

-git-cleanroot:

-copy-git-state:
     [copy] Copying 1 file to /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build

git-autoclean:

resolve:

common.init:

compile-lucene-core:

-check-git-state:

-git-cleanroot:

-copy-git-state:

git-autoclean:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/top-level-ivy-settings.xml

resolve:

init:

-clover.disable:

-clover.load:

-clover.classpath:

-clover.setup:

clover:

compile-core:
    [mkdir] Created dir: /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java
    [javac] Compiling 858 source files to /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java
    [javac] /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/core/src/java/org/apache/lucene/index/FrozenBufferedUpdates.java:314: warning: [try] auto-closeable resource finalizer is never referenced in body of corresponding try statement
    [javac]         try (Closeable finalizer = () -> finishApply(writer, segStates, success.get(), delFiles)) {
    [javac]                        ^
    [javac] Note: Some input files use or override a deprecated API.
    [javac] Note: Recompile with -Xlint:deprecation for details.
    [javac] 1 warning
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/util/graph/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/document/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/util/bkd/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/codecs/compressing/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/codecs/lucene60/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/codecs/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/util/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/index/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/util/fst/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/analysis/tokenattributes/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/search/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/codecs/lucene62/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/util/packed/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/util/mutable/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/codecs/lucene70/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/codecs/perfield/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/analysis/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/analysis/standard/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/store/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/codecs/blocktree/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/search/spans/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/search/similarities/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/lucene/util/automaton/package-info.class
    [javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/classes/java/org/apache/

[...truncated too long message...]

nPool-5-worker-2) [    ] o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool executor now
   [junit4]   2> 43608 DEBUG (ForkJoinPool-5-worker-2) [    ] o.a.s.c.a.ScheduledTriggers Shutting down action executor now
   [junit4]   2> 43609 DEBUG (ForkJoinPool-5-worker-2) [    ] o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor
   [junit4]   2> 43609 DEBUG (ForkJoinPool-5-worker-2) [    ] o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread pool executor
   [junit4]   2> 43609 DEBUG (ForkJoinPool-5-worker-2) [    ] o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
   [junit4]   2> 43609 DEBUG (ForkJoinPool-5-worker-2) [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 43609 INFO  (ForkJoinPool-5-worker-9) [    ] o.a.s.c.Overseer Overseer (id=72152182609215495-127.0.0.1:34469_solr-n_0000000001) closing
   [junit4]   2> 43611 INFO  (Thread-31) [    ] o.a.s.c.Overseer Overseer (id=72152182609215495-127.0.0.1:34469_solr-n_0000000001) closing
   [junit4]   2> 43612 INFO  (zkCallback-60-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 43615 INFO  (zkCallback-53-thread-2) [    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:59787_solr
   [junit4]   2> 43615 INFO  (zkCallback-53-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 43624 INFO  (Thread-32) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
   [junit4]   2> 43626 INFO  (Thread-32) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3f4008: rootName = solr_59787, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@6927002a
   [junit4]   2> 43627 INFO  (Thread-32) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
   [junit4]   2> 43627 INFO  (Thread-32) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@70f461b4: rootName = solr_59787, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@4938631c
   [junit4]   2> 43637 INFO  (Thread-32) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
   [junit4]   2> 43637 INFO  (Thread-32) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@a74bca2: rootName = solr_59787, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@2e7e6856
   [junit4]   2> 43638 INFO  (Thread-32) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
   [junit4]   2> 43655 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
   [junit4]   2> 43658 ERROR (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] 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> 43659 WARN  (ZkTestServer Run Thread) [    ] o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	7	/solr/aliases.json
   [junit4]   2> 	7	/solr/clusterprops.json
   [junit4]   2> 	3	/solr/security.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2> 	7	/solr/clusterstate.json
   [junit4]   2> 	2	/solr/autoscaling.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	7	/solr/live_nodes
   [junit4]   2> 	7	/solr/collections
   [junit4]   2> 	2	/solr/overseer/queue
   [junit4]   2> 	2	/solr/autoscaling/events/.auto_add_replicas
   [junit4]   2> 	2	/solr/overseer/queue-work
   [junit4]   2> 	2	/solr/overseer/collection-queue-work
   [junit4]   2> 
   [junit4]   2> 43660 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:50427
   [junit4]   2> 43660 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 50427
   [junit4]   2> 43661 INFO  (TEST-NodeMarkersRegistrationTest.testNodeMarkersRegistration-seed#[9CCB7815F5D34784]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testNodeMarkersRegistration
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=NodeMarkersRegistrationTest -Dtests.method=testNodeMarkersRegistration -Dtests.seed=9CCB7815F5D34784 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=lv-LV -Dtests.timezone=Africa/Juba -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] FAILURE 40.7s J0 | NodeMarkersRegistrationTest.testNodeMarkersRegistration <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Path /autoscaling/nodeLost/127.0.0.1:65068_solr exists
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([9CCB7815F5D34784:8471F019FBE68A6B]:0)
   [junit4]    > 	at org.apache.solr.cloud.autoscaling.NodeMarkersRegistrationTest.testNodeMarkersRegistration(NodeMarkersRegistrationTest.java:152)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> NOTE: leaving temporary files on disk at: /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeMarkersRegistrationTest_9CCB7815F5D34784-001
   [junit4]   2> Dec 01, 2018 3:11:10 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 5 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=875, maxMBSortInHeap=7.983155544561405, sim=RandomSimilarity(queryNorm=true): {}, locale=lv-LV, timezone=Africa/Juba
   [junit4]   2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_191 (64-bit)/cpus=3,threads=1,free=66735968,total=97648640
   [junit4]   2> NOTE: All tests run in this JVM: [NodeMarkersRegistrationTest]
   [junit4] Completed [2/5 (2!)] on J0 in 43.36s, 1 test, 1 failure <<< FAILURES!
   [junit4] 
   [junit4] Duplicate suite name used with XML reports: org.apache.solr.cloud.autoscaling.NodeMarkersRegistrationTest. This may confuse tools that process XML reports. Set 'ignoreDuplicateSuites' to true to skip this message.
   [junit4] Suite: org.apache.solr.cloud.autoscaling.NodeMarkersRegistrationTest
   [junit4] OK      16.3s J0 | NodeMarkersRegistrationTest.testNodeMarkersRegistration
   [junit4] Completed [3/5 (2!)] on J0 in 16.87s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.cloud.autoscaling.NodeMarkersRegistrationTest
   [junit4] OK      16.2s J1 | NodeMarkersRegistrationTest.testNodeMarkersRegistration
   [junit4] Completed [4/5 (2!)] on J1 in 16.72s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.cloud.autoscaling.NodeMarkersRegistrationTest
   [junit4] OK      15.8s J0 | NodeMarkersRegistrationTest.testNodeMarkersRegistration
   [junit4] Completed [5/5 (2!)] on J0 in 16.85s, 1 test
   [junit4] 
   [junit4] 
   [junit4] Tests with failures [seed: 9CCB7815F5D34784]:
   [junit4]   - org.apache.solr.cloud.autoscaling.NodeMarkersRegistrationTest.testNodeMarkersRegistration
   [junit4]   - org.apache.solr.cloud.autoscaling.NodeMarkersRegistrationTest.testNodeMarkersRegistration
   [junit4] 
   [junit4] 
   [junit4] JVM J0:     0.72 ..    78.49 =    77.76s
   [junit4] JVM J1:     0.72 ..    61.93 =    61.21s
   [junit4] Execution time total: 1 minute 18 seconds
   [junit4] Tests summary: 5 suites, 5 tests, 2 failures

BUILD FAILED
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/common-build.xml:1567: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/common-build.xml:1092: There were test failures: 5 suites, 5 tests, 2 failures [seed: 9CCB7815F5D34784]

Total time: 1 minute 20 seconds

[repro] Setting last failure code to 256

[repro] Failures:
[repro]   2/5 failed: org.apache.solr.cloud.autoscaling.NodeMarkersRegistrationTest
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all warnings.
<Git Blamer> GIT_COMMIT=2f6bdb5940ba34386b60ab5868df98eb8cf94b2a, workspace=/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris
[WARNINGS] Computing warning deltas based on reference build #939
Recording test results
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2