lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS] Lucene-Solr-master-Solaris (64bit/jdk1.8.0) - Build # 2084 - Still Unstable!
Date Sun, 30 Sep 2018 18:35:21 GMT
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/2084/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseG1GC

2 tests failed.
FAILED:  org.apache.solr.cloud.MoveReplicaHDFSTest.testFailedMove

Error Message:
No live SolrServers available to handle this request:[http://127.0.0.1:35449/solr/MoveReplicaHDFSTest_failed_coll_true, http://127.0.0.1:41763/solr/MoveReplicaHDFSTest_failed_coll_true]

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:35449/solr/MoveReplicaHDFSTest_failed_coll_true, http://127.0.0.1:41763/solr/MoveReplicaHDFSTest_failed_coll_true]
	at __randomizedtesting.SeedInfo.seed([BFB4BFC46A06B6E7:15796C36DDD56337]:0)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:462)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1107)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:884)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:994)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:817)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
	at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:942)
	at org.apache.solr.cloud.MoveReplicaTest.testFailedMove(MoveReplicaTest.java:301)
	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)
Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:41763/solr/MoveReplicaHDFSTest_failed_coll_true: no servers hosting shard: shard2
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
	... 46 more


FAILED:  org.apache.solr.cloud.MoveReplicaHDFSTest.testFailedMove

Error Message:
No live SolrServers available to handle this request:[http://127.0.0.1:50537/solr/MoveReplicaHDFSTest_failed_coll_true, http://127.0.0.1:62256/solr/MoveReplicaHDFSTest_failed_coll_true]

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:50537/solr/MoveReplicaHDFSTest_failed_coll_true, http://127.0.0.1:62256/solr/MoveReplicaHDFSTest_failed_coll_true]
	at __randomizedtesting.SeedInfo.seed([BFB4BFC46A06B6E7:15796C36DDD56337]:0)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:462)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1107)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:884)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:994)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:817)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
	at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:942)
	at org.apache.solr.cloud.MoveReplicaTest.testFailedMove(MoveReplicaTest.java:301)
	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)
Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:62256/solr/MoveReplicaHDFSTest_failed_coll_true: no servers hosting shard: shard1
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:436)
	... 46 more




Build Log:
[...truncated 13890 lines...]
   [junit4] Suite: org.apache.solr.cloud.MoveReplicaHDFSTest
   [junit4]   2> 2403646 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/init-core-data-001
   [junit4]   2> 2403647 WARN  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=9 numCloses=9
   [junit4]   2> 2403647 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 2403648 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 2403649 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/tempDir-001
   [junit4]   2> 2403649 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2403649 INFO  (Thread-5735) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2403649 INFO  (Thread-5735) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 2403651 ERROR (Thread-5735) [    ] 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> 2403749 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.a.s.c.ZkTestServer start zk server on port:37583
   [junit4]   2> 2403751 INFO  (zkConnectionManagerCallback-8377-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2403756 INFO  (jetty-launcher-8374-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_172-b11
   [junit4]   2> 2403756 INFO  (jetty-launcher-8374-thread-3) [    ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
   [junit4]   2> 2403756 INFO  (jetty-launcher-8374-thread-4) [    ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
   [junit4]   2> 2403757 INFO  (jetty-launcher-8374-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_172-b11
   [junit4]   2> 2403758 INFO  (jetty-launcher-8374-thread-2) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2403758 INFO  (jetty-launcher-8374-thread-2) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2403758 INFO  (jetty-launcher-8374-thread-2) [    ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 2403759 INFO  (jetty-launcher-8374-thread-1) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2403759 INFO  (jetty-launcher-8374-thread-1) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2403759 INFO  (jetty-launcher-8374-thread-1) [    ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 2403759 INFO  (jetty-launcher-8374-thread-2) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@642dce76{/solr,null,AVAILABLE}
   [junit4]   2> 2403760 INFO  (jetty-launcher-8374-thread-4) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2403760 INFO  (jetty-launcher-8374-thread-4) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2403760 INFO  (jetty-launcher-8374-thread-4) [    ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 2403760 INFO  (jetty-launcher-8374-thread-1) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@60beb857{/solr,null,AVAILABLE}
   [junit4]   2> 2403760 INFO  (jetty-launcher-8374-thread-1) [    ] o.e.j.s.AbstractConnector Started ServerConnector@7c0d67fd{HTTP/1.1,[http/1.1]}{127.0.0.1:61383}
   [junit4]   2> 2403760 INFO  (jetty-launcher-8374-thread-1) [    ] o.e.j.s.Server Started @2405359ms
   [junit4]   2> 2403760 INFO  (jetty-launcher-8374-thread-1) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=61383}
   [junit4]   2> 2403760 ERROR (jetty-launcher-8374-thread-1) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2403760 INFO  (jetty-launcher-8374-thread-1) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-1) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.0.0
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-1) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-1) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-1) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-09-30T17:39:47.507Z
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-2) [    ] o.e.j.s.AbstractConnector Started ServerConnector@48ebb396{HTTP/1.1,[http/1.1]}{127.0.0.1:50537}
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-2) [    ] o.e.j.s.Server Started @2405360ms
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-2) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=50537}
   [junit4]   2> 2403761 ERROR (jetty-launcher-8374-thread-2) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-2) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-3) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-3) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-3) [    ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-2) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.0.0
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-2) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-2) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-2) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-09-30T17:39:47.507Z
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-3) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7e88f506{/solr,null,AVAILABLE}
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-3) [    ] o.e.j.s.AbstractConnector Started ServerConnector@5fac4264{HTTP/1.1,[http/1.1]}{127.0.0.1:38924}
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-3) [    ] o.e.j.s.Server Started @2405360ms
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-3) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=38924}
   [junit4]   2> 2403761 ERROR (jetty-launcher-8374-thread-3) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-3) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2403761 INFO  (jetty-launcher-8374-thread-3) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.0.0
   [junit4]   2> 2403762 INFO  (jetty-launcher-8374-thread-3) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2403762 INFO  (jetty-launcher-8374-thread-3) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2403762 INFO  (jetty-launcher-8374-thread-3) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-09-30T17:39:47.508Z
   [junit4]   2> 2403763 INFO  (jetty-launcher-8374-thread-4) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7c575323{/solr,null,AVAILABLE}
   [junit4]   2> 2403763 INFO  (jetty-launcher-8374-thread-4) [    ] o.e.j.s.AbstractConnector Started ServerConnector@134d45b3{HTTP/1.1,[http/1.1]}{127.0.0.1:34585}
   [junit4]   2> 2403763 INFO  (jetty-launcher-8374-thread-4) [    ] o.e.j.s.Server Started @2405362ms
   [junit4]   2> 2403763 INFO  (jetty-launcher-8374-thread-4) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34585}
   [junit4]   2> 2403763 ERROR (jetty-launcher-8374-thread-4) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2403763 INFO  (jetty-launcher-8374-thread-4) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2403763 INFO  (jetty-launcher-8374-thread-4) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.0.0
   [junit4]   2> 2403763 INFO  (jetty-launcher-8374-thread-4) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2403763 INFO  (jetty-launcher-8374-thread-4) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2403763 INFO  (jetty-launcher-8374-thread-4) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-09-30T17:39:47.509Z
   [junit4]   2> 2403764 INFO  (zkConnectionManagerCallback-8383-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2403765 INFO  (zkConnectionManagerCallback-8379-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2403765 INFO  (zkConnectionManagerCallback-8385-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2403765 INFO  (zkConnectionManagerCallback-8381-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2403765 INFO  (jetty-launcher-8374-thread-3) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2403765 INFO  (jetty-launcher-8374-thread-4) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2403765 INFO  (jetty-launcher-8374-thread-2) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2403767 INFO  (jetty-launcher-8374-thread-1) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2404064 INFO  (jetty-launcher-8374-thread-1) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37583/solr
   [junit4]   2> 2404065 INFO  (zkConnectionManagerCallback-8389-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2404066 DEBUG (jetty-launcher-8374-thread-1) [n:127.0.0.1:61383_solr    ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$42/458497280@5b3de575
   [junit4]   2> 2404067 INFO  (zkConnectionManagerCallback-8391-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2404220 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/clusterprops.json
   [junit4]   2> 2404220 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2404220 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/clusterstate.json
   [junit4]   2> 2404221 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/collections
   [junit4]   2> 2404221 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/aliases.json
   [junit4]   2> 2404221 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/security.json
   [junit4]   2> 2404224 DEBUG (jetty-launcher-8374-thread-1) [n:127.0.0.1:61383_solr    ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/72093056576520198-127.0.0.1:61383_solr-n_0000000000
   [junit4]   2> 2404225 INFO  (jetty-launcher-8374-thread-1) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:61383_solr
   [junit4]   2> 2404225 INFO  (jetty-launcher-8374-thread-1) [n:127.0.0.1:61383_solr    ] o.a.s.c.Overseer Overseer (id=72093056576520198-127.0.0.1:61383_solr-n_0000000000) starting
   [junit4]   2> 2404243 INFO  (zkConnectionManagerCallback-8398-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2404244 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/clusterprops.json
   [junit4]   2> 2404244 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2404244 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/clusterstate.json
   [junit4]   2> 2404244 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/collections
   [junit4]   2> 2404245 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/aliases.json
   [junit4]   2> 2404245 INFO  (jetty-launcher-8374-thread-1) [n:127.0.0.1:61383_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:37583/solr ready
   [junit4]   2> 2404246 INFO  (OverseerStateUpdate-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:61383_solr
   [junit4]   2> 2404246 DEBUG (OverseerAutoScalingTriggerThread-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
   [junit4]   2> 2404246 INFO  (jetty-launcher-8374-thread-1) [n:127.0.0.1:61383_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:61383_solr
   [junit4]   2> 2404247 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/autoscaling.json
   [junit4]   2> 2404247 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2404247 DEBUG (OverseerAutoScalingTriggerThread-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
   [junit4]   2> 2404247 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2404247 DEBUG (OverseerAutoScalingTriggerThread-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion -1
   [junit4]   2> 2404248 DEBUG (OverseerAutoScalingTriggerThread-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
   [junit4]   2> 2404248 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2404248 INFO  (zkCallback-8397-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2404248 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations
   [junit4]   2> 2404248 INFO  (OverseerStateUpdate-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2404248 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2404249 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/overseer/queue-work
   [junit4]   2> 2404249 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/overseer/queue
   [junit4]   2> 2404264 INFO  (jetty-launcher-8374-thread-1) [n:127.0.0.1:61383_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 2404273 INFO  (jetty-launcher-8374-thread-2) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37583/solr
   [junit4]   2> 2404275 INFO  (zkConnectionManagerCallback-8403-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2404275 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor Cleaning up work-queue. #Running tasks: 0
   [junit4]   2> 2404275 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor RunningTasks: []
   [junit4]   2> 2404276 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor BlockedTasks: []
   [junit4]   2> 2404276 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor CompletedTasks: []
   [junit4]   2> 2404276 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor RunningZKTasks: []
   [junit4]   2> 2404276 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskQueue Peeking for top 100 elements. ExcludeSet: []
   [junit4]   2> 2404276 DEBUG (jetty-launcher-8374-thread-2) [n:127.0.0.1:50537_solr    ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$42/458497280@12fd9425
   [junit4]   2> 2404276 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/overseer/collection-queue-work
   [junit4]   2> 2404277 INFO  (zkConnectionManagerCallback-8405-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2404284 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/clusterprops.json
   [junit4]   2> 2404284 INFO  (jetty-launcher-8374-thread-1) [n:127.0.0.1:61383_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_61383.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@603f2c96
   [junit4]   2> 2404285 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2404285 INFO  (jetty-launcher-8374-thread-2) [n:127.0.0.1:50537_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2404285 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/clusterstate.json
   [junit4]   2> 2404285 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/collections
   [junit4]   2> 2404285 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/aliases.json
   [junit4]   2> 2404286 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/security.json
   [junit4]   2> 2404287 DEBUG (jetty-launcher-8374-thread-2) [n:127.0.0.1:50537_solr    ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/72093056576520201-127.0.0.1:50537_solr-n_0000000001
   [junit4]   2> 2404288 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/overseer_elect/election/72093056576520198-127.0.0.1:61383_solr-n_0000000000
   [junit4]   2> 2404288 DEBUG (jetty-launcher-8374-thread-2) [n:127.0.0.1:50537_solr    ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/72093056576520198-127.0.0.1:61383_solr-n_0000000000 to know if I could be the leader
   [junit4]   2> 2404288 DEBUG (jetty-launcher-8374-thread-2) [n:127.0.0.1:50537_solr    ] o.a.s.c.ZkController Publish node=127.0.0.1:50537_solr as DOWN
   [junit4]   2> 2404289 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/overseer/queue
   [junit4]   2> 2404289 INFO  (jetty-launcher-8374-thread-2) [n:127.0.0.1:50537_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 2404289 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/overseer/queue
   [junit4]   2> 2404289 INFO  (jetty-launcher-8374-thread-2) [n:127.0.0.1:50537_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:50537_solr
   [junit4]   2> 2404289 INFO  (jetty-launcher-8374-thread-1) [n:127.0.0.1:61383_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_61383.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@603f2c96
   [junit4]   2> 2404290 INFO  (jetty-launcher-8374-thread-1) [n:127.0.0.1:61383_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_61383.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@603f2c96
   [junit4]   2> 2404290 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2404290 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2404290 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2404290 INFO  (jetty-launcher-8374-thread-1) [n:127.0.0.1:61383_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/tempDir-001/node1/.
   [junit4]   2> 2404290 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2404290 INFO  (zkCallback-8390-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2404291 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2404291 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2404291 INFO  (zkCallback-8397-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2404294 INFO  (zkCallback-8404-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2404304 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/autoscaling/events/.scheduled_maintenance
   [junit4]   2> 2404305 DEBUG (OverseerAutoScalingTriggerThread-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [    ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:61383_solr, 127.0.0.1:50537_solr]
   [junit4]   2> 2404305 DEBUG (OverseerAutoScalingTriggerThread-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 2404305 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/autoscaling/events/.auto_add_replicas
   [junit4]   2> 2404306 DEBUG (OverseerAutoScalingTriggerThread-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 2404306 DEBUG (ScheduledTrigger-11140-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2
   [junit4]   2> 2404313 INFO  (zkConnectionManagerCallback-8412-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2404314 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/clusterprops.json
   [junit4]   2> 2404314 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2404314 INFO  (jetty-launcher-8374-thread-2) [n:127.0.0.1:50537_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2404314 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/clusterstate.json
   [junit4]   2> 2404314 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/collections
   [junit4]   2> 2404315 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/aliases.json
   [junit4]   2> 2404315 INFO  (jetty-launcher-8374-thread-2) [n:127.0.0.1:50537_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:37583/solr ready
   [junit4]   2> 2404315 INFO  (jetty-launcher-8374-thread-2) [n:127.0.0.1:50537_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 2404327 INFO  (jetty-launcher-8374-thread-2) [n:127.0.0.1:50537_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50537.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@603f2c96
   [junit4]   2> 2404333 INFO  (jetty-launcher-8374-thread-2) [n:127.0.0.1:50537_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50537.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@603f2c96
   [junit4]   2> 2404333 INFO  (jetty-launcher-8374-thread-2) [n:127.0.0.1:50537_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50537.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@603f2c96
   [junit4]   2> 2404333 INFO  (jetty-launcher-8374-thread-2) [n:127.0.0.1:50537_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/tempDir-001/node2/.
   [junit4]   2> 2404391 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/overseer/queue
   [junit4]   2> 2404392 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/overseer/queue
   [junit4]   2> 2404552 INFO  (jetty-launcher-8374-thread-4) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37583/solr
   [junit4]   2> 2404554 INFO  (zkConnectionManagerCallback-8417-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2404555 DEBUG (jetty-launcher-8374-thread-4) [n:127.0.0.1:34585_solr    ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$42/458497280@f4a9cc9
   [junit4]   2> 2404556 INFO  (zkConnectionManagerCallback-8419-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2404565 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/clusterprops.json
   [junit4]   2> 2404565 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2404565 INFO  (jetty-launcher-8374-thread-4) [n:127.0.0.1:34585_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2404566 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/clusterstate.json
   [junit4]   2> 2404566 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/collections
   [junit4]   2> 2404566 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/aliases.json
   [junit4]   2> 2404567 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/security.json
   [junit4]   2> 2404569 DEBUG (jetty-launcher-8374-thread-4) [n:127.0.0.1:34585_solr    ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/72093056576520204-127.0.0.1:34585_solr-n_0000000002
   [junit4]   2> 2404569 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/overseer_elect/election/72093056576520201-127.0.0.1:50537_solr-n_0000000001
   [junit4]   2> 2404570 DEBUG (jetty-launcher-8374-thread-4) [n:127.0.0.1:34585_solr    ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/72093056576520201-127.0.0.1:50537_solr-n_0000000001 to know if I could be the leader
   [junit4]   2> 2404570 DEBUG (jetty-launcher-8374-thread-4) [n:127.0.0.1:34585_solr    ] o.a.s.c.ZkController Publish node=127.0.0.1:34585_solr as DOWN
   [junit4]   2> 2404571 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/overseer/queue
   [junit4]   2> 2404571 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/overseer/queue
   [junit4]   2> 2404572 INFO  (jetty-launcher-8374-thread-4) [n:127.0.0.1:34585_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 2404572 INFO  (jetty-launcher-8374-thread-4) [n:127.0.0.1:34585_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34585_solr
   [junit4]   2> 2404573 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2404573 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2404573 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2404573 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2404573 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2404573 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2404573 INFO  (zkCallback-8397-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 2404573 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2404573 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2404573 INFO  (zkCallback-8390-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 2404574 INFO  (zkCallback-8404-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 2404574 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2404574 INFO  (zkCallback-8411-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 2404574 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2404574 INFO  (zkCallback-8418-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 2404593 INFO  (zkConnectionManagerCallback-8426-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2404594 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/clusterprops.json
   [junit4]   2> 2404594 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2404594 INFO  (jetty-launcher-8374-thread-4) [n:127.0.0.1:34585_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 2404595 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/clusterstate.json
   [junit4]   2> 2404595 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/collections
   [junit4]   2> 2404595 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/aliases.json
   [junit4]   2> 2404595 INFO  (jetty-launcher-8374-thread-4) [n:127.0.0.1:34585_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:37583/solr ready
   [junit4]   2> 2404596 INFO  (jetty-launcher-8374-thread-4) [n:127.0.0.1:34585_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 2404608 INFO  (jetty-launcher-8374-thread-4) [n:127.0.0.1:34585_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34585.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@603f2c96
   [junit4]   2> 2404613 INFO  (jetty-launcher-8374-thread-4) [n:127.0.0.1:34585_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34585.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@603f2c96
   [junit4]   2> 2404614 INFO  (jetty-launcher-8374-thread-4) [n:127.0.0.1:34585_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34585.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@603f2c96
   [junit4]   2> 2404614 INFO  (jetty-launcher-8374-thread-4) [n:127.0.0.1:34585_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/tempDir-001/node4/.
   [junit4]   2> 2404673 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/overseer/queue
   [junit4]   2> 2404674 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/overseer/queue
   [junit4]   2> 2405307 DEBUG (ScheduledTrigger-11140-thread-2) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 3
   [junit4]   2> 2405320 INFO  (jetty-launcher-8374-thread-3) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37583/solr
   [junit4]   2> 2405321 INFO  (zkConnectionManagerCallback-8431-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2405323 DEBUG (jetty-launcher-8374-thread-3) [n:127.0.0.1:38924_solr    ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$42/458497280@4969e7e6
   [junit4]   2> 2405324 INFO  (zkConnectionManagerCallback-8433-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2405336 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/clusterprops.json
   [junit4]   2> 2405336 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2405336 INFO  (jetty-launcher-8374-thread-3) [n:127.0.0.1:38924_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 2405336 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/clusterstate.json
   [junit4]   2> 2405337 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/collections
   [junit4]   2> 2405337 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/aliases.json
   [junit4]   2> 2405338 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/security.json
   [junit4]   2> 2405339 DEBUG (jetty-launcher-8374-thread-3) [n:127.0.0.1:38924_solr    ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/72093056576520207-127.0.0.1:38924_solr-n_0000000003
   [junit4]   2> 2405340 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/overseer_elect/election/72093056576520204-127.0.0.1:34585_solr-n_0000000002
   [junit4]   2> 2405340 DEBUG (jetty-launcher-8374-thread-3) [n:127.0.0.1:38924_solr    ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/72093056576520204-127.0.0.1:34585_solr-n_0000000002 to know if I could be the leader
   [junit4]   2> 2405340 DEBUG (jetty-launcher-8374-thread-3) [n:127.0.0.1:38924_solr    ] o.a.s.c.ZkController Publish node=127.0.0.1:38924_solr as DOWN
   [junit4]   2> 2405341 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/overseer/queue
   [junit4]   2> 2405341 INFO  (jetty-launcher-8374-thread-3) [n:127.0.0.1:38924_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 2405341 INFO  (jetty-launcher-8374-thread-3) [n:127.0.0.1:38924_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38924_solr
   [junit4]   2> 2405342 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/overseer/queue
   [junit4]   2> 2405342 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2405342 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2405342 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2405342 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2405342 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2405342 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2405342 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2405343 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2405343 INFO  (zkCallback-8397-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2405343 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2405343 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2405343 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2405344 INFO  (zkCallback-8418-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2405344 INFO  (zkCallback-8390-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2405344 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2405344 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2405344 INFO  (zkCallback-8425-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2405344 INFO  (zkCallback-8411-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2405344 INFO  (zkCallback-8404-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2405344 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2405345 INFO  (zkCallback-8432-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2405380 INFO  (zkConnectionManagerCallback-8440-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2405381 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/clusterprops.json
   [junit4]   2> 2405382 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2405382 INFO  (jetty-launcher-8374-thread-3) [n:127.0.0.1:38924_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 2405382 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/clusterstate.json
   [junit4]   2> 2405383 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/collections
   [junit4]   2> 2405383 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/aliases.json
   [junit4]   2> 2405383 INFO  (jetty-launcher-8374-thread-3) [n:127.0.0.1:38924_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:37583/solr ready
   [junit4]   2> 2405384 INFO  (jetty-launcher-8374-thread-3) [n:127.0.0.1:38924_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 2405394 INFO  (jetty-launcher-8374-thread-3) [n:127.0.0.1:38924_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38924.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@603f2c96
   [junit4]   2> 2405403 INFO  (jetty-launcher-8374-thread-3) [n:127.0.0.1:38924_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38924.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@603f2c96
   [junit4]   2> 2405404 INFO  (jetty-launcher-8374-thread-3) [n:127.0.0.1:38924_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38924.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@603f2c96
   [junit4]   2> 2405404 INFO  (jetty-launcher-8374-thread-3) [n:127.0.0.1:38924_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/tempDir-001/node3/.
   [junit4]   2> 2405430 INFO  (zkConnectionManagerCallback-8443-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2405434 INFO  (zkConnectionManagerCallback-8448-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2405435 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/clusterprops.json
   [junit4]   2> 2405436 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2405436 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 2405437 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/clusterstate.json
   [junit4]   2> 2405437 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/collections
   [junit4]   2> 2405437 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/aliases.json
   [junit4]   2> 2405438 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:37583/solr ready
   [junit4]   2> 2405444 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/overseer/queue
   [junit4]   2> 2405445 INFO  (qtp1026803748-29059) [n:127.0.0.1:38924_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 2405445 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/overseer/queue
   [junit4]   2> 2405445 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/overseer/collection-queue-work
   [junit4]   2> 2405446 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/overseer/collection-queue-work/qnr-0000000000
   [junit4]   2> 2405446 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/overseer/collection-queue-work
   [junit4]   2> 2405446 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.ZkDistributedQueue Found child node with improper name: qnr-0000000000
   [junit4]   2> 2405446 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/overseer/collection-queue-work
   [junit4]   2> 2405447 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/overseer/collection-queue-work
   [junit4]   2> 2405447 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.ZkDistributedQueue Found child node with improper name: qnr-0000000000
   [junit4]   2> 2405447 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskQueue Returning topN elements: [/overseer/collection-queue-work/qn-0000000000, ]
   [junit4]   2> 2405447 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor Got 1 tasks from work-queue : [[org.apache.solr.cloud.OverseerTaskQueue$QueueEvent@2e684ecf]]
   [junit4]   2> 2405447 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor Marked task [/overseer/collection-queue-work/qn-0000000000] as running
   [junit4]   2> 2405447 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor Overseer Collection Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000000 message:{"operation":"overseerstatus"}
   [junit4]   2> 2405448 DEBUG (OverseerThreadFactory-11148-thread-1-processing-n:127.0.0.1:61383_solr) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor Runner processing /overseer/collection-queue-work/qn-0000000000
   [junit4]   2> 2405448 DEBUG (OverseerThreadFactory-11148-thread-1-processing-n:127.0.0.1:61383_solr) [n:127.0.0.1:61383_solr    ] o.a.s.c.a.c.OverseerCollectionMessageHandler OverseerCollectionMessageHandler.processMessage : overseerstatus , {"operation":"overseerstatus"}
   [junit4]   2> 2405448 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor Cleaning up work-queue. #Running tasks: 1
   [junit4]   2> 2405448 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor RunningTasks: [/overseer/collection-queue-work/qn-0000000000]
   [junit4]   2> 2405448 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor BlockedTasks: []
   [junit4]   2> 2405448 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor CompletedTasks: []
   [junit4]   2> 2405448 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor RunningZKTasks: [/overseer/collection-queue-work/qn-0000000000]
   [junit4]   2> 2405448 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskQueue Peeking for top 99 elements. ExcludeSet: [/overseer/collection-queue-work/qn-0000000000],[]
   [junit4]   2> 2405450 DEBUG (OverseerThreadFactory-11148-thread-1-processing-n:127.0.0.1:61383_solr) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor Completed task:[/overseer/collection-queue-work/qn-0000000000]
   [junit4]   2> 2405451 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: data: /solr/overseer/collection-queue-work/qnr-0000000000
   [junit4]   2> 2405451 DEBUG (zkCallback-8432-thread-1) [    ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000000 state SyncConnected latchEventType null
   [junit4]   2> 2405451 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/overseer/collection-queue-work
   [junit4]   2> 2405451 DEBUG (OverseerThreadFactory-11148-thread-1-processing-n:127.0.0.1:61383_solr) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor Marked task [/overseer/collection-queue-work/qn-0000000000] as completed.
   [junit4]   2> 2405451 DEBUG (OverseerThreadFactory-11148-thread-1-processing-n:127.0.0.1:61383_solr) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor RunningTasks: []
   [junit4]   2> 2405451 DEBUG (OverseerThreadFactory-11148-thread-1-processing-n:127.0.0.1:61383_solr) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor BlockedTasks: []
   [junit4]   2> 2405451 DEBUG (OverseerThreadFactory-11148-thread-1-processing-n:127.0.0.1:61383_solr) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor CompletedTasks: [/overseer/collection-queue-work/qn-0000000000]
   [junit4]   2> 2405451 DEBUG (OverseerThreadFactory-11148-thread-1-processing-n:127.0.0.1:61383_solr) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor RunningZKTasks: [/overseer/collection-queue-work/qn-0000000000]
   [junit4]   2> 2405451 DEBUG (OverseerThreadFactory-11148-thread-1-processing-n:127.0.0.1:61383_solr) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor Overseer Collection Message Handler: Message id:/overseer/collection-queue-work/qn-0000000000 complete, response:{leader=127.0.0.1:61383_solr,overseer_queue_size=0,overseer_work_queue_size=0,overseer_collection_queue_size=2,overseer_operations={am_i_leader={requests=5,errors=0,avgRequestsPerSecond=4.150791428703696,5minRateRequestsPerSecond=0.0,15minRateRequestsPerSecond=0.0,avgTimePerRequest=0.41060312983414265,medianRequestTime=0.445872,75thPcRequestTime=0.483252,95thPcRequestTime=0.54168,99thPcRequestTime=0.54168,999thPcRequestTime=0.54168},downnode={requests=3,errors=0,avgRequestsPerSecond=2.585099742902524,5minRateRequestsPerSecond=0.0,15minRateRequestsPerSecond=0.0,avgTimePerRequest=0.011019393983820482,medianRequestTime=0.005738,75thPcRequestTime=0.02171,95thPcRequestTime=0.02171,99thPcRequestTime=0.02171,999thPcRequestTime=0.02171}},collection_operations={am_i_leader={requests=3,errors=0,avgRequestsPerSecond=2.495479412010782,5minRateRequestsPerSecond=0.0,15minRateRequestsPerSecond=0.0,avgTimePerRequest=0.3346276395965422,medianRequestTime=0.322036,75thPcRequestTime=0.35959,95thPcRequestTime=0.35959,99thPcRequestTime=0.35959,999thPcRequestTime=0.35959},overseerstatus={requests=0,errors=0,avgRequestsPerSecond=0.0,5minRateRequestsPerSecond=0.0,15minRateRequestsPerSecond=0.0,avgTimePerRequest=0.0,medianRequestTime=0.0,75thPcRequestTime=0.0,95thPcRequestTime=0.0,99thPcRequestTime=0.0,999thPcRequestTime=0.0}},overseer_queue={},overseer_internal_queue={peek={avgRequestsPerSecond=0.8321236301388373,5minRateRequestsPerSecond=0.0,15minRateRequestsPerSecond=0.0,avgTimePerRequest=0.256169,medianRequestTime=0.256169,75thPcRequestTime=0.256169,95thPcRequestTime=0.256169,99thPcRequestTime=0.256169,999thPcRequestTime=0.256169}},collection_queue={peektopn_wait2000={avgRequestsPerSecond=0.8516694610012654,5minRateRequestsPerSecond=0.0,15minRateRequestsPerSecond=0.0,avgTimePerRequest=1171.826615,medianRequestTime=1171.826615,75thPcRequestTime=1171.826615,95thPcRequestTime=1171.826615,99thPcRequestTime=1171.826615,999thPcRequestTime=1171.826615}}}
   [junit4]   2> 2405452 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/overseer/collection-queue-work
   [junit4]   2> 2405452 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.ZkDistributedQueue Found child node with improper name: qnr-0000000000
   [junit4]   2> 2405452 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/overseer/collection-queue-work
   [junit4]   2> 2405453 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/overseer/collection-queue-work
   [junit4]   2> 2405453 INFO  (qtp1026803748-29059) [n:127.0.0.1:38924_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=8
   [junit4]   1> Formatting using clusterid: testClusterID
   [junit4]   2> 2405521 WARN  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
   [junit4]   2> 2405525 WARN  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
   [junit4]   2> 2405528 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.m.log jetty-6.1.26
   [junit4]   2> 2405541 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.m.log Extract jar:file:/export/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/hdfs to ./temp/Jetty_serv1.vm3_59285_hdfs____v08824/webapp
   [junit4]   2> 2406019 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@serv1-vm3:59285
   [junit4]   2> 2406135 WARN  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
   [junit4]   2> 2406136 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.m.log jetty-6.1.26
   [junit4]   2> 2406149 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.m.log Extract jar:file:/export/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/datanode to ./temp/Jetty_localhost_54417_datanode____.bvr67y/webapp
   [junit4]   2> 2406311 DEBUG (ScheduledTrigger-11140-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 4
   [junit4]   2> 2406609 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:54417
   [junit4]   2> 2406673 WARN  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
   [junit4]   2> 2406674 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.m.log jetty-6.1.26
   [junit4]   2> 2406685 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.m.log Extract jar:file:/export/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/datanode to ./temp/Jetty_localhost_62401_datanode____.664bkw/webapp
   [junit4]   2> 2406781 ERROR (DataNode: [[[DISK]file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/tempDir-002/hdfsBaseDir/data/data1/, [DISK]file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/tempDir-002/hdfsBaseDir/data/data2/]]  heartbeating to serv1-vm3/127.0.0.1:43348) [    ] o.a.h.h.s.d.DirectoryScanner dfs.datanode.directoryscan.throttle.limit.ms.per.sec set to value below 1 ms/sec. Assuming default value of 1000
   [junit4]   2> 2406793 INFO  (Block report processor) [    ] BlockStateChange BLOCK* processReport 0x1ec24fa687386: from storage DS-7b502d54-e24e-458d-908c-9b2bff119872 node DatanodeRegistration(127.0.0.1:38790, datanodeUuid=779a105c-b6ec-4b05-ba4f-0e008b521af6, infoPort=45142, infoSecurePort=0, ipcPort=58833, storageInfo=lv=-56;cid=testClusterID;nsid=944792505;c=0), blocks: 0, hasStaleStorage: true, processing time: 0 msecs
   [junit4]   2> 2406793 INFO  (Block report processor) [    ] BlockStateChange BLOCK* processReport 0x1ec24fa687386: from storage DS-e7a049d3-650c-43c1-9375-bed3e526c172 node DatanodeRegistration(127.0.0.1:38790, datanodeUuid=779a105c-b6ec-4b05-ba4f-0e008b521af6, infoPort=45142, infoSecurePort=0, ipcPort=58833, storageInfo=lv=-56;cid=testClusterID;nsid=944792505;c=0), blocks: 0, hasStaleStorage: false, processing time: 0 msecs
   [junit4]   2> 2407220 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:62401
   [junit4]   2> 2407314 DEBUG (ScheduledTrigger-11140-thread-2) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 4
   [junit4]   2> 2407355 ERROR (DataNode: [[[DISK]file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/tempDir-002/hdfsBaseDir/data/data3/, [DISK]file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/tempDir-002/hdfsBaseDir/data/data4/]]  heartbeating to serv1-vm3/127.0.0.1:43348) [    ] o.a.h.h.s.d.DirectoryScanner dfs.datanode.directoryscan.throttle.limit.ms.per.sec set to value below 1 ms/sec. Assuming default value of 1000
   [junit4]   2> 2407361 INFO  (Block report processor) [    ] BlockStateChange BLOCK* processReport 0x1ec251c4ea201: from storage DS-b666a8e6-e6c4-4e30-b3ec-2bc5cdcb46a5 node DatanodeRegistration(127.0.0.1:48405, datanodeUuid=00b38543-c2d9-4c6b-97d1-679d97f0baed, infoPort=46561, infoSecurePort=0, ipcPort=41669, storageInfo=lv=-56;cid=testClusterID;nsid=944792505;c=0), blocks: 0, hasStaleStorage: true, processing time: 0 msecs
   [junit4]   2> 2407361 INFO  (Block report processor) [    ] BlockStateChange BLOCK* processReport 0x1ec251c4ea201: from storage DS-d07af340-66f7-4695-9b0f-86c7a8b60aa5 node DatanodeRegistration(127.0.0.1:48405, datanodeUuid=00b38543-c2d9-4c6b-97d1-679d97f0baed, infoPort=46561, infoSecurePort=0, ipcPort=41669, storageInfo=lv=-56;cid=testClusterID;nsid=944792505;c=0), blocks: 0, hasStaleStorage: false, processing time: 0 msecs
   [junit4]   2> 2407452 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor Got 0 tasks from work-queue : [[]]
   [junit4]   2> 2407452 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor Cleaning up work-queue. #Running tasks: 0
   [junit4]   2> 2407453 INFO  (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may have disconnected from ZooKeeper
   [junit4]   2> 2407454 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor RunningTasks: []
   [junit4]   2> 2407454 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor BlockedTasks: []
   [junit4]   2> 2407454 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor CompletedTasks: []
   [junit4]   2> 2407454 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskProcessor RunningZKTasks: []
   [junit4]   2> 2407454 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskQueue Peeking for top 100 elements. ExcludeSet: []
   [junit4]   2> 2407551 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testNormalMove
   [junit4]   2> 2407552 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/clusterprops.json
   [junit4]   2> 2407553 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2407553 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 2407553 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/clusterstate.json
   [junit4]   2> 2407553 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/collections
   [junit4]   2> 2407554 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/aliases.json
   [junit4]   2> 2407555 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: data: /solr/aliases.json
   [junit4]   2> 2407555 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: data: /solr/aliases.json
   [junit4]   2> 2407555 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: data: /solr/aliases.json
   [junit4]   2> 2407555 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: data: /solr/aliases.json
   [junit4]   2> 2407555 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: data: /solr/aliases.json
   [junit4]   2> 2407555 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: data: /solr/aliases.json
   [junit4]   2> 2407555 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: data: /solr/aliases.json
   [junit4]   2> 2407555 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: data: /solr/aliases.json
   [junit4]   2> 2407555 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: data: /solr/aliases.json
   [junit4]   2> 2407555 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/aliases.json
   [junit4]   2> 2407555 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/aliases.json
   [junit4]   2> 2407555 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/aliases.json
   [junit4]   2> 2407555 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/aliases.json
   [junit4]   2> 2407555 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/aliases.json
   [junit4]   2> 2407555 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/aliases.json
   [junit4]   2> 2407555 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/aliases.json
   [junit4]   2> 2407555 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/aliases.json
   [junit4]   2> 2407559 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/aliases.json
   [junit4]   2> 2407559 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/aliases.json
   [junit4]   2> 2407560 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
   [junit4]   2> 2407561 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2407561 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2407561 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 2407561 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@171b3b6{/solr,null,AVAILABLE}
   [junit4]   2> 2407562 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@5e6a8c84{HTTP/1.1,[http/1.1]}{127.0.0.1:62256}
   [junit4]   2> 2407562 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.e.j.s.Server Started @2409163ms
   [junit4]   2> 2407562 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=62256}
   [junit4]   2> 2407562 ERROR (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2407562 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2407562 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.0.0
   [junit4]   2> 2407562 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2407562 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2407562 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-09-30T17:39:51.308Z
   [junit4]   2> 2407563 INFO  (zkConnectionManagerCallback-8452-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2407564 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2407868 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37583/solr
   [junit4]   2> 2407870 INFO  (zkConnectionManagerCallback-8456-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2407871 DEBUG (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [n:127.0.0.1:62256_solr    ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$42/458497280@c5db30
   [junit4]   2> 2407872 INFO  (zkConnectionManagerCallback-8458-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2407882 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/clusterprops.json
   [junit4]   2> 2407883 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2407883 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [n:127.0.0.1:62256_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 2407883 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/clusterstate.json
   [junit4]   2> 2407884 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/collections
   [junit4]   2> 2407884 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/aliases.json
   [junit4]   2> 2407885 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/security.json
   [junit4]   2> 2407887 DEBUG (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [n:127.0.0.1:62256_solr    ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/72093056576520213-127.0.0.1:62256_solr-n_0000000004
   [junit4]   2> 2407887 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/overseer_elect/election/72093056576520207-127.0.0.1:38924_solr-n_0000000003
   [junit4]   2> 2407887 DEBUG (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [n:127.0.0.1:62256_solr    ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/72093056576520207-127.0.0.1:38924_solr-n_0000000003 to know if I could be the leader
   [junit4]   2> 2407888 DEBUG (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [n:127.0.0.1:62256_solr    ] o.a.s.c.ZkController Publish node=127.0.0.1:62256_solr as DOWN
   [junit4]   2> 2407889 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/overseer/queue
   [junit4]   2> 2407889 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [n:127.0.0.1:62256_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 2407889 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/overseer/queue
   [junit4]   2> 2407889 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [n:127.0.0.1:62256_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:62256_solr
   [junit4]   2> 2407890 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2407890 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2407890 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2407890 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2407890 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2407890 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2407890 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2407890 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2407890 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2407890 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/live_nodes
   [junit4]   2> 2407891 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2407891 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2407891 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2407891 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2407891 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2407891 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2407891 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2407891 INFO  (zkCallback-8447-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 2407891 INFO  (zkCallback-8390-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 2407891 INFO  (zkCallback-8425-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 2407891 INFO  (zkCallback-8432-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 2407892 INFO  (zkCallback-8397-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 2407892 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2407892 INFO  (zkCallback-8404-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 2407892 INFO  (zkCallback-8411-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 2407892 INFO  (zkCallback-8418-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 2407892 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2407892 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2407892 INFO  (zkCallback-8439-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 2407892 INFO  (zkCallback-8447-thread-2) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 2407892 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2407892 INFO  (zkCallback-8457-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 2407912 INFO  (zkConnectionManagerCallback-8465-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2407914 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/clusterprops.json
   [junit4]   2> 2407914 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/live_nodes
   [junit4]   2> 2407914 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [n:127.0.0.1:62256_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
   [junit4]   2> 2407915 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: data: /solr/clusterstate.json
   [junit4]   2> 2407915 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/collections
   [junit4]   2> 2407915 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/aliases.json
   [junit4]   2> 2407916 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [n:127.0.0.1:62256_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:37583/solr ready
   [junit4]   2> 2407916 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [n:127.0.0.1:62256_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 2407931 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [n:127.0.0.1:62256_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_62256.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@603f2c96
   [junit4]   2> 2407939 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [n:127.0.0.1:62256_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_62256.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@603f2c96
   [junit4]   2> 2407939 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [n:127.0.0.1:62256_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_62256.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@603f2c96
   [junit4]   2> 2407940 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [n:127.0.0.1:62256_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/tempDir-001/node5/.
   [junit4]   2> 2407981 INFO  (zkConnectionManagerCallback-8468-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2407983 INFO  (TEST-MoveReplicaHDFSTest.testNormalMove-seed#[BFB4BFC46A06B6E7]) [    ] o.a.s.c.MoveReplicaTest total_jettys: 5
   [junit4]   2> 2407984 INFO  (qtp1660725373-29050) [n:127.0.0.1:34585_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf1&maxShardsPerNode=2&autoAddReplicas=false&name=MoveReplicaHDFSTest_coll_false&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 2407986 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/overseer/collection-queue-work
   [junit4]   2> 2407986 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: create/delete: /solr/overseer/collection-queue-work/qnr-0000000002
   [junit4]   2> 2407987 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/overseer/collection-queue-work
   [junit4]   2> 2407987 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.ZkDistributedQueue Found child node with improper name: qnr-0000000002
   [junit4]   2> 2407987 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch fired: children: /solr/overseer/collection-queue-work
   [junit4]   2> 2407987 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch added: children: /solr/overseer/collection-queue-work
   [junit4]   2> 2407988 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.ZkDistributedQueue Found child node with improper name: qnr-0000000002
   [junit4]   2> 2407988 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000) [n:127.0.0.1:61383_solr    ] o.a.s.c.OverseerTaskQueue Returning topN elements: [/overseer/collection-queue-work/qn-0000000002, ]
   [junit4]   2> 2407988 DEBUG (OverseerCollectionConfigSetProcessor-72093056576520198-127.0.0.1:61383_solr-n_0000000000)

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

?]
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_172]
   [junit4]   2> 197337 INFO  (jetty-closer-129-thread-3) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 197338 ERROR (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 197339 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:60228 60228
   [junit4]   2> 197458 INFO  (Thread-2106) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:60228 60228
   [junit4]   2> 197460 WARN  (Thread-2106) [    ] o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	33	/solr/collections/MoveReplicaHDFSTest_coll_false/terms/shard1
   [junit4]   2> 	22	/solr/collections/MoveReplicaHDFSTest_coll_true/terms/shard1
   [junit4]   2> 	19	/solr/configs/conf1
   [junit4]   2> 	17	/solr/aliases.json
   [junit4]   2> 	17	/solr/clusterprops.json
   [junit4]   2> 	10	/solr/collections/MoveReplicaHDFSTest_coll_true/terms/shard2
   [junit4]   2> 	9	/solr/collections/MoveReplicaHDFSTest_coll_false/terms/shard2
   [junit4]   2> 	8	/solr/collections/MoveReplicaHDFSTest_failed_coll_true/terms/shard1
   [junit4]   2> 	8	/solr/collections/MoveReplicaHDFSTest_failed_coll_true/terms/shard2
   [junit4]   2> 	7	/solr/collections/MoveReplicaHDFSTest_failed_coll_false/terms/shard2
   [junit4]   2> 	7	/solr/collections/MoveReplicaHDFSTest_failed_coll_false/terms/shard1
   [junit4]   2> 	6	/solr/security.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2> 	17	/solr/clusterstate.json
   [junit4]   2> 	15	/solr/collections/MoveReplicaHDFSTest_coll_false/state.json
   [junit4]   2> 	10	/solr/aliases.json
   [junit4]   2> 	4	/solr/collections/MoveReplicaHDFSTest_coll_true/state.json
   [junit4]   2> 	4	/solr/overseer_elect/election/72093248828932102-127.0.0.1:58469_solr-n_0000000000
   [junit4]   2> 	4	/solr/collections/MoveReplicaHDFSTest_failed_coll_false/state.json
   [junit4]   2> 	4	/solr/collections/MoveReplicaHDFSTest_failed_coll_true/state.json
   [junit4]   2> 	2	/solr/collections/MoveReplicaHDFSTest_coll_true/leader_elect/shard1/election/72093248828932105-core_node5-n_0000000000
   [junit4]   2> 	2	/solr/collections/MoveReplicaHDFSTest_coll_false/leader_elect/shard1/election/72093248828932111-core_node3-n_0000000001
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	32	/solr/collections
   [junit4]   2> 	29	/solr/live_nodes
   [junit4]   2> 
   [junit4]   2> 197462 WARN  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.a.h.h.s.d.DirectoryScanner DirectoryScanner: shutdown has been called
   [junit4]   2> 197469 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.m.log Stopped HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:0
   [junit4]   2> 197573 WARN  (DataNode: [[[DISK]file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/tempDir-002/hdfsBaseDir/data/data3/, [DISK]file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/tempDir-002/hdfsBaseDir/data/data4/]]  heartbeating to serv1-vm3/127.0.0.1:40960) [    ] o.a.h.h.s.d.IncrementalBlockReportManager IncrementalBlockReportManager interrupted
   [junit4]   2> 197573 WARN  (DataNode: [[[DISK]file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/tempDir-002/hdfsBaseDir/data/data3/, [DISK]file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/tempDir-002/hdfsBaseDir/data/data4/]]  heartbeating to serv1-vm3/127.0.0.1:40960) [    ] o.a.h.h.s.d.DataNode Ending block pool service for: Block pool BP-998357028-127.0.0.1-1538332120373 (Datanode Uuid b48c248b-37c2-49aa-b5a6-e208104cdd4f) service to serv1-vm3/127.0.0.1:40960
   [junit4]   2> 197579 WARN  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.a.h.h.s.d.DirectoryScanner DirectoryScanner: shutdown has been called
   [junit4]   2> 197585 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.m.log Stopped HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:0
   [junit4]   2> 197690 WARN  (DataNode: [[[DISK]file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/tempDir-002/hdfsBaseDir/data/data1/, [DISK]file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/tempDir-002/hdfsBaseDir/data/data2/]]  heartbeating to serv1-vm3/127.0.0.1:40960) [    ] o.a.h.h.s.d.IncrementalBlockReportManager IncrementalBlockReportManager interrupted
   [junit4]   2> 197690 WARN  (DataNode: [[[DISK]file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/tempDir-002/hdfsBaseDir/data/data1/, [DISK]file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001/tempDir-002/hdfsBaseDir/data/data2/]]  heartbeating to serv1-vm3/127.0.0.1:40960) [    ] o.a.h.h.s.d.DataNode Ending block pool service for: Block pool BP-998357028-127.0.0.1-1538332120373 (Datanode Uuid fac0cde1-f322-4707-a8bb-a5ecb0d706ba) service to serv1-vm3/127.0.0.1:40960
   [junit4]   2> 197709 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.m.log Stopped HttpServer2$SelectChannelConnectorWithSafeStartup@serv1-vm3:0
   [junit4]   2> 197831 INFO  (SUITE-MoveReplicaHDFSTest-seed#[BFB4BFC46A06B6E7]-worker) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:60228 60228
   [junit4]   2> NOTE: leaving temporary files on disk at: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BFB4BFC46A06B6E7-001
   [junit4]   2> Sep 30, 2018 6:30:00 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 27 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=Lucene80, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@32495463), locale=ko-KR, timezone=CST
   [junit4]   2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_172 (64-bit)/cpus=3,threads=2,free=79991760,total=212860928
   [junit4]   2> NOTE: All tests run in this JVM: [MoveReplicaHDFSTest, MoveReplicaHDFSTest]
   [junit4] Completed [4/5 (2!)] on J1 in 91.42s, 4 tests, 1 error <<< FAILURES!
   [junit4] 
   [junit4] Suite: org.apache.solr.cloud.MoveReplicaHDFSTest
   [junit4] OK      23.8s J0 | MoveReplicaHDFSTest.testNormalMove
   [junit4] OK      24.9s J0 | MoveReplicaHDFSTest.test
   [junit4] OK      13.8s J0 | MoveReplicaHDFSTest.testFailedMove
   [junit4] OK      15.8s J0 | MoveReplicaHDFSTest.testNormalFailedMove
   [junit4] Completed [5/5 (2!)] on J0 in 92.43s, 4 tests
   [junit4] 
   [junit4] 
   [junit4] Tests with failures [seed: BFB4BFC46A06B6E7]:
   [junit4]   - org.apache.solr.cloud.MoveReplicaHDFSTest.testFailedMove
   [junit4]   - org.apache.solr.cloud.MoveReplicaHDFSTest.testFailedMove
   [junit4] 
   [junit4] 
   [junit4] JVM J0:     0.68 ..   292.77 =   292.10s
   [junit4] JVM J1:     0.68 ..   208.88 =   208.20s
   [junit4] Execution time total: 4 minutes 52 seconds
   [junit4] Tests summary: 5 suites, 20 tests, 2 errors

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

Total time: 4 minutes 54 seconds

[repro] Setting last failure code to 256

[repro] Failures:
[repro]   2/5 failed: org.apache.solr.cloud.MoveReplicaHDFSTest
[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=964cc88cee7d62edf03a923e3217809d630af5d5, workspace=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris
[WARNINGS] Computing warning deltas based on reference build #2083
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

Mime
View raw message