Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Windows/64/
Java: 64bit/jdk1.8.0_172 -XX:-UseCompressedOops -XX:+UseSerialGC

1 tests failed.
FAILED:  org.apache.solr.cloud.OverseerRolesTest.testOverseerRole

Error Message:
Timed out waiting for overseer state change

Stack Trace:
java.lang.AssertionError: Timed out waiting for overseer state change
        at 
__randomizedtesting.SeedInfo.seed([DEA3ACF9439D1556:3F68516D782E2387]:0)
        at org.junit.Assert.fail(Assert.java:88)
        at 
org.apache.solr.cloud.OverseerRolesTest.waitForNewOverseer(OverseerRolesTest.java:63)
        at 
org.apache.solr.cloud.OverseerRolesTest.testOverseerRole(OverseerRolesTest.java:145)
        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:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        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:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 14379 lines...]
   [junit4] Suite: org.apache.solr.cloud.OverseerRolesTest
   [junit4]   2> 2462465 INFO  
(SUITE-OverseerRolesTest-seed#[DEA3ACF9439D1556]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.OverseerRolesTest_DEA3ACF9439D1556-001\init-core-data-001
   [junit4]   2> 2462467 INFO  
(SUITE-OverseerRolesTest-seed#[DEA3ACF9439D1556]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 2462469 INFO  
(SUITE-OverseerRolesTest-seed#[DEA3ACF9439D1556]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 2462471 INFO  
(SUITE-OverseerRolesTest-seed#[DEA3ACF9439D1556]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.OverseerRolesTest_DEA3ACF9439D1556-001\tempDir-001
   [junit4]   2> 2462472 INFO  
(SUITE-OverseerRolesTest-seed#[DEA3ACF9439D1556]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2462472 INFO  (ZkTestServer Run Thread) [    ] 
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2462473 INFO  (ZkTestServer Run Thread) [    ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 2462573 INFO  
(SUITE-OverseerRolesTest-seed#[DEA3ACF9439D1556]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:51711
   [junit4]   2> 2462573 INFO  
(SUITE-OverseerRolesTest-seed#[DEA3ACF9439D1556]-worker) [    ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:51711
   [junit4]   2> 2462573 INFO  
(SUITE-OverseerRolesTest-seed#[DEA3ACF9439D1556]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 51711
   [junit4]   2> 2462579 INFO  (zkConnectionManagerCallback-20383-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2462584 INFO  (zkConnectionManagerCallback-20385-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2462586 INFO  (zkConnectionManagerCallback-20387-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2462590 WARN  (jetty-launcher-20388-thread-4) [    ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 2462590 WARN  (jetty-launcher-20388-thread-3) [    ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 2462590 WARN  (jetty-launcher-20388-thread-2) [    ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 2462590 INFO  (jetty-launcher-20388-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 2462590 INFO  (jetty-launcher-20388-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 2462590 INFO  (jetty-launcher-20388-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 2462590 INFO  (jetty-launcher-20388-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 2462590 INFO  (jetty-launcher-20388-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 2462590 INFO  (jetty-launcher-20388-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 2462590 INFO  (jetty-launcher-20388-thread-2) [    ] 
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: 
c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_172-b11
   [junit4]   2> 2462590 INFO  (jetty-launcher-20388-thread-4) [    ] 
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: 
c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_172-b11
   [junit4]   2> 2462590 INFO  (jetty-launcher-20388-thread-3) [    ] 
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: 
c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_172-b11
   [junit4]   2> 2462590 WARN  (jetty-launcher-20388-thread-1) [    ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 2462590 INFO  (jetty-launcher-20388-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 2462590 INFO  (jetty-launcher-20388-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 2462590 INFO  (jetty-launcher-20388-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: 
c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_172-b11
   [junit4]   2> 2462591 INFO  (jetty-launcher-20388-thread-3) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2462591 INFO  (jetty-launcher-20388-thread-3) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2462591 INFO  (jetty-launcher-20388-thread-3) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 2462591 INFO  (jetty-launcher-20388-thread-4) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2462591 INFO  (jetty-launcher-20388-thread-4) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2462591 INFO  (jetty-launcher-20388-thread-4) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 2462591 INFO  (jetty-launcher-20388-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2462591 INFO  (jetty-launcher-20388-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2462591 INFO  (jetty-launcher-20388-thread-2) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 2462591 INFO  (jetty-launcher-20388-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3ab51fe3{/solr,null,AVAILABLE}
   [junit4]   2> 2462591 INFO  (jetty-launcher-20388-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@31c41c85{/solr,null,AVAILABLE}
   [junit4]   2> 2462591 INFO  (jetty-launcher-20388-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2462591 INFO  (jetty-launcher-20388-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2462591 INFO  (jetty-launcher-20388-thread-1) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 2462592 INFO  (jetty-launcher-20388-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7aa74d6b{/solr,null,AVAILABLE}
   [junit4]   2> 2462592 INFO  (jetty-launcher-20388-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3ee5e4b2{/solr,null,AVAILABLE}
   [junit4]   2> 2462592 INFO  (jetty-launcher-20388-thread-3) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@27079b39{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:51723}
   [junit4]   2> 2462592 INFO  (jetty-launcher-20388-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@2a3611a1{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:51722}
   [junit4]   2> 2462592 INFO  (jetty-launcher-20388-thread-2) [    ] 
o.e.j.s.Server Started @2462631ms
   [junit4]   2> 2462592 INFO  (jetty-launcher-20388-thread-3) [    ] 
o.e.j.s.Server Started @2462631ms
   [junit4]   2> 2462592 INFO  (jetty-launcher-20388-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=51722}
   [junit4]   2> 2462592 INFO  (jetty-launcher-20388-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=51723}
   [junit4]   2> 2462592 ERROR (jetty-launcher-20388-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2462592 INFO  (jetty-launcher-20388-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2462592 ERROR (jetty-launcher-20388-thread-3) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2462592 INFO  (jetty-launcher-20388-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2462592 INFO  (jetty-launcher-20388-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.1.0
   [junit4]   2> 2462592 INFO  (jetty-launcher-20388-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.1.0
   [junit4]   2> 2462592 INFO  (jetty-launcher-20388-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2462592 INFO  (jetty-launcher-20388-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2462592 INFO  (jetty-launcher-20388-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2462592 INFO  (jetty-launcher-20388-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-03-02T12:44:21.405Z
   [junit4]   2> 2462592 INFO  (jetty-launcher-20388-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2462592 INFO  (jetty-launcher-20388-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-03-02T12:44:21.405Z
   [junit4]   2> 2462593 INFO  (jetty-launcher-20388-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@506a29bd{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:51727}
   [junit4]   2> 2462593 INFO  (jetty-launcher-20388-thread-1) [    ] 
o.e.j.s.Server Started @2462632ms
   [junit4]   2> 2462593 INFO  (jetty-launcher-20388-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=51727}
   [junit4]   2> 2462593 ERROR (jetty-launcher-20388-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2462593 INFO  (jetty-launcher-20388-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2462593 INFO  (jetty-launcher-20388-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.1.0
   [junit4]   2> 2462593 INFO  (jetty-launcher-20388-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2462593 INFO  (jetty-launcher-20388-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2462593 INFO  (jetty-launcher-20388-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-03-02T12:44:21.406Z
   [junit4]   2> 2462593 INFO  (jetty-launcher-20388-thread-4) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@644224d2{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:51731}
   [junit4]   2> 2462593 INFO  (jetty-launcher-20388-thread-4) [    ] 
o.e.j.s.Server Started @2462633ms
   [junit4]   2> 2462593 INFO  (jetty-launcher-20388-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=51731}
   [junit4]   2> 2462595 ERROR (jetty-launcher-20388-thread-4) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2462595 INFO  (jetty-launcher-20388-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2462595 INFO  (jetty-launcher-20388-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.1.0
   [junit4]   2> 2462595 INFO  (jetty-launcher-20388-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2462595 INFO  (jetty-launcher-20388-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2462595 INFO  (jetty-launcher-20388-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-03-02T12:44:21.408Z
   [junit4]   2> 2462599 INFO  (zkConnectionManagerCallback-20390-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2462599 INFO  (zkConnectionManagerCallback-20392-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2462599 INFO  (zkConnectionManagerCallback-20394-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2462599 INFO  (zkConnectionManagerCallback-20396-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2462599 INFO  (jetty-launcher-20388-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2462599 INFO  (jetty-launcher-20388-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2462599 INFO  (jetty-launcher-20388-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2462600 INFO  (jetty-launcher-20388-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2462614 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x1001c75da9a0006, likely client has closed socket
   [junit4]   2> 2462692 INFO  (jetty-launcher-20388-thread-3) [    ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 2462692 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x1001c75da9a0005, likely client has closed socket
   [junit4]   2> 2462721 INFO  (jetty-launcher-20388-thread-4) [    ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 2462725 WARN  (jetty-launcher-20388-thread-3) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@cb0ce8d[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2462737 WARN  (jetty-launcher-20388-thread-4) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@32bb8d68[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2462747 WARN  (jetty-launcher-20388-thread-4) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@1d9f3b62[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2462748 INFO  (jetty-launcher-20388-thread-4) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51711/solr
   [junit4]   2> 2462749 WARN  (jetty-launcher-20388-thread-3) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@ad4c394[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2462750 INFO  (jetty-launcher-20388-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51711/solr
   [junit4]   2> 2462753 INFO  (zkConnectionManagerCallback-20405-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2462755 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x1001c75da9a0007, likely client has closed socket
   [junit4]   2> 2462756 INFO  (zkConnectionManagerCallback-20408-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2462757 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x1001c75da9a0008, likely client has closed socket
   [junit4]   2> 2462761 INFO  (zkConnectionManagerCallback-20410-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2462776 INFO  (zkConnectionManagerCallback-20412-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2462796 INFO  (jetty-launcher-20388-thread-3) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:51723_solr
   [junit4]   2> 2462797 INFO  (jetty-launcher-20388-thread-3) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.Overseer Overseer 
(id=72088886542204938-127.0.0.1:51723_solr-n_0000000000) starting
   [junit4]   2> 2462821 INFO  (jetty-launcher-20388-thread-1) [    ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 2462822 INFO  (zkConnectionManagerCallback-20421-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2462824 WARN  (jetty-launcher-20388-thread-1) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@418da501[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2462828 INFO  (jetty-launcher-20388-thread-3) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:51711/solr ready
   [junit4]   2> 2462829 INFO  (jetty-launcher-20388-thread-3) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:51723_solr
   [junit4]   2> 2462829 WARN  (jetty-launcher-20388-thread-1) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@6cdc4f2e[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2462830 INFO  (jetty-launcher-20388-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51711/solr
   [junit4]   2> 2462846 INFO  (jetty-launcher-20388-thread-4) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2462852 INFO  (jetty-launcher-20388-thread-4) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.ZkController Publish 
node=127.0.0.1:51731_solr as DOWN
   [junit4]   2> 2462852 INFO  (jetty-launcher-20388-thread-4) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 2462852 INFO  (jetty-launcher-20388-thread-4) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:51731_solr
   [junit4]   2> 2462882 INFO  
(OverseerStateUpdate-72088886542204938-127.0.0.1:51723_solr-n_0000000000) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:51723_solr
   [junit4]   2> 2462905 INFO  (zkCallback-20411-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2462905 INFO  (zkCallback-20409-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2462905 INFO  (zkCallback-20420-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2462910 INFO  (zkConnectionManagerCallback-20427-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2462926 INFO  (zkConnectionManagerCallback-20429-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2462931 INFO  (jetty-launcher-20388-thread-1) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 2462934 INFO  (jetty-launcher-20388-thread-1) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.ZkController Publish 
node=127.0.0.1:51727_solr as DOWN
   [junit4]   2> 2462936 INFO  (jetty-launcher-20388-thread-1) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 2462936 INFO  (jetty-launcher-20388-thread-1) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:51727_solr
   [junit4]   2> 2462938 INFO  (zkCallback-20420-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 2462938 INFO  (zkCallback-20411-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 2462938 INFO  (zkCallback-20409-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 2462940 INFO  (jetty-launcher-20388-thread-3) 
[n:127.0.0.1:51723_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 2462957 INFO  (zkCallback-20428-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 2462968 INFO  (zkConnectionManagerCallback-20437-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2462970 INFO  (jetty-launcher-20388-thread-4) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 2462971 INFO  (zkConnectionManagerCallback-20442-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2462971 INFO  (jetty-launcher-20388-thread-4) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:51711/solr ready
   [junit4]   2> 2462971 INFO  (jetty-launcher-20388-thread-4) 
[n:127.0.0.1:51731_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 2462971 INFO  (jetty-launcher-20388-thread-1) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 2462971 INFO  (jetty-launcher-20388-thread-1) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:51711/solr ready
   [junit4]   2> 2462971 INFO  (jetty-launcher-20388-thread-1) 
[n:127.0.0.1:51727_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 2463056 INFO  (jetty-launcher-20388-thread-3) 
[n:127.0.0.1:51723_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_51723.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1e25fe4e
   [junit4]   2> 2463057 INFO  (jetty-launcher-20388-thread-4) 
[n:127.0.0.1:51731_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_51731.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1e25fe4e
   [junit4]   2> 2463058 INFO  (jetty-launcher-20388-thread-1) 
[n:127.0.0.1:51727_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_51727.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1e25fe4e
   [junit4]   2> 2463072 INFO  (jetty-launcher-20388-thread-3) 
[n:127.0.0.1:51723_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_51723.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1e25fe4e
   [junit4]   2> 2463072 INFO  (jetty-launcher-20388-thread-3) 
[n:127.0.0.1:51723_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_51723.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1e25fe4e
   [junit4]   2> 2463073 INFO  (jetty-launcher-20388-thread-4) 
[n:127.0.0.1:51731_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_51731.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1e25fe4e
   [junit4]   2> 2463073 INFO  (jetty-launcher-20388-thread-4) 
[n:127.0.0.1:51731_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_51731.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1e25fe4e
   [junit4]   2> 2463074 INFO  (jetty-launcher-20388-thread-1) 
[n:127.0.0.1:51727_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_51727.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1e25fe4e
   [junit4]   2> 2463074 INFO  (jetty-launcher-20388-thread-1) 
[n:127.0.0.1:51727_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_51727.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1e25fe4e
   [junit4]   2> 2463075 INFO  (jetty-launcher-20388-thread-3) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.OverseerRolesTest_DEA3ACF9439D1556-001\tempDir-001\node3\.
   [junit4]   2> 2463075 INFO  (jetty-launcher-20388-thread-4) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.OverseerRolesTest_DEA3ACF9439D1556-001\tempDir-001\node4\.
   [junit4]   2> 2463076 INFO  (jetty-launcher-20388-thread-1) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.OverseerRolesTest_DEA3ACF9439D1556-001\tempDir-001\node1\.
   [junit4]   2> 2463384 INFO  (jetty-launcher-20388-thread-2) [    ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 2463386 WARN  (jetty-launcher-20388-thread-2) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@76eca3db[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2463394 WARN  (jetty-launcher-20388-thread-2) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@74719333[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2463395 INFO  (jetty-launcher-20388-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51711/solr
   [junit4]   2> 2463397 INFO  (zkConnectionManagerCallback-20450-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2463402 INFO  (zkConnectionManagerCallback-20452-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2463407 INFO  (jetty-launcher-20388-thread-2) 
[n:127.0.0.1:51722_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 2463411 INFO  (jetty-launcher-20388-thread-2) 
[n:127.0.0.1:51722_solr    ] o.a.s.c.ZkController Publish 
node=127.0.0.1:51722_solr as DOWN
   [junit4]   2> 2463412 INFO  (jetty-launcher-20388-thread-2) 
[n:127.0.0.1:51722_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 2463412 INFO  (jetty-launcher-20388-thread-2) 
[n:127.0.0.1:51722_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:51722_solr
   [junit4]   2> 2463413 INFO  (zkCallback-20409-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2463414 INFO  (zkCallback-20428-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2463414 INFO  (zkCallback-20420-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2463414 INFO  (zkCallback-20411-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2463414 INFO  (zkCallback-20436-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2463414 INFO  (zkCallback-20451-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2463415 INFO  (zkCallback-20441-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2463474 INFO  (zkConnectionManagerCallback-20459-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2463475 INFO  (jetty-launcher-20388-thread-2) 
[n:127.0.0.1:51722_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (4)
   [junit4]   2> 2463476 INFO  (jetty-launcher-20388-thread-2) 
[n:127.0.0.1:51722_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:51711/solr ready
   [junit4]   2> 2463477 INFO  (jetty-launcher-20388-thread-2) 
[n:127.0.0.1:51722_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 2463516 INFO  (jetty-launcher-20388-thread-2) 
[n:127.0.0.1:51722_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_51722.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1e25fe4e
   [junit4]   2> 2463525 INFO  (jetty-launcher-20388-thread-2) 
[n:127.0.0.1:51722_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_51722.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1e25fe4e
   [junit4]   2> 2463525 INFO  (jetty-launcher-20388-thread-2) 
[n:127.0.0.1:51722_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_51722.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1e25fe4e
   [junit4]   2> 2463527 INFO  (jetty-launcher-20388-thread-2) 
[n:127.0.0.1:51722_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.OverseerRolesTest_DEA3ACF9439D1556-001\tempDir-001\node2\.
   [junit4]   2> 2463581 INFO  (zkConnectionManagerCallback-20465-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2463583 INFO  
(SUITE-OverseerRolesTest-seed#[DEA3ACF9439D1556]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 2463583 INFO  
(SUITE-OverseerRolesTest-seed#[DEA3ACF9439D1556]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:51711/solr ready
   [junit4]   2> 2463641 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testOverseerRole
   [junit4]   2> 2463641 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.c.OverseerRolesTest Overseer: 127.0.0.1:51723_solr
   [junit4]   2> 2463642 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.c.OverseerRolesTest Election queue: 
   [junit4]   2> 2463643 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.c.OverseerRolesTest ### Setting overseer designate 127.0.0.1:51722_solr
   [junit4]   2> 2463644 INFO  (qtp363719561-47760) [n:127.0.0.1:51722_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addrole with params 
node=127.0.0.1:51722_solr&role=overseer&action=ADDROLE&wt=javabin&version=2 and 
sendToOCPQueue=true
   [junit4]   2> 2463651 INFO  
(OverseerThreadFactory-13345-thread-1-processing-n:127.0.0.1:51723_solr) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.a.c.OverseerRoleCmd Overseer role added to 
127.0.0.1:51722_solr
   [junit4]   2> 2463655 INFO  (qtp363719561-47760) [n:127.0.0.1:51722_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={node=127.0.0.1:51722_solr&role=overseer&action=ADDROLE&wt=javabin&version=2}
 status=0 QTime=10
   [junit4]   2> 2463659 INFO  (Thread-6747) [    ] 
o.a.s.c.OverseerNodePrioritizer prioritizing overseer nodes at 
72088886542204938-127.0.0.1:51723_solr-n_0000000000 overseer designates are 
[127.0.0.1:51722_solr]
   [junit4]   2> 2463660 INFO  (Thread-6747) [    ] 
o.a.s.c.OverseerNodePrioritizer sorted nodes 
[72088886542204938-127.0.0.1:51723_solr-n_0000000000, 
72088886542204937-127.0.0.1:51731_solr-n_0000000001, 
72088886542204941-127.0.0.1:51727_solr-n_0000000002, 
72088886542204945-127.0.0.1:51722_solr-n_0000000003]
   [junit4]   2> 2463660 INFO  (Thread-6747) [    ] 
o.a.s.c.OverseerNodePrioritizer asking node 
72088886542204945-127.0.0.1:51722_solr-n_0000000003 to come join election at 
head
   [junit4]   2> 2463662 INFO  (qtp363719561-47777) [n:127.0.0.1:51722_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={op=rejoinAtHead&qt=/admin/cores&action=OVERSEEROP&electionNode=72088886542204945-127.0.0.1:51722_solr-n_0000000003&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2463662 INFO  (Thread-6747) [    ] 
o.a.s.c.OverseerNodePrioritizer asking the old first in line 
72088886542204937-127.0.0.1:51731_solr-n_0000000001 to rejoin election  
   [junit4]   2> 2463664 INFO  (qtp957057230-47770) [n:127.0.0.1:51731_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={op=rejoin&qt=/admin/cores&action=OVERSEEROP&electionNode=72088886542204937-127.0.0.1:51731_solr-n_0000000001&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2463667 INFO  
(OverseerStateUpdate-72088886542204938-127.0.0.1:51723_solr-n_0000000000) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.Overseer Quit command received {
   [junit4]   2>   "operation":"quit",
   [junit4]   2>   "id":"72088886542204938-127.0.0.1:51723_solr-n_0000000000"} 
127.0.0.1:51723_solr
   [junit4]   2> 2463667 INFO  
(OverseerStateUpdate-72088886542204938-127.0.0.1:51723_solr-n_0000000000) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:51723_solr
   [junit4]   2> 2463668 WARN  (OverseerExitThread) [    ] o.a.s.c.Overseer I 
(id=72088886542204938-127.0.0.1:51723_solr-n_0000000000) am exiting, but I'm 
still the leader
   [junit4]   2> 2463670 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204938-127.0.0.1:51723_solr-n_0000000000) closing
   [junit4]   2> 2463672 INFO  
(OverseerAutoScalingTriggerThread-72088886542204938-127.0.0.1:51723_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 2463672 INFO  (zkCallback-20409-thread-1) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:51731_solr
   [junit4]   2> 2463676 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204938-127.0.0.1:51723_solr-n_0000000000) closing
   [junit4]   2> 2463676 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204938-127.0.0.1:51723_solr-n_0000000000) closing
   [junit4]   2> 2463676 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204938-127.0.0.1:51723_solr-n_0000000000) closing
   [junit4]   2> 2463677 INFO  (zkCallback-20409-thread-1) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.Overseer Overseer 
(id=72088886542204937-127.0.0.1:51731_solr-n_0000000001) starting
   [junit4]   2> 2463682 INFO  
(OverseerStateUpdate-72088886542204937-127.0.0.1:51731_solr-n_0000000001) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:51731_solr
   [junit4]   2> 2463687 INFO  
(OverseerCollectionConfigSetProcessor-72088886542204937-127.0.0.1:51731_solr-n_0000000001)
 [n:127.0.0.1:51731_solr    ] o.a.s.c.OverseerNodePrioritizer prioritizing 
overseer nodes at 72088886542204937-127.0.0.1:51731_solr-n_0000000001 overseer 
designates are [127.0.0.1:51722_solr]
   [junit4]   2> 2463687 INFO  
(OverseerCollectionConfigSetProcessor-72088886542204937-127.0.0.1:51731_solr-n_0000000001)
 [n:127.0.0.1:51731_solr    ] o.a.s.c.OverseerNodePrioritizer sorted nodes 
[72088886542204937-127.0.0.1:51731_solr-n_0000000001, 
72088886542204941-127.0.0.1:51727_solr-n_0000000002, 
72088886542204945-127.0.0.1:51722_solr-n_0000000003, 
72088886542204938-127.0.0.1:51723_solr-n_0000000004]
   [junit4]   2> 2463687 INFO  
(OverseerCollectionConfigSetProcessor-72088886542204937-127.0.0.1:51731_solr-n_0000000001)
 [n:127.0.0.1:51731_solr    ] o.a.s.c.OverseerNodePrioritizer asking node 
72088886542204945-127.0.0.1:51722_solr-n_0000000003 to come join election at 
head
   [junit4]   2> 2463690 INFO  (qtp363719561-47779) [n:127.0.0.1:51722_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={op=rejoinAtHead&qt=/admin/cores&action=OVERSEEROP&electionNode=72088886542204945-127.0.0.1:51722_solr-n_0000000003&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2463690 INFO  
(OverseerCollectionConfigSetProcessor-72088886542204937-127.0.0.1:51731_solr-n_0000000001)
 [n:127.0.0.1:51731_solr    ] o.a.s.c.OverseerNodePrioritizer asking the old 
first in line 72088886542204941-127.0.0.1:51727_solr-n_0000000002 to rejoin 
election  
   [junit4]   2> 2463691 INFO  (qtp1631904391-47766) [n:127.0.0.1:51727_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={op=rejoin&qt=/admin/cores&action=OVERSEEROP&electionNode=72088886542204941-127.0.0.1:51727_solr-n_0000000002&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2463693 INFO  
(OverseerStateUpdate-72088886542204937-127.0.0.1:51731_solr-n_0000000001) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.Overseer Quit command received {
   [junit4]   2>   "operation":"quit",
   [junit4]   2>   "id":"72088886542204937-127.0.0.1:51731_solr-n_0000000001"} 
127.0.0.1:51731_solr
   [junit4]   2> 2463693 INFO  
(OverseerStateUpdate-72088886542204937-127.0.0.1:51731_solr-n_0000000001) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:51731_solr
   [junit4]   2> 2463698 WARN  (OverseerExitThread) [    ] o.a.s.c.Overseer I 
(id=72088886542204937-127.0.0.1:51731_solr-n_0000000001) am exiting, but I'm 
still the leader
   [junit4]   2> 2463700 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204937-127.0.0.1:51731_solr-n_0000000001) closing
   [junit4]   2> 2463702 INFO  
(OverseerAutoScalingTriggerThread-72088886542204937-127.0.0.1:51731_solr-n_0000000001)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 2463703 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204937-127.0.0.1:51731_solr-n_0000000001) closing
   [junit4]   2> 2463703 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204937-127.0.0.1:51731_solr-n_0000000001) closing
   [junit4]   2> 2463703 INFO  (zkCallback-20428-thread-1) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:51727_solr
   [junit4]   2> 2463703 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204937-127.0.0.1:51731_solr-n_0000000001) closing
   [junit4]   2> 2463703 INFO  (zkCallback-20428-thread-1) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.Overseer Overseer 
(id=72088886542204941-127.0.0.1:51727_solr-n_0000000002) starting
   [junit4]   2> 2463713 INFO  
(OverseerStateUpdate-72088886542204941-127.0.0.1:51727_solr-n_0000000002) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:51727_solr
   [junit4]   2> 2463716 INFO  
(OverseerCollectionConfigSetProcessor-72088886542204941-127.0.0.1:51727_solr-n_0000000002)
 [n:127.0.0.1:51727_solr    ] o.a.s.c.OverseerNodePrioritizer prioritizing 
overseer nodes at 72088886542204941-127.0.0.1:51727_solr-n_0000000002 overseer 
designates are [127.0.0.1:51722_solr]
   [junit4]   2> 2463716 INFO  
(OverseerCollectionConfigSetProcessor-72088886542204941-127.0.0.1:51727_solr-n_0000000002)
 [n:127.0.0.1:51727_solr    ] o.a.s.c.OverseerNodePrioritizer sorted nodes 
[72088886542204941-127.0.0.1:51727_solr-n_0000000002, 
72088886542204945-127.0.0.1:51722_solr-n_0000000003, 
72088886542204938-127.0.0.1:51723_solr-n_0000000004, 
72088886542204937-127.0.0.1:51731_solr-n_0000000005]
   [junit4]   2> 2463718 INFO  
(OverseerStateUpdate-72088886542204941-127.0.0.1:51727_solr-n_0000000002) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.Overseer Quit command received {
   [junit4]   2>   "operation":"quit",
   [junit4]   2>   "id":"72088886542204941-127.0.0.1:51727_solr-n_0000000002"} 
127.0.0.1:51727_solr
   [junit4]   2> 2463718 INFO  
(OverseerStateUpdate-72088886542204941-127.0.0.1:51727_solr-n_0000000002) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:51727_solr
   [junit4]   2> 2463721 WARN  (OverseerExitThread) [    ] o.a.s.c.Overseer I 
(id=72088886542204941-127.0.0.1:51727_solr-n_0000000002) am exiting, but I'm 
still the leader
   [junit4]   2> 2463722 INFO  (zkCallback-20451-thread-1) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:51722_solr
   [junit4]   2> 2463723 INFO  (zkCallback-20451-thread-1) 
[n:127.0.0.1:51722_solr    ] o.a.s.c.Overseer Overseer 
(id=72088886542204945-127.0.0.1:51722_solr-n_0000000003) starting
   [junit4]   2> 2463726 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204941-127.0.0.1:51727_solr-n_0000000002) closing
   [junit4]   2> 2463726 INFO  
(OverseerAutoScalingTriggerThread-72088886542204941-127.0.0.1:51727_solr-n_0000000002)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 2463731 INFO  
(OverseerStateUpdate-72088886542204945-127.0.0.1:51722_solr-n_0000000003) 
[n:127.0.0.1:51722_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:51722_solr
   [junit4]   2> 2463731 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204941-127.0.0.1:51727_solr-n_0000000002) closing
   [junit4]   2> 2463731 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204941-127.0.0.1:51727_solr-n_0000000002) closing
   [junit4]   2> 2463731 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204941-127.0.0.1:51727_solr-n_0000000002) closing
   [junit4]   2> 2463757 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.c.OverseerRolesTest ### Adding another overseer designate 
127.0.0.1:51727_solr
   [junit4]   2> 2463757 INFO  (qtp363719561-47755) [n:127.0.0.1:51722_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addrole with params 
node=127.0.0.1:51727_solr&role=overseer&action=ADDROLE&wt=javabin&version=2 and 
sendToOCPQueue=true
   [junit4]   2> 2463760 INFO  
(OverseerThreadFactory-13376-thread-1-processing-n:127.0.0.1:51722_solr) 
[n:127.0.0.1:51722_solr    ] o.a.s.c.a.c.OverseerRoleCmd Overseer role added to 
127.0.0.1:51727_solr
   [junit4]   2> 2463761 INFO  (qtp363719561-47755) [n:127.0.0.1:51722_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={node=127.0.0.1:51727_solr&role=overseer&action=ADDROLE&wt=javabin&version=2}
 status=0 QTime=3
   [junit4]   2> 2463761 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.c.OverseerRolesTest Overseer: 127.0.0.1:51722_solr
   [junit4]   2> 2463761 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.c.OverseerRolesTest Election queue: 
   [junit4]   2> 2463761 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1234021683
   [junit4]   2> 2463761 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:51722_solr
   [junit4]   2> 2463765 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.c.CoreContainer Publish this node as DOWN...
   [junit4]   2> 2463765 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.c.ZkController Publish node=127.0.0.1:51722_solr as DOWN
   [junit4]   2> 2463765 INFO  
(OverseerCollectionConfigSetProcessor-72088886542204945-127.0.0.1:51722_solr-n_0000000003)
 [n:127.0.0.1:51722_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000002 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 2463770 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 2463770 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3fda690f: rootName = 
solr_51722, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@69a3a85
   [junit4]   2> 2463771 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 2463771 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@ecd431b: rootName = 
solr_51722, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@3251f0bb
   [junit4]   2> 2463776 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 2463776 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2ddb1d1: rootName = 
solr_51722, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@25480138
   [junit4]   2> 2463776 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 2463784 INFO  (closeThreadPool-20468-thread-2) [    ] 
o.a.s.c.Overseer Overseer 
(id=72088886542204945-127.0.0.1:51722_solr-n_0000000003) closing
   [junit4]   2> 2463789 INFO  
(OverseerAutoScalingTriggerThread-72088886542204945-127.0.0.1:51722_solr-n_0000000003)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 2463790 INFO  
(OverseerStateUpdate-72088886542204945-127.0.0.1:51722_solr-n_0000000003) 
[n:127.0.0.1:51722_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:51722_solr
   [junit4]   2> 2463791 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.c.Overseer Overseer 
(id=72088886542204945-127.0.0.1:51722_solr-n_0000000003) closing
   [junit4]   2> 2463791 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x1001c75da9a0011, likely client has closed socket
   [junit4]   2> 2463791 INFO  (closeThreadPool-20468-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72088886542204945-127.0.0.1:51722_solr-n_0000000003) closing
   [junit4]   2> 2463791 INFO  (zkCallback-20411-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72088886542204938-127.0.0.1:51723_solr-n_0000000000) closing
   [junit4]   2> 2463793 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@2a3611a1{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:0}
   [junit4]   2> 2463797 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@3ab51fe3{/solr,null,UNAVAILABLE}
   [junit4]   2> 2463798 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 2463798 INFO  (zkCallback-20411-thread-1) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:51723_solr
   [junit4]   2> 2463798 INFO  (zkCallback-20409-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 2463800 INFO  (zkCallback-20428-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 2463800 INFO  (zkCallback-20420-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 2463800 INFO  (zkCallback-20436-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 2463800 INFO  (zkCallback-20441-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 2463800 INFO  (zkCallback-20464-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 2463800 INFO  (zkCallback-20411-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 2463801 INFO  (zkCallback-20411-thread-1) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.Overseer Overseer 
(id=72088886542204938-127.0.0.1:51723_solr-n_0000000004) starting
   [junit4]   2> 2463805 INFO  
(OverseerStateUpdate-72088886542204938-127.0.0.1:51723_solr-n_0000000004) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:51723_solr
   [junit4]   2> 2463808 INFO  
(OverseerCollectionConfigSetProcessor-72088886542204938-127.0.0.1:51723_solr-n_0000000004)
 [n:127.0.0.1:51723_solr    ] o.a.s.c.OverseerNodePrioritizer prioritizing 
overseer nodes at 72088886542204938-127.0.0.1:51723_solr-n_0000000004 overseer 
designates are [127.0.0.1:51722_solr, 127.0.0.1:51727_solr]
   [junit4]   2> 2463808 INFO  
(OverseerCollectionConfigSetProcessor-72088886542204938-127.0.0.1:51723_solr-n_0000000004)
 [n:127.0.0.1:51723_solr    ] o.a.s.c.OverseerNodePrioritizer sorted nodes 
[72088886542204938-127.0.0.1:51723_solr-n_0000000004, 
72088886542204937-127.0.0.1:51731_solr-n_0000000005, 
72088886542204941-127.0.0.1:51727_solr-n_0000000006]
   [junit4]   2> 2463808 INFO  
(OverseerCollectionConfigSetProcessor-72088886542204938-127.0.0.1:51723_solr-n_0000000004)
 [n:127.0.0.1:51723_solr    ] o.a.s.c.OverseerNodePrioritizer asking node 
72088886542204941-127.0.0.1:51727_solr-n_0000000006 to come join election at 
head
   [junit4]   2> 2463810 INFO  (qtp1631904391-47771) [n:127.0.0.1:51727_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={op=rejoinAtHead&qt=/admin/cores&action=OVERSEEROP&electionNode=72088886542204941-127.0.0.1:51727_solr-n_0000000006&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2463810 INFO  
(OverseerCollectionConfigSetProcessor-72088886542204938-127.0.0.1:51723_solr-n_0000000004)
 [n:127.0.0.1:51723_solr    ] o.a.s.c.OverseerNodePrioritizer asking the old 
first in line 72088886542204937-127.0.0.1:51731_solr-n_0000000005 to rejoin 
election  
   [junit4]   2> 2463810 INFO  (qtp957057230-47773) [n:127.0.0.1:51731_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={op=rejoin&qt=/admin/cores&action=OVERSEEROP&electionNode=72088886542204937-127.0.0.1:51731_solr-n_0000000005&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2463810 INFO  
(OverseerStateUpdate-72088886542204938-127.0.0.1:51723_solr-n_0000000004) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.Overseer Quit command received {
   [junit4]   2>   "operation":"quit",
   [junit4]   2>   "id":"72088886542204938-127.0.0.1:51723_solr-n_0000000004"} 
127.0.0.1:51723_solr
   [junit4]   2> 2463810 INFO  
(OverseerStateUpdate-72088886542204938-127.0.0.1:51723_solr-n_0000000004) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:51723_solr
   [junit4]   2> 2463821 WARN  (OverseerExitThread) [    ] o.a.s.c.Overseer I 
(id=72088886542204938-127.0.0.1:51723_solr-n_0000000004) am exiting, but I'm 
still the leader
   [junit4]   2> 2463821 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204938-127.0.0.1:51723_solr-n_0000000004) closing
   [junit4]   2> 2463826 INFO  
(OverseerAutoScalingTriggerThread-72088886542204938-127.0.0.1:51723_solr-n_0000000004)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 2463826 INFO  (zkCallback-20409-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72088886542204937-127.0.0.1:51731_solr-n_0000000001) closing
   [junit4]   2> 2463828 INFO  (zkCallback-20409-thread-1) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:51731_solr
   [junit4]   2> 2463830 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204938-127.0.0.1:51723_solr-n_0000000004) closing
   [junit4]   2> 2463830 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204938-127.0.0.1:51723_solr-n_0000000004) closing
   [junit4]   2> 2463831 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204938-127.0.0.1:51723_solr-n_0000000004) closing
   [junit4]   2> 2463831 INFO  (zkCallback-20409-thread-1) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.Overseer Overseer 
(id=72088886542204937-127.0.0.1:51731_solr-n_0000000005) starting
   [junit4]   2> 2463849 INFO  
(OverseerStateUpdate-72088886542204937-127.0.0.1:51731_solr-n_0000000005) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:51731_solr
   [junit4]   2> 2463850 INFO  
(OverseerCollectionConfigSetProcessor-72088886542204937-127.0.0.1:51731_solr-n_0000000005)
 [n:127.0.0.1:51731_solr    ] o.a.s.c.OverseerNodePrioritizer prioritizing 
overseer nodes at 72088886542204937-127.0.0.1:51731_solr-n_0000000005 overseer 
designates are [127.0.0.1:51722_solr, 127.0.0.1:51727_solr]
   [junit4]   2> 2463850 INFO  
(OverseerCollectionConfigSetProcessor-72088886542204937-127.0.0.1:51731_solr-n_0000000005)
 [n:127.0.0.1:51731_solr    ] o.a.s.c.OverseerNodePrioritizer sorted nodes 
[72088886542204937-127.0.0.1:51731_solr-n_0000000005, 
72088886542204941-127.0.0.1:51727_solr-n_0000000006, 
72088886542204938-127.0.0.1:51723_solr-n_0000000007]
   [junit4]   2> 2463860 INFO  
(OverseerStateUpdate-72088886542204937-127.0.0.1:51731_solr-n_0000000005) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.Overseer Quit command received {
   [junit4]   2>   "operation":"quit",
   [junit4]   2>   "id":"72088886542204937-127.0.0.1:51731_solr-n_0000000005"} 
127.0.0.1:51731_solr
   [junit4]   2> 2463861 INFO  
(OverseerStateUpdate-72088886542204937-127.0.0.1:51731_solr-n_0000000005) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:51731_solr
   [junit4]   2> 2463861 WARN  (OverseerExitThread) [    ] o.a.s.c.Overseer I 
(id=72088886542204937-127.0.0.1:51731_solr-n_0000000005) am exiting, but I'm 
still the leader
   [junit4]   2> 2463867 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204937-127.0.0.1:51731_solr-n_0000000005) closing
   [junit4]   2> 2463884 INFO  
(OverseerAutoScalingTriggerThread-72088886542204937-127.0.0.1:51731_solr-n_0000000005)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 2463885 INFO  (zkCallback-20428-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72088886542204941-127.0.0.1:51727_solr-n_0000000002) closing
   [junit4]   2> 2463886 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204937-127.0.0.1:51731_solr-n_0000000005) closing
   [junit4]   2> 2463886 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204937-127.0.0.1:51731_solr-n_0000000005) closing
   [junit4]   2> 2463887 INFO  (zkCallback-20428-thread-1) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:51727_solr
   [junit4]   2> 2463887 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204937-127.0.0.1:51731_solr-n_0000000005) closing
   [junit4]   2> 2463888 INFO  (zkCallback-20428-thread-1) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.Overseer Overseer 
(id=72088886542204941-127.0.0.1:51727_solr-n_0000000006) starting
   [junit4]   2> 2463901 INFO  
(OverseerStateUpdate-72088886542204941-127.0.0.1:51727_solr-n_0000000006) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:51727_solr
   [junit4]   2> 2463911 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.c.OverseerRolesTest ### Adding last overseer designate 
127.0.0.1:51731_solr
   [junit4]   2> 2463913 INFO  (qtp993688690-47759) [n:127.0.0.1:51723_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addrole with params 
node=127.0.0.1:51731_solr&role=overseer&action=ADDROLE&wt=javabin&version=2 and 
sendToOCPQueue=true
   [junit4]   2> 2463932 INFO  
(OverseerThreadFactory-13389-thread-1-processing-n:127.0.0.1:51727_solr) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.a.c.OverseerRoleCmd Overseer role added to 
127.0.0.1:51731_solr
   [junit4]   2> 2463935 INFO  (qtp993688690-47759) [n:127.0.0.1:51723_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={node=127.0.0.1:51731_solr&role=overseer&action=ADDROLE&wt=javabin&version=2}
 status=0 QTime=21
   [junit4]   2> 2463935 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.c.OverseerRolesTest Overseer: 127.0.0.1:51727_solr
   [junit4]   2> 2463936 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.c.OverseerRolesTest Election queue: 
   [junit4]   2> 2463941 INFO  (qtp993688690-47764) [n:127.0.0.1:51723_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :removerole with 
params 
node=127.0.0.1:51727_solr&role=overseer&action=REMOVEROLE&wt=javabin&version=2 
and sendToOCPQueue=true
   [junit4]   2> 2463942 INFO  
(OverseerCollectionConfigSetProcessor-72088886542204941-127.0.0.1:51727_solr-n_0000000006)
 [n:127.0.0.1:51727_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000004 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 2463976 INFO  
(OverseerThreadFactory-13389-thread-2-processing-n:127.0.0.1:51727_solr) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.a.c.OverseerRoleCmd Overseer role removed 
from 127.0.0.1:51727_solr
   [junit4]   2> 2463982 INFO  (qtp993688690-47764) [n:127.0.0.1:51723_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={node=127.0.0.1:51727_solr&role=overseer&action=REMOVEROLE&wt=javabin&version=2}
 status=0 QTime=41
   [junit4]   2> 2464010 INFO  (Thread-6751) [    ] 
o.a.s.c.OverseerNodePrioritizer prioritizing overseer nodes at 
72088886542204941-127.0.0.1:51727_solr-n_0000000006 overseer designates are 
[127.0.0.1:51722_solr, 127.0.0.1:51731_solr]
   [junit4]   2> 2464011 INFO  (Thread-6751) [    ] 
o.a.s.c.OverseerNodePrioritizer sorted nodes 
[72088886542204941-127.0.0.1:51727_solr-n_0000000006, 
72088886542204938-127.0.0.1:51723_solr-n_0000000007, 
72088886542204937-127.0.0.1:51731_solr-n_0000000008]
   [junit4]   2> 2464011 INFO  (Thread-6751) [    ] 
o.a.s.c.OverseerNodePrioritizer asking node 
72088886542204937-127.0.0.1:51731_solr-n_0000000008 to come join election at 
head
   [junit4]   2> 2464024 INFO  (qtp957057230-47774) [n:127.0.0.1:51731_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={op=rejoinAtHead&qt=/admin/cores&action=OVERSEEROP&electionNode=72088886542204937-127.0.0.1:51731_solr-n_0000000008&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2464024 INFO  (Thread-6751) [    ] 
o.a.s.c.OverseerNodePrioritizer asking the old first in line 
72088886542204938-127.0.0.1:51723_solr-n_0000000007 to rejoin election  
   [junit4]   2> 2464029 INFO  (qtp993688690-47768) [n:127.0.0.1:51723_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={op=rejoin&qt=/admin/cores&action=OVERSEEROP&electionNode=72088886542204938-127.0.0.1:51723_solr-n_0000000007&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2464031 INFO  
(OverseerStateUpdate-72088886542204941-127.0.0.1:51727_solr-n_0000000006) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.Overseer Quit command received {
   [junit4]   2>   "operation":"quit",
   [junit4]   2>   "id":"72088886542204941-127.0.0.1:51727_solr-n_0000000006"} 
127.0.0.1:51727_solr
   [junit4]   2> 2464031 INFO  
(OverseerStateUpdate-72088886542204941-127.0.0.1:51727_solr-n_0000000006) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:51727_solr
   [junit4]   2> 2464051 WARN  (OverseerExitThread) [    ] o.a.s.c.Overseer I 
(id=72088886542204941-127.0.0.1:51727_solr-n_0000000006) am exiting, but I'm 
still the leader
   [junit4]   2> 2464052 INFO  (zkCallback-20411-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72088886542204938-127.0.0.1:51723_solr-n_0000000004) closing
   [junit4]   2> 2464052 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204941-127.0.0.1:51727_solr-n_0000000006) closing
   [junit4]   2> 2464052 INFO  (zkCallback-20411-thread-1) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:51723_solr
   [junit4]   2> 2464052 INFO  
(OverseerAutoScalingTriggerThread-72088886542204941-127.0.0.1:51727_solr-n_0000000006)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 2464056 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204941-127.0.0.1:51727_solr-n_0000000006) closing
   [junit4]   2> 2464056 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204941-127.0.0.1:51727_solr-n_0000000006) closing
   [junit4]   2> 2464057 INFO  (zkCallback-20411-thread-1) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.Overseer Overseer 
(id=72088886542204938-127.0.0.1:51723_solr-n_0000000007) starting
   [junit4]   2> 2464058 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204941-127.0.0.1:51727_solr-n_0000000006) closing
   [junit4]   2> 2464065 INFO  
(OverseerStateUpdate-72088886542204938-127.0.0.1:51723_solr-n_0000000007) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:51723_solr
   [junit4]   2> 2464068 INFO  
(OverseerCollectionConfigSetProcessor-72088886542204938-127.0.0.1:51723_solr-n_0000000007)
 [n:127.0.0.1:51723_solr    ] o.a.s.c.OverseerNodePrioritizer prioritizing 
overseer nodes at 72088886542204938-127.0.0.1:51723_solr-n_0000000007 overseer 
designates are [127.0.0.1:51722_solr, 127.0.0.1:51731_solr]
   [junit4]   2> 2464068 INFO  
(OverseerCollectionConfigSetProcessor-72088886542204938-127.0.0.1:51723_solr-n_0000000007)
 [n:127.0.0.1:51723_solr    ] o.a.s.c.OverseerNodePrioritizer sorted nodes 
[72088886542204938-127.0.0.1:51723_solr-n_0000000007, 
72088886542204937-127.0.0.1:51731_solr-n_0000000008, 
72088886542204941-127.0.0.1:51727_solr-n_0000000009]
   [junit4]   2> 2464071 INFO  
(OverseerStateUpdate-72088886542204938-127.0.0.1:51723_solr-n_0000000007) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.Overseer Quit command received {
   [junit4]   2>   "operation":"quit",
   [junit4]   2>   "id":"72088886542204938-127.0.0.1:51723_solr-n_0000000007"} 
127.0.0.1:51723_solr
   [junit4]   2> 2464071 INFO  
(OverseerStateUpdate-72088886542204938-127.0.0.1:51723_solr-n_0000000007) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:51723_solr
   [junit4]   2> 2464077 WARN  (OverseerExitThread) [    ] o.a.s.c.Overseer I 
(id=72088886542204938-127.0.0.1:51723_solr-n_0000000007) am exiting, but I'm 
still the leader
   [junit4]   2> 2464079 INFO  (zkCallback-20409-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72088886542204937-127.0.0.1:51731_solr-n_0000000005) closing
   [junit4]   2> 2464079 INFO  (zkCallback-20409-thread-1) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:51731_solr
   [junit4]   2> 2464080 INFO  (zkCallback-20409-thread-1) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.Overseer Overseer 
(id=72088886542204937-127.0.0.1:51731_solr-n_0000000008) starting
   [junit4]   2> 2464081 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204938-127.0.0.1:51723_solr-n_0000000007) closing
   [junit4]   2> 2464084 INFO  (qtp993688690-47769) [n:127.0.0.1:51723_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addrole with params 
node=127.0.0.1:51727_solr&role=overseer&action=ADDROLE&wt=javabin&version=2 and 
sendToOCPQueue=true
   [junit4]   2> 2464087 INFO  
(OverseerAutoScalingTriggerThread-72088886542204938-127.0.0.1:51723_solr-n_0000000007)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 2464098 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204938-127.0.0.1:51723_solr-n_0000000007) closing
   [junit4]   2> 2464098 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204938-127.0.0.1:51723_solr-n_0000000007) closing
   [junit4]   2> 2464100 INFO  
(OverseerStateUpdate-72088886542204937-127.0.0.1:51731_solr-n_0000000008) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:51731_solr
   [junit4]   2> 2464106 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204938-127.0.0.1:51723_solr-n_0000000007) closing
   [junit4]   2> 2464137 INFO  
(OverseerThreadFactory-13397-thread-1-processing-n:127.0.0.1:51731_solr) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.a.c.OverseerRoleCmd Overseer role added to 
127.0.0.1:51727_solr
   [junit4]   2> 2464139 INFO  (qtp993688690-47769) [n:127.0.0.1:51723_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={node=127.0.0.1:51727_solr&role=overseer&action=ADDROLE&wt=javabin&version=2}
 status=0 QTime=55
   [junit4]   2> 2464140 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.c.OverseerRolesTest ### Sending QUIT to overseer 127.0.0.1:51731_solr
   [junit4]   2> 2464143 INFO  
(OverseerStateUpdate-72088886542204937-127.0.0.1:51731_solr-n_0000000008) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.Overseer Quit command received {
   [junit4]   2>   "operation":"quit",
   [junit4]   2>   "id":"72088886542204937-127.0.0.1:51731_solr-n_0000000008"} 
127.0.0.1:51731_solr
   [junit4]   2> 2464143 INFO  
(OverseerStateUpdate-72088886542204937-127.0.0.1:51731_solr-n_0000000008) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:51731_solr
   [junit4]   2> 2464148 WARN  (OverseerExitThread) [    ] o.a.s.c.Overseer I 
(id=72088886542204937-127.0.0.1:51731_solr-n_0000000008) am exiting, but I'm 
still the leader
   [junit4]   2> 2464150 INFO  (Thread-6752) [    ] 
o.a.s.c.OverseerNodePrioritizer prioritizing overseer nodes at 
72088886542204937-127.0.0.1:51731_solr-n_0000000008 overseer designates are 
[127.0.0.1:51722_solr, 127.0.0.1:51731_solr, 127.0.0.1:51727_solr]
   [junit4]   2> 2464150 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204937-127.0.0.1:51731_solr-n_0000000008) closing
   [junit4]   2> 2464153 INFO  (Thread-6752) [    ] 
o.a.s.c.OverseerNodePrioritizer sorted nodes 
[72088886542204941-127.0.0.1:51727_solr-n_0000000009, 
72088886542204938-127.0.0.1:51723_solr-n_0000000010]
   [junit4]   2> 2464153 INFO  (Thread-6752) [    ] 
o.a.s.c.OverseerNodePrioritizer asking node 
72088886542204941-127.0.0.1:51727_solr-n_0000000009 to come join election at 
head
   [junit4]   2> 2464153 INFO  (zkCallback-20428-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72088886542204941-127.0.0.1:51727_solr-n_0000000006) closing
   [junit4]   2> 2464154 INFO  
(OverseerAutoScalingTriggerThread-72088886542204937-127.0.0.1:51731_solr-n_0000000008)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 2464155 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204937-127.0.0.1:51731_solr-n_0000000008) closing
   [junit4]   2> 2464155 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204937-127.0.0.1:51731_solr-n_0000000008) closing
   [junit4]   2> 2464156 INFO  (qtp1631904391-47784) [n:127.0.0.1:51727_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={op=rejoinAtHead&qt=/admin/cores&action=OVERSEEROP&electionNode=72088886542204941-127.0.0.1:51727_solr-n_0000000009&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2464156 INFO  (Thread-6752) [    ] 
o.a.s.c.OverseerNodePrioritizer asking the old first in line 
72088886542204938-127.0.0.1:51723_solr-n_0000000010 to rejoin election  
   [junit4]   2> 2464157 INFO  (zkCallback-20428-thread-1) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:51727_solr
   [junit4]   2> 2464158 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204937-127.0.0.1:51731_solr-n_0000000008) closing
   [junit4]   2> 2464158 INFO  (qtp993688690-47759) [n:127.0.0.1:51723_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={op=rejoin&qt=/admin/cores&action=OVERSEEROP&electionNode=72088886542204938-127.0.0.1:51723_solr-n_0000000010&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2464158 INFO  (zkCallback-20428-thread-1) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.Overseer Overseer 
(id=72088886542204941-127.0.0.1:51727_solr-n_0000000009) starting
   [junit4]   2> 2464163 INFO  
(OverseerStateUpdate-72088886542204941-127.0.0.1:51727_solr-n_0000000009) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:51727_solr
   [junit4]   2> 2464165 INFO  
(OverseerStateUpdate-72088886542204941-127.0.0.1:51727_solr-n_0000000009) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.Overseer Quit command received {
   [junit4]   2>   "operation":"quit",
   [junit4]   2>   "id":"72088886542204941-127.0.0.1:51727_solr-n_0000000009"} 
127.0.0.1:51727_solr
   [junit4]   2> 2464165 INFO  
(OverseerStateUpdate-72088886542204941-127.0.0.1:51727_solr-n_0000000009) 
[n:127.0.0.1:51727_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:51727_solr
   [junit4]   2> 2464168 WARN  (OverseerExitThread) [    ] o.a.s.c.Overseer I 
(id=72088886542204941-127.0.0.1:51727_solr-n_0000000009) am exiting, but I'm 
still the leader
   [junit4]   2> 2464168 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204941-127.0.0.1:51727_solr-n_0000000009) closing
   [junit4]   2> 2464170 INFO  (zkCallback-20411-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72088886542204938-127.0.0.1:51723_solr-n_0000000007) closing
   [junit4]   2> 2464171 INFO  (zkCallback-20411-thread-1) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:51723_solr
   [junit4]   2> 2464173 WARN  
(OverseerAutoScalingTriggerThread-72088886542204941-127.0.0.1:51727_solr-n_0000000009)
 [    ] o.a.s.c.a.OverseerTriggerThread Error removing old markers
   [junit4]   2>           => org.apache.solr.common.AlreadyClosedException
   [junit4]   2>        at 
org.apache.solr.client.solrj.impl.ZkDistribStateManager.listData(ZkDistribStateManager.java:74)
   [junit4]   2> org.apache.solr.common.AlreadyClosedException: null
   [junit4]   2>        at 
org.apache.solr.client.solrj.impl.ZkDistribStateManager.listData(ZkDistribStateManager.java:74)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.client.solrj.impl.ZkDistribStateManager.listData(ZkDistribStateManager.java:80)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.client.solrj.cloud.DistribStateManager.listTree(DistribStateManager.java:104)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.client.solrj.cloud.DistribStateManager.removeRecursively(DistribStateManager.java:123)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.removeMarkers(OverseerTriggerThread.java:269)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:261)
 ~[java/:?]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_172]
   [junit4]   2> 2464173 WARN  
(OverseerAutoScalingTriggerThread-72088886542204941-127.0.0.1:51727_solr-n_0000000009)
 [    ] o.a.s.c.a.OverseerTriggerThread Error removing old markers
   [junit4]   2>           => org.apache.solr.common.AlreadyClosedException
   [junit4]   2>        at 
org.apache.solr.client.solrj.impl.ZkDistribStateManager.listData(ZkDistribStateManager.java:74)
   [junit4]   2> org.apache.solr.common.AlreadyClosedException: null
   [junit4]   2>        at 
org.apache.solr.client.solrj.impl.ZkDistribStateManager.listData(ZkDistribStateManager.java:74)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.client.solrj.impl.ZkDistribStateManager.listData(ZkDistribStateManager.java:80)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.client.solrj.cloud.DistribStateManager.listTree(DistribStateManager.java:104)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.client.solrj.cloud.DistribStateManager.removeRecursively(DistribStateManager.java:123)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.removeMarkers(OverseerTriggerThread.java:269)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:262)
 ~[java/:?]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_172]
   [junit4]   2> 2464173 INFO  (zkCallback-20411-thread-1) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.Overseer Overseer 
(id=72088886542204938-127.0.0.1:51723_solr-n_0000000010) starting
   [junit4]   2> 2464174 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204941-127.0.0.1:51727_solr-n_0000000009) closing
   [junit4]   2> 2464174 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204941-127.0.0.1:51727_solr-n_0000000009) closing
   [junit4]   2> 2464178 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204941-127.0.0.1:51727_solr-n_0000000009) closing
   [junit4]   2> 2464182 INFO  
(OverseerStateUpdate-72088886542204938-127.0.0.1:51723_solr-n_0000000010) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:51723_solr
   [junit4]   2> 2464185 INFO  
(OverseerCollectionConfigSetProcessor-72088886542204938-127.0.0.1:51723_solr-n_0000000010)
 [n:127.0.0.1:51723_solr    ] o.a.s.c.OverseerNodePrioritizer prioritizing 
overseer nodes at 72088886542204938-127.0.0.1:51723_solr-n_0000000010 overseer 
designates are [127.0.0.1:51722_solr, 127.0.0.1:51731_solr, 
127.0.0.1:51727_solr]
   [junit4]   2> 2464186 INFO  
(OverseerCollectionConfigSetProcessor-72088886542204938-127.0.0.1:51723_solr-n_0000000010)
 [n:127.0.0.1:51723_solr    ] o.a.s.c.OverseerNodePrioritizer sorted nodes 
[72088886542204938-127.0.0.1:51723_solr-n_0000000010, 
72088886542204937-127.0.0.1:51731_solr-n_0000000011, 
72088886542204941-127.0.0.1:51727_solr-n_0000000012]
   [junit4]   2> 2464186 INFO  
(OverseerStateUpdate-72088886542204938-127.0.0.1:51723_solr-n_0000000010) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.Overseer Quit command received {
   [junit4]   2>   "operation":"quit",
   [junit4]   2>   "id":"72088886542204938-127.0.0.1:51723_solr-n_0000000010"} 
127.0.0.1:51723_solr
   [junit4]   2> 2464186 INFO  
(OverseerStateUpdate-72088886542204938-127.0.0.1:51723_solr-n_0000000010) 
[n:127.0.0.1:51723_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:51723_solr
   [junit4]   2> 2464189 WARN  (OverseerExitThread) [    ] o.a.s.c.Overseer I 
(id=72088886542204938-127.0.0.1:51723_solr-n_0000000010) am exiting, but I'm 
still the leader
   [junit4]   2> 2464212 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204938-127.0.0.1:51723_solr-n_0000000010) closing
   [junit4]   2> 2464213 INFO  
(OverseerAutoScalingTriggerThread-72088886542204938-127.0.0.1:51723_solr-n_0000000010)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 2464213 INFO  (zkCallback-20409-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72088886542204937-127.0.0.1:51731_solr-n_0000000008) closing
   [junit4]   2> 2464215 INFO  (zkCallback-20409-thread-1) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:51731_solr
   [junit4]   2> 2464216 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204938-127.0.0.1:51723_solr-n_0000000010) closing
   [junit4]   2> 2464216 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204938-127.0.0.1:51723_solr-n_0000000010) closing
   [junit4]   2> 2464217 INFO  (OverseerExitThread) [    ] o.a.s.c.Overseer 
Overseer (id=72088886542204938-127.0.0.1:51723_solr-n_0000000010) closing
   [junit4]   2> 2464217 INFO  (zkCallback-20409-thread-1) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.Overseer Overseer 
(id=72088886542204937-127.0.0.1:51731_solr-n_0000000011) starting
   [junit4]   2> 2464221 INFO  
(OverseerStateUpdate-72088886542204937-127.0.0.1:51731_solr-n_0000000011) 
[n:127.0.0.1:51731_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:51731_solr
   [junit4]   2> 2479172 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[DEA3ACF9439D1556]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testOverseerRole
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=OverseerRolesTest 
-Dtests.method=testOverseerRole -Dtests.seed=DEA3ACF9439D1556 -Dtests.slow=true 
-Dtests.locale=pl -Dtests.timezone=Antarctica/Troll -Dtests.asserts=true 
-Dtests.file.encoding=Cp1252
   [junit4] FAILURE 15.6s J1 | OverseerRolesTest.testOverseerRole <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Timed out waiting for 
overseer state change
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([DEA3ACF9439D1556:3F68516D782E2387]:0)
   [junit4]    >        at 
org.apache.solr.cloud.OverseerRolesTest.waitForNewOverseer(OverseerRolesTest.java:63)
   [junit4]    >        at 
org.apache.solr.cloud.OverseerRolesTest.testOverseerRole(OverseerRolesTest.java:145)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 2479176 INFO  (jetty-closer-20469-thread-1) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1470798343
   [junit4]   2> 2479176 INFO  (jetty-closer-20469-thread-2) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=892920084
   [junit4]   2> 2479176 INFO  (jetty-closer-20469-thread-2) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:51727_solr
   [junit4]   2> 2479176 INFO  (jetty-closer-20469-thread-3) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1320006741
   [junit4]   2> 2479176 INFO  (jetty-closer-20469-thread-3) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:51723_solr
   [junit4]   2> 2479176 INFO  (jetty-closer-20469-thread-1) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:51731_solr
   [junit4]   2> 2479176 INFO  (jetty-closer-20469-thread-2) [    ] 
o.a.s.c.CoreContainer Publish this node as DOWN...
   [junit4]   2> 2479176 INFO  (jetty-closer-20469-thread-2) [    ] 
o.a.s.c.ZkController Publish node=127.0.0.1:51727_solr as DOWN
   [junit4]   2> 2479176 INFO  (jetty-closer-20469-thread-3) [    ] 
o.a.s.c.CoreContainer Publish this node as DOWN...
   [junit4]   2> 2479176 INFO  (jetty-closer-20469-thread-3) [    ] 
o.a.s.c.ZkController Publish node=127.0.0.1:51723_solr as DOWN
   [junit4]   2> 2479177 INFO  (jetty-closer-20469-thread-1) [    ] 
o.a.s.c.CoreContainer Publish this node as DOWN...
   [junit4]   2> 2479177 INFO  (jetty-closer-20469-thread-1) [    ] 
o.a.s.c.ZkController Publish node=127.0.0.1:51731_solr as DOWN
   [junit4]   2> 2479178 INFO  (jetty-closer-20469-thread-3) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 2479180 INFO  (jetty-closer-20469-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 2479180 INFO  (jetty-closer-20469-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 2479180 INFO  (jetty-closer-20469-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@663339d7: rootName = 
solr_51727, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@26a05216
   [junit4]   2> 2479180 INFO  (jetty-closer-20469-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@438a2a5d: rootName = 
solr_51731, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@34e0e499
   [junit4]   2> 2479180 INFO  (jetty-closer-20469-thread-3) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 2479180 INFO  (jetty-closer-20469-thread-3) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1344cbbf: rootName = 
solr_51723, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@38608278
   [junit4]   2> 2479199 INFO  (jetty-closer-20469-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 2479199 INFO  (jetty-closer-20469-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@63350256: rootName = 
solr_51727, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@3251f0bb
   [junit4]   2> 2479199 INFO  (jetty-closer-20469-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 2479199 INFO  (jetty-closer-20469-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3d384050: rootName = 
solr_51731, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@3251f0bb
   [junit4]   2> 2479201 INFO  (jetty-closer-20469-thread-3) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 2479201 INFO  (jetty-closer-20469-thread-3) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@bc06358: rootName = 
solr_51723, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@3251f0bb
   [junit4]   2> 2479213 INFO  (jetty-closer-20469-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 2479213 INFO  (jetty-closer-20469-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@630e9af8: rootName = 
solr_51727, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@25480138
   [junit4]   2> 2479213 INFO  (jetty-closer-20469-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 2479213 INFO  (jetty-closer-20469-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 2479213 INFO  (jetty-closer-20469-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2bd5bfb0: rootName = 
solr_51731, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@25480138
   [junit4]   2> 2479213 INFO  (jetty-closer-20469-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 2479213 INFO  (jetty-closer-20469-thread-3) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 2479213 INFO  (jetty-closer-20469-thread-3) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@60166ecf: rootName = 
solr_51723, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@25480138
   [junit4]   2> 2479213 INFO  (jetty-closer-20469-thread-3) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 2479215 INFO  (jetty-closer-20469-thread-2) [    ] 
o.a.s.c.Overseer Overseer 
(id=72088886542204941-127.0.0.1:51727_solr-n_0000000009) closing
   [junit4]   2> 2479215 INFO  (zkCallback-20420-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
   [junit4]   2> 2479215 INFO  (zkCallback-20436-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
   [junit4]   2> 2479215 INFO  (zkCallback-20441-thread-1) [    ] 
o.a.s.c.c.ZkStateRe

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

UL
Total time: 2 minutes 23 seconds
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.OverseerRolesTest" -Dtests.showOutput=onerror 
"-Dargs=-XX:-UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=DEA3ACF9439D1556 
-Dtests.slow=true -Dtests.locale=pl -Dtests.timezone=Antarctica/Troll 
-Dtests.asserts=true -Dtests.file.encoding=Cp1252
Buildfile: 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\build.xml

-clover.disable:

ivy-configure:
[ivy:configure] :: Apache Ivy 2.4.0 - 20141213170938 :: 
http://ant.apache.org/ivy/ ::
[ivy:configure] :: loading settings :: file = 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\lucene\top-level-ivy-settings.xml

install-junit4-taskdef:

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

-ivy-fail-disallowed-ivy-version:

ivy-fail:

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

-init-totals:

-test:
    [mkdir] Created dir: 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test
[junit4:pickseed] Seed property 'tests.seed' already defined: DEA3ACF9439D1556
    [mkdir] Created dir: 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\temp
   [junit4] <JUnit4> says ?????! Master seed: DEA3ACF9439D1556
   [junit4] Your default console's encoding may not display certain unicode 
glyphs: windows-1252
   [junit4] Executing 5 suites with 2 JVMs.
   [junit4] 
   [junit4] Started J1 PID(6124@serv1-vm1).
   [junit4] Started J0 PID(14060@serv1-vm1).
   [junit4] Suite: org.apache.solr.cloud.OverseerRolesTest
   [junit4] OK      3.84s J1 | OverseerRolesTest.testOverseerRole
   [junit4] Completed [1/5] on J1 in 34.74s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.cloud.OverseerRolesTest
   [junit4] OK      3.96s J0 | OverseerRolesTest.testOverseerRole
   [junit4] Completed [2/5] on J0 in 34.64s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.cloud.OverseerRolesTest
   [junit4] OK      2.43s J0 | OverseerRolesTest.testOverseerRole
   [junit4] Completed [3/5] on J0 in 7.56s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.cloud.OverseerRolesTest
   [junit4] OK      2.00s J1 | OverseerRolesTest.testOverseerRole
   [junit4] Completed [4/5] on J1 in 7.32s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.cloud.OverseerRolesTest
   [junit4] OK      1.56s J0 | OverseerRolesTest.testOverseerRole
   [junit4] Completed [5/5] on J0 in 4.43s, 1 test
   [junit4] 
   [junit4] JVM J0:     1.35 ..    50.51 =    49.16s
   [junit4] JVM J1:     1.33 ..    46.83 =    45.50s
   [junit4] Execution time total: 50 seconds
   [junit4] Tests summary: 5 suites, 5 tests
   [junit4] Could not remove temporary path: 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1 
(java.nio.file.DirectoryNotEmptyException: Remaining files: 
[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp])
   [junit4] Could not remove temporary path: 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0 
(java.nio.file.DirectoryNotEmptyException: Remaining files: 
[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp])
     [echo] 5 slowest tests:
[junit4:tophints] 263.16s | org.apache.solr.cloud.api.collections.ShardSplitTest
[junit4:tophints] 124.19s | org.apache.solr.search.facet.TestJsonFacets
[junit4:tophints] 119.04s | org.apache.solr.handler.TestReplicationHandler
[junit4:tophints] 112.99s | org.apache.solr.cloud.ReplicationFactorTest
[junit4:tophints] 105.43s | org.apache.solr.cloud.HttpPartitionTest

-check-totals:

test-nocompile:

BUILD SUCCESSFUL
Total time: 54 seconds
[repro] Failures:
[repro]   0/5 failed: org.apache.solr.cloud.OverseerRolesTest
[repro] Exiting with code 0

C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows>IF EXIST lucene\build move 
/y lucene\build lucene\build.repro 
        1 dir(s) moved.

C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows>IF EXIST solr\build move /y 
solr\build solr\build.repro 
        1 dir(s) moved.

C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows>IF EXIST lucene\build.orig 
move /y lucene\build.orig lucene\build 
        1 dir(s) moved.

C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows>IF EXIST solr\build.orig 
move /y solr\build.orig solr\build 
        1 dir(s) moved.

C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows>exit 0 
Archiving artifacts
Setting 
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
java.lang.InterruptedException: no matches found within 10000
        at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2800)
        at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2679)
        at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2660)
        at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3039)
Also:   hudson.remoting.Channel$CallSiteStackTrace: Remote call to Windows VBOX
                at 
hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1743)
                at 
hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:357)
                at hudson.remoting.Channel.call(Channel.java:957)
                at hudson.FilePath.act(FilePath.java:1067)
                at hudson.FilePath.act(FilePath.java:1056)
                at hudson.FilePath.validateAntFileMask(FilePath.java:2658)
                at 
hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
                at 
hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
                at 
hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
                at 
hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
                at 
hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
                at hudson.model.Build$BuildExecution.post2(Build.java:186)
                at 
hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
                at hudson.model.Run.execute(Run.java:1841)
                at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
                at 
hudson.model.ResourceController.execute(ResourceController.java:97)
                at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
        at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3041)
        at hudson.remoting.UserRequest.perform(UserRequest.java:212)
        at hudson.remoting.UserRequest.perform(UserRequest.java:54)
        at hudson.remoting.Request$2.run(Request.java:369)
        at 
hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
        at java.util.concurrent.FutureTask.run(Unknown Source)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
        at java.lang.Thread.run(Unknown Source)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no 
matches found within 10000
        at hudson.FilePath.act(FilePath.java:1069)
        at hudson.FilePath.act(FilePath.java:1056)
        at hudson.FilePath.validateAntFileMask(FilePath.java:2658)
        at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
        at 
hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
        at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
        at 
hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
        at 
hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
        at hudson.model.Build$BuildExecution.post2(Build.java:186)
        at 
hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
        at hudson.model.Run.execute(Run.java:1841)
        at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
        at hudson.model.ResourceController.execute(ResourceController.java:97)
        at hudson.model.Executor.run(Executor.java:429)
No artifacts found that match the file pattern 
"**/*.events,heapdumps/**,**/*_pid*.log". Configuration error?
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting 
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
No credentials specified
Setting 
ANT_1_8_2_HOME=C:\Users\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=677a97edc7ba07a35f644792c98fa5ebf5667bb5, 
workspace=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows
[WARNINGS] Computing warning deltas based on reference build #61
Recording test results
Setting 
ANT_1_8_2_HOME=C:\Users\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=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting 
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting 
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting 
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting 
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting 
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to