Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/2861/

3 tests failed.
FAILED:  
org.apache.solr.cloud.api.collections.CollectionsAPIDistributedZkTest.testCoresAreDistributedAcrossNodes

Error Message:
[127.0.0.1:38121_solr] expected:<0> but was:<1>

Stack Trace:
java.lang.AssertionError: [127.0.0.1:38121_solr] expected:<0> but was:<1>
        at 
__randomizedtesting.SeedInfo.seed([104795730302867C:7407401FB8CC0E6D]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:472)
        at 
org.apache.solr.cloud.api.collections.CollectionsAPIDistributedZkTest.testCoresAreDistributedAcrossNodes(CollectionsAPIDistributedZkTest.java:352)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:944)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  
org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest.testSplitIntegration

Error Message:
did not finish processing in time

Stack Trace:
java.lang.AssertionError: did not finish processing in time
        at 
__randomizedtesting.SeedInfo.seed([104795730302867C:29C92C332CFD4F82]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest.testSplitIntegration(IndexSizeTriggerTest.java:316)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:944)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  
org.apache.solr.client.solrj.impl.CloudSolrClientTest.testNonRetryableRequests

Error Message:
expected:<1> but was:<2>

Stack Trace:
java.lang.AssertionError: expected:<1> but was:<2>
        at 
__randomizedtesting.SeedInfo.seed([8A835F3B05C5DA1D:226D98A8FB8CAE11]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:472)
        at org.junit.Assert.assertEquals(Assert.java:456)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClientTest.testNonRetryableRequests(CloudSolrClientTest.java:550)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985)
        at 
org.junit.rules.ExpectedException$ExpectedExceptionStatement.evaluate(ExpectedException.java:110)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:944)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 12878 lines...]
   [junit4] Suite: 
org.apache.solr.cloud.api.collections.CollectionsAPIDistributedZkTest
   [junit4]   2> 1064501 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[104795730302867C]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.api.collections.CollectionsAPIDistributedZkTest_104795730302867C-001/init-core-data-001
   [junit4]   2> 1064502 WARN  
(SUITE-CollectionsAPIDistributedZkTest-seed#[104795730302867C]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 1064502 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[104795730302867C]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1064544 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[104795730302867C]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 1064546 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[104795730302867C]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.api.collections.CollectionsAPIDistributedZkTest_104795730302867C-001/tempDir-001
   [junit4]   2> 1064546 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[104795730302867C]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1064546 INFO  (Thread-881) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1064546 INFO  (Thread-881) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1064654 ERROR (Thread-881) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 1064661 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[104795730302867C]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:43795
   [junit4]   2> 1064787 INFO  (zkConnectionManagerCallback-4944-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1064798 INFO  (jetty-launcher-4941-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: 
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
   [junit4]   2> 1064814 INFO  (jetty-launcher-4941-thread-2) [    ] 
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: 
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
   [junit4]   2> 1064850 INFO  (jetty-launcher-4941-thread-4) [    ] 
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: 
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
   [junit4]   2> 1064850 INFO  (jetty-launcher-4941-thread-3) [    ] 
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: 
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
   [junit4]   2> 1065169 INFO  (jetty-launcher-4941-thread-3) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1065169 INFO  (jetty-launcher-4941-thread-3) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1065169 INFO  (jetty-launcher-4941-thread-3) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1065170 INFO  (jetty-launcher-4941-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@44babd63{/solr,null,AVAILABLE}
   [junit4]   2> 1065170 INFO  (jetty-launcher-4941-thread-3) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@1a1091af{SSL,[ssl, 
http/1.1]}{127.0.0.1:44279}
   [junit4]   2> 1065170 INFO  (jetty-launcher-4941-thread-3) [    ] 
o.e.j.s.Server Started @1065232ms
   [junit4]   2> 1065170 INFO  (jetty-launcher-4941-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=44279}
   [junit4]   2> 1065170 ERROR (jetty-launcher-4941-thread-3) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1065171 INFO  (jetty-launcher-4941-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1065171 INFO  (jetty-launcher-4941-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1065171 INFO  (jetty-launcher-4941-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1065171 INFO  (jetty-launcher-4941-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1065171 INFO  (jetty-launcher-4941-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-10-09T16:28:08.600Z
   [junit4]   2> 1065226 INFO  (jetty-launcher-4941-thread-4) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1065226 INFO  (jetty-launcher-4941-thread-4) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1065226 INFO  (jetty-launcher-4941-thread-4) [    ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1065226 INFO  (jetty-launcher-4941-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@4a56af06{/solr,null,AVAILABLE}
   [junit4]   2> 1065227 INFO  (jetty-launcher-4941-thread-4) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@52f6de12{SSL,[ssl, 
http/1.1]}{127.0.0.1:42696}
   [junit4]   2> 1065227 INFO  (jetty-launcher-4941-thread-4) [    ] 
o.e.j.s.Server Started @1065289ms
   [junit4]   2> 1065227 INFO  (jetty-launcher-4941-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=42696}
   [junit4]   2> 1065227 ERROR (jetty-launcher-4941-thread-4) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1065227 INFO  (jetty-launcher-4941-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1065227 INFO  (jetty-launcher-4941-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1065227 INFO  (jetty-launcher-4941-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1065227 INFO  (jetty-launcher-4941-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1065227 INFO  (jetty-launcher-4941-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-10-09T16:28:08.656Z
   [junit4]   2> 1065246 INFO  (jetty-launcher-4941-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1065246 INFO  (jetty-launcher-4941-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1065246 INFO  (jetty-launcher-4941-thread-2) [    ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1065247 INFO  (jetty-launcher-4941-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3448ca7c{/solr,null,AVAILABLE}
   [junit4]   2> 1065247 INFO  (jetty-launcher-4941-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@65f3078d{SSL,[ssl, 
http/1.1]}{127.0.0.1:38121}
   [junit4]   2> 1065247 INFO  (jetty-launcher-4941-thread-2) [    ] 
o.e.j.s.Server Started @1065309ms
   [junit4]   2> 1065247 INFO  (jetty-launcher-4941-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=38121}
   [junit4]   2> 1065247 ERROR (jetty-launcher-4941-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1065247 INFO  (jetty-launcher-4941-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1065248 INFO  (jetty-launcher-4941-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1065248 INFO  (jetty-launcher-4941-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1065248 INFO  (jetty-launcher-4941-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1065248 INFO  (jetty-launcher-4941-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-10-09T16:28:08.677Z
   [junit4]   2> 1065249 INFO  (zkConnectionManagerCallback-4950-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1065263 INFO  (jetty-launcher-4941-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1065266 INFO  (jetty-launcher-4941-thread-2) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1065266 INFO  (jetty-launcher-4941-thread-2) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1065352 INFO  (jetty-launcher-4941-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1065352 INFO  (jetty-launcher-4941-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1065352 INFO  (jetty-launcher-4941-thread-1) [    ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1065353 INFO  (jetty-launcher-4941-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5a918aa4{/solr,null,AVAILABLE}
   [junit4]   2> 1065417 INFO  (zkConnectionManagerCallback-4948-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1065418 INFO  (jetty-launcher-4941-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1065421 INFO  (jetty-launcher-4941-thread-4) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1065421 INFO  (jetty-launcher-4941-thread-4) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1065437 INFO  (jetty-launcher-4941-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@1ef42093{SSL,[ssl, 
http/1.1]}{127.0.0.1:37507}
   [junit4]   2> 1065437 INFO  (jetty-launcher-4941-thread-1) [    ] 
o.e.j.s.Server Started @1065499ms
   [junit4]   2> 1065437 INFO  (jetty-launcher-4941-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=37507}
   [junit4]   2> 1065438 ERROR (jetty-launcher-4941-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1065438 INFO  (jetty-launcher-4941-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1065457 INFO  (jetty-launcher-4941-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1065458 INFO  (jetty-launcher-4941-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1065458 INFO  (jetty-launcher-4941-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1065458 INFO  (jetty-launcher-4941-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-10-09T16:28:08.887Z
   [junit4]   2> 1065458 INFO  (zkConnectionManagerCallback-4946-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1065458 INFO  (jetty-launcher-4941-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1065461 INFO  (jetty-launcher-4941-thread-3) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1065461 INFO  (jetty-launcher-4941-thread-3) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1065531 INFO  (zkConnectionManagerCallback-4952-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1065533 INFO  (jetty-launcher-4941-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1065588 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 
0x104fdeabe220001, likely client has closed socket
   [junit4]   2> 1065643 INFO  (jetty-launcher-4941-thread-1) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1065643 INFO  (jetty-launcher-4941-thread-1) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1066806 INFO  (jetty-launcher-4941-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43795/solr
   [junit4]   2> 1066829 INFO  (zkConnectionManagerCallback-4956-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1066858 INFO  (zkConnectionManagerCallback-4958-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1067212 INFO  (jetty-launcher-4941-thread-1) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:37507_solr
   [junit4]   2> 1067213 INFO  (jetty-launcher-4941-thread-1) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.Overseer Overseer 
(id=73462678598844422-127.0.0.1:37507_solr-n_0000000000) starting
   [junit4]   2> 1067270 INFO  (zkConnectionManagerCallback-4965-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1067285 INFO  (jetty-launcher-4941-thread-1) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:43795/solr ready
   [junit4]   2> 1067317 INFO  (jetty-launcher-4941-thread-1) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:37507_solr
   [junit4]   2> 1067317 INFO  
(OverseerStateUpdate-73462678598844422-127.0.0.1:37507_solr-n_0000000000) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:37507_solr
   [junit4]   2> 1067369 DEBUG 
(OverseerAutoScalingTriggerThread-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 1067645 DEBUG 
(OverseerAutoScalingTriggerThread-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 1
   [junit4]   2> 1067646 DEBUG 
(OverseerAutoScalingTriggerThread-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, 
lastZnodeVersion -1
   [junit4]   2> 1067646 DEBUG 
(OverseerAutoScalingTriggerThread-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto 
znodeVersion 1
   [junit4]   2> 1067666 INFO  (zkCallback-4964-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1067734 INFO  
(OverseerStateUpdate-73462678598844422-127.0.0.1:37507_solr-n_0000000000) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1067826 INFO  (jetty-launcher-4941-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43795/solr
   [junit4]   2> 1067859 DEBUG 
(OverseerAutoScalingTriggerThread-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [    ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial 
livenodes: [127.0.0.1:37507_solr]
   [junit4]   2> 1067860 DEBUG 
(OverseerAutoScalingTriggerThread-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1067860 DEBUG 
(OverseerAutoScalingTriggerThread-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, 
lastZnodeVersion 1
   [junit4]   2> 1067873 INFO  (zkConnectionManagerCallback-4969-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1067894 DEBUG (ScheduledTrigger-2404-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1067971 INFO  (jetty-launcher-4941-thread-1) 
[n:127.0.0.1:37507_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1068103 INFO  (jetty-launcher-4941-thread-1) 
[n:127.0.0.1:37507_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f062ab4
   [junit4]   2> 1068129 INFO  (zkConnectionManagerCallback-4972-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1068211 INFO  (jetty-launcher-4941-thread-1) 
[n:127.0.0.1:37507_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f062ab4
   [junit4]   2> 1068211 INFO  (jetty-launcher-4941-thread-1) 
[n:127.0.0.1:37507_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f062ab4
   [junit4]   2> 1068212 INFO  (jetty-launcher-4941-thread-1) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.api.collections.CollectionsAPIDistributedZkTest_104795730302867C-001/tempDir-001/node1
   [junit4]   2> 1068241 INFO  (jetty-launcher-4941-thread-3) 
[n:127.0.0.1:44279_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1068261 INFO  (jetty-launcher-4941-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43795/solr
   [junit4]   2> 1068276 INFO  (zkConnectionManagerCallback-4978-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1068283 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 
0x104fdeabe22000a, likely client has closed socket
   [junit4]   2> 1068284 INFO  (jetty-launcher-4941-thread-3) 
[n:127.0.0.1:44279_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1068284 INFO  (jetty-launcher-4941-thread-3) 
[n:127.0.0.1:44279_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:44279_solr
   [junit4]   2> 1068324 INFO  (zkCallback-4957-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1068364 INFO  (zkCallback-4964-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1068364 INFO  (zkConnectionManagerCallback-4980-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1068710 INFO  (zkCallback-4971-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1068775 INFO  (zkConnectionManagerCallback-4985-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1068831 INFO  (jetty-launcher-4941-thread-3) 
[n:127.0.0.1:44279_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 1068904 INFO  (jetty-launcher-4941-thread-3) 
[n:127.0.0.1:44279_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:43795/solr ready
   [junit4]   2> 1068905 INFO  (jetty-launcher-4941-thread-3) 
[n:127.0.0.1:44279_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1068911 INFO  (jetty-launcher-4941-thread-2) 
[n:127.0.0.1:38121_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 1068984 DEBUG (ScheduledTrigger-2404-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1069036 INFO  (jetty-launcher-4941-thread-2) 
[n:127.0.0.1:38121_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1069036 INFO  (jetty-launcher-4941-thread-2) 
[n:127.0.0.1:38121_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:38121_solr
   [junit4]   2> 1069050 INFO  (zkCallback-4971-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1069051 INFO  (zkCallback-4957-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1069058 INFO  (zkCallback-4964-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1069125 INFO  (jetty-launcher-4941-thread-3) 
[n:127.0.0.1:44279_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f062ab4
   [junit4]   2> 1069204 INFO  (zkCallback-4979-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1069213 INFO  (zkCallback-4984-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1069220 INFO  (jetty-launcher-4941-thread-3) 
[n:127.0.0.1:44279_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f062ab4
   [junit4]   2> 1069220 INFO  (jetty-launcher-4941-thread-3) 
[n:127.0.0.1:44279_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f062ab4
   [junit4]   2> 1069236 INFO  (jetty-launcher-4941-thread-3) 
[n:127.0.0.1:44279_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.api.collections.CollectionsAPIDistributedZkTest_104795730302867C-001/tempDir-001/node3
   [junit4]   2> 1069306 INFO  (zkConnectionManagerCallback-4993-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1069347 INFO  (jetty-launcher-4941-thread-2) 
[n:127.0.0.1:38121_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 1069348 INFO  (jetty-launcher-4941-thread-2) 
[n:127.0.0.1:38121_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:43795/solr ready
   [junit4]   2> 1069367 INFO  (jetty-launcher-4941-thread-2) 
[n:127.0.0.1:38121_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1069516 INFO  (jetty-launcher-4941-thread-2) 
[n:127.0.0.1:38121_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f062ab4
   [junit4]   2> 1069567 INFO  (jetty-launcher-4941-thread-2) 
[n:127.0.0.1:38121_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f062ab4
   [junit4]   2> 1069567 INFO  (jetty-launcher-4941-thread-2) 
[n:127.0.0.1:38121_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f062ab4
   [junit4]   2> 1069568 INFO  (jetty-launcher-4941-thread-2) 
[n:127.0.0.1:38121_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.api.collections.CollectionsAPIDistributedZkTest_104795730302867C-001/tempDir-001/node2
   [junit4]   2> 1070069 DEBUG (ScheduledTrigger-2404-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 3
   [junit4]   2> 1070288 INFO  (jetty-launcher-4941-thread-4) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43795/solr
   [junit4]   2> 1070291 INFO  (zkConnectionManagerCallback-4998-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1070325 INFO  (zkConnectionManagerCallback-5000-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1070370 INFO  (jetty-launcher-4941-thread-4) 
[n:127.0.0.1:42696_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 1070390 INFO  (jetty-launcher-4941-thread-4) 
[n:127.0.0.1:42696_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1070390 INFO  (jetty-launcher-4941-thread-4) 
[n:127.0.0.1:42696_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:42696_solr
   [junit4]   2> 1070406 INFO  (zkCallback-4971-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1070414 INFO  (zkCallback-4964-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1070427 INFO  (zkCallback-4957-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1070488 INFO  (zkCallback-4999-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1070488 INFO  (zkCallback-4992-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1070544 INFO  (zkCallback-4979-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1070545 INFO  (zkCallback-4984-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1070550 INFO  (zkConnectionManagerCallback-5007-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1070551 INFO  (jetty-launcher-4941-thread-4) 
[n:127.0.0.1:42696_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (4)
   [junit4]   2> 1070552 INFO  (jetty-launcher-4941-thread-4) 
[n:127.0.0.1:42696_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:43795/solr ready
   [junit4]   2> 1070597 INFO  (jetty-launcher-4941-thread-4) 
[n:127.0.0.1:42696_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1070670 INFO  (jetty-launcher-4941-thread-4) 
[n:127.0.0.1:42696_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f062ab4
   [junit4]   2> 1070707 INFO  (jetty-launcher-4941-thread-4) 
[n:127.0.0.1:42696_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f062ab4
   [junit4]   2> 1070707 INFO  (jetty-launcher-4941-thread-4) 
[n:127.0.0.1:42696_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f062ab4
   [junit4]   2> 1070708 INFO  (jetty-launcher-4941-thread-4) 
[n:127.0.0.1:42696_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.api.collections.CollectionsAPIDistributedZkTest_104795730302867C-001/tempDir-001/node4
   [junit4]   2> 1070983 INFO  (zkConnectionManagerCallback-5010-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1071060 INFO  (zkConnectionManagerCallback-5015-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1071060 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[104795730302867C]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 1071061 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[104795730302867C]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:43795/solr ready
   [junit4]   2> 1071092 DEBUG (ScheduledTrigger-2404-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 4
   [junit4]   2> 1071315 INFO  
(TEST-CollectionsAPIDistributedZkTest.testCreateNodeSet-seed#[104795730302867C])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testCreateNodeSet
   [junit4]   2> 1071344 INFO  
(TEST-CollectionsAPIDistributedZkTest.testCreateNodeSet-seed#[104795730302867C])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 1071584 INFO  (qtp1227543936-11040) [n:127.0.0.1:42696_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
collection.configName=conf&name=nodeset_collection&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=https://127.0.0.1:38121/solr,https://127.0.0.1:42696/solr&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1071673 INFO  
(OverseerThreadFactory-2406-thread-1-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
nodeset_collection
   [junit4]   2> 1071783 WARN  
(OverseerThreadFactory-2406-thread-1-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.a.c.CreateCollectionCmd It is unusual to 
create a collection (nodeset_collection) without cores.
   [junit4]   2> 1071785 INFO  (qtp1227543936-11040) [n:127.0.0.1:42696_solr    
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 1071786 INFO  (qtp1227543936-11040) [n:127.0.0.1:42696_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={collection.configName=conf&name=nodeset_collection&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=https://127.0.0.1:38121/solr,https://127.0.0.1:42696/solr&wt=javabin&version=2}
 status=0 QTime=201
   [junit4]   2> 1071820 INFO  
(TEST-CollectionsAPIDistributedZkTest.testCreateNodeSet-seed#[104795730302867C])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testCreateNodeSet
   [junit4]   2> 1072000 INFO  
(TEST-CollectionsAPIDistributedZkTest.addReplicaTest-seed#[104795730302867C]) [ 
   ] o.a.s.SolrTestCaseJ4 ###Starting addReplicaTest
   [junit4]   2> 1072018 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: data: /solr/clusterprops.json
   [junit4]   2> 1072018 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/live_nodes
   [junit4]   2> 1072018 INFO  
(TEST-CollectionsAPIDistributedZkTest.addReplicaTest-seed#[104795730302867C]) [ 
   ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 1072018 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: data: /solr/clusterstate.json
   [junit4]   2> 1072019 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1072019 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: create/delete: /solr/aliases.json
   [junit4]   2> 1072019 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: data: /solr/aliases.json
   [junit4]   2> 1072019 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: data: /solr/aliases.json
   [junit4]   2> 1072019 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: data: /solr/aliases.json
   [junit4]   2> 1072020 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: data: /solr/aliases.json
   [junit4]   2> 1072020 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: data: /solr/aliases.json
   [junit4]   2> 1072020 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: data: /solr/aliases.json
   [junit4]   2> 1072020 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: data: /solr/aliases.json
   [junit4]   2> 1072020 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: data: /solr/aliases.json
   [junit4]   2> 1072020 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: data: /solr/aliases.json
   [junit4]   2> 1072020 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: data: /solr/aliases.json
   [junit4]   2> 1072020 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: data: /solr/aliases.json
   [junit4]   2> 1072020 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: data: /solr/aliases.json
   [junit4]   2> 1072020 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: data: /solr/aliases.json
   [junit4]   2> 1072020 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: data: /solr/aliases.json
   [junit4]   2> 1072020 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: data: /solr/aliases.json
   [junit4]   2> 1072020 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: data: /solr/aliases.json
   [junit4]   2> 1072021 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: data: /solr/aliases.json
   [junit4]   2> 1072021 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: data: /solr/aliases.json
   [junit4]   2> 1072038 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: data: /solr/aliases.json
   [junit4]   2> 1072039 INFO  (qtp1227543936-11045) [n:127.0.0.1:42696_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params 
name=nodeset_collection&action=DELETE&wt=javabin&version=2 and 
sendToOCPQueue=true
   [junit4]   2> 1072040 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/collection-queue-work
   [junit4]   2> 1072040 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/collection-queue-work
   [junit4]   2> 1072040 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: create/delete: /solr/overseer/collection-queue-work/qnr-0000000002
   [junit4]   2> 1072040 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.ZkDistributedQueue Found child node with 
improper name: qnr-0000000002
   [junit4]   2> 1072041 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/collection-queue-work
   [junit4]   2> 1072041 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/collection-queue-work
   [junit4]   2> 1072041 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.ZkDistributedQueue Found child node with 
improper name: qnr-0000000002
   [junit4]   2> 1072041 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskQueue Returning topN 
elements: [/overseer/collection-queue-work/qn-0000000002, ]
   [junit4]   2> 1072041 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor Got 1 tasks from 
work-queue : [[org.apache.solr.cloud.OverseerTaskQueue$QueueEvent@2e684ed1]]
   [junit4]   2> 1072041 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor Marked task 
[/overseer/collection-queue-work/qn-0000000002] as running
   [junit4]   2> 1072041 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor Overseer Collection 
Message Handler: Get the message 
id:/overseer/collection-queue-work/qn-0000000002 message:{
   [junit4]   2>   "name":"nodeset_collection",
   [junit4]   2>   "operation":"delete"}
   [junit4]   2> 1072054 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: data: /solr/aliases.json
   [junit4]   2> 1072090 DEBUG 
(OverseerThreadFactory-2406-thread-2-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor Runner processing 
/overseer/collection-queue-work/qn-0000000002
   [junit4]   2> 1072090 DEBUG 
(OverseerThreadFactory-2406-thread-2-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.a.c.OverseerCollectionMessageHandler 
OverseerCollectionMessageHandler.processMessage : delete , {
   [junit4]   2>   "name":"nodeset_collection",
   [junit4]   2>   "operation":"delete"}
   [junit4]   2> 1072106 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor Cleaning up 
work-queue. #Running tasks: 1
   [junit4]   2> 1072114 INFO  
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1072114 INFO  
(OverseerThreadFactory-2406-thread-2-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.a.c.OverseerCollectionMessageHandler 
Executing Collection 
Cmd=action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true&deleteMetricsHistory=true,
 asyncId=null
   [junit4]   2> 1072114 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor RunningTasks: 
[/overseer/collection-queue-work/qn-0000000002]
   [junit4]   2> 1072114 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor BlockedTasks: []
   [junit4]   2> 1072114 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor CompletedTasks: []
   [junit4]   2> 1072114 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor RunningZKTasks: 
[/overseer/collection-queue-work/qn-0000000002]
   [junit4]   2> 1072115 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskQueue Peeking for top 99 
elements. ExcludeSet: [/overseer/collection-queue-work/qn-0000000002],[]
   [junit4]   2> 1072128 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/queue
   [junit4]   2> 1072128 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/queue
   [junit4]   2> 1072196 DEBUG (ScheduledTrigger-2404-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 4
   [junit4]   2> 1072230 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/queue
   [junit4]   2> 1072230 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/queue
   [junit4]   2> 1072928 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/collections
   [junit4]   2> 1072928 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/collections
   [junit4]   2> 1072928 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/collections
   [junit4]   2> 1072928 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/collections
   [junit4]   2> 1072928 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/collections
   [junit4]   2> 1072928 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/collections
   [junit4]   2> 1072928 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/collections
   [junit4]   2> 1072928 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/collections
   [junit4]   2> 1072928 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/collections
   [junit4]   2> 1072929 DEBUG 
(OverseerThreadFactory-2406-thread-2-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor Completed 
task:[/overseer/collection-queue-work/qn-0000000002]
   [junit4]   2> 1072929 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1072929 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1072929 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1072929 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: data: /solr/overseer/collection-queue-work/qnr-0000000002
   [junit4]   2> 1072930 DEBUG (zkCallback-4999-thread-1) [    ] 
o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path 
/overseer/collection-queue-work/qnr-0000000002 state SyncConnected 
latchEventType null
   [junit4]   2> 1072930 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/collection-queue-work
   [junit4]   2> 1072930 DEBUG 
(OverseerThreadFactory-2406-thread-2-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor Marked task 
[/overseer/collection-queue-work/qn-0000000002] as completed.
   [junit4]   2> 1072930 DEBUG 
(OverseerThreadFactory-2406-thread-2-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor RunningTasks: []
   [junit4]   2> 1072930 DEBUG 
(OverseerThreadFactory-2406-thread-2-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor BlockedTasks: []
   [junit4]   2> 1072930 DEBUG 
(OverseerThreadFactory-2406-thread-2-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor CompletedTasks: 
[/overseer/collection-queue-work/qn-0000000002]
   [junit4]   2> 1072930 DEBUG 
(OverseerThreadFactory-2406-thread-2-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor RunningZKTasks: 
[/overseer/collection-queue-work/qn-0000000002]
   [junit4]   2> 1072930 DEBUG 
(OverseerThreadFactory-2406-thread-2-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor Overseer Collection 
Message Handler: Message id:/overseer/collection-queue-work/qn-0000000002 
complete, response:{}
   [junit4]   2> 1072930 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/collection-queue-work
   [junit4]   2> 1072930 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.ZkDistributedQueue Found child node with 
improper name: qnr-0000000002
   [junit4]   2> 1072948 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1072948 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1072948 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1072948 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1072948 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1072948 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1072948 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1072948 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1072964 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/collection-queue-work
   [junit4]   2> 1072964 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/collection-queue-work
   [junit4]   2> 1072968 INFO  (qtp1227543936-11045) [n:127.0.0.1:42696_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={name=nodeset_collection&action=DELETE&wt=javabin&version=2} status=0 
QTime=929
   [junit4]   2> 1072970 INFO  (qtp1227543936-11043) [n:127.0.0.1:42696_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
collection.configName=conf&maxShardsPerNode=4&name=addReplicaColl&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1072992 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/collection-queue-work
   [junit4]   2> 1072993 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: create/delete: /solr/overseer/collection-queue-work/qnr-0000000004
   [junit4]   2> 1072993 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/collection-queue-work
   [junit4]   2> 1072993 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/collection-queue-work
   [junit4]   2> 1073006 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.ZkDistributedQueue Found child node with 
improper name: qnr-0000000004
   [junit4]   2> 1073006 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/collection-queue-work
   [junit4]   2> 1073006 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.ZkDistributedQueue Found child node with 
improper name: qnr-0000000004
   [junit4]   2> 1073006 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskQueue Returning topN 
elements: [/overseer/collection-queue-work/qn-0000000004, ]
   [junit4]   2> 1073006 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor Got 1 tasks from 
work-queue : [[org.apache.solr.cloud.OverseerTaskQueue$QueueEvent@2e684ed3]]
   [junit4]   2> 1073006 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor Marked task 
[/overseer/collection-queue-work/qn-0000000004] as running
   [junit4]   2> 1073006 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor Overseer Collection 
Message Handler: Get the message 
id:/overseer/collection-queue-work/qn-0000000004 message:{
   [junit4]   2>   "name":"addReplicaColl",
   [junit4]   2>   "fromApi":"true",
   [junit4]   2>   "collection.configName":"conf",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "maxShardsPerNode":"4",
   [junit4]   2>   "nrtReplicas":"2",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "operation":"create"}
   [junit4]   2> 1073007 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor Cleaning up 
work-queue. #Running tasks: 1
   [junit4]   2> 1073007 INFO  
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_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> 1073007 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor RunningTasks: 
[/overseer/collection-queue-work/qn-0000000004]
   [junit4]   2> 1073007 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor BlockedTasks: []
   [junit4]   2> 1073007 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor CompletedTasks: []
   [junit4]   2> 1073007 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor RunningZKTasks: 
[/overseer/collection-queue-work/qn-0000000004]
   [junit4]   2> 1073007 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskQueue Peeking for top 99 
elements. ExcludeSet: [/overseer/collection-queue-work/qn-0000000004],[]
   [junit4]   2> 1073007 DEBUG 
(OverseerThreadFactory-2406-thread-3-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor Runner processing 
/overseer/collection-queue-work/qn-0000000004
   [junit4]   2> 1073008 DEBUG 
(OverseerThreadFactory-2406-thread-3-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.a.c.OverseerCollectionMessageHandler 
OverseerCollectionMessageHandler.processMessage : create , {
   [junit4]   2>   "name":"addReplicaColl",
   [junit4]   2>   "fromApi":"true",
   [junit4]   2>   "collection.configName":"conf",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "maxShardsPerNode":"4",
   [junit4]   2>   "nrtReplicas":"2",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "operation":"create"}
   [junit4]   2> 1073008 INFO  
(OverseerThreadFactory-2406-thread-3-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
addReplicaColl
   [junit4]   2> 1073011 DEBUG 
(OverseerThreadFactory-2406-thread-3-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.a.c.OverseerCollectionMessageHandler 
creating collections conf node /collections/addReplicaColl 
   [junit4]   2> 1073012 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/collections
   [junit4]   2> 1073012 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/collections
   [junit4]   2> 1073012 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/collections
   [junit4]   2> 1073012 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/collections
   [junit4]   2> 1073012 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/collections
   [junit4]   2> 1073012 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/collections
   [junit4]   2> 1073012 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/collections
   [junit4]   2> 1073012 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/collections
   [junit4]   2> 1073012 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/collections
   [junit4]   2> 1073012 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1073012 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1073029 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1073029 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1073029 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1073029 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1073029 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1073030 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1073030 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1073030 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1073030 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/collections
   [junit4]   2> 1073030 DEBUG 
(OverseerThreadFactory-2406-thread-3-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.a.c.CreateCollectionCmd Check for 
collection zkNode:addReplicaColl
   [junit4]   2> 1073052 DEBUG 
(OverseerThreadFactory-2406-thread-3-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.a.c.CreateCollectionCmd Collection zkNode 
exists
   [junit4]   2> 1073053 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/queue
   [junit4]   2> 1073053 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/queue
   [junit4]   2> 1073172 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/queue
   [junit4]   2> 1073172 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/queue
   [junit4]   2> 1073197 DEBUG (ScheduledTrigger-2404-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 4
   [junit4]   2> 1073254 DEBUG 
(OverseerThreadFactory-2406-thread-3-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.a.c.Assign shardnames [shard1, shard2] NRT 
2 TLOG 0 PULL 0 , policy null, nodeList [127.0.0.1:42696_solr, 
127.0.0.1:37507_solr, 127.0.0.1:44279_solr, 127.0.0.1:38121_solr]
   [junit4]   2> 1073260 INFO  (qtp1227543936-11046) [n:127.0.0.1:42696_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1073450 INFO  (qtp1007603861-11025) [n:127.0.0.1:38121_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1073578 INFO  (qtp220436642-11029) [n:127.0.0.1:44279_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1073705 INFO  (qtp57504572-11057) [n:127.0.0.1:37507_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1073720 DEBUG 
(OverseerThreadFactory-2406-thread-3-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.a.c.CreateCollectionCmd Creating SolrCores 
for new collection addReplicaColl, shardNames [shard1, shard2] , message : {
   [junit4]   2>   "name":"addReplicaColl",
   [junit4]   2>   "fromApi":"true",
   [junit4]   2>   "collection.configName":"conf",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "maxShardsPerNode":"4",
   [junit4]   2>   "nrtReplicas":"2",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "operation":"create"}
   [junit4]   2> 1073721 DEBUG 
(OverseerThreadFactory-2406-thread-3-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.a.c.CreateCollectionCmd Creating core 
addReplicaColl_shard1_replica_n1 as part of shard shard1 of collection 
addReplicaColl on 127.0.0.1:37507_solr
   [junit4]   2> 1073722 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/queue
   [junit4]   2> 1073722 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/queue
   [junit4]   2> 1073722 INFO  
(OverseerStateUpdate-73462678598844422-127.0.0.1:37507_solr-n_0000000000) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"addReplicaColl",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"addReplicaColl_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:37507/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1073740 DEBUG 
(OverseerThreadFactory-2406-thread-3-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.a.c.CreateCollectionCmd Creating core 
addReplicaColl_shard1_replica_n3 as part of shard shard1 of collection 
addReplicaColl on 127.0.0.1:44279_solr
   [junit4]   2> 1073741 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/queue
   [junit4]   2> 1073741 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/queue
   [junit4]   2> 1073741 INFO  
(OverseerStateUpdate-73462678598844422-127.0.0.1:37507_solr-n_0000000000) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"addReplicaColl",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"addReplicaColl_shard1_replica_n3",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:44279/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1073743 DEBUG 
(OverseerThreadFactory-2406-thread-3-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.a.c.CreateCollectionCmd Creating core 
addReplicaColl_shard2_replica_n5 as part of shard shard2 of collection 
addReplicaColl on 127.0.0.1:38121_solr
   [junit4]   2> 1073756 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/queue
   [junit4]   2> 1073756 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/queue
   [junit4]   2> 1073757 DEBUG 
(OverseerThreadFactory-2406-thread-3-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.a.c.CreateCollectionCmd Creating core 
addReplicaColl_shard2_replica_n6 as part of shard shard2 of collection 
addReplicaColl on 127.0.0.1:42696_solr
   [junit4]   2> 1073758 INFO  
(OverseerStateUpdate-73462678598844422-127.0.0.1:37507_solr-n_0000000000) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"addReplicaColl",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"addReplicaColl_shard2_replica_n5",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:38121/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1073758 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/queue
   [junit4]   2> 1073759 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/queue
   [junit4]   2> 1073759 DEBUG 
(OverseerThreadFactory-2406-thread-3-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.a.c.OverseerCollectionMessageHandler 
Expecting [addReplicaColl_shard1_replica_n1, addReplicaColl_shard1_replica_n3, 
addReplicaColl_shard2_replica_n5, addReplicaColl_shard2_replica_n6] cores but 
found {}
   [junit4]   2> 1073759 INFO  
(OverseerStateUpdate-73462678598844422-127.0.0.1:37507_solr-n_0000000000) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"addReplicaColl",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"addReplicaColl_shard2_replica_n6",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:42696/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1073866 DEBUG 
(OverseerThreadFactory-2406-thread-3-processing-n:127.0.0.1:37507_solr) 
[n:127.0.0.1:37507_solr    ] o.a.s.c.a.c.OverseerCollectionMessageHandler 
Expecting [addReplicaColl_shard1_replica_n1, addReplicaColl_shard1_replica_n3, 
addReplicaColl_shard2_replica_n5, addReplicaColl_shard2_replica_n6] cores but 
found {}
   [junit4]   2> 1073888 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/queue
   [junit4]   2> 1073888 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/queue
   [junit4]   2> 1074159 INFO  (qtp57504572-11057) [n:127.0.0.1:37507_solr    
x:addReplicaColl_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create 
command 
qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=addReplicaColl_shard1_replica_n1&action=CREATE&numShards=2&collection=addReplicaColl&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1074160 INFO  (qtp57504572-11057) [n:127.0.0.1:37507_solr    
x:addReplicaColl_shard1_replica_n1] o.a.s.c.TransientSolrCoreCacheDefault 
Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 1074211 DEBUG (ScheduledTrigger-2404-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 4
   [junit4]   2> 1074212 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: data: /solr/collections/addReplicaColl/state.json
   [junit4]   2> 1074213 INFO  (qtp1007603861-11025) [n:127.0.0.1:38121_solr    
x:addReplicaColl_shard2_replica_n5] o.a.s.h.a.CoreAdminOperation core create 
command 
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=addReplicaColl_shard2_replica_n5&action=CREATE&numShards=2&collection=addReplicaColl&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1074233 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: data: /solr/collections/addReplicaColl/state.json
   [junit4]   2> 1074239 DEBUG (qtp57504572-11057) [n:127.0.0.1:37507_solr 
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica_n1] 
o.a.s.c.ZkController publishing state=down
   [junit4]   2> 1074248 INFO  (qtp1227543936-11045) [n:127.0.0.1:42696_solr    
x:addReplicaColl_shard2_replica_n6] o.a.s.h.a.CoreAdminOperation core create 
command 
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=addReplicaColl_shard2_replica_n6&action=CREATE&numShards=2&collection=addReplicaColl&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1074260 DEBUG (qtp1007603861-11025) [n:127.0.0.1:38121_solr 
c:addReplicaColl s:shard2 r:core_node7 x:addReplicaColl_shard2_replica_n5] 
o.a.s.c.ZkController publishing state=down
   [junit4]   2> 1074285 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/queue
   [junit4]   2> 1074285 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/queue
   [junit4]   2> 1074297 INFO  (qtp220436642-11034) [n:127.0.0.1:44279_solr    
x:addReplicaColl_shard1_replica_n3] o.a.s.h.a.CoreAdminOperation core create 
command 
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=addReplicaColl_shard1_replica_n3&action=CREATE&numShards=2&collection=addReplicaColl&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1074301 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/queue
   [junit4]   2> 1074301 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/queue
   [junit4]   2> 1074304 DEBUG (qtp57504572-11057) [n:127.0.0.1:37507_solr 
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica_n1] 
o.a.s.c.ZkController Registering watch for collection addReplicaColl
   [junit4]   2> 1074304 DEBUG (qtp57504572-11057) [n:127.0.0.1:37507_solr 
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica_n1] 
o.a.s.c.ZkController waiting to find shard id in clusterstate for 
addReplicaColl_shard1_replica_n1
   [junit4]   2> 1074337 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: data: /solr/collections/addReplicaColl/state.json
   [junit4]   2> 1074337 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: data: /solr/collections/addReplicaColl/state.json
   [junit4]   2> 1074349 DEBUG (qtp1007603861-11025) [n:127.0.0.1:38121_solr 
c:addReplicaColl s:shard2 r:core_node7 x:addReplicaColl_shard2_replica_n5] 
o.a.s.c.ZkController Registering watch for collection addReplicaColl
   [junit4]   2> 1074349 DEBUG (qtp1007603861-11025) [n:127.0.0.1:38121_solr 
c:addReplicaColl s:shard2 r:core_node7 x:addReplicaColl_shard2_replica_n5] 
o.a.s.c.ZkController waiting to find shard id in clusterstate for 
addReplicaColl_shard2_replica_n5
   [junit4]   2> 1074357 DEBUG (qtp1227543936-11045) [n:127.0.0.1:42696_solr 
c:addReplicaColl s:shard2 r:core_node8 x:addReplicaColl_shard2_replica_n6] 
o.a.s.c.ZkController publishing state=down
   [junit4]   2> 1074374 DEBUG (qtp220436642-11034) [n:127.0.0.1:44279_solr 
c:addReplicaColl s:shard1 r:core_node4 x:addReplicaColl_shard1_replica_n3] 
o.a.s.c.ZkController publishing state=down
   [junit4]   2> 1074386 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/queue
   [junit4]   2> 1074406 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/queue
   [junit4]   2> 1074410 DEBUG (qtp1227543936-11045) [n:127.0.0.1:42696_solr 
c:addReplicaColl s:shard2 r:core_node8 x:addReplicaColl_shard2_replica_n6] 
o.a.s.c.ZkController Registering watch for collection addReplicaColl
   [junit4]   2> 1074410 DEBUG (qtp1227543936-11045) [n:127.0.0.1:42696_solr 
c:addReplicaColl s:shard2 r:core_node8 x:addReplicaColl_shard2_replica_n6] 
o.a.s.c.ZkController waiting to find shard id in clusterstate for 
addReplicaColl_shard2_replica_n6
   [junit4]   2> 1074411 DEBUG (qtp220436642-11034) [n:127.0.0.1:44279_solr 
c:addReplicaColl s:shard1 r:core_node4 x:addReplicaColl_shard1_replica_n3] 
o.a.s.c.ZkController Registering watch for collection addReplicaColl
   [junit4]   2> 1074411 DEBUG (qtp220436642-11034) [n:127.0.0.1:44279_solr 
c:addReplicaColl s:shard1 r:core_node4 x:addReplicaColl_shard1_replica_n3] 
o.a.s.c.ZkController waiting to find shard id in clusterstate for 
addReplicaColl_shard1_replica_n3
   [junit4]   2> 1074520 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: data: /solr/collections/addReplicaColl/state.json
   [junit4]   2> 1074520 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: data: /solr/collections/addReplicaColl/state.json
   [junit4]   2> 1074520 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: data: /solr/collections/addReplicaColl/state.json
   [junit4]   2> 1074520 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: data: /solr/collections/addReplicaColl/state.json
   [junit4]   2> 1074521 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
fired: children: /solr/overseer/queue
   [junit4]   2> 1074521 DEBUG (SyncThread:0) [    ] o.a.s.c.ZkTestServer Watch 
added: children: /solr/overseer/queue
   [junit4]   2> 1075011 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor Got 0 tasks from 
work-queue : [[]]
   [junit4]   2> 1075012 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor Cleaning up 
work-queue. #Running tasks: 1
   [junit4]   2> 1075012 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor RunningTasks: 
[/overseer/collection-queue-work/qn-0000000004]
   [junit4]   2> 1075012 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor BlockedTasks: []
   [junit4]   2> 1075012 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor CompletedTasks: []
   [junit4]   2> 1075012 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskProcessor RunningZKTasks: 
[/overseer/collection-queue-work/qn-0000000004]
   [junit4]   2> 1075012 DEBUG 
(OverseerCollectionConfigSetProcessor-73462678598844422-127.0.0.1:37507_solr-n_0000000000)
 [n:127.0.0.1:37507_solr    ] o.a.s.c.OverseerTaskQueue Peeking for top 99 
elements. ExcludeSet: [/overseer/collection-queue-work/qn-0000000004],[]
   [junit4]   2> 1075219 DEBUG (ScheduledTrigger-2404-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 4
   [junit4]   2> 1075377 INFO  (qtp57504572-11057) [n:127.0.0.1:37507_solr 
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica_n1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1075469 INFO  (qtp1007603861-11025) [n:127.0.0.1:38121_solr 
c:addReplicaColl s:shard2 r:core_node7 x:addReplicaColl_shard2_replica_n5] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1075472 INFO  (qtp57504572-11057) [n:127.0.0.1:37507_solr 
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica_n1] 
o.a.s.s.IndexSchema [addReplicaColl_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 1075519 INFO  (qtp57504572-11057) [n:127.0.0.1:37507_solr 
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica_n1] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1075519 INFO  (qtp57504572-11057) [n:127.0.0.1:37507_solr 
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica_n1] 
o.a.s.c.CoreContainer Creating SolrCore 'addReplicaColl_shard1_replica_n1' 
using configuration from collection addReplicaColl, trusted=true
   [junit4]   2> 1075520 INFO  (qtp57504572-11057) [n:127.0.0.1:37507_solr 
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.addReplicaColl.shard1.replica_n1' (registry 
'solr.core.addReplicaColl.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f062ab4
   [junit4]   2> 1075520 INFO  (qtp57504572-11057) [n:127.0.0.1:37507_solr 
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica_n1] 
o.a.s.c.SolrCore [[addReplicaColl_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.api.collections.CollectionsAPIDistributedZkTest_104795730302867C-001/tempDir-001/node1/addReplicaColl_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.api.collections.CollectionsAPIDistributedZkTest_104795730302867C-001/tempDir-001/node1/addReplicaColl_shard1_replica_n1/data/]
   [junit4]   2> 1075523 INFO  (qtp220436642-11034) [n:127.0.0.1:44279_solr 
c:addReplicaColl s:shard1 r:core_node4 x:addReplicaColl_shard1_replica_n3] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1075526 INFO  (qtp1007603861-11025) [n:127.0.0.1:38121_solr 
c:addReplicaColl s:shard2 r:core_node7 x:addReplicaColl_shard2_replica_n5] 
o.a.s.s.IndexSchema [addReplicaColl_shard2_replica_n5] Schema name=minimal
   [junit4]   2> 1075574 INFO  (qtp1007603861-11025) [n:127.0.0.1:38121_solr 
c:addReplicaColl s:shard2 r:core_node7 x:addReplicaColl_shard2_replica_n5] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1075574 INFO  (qtp1007603861-11025) [n:127.0.0.1:38121_solr 
c:addReplicaColl s:shard2 r:core_node7 x:addReplicaColl_shard2_replica_n5] 
o.a.s.c.CoreContainer Creating SolrCore 'addReplicaColl_shard2_replica_n5' 
using configuration from collection addReplicaColl, trusted=true
   [junit4]   2> 1075574 INFO  (qtp1007603861-11025) [n:127.0.0.1:38121_solr 
c:addReplicaColl s:shard2 r:core_node7 x:addReplicaColl_shard2_replica_n5] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.addReplicaColl.shard2.replica_n5' (registry 
'solr.core.addReplicaColl.shard2.replica_n5') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f062ab4
   [junit4]   2> 1075575 INFO  (qtp1007603861-11025) [n:127.0.0.1:38121_solr 
c:addReplicaColl s:shard2 r:core_node7 x:addReplicaColl_shard2_replica_n5] 
o.a.s.c.SolrCore [[addReplicaColl_shard2_replica_n5] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.api.collections.CollectionsAPIDistributedZkTest_104795730302867C-001/tempDir-001/node2/addReplicaColl_shard2_replica_n5],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.api.collections.CollectionsAPIDistributedZkTest_104795730302867C-001/tempDir-001/node2/addReplicaColl_shard2_replica_n5/data/]
   [junit4]   2> 1075630 INFO  (qtp220436642-11034) [n:127.0.0.1:44279_solr 
c:addReplicaColl s:shard1 r:core_node4 x:addReplicaColl_shard1_replica_n3] 
o.a.s.s.IndexSchema [addReplicaColl_shard1_replica_n3] Schema name=minimal
   [junit4]   2> 1075632 INFO  (qtp220436642-11034) [n:127.0.0.1:44279_solr 
c:addReplicaColl s:shard1 r:core_node4 x:addReplicaColl_shard1_replica_n3] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1075633 INFO  (qtp220436642-11034) [n:127.0.0.1:44279_solr 
c:addReplicaColl s:shard1 r:core_node4 x:addReplicaColl_shard1_replica_n3] 
o.a.s.c.CoreContainer Creating SolrCore 'addReplicaColl_shard1_replica_n3' 
using configuration from collection addReplicaColl, trusted=true
   [junit4]   2> 1075668 INFO  (qtp220436642-11034) [n:127.0.0.1:44279_solr 
c:addReplicaColl s:shard1 r:core_node4 x:addReplicaColl_shard1_replica_n3] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.addReplicaColl.shard1.replica_n3' (registry 
'solr.core.addReplicaColl.shard1.replica_n3') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f062ab4
   [junit4]   2> 1075668 INFO  (qtp220436642-11034) [n:127.0.0.1:44279_solr 
c:addReplicaColl s:shard1 r:core_node4 x:addReplicaColl_shard1_replica_n3] 
o.a.s.c.SolrCore [[addReplicaColl_shard1_replica_n3] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.api.collections.CollectionsAPIDistributedZkTest_104795730302867C-001/tempDir-001/node3/addReplicaColl_shard1_replica_n3],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.api.collections.CollectionsAPIDistributedZkTest_104795730302867C-001/tempDir-001/node3/addReplicaColl_shard1_replica_n3/data/]
   [junit4]   2> 1075691 INFO  (qtp1227543936-11045) [n:127.0.0.1:42696_solr 
c:addReplicaColl s:shard2 r:core_node8 x:addReplicaColl_shard2_replica_n6] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1075766 INFO  (qtp1227543936-11045) [n:127.0.0.1:42696_solr 
c:addReplicaColl s:shard2 r:core_node8 x:addReplicaColl_shard2_replica_n6] 
o.a.s.s.IndexSchema [addReplicaColl_shard2_replica_n6] Schema name=minimal
   [junit4]   2> 1075780 INFO  (qtp1227543936-11045) [n:127.0.0.1:42696_solr 
c:addReplicaColl s:shard

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

ava:748)
   [junit4]   1> 
   [junit4]   1> 23:10:29.781 
[SUITE-CloudSolrClientTest-seed#[8A835F3B05C5DA1D]-worker] ERROR 
org.apache.zookeeper.server.ZooKeeperServer - ZKShutdownHandler is not 
registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN 
server state changes
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_8A835F3B05C5DA1D-001
   [junit4]   2> Oct 09, 2018 5:40:29 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Lucene80, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@5dc0d8c1),
 locale=ru-RU, timezone=America/Cordoba
   [junit4]   2> NOTE: Linux 4.4.0-112-generic amd64/Oracle Corporation 
1.8.0_172 (64-bit)/cpus=4,threads=1,free=125292256,total=446169088
   [junit4]   2> NOTE: All tests run in this JVM: 
[StreamExpressionToExplanationTest, GreaterThanEqualToEvaluatorTest, 
TestSolrJsonWriter, TangentEvaluatorTest, HttpSolrClientBuilderTest, 
MultiplyEvaluatorTest, CommonParamsTest, SineEvaluatorTest, 
ConcurrentUpdateSolrClientMultiCollectionTest, LBHttpSolrClientBuilderTest, 
CosineEvaluatorTest, GetByIdTest, SolrExampleJettyTest, TestEmbeddedSolrServer, 
AddEvaluatorTest, ArrayEvaluatorTest, UuidEvaluatorTest, StreamDecoratorTest, 
LessThanEqualToEvaluatorTest, CloudSolrClientRetryTest, TestV1toV2ApiMapper, 
TestClusteringResponse, ExclusiveOrEvaluatorTest, TestCollectionStateWatchers, 
TestHash, JettyWebappTest, LargeVolumeJettyTest, TestSolrProperties, 
BasicHttpSolrClientTest, CloudSolrClientTest]
   [junit4] Completed [104/157 (1!)] on J2 in 60.94s, 16 tests, 1 failure <<< 
FAILURES!

[...truncated 44744 lines...]
-ecj-javadoc-lint-src:
    [mkdir] Created dir: /tmp/ecj574323638
 [ecj-lint] Compiling 1234 source files to /tmp/ecj574323638
 [ecj-lint] Processing annotations
 [ecj-lint] Annotations processed
 [ecj-lint] Processing annotations
 [ecj-lint] No elements to process
 [ecj-lint] invalid Class-Path header in manifest of jar file: 
/home/jenkins/.ivy2/cache/org.restlet.jee/org.restlet/jars/org.restlet-2.3.0.jar
 [ecj-lint] invalid Class-Path header in manifest of jar file: 
/home/jenkins/.ivy2/cache/org.restlet.jee/org.restlet.ext.servlet/jars/org.restlet.ext.servlet-2.3.0.jar
 [ecj-lint] ----------
 [ecj-lint] 1. WARNING in 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/client/solrj/embedded/EmbeddedSolrServer.java
 (at line 219)
 [ecj-lint]     return (NamedList<Object>) new 
JavaBinCodec(resolver).unmarshal(in);
 [ecj-lint]                                ^^^^^^^^^^^^^^^^^^^^^^^^^^
 [ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed
 [ecj-lint] ----------
 [ecj-lint] ----------
 [ecj-lint] 2. ERROR in 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/cloud/ElectionContext.java
 (at line 24)
 [ecj-lint]     import java.util.HashSet;
 [ecj-lint]            ^^^^^^^^^^^^^^^^^
 [ecj-lint] The import java.util.HashSet is never used
 [ecj-lint] ----------
 [ecj-lint] 3. ERROR in 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/cloud/ElectionContext.java
 (at line 26)
 [ecj-lint]     import java.util.Set;
 [ecj-lint]            ^^^^^^^^^^^^^
 [ecj-lint] The import java.util.Set is never used
 [ecj-lint] ----------
 [ecj-lint] ----------
 [ecj-lint] 4. ERROR in 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/cloud/ZkController.java
 (at line 113)
 [ecj-lint]     import 
org.apache.zookeeper.KeeperException.ConnectionLossException;
 [ecj-lint]            
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
 [ecj-lint] The import 
org.apache.zookeeper.KeeperException.ConnectionLossException is never used
 [ecj-lint] ----------
 [ecj-lint] 5. ERROR in 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/cloud/ZkController.java
 (at line 122)
 [ecj-lint]     import org.slf4j.MDC;
 [ecj-lint]            ^^^^^^^^^^^^^
 [ecj-lint] The import org.slf4j.MDC is never used
 [ecj-lint] ----------
 [ecj-lint] ----------
 [ecj-lint] 6. WARNING in 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/cloud/api/collections/RestoreCmd.java
 (at line 260)
 [ecj-lint]     throw new SolrException(ErrorCode.BAD_REQUEST, "Unexpected 
number of replicas, replicationFactor, " +
 [ecj-lint]               Replica.Type.NRT + " or " + Replica.Type.TLOG + " 
must be greater than 0");
 [ecj-lint]     
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
 [ecj-lint] Resource leak: 'repository' is not closed at this location
 [ecj-lint] ----------
 [ecj-lint] ----------
 [ecj-lint] 7. WARNING in 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/handler/loader/JavabinLoader.java
 (at line 143)
 [ecj-lint]     new JavaBinCodec() {
 [ecj-lint]       SolrParams params;
 [ecj-lint]       AddUpdateCommand addCmd = null;
 [ecj-lint] 
 [ecj-lint]       @Override
 [ecj-lint]       public List<Object> readIterator(DataInputInputStream fis) 
throws IOException {
 [ecj-lint]         while (true) {
 [ecj-lint]           Object o = readVal(fis);
 [ecj-lint]           if (o == END_OBJ) break;
 [ecj-lint]           if (o instanceof NamedList) {
 [ecj-lint]             params = ((NamedList) o).toSolrParams();
 [ecj-lint]           } else {
 [ecj-lint]             try {
 [ecj-lint]               if (o instanceof byte[]) {
 [ecj-lint]                 if (params != null) req.setParams(params);
 [ecj-lint]                 byte[] buf = (byte[]) o;
 [ecj-lint]                 contentStreamLoader.load(req, rsp, new 
ContentStreamBase.ByteArrayStream(buf, null), processor);
 [ecj-lint]               } else {
 [ecj-lint]                 throw new RuntimeException("unsupported type ");
 [ecj-lint]               }
 [ecj-lint]             } catch (Exception e) {
 [ecj-lint]               throw new RuntimeException(e);
 [ecj-lint]             } finally {
 [ecj-lint]               params = null;
 [ecj-lint]               req.setParams(old);
 [ecj-lint]             }
 [ecj-lint]           }
 [ecj-lint]         }
 [ecj-lint]         return Collections.emptyList();
 [ecj-lint]       }
 [ecj-lint] 
 [ecj-lint]     }.unmarshal(in);
 [ecj-lint]     
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
 [ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed
 [ecj-lint] ----------
 [ecj-lint] ----------
 [ecj-lint] 8. WARNING in 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/update/UpdateLog.java
 (at line 1865)
 [ecj-lint]     if (exceptionOnExecuteUpdate.get() != null) throw 
exceptionOnExecuteUpdate.get();
 [ecj-lint]                                                 
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
 [ecj-lint] Resource leak: 'proc' is not closed at this location
 [ecj-lint] ----------
 [ecj-lint] ----------
 [ecj-lint] 9. WARNING in 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/util/FileUtils.java
 (at line 50)
 [ecj-lint]     in = new FileInputStream(src).getChannel();
 [ecj-lint]          ^^^^^^^^^^^^^^^^^^^^^^^^
 [ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed
 [ecj-lint] ----------
 [ecj-lint] 10. WARNING in 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/util/FileUtils.java
 (at line 51)
 [ecj-lint]     out = new FileOutputStream(destination).getChannel();
 [ecj-lint]           ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
 [ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed
 [ecj-lint] ----------
 [ecj-lint] 10 problems (4 errors, 6 warnings)

BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:633: 
The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:101: 
The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build.xml:680:
 The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:2086:
 The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:2125:
 Compile failed; see the compiler error output for details.

Total time: 206 minutes 5 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to