Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-7.x/268/

3 tests failed.
FAILED:  org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.test

Error Message:
Error from server at http://127.0.0.1:34772/xo/control_collection: Expected 
mime type application/octet-stream but got text/html. <html> <head> <meta 
http-equiv="Content-Type" content="text/html;charset=utf-8"/> <title>Error 404 
Can not find: /xo/control_collection/update</title> </head> <body><h2>HTTP 
ERROR 404</h2> <p>Problem accessing /xo/control_collection/update. Reason: 
<pre>    Can not find: /xo/control_collection/update</pre></p><hr><a 
href="http://eclipse.org/jetty";>Powered by Jetty:// 9.4.11.v20180605</a><hr/>  
</body> </html> 

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:34772/xo/control_collection: Expected mime type 
application/octet-stream but got text/html. <html>
<head>
<meta http-equiv="Content-Type" content="text/html;charset=utf-8"/>
<title>Error 404 Can not find: /xo/control_collection/update</title>
</head>
<body><h2>HTTP ERROR 404</h2>
<p>Problem accessing /xo/control_collection/update. Reason:
<pre>    Can not find: /xo/control_collection/update</pre></p><hr><a 
href="http://eclipse.org/jetty";>Powered by Jetty:// 9.4.11.v20180605</a><hr/>

</body>
</html>

        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:607)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
        at org.apache.solr.client.solrj.SolrClient.commit(SolrClient.java:484)
        at org.apache.solr.client.solrj.SolrClient.commit(SolrClient.java:463)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.commit(AbstractFullDistribZkTestBase.java:1590)
        at 
org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.testIndexingBatchPerRequestWithHttpSolrClient(FullSolrCloudDistribCmdsTest.java:656)
        at 
org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.test(FullSolrCloudDistribCmdsTest.java:152)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1008)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:983)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  org.apache.lucene.document.TestLatLonShapeQueries.testRandomBig

Error Message:
Java heap space

Stack Trace:
java.lang.OutOfMemoryError: Java heap space
        at 
__randomizedtesting.SeedInfo.seed([1A8E9753E181CD65:9DD9EADC70D8B1E5]:0)
        at org.apache.lucene.geo.Polygon.<init>(Polygon.java:95)
        at 
org.apache.lucene.geo.GeoTestUtil.createRegularPolygon(GeoTestUtil.java:384)
        at org.apache.lucene.geo.GeoTestUtil.nextPolygon(GeoTestUtil.java:398)
        at 
org.apache.lucene.document.TestLatLonShapeQueries.doTestRandom(TestLatLonShapeQueries.java:126)
        at 
org.apache.lucene.document.TestLatLonShapeQueries.testRandomBig(TestLatLonShapeQueries.java:106)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
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)


FAILED:  
org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration.testNodeLostTriggerRestoreState

Error Message:
The trigger did not fire at all

Stack Trace:
java.lang.AssertionError: The trigger did not fire at all
        at 
__randomizedtesting.SeedInfo.seed([CCA6D96558318902:E7590C3EC2499CD2]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration.testNodeLostTriggerRestoreState(TestTriggerIntegration.java:324)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 10297 lines...]
   [junit4] Suite: org.apache.lucene.document.TestLatLonShapeQueries
   [junit4]   2> NOTE: download the large Jenkins line-docs file by running 
'ant get-jenkins-line-docs' in the lucene directory.
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestLatLonShapeQueries -Dtests.method=testRandomBig 
-Dtests.seed=1A8E9753E181CD65 -Dtests.multiplier=2 -Dtests.nightly=true 
-Dtests.slow=true 
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/test-data/enwiki.random.lines.txt
 -Dtests.locale=is -Dtests.timezone=Australia/Canberra -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR    660s J0 | TestLatLonShapeQueries.testRandomBig <<<
   [junit4]    > Throwable #1: java.lang.OutOfMemoryError: Java heap space
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([1A8E9753E181CD65:9DD9EADC70D8B1E5]:0)
   [junit4]    >        at org.apache.lucene.geo.Polygon.<init>(Polygon.java:95)
   [junit4]    >        at 
org.apache.lucene.geo.GeoTestUtil.createRegularPolygon(GeoTestUtil.java:384)
   [junit4]    >        at 
org.apache.lucene.geo.GeoTestUtil.nextPolygon(GeoTestUtil.java:398)
   [junit4]    >        at 
org.apache.lucene.document.TestLatLonShapeQueries.doTestRandom(TestLatLonShapeQueries.java:126)
   [junit4]    >        at 
org.apache.lucene.document.TestLatLonShapeQueries.testRandomBig(TestLatLonShapeQueries.java:106)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/lucene/build/sandbox/test/J0/temp/lucene.document.TestLatLonShapeQueries_1A8E9753E181CD65-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{id=PostingsFormat(name=LuceneFixedGap)}, 
docValues:{shape=DocValuesFormat(name=Direct), 
id=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=950, 
maxMBSortInHeap=6.330183374656174, sim=RandomSimilarity(queryNorm=true): {}, 
locale=is, timezone=Australia/Canberra
   [junit4]   2> NOTE: Linux 4.4.0-112-generic amd64/Oracle Corporation 
1.8.0_172 (64-bit)/cpus=4,threads=1,free=158087112,total=287309824
   [junit4]   2> NOTE: All tests run in this JVM: [TestLatLonShapeQueries]
   [junit4] Completed [20/24 (1!)] on J0 in 895.18s, 3 tests, 1 error <<< 
FAILURES!

[...truncated 16 lines...]
   [junit4] JVM J0: stdout was not empty, see: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/lucene/build/sandbox/test/temp/junit4-J0-20180723_045851_5262118161278346740366.sysout
   [junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
   [junit4] java.lang.OutOfMemoryError: Java heap space
   [junit4] Dumping heap to 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/heapdumps/java_pid14167.hprof
 ...
   [junit4] Heap dump file created [491702470 bytes in 6.873 secs]
   [junit4] <<< JVM J0: EOF ----

[...truncated 3280 lines...]
   [junit4] Suite: org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration
   [junit4]   2> Creating dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.sim.TestTriggerIntegration_CCA6D96558318902-001/init-core-data-001
   [junit4]   2> 1455032 DEBUG 
(SUITE-TestTriggerIntegration-seed#[CCA6D96558318902]-worker) [    ] 
o.a.s.c.a.s.SimClusterStateProvider --- new Overseer leader: 
127.0.0.1:10000_solr
   [junit4]   2> 1455033 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 1455033 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 0
   [junit4]   2> 1455034 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion -1
   [junit4]   2> 1455034 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 0
   [junit4]   2> 1455073 INFO  
(SUITE-TestTriggerIntegration-seed#[CCA6D96558318902]-worker) [    ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4] IGNOR/A 0.00s J2 | TestTriggerIntegration.testCooldown
   [junit4]    > Assumption #1: 'badapple' test group is disabled 
(@BadApple(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4]   2> 1455155 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial 
livenodes: [127.0.0.1:10001_solr, 127.0.0.1:10000_solr]
   [junit4]   2> 1455161 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1455161 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion 0
   [junit4]   2> 1455197 DEBUG (ScheduledTrigger-3331-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1455235 DEBUG 
(TEST-TestTriggerIntegration.testNodeLostTriggerRestoreState-seed#[CCA6D96558318902])
 [    ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 1
   [junit4]   2> 1455235 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
   [junit4]   2> 1455236 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 1455236 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1455236 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 1455236 INFO  
(TEST-TestTriggerIntegration.testNodeLostTriggerRestoreState-seed#[CCA6D96558318902])
 [    ] o.a.s.c.a.s.SimCloudManager === Restarting OverseerTriggerThread and 
clearing object cache...
   [junit4]   2> 1455235 DEBUG (ScheduledTrigger-3331-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1455237 WARN  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Interrupted
   [junit4]   2> java.lang.InterruptedException: null
   [junit4]   2>        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
 ~[?:1.8.0_172]
   [junit4]   2>        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2048)
 ~[?:1.8.0_172]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:189)
 [java/:?]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_172]
   [junit4]   2> 1455237 DEBUG 
(TEST-TestTriggerIntegration.testNodeLostTriggerRestoreState-seed#[CCA6D96558318902])
 [    ] o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool 
executor now
   [junit4]   2> 1455238 DEBUG 
(TEST-TestTriggerIntegration.testNodeLostTriggerRestoreState-seed#[CCA6D96558318902])
 [    ] o.a.s.c.a.ScheduledTriggers Shutting down action executor now
   [junit4]   2> 1455238 DEBUG 
(TEST-TestTriggerIntegration.testNodeLostTriggerRestoreState-seed#[CCA6D96558318902])
 [    ] o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor
   [junit4]   2> 1455238 DEBUG 
(TEST-TestTriggerIntegration.testNodeLostTriggerRestoreState-seed#[CCA6D96558318902])
 [    ] o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread 
pool executor
   [junit4]   2> 1455275 DEBUG 
(TEST-TestTriggerIntegration.testNodeLostTriggerRestoreState-seed#[CCA6D96558318902])
 [    ] o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
   [junit4]   2> 1455275 DEBUG 
(TEST-TestTriggerIntegration.testNodeLostTriggerRestoreState-seed#[CCA6D96558318902])
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed 
explicitly
   [junit4]   2> 1455275 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 1455275 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 2
   [junit4]   2> 1455276 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion -1
   [junit4]   2> 1455276 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
   [junit4]   2> 1455276 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial 
livenodes: [127.0.0.1:10001_solr, 127.0.0.1:10000_solr]
   [junit4]   2> 1455276 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1455276 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
   [junit4]   2> 1455276 DEBUG (ScheduledTrigger-3336-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1455297 DEBUG (ScheduledTrigger-3336-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1455332 DEBUG (ScheduledTrigger-3336-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1455368 DEBUG (ScheduledTrigger-3336-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1455405 DEBUG (ScheduledTrigger-3336-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1455492 DEBUG (ScheduledTrigger-3336-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1455514 DEBUG (ScheduledTrigger-3336-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1455527 DEBUG (simCloudManagerPool-3335-thread-1) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1455527 DEBUG (simCloudManagerPool-3335-thread-1) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
3
   [junit4]   2> 1455548 DEBUG (ScheduledTrigger-3336-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1455551 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3
   [junit4]   2> 1455551 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1455551 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3
   [junit4]   2> 1455568 DEBUG (simCloudManagerPool-3335-thread-2) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1455569 DEBUG (simCloudManagerPool-3335-thread-2) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
4
   [junit4]   2> 1455569 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 4
   [junit4]   2> 1455569 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.s.TestTriggerIntegration TestTriggerAction init
   [junit4]   2> 1455569 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger node_lost_restore_trigger - 
Initial livenodes: [127.0.0.1:10001_solr, 127.0.0.1:10000_solr, 
127.0.0.1:10002_solr]
   [junit4]   2> 1455569 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1455570 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 4, lastZnodeVersion 4
   [junit4]   2> 1455579 DEBUG (ScheduledTrigger-3336-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1455579 DEBUG (ScheduledTrigger-3336-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: node_lost_restore_trigger 
with currently live nodes: 2
   [junit4]   2> 1455579 DEBUG (ScheduledTrigger-3336-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Tracking lost node: 127.0.0.1:10002_solr
   [junit4]   2> 1455600 DEBUG (ScheduledTrigger-3336-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1455600 DEBUG (ScheduledTrigger-3336-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: node_lost_restore_trigger 
with currently live nodes: 2
   [junit4]   2> 1455620 DEBUG (ScheduledTrigger-3336-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1455620 DEBUG (ScheduledTrigger-3336-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: node_lost_restore_trigger 
with currently live nodes: 2
   [junit4]   2> 1455625 DEBUG (simCloudManagerPool-3335-thread-3) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1455625 DEBUG (simCloudManagerPool-3335-thread-3) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
5
   [junit4]   2> 1455625 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 5
   [junit4]   2> 1455626 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.s.TestTriggerIntegration TestTriggerAction init
   [junit4]   2> 1455626 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger node_lost_restore_trigger - 
Initial livenodes: [127.0.0.1:10001_solr, 127.0.0.1:10000_solr]
   [junit4]   2> 1455626 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeLostTrigger Adding lost node from marker path: 
127.0.0.1:10002_solr
   [junit4]   2> 1455626 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1455626 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 5, lastZnodeVersion 5
   [junit4]   2> 1455626 DEBUG (ScheduledTrigger-3336-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: node_lost_restore_trigger 
with currently live nodes: 2
   [junit4]   2> 1455626 DEBUG (ScheduledTrigger-3336-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger NodeLostTrigger firing registered processor for lost 
nodes: [127.0.0.1:10002_solr]
   [junit4]   2> 1455626 DEBUG (ScheduledTrigger-3336-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
   [junit4]   2>   "id":"341898e64ac048Tf2ajl6ovim0jkakwiwyb17cnl",
   [junit4]   2>   "source":"node_lost_restore_trigger",
   [junit4]   2>   "eventTime":14663743766708296,
   [junit4]   2>   "eventType":"NODELOST",
   [junit4]   2>   "properties":{
   [junit4]   2>     "eventTimes":[14663743766708296],
   [junit4]   2>     "nodeNames":["127.0.0.1:10002_solr"]}}
   [junit4]   2> 1455627 DEBUG (ScheduledTrigger-3336-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers Pausing all triggers: [.auto_add_replicas, 
node_lost_restore_trigger]
   [junit4]   2> 1455737 INFO  
(TEST-TestTriggerIntegration.testNodeLostTriggerRestoreState-seed#[CCA6D96558318902])
 [    ] o.a.s.c.a.s.SimSolrCloudTestCase #######################################
   [junit4]   2> ############ CLUSTER STATE ############
   [junit4]   2> #######################################
   [junit4]   2> ## Live nodes:         2
   [junit4]   2> ## Empty nodes:        1
   [junit4]   2> ## Dead nodes:         1
   [junit4]   2> ##             127.0.0.1:10002_solr
   [junit4]   2> ## Collections:        [.system]
   [junit4]   2> ## Max replicas per node:      1
   [junit4]   2> ## Min replicas per node:      0
   [junit4]   2> ## Total replicas:             1
   [junit4]   2> ## * .system           1
   [junit4]   2> ##             - active           1
   [junit4]   2> ######### Solr op counts ##########
   [junit4]   2> ##             - autoscaling        3
   [junit4]   2> ##             - update             1
   [junit4]   2> ######### Autoscaling event counts ###########
   [junit4]   2> 
   [junit4]   2> NOTE: download the large Jenkins line-docs file by running 
'ant get-jenkins-line-docs' in the lucene directory.
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestTriggerIntegration 
-Dtests.method=testNodeLostTriggerRestoreState -Dtests.seed=CCA6D96558318902 
-Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true 
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/test-data/enwiki.random.lines.txt
 -Dtests.locale=es-PY -Dtests.timezone=America/St_Vincent -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] FAILURE 0.70s J2 | 
TestTriggerIntegration.testNodeLostTriggerRestoreState <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: The trigger did not 
fire at all
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([CCA6D96558318902:E7590C3EC2499CD2]:0)
   [junit4]    >        at 
org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration.testNodeLostTriggerRestoreState(TestTriggerIntegration.java:324)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4] IGNOR/A 0.00s J2 | TestTriggerIntegration.testSearchRate
   [junit4]    > Assumption #1: 'badapple' test group is disabled 
(@BadApple(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4] IGNOR/A 0.00s J2 | 
TestTriggerIntegration.testNodeMarkersRegistration
   [junit4]    > Assumption #1: 'badapple' test group is disabled 
(@BadApple(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4] IGNOR/A 0.00s J2 | TestTriggerIntegration.testEventFromRestoredState
   [junit4]    > Assumption #1: 'badapple' test group is disabled 
(@BadApple(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4] IGNOR/A 0.00s J2 | TestTriggerIntegration.testEventQueue
   [junit4]    > Assumption #1: 'badapple' test group is disabled 
(@BadApple(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4] IGNOR/A 0.02s J2 | TestTriggerIntegration.testTriggerThrottling
   [junit4]    > Assumption #1: 'badapple' test group is disabled 
(@BadApple(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4] IGNOR/A 0.00s J2 | TestTriggerIntegration.testNodeAddedTrigger
   [junit4]    > Assumption #1: 'badapple' test group is disabled 
(@BadApple(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4] IGNOR/A 0.00s J2 | 
TestTriggerIntegration.testNodeAddedTriggerRestoreState
   [junit4]    > Assumption #1: 'badapple' test group is disabled 
(@BadApple(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4] IGNOR/A 0.00s J2 | TestTriggerIntegration.testListeners
   [junit4]    > Assumption #1: 'badapple' test group is disabled 
(@BadApple(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4] IGNOR/A 0.00s J2 | TestTriggerIntegration.testNodeLostTrigger
   [junit4]    > Assumption #1: 'badapple' test group is disabled 
(@BadApple(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4]   2> 1455807 WARN  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Interrupted
   [junit4]   2> java.lang.InterruptedException: null
   [junit4]   2>        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
 ~[?:1.8.0_172]
   [junit4]   2>        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2048)
 ~[?:1.8.0_172]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:189)
 [java/:?]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_172]
   [junit4]   2> 1455809 DEBUG 
(SUITE-TestTriggerIntegration-seed#[CCA6D96558318902]-worker) [    ] 
o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool executor now
   [junit4]   2> 1455809 DEBUG 
(SUITE-TestTriggerIntegration-seed#[CCA6D96558318902]-worker) [    ] 
o.a.s.c.a.ScheduledTriggers Shutting down action executor now
   [junit4]   2> 1455809 DEBUG 
(SUITE-TestTriggerIntegration-seed#[CCA6D96558318902]-worker) [    ] 
o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor
   [junit4]   2> 1455809 DEBUG 
(SUITE-TestTriggerIntegration-seed#[CCA6D96558318902]-worker) [    ] 
o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread pool 
executor
   [junit4]   2> 1455809 WARN  (ScheduledTrigger-3336-thread-2) [    ] 
o.a.s.c.a.SystemLogListener Exception sending event to collection .system
   [junit4]   2> java.io.IOException: java.lang.InterruptedException
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.sim.SimCloudManager.request(SimCloudManager.java:632)
 ~[test/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.SystemLogListener.onEvent(SystemLogListener.java:118)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:790)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:757)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$add$4(ScheduledTriggers.java:283)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.NodeLostTrigger.run(NodeLostTrigger.java:157) 
[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerWrapper.run(ScheduledTriggers.java:589)
 [java/:?]
   [junit4]   2>        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) 
[?:1.8.0_172]
   [junit4]   2>        at 
java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) [?:1.8.0_172]
   [junit4]   2>        at 
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
 [?:1.8.0_172]
   [junit4]   2>        at 
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
 [?:1.8.0_172]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) 
[?:1.8.0_172]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) 
[?:1.8.0_172]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_172]
   [junit4]   2> Caused by: java.lang.InterruptedException
   [junit4]   2>        at 
java.util.concurrent.FutureTask.awaitDone(FutureTask.java:404) ~[?:1.8.0_172]
   [junit4]   2>        at 
java.util.concurrent.FutureTask.get(FutureTask.java:191) ~[?:1.8.0_172]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.sim.SimCloudManager.request(SimCloudManager.java:630)
 ~[test/:?]
   [junit4]   2>        ... 13 more
   [junit4]   2> 1455949 DEBUG (simCloudManagerPool-3335-thread-6) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- no leader in shard1:{
   [junit4]   2>   "replicas":{"core_node1":{
   [junit4]   2>       "core":".system_shard1_replica_n1",
   [junit4]   2>       "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>       "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>       "INDEX.sizeInBytes":10240,
   [junit4]   2>       "node_name":"127.0.0.1:10000_solr",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "type":"NRT",
   [junit4]   2>       "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>       "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active"}
   [junit4]   2> 1455950 WARN  (ScheduledTrigger-3336-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers Ignoring autoscaling event {
   [junit4]   2>   "id":"341898e64ac048Tf2ajl6ovim0jkakwiwyb17cnl",
   [junit4]   2>   "source":"node_lost_restore_trigger",
   [junit4]   2>   "eventTime":14663743766708296,
   [junit4]   2>   "eventType":"NODELOST",
   [junit4]   2>   "properties":{
   [junit4]   2>     "eventTimes":[14663743766708296],
   [junit4]   2>     "_enqueue_time_":14663743807440146,
   [junit4]   2>     "nodeNames":["127.0.0.1:10002_solr"]}} from trigger 
org.apache.solr.cloud.autoscaling.NodeLostTrigger@25926685 because the executor 
has already been closed
   [junit4]   2> 1455950 DEBUG (ScheduledTrigger-3336-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger NodeLostTrigger processor for lost nodes: 
[127.0.0.1:10002_solr] is not ready, will try later
   [junit4]   2> 1455950 DEBUG 
(SUITE-TestTriggerIntegration-seed#[CCA6D96558318902]-worker) [    ] 
o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
   [junit4]   2> 1455950 DEBUG 
(SUITE-TestTriggerIntegration-seed#[CCA6D96558318902]-worker) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.sim.TestTriggerIntegration_CCA6D96558318902-001
   [junit4]   2> NOTE: test params are: codec=Lucene70, 
sim=RandomSimilarity(queryNorm=false): {}, locale=es-PY, 
timezone=America/St_Vincent
   [junit4]   2> NOTE: Linux 4.4.0-112-generic amd64/Oracle Corporation 
1.8.0_172 (64-bit)/cpus=4,threads=1,free=255062824,total=477102080
   [junit4]   2> NOTE: All tests run in this JVM: 
[LeaderElectionContextKeyTest, TestLocalFSCloudBackupRestore, 
CollectionsAPIDistributedZkTest, TestConfigSetsAPIZkFailure, 
SolrPluginUtilsTest, LoggingHandlerTest, SignatureUpdateProcessorFactoryTest, 
TestSystemCollAutoCreate, TemplateUpdateProcessorTest, TestStressUserVersions, 
TestBadConfig, TestZkChroot, PreAnalyzedFieldManagedSchemaCloudTest, 
MetricTriggerTest, TestConfigSets, TestScoreJoinQPScore, 
TestGeoJSONResponseWriter, FacetPivotSmallTest, MigrateRouteKeyTest, 
TestMiniSolrCloudClusterSSL, TestCSVLoader, CollectionReloadTest, 
ZkStateReaderTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, 
DefaultValueUpdateProcessorTest, TestXmlQParserPlugin, PeerSyncTest, 
TestPHPSerializedResponseWriter, MoreLikeThisHandlerTest, 
TestFieldCacheWithThreads, DateFieldTest, ConfigureRecoveryStrategyTest, 
TestStressLucene, SuggesterFSTTest, OutputWriterTest, ReplaceNodeTest, 
DirectSolrConnectionTest, UnloadDistributedZkTest, 
DistributedQueryComponentCustomSortTest, HttpPartitionTest, 
DeleteInactiveReplicaTest, TestJettySolrRunner, TestDocumentBuilder, 
TestDocTermOrdsUninvertLimit, HdfsRecoveryZkTest, 
ManagedSchemaRoundRobinCloudTest, TestSchemaNameResource, QueryEqualityTest, 
TestRawTransformer, TestLazyCores, ZkShardTermsTest, MetricsHandlerTest, 
LeaderFailoverAfterPartitionTest, JSONWriterTest, ConnectionManagerTest, 
TestLegacyNumericRangeQueryBuilder, TestLeaderElectionZkExpiry, 
TestStressInPlaceUpdates, TestRandomCollapseQParserPlugin, BasicZkTest, 
HdfsBasicDistributedZk2Test, TestObjectReleaseTracker, 
TestGraphTermsQParserPlugin, DocumentAnalysisRequestHandlerTest, 
CoreAdminRequestStatusTest, TestFilteredDocIdSet, TestWriterPerf, 
RequestHandlersTest, TestExtendedDismaxParser, ChangedSchemaMergeTest, 
TestSha256AuthenticationProvider, DistanceFunctionTest, 
DirectSolrSpellCheckerTest, SolrTestCaseJ4Test, HttpTriggerListenerTest, 
TestSimpleTrackingShardHandler, TestTriggerIntegration]
   [junit4] Completed [163/823 (1!)] on J2 in 1.29s, 11 tests, 1 failure, 10 
skipped <<< FAILURES!

[...truncated 444 lines...]
   [junit4] Suite: org.apache.solr.cloud.FullSolrCloudDistribCmdsTest
   [junit4]   2> 1854157 INFO  
(SUITE-FullSolrCloudDistribCmdsTest-seed#[CCA6D96558318902]-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-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_CCA6D96558318902-001/init-core-data-001
   [junit4]   2> 1854157 WARN  
(SUITE-FullSolrCloudDistribCmdsTest-seed#[CCA6D96558318902]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=3 numCloses=3
   [junit4]   2> 1854157 INFO  
(SUITE-FullSolrCloudDistribCmdsTest-seed#[CCA6D96558318902]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1854159 INFO  
(SUITE-FullSolrCloudDistribCmdsTest-seed#[CCA6D96558318902]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776)
   [junit4]   2> 1854159 INFO  
(SUITE-FullSolrCloudDistribCmdsTest-seed#[CCA6D96558318902]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /xo/
   [junit4]   2> 1854173 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1854173 INFO  (Thread-1601) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1854173 INFO  (Thread-1601) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1854175 ERROR (Thread-1601) [    ] 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> 1854273 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:36651
   [junit4]   2> 1854276 INFO  (zkConnectionManagerCallback-1605-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1854286 INFO  (zkConnectionManagerCallback-1607-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1854302 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 1854304 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/schema15.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 1854305 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1854307 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 1854308 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 1854309 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 1854323 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 1854324 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1854339 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1854340 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 1854341 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 1854375 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly 
asked otherwise
   [junit4]   2> 1854901 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
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> 1854928 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1854928 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1854928 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1854930 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5d4e232d{/xo,null,AVAILABLE}
   [junit4]   2> 1854931 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@6e273ca4{HTTP/1.1,[http/1.1]}{127.0.0.1:34772}
   [junit4]   2> 1854943 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.e.j.s.Server Started @1855105ms
   [junit4]   2> 1854943 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_CCA6D96558318902-001/tempDir-001/control/data,
 hostContext=/xo, hostPort=34772, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_CCA6D96558318902-001/control-001/cores}
   [junit4]   2> 1854944 ERROR 
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1854944 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1854944 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.5.0
   [junit4]   2> 1854944 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1854944 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1854944 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-07-23T06:18:27.606Z
   [junit4]   2> 1854961 INFO  (zkConnectionManagerCallback-1609-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1854962 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1854962 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_CCA6D96558318902-001/control-001/solr.xml
   [junit4]   2> 1854982 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1854982 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1854983 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ce641eb, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1855966 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36651/solr
   [junit4]   2> 1855975 INFO  (zkConnectionManagerCallback-1613-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1855978 INFO  (zkConnectionManagerCallback-1615-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1856295 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:34772_xo    ] o.a.s.c.OverseerElectionContext I am going to be the 
leader 127.0.0.1:34772_xo
   [junit4]   2> 1856308 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:34772_xo    ] o.a.s.c.Overseer Overseer 
(id=73018621005004804-127.0.0.1:34772_xo-n_0000000000) starting
   [junit4]   2> 1856475 INFO  (zkConnectionManagerCallback-1622-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1856493 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:34772_xo    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:36651/solr ready
   [junit4]   2> 1856539 INFO  
(OverseerStateUpdate-73018621005004804-127.0.0.1:34772_xo-n_0000000000) [    ] 
o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:34772_xo
   [junit4]   2> 1856540 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:34772_xo    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:34772_xo
   [junit4]   2> 1856703 INFO  
(OverseerStateUpdate-73018621005004804-127.0.0.1:34772_xo-n_0000000000) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1856820 INFO  (zkCallback-1621-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1856865 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:34772_xo    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1856977 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:34772_xo    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ce641eb
   [junit4]   2> 1857069 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:34772_xo    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ce641eb
   [junit4]   2> 1857070 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:34772_xo    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ce641eb
   [junit4]   2> 1857084 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:34772_xo    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_CCA6D96558318902-001/control-001/cores
   [junit4]   2> 1857300 INFO  (zkConnectionManagerCallback-1628-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1857304 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1857305 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36651/solr ready
   [junit4]   2> 1857313 INFO  (qtp705050781-6605) [n:127.0.0.1:34772_xo    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:34772_xo&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1857517 INFO  (OverseerThreadFactory-2947-thread-1) [    ] 
o.a.s.c.a.c.CreateCollectionCmd Create collection control_collection
   [junit4]   2> 1857784 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo    
x:control_collection_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core 
create command 
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1857785 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo    
x:control_collection_shard1_replica_n1] o.a.s.c.TransientSolrCoreCacheDefault 
Allocating transient cache for 4 transient cores
   [junit4]   2> 1859350 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
   [junit4]   2> 1859425 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.s.IndexSchema [control_collection_shard1_replica_n1] Schema name=test
   [junit4]   2> 1859883 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1859971 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1' 
using configuration from collection control_collection, trusted=true
   [junit4]   2> 1859972 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.control_collection.shard1.replica_n1' (registry 
'solr.core.control_collection.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ce641eb
   [junit4]   2> 1859972 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1859972 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SolrCore [[control_collection_shard1_replica_n1] ] Opening new SolrCore 
at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_CCA6D96558318902-001/control-001/cores/control_collection_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_CCA6D96558318902-001/control-001/cores/control_collection_shard1_replica_n1/data/]
   [junit4]   2> 1859987 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=17, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=1.505859375, 
floorSegmentMB=1.2705078125, forceMergeDeletesPctAllowed=4.843586772451537, 
segmentsPerTier=24.0, maxCFSSegmentSizeMB=2.16796875, 
noCFSRatio=0.7309616722700067, deletesPctAllowed=44.05987407323393
   [junit4]   2> 1860021 WARN  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 1860255 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1860255 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1860256 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1860256 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1860257 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=40, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1860257 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@7d550686[control_collection_shard1_replica_n1] main]
   [junit4]   2> 1860263 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1860263 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1860264 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1860265 INFO  
(searcherExecutor-2952-thread-1-processing-n:127.0.0.1:34772_xo 
x:control_collection_shard1_replica_n1 c:control_collection s:shard1) 
[n:127.0.0.1:34772_xo c:control_collection s:shard1  
x:control_collection_shard1_replica_n1] o.a.s.c.SolrCore 
[control_collection_shard1_replica_n1] Registered new searcher 
Searcher@7d550686[control_collection_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1860265 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1606761015334141952
   [junit4]   2> 1860318 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/control_collection/terms/shard1 to Terms{values={core_node2=0}, 
version=0}
   [junit4]   2> 1860390 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1860390 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1860390 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:34772/xo/control_collection_shard1_replica_n1/
   [junit4]   2> 1860390 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1860390 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SyncStrategy 
http://127.0.0.1:34772/xo/control_collection_shard1_replica_n1/ has no replicas
   [junit4]   2> 1860390 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1860410 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:34772/xo/control_collection_shard1_replica_n1/ shard1
   [junit4]   2> 1860483 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1860485 INFO  (qtp705050781-6600) [n:127.0.0.1:34772_xo 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2700
   [junit4]   2> 1860540 INFO  (qtp705050781-6605) [n:127.0.0.1:34772_xo    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 1860541 INFO  
(OverseerCollectionConfigSetProcessor-73018621005004804-127.0.0.1:34772_xo-n_0000000000)
 [    ] 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> 1860593 INFO  (zkCallback-1614-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1861541 INFO  (qtp705050781-6605) [n:127.0.0.1:34772_xo    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:34772_xo&wt=javabin&version=2}
 status=0 QTime=4227
   [junit4]   2> 1861856 INFO  (zkConnectionManagerCallback-1633-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1861873 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1861874 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36651/solr ready
   [junit4]   2> 1861874 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection 
loss:false
   [junit4]   2> 1861885 INFO  (qtp705050781-6601) [n:127.0.0.1:34772_xo    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=3&createNodeSet=&stateFormat=2&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1861942 INFO  (OverseerThreadFactory-2947-thread-2) [    ] 
o.a.s.c.a.c.CreateCollectionCmd Create collection collection1
   [junit4]   2> 1861955 WARN  (OverseerThreadFactory-2947-thread-2) [    ] 
o.a.s.c.a.c.CreateCollectionCmd It is unusual to create a collection 
(collection1) without cores.
   [junit4]   2> 1862187 INFO  (qtp705050781-6601) [n:127.0.0.1:34772_xo    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 1862259 INFO  (qtp705050781-6601) [n:127.0.0.1:34772_xo    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=3&createNodeSet=&stateFormat=2&wt=javabin&version=2}
 status=0 QTime=373
   [junit4]   2> 1863960 INFO  
(OverseerCollectionConfigSetProcessor-73018621005004804-127.0.0.1:34772_xo-n_0000000000)
 [    ] 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> 1864186 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_CCA6D96558318902-001/shard-1-001
 of type NRT
   [junit4]   2> 1864187 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
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> 1864188 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1864188 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1864188 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1864188 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7d69f255{/xo,null,AVAILABLE}
   [junit4]   2> 1864189 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@3a1f71b3{HTTP/1.1,[http/1.1]}{127.0.0.1:36939}
   [junit4]   2> 1864190 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.e.j.s.Server Started @1864351ms
   [junit4]   2> 1864190 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_CCA6D96558318902-001/tempDir-001/jetty1,
 replicaType=NRT, solrconfig=solrconfig.xml, hostContext=/xo, hostPort=36939, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/../../../../../../../../../../../home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_CCA6D96558318902-001/shard-1-001/cores}
   [junit4]   2> 1864190 ERROR 
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1864190 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1864190 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.5.0
   [junit4]   2> 1864190 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1864190 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1864190 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-07-23T06:18:36.852Z
   [junit4]   2> 1864192 INFO  (zkConnectionManagerCallback-1635-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1864193 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1864193 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_CCA6D96558318902-001/shard-1-001/solr.xml
   [junit4]   2> 1864227 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1864227 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1864229 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ce641eb, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1864491 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36651/solr
   [junit4]   2> 1864493 INFO  (zkConnectionManagerCallback-1639-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1864495 INFO  (zkConnectionManagerCallback-1641-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1864527 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:36939_xo    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1864531 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:36939_xo    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 4 transient cores
   [junit4]   2> 1864532 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:36939_xo    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:36939_xo
   [junit4]   2> 1864533 INFO  (zkCallback-1621-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1864533 INFO  (zkCallback-1614-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1864589 INFO  (zkCallback-1632-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1864591 INFO  (zkCallback-1640-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1864630 INFO  (zkConnectionManagerCallback-1648-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1864631 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:36939_xo    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 1864632 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:36939_xo    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:36651/solr ready
   [junit4]   2> 1864632 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:36939_xo    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1864705 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:36939_xo    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ce641eb
   [junit4]   2> 1864738 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:36939_xo    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ce641eb
   [junit4]   2> 1864738 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:36939_xo    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ce641eb
   [junit4]   2> 1864748 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) 
[n:127.0.0.1:36939_xo    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/../../../../../../../../../../../home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_CCA6D96558318902-001/shard-1-001/cores
   [junit4]   2> 1864836 INFO  (qtp705050781-6607) [n:127.0.0.1:34772_xo    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params 
node=127.0.0.1:36939_xo&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1864854 INFO  (OverseerThreadFactory-2947-thread-3) [ 
c:collection1 s:shard2  ] o.a.s.c.a.c.AddReplicaCmd Node Identified 
127.0.0.1:36939_xo for creating new replica
   [junit4]   2> 1864866 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo    
x:collection1_shard2_replica_n61] o.a.s.h.a.CoreAdminOperation core create 
command 
qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n61&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1865897 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.5.0
   [junit4]   2> 1866036 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] o.a.s.s.IndexSchema 
[collection1_shard2_replica_n61] Schema name=test
   [junit4]   2> 1866267 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] o.a.s.s.IndexSchema 
Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1866306 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1_shard2_replica_n61' using configuration from 
collection collection1, trusted=true
   [junit4]   2> 1866307 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1.shard2.replica_n61' (registry 
'solr.core.collection1.shard2.replica_n61') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ce641eb
   [junit4]   2> 1866307 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1866307 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] o.a.s.c.SolrCore 
[[collection1_shard2_replica_n61] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_CCA6D96558318902-001/shard-1-001/cores/collection1_shard2_replica_n61],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/../../../../../../../../../../../home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_CCA6D96558318902-001/shard-1-001/cores/collection1_shard2_replica_n61/data/]
   [junit4]   2> 1866330 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=17, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=1.505859375, 
floorSegmentMB=1.2705078125, forceMergeDeletesPctAllowed=4.843586772451537, 
segmentsPerTier=24.0, maxCFSSegmentSizeMB=2.16796875, 
noCFSRatio=0.7309616722700067, deletesPctAllowed=44.05987407323393
   [junit4]   2> 1866332 WARN  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 1866532 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1866532 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1866534 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1866534 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1866535 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=40, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1866552 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@13d577af[collection1_shard2_replica_n61] main]
   [junit4]   2> 1866576 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1866576 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1866577 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1866577 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1606761021952753664
   [junit4]   2> 1866585 INFO  
(searcherExecutor-2966-thread-1-processing-n:127.0.0.1:36939_xo 
x:collection1_shard2_replica_n61 c:collection1 s:shard2) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] o.a.s.c.SolrCore 
[collection1_shard2_replica_n61] Registered new searcher 
Searcher@13d577af[collection1_shard2_replica_n61] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1866592 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] o.a.s.c.ZkShardTerms 
Successful update of terms at /collections/collection1/terms/shard2 to 
Terms{values={core_node62=0}, version=0}
   [junit4]   2> 1866608 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1866608 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1866608 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:36939/xo/collection1_shard2_replica_n61/
   [junit4]   2> 1866608 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 1866608 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] o.a.s.c.SyncStrategy 
http://127.0.0.1:36939/xo/collection1_shard2_replica_n61/ has no replicas
   [junit4]   2> 1866608 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1866620 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:36939/xo/collection1_shard2_replica_n61/ shard2
   [junit4]   2> 1866786 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 1866790 INFO  (qtp1367281427-6660) [n:127.0.0.1:36939_xo 
c:collection1 s:shard2  x:collection1_shard2_replica_n61] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n61&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1924
   [junit4]   2> 1866813 INFO  (qtp705050781-6607) [n:127.0.0.1:34772_xo 
c:collection1   ] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/admin/collections 
params={node=127.0.0.1:36939_xo&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2}
 status=0 QTime=1977
   [junit4]   2> 1866920 INFO  
(OverseerCollectionConfigSetProcessor-73018621005004804-127.0.0.1:34772_xo-n_0000000000)
 [    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000004 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1866930 INFO  (zkCallback-1640-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [2])
   [junit4]   2> 1867270 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_CCA6D96558318902-001/shard-2-001
 of type NRT
   [junit4]   2> 1867270 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
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> 1867279 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1867279 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1867280 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1867280 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7dca3a0f{/xo,null,AVAILABLE}
   [junit4]   2> 1867280 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@287b57e7{HTTP/1.1,[http/1.1]}{127.0.0.1:41764}
   [junit4]   2> 1867280 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.e.j.s.Server Started @1867442ms
   [junit4]   2> 1867280 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_CCA6D96558318902-001/tempDir-001/jetty2,
 replicaType=NRT, solrconfig=solrconfig.xml, hostContext=/xo, hostPort=41764, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/../../../../../../../../../../../home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_CCA6D96558318902-001/shard-2-001/cores}
   [junit4]   2> 1867282 ERROR 
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[CCA6D96558318902]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing

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

aused by: org.apache.solr.common.SolrException: Could not load collection from 
ZK: collection2
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([CCA6D96558318902]:0)
   [junit4]    >        at 
org.apache.solr.common.cloud.ZkStateReader.getCollectionLive(ZkStateReader.java:1316)
   [junit4]    >        at 
org.apache.solr.common.cloud.ZkStateReader$LazyCollectionRef.get(ZkStateReader.java:732)
   [junit4]    >        at 
org.apache.solr.common.cloud.ClusterState$CollectionRef.get(ClusterState.java:386)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.getDocCollection(CloudSolrClient.java:1208)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:851)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:948)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:819)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
   [junit4]    >        at 
org.apache.solr.cloud.FullSolrCloudDistribCmdsTest$1IndexThread.run(FullSolrCloudDistribCmdsTest.java:633)
   [junit4]    > Caused by: 
org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = 
Session expired for /collections/collection2/state.json
   [junit4]    >        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:130)
   [junit4]    >        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:54)
   [junit4]    >        at 
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1215)
   [junit4]    >        at 
org.apache.solr.common.cloud.SolrZkClient.lambda$getData$5(SolrZkClient.java:341)
   [junit4]    >        at 
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
   [junit4]    >        at 
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:341)
   [junit4]    >        at 
org.apache.solr.common.cloud.ZkStateReader.fetchCollectionState(ZkStateReader.java:1328)
   [junit4]    >        at 
org.apache.solr.common.cloud.ZkStateReader.getCollectionLive(ZkStateReader.java:1314)
   [junit4]    >        ... 9 moreThrowable #3: 
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=7125, name=Thread-1691, state=RUNNABLE, 
group=TGRP-FullSolrCloudDistribCmdsTest]
   [junit4]    > Caused by: org.apache.solr.common.SolrException: Could not 
load collection from ZK: collection2
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([CCA6D96558318902]:0)
   [junit4]    >        at 
org.apache.solr.common.cloud.ZkStateReader.getCollectionLive(ZkStateReader.java:1316)
   [junit4]    >        at 
org.apache.solr.common.cloud.ZkStateReader$LazyCollectionRef.get(ZkStateReader.java:732)
   [junit4]    >        at 
org.apache.solr.common.cloud.ClusterState$CollectionRef.get(ClusterState.java:386)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.getDocCollection(CloudSolrClient.java:1208)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:851)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:948)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:819)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
   [junit4]    >        at 
org.apache.solr.cloud.FullSolrCloudDistribCmdsTest$1IndexThread.run(FullSolrCloudDistribCmdsTest.java:633)
   [junit4]    > Caused by: 
org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = 
Session expired for /collections/collection2/state.json
   [junit4]    >        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:130)
   [junit4]    >        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:54)
   [junit4]    >        at 
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1215)
   [junit4]    >        at 
org.apache.solr.common.cloud.SolrZkClient.lambda$getData$5(SolrZkClient.java:341)
   [junit4]    >        at 
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
   [junit4]    >        at 
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:341)
   [junit4]    >        at 
org.apache.solr.common.cloud.ZkStateReader.fetchCollectionState(ZkStateReader.java:1328)
   [junit4]    >        at 
org.apache.solr.common.cloud.ZkStateReader.getCollectionLive(ZkStateReader.java:1314)
   [junit4]    >        ... 9 moreThrowable #4: 
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=7124, name=Thread-1690, state=RUNNABLE, 
group=TGRP-FullSolrCloudDistribCmdsTest]
   [junit4]    > Caused by: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:34772/xo/control_collection: Cannot talk to 
ZooKeeper - Updates are disabled.
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([CCA6D96558318902]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
   [junit4]    >        at 
org.apache.solr.cloud.FullSolrCloudDistribCmdsTest$1IndexThread.run(FullSolrCloudDistribCmdsTest.java:634)Throwable
 #5: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an 
uncaught exception in thread: Thread[id=7127, name=Thread-1693, state=RUNNABLE, 
group=TGRP-FullSolrCloudDistribCmdsTest]
   [junit4]    > Caused by: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:34772/xo/control_collection: Cannot talk to 
ZooKeeper - Updates are disabled.
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([CCA6D96558318902]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
   [junit4]    >        at 
org.apache.solr.cloud.FullSolrCloudDistribCmdsTest$1IndexThread.run(FullSolrCloudDistribCmdsTest.java:634)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_CCA6D96558318902-001
   [junit4]   2> Jul 23, 2018 6:30:15 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=SimpleText, 
sim=RandomSimilarity(queryNorm=false): {}, locale=be, timezone=Libya
   [junit4]   2> NOTE: Linux 4.4.0-112-generic amd64/Oracle Corporation 
1.8.0_172 (64-bit)/cpus=4,threads=1,free=91412800,total=505413632
   [junit4]   2> NOTE: All tests run in this JVM: [TestCustomStream, 
TestLMJelinekMercerSimilarityFactory, TestStreamBody, 
OverseerCollectionConfigSetProcessorTest, CreateCollectionCleanupTest, 
TestNestedDocsSort, TestLegacyField, TestRetrieveFieldsOptimizer, 
TestStressVersions, TestFastOutputStream, TestAtomicUpdateErrorCases, 
ConnectionReuseTest, CdcrVersionReplicationTest, CursorPagingTest, 
SignificantTermsQParserPluginTest, TestBulkSchemaConcurrent, 
BasicAuthStandaloneTest, SSLMigrationTest, LukeRequestHandlerTest, 
TestDynamicURP, ReplicationFactorTest, DistribDocExpirationUpdateProcessorTest, 
TestCodecSupport, HLLSerializationTest, TestCloudJSONFacetSKG, 
TestCoreContainer, TestFaceting, TestSort, TestDistribStateManager, 
TestAnalyzeInfixSuggestions, TlogReplayBufferedWhileIndexingTest, 
ResourceLoaderTest, DOMUtilTest, TestCryptoKeys, TestLargeCluster, 
TestPayloadScoreQParserPlugin, ShardSplitTest, ZkFailoverTest, StressHdfsTest, 
TestHdfsUpdateLog, TimeZoneUtilsTest, TestZkAclsWithHadoopAuth, 
TestSystemIdResolver, TestLuceneMatchVersion, 
TestLeaderInitiatedRecoveryThread, TestUninvertingReader, 
PeerSyncWithBufferUpdatesTest, SpatialRPTFieldTypeTest, TestReload, 
PathHierarchyTokenizerFactoryTest, TestCloudRecovery, TestSimpleTextCodec, 
SolrRequestParserTest, TestJsonRequest, NodeMutatorTest, AnalyticsQueryTest, 
HttpSolrCallGetCoreTest, TestPerFieldSimilarityWithDefaultOverride, 
TestIndexingPerformance, TestOrdValues, TestFieldTypeCollectionResource, 
QueryResultKeyTest, TestManagedSchema, BinaryUpdateRequestHandlerTest, 
TestPushWriter, TestGraphMLResponseWriter, TestNoOpRegenerator, 
FullSolrCloudDistribCmdsTest]
   [junit4] Completed [282/823 (2!)] on J0 in 709.36s, 1 test, 1 error <<< 
FAILURES!

[...truncated 10700 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/build.xml:651:
 The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/build.xml:585:
 Some of the tests produced a heap dump, but did not fail. Maybe a suppressed 
OutOfMemoryError? Dumps created:
* java_pid14167.hprof

Total time: 452 minutes 44 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: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to