Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/4185/
Java: 64bit/jdk-9 -XX:+UseCompressedOops -XX:+UseParallelGC 
--illegal-access=deny

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

Error Message:
Could not find collection:collection2

Stack Trace:
java.lang.AssertionError: Could not find collection:collection2
        at 
__randomizedtesting.SeedInfo.seed([79E605EA1992276E:F1B23A30B76E4A96]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNotNull(Assert.java:526)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:155)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:140)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:135)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:908)
        at 
org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.testIndexingBatchPerRequestWithHttpSolrClient(FullSolrCloudDistribCmdsTest.java:612)
        at 
org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.test(FullSolrCloudDistribCmdsTest.java:152)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:564)
        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:993)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
        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 
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.base/java.lang.Thread.run(Thread.java:844)




Build Log:
[...truncated 12548 lines...]
   [junit4] Suite: org.apache.solr.cloud.FullSolrCloudDistribCmdsTest
   [junit4]   2> 1371646 INFO  
(SUITE-FullSolrCloudDistribCmdsTest-seed#[79E605EA1992276E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/init-core-data-001
   [junit4]   2> 1371647 WARN  
(SUITE-FullSolrCloudDistribCmdsTest-seed#[79E605EA1992276E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=10 numCloses=10
   [junit4]   2> 1371647 INFO  
(SUITE-FullSolrCloudDistribCmdsTest-seed#[79E605EA1992276E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1371647 INFO  
(SUITE-FullSolrCloudDistribCmdsTest-seed#[79E605EA1992276E]-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";)
 w/ MAC_OS_X supressed clientAuth
   [junit4]   2> 1371647 INFO  
(SUITE-FullSolrCloudDistribCmdsTest-seed#[79E605EA1992276E]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /q/jz
   [junit4]   2> 1371648 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1371649 INFO  (Thread-3086) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1371649 INFO  (Thread-3086) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1371652 ERROR (Thread-3086) [    ] 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> 1371757 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:50583
   [junit4]   2> 1371779 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 1371782 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema15.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 1371784 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1371786 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 1371788 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 1371790 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 1371792 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 1371794 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1371796 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1371798 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 1371800 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 1371803 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly 
asked otherwise
   [junit4]   2> 1372038 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1372039 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@eb4a37b{/q/jz,null,AVAILABLE}
   [junit4]   2> 1372040 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@7f7c13c2{HTTP/1.1,[http/1.1]}{127.0.0.1:50586}
   [junit4]   2> 1372040 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.Server Started @1373707ms
   [junit4]   2> 1372040 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/q/jz, 
solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/tempDir-001/control/data,
 hostPort=50586, 
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/control-001/cores,
 replicaType=NRT}
   [junit4]   2> 1372040 ERROR 
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1372041 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1372041 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1372041 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 1372041 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-09-23T03:51:56.652292Z
   [junit4]   2> 1372044 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1372044 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/control-001/solr.xml
   [junit4]   2> 1372046 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1372048 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50583/solr
   [junit4]   2> 1372192 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1372193 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 
127.0.0.1:50586_q%2Fjz
   [junit4]   2> 1372194 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.Overseer Overseer 
(id=98706306908946436-127.0.0.1:50586_q%2Fjz-n_0000000000) starting
   [junit4]   2> 1372203 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:50586_q%2Fjz
   [junit4]   2> 1372208 INFO  (zkCallback-2045-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1372255 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1372268 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1372269 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1372270 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/control-001/cores
   [junit4]   2> 1372290 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1372292 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:50583/solr ready
   [junit4]   2> 1372294 INFO  (qtp990252548-12610) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:50586_q%252Fjz&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1372297 INFO  (OverseerThreadFactory-5407-thread-1) [    ] 
o.a.s.c.CreateCollectionCmd Create collection control_collection
   [junit4]   2> 1372405 INFO  (qtp990252548-12612) [    ] 
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> 1372406 INFO  (qtp990252548-12612) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1372520 INFO  (zkCallback-2045-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> 1373422 INFO  (qtp990252548-12612) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1373429 INFO  (qtp990252548-12612) [    ] o.a.s.s.IndexSchema 
[control_collection_shard1_replica_n1] Schema name=test
   [junit4]   2> 1373469 INFO  (qtp990252548-12612) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1373491 INFO  (qtp990252548-12612) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1' 
using configuration from collection control_collection, trusted=true
   [junit4]   2> 1373491 INFO  (qtp990252548-12612) [    ] 
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@56086aea
   [junit4]   2> 1373491 INFO  (qtp990252548-12612) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1373491 INFO  (qtp990252548-12612) [    ] o.a.s.c.SolrCore 
[[control_collection_shard1_replica_n1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/control-001/cores/control_collection_shard1_replica_n1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/control-001/cores/control_collection_shard1_replica_n1/data/]
   [junit4]   2> 1373493 INFO  (qtp990252548-12612) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=41, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1373495 WARN  (qtp990252548-12612) [    ] 
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> 1373538 INFO  (qtp990252548-12612) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1373538 INFO  (qtp990252548-12612) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1373540 INFO  (qtp990252548-12612) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1373540 INFO  (qtp990252548-12612) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1373542 INFO  (qtp990252548-12612) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=28, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 1373542 INFO  (qtp990252548-12612) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2147e1bc[control_collection_shard1_replica_n1] main]
   [junit4]   2> 1373544 INFO  (qtp990252548-12612) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1373544 INFO  (qtp990252548-12612) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1373545 INFO  (qtp990252548-12612) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1373546 INFO  (qtp990252548-12612) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1579300912530194432
   [junit4]   2> 1373546 INFO  (searcherExecutor-5410-thread-1) [    ] 
o.a.s.c.SolrCore [control_collection_shard1_replica_n1] Registered new searcher 
Searcher@2147e1bc[control_collection_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1373558 INFO  (qtp990252548-12612) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1373558 INFO  (qtp990252548-12612) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1373558 INFO  (qtp990252548-12612) [    ] o.a.s.c.SyncStrategy 
Sync replicas to 
http://127.0.0.1:50586/q/jz/control_collection_shard1_replica_n1/
   [junit4]   2> 1373558 INFO  (qtp990252548-12612) [    ] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 1373558 INFO  (qtp990252548-12612) [    ] o.a.s.c.SyncStrategy 
http://127.0.0.1:50586/q/jz/control_collection_shard1_replica_n1/ has no 
replicas
   [junit4]   2> 1373558 INFO  (qtp990252548-12612) [    ] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1373565 INFO  (qtp990252548-12612) [    ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:50586/q/jz/control_collection_shard1_replica_n1/ shard1
   [junit4]   2> 1373673 INFO  (zkCallback-2045-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> 1373717 INFO  (qtp990252548-12612) [    ] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 1373719 INFO  (qtp990252548-12612) [    ] 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=1313
   [junit4]   2> 1373722 INFO  (qtp990252548-12610) [    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 1373831 INFO  (zkCallback-2045-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> 1374300 INFO  
(OverseerCollectionConfigSetProcessor-98706306908946436-127.0.0.1:50586_q%2Fjz-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> 1374722 INFO  (qtp990252548-12610) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={replicationFactor=1&collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:50586_q%252Fjz&wt=javabin&version=2}
 status=0 QTime=2427
   [junit4]   2> 1374727 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1374728 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:50583/solr ready
   [junit4]   2> 1374728 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection 
loss:false
   [junit4]   2> 1374729 INFO  (qtp990252548-12615) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=3&createNodeSet=&stateFormat=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1374731 INFO  (OverseerThreadFactory-5407-thread-2) [    ] 
o.a.s.c.CreateCollectionCmd Create collection collection1
   [junit4]   2> 1374733 WARN  (OverseerThreadFactory-5407-thread-2) [    ] 
o.a.s.c.CreateCollectionCmd It is unusual to create a collection (collection1) 
without cores.
   [junit4]   2> 1374938 INFO  (qtp990252548-12615) [    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 1374938 INFO  (qtp990252548-12615) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={replicationFactor=1&collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=3&createNodeSet=&stateFormat=1&wt=javabin&version=2}
 status=0 QTime=209
   [junit4]   2> 1375146 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-1-001
 of type NRT
   [junit4]   2> 1375146 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1375147 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3c6880df{/q/jz,null,AVAILABLE}
   [junit4]   2> 1375148 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@8c7c190{HTTP/1.1,[http/1.1]}{127.0.0.1:50595}
   [junit4]   2> 1375148 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.Server Started @1376814ms
   [junit4]   2> 1375148 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/q/jz, 
solrconfig=solrconfig.xml, 
solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/tempDir-001/jetty1,
 hostPort=50595, 
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-1-001/cores}
   [junit4]   2> 1375148 ERROR 
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1375148 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1375148 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1375148 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 1375149 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-09-23T03:51:59.760011Z
   [junit4]   2> 1375151 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1375151 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-1-001/solr.xml
   [junit4]   2> 1375154 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1375155 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50583/solr
   [junit4]   2> 1375169 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1375172 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1375175 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:50595_q%2Fjz
   [junit4]   2> 1375177 INFO  (zkCallback-2057-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1375177 INFO  (zkCallback-2045-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1375177 INFO  (zkCallback-2052-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1375208 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1375218 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1375219 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1375220 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-1-001/cores
   [junit4]   2> 1375240 INFO  (qtp990252548-12608) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params 
node=127.0.0.1:50595_q%252Fjz&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1375243 INFO  (OverseerThreadFactory-5407-thread-3) [    ] 
o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:50595_q%2Fjz for creating new 
replica
   [junit4]   2> 1375243 INFO  
(OverseerCollectionConfigSetProcessor-98706306908946436-127.0.0.1:50586_q%2Fjz-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> 1375247 INFO  (qtp1912969630-12651) [    ] 
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> 1375247 INFO  (qtp1912969630-12651) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1376259 INFO  (qtp1912969630-12651) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1376266 INFO  (qtp1912969630-12651) [    ] o.a.s.s.IndexSchema 
[collection1_shard2_replica_n61] Schema name=test
   [junit4]   2> 1376306 INFO  (qtp1912969630-12651) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1376329 INFO  (qtp1912969630-12651) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_n61' using 
configuration from collection collection1, trusted=true
   [junit4]   2> 1376329 INFO  (qtp1912969630-12651) [    ] 
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@56086aea
   [junit4]   2> 1376330 INFO  (qtp1912969630-12651) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1376330 INFO  (qtp1912969630-12651) [    ] o.a.s.c.SolrCore 
[[collection1_shard2_replica_n61] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-1-001/cores/collection1_shard2_replica_n61],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-1-001/cores/collection1_shard2_replica_n61/data/]
   [junit4]   2> 1376332 INFO  (qtp1912969630-12651) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=41, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1376334 WARN  (qtp1912969630-12651) [    ] 
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> 1376372 INFO  (qtp1912969630-12651) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1376372 INFO  (qtp1912969630-12651) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1376374 INFO  (qtp1912969630-12651) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1376374 INFO  (qtp1912969630-12651) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1376375 INFO  (qtp1912969630-12651) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=28, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 1376376 INFO  (qtp1912969630-12651) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@441e5c99[collection1_shard2_replica_n61] main]
   [junit4]   2> 1376377 INFO  (qtp1912969630-12651) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1376378 INFO  (qtp1912969630-12651) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1376378 INFO  (qtp1912969630-12651) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1376378 INFO  (qtp1912969630-12651) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1579300915499761664
   [junit4]   2> 1376379 INFO  (searcherExecutor-5421-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard2_replica_n61] Registered new searcher 
Searcher@441e5c99[collection1_shard2_replica_n61] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1376387 INFO  (qtp1912969630-12651) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1376387 INFO  (qtp1912969630-12651) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1376387 INFO  (qtp1912969630-12651) [    ] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:50595/q/jz/collection1_shard2_replica_n61/
   [junit4]   2> 1376387 INFO  (qtp1912969630-12651) [    ] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1376387 INFO  (qtp1912969630-12651) [    ] 
o.a.s.c.SyncStrategy 
http://127.0.0.1:50595/q/jz/collection1_shard2_replica_n61/ has no replicas
   [junit4]   2> 1376387 INFO  (qtp1912969630-12651) [    ] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1376392 INFO  (qtp1912969630-12651) [    ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:50595/q/jz/collection1_shard2_replica_n61/ shard2
   [junit4]   2> 1376545 INFO  (qtp1912969630-12651) [    ] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1376547 INFO  (qtp1912969630-12651) [    ] 
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=1300
   [junit4]   2> 1376550 INFO  (qtp990252548-12608) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={node=127.0.0.1:50595_q%252Fjz&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2}
 status=0 QTime=1310
   [junit4]   2> 1376795 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-2-001
 of type NRT
   [junit4]   2> 1376795 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1376796 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@10fc6d9f{/q/jz,null,AVAILABLE}
   [junit4]   2> 1376797 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@2476dee9{HTTP/1.1,[http/1.1]}{127.0.0.1:50600}
   [junit4]   2> 1376797 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.Server Started @1378463ms
   [junit4]   2> 1376797 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/q/jz, 
solrconfig=solrconfig.xml, 
solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/tempDir-001/jetty2,
 hostPort=50600, 
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-2-001/cores,
 replicaType=NRT}
   [junit4]   2> 1376797 ERROR 
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1376797 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1376797 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1376797 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 1376797 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-09-23T03:52:01.408741Z
   [junit4]   2> 1376802 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1376802 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-2-001/solr.xml
   [junit4]   2> 1376804 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1376806 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50583/solr
   [junit4]   2> 1376818 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 1376822 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1376825 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:50600_q%2Fjz
   [junit4]   2> 1376827 INFO  (zkCallback-2045-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1376827 INFO  (zkCallback-2057-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1376827 INFO  (zkCallback-2052-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1376827 INFO  (zkCallback-2063-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1376862 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1376873 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1376873 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1376874 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-2-001/cores
   [junit4]   2> 1376903 INFO  (qtp990252548-12611) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params 
node=127.0.0.1:50600_q%252Fjz&action=ADDREPLICA&collection=collection1&shard=shard3&type=NRT&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1376906 INFO  (OverseerThreadFactory-5407-thread-4) [    ] 
o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:50600_q%2Fjz for creating new 
replica
   [junit4]   2> 1376907 INFO  
(OverseerCollectionConfigSetProcessor-98706306908946436-127.0.0.1:50586_q%2Fjz-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> 1376911 INFO  (qtp844001873-12681) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&name=collection1_shard3_replica_n63&action=CREATE&collection=collection1&shard=shard3&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1376911 INFO  (qtp844001873-12681) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1377924 INFO  (qtp844001873-12681) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1377932 INFO  (qtp844001873-12681) [    ] o.a.s.s.IndexSchema 
[collection1_shard3_replica_n63] Schema name=test
   [junit4]   2> 1377973 INFO  (qtp844001873-12681) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1377993 INFO  (qtp844001873-12681) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard3_replica_n63' using 
configuration from collection collection1, trusted=true
   [junit4]   2> 1377994 INFO  (qtp844001873-12681) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1.shard3.replica_n63' (registry 
'solr.core.collection1.shard3.replica_n63') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1377994 INFO  (qtp844001873-12681) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1377994 INFO  (qtp844001873-12681) [    ] o.a.s.c.SolrCore 
[[collection1_shard3_replica_n63] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-2-001/cores/collection1_shard3_replica_n63],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-2-001/cores/collection1_shard3_replica_n63/data/]
   [junit4]   2> 1377996 INFO  (qtp844001873-12681) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=41, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1377999 WARN  (qtp844001873-12681) [    ] 
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> 1378035 INFO  (qtp844001873-12681) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1378035 INFO  (qtp844001873-12681) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1378036 INFO  (qtp844001873-12681) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1378036 INFO  (qtp844001873-12681) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1378037 INFO  (qtp844001873-12681) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=28, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 1378038 INFO  (qtp844001873-12681) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1a4084b8[collection1_shard3_replica_n63] main]
   [junit4]   2> 1378039 INFO  (qtp844001873-12681) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1378040 INFO  (qtp844001873-12681) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1378040 INFO  (qtp844001873-12681) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1378040 INFO  (qtp844001873-12681) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1579300917242494976
   [junit4]   2> 1378041 INFO  (searcherExecutor-5432-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard3_replica_n63] Registered new searcher 
Searcher@1a4084b8[collection1_shard3_replica_n63] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1378047 INFO  (qtp844001873-12681) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1378048 INFO  (qtp844001873-12681) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1378048 INFO  (qtp844001873-12681) [    ] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:50600/q/jz/collection1_shard3_replica_n63/
   [junit4]   2> 1378048 INFO  (qtp844001873-12681) [    ] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 1378048 INFO  (qtp844001873-12681) [    ] o.a.s.c.SyncStrategy 
http://127.0.0.1:50600/q/jz/collection1_shard3_replica_n63/ has no replicas
   [junit4]   2> 1378048 INFO  (qtp844001873-12681) [    ] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1378052 INFO  (qtp844001873-12681) [    ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:50600/q/jz/collection1_shard3_replica_n63/ shard3
   [junit4]   2> 1378204 INFO  (qtp844001873-12681) [    ] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 1378205 INFO  (qtp844001873-12681) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard3_replica_n63&action=CREATE&collection=collection1&shard=shard3&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1294
   [junit4]   2> 1378208 INFO  (qtp990252548-12611) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={node=127.0.0.1:50600_q%252Fjz&action=ADDREPLICA&collection=collection1&shard=shard3&type=NRT&wt=javabin&version=2}
 status=0 QTime=1304
   [junit4]   2> 1378454 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-3-001
 of type NRT
   [junit4]   2> 1378454 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1378456 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@13c1f0db{/q/jz,null,AVAILABLE}
   [junit4]   2> 1378457 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@7a46b965{HTTP/1.1,[http/1.1]}{127.0.0.1:50609}
   [junit4]   2> 1378457 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.Server Started @1380123ms
   [junit4]   2> 1378457 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/q/jz, 
solrconfig=solrconfig.xml, 
solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/tempDir-001/jetty3,
 hostPort=50609, 
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-3-001/cores,
 replicaType=NRT}
   [junit4]   2> 1378457 ERROR 
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1378458 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1378458 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1378458 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 1378458 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-09-23T03:52:03.069220Z
   [junit4]   2> 1378461 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1378461 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-3-001/solr.xml
   [junit4]   2> 1378465 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1378468 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50583/solr
   [junit4]   2> 1378481 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 1378484 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1378487 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:50609_q%2Fjz
   [junit4]   2> 1378489 INFO  (zkCallback-2057-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1378489 INFO  (zkCallback-2063-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1378489 INFO  (zkCallback-2052-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1378489 INFO  (zkCallback-2045-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1378489 INFO  (zkCallback-2069-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1378534 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1378544 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1378544 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1378546 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-3-001/cores
   [junit4]   2> 1378583 INFO  (qtp990252548-12612) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params 
node=127.0.0.1:50609_q%252Fjz&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1378586 INFO  (OverseerThreadFactory-5407-thread-5) [    ] 
o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:50609_q%2Fjz for creating new 
replica
   [junit4]   2> 1378586 INFO  
(OverseerCollectionConfigSetProcessor-98706306908946436-127.0.0.1:50586_q%2Fjz-n_0000000000)
 [    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000006 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1378590 INFO  (qtp1504261677-12710) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n65&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1378590 INFO  (qtp1504261677-12710) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1379601 INFO  (qtp1504261677-12710) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1379616 INFO  (qtp1504261677-12710) [    ] o.a.s.s.IndexSchema 
[collection1_shard1_replica_n65] Schema name=test
   [junit4]   2> 1379650 INFO  (qtp1504261677-12710) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1379668 INFO  (qtp1504261677-12710) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n65' using 
configuration from collection collection1, trusted=true
   [junit4]   2> 1379669 INFO  (qtp1504261677-12710) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1.shard1.replica_n65' (registry 
'solr.core.collection1.shard1.replica_n65') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1379669 INFO  (qtp1504261677-12710) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1379669 INFO  (qtp1504261677-12710) [    ] o.a.s.c.SolrCore 
[[collection1_shard1_replica_n65] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-3-001/cores/collection1_shard1_replica_n65],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-3-001/cores/collection1_shard1_replica_n65/data/]
   [junit4]   2> 1379672 INFO  (qtp1504261677-12710) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=41, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1379674 WARN  (qtp1504261677-12710) [    ] 
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> 1379708 INFO  (qtp1504261677-12710) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1379708 INFO  (qtp1504261677-12710) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1379709 INFO  (qtp1504261677-12710) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1379709 INFO  (qtp1504261677-12710) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1379710 INFO  (qtp1504261677-12710) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=28, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 1379710 INFO  (qtp1504261677-12710) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@142c983[collection1_shard1_replica_n65] main]
   [junit4]   2> 1379711 INFO  (qtp1504261677-12710) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1379712 INFO  (qtp1504261677-12710) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1379712 INFO  (qtp1504261677-12710) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1379712 INFO  (qtp1504261677-12710) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1579300918995714048
   [junit4]   2> 1379713 INFO  (searcherExecutor-5443-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard1_replica_n65] Registered new searcher 
Searcher@142c983[collection1_shard1_replica_n65] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1379719 INFO  (qtp1504261677-12710) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1379719 INFO  (qtp1504261677-12710) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1379719 INFO  (qtp1504261677-12710) [    ] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:50609/q/jz/collection1_shard1_replica_n65/
   [junit4]   2> 1379719 INFO  (qtp1504261677-12710) [    ] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1379719 INFO  (qtp1504261677-12710) [    ] 
o.a.s.c.SyncStrategy 
http://127.0.0.1:50609/q/jz/collection1_shard1_replica_n65/ has no replicas
   [junit4]   2> 1379719 INFO  (qtp1504261677-12710) [    ] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1379723 INFO  (qtp1504261677-12710) [    ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:50609/q/jz/collection1_shard1_replica_n65/ shard1
   [junit4]   2> 1379894 INFO  (qtp1504261677-12710) [    ] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1379896 INFO  (qtp1504261677-12710) [    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n65&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1306
   [junit4]   2> 1379899 INFO  (qtp990252548-12612) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={node=127.0.0.1:50609_q%252Fjz&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2}
 status=0 QTime=1315
   [junit4]   2> 1380120 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 4 in directory 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-4-001
 of type NRT
   [junit4]   2> 1380121 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1380122 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@539bd154{/q/jz,null,AVAILABLE}
   [junit4]   2> 1380123 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@64e8ae93{HTTP/1.1,[http/1.1]}{127.0.0.1:50620}
   [junit4]   2> 1380123 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.Server Started @1381789ms
   [junit4]   2> 1380123 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/q/jz, 
solrconfig=solrconfig.xml, 
solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/tempDir-001/jetty4,
 hostPort=50620, 
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-4-001/cores}
   [junit4]   2> 1380123 ERROR 
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1380124 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1380124 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1380124 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 1380124 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-09-23T03:52:04.735507Z
   [junit4]   2> 1380127 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1380127 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-4-001/solr.xml
   [junit4]   2> 1380131 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1380133 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50583/solr
   [junit4]   2> 1380147 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 1380151 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1380154 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:50620_q%2Fjz
   [junit4]   2> 1380156 INFO  (zkCallback-2045-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1380157 INFO  (zkCallback-2057-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1380157 INFO  (zkCallback-2069-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1380157 INFO  (zkCallback-2063-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1380157 INFO  (zkCallback-2075-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1380157 INFO  (zkCallback-2052-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1380201 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1380213 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1380213 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1380214 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-4-001/cores
   [junit4]   2> 1380288 INFO  (qtp990252548-12610) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params 
node=127.0.0.1:50620_q%252Fjz&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1380290 INFO  (OverseerThreadFactory-5407-thread-5) [    ] 
o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:50620_q%2Fjz for creating new 
replica
   [junit4]   2> 1380291 INFO  
(OverseerCollectionConfigSetProcessor-98706306908946436-127.0.0.1:50586_q%2Fjz-n_0000000000)
 [    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000008 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1380295 INFO  (qtp995887153-12739) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n67&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1380295 INFO  (qtp995887153-12739) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1381322 INFO  (qtp995887153-12739) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1381338 INFO  (qtp995887153-12739) [    ] o.a.s.s.IndexSchema 
[collection1_shard2_replica_n67] Schema name=test
   [junit4]   2> 1381371 INFO  (qtp995887153-12739) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1381391 INFO  (qtp995887153-12739) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_n67' using 
configuration from collection collection1, trusted=true
   [junit4]   2> 1381392 INFO  (qtp995887153-12739) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1.shard2.replica_n67' (registry 
'solr.core.collection1.shard2.replica_n67') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1381392 INFO  (qtp995887153-12739) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1381392 INFO  (qtp995887153-12739) [    ] o.a.s.c.SolrCore 
[[collection1_shard2_replica_n67] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-4-001/cores/collection1_shard2_replica_n67],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-4-001/cores/collection1_shard2_replica_n67/data/]
   [junit4]   2> 1381393 INFO  (qtp995887153-12739) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=41, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1381395 WARN  (qtp995887153-12739) [    ] 
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> 1381428 INFO  (qtp995887153-12739) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1381428 INFO  (qtp995887153-12739) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1381429 INFO  (qtp995887153-12739) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1381429 INFO  (qtp995887153-12739) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1381430 INFO  (qtp995887153-12739) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=28, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 1381430 INFO  (qtp995887153-12739) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@437a2aa6[collection1_shard2_replica_n67] main]
   [junit4]   2> 1381431 INFO  (qtp995887153-12739) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1381432 INFO  (qtp995887153-12739) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1381432 INFO  (qtp995887153-12739) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1381432 INFO  (qtp995887153-12739) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1579300920799264768
   [junit4]   2> 1381439 INFO  (searcherExecutor-5454-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard2_replica_n67] Registered new searcher 
Searcher@437a2aa6[collection1_shard2_replica_n67] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1381442 INFO  (qtp995887153-12739) [    ] o.a.s.c.ZkController 
Core needs to recover:collection1_shard2_replica_n67
   [junit4]   2> 1381442 INFO  (updateExecutor-2072-thread-1) [    ] 
o.a.s.u.DefaultSolrCoreState Running recovery
   [junit4]   2> 1381443 INFO  (qtp995887153-12739) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n67&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1147
   [junit4]   2> 1381443 INFO  (recoveryExecutor-2073-thread-1) [    ] 
o.a.s.c.RecoveryStrategy Starting recovery process. recoveringAfterStartup=true
   [junit4]   2> 1381443 INFO  (recoveryExecutor-2073-thread-1) [    ] 
o.a.s.c.RecoveryStrategy ###### startupVersions=[[]]
   [junit4]   2> 1381443 INFO  (recoveryExecutor-2073-thread-1) [    ] 
o.a.s.c.RecoveryStrategy Begin buffering updates. 
core=[collection1_shard2_replica_n67]
   [junit4]   2> 1381443 INFO  (recoveryExecutor-2073-thread-1) [    ] 
o.a.s.u.UpdateLog Starting to buffer updates. FSUpdateLog{state=ACTIVE, 
tlog=null}
   [junit4]   2> 1381443 INFO  (recoveryExecutor-2073-thread-1) [    ] 
o.a.s.c.RecoveryStrategy Publishing state of core 
[collection1_shard2_replica_n67] as recovering, leader is 
[http://127.0.0.1:50595/q/jz/collection1_shard2_replica_n61/] and I am 
[http://127.0.0.1:50620/q/jz/collection1_shard2_replica_n67/]
   [junit4]   2> 1381445 INFO  (recoveryExecutor-2073-thread-1) [    ] 
o.a.s.c.RecoveryStrategy Sending prep recovery command to 
[http://127.0.0.1:50595/q/jz]; [WaitForState: 
action=PREPRECOVERY&core=collection1_shard2_replica_n61&nodeName=127.0.0.1:50620_q%252Fjz&coreNodeName=core_node68&state=recovering&checkLive=true&onlyIfLeader=true&onlyIfLeaderActive=true]
   [junit4]   2> 1381446 INFO  (qtp990252548-12610) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={node=127.0.0.1:50620_q%252Fjz&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2}
 status=0 QTime=1158
   [junit4]   2> 1381446 INFO  (qtp1912969630-12652) [    ] 
o.a.s.h.a.PrepRecoveryOp Going to wait for coreNodeName: core_node68, state: 
recovering, checkLive: true, onlyIfLeader: true, onlyIfLeaderActive: true, 
maxTime: 183 s
   [junit4]   2> 1381447 INFO  (qtp1912969630-12652) [    ] 
o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=collection1, 
shard=shard2, thisCore=collection1_shard2_replica_n61, 
leaderDoesNotNeedRecovery=false, isLeader? true, live=true, checkLive=true, 
currentState=down, localState=active, nodeName=127.0.0.1:50620_q%2Fjz, 
coreNodeName=core_node68, onlyIfActiveCheckResult=false, nodeProps: 
core_node68:{"core":"collection1_shard2_replica_n67","base_url":"http://127.0.0.1:50620/q/jz","node_name":"127.0.0.1:50620_q%2Fjz","state":"down","type":"NRT"}
   [junit4]   2> 1381653 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 5 in directory 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-5-001
 of type NRT
   [junit4]   2> 1381654 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1381656 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@16da29c4{/q/jz,null,AVAILABLE}
   [junit4]   2> 1381656 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@7cba12d8{HTTP/1.1,[http/1.1]}{127.0.0.1:50626}
   [junit4]   2> 1381656 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.e.j.s.Server Started @1383323ms
   [junit4]   2> 1381656 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/q/jz, 
solrconfig=solrconfig.xml, 
solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/tempDir-001/jetty5,
 hostPort=50626, 
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-5-001/cores}
   [junit4]   2> 1381657 ERROR 
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1381657 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1381657 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1381657 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 1381657 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-09-23T03:52:06.268286Z
   [junit4]   2> 1381659 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1381659 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-5-001/solr.xml
   [junit4]   2> 1381661 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1381663 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50583/solr
   [junit4]   2> 1381675 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
   [junit4]   2> 1381679 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1381681 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:50626_q%2Fjz
   [junit4]   2> 1381683 INFO  (zkCallback-2069-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
   [junit4]   2> 1381684 INFO  (zkCallback-2063-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
   [junit4]   2> 1381684 INFO  (zkCallback-2075-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
   [junit4]   2> 1381684 INFO  (zkCallback-2052-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
   [junit4]   2> 1381684 INFO  (zkCallback-2082-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
   [junit4]   2> 1381684 INFO  (zkCallback-2057-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
   [junit4]   2> 1381684 INFO  (zkCallback-2045-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
   [junit4]   2> 1381732 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1381742 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1381742 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1381744 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[79E605EA1992276E]) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-5-001/cores
   [junit4]   2> 1381797 INFO  (qtp990252548-12614) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params 
node=127.0.0.1:50626_q%252Fjz&action=ADDREPLICA&collection=collection1&shard=shard3&type=NRT&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1381799 INFO  (OverseerThreadFactory-5407-thread-5) [    ] 
o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:50626_q%2Fjz for creating new 
replica
   [junit4]   2> 1381800 INFO  
(OverseerCollectionConfigSetProcessor-98706306908946436-127.0.0.1:50586_q%2Fjz-n_0000000000)
 [    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000010 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1381803 INFO  (qtp1688025851-12771) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&name=collection1_shard3_replica_n69&action=CREATE&collection=collection1&shard=shard3&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1381804 INFO  (qtp1688025851-12771) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1382453 INFO  (qtp1912969630-12652) [    ] 
o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=collection1, 
shard=shard2, thisCore=collection1_shard2_replica_n61, 
leaderDoesNotNeedRecovery=false, isLeader? true, live=true, checkLive=true, 
currentState=recovering, localState=active, nodeName=127.0.0.1:50620_q%2Fjz, 
coreNodeName=core_node68, onlyIfActiveCheckResult=false, nodeProps: 
core_node68:{"core":"collection1_shard2_replica_n67","base_url":"http://127.0.0.1:50620/q/jz","node_name":"127.0.0.1:50620_q%2Fjz","state":"recovering","type":"NRT"}
   [junit4]   2> 1382453 INFO  (qtp1912969630-12652) [    ] 
o.a.s.h.a.PrepRecoveryOp Waited coreNodeName: core_node68, state: recovering, 
checkLive: true, onlyIfLeader: true for: 1 seconds.
   [junit4]   2> 1382453 INFO  (qtp1912969630-12652) [    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={nodeName=127.0.0.1:50620_q%252Fjz&onlyIfLeaderActive=true&core=collection1_shard2_replica_n61&coreNodeName=core_node68&action=PREPRECOVERY&checkLive=true&state=recovering&onlyIfLeader=true&wt=javabin&version=2}
 status=0 QTime=1006
   [junit4]   2> 1382841 INFO  (qtp1688025851-12771) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1382855 INFO  (qtp1688025851-12771) [    ] o.a.s.s.IndexSchema 
[collection1_shard3_replica_n69] Schema name=test
   [junit4]   2> 1382894 INFO  (qtp1688025851-12771) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1382914 INFO  (qtp1688025851-12771) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard3_replica_n69' using 
configuration from collection collection1, trusted=true
   [junit4]   2> 1382914 INFO  (qtp1688025851-12771) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1.shard3.replica_n69' (registry 
'solr.core.collection1.shard3.replica_n69') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@56086aea
   [junit4]   2> 1382914 INFO  (qtp1688025851-12771) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1382914 INFO  (qtp1688025851-12771) [    ] o.a.s.c.SolrCore 
[[collection1_shard3_replica_n69] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-5-001/cores/collection1_shard3_replica_n69],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.FullSolrCloudDistribCmdsTest_79E605EA1992276E-001/shard-5-001/cores/collection1_shard3_replica_n69/data/]
   [junit4]   2> 1382916 INFO  (qtp1688025851-12771) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=41, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1382918 WARN  (qtp1688025851-12771) [    ] 
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> 1382956 INFO  (qtp1688025851-12771) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.Upd

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

edInterval), 6child2_s=PostingsFormat(name=LuceneFixedGap), 
id=PostingsFormat(name=Memory), 5grand3_s=PostingsFormat(name=LuceneFixedGap), 
1parent_f1_s=PostingsFormat(name=MockRandom), 
13parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
6child1_s=PostingsFormat(name=MockRandom), 
_root_=PostingsFormat(name=LuceneVarGapFixedInterval), 
5child2_s=PostingsFormat(name=Memory), 
3child0_s=PostingsFormat(name=MockRandom), 
4child3_s=PostingsFormat(name=MockRandom), 
12parent_f1_s=PostingsFormat(name=Memory), 
1grand0_s=PostingsFormat(name=MockRandom), 
11grand2_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
11grand6_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
10grand7_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
7parent_f1_s=PostingsFormat(name=Memory), 
2child1_s=PostingsFormat(name=Memory), 
3parent_f2_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
10grand3_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
6grand3_s=PostingsFormat(name=MockRandom), 
5grand2_s=PostingsFormat(name=MockRandom), 
10grand9_s=PostingsFormat(name=LuceneFixedGap), 
11parent_f2_s=PostingsFormat(name=MockRandom), 
4grand1_s=PostingsFormat(name=MockRandom), 
7grand4_s=PostingsFormat(name=MockRandom), 
3grand0_s=PostingsFormat(name=MockRandom), 
9grand6_s=PostingsFormat(name=Memory), 
8grand1_s=PostingsFormat(name=MockRandom), 
9grand2_s=PostingsFormat(name=Memory), 
8grand5_s=PostingsFormat(name=MockRandom), 
9parent_f1_s=PostingsFormat(name=MockRandom), 
14parent_f2_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
1parent_f2_s=PostingsFormat(name=LuceneFixedGap), 
6child3_s=PostingsFormat(name=Memory), 
7grand0_s=PostingsFormat(name=MockRandom), 
text_t=PostingsFormat(name=LuceneVarGapFixedInterval), 
13parent_f2_s=PostingsFormat(name=Memory), 
type_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
5child1_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
10parent_f1_s=PostingsFormat(name=MockRandom), 
11grand1_s=PostingsFormat(name=MockRandom), 
10grand0_s=PostingsFormat(name=MockRandom), 
4child0_s=PostingsFormat(name=LuceneFixedGap), 
11grand5_s=PostingsFormat(name=MockRandom), 
12parent_f2_s=PostingsFormat(name=LuceneFixedGap), 
10grand8_s=PostingsFormat(name=MockRandom), 
10grand4_s=PostingsFormat(name=MockRandom), 
5grand1_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
6grand4_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
11parent_f1_s=PostingsFormat(name=LuceneFixedGap), 
4grand2_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
7grand3_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
11grand9_s=PostingsFormat(name=MockRandom), 
8grand2_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
9grand5_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
8grand6_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
9grand1_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
14parent_f1_s=PostingsFormat(name=MockRandom), 
6child4_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
5parent_f1_s=PostingsFormat(name=MockRandom), 
6grand0_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
10parent_f2_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
5child0_s=PostingsFormat(name=MockRandom), 
8parent_f1_s=PostingsFormat(name=LuceneFixedGap), 
2parent_f2_s=PostingsFormat(name=MockRandom), 
11grand0_s=PostingsFormat(name=LuceneFixedGap), 
4child1_s=PostingsFormat(name=Memory), 
2grand1_s=PostingsFormat(name=MockRandom), 
11grand4_s=PostingsFormat(name=LuceneFixedGap), 
3child2_s=PostingsFormat(name=Memory), 
10grand5_s=PostingsFormat(name=LuceneFixedGap), 
1child0_s=PostingsFormat(name=Memory), 
10grand1_s=PostingsFormat(name=LuceneFixedGap), 
7grand6_s=PostingsFormat(name=Memory), 5grand0_s=PostingsFormat(name=Memory), 
6grand5_s=PostingsFormat(name=Memory), 7grand2_s=PostingsFormat(name=Memory), 
4grand3_s=PostingsFormat(name=Memory), 
9grand8_s=PostingsFormat(name=MockRandom), 
11grand8_s=PostingsFormat(name=LuceneFixedGap), 
8grand3_s=PostingsFormat(name=Memory), 
6parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
9grand4_s=PostingsFormat(name=MockRandom), 
8grand7_s=PostingsFormat(name=Memory), 
0parent_f1_s=PostingsFormat(name=LuceneFixedGap), 
3grand2_s=PostingsFormat(name=Memory), 
9grand0_s=PostingsFormat(name=MockRandom), 
4parent_f2_s=PostingsFormat(name=Memory), 
5child4_s=PostingsFormat(name=MockRandom), 
6child5_s=PostingsFormat(name=MockRandom), 
5grand4_s=PostingsFormat(name=Memory), 6grand1_s=PostingsFormat(name=Memory), 
5parent_f2_s=PostingsFormat(name=LuceneFixedGap), 
6child0_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
8parent_f2_s=PostingsFormat(name=Memory), 
2parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
4child2_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
rnd_b=PostingsFormat(name=Memory), 11grand3_s=PostingsFormat(name=Memory), 
2grand0_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
11grand7_s=PostingsFormat(name=Memory), 
3child1_s=PostingsFormat(name=LuceneFixedGap), 
10grand6_s=PostingsFormat(name=Memory), 
7parent_f2_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
10grand2_s=PostingsFormat(name=Memory), 
2child0_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
3parent_f1_s=PostingsFormat(name=Memory)}, 
docValues:{_version_=DocValuesFormat(name=Asserting)}, 
maxPointsInLeafNode=1073, maxMBSortInHeap=5.177664946943085, 
sim=RandomSimilarity(queryNorm=true): {}, locale=lkt-US, timezone=Europe/Monaco
   [junit4]   2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 9 
(64-bit)/cpus=3,threads=1,free=18646224,total=472383488
   [junit4]   2> NOTE: All tests run in this JVM: 
[DistributedSuggestComponentTest, SimpleFacetsTest, SolrMetricManagerTest, 
HdfsWriteToMultipleCollectionsTest, TestHashPartitioner, 
FieldAnalysisRequestHandlerTest, TestStressVersions, ResponseLogComponentTest, 
TestLegacyField, TestBulkSchemaAPI, ZkFailoverTest, SolrIndexSplitterTest, 
UUIDUpdateProcessorFallbackTest, MetricsConfigTest, 
HdfsChaosMonkeySafeLeaderTest, TestCursorMarkWithoutUniqueKey, TestLFUCache, 
ExplicitHLLTest, TestNonDefinedSimilarityFactory, TestSchemaNameResource, 
PrimUtilsTest, TestTestInjection, HdfsLockFactoryTest, ResponseHeaderTest, 
TestHdfsUpdateLog, ChaosMonkeyNothingIsSafeTest, LargeFieldTest, 
TestFilteredDocIdSet, TestScoreJoinQPScore, RuleEngineTest, 
MoveReplicaHDFSTest, AtomicUpdateProcessorFactoryTest, 
XsltUpdateRequestHandlerTest, TestSubQueryTransformerDistrib, 
BlobRepositoryCloudTest, DistributedFacetPivotLongTailTest, 
TestHdfsBackupRestoreCore, TestTolerantSearch, TestOrdValues, 
TestFuzzyAnalyzedSuggestions, HighlighterTest, URLClassifyProcessorTest, 
CleanupOldIndexTest, SaslZkACLProviderTest, TestMacroExpander, 
TestFieldCollectionResource, ClassificationUpdateProcessorTest, 
BasicAuthIntegrationTest, SparseHLLTest, TestZkAclsWithHadoopAuth, 
TestCSVResponseWriter, RollingRestartTest, SolrMetricsIntegrationTest, 
AlternateDirectoryTest, DistributedFacetExistsSmallTest, SoftAutoCommitTest, 
TestSlowCompositeReaderWrapper, TestReqParamsAPI, DistribCursorPagingTest, 
CSVRequestHandlerTest, TestCloudInspectUtil, SolrGraphiteReporterTest, 
RecoveryZkTest, TestStressInPlaceUpdates, SliceStateTest, CursorPagingTest, 
TestQueryWrapperFilter, TestSolrConfigHandler, DeleteShardTest, 
TestPhraseSuggestions, OverseerModifyCollectionTest, RAMDirectoryFactoryTest, 
TestOmitPositions, IndexBasedSpellCheckerTest, TestNumericTerms64, 
NotRequiredUniqueKeyTest, TestNestedDocsSort, 
BigEndianAscendingWordSerializerTest, TestCodecSupport, TestSearcherReuse, 
TestShortCircuitedRequests, PeerSyncWithIndexFingerprintCachingTest, 
TestLegacyFieldCache, TestSolrCloudSnapshots, TestBlendedInfixSuggestions, 
TestCustomSort, TimeZoneUtilsTest, OverseerStatusTest, 
TestSolrCloudWithSecureImpersonation, TestGraphMLResponseWriter, 
PeerSyncReplicationTest, TestHighlightDedupGrouping, 
TestSchemaSimilarityResource, InfoHandlerTest, OutputWriterTest, 
ReturnFieldsTest, DirectUpdateHandlerOptimizeTest, TestXmlQParserPlugin, 
TestApiFramework, TestAddFieldRealTimeGet, 
DocExpirationUpdateProcessorFactoryTest, MultiTermTest, OverseerTest, 
HardAutoCommitTest, SolrInfoBeanTest, RemoteQueryErrorTest, 
HdfsBasicDistributedZkTest, DirectSolrConnectionTest, 
TestManagedResourceStorage, TestFieldCache, BufferStoreTest, 
HighlighterMaxOffsetTest, TestEmbeddedSolrServerConstructors, JSONWriterTest, 
TestSerializedLuceneMatchVersion, LeaderElectionTest, CollectionsAPISolrJTest, 
TestPHPSerializedResponseWriter, WrapperMergePolicyFactoryTest, 
DistanceFunctionTest, BlockCacheTest, InfixSuggestersTest, MoveReplicaTest, 
ClusterStateUpdateTest, TestIndexingPerformance, TestUtils, 
TestLeaderInitiatedRecoveryThread, TestExclusionRuleCollectionAccess, 
OverriddenZkACLAndCredentialsProvidersTest, TestRequestForwarding, 
XmlUpdateRequestHandlerTest, TestRawTransformer, QueryElevationComponentTest, 
BinaryUpdateRequestHandlerTest, TestRTimerTree, TestSolrDeletionPolicy2, 
TestRecoveryHdfs, DeleteInactiveReplicaTest, V2StandaloneTest, 
QueryResultKeyTest, TestClassicSimilarityFactory, TestLockTree, 
TestShardHandlerFactory, ActionThrottleTest, TestReplicationHandler, 
CreateCollectionCleanupTest, RequestLoggingTest, TestPolicyCloud, 
TestTolerantUpdateProcessorRandomCloud, TestLegacyNumericRangeQueryBuilder, 
TestDynamicFieldCollectionResource, DateMathParserTest, 
TestSolrCloudWithDelegationTokens, TestJsonFacets, 
TestLMDirichletSimilarityFactory, TestStressRecovery, TestClusterStateMutator, 
TriLevelCompositeIdRoutingTest, TestTrieFacet, 
ManagedSchemaRoundRobinCloudTest, AddBlockUpdateTest, 
TestReversedWildcardFilterFactory, NumericFieldsTest, 
TestPKIAuthenticationPlugin, TestDFRSimilarityFactory, 
TestFieldTypeCollectionResource, TestManagedSchemaAPI, 
TestSweetSpotSimilarityFactory, ForceLeaderTest, TestBlobHandler, 
TestManagedStopFilterFactory, TestImpersonationWithHadoopAuth, 
TestLeaderElectionWithEmptyReplica, ShufflingReplicaListTransformerTest, 
ClassificationUpdateProcessorFactoryTest, CoreSorterTest, 
BasicDistributedZkTest, SyncSliceTest, ShardRoutingTest, BasicZkTest, 
FullSolrCloudDistribCmdsTest]
   [junit4] Completed [379/733 (1!)] on J0 in 61.81s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 40406 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to